builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1481805904.06 results: success (0) buildid: 20161215030701 builduid: 8cf536eb5a134210bec7145866753b17 revision: ea07499d13936886f4b10455628a2f951798bf9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.058377) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.058896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.059210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.116022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.116343) ========= 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=745a4373a2a16df560f216e000000264-1481799855.761566-1232380804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 04:45:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-12-15 04:45:04 (38.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.245220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.245607) ========= 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=745a4373a2a16df560f216e000000264-1481799855.761566-1232380804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019291 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.294339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.294654) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ea07499d13936886f4b10455628a2f951798bf9c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ea07499d13936886f4b10455628a2f951798bf9c --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=745a4373a2a16df560f216e000000264-1481799855.761566-1232380804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 04:45:04,710 truncating revision to first 12 chars 2016-12-15 04:45:04,710 Setting DEBUG logging. 2016-12-15 04:45:04,710 attempt 1/10 2016-12-15 04:45:04,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ea07499d1393?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 04:45:05,014 unpacking tar archive at: mozilla-aurora-ea07499d1393/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645488 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.953759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.954270) ========= script_repo_revision: ea07499d13936886f4b10455628a2f951798bf9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.954992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.955289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.964622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-15 04:45:04.965044) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1481799855.761566-1232380804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:05 INFO - MultiFileLogger online at 20161215 04:45:05 in /builds/slave/test 04:45:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:45:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:05 INFO - {'append_to_log': False, 04:45:05 INFO - 'base_work_dir': '/builds/slave/test', 04:45:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:45:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:05 INFO - 'branch': 'Mozilla-Aurora', 04:45:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:05 INFO - 'config_files': ('talos/linux_config.py',), 04:45:05 INFO - 'default_actions': ('clobber', 04:45:05 INFO - 'read-buildbot-config', 04:45:05 INFO - 'download-and-extract', 04:45:05 INFO - 'populate-webroot', 04:45:05 INFO - 'create-virtualenv', 04:45:05 INFO - 'install', 04:45:05 INFO - 'run-tests'), 04:45:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:05 INFO - 'download_minidump_stackwalk': True, 04:45:05 INFO - 'download_symbols': 'ondemand', 04:45:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:05 INFO - 'installer_path': 'installer.exe', 04:45:05 INFO - 'log_level': 'info', 04:45:05 INFO - 'log_name': 'talos', 04:45:05 INFO - 'log_to_console': True, 04:45:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:05 INFO - 'opt_config_files': (), 04:45:05 INFO - 'pip_index': False, 04:45:05 INFO - 'sps_profile': False, 04:45:05 INFO - 'sps_profile_interval': 0, 04:45:05 INFO - 'suite': 'dromaeojs', 04:45:05 INFO - 'system_bits': '32', 04:45:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:05 INFO - 'title': 'talos-linux64-ix-032', 04:45:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:05 INFO - 'use_talos_json': True, 04:45:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:05 INFO - 'work_dir': 'build'} 04:45:05 INFO - [mozharness: 2016-12-15 12:45:05.482816Z] Running clobber step. 04:45:05 INFO - Running pre-action listener: _resource_record_pre_action 04:45:05 INFO - Running main action method: clobber 04:45:05 INFO - rmtree: /builds/slave/test/build 04:45:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:05 INFO - Running post-action listener: _resource_record_post_action 04:45:05 INFO - [mozharness: 2016-12-15 12:45:05.945084Z] Finished clobber step (success) 04:45:05 INFO - [mozharness: 2016-12-15 12:45:05.945184Z] Running read-buildbot-config step. 04:45:05 INFO - Running pre-action listener: _resource_record_pre_action 04:45:05 INFO - Running main action method: read_buildbot_config 04:45:05 INFO - Using buildbot properties: 04:45:05 INFO - { 04:45:05 INFO - "project": "", 04:45:05 INFO - "product": "firefox", 04:45:05 INFO - "script_repo_revision": "production", 04:45:05 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:45:05 INFO - "repository": "", 04:45:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:45:05 INFO - "buildid": "20161215030701", 04:45:05 INFO - "pgo_build": "True", 04:45:05 INFO - "basedir": "/builds/slave/test", 04:45:05 INFO - "buildnumber": 962, 04:45:05 INFO - "slavename": "talos-linux64-ix-032", 04:45:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:45:05 INFO - "platform": "ubuntu64_hw", 04:45:05 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:45:05 INFO - "branch": "mozilla-aurora", 04:45:05 INFO - "repo_path": "releases/mozilla-aurora", 04:45:05 INFO - "revision": "ea07499d13936886f4b10455628a2f951798bf9c", 04:45:05 INFO - "stage_platform": "linux64-pgo", 04:45:05 INFO - "builduid": "8cf536eb5a134210bec7145866753b17", 04:45:05 INFO - "slavebuilddir": "test" 04:45:05 INFO - } 04:45:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 04:45:05 INFO - Running post-action listener: _resource_record_post_action 04:45:05 INFO - [mozharness: 2016-12-15 12:45:05.947624Z] Finished read-buildbot-config step (success) 04:45:05 INFO - [mozharness: 2016-12-15 12:45:05.947712Z] Running download-and-extract step. 04:45:05 INFO - Running pre-action listener: _resource_record_pre_action 04:45:05 INFO - Running main action method: download_and_extract 04:45:05 INFO - mkdir: /builds/slave/test/build/tests 04:45: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')]} 04:45:05 INFO - trying https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:45:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:45:06 INFO - Downloaded 1361 bytes. 04:45:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:45:06 INFO - Using the following test package requirements: 04:45:06 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:45:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'jsshell-linux-x86_64.zip'], 04:45:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:45:06 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:45:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:45:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:45:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:45:07 INFO - Http code: 200 04:45:07 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 04:45:07 INFO - x-amz-cf-id: i4el93VAJbisfq7pzLPm6oAenmwF3okH4Y2qHQHSZKuorDUXPmKGyg== 04:45:07 INFO - x-amz-version-id: emIFLUz2.m82EumU7tirjYS_rbtJDgQH 04:45:07 INFO - Expected file size: 21953604 04:45:07 INFO - Obtained file size: 21953604 04:45:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:45:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:45:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:45:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:45:12 INFO - Http code: 200 04:45:12 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 04:45:12 INFO - x-amz-cf-id: lgdSEC0NHXFl7doXsijOB6BClyXRO46ghlndC6CM4zCurBS98hJt1Q== 04:45:12 INFO - x-amz-version-id: emIFLUz2.m82EumU7tirjYS_rbtJDgQH 04:45:12 INFO - Expected file size: 21953604 04:45:12 INFO - Obtained file size: 21953604 04:45:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:45:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:45:17 INFO - Http code: 200 04:45:17 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 04:45:17 INFO - x-amz-cf-id: pHVoc7mzlmYMqDUmtXZb6nJ8uBmox3Z-jqUdu3FRFJ-z3yV9md0Ghg== 04:45:17 INFO - x-amz-version-id: HEDlEuzGYrxPkfwRkfSlym_lLFkmrZCJ 04:45:17 INFO - Expected file size: 14409038 04:45:17 INFO - Obtained file size: 14409038 04:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:17 INFO - trying https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:45:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:45:18 INFO - Downloaded 63981342 bytes. 04:45:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:45:18 INFO - mkdir: /builds/slave/test/properties 04:45:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:18 INFO - Contents: 04:45:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:45:19 INFO - Running post-action listener: _resource_record_post_action 04:45:19 INFO - Running post-action listener: set_extra_try_arguments 04:45:19 INFO - [mozharness: 2016-12-15 12:45:19.557228Z] Finished download-and-extract step (success) 04:45:19 INFO - [mozharness: 2016-12-15 12:45:19.557457Z] Running populate-webroot step. 04:45:19 INFO - Running pre-action listener: _resource_record_pre_action 04:45:19 INFO - Running main action method: populate_webroot 04:45:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:19 INFO - '--tppagecycles', 04:45:19 INFO - '7'], 04:45:19 INFO - 'tests': ['tsvgm']}}, 04:45:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['damp', 'tps']}, 04:45:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'tests': ['damp', 'tps']}, 04:45:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['dromaeo_dom']}, 04:45:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['basic_compositor_video']}, 04:45:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:45:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['tsvgx', 04:45:19 INFO - 'tsvgr_opacity', 04:45:19 INFO - 'tart', 04:45:19 INFO - 'tscrollx', 04:45:19 INFO - 'cart']}, 04:45:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:19 INFO - 'tsvgr_opacity', 04:45:19 INFO - 'tart', 04:45:19 INFO - 'tscrollx', 04:45:19 INFO - 'cart']}, 04:45:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['tp5o']}, 04:45:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'tests': ['tp5o']}, 04:45:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'talos_options': ['--disable-e10s', 04:45:19 INFO - '--xperf_path', 04:45:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:19 INFO - 'tests': ['tp5n']}, 04:45:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'talos_options': ['--xperf_path', 04:45:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:19 INFO - 'tests': ['tp5n']}}, 04:45:19 INFO - 'talos.zip': {'path': '', 04:45:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:19 INFO - Running post-action listener: _resource_record_post_action 04:45:19 INFO - [mozharness: 2016-12-15 12:45:19.577113Z] Finished populate-webroot step (success) 04:45:19 INFO - [mozharness: 2016-12-15 12:45:19.577201Z] Running create-virtualenv step. 04:45:19 INFO - Running pre-action listener: _resource_record_pre_action 04:45:19 INFO - Running main action method: create_virtualenv 04:45:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:19 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 04:45:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:19 INFO - Using real prefix '/usr' 04:45:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:22 INFO - Installing pip.................done. 04:45:22 INFO - Return code: 0 04:45:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:45:22 INFO - Reading from file tmpfile_stdout 04:45:22 INFO - Output received: 04:45:22 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) 04:45:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:45:22 INFO - Using env: {'DISPLAY': ':0', 04:45:22 INFO - 'HOME': '/home/cltbld', 04:45:22 INFO - 'LANG': 'en_US.UTF-8', 04:45:22 INFO - 'LANGUAGE': 'en_US:en', 04:45:22 INFO - 'LOGNAME': 'cltbld', 04:45:22 INFO - 'MAIL': '/var/mail/cltbld', 04:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:22 INFO - 'MOZ_NO_REMOTE': '1', 04:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:22 INFO - 'NO_EM_RESTART': '1', 04:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:22 INFO - 'PWD': '/builds/slave/test', 04:45:22 INFO - 'SHELL': '/bin/bash', 04:45:22 INFO - 'SHLVL': '1', 04:45:22 INFO - 'TERM': 'linux', 04:45:22 INFO - 'TMOUT': '86400', 04:45:22 INFO - 'USER': 'cltbld', 04:45:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:22 INFO - '_': '/tools/buildbot/bin/python'} 04:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:22 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 04:45:22 INFO - Cleaning up... 04:45:22 INFO - Return code: 0 04:45:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:45:22 INFO - Using env: {'DISPLAY': ':0', 04:45:22 INFO - 'HOME': '/home/cltbld', 04:45:22 INFO - 'LANG': 'en_US.UTF-8', 04:45:22 INFO - 'LANGUAGE': 'en_US:en', 04:45:22 INFO - 'LOGNAME': 'cltbld', 04:45:22 INFO - 'MAIL': '/var/mail/cltbld', 04:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:22 INFO - 'MOZ_NO_REMOTE': '1', 04:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:22 INFO - 'NO_EM_RESTART': '1', 04:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:22 INFO - 'PWD': '/builds/slave/test', 04:45:22 INFO - 'SHELL': '/bin/bash', 04:45:22 INFO - 'SHLVL': '1', 04:45:22 INFO - 'TERM': 'linux', 04:45:22 INFO - 'TMOUT': '86400', 04:45:22 INFO - 'USER': 'cltbld', 04:45:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:22 INFO - '_': '/tools/buildbot/bin/python'} 04:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:22 INFO - Downloading/unpacking psutil>=3.1.1 04:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:24 INFO - Installing collected packages: psutil 04:45:24 INFO - Running setup.py install for psutil 04:45:24 INFO - building 'psutil._psutil_linux' extension 04:45:24 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 04:45:25 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 04:45:25 INFO - building 'psutil._psutil_posix' extension 04:45:25 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 04:45:25 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 04:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:25 INFO - Successfully installed psutil 04:45:25 INFO - Cleaning up... 04:45:25 INFO - Return code: 0 04:45:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:45:25 INFO - Using env: {'DISPLAY': ':0', 04:45:25 INFO - 'HOME': '/home/cltbld', 04:45:25 INFO - 'LANG': 'en_US.UTF-8', 04:45:25 INFO - 'LANGUAGE': 'en_US:en', 04:45:25 INFO - 'LOGNAME': 'cltbld', 04:45:25 INFO - 'MAIL': '/var/mail/cltbld', 04:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:25 INFO - 'MOZ_NO_REMOTE': '1', 04:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:25 INFO - 'NO_EM_RESTART': '1', 04:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:25 INFO - 'PWD': '/builds/slave/test', 04:45:25 INFO - 'SHELL': '/bin/bash', 04:45:25 INFO - 'SHLVL': '1', 04:45:25 INFO - 'TERM': 'linux', 04:45:25 INFO - 'TMOUT': '86400', 04:45:25 INFO - 'USER': 'cltbld', 04:45:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:25 INFO - '_': '/tools/buildbot/bin/python'} 04:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:27 INFO - Installing collected packages: mozsystemmonitor 04:45:27 INFO - Running setup.py install for mozsystemmonitor 04:45:27 INFO - Successfully installed mozsystemmonitor 04:45:27 INFO - Cleaning up... 04:45:27 INFO - Return code: 0 04:45:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:45:27 INFO - Using env: {'DISPLAY': ':0', 04:45:27 INFO - 'HOME': '/home/cltbld', 04:45:27 INFO - 'LANG': 'en_US.UTF-8', 04:45:27 INFO - 'LANGUAGE': 'en_US:en', 04:45:27 INFO - 'LOGNAME': 'cltbld', 04:45:27 INFO - 'MAIL': '/var/mail/cltbld', 04:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:27 INFO - 'MOZ_NO_REMOTE': '1', 04:45:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:27 INFO - 'NO_EM_RESTART': '1', 04:45:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:27 INFO - 'PWD': '/builds/slave/test', 04:45:27 INFO - 'SHELL': '/bin/bash', 04:45:27 INFO - 'SHLVL': '1', 04:45:27 INFO - 'TERM': 'linux', 04:45:27 INFO - 'TMOUT': '86400', 04:45:27 INFO - 'USER': 'cltbld', 04:45:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:27 INFO - '_': '/tools/buildbot/bin/python'} 04:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:28 INFO - Downloading/unpacking jsonschema==2.5.1 04:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:30 INFO - warning: no files found matching '*.txt' 04:45:30 INFO - no previously-included directories found matching 'build' 04:45:30 INFO - no previously-included directories found matching 'dist' 04:45:30 INFO - no previously-included directories found matching '.git*' 04:45:30 INFO - Installing collected packages: jsonschema, functools32 04:45:30 INFO - Running setup.py install for functools32 04:45:30 INFO - warning: no files found matching '*.txt' 04:45:30 INFO - no previously-included directories found matching 'build' 04:45:30 INFO - no previously-included directories found matching 'dist' 04:45:30 INFO - no previously-included directories found matching '.git*' 04:45:30 INFO - Successfully installed jsonschema functools32 04:45:30 INFO - Cleaning up... 04:45:30 INFO - Return code: 0 04:45:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:45:30 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')]} 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 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')]} 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 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 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:30 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 04:45:30 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 04:45:30 INFO - Using env: {'DISPLAY': ':0', 04:45:30 INFO - 'HOME': '/home/cltbld', 04:45:30 INFO - 'LANG': 'en_US.UTF-8', 04:45:30 INFO - 'LANGUAGE': 'en_US:en', 04:45:30 INFO - 'LOGNAME': 'cltbld', 04:45:30 INFO - 'MAIL': '/var/mail/cltbld', 04:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:30 INFO - 'MOZ_NO_REMOTE': '1', 04:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:30 INFO - 'NO_EM_RESTART': '1', 04:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:30 INFO - 'PWD': '/builds/slave/test', 04:45:30 INFO - 'SHELL': '/bin/bash', 04:45:30 INFO - 'SHLVL': '1', 04:45:30 INFO - 'TERM': 'linux', 04:45:30 INFO - 'TMOUT': '86400', 04:45:30 INFO - 'USER': 'cltbld', 04:45:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:30 INFO - '_': '/tools/buildbot/bin/python'} 04:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:45:30 INFO - Cleaning up... 04:45:30 INFO - Return code: 0 04:45:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45:30 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')]} 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 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')]} 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 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 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:30 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 04:45:30 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 04:45:30 INFO - Using env: {'DISPLAY': ':0', 04:45:30 INFO - 'HOME': '/home/cltbld', 04:45:30 INFO - 'LANG': 'en_US.UTF-8', 04:45:30 INFO - 'LANGUAGE': 'en_US:en', 04:45:30 INFO - 'LOGNAME': 'cltbld', 04:45:30 INFO - 'MAIL': '/var/mail/cltbld', 04:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:30 INFO - 'MOZ_NO_REMOTE': '1', 04:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:30 INFO - 'NO_EM_RESTART': '1', 04:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:30 INFO - 'PWD': '/builds/slave/test', 04:45:30 INFO - 'SHELL': '/bin/bash', 04:45:30 INFO - 'SHLVL': '1', 04:45:30 INFO - 'TERM': 'linux', 04:45:30 INFO - 'TMOUT': '86400', 04:45:30 INFO - 'USER': 'cltbld', 04:45:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:30 INFO - '_': '/tools/buildbot/bin/python'} 04:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:31 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 04:45:31 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 04:45:31 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 04:45:31 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 04:45:31 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 04:45:31 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 04:45:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 INFO - Downloading docopt-0.6.1.tar.gz 04:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:34 INFO - Running setup.py install for blobuploader 04:45:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:34 INFO - Running setup.py install for requests 04:45:34 INFO - Running setup.py install for docopt 04:45:34 INFO - Successfully installed blobuploader requests docopt 04:45:34 INFO - Cleaning up... 04:45:34 INFO - Return code: 0 04:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:45:34 INFO - Using env: {'DISPLAY': ':0', 04:45:34 INFO - 'HOME': '/home/cltbld', 04:45:34 INFO - 'LANG': 'en_US.UTF-8', 04:45:34 INFO - 'LANGUAGE': 'en_US:en', 04:45:34 INFO - 'LOGNAME': 'cltbld', 04:45:34 INFO - 'MAIL': '/var/mail/cltbld', 04:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:34 INFO - 'MOZ_NO_REMOTE': '1', 04:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:34 INFO - 'NO_EM_RESTART': '1', 04:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:34 INFO - 'PWD': '/builds/slave/test', 04:45:34 INFO - 'SHELL': '/bin/bash', 04:45:34 INFO - 'SHLVL': '1', 04:45:34 INFO - 'TERM': 'linux', 04:45:34 INFO - 'TMOUT': '86400', 04:45:34 INFO - 'USER': 'cltbld', 04:45:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:34 INFO - '_': '/tools/buildbot/bin/python'} 04:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:34 INFO - Running setup.py (path:/tmp/pip-j3ZCUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:34 INFO - Running setup.py (path:/tmp/pip-R0aeic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:34 INFO - Running setup.py (path:/tmp/pip-4S1_5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:35 INFO - Running setup.py (path:/tmp/pip-MDWbx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:35 INFO - Running setup.py (path:/tmp/pip-OfSXIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:35 INFO - Running setup.py (path:/tmp/pip-jTXg9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:35 INFO - Running setup.py (path:/tmp/pip-JEsCJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:35 INFO - Running setup.py (path:/tmp/pip-Fh3LAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:35 INFO - Running setup.py (path:/tmp/pip-uJ0lNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:35 INFO - Running setup.py (path:/tmp/pip-vNLgMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:35 INFO - Running setup.py (path:/tmp/pip-XfaAb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:35 INFO - Running setup.py (path:/tmp/pip-9xx902-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:35 INFO - Running setup.py (path:/tmp/pip-LPb9lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:35 INFO - Running setup.py (path:/tmp/pip-cszPeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:35 INFO - Running setup.py (path:/tmp/pip-Ow2QLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:35 INFO - Running setup.py (path:/tmp/pip-W5sVMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:35 INFO - Running setup.py (path:/tmp/pip-Ge3dCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:36 INFO - Running setup.py install for manifestparser 04:45:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozcrash 04:45:36 INFO - Running setup.py install for mozdebug 04:45:36 INFO - Running setup.py install for mozdevice 04:45:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozfile 04:45:36 INFO - Running setup.py install for mozhttpd 04:45:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozinfo 04:45:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozInstall 04:45:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozleak 04:45:36 INFO - Running setup.py install for mozlog 04:45:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for moznetwork 04:45:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for mozprocess 04:45:37 INFO - Running setup.py install for mozprofile 04:45:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for mozrunner 04:45:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for mozscreenshot 04:45:37 INFO - Running setup.py install for moztest 04:45:37 INFO - Running setup.py install for mozversion 04:45:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:37 INFO - Cleaning up... 04:45:37 INFO - Return code: 0 04:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:37 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')]} 04:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:37 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')]} 04:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:37 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 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:37 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 04:45:37 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 04:45:37 INFO - Using env: {'DISPLAY': ':0', 04:45:37 INFO - 'HOME': '/home/cltbld', 04:45:37 INFO - 'LANG': 'en_US.UTF-8', 04:45:37 INFO - 'LANGUAGE': 'en_US:en', 04:45:37 INFO - 'LOGNAME': 'cltbld', 04:45:37 INFO - 'MAIL': '/var/mail/cltbld', 04:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:37 INFO - 'MOZ_NO_REMOTE': '1', 04:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:37 INFO - 'NO_EM_RESTART': '1', 04:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:37 INFO - 'PWD': '/builds/slave/test', 04:45:37 INFO - 'SHELL': '/bin/bash', 04:45:37 INFO - 'SHLVL': '1', 04:45:37 INFO - 'TERM': 'linux', 04:45:37 INFO - 'TMOUT': '86400', 04:45:37 INFO - 'USER': 'cltbld', 04:45:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:37 INFO - '_': '/tools/buildbot/bin/python'} 04:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:38 INFO - Running setup.py (path:/tmp/pip-YKLvj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:38 INFO - Running setup.py (path:/tmp/pip-vhIdCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:38 INFO - Running setup.py (path:/tmp/pip-SRJ_3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:38 INFO - Running setup.py (path:/tmp/pip-XXkxEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:38 INFO - Running setup.py (path:/tmp/pip-jbVOD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:38 INFO - Running setup.py (path:/tmp/pip-1fkV8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:38 INFO - Running setup.py (path:/tmp/pip-qGAqDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:38 INFO - Running setup.py (path:/tmp/pip-6TcGat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:38 INFO - Running setup.py (path:/tmp/pip-_GIBTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:38 INFO - Running setup.py (path:/tmp/pip-5fCKqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:38 INFO - Running setup.py (path:/tmp/pip-soCrMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:38 INFO - Running setup.py (path:/tmp/pip-C32A9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:39 INFO - Running setup.py (path:/tmp/pip-Hh7dgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:39 INFO - Running setup.py (path:/tmp/pip-Rkv6ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:39 INFO - Running setup.py (path:/tmp/pip-HuwDcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:39 INFO - Running setup.py (path:/tmp/pip-gYjGl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:39 INFO - Running setup.py (path:/tmp/pip-zmNl2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:39 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 04:45:39 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 04:45:39 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 04:45:39 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 04:45:39 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 04:45:39 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 04:45:41 INFO - Downloading blessings-1.6.tar.gz 04:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:41 INFO - Installing collected packages: blessings 04:45:41 INFO - Running setup.py install for blessings 04:45:41 INFO - Successfully installed blessings 04:45:41 INFO - Cleaning up... 04:45:41 INFO - Return code: 0 04:45:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:41 INFO - Reading from file tmpfile_stdout 04:45:41 INFO - Current package versions: 04:45:41 INFO - argparse == 1.2.1 04:45:41 INFO - blessings == 1.6 04:45:41 INFO - blobuploader == 1.2.4 04:45:41 INFO - docopt == 0.6.1 04:45:41 INFO - functools32 == 3.2.3-2 04:45:41 INFO - jsonschema == 2.5.1 04:45:41 INFO - manifestparser == 1.1 04:45:41 INFO - mozInstall == 1.12 04:45:41 INFO - mozcrash == 1.0 04:45:41 INFO - mozdebug == 0.1 04:45:41 INFO - mozdevice == 0.48 04:45:41 INFO - mozfile == 1.2 04:45:41 INFO - mozhttpd == 0.7 04:45:41 INFO - mozinfo == 0.9 04:45:41 INFO - mozleak == 0.1 04:45:41 INFO - mozlog == 3.4 04:45:41 INFO - moznetwork == 0.27 04:45:41 INFO - mozprocess == 0.23 04:45:41 INFO - mozprofile == 0.28 04:45:41 INFO - mozrunner == 6.13 04:45:41 INFO - mozscreenshot == 0.1 04:45:41 INFO - mozsystemmonitor == 0.3 04:45:41 INFO - moztest == 0.7 04:45:41 INFO - mozversion == 1.4 04:45:41 INFO - psutil == 3.1.1 04:45:41 INFO - requests == 1.2.3 04:45:41 INFO - wsgiref == 0.1.2 04:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:41 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 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:41 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 04:45:41 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 04:45:41 INFO - Using env: {'DISPLAY': ':0', 04:45:41 INFO - 'HOME': '/home/cltbld', 04:45:41 INFO - 'LANG': 'en_US.UTF-8', 04:45:41 INFO - 'LANGUAGE': 'en_US:en', 04:45:41 INFO - 'LOGNAME': 'cltbld', 04:45:41 INFO - 'MAIL': '/var/mail/cltbld', 04:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:41 INFO - 'MOZ_NO_REMOTE': '1', 04:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:41 INFO - 'NO_EM_RESTART': '1', 04:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:41 INFO - 'PWD': '/builds/slave/test', 04:45:41 INFO - 'SHELL': '/bin/bash', 04:45:41 INFO - 'SHLVL': '1', 04:45:41 INFO - 'TERM': 'linux', 04:45:41 INFO - 'TMOUT': '86400', 04:45:41 INFO - 'USER': 'cltbld', 04:45:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:41 INFO - '_': '/tools/buildbot/bin/python'} 04:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 INFO - Cleaning up... 04:45:42 INFO - Return code: 0 04:45:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:42 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')]} 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:42 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')]} 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:42 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 0x7eff49f05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, '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': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', '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 04:45:42 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 04:45:42 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 04:45:42 INFO - Using env: {'DISPLAY': ':0', 04:45:42 INFO - 'HOME': '/home/cltbld', 04:45:42 INFO - 'LANG': 'en_US.UTF-8', 04:45:42 INFO - 'LANGUAGE': 'en_US:en', 04:45:42 INFO - 'LOGNAME': 'cltbld', 04:45:42 INFO - 'MAIL': '/var/mail/cltbld', 04:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:42 INFO - 'MOZ_NO_REMOTE': '1', 04:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:42 INFO - 'NO_EM_RESTART': '1', 04:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:42 INFO - 'PWD': '/builds/slave/test', 04:45:42 INFO - 'SHELL': '/bin/bash', 04:45:42 INFO - 'SHLVL': '1', 04:45:42 INFO - 'TERM': 'linux', 04:45:42 INFO - 'TMOUT': '86400', 04:45:42 INFO - 'USER': 'cltbld', 04:45:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:42 INFO - '_': '/tools/buildbot/bin/python'} 04:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:42 INFO - Cleaning up... 04:45:42 INFO - Return code: 0 04:45:42 INFO - Running post-action listener: _resource_record_post_action 04:45:42 INFO - Running post-action listener: _start_resource_monitoring 04:45:42 INFO - Starting resource monitoring. 04:45:42 INFO - [mozharness: 2016-12-15 12:45:42.359826Z] Finished create-virtualenv step (success) 04:45:42 INFO - [mozharness: 2016-12-15 12:45:42.360325Z] Running install step. 04:45:42 INFO - Running pre-action listener: _resource_record_pre_action 04:45:42 INFO - Running main action method: install 04:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:42 INFO - Reading from file tmpfile_stdout 04:45:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:42 INFO - Reading from file tmpfile_stdout 04:45:42 INFO - Output received: 04:45:42 INFO - Usage: mozinstall [options] installer 04:45:42 INFO - Options: 04:45:42 INFO - -h, --help show this help message and exit 04:45:42 INFO - -d DEST, --destination=DEST 04:45:42 INFO - Directory to install application into. [default: 04:45:42 INFO - "/builds/slave/test"] 04:45:42 INFO - --app=APP Application being installed. [default: firefox] 04:45:42 INFO - mkdir: /builds/slave/test/build/application 04:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:45:58 INFO - Reading from file tmpfile_stdout 04:45:58 INFO - Output received: 04:45:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:58 INFO - Running post-action listener: _resource_record_post_action 04:45:58 INFO - [mozharness: 2016-12-15 12:45:58.589425Z] Finished install step (success) 04:45:58 INFO - [mozharness: 2016-12-15 12:45:58.589668Z] Running run-tests step. 04:45:58 INFO - Running pre-action listener: _resource_record_pre_action 04:45:58 INFO - Running main action method: run_tests 04:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:58 INFO - Python 2.7.3 04:45:58 INFO - Return code: 0 04:45:58 INFO - grabbing minidump binary from tooltool 04:45: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')]} 04:45:58 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 0x24f4f60>, '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 0x24f5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:58 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 04:45:58 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 04:45:58 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 04:45:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:58 INFO - Return code: 0 04:45:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 04:45:58 INFO - Using env: {'DISPLAY': ':0', 04:45:58 INFO - 'HOME': '/home/cltbld', 04:45:58 INFO - 'LANG': 'en_US.UTF-8', 04:45:58 INFO - 'LANGUAGE': 'en_US:en', 04:45:58 INFO - 'LOGNAME': 'cltbld', 04:45:58 INFO - 'MAIL': '/var/mail/cltbld', 04:45:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:58 INFO - 'MOZ_NO_REMOTE': '1', 04:45:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:58 INFO - 'NO_EM_RESTART': '1', 04:45:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:58 INFO - 'PWD': '/builds/slave/test', 04:45:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:58 INFO - 'SHELL': '/bin/bash', 04:45:58 INFO - 'SHLVL': '1', 04:45:58 INFO - 'TERM': 'linux', 04:45:58 INFO - 'TMOUT': '86400', 04:45:58 INFO - 'USER': 'cltbld', 04:45:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1481799855.761566-1232380804', 04:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:58 INFO - '_': '/tools/buildbot/bin/python'} 04:45:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 04:45:58 INFO - mozversion application_buildid: 20161215030701 04:45:58 INFO - mozversion application_changeset: ea07499d13936886f4b10455628a2f951798bf9c 04:45:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:45:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:58 INFO - mozversion application_name: Firefox 04:45:58 INFO - mozversion application_remotingname: firefox-dev 04:45:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:58 INFO - mozversion application_vendor: Mozilla 04:45:58 INFO - mozversion application_version: 52.0a2 04:45:58 INFO - mozversion platform_buildid: 20161215030701 04:45:58 INFO - mozversion platform_changeset: ea07499d13936886f4b10455628a2f951798bf9c 04:45:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:58 INFO - mozversion platform_version: 52.0a2 04:45:58 INFO - using testdate: 1481805958 04:45:58 INFO - actual date: 1481805958 04:45:58 INFO - starting webserver on 'localhost:38014' 04:45:58 INFO - SUITE-START | Running 2 tests 04:45:58 INFO - TEST-START | dromaeo_css 04:45:58 INFO - operating with platform_type : linux_ 04:45:58 INFO - Initialising browser for dromaeo_css test... 04:45:58 INFO - TEST-INFO | started process 3419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPq_j_/profile http://localhost:38014/getInfo.html) 04:46:03 INFO - PROCESS | 3419 | __metrics Screen width/height:1600/1200 04:46:03 INFO - PROCESS | 3419 | colorDepth:24 04:46:03 INFO - PROCESS | 3419 | Browser inner width/height: 1024/697 04:46:03 INFO - PROCESS | 3419 | __metrics 04:46:03 INFO - PROCESS | 3419 | 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" 04:46:03 INFO - PROCESS | 3419 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:04 INFO - PROCESS | 3419 | console.error: PushService: 04:46:04 INFO - PROCESS | 3419 | stateChangeProcessEnqueue: Error transitioning state 04:46:04 INFO - PROCESS | 3419 | UnknownError 04:46:04 INFO - TEST-INFO | 3419: exit 0 04:46:04 INFO - Browser initialized. 04:46:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:04 INFO - TEST-INFO | started process 3513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPq_j_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:16 INFO - PROCESS | 3513 | RSS: Main: 147402752 04:46:16 INFO - PROCESS | 3513 | 04:47:08 INFO - PROCESS | 3513 | 1481806028411 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:49:18 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:38014/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38014/tests/dromaeo/cssquery-ext.html) 04:49:19 INFO - PROCESS | 3513 | RSS: Main: 283340800 04:49:19 INFO - PROCESS | 3513 | 04:52:22 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:38014/tests/dromaeo/cssquery-ext.html (next: http://localhost:38014/tests/dromaeo/cssquery-jquery.html) 04:52:22 INFO - PROCESS | 3513 | RSS: Main: 228589568 04:52:22 INFO - PROCESS | 3513 | 04:55:24 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:38014/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38014/tests/dromaeo/cssquery-mootools.html) 04:55:25 INFO - PROCESS | 3513 | RSS: Main: 222392320 04:55:25 INFO - PROCESS | 3513 | 04:58:27 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:38014/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38014/tests/dromaeo/cssquery-prototype.html) 04:58:27 INFO - PROCESS | 3513 | RSS: Main: 175644672 04:58:27 INFO - PROCESS | 3513 | 05:01:30 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:38014/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38014/tests/dromaeo/cssquery-yui.html) 05:01:31 INFO - PROCESS | 3513 | RSS: Main: 174338048 05:01:31 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:38014/tests/dromaeo/cssquery-yui.html (next: http://localhost:38014/tests/dromaeo/cssquery-dojo.html) 05:04:33 INFO - PROCESS | 3513 | RSS: Main: 268025856 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | __start_tp_report 05:04:33 INFO - PROCESS | 3513 | _x_x_mozilla_page_load 05:04:33 INFO - PROCESS | 3513 | _x_x_mozilla_page_load_details 05:04:33 INFO - PROCESS | 3513 | |i|pagename|runs| 05:04:33 INFO - PROCESS | 3513 | |0;dojo.html;3188.7767856250066;3228.4188846007723;3229.2572708277094;3242.3191129862726;3258.690424409682;5537.3632032316245;5565.220869078327;5589.217509548656;5591.664500129995;5639.125935480002;5571.13647384655;5627.127795191742;5631.943680563203;5642.125470552071;5651.1523271509195;5090.211017292317;5110.182370820669;5139.871503212412;5167.173252279636;5191.351081114861;4913.459519452876;4928.359313289286;5158.613104017195;5199.818006369778;5221.112410890139;4945.678530895499;4992.301077849104;5000.349954505909;5016.49835016499;5018.996200759862;5083.8983220335385;5087.313212716273;5104.132297509433;5116.872078198037;5119.283300337956;5097.847064588068;5098.898022039575;5103.157978933508;5156.690598564098;5158.226266060084;5345.037893179227;5565.916511252334;5595.160725891108;5656.632318899258;5680.091185410356;5841.094630332305;5882;5894.705264736746;5898.174255604176;5920.200772895647;5944.405559444021;5977.193078934375;6029.155918171459;6064.878702425971;6070.362611925772;5652.3217213934595;5655.123455864347;5659.40576239493;5664;5665.178549110438;5814;5869.706514674249;6078.240219972504;6122.093225952662;6124.846878828065;5947;5952.4047595241;5957.344692083867;5959.314678811992;5967.8209653710455;6012.909806352908;6021.5182785377065;6023.367546407651;6023.608465449819;6027.367126451747;5800.245968024215;5870.442307980735;5898.380670029671;5953.880922381528;5978;5990.011648078018;5996.310424301174;6011.158437818709;6017.247844019497;6040.848978775566;4601.677882548256;4624.861254162381;4652.092841895866;4657.951960808791;4681.227597446451;4023.75857448554;4043.8180281887385;4085.9795701021303;4094.9181016379507;4132.008318003657;5696.772129114872;5728.598998070179;5734.77060917567;5737.913931291034;5776.537876969916;6056.515478761688;6067.211262535842;6081.513478921675;6082.635041897501;6089;5436.429174936575;5488.69812160327;5567.554595632339;5706;5709.229254050733;4956.776945037482;5050.974745126251;5074.086664400444;5086.974565127225;5095.770690318945;6175.567710260329;6185.84535386619;6185.938140618537;6189.04069869171;6189.319174890758;5783;6003.279606447254;6010.429009244115;6046.395360463918;6058.5758996871555;5932.436418540232;5998.7300571473515;5999.88000239984;6052.303985041776;6110.467630727307;5875.970620146872;5877.059670452707;5877.147813566923;5882.1470886722045;5909.497692696169;5974.342822289632;5984.1323008164445;5987.820365389045;5987.9401205989125;5990.580659353804;5565.833025009256;5690.402507736793;5819.563532734977;5866.67733274674;5894.911576326444;5911.674857882857;5948.970255148696;5952.494038006818;5953.553483488842;5963.7912673056235;5905.645661260338;5930.584859059824;5930.673812940329;5931.9110213345975;5935.198748168942;5712.800051998326;5719.170720245625;5819;5872.677002764889;5932.79235226765;5787.826365209051;5793.507551858139;5798.043322851851;5804.071348584206;5827.737751801264 05:04:33 INFO - PROCESS | 3513 | |1;ext.html;581.1631250998562;631.9652419116948;642.9549931504795;658.0458335413648;669.0132055218556;34506.48240276395;35219.47170792437;37363.25273494529;44441;45589.54410455895;46347.76826115865;46685.066298674006;46712.29931551021;46836.765816170955;46872.8907199176;8788.604512796923;8922.375433719642;8933;8933.55332233389;8934.508602026886;8400.327973762085;8585.484870907765;8799.208071273584;10444.26890117692;10688.519016644232;10723.839142412831;10779;10794;10801.135909127252;10801.83797243042;10675;10709.892901070967;10731.409772462512;10742.979416955377;10756.139508839275;10425.426601536912;10474.790504189874;10492;10493.160547156285;10499.73750656232;42873.35689964653;43087.784561076995;43103.35344969828;43110.568894311284;43237.35143972843;3590.299891521154;3748.7001039917013;3810.0665336992615;3974.721769476138;4143.585641435832;32545;33263.16842078943;33694.831525842455;33987.15032124192;34170.65829341725;4365.4106695596;4501.4598248210095;4547.681662283641;4577.153226653079;4605.148047611203;347754;348885;349470;349937;350492;38294.42558361627;39352.60647393547;64199.679001604694;64708.67645661742;64793;40522;41109.58890411058;41200.793996029824;41253.1749365011;41273.79363103165;15463.84536154624;15728.370865165265;15733.44932927342;15734.449294274646;15742.212889355487;10309.793804124025;12627.747445051047;12826.486940522274;12862.614121576367;12864.807027894589;8901.376903616814;9218.76953076165;9524.666636667822;9528.618855245713;9595.664151754656;3583.910402239913;3593.6226696196522;3644.562652481666;3653.159773252167;3672.944905826415;1058.4919238765435;1106.8118419868642;1167.4979758703669;1173.2139466557428;1188.851393575803;32442.675573243967;32687.019389418354;32693.67306326954;32802.50796238059;32945.835270823496;980.5930538826307;1117.4692021289984;1177.3406892140429;1179.728662407651;1182.1370399608334;16218.918905405397;18214.90892545529;18240.543986400182;18695.81304186968;19101.808981910282;520959;523183;526903;527195;527781;62939;63351.68324158442;63450.36549634537;63497;63655.36344636587;1285.1453783234044;1339.4106593099004;1395.7836535336835;1440.7622742247622;1459.6350912271932;31008.53487197739;34846.65153348434;35374;35416.291674165856;35688;53534.732326339676;54176.458235418715;54182.45817541932;54200.45799541954;54510.727446362514;403092;403272;406265;409754;410286;29918.401631967674;30091.247718807204;30629;31310.37379252448;32464.51303230406;49890.501094988584;49973.75013124911;50778.49221507738;51260.48739512557;51580;41957.79021104875;42112.15775684531;42283.36574951317;43882.34176487419;44363.778181108886;42058;42247.366289506295;42613.36079958865;43103.35344969891;43707.78146109249;42994.140117196854;43857.122857543305;44595.777021114685;44701.32948005848;44726.329105062796;35616;37863.81068094642;38194.23611527698;38530.80734596309;38533.22933541369;28996.710032899402;29400.26499337534;29661.40677186401;29734.851325744097;29815.254618634706 05:04:33 INFO - PROCESS | 3513 | |2;jquery.html;386.3702165470283;404.2662567440098;408.12457279136254;410.93630487274476;431.77547675208893;15345.53963381099;19808.30670926518;20057.498562535944;20260.797392026074;20276.188952441884;12070.939645301783;12230.021598272138;12632.747345053116;12775.169613975086;12783.360831958387;5212.635115541913;5408.675479471244;5409.107497262947;5410.242566040757;5410.864728381803;3979.2638361902996;4324.913501729963;5331.440198779131;5427.972860135694;6607.900881486781;6658.567193132455;6661.100751398548;6663.100481434993;6671.59970401775;6675.198976122872;6094.878102437927;6107.5113990880845;6111.54163437744;6234.470070044029;6662.800115996503;5920.615160014585;5944.583879128462;5944.613600116022;5945;5947.791827286068;12897.35513224335;12920.54778082772;12940.094193406465;12943.741125177443;12959.611211663665;2407.687000689899;2667.093188315982;2667.199840047978;2713.877875495588;2816.7746580273733;10159.644412445603;10486.475676216234;10655.147588193004;10734.302270352402;10848.457577121113;1939.9612007759906;1962.0484065228352;1991.9004049797597;2026.230032587622;2051.8974051297523;83600;87678;90134.5493272536;90631;91476;11401.429928503541;11475.598354057567;11495.252808567417;11537.250078744855;11766.235194712317;16485.17574121289;16493.17534123313;16521.83478165227;16524;16541.58646033859;8388.538630375266;8395.496270223806;8452.366072544584;8553.572321383906;8560.315174786003;7964.721234756756;7979.8404031919035;8095.878561821577;8179.386546009073;8208.138145494637;4742.241241401359;4872.4153101628035;4890.902181956341;4899.289603007615;5035.874103147451;1982.3953694123431;1994.4216177308417;2022.4236092713506;2031.0961622078328;2046.5395286060518;970.4565443351746;999.6786394086994;1051.854953688466;1080.443571560647;1094.63876920616;20046;20410.69383959242;20959.47601309949;21004.894975525025;21059.473513161985;1044.2220545693508;1062.3625824505389;1062.4900047977014;1085.0505807418508;1089.0525243038608;10694.19793515474;11492.655220343404;11514.76970460603;11531.13516486267;11566.132540059529;464693;471111;483016;486843;487451;97579;98763.50618247007;101021.49489252653;101041;102131;1032.9225308101923;1036.18659352408;1039.8163855902694;1044.8798388185455;1051.4637534857125;17831.821681783014;18204.72692909581;18766.6246675063;18779.924463961623;18978;44131.99999999871;44365.55634443614;44605.77697111623;44785.55214447814;45016.32475512935;55840.720796395755;59092;63401;63848;64777.35222647713;8830.293576513992;8948.105189481;9051.818963620823;9090.09099090112;9230.584623691815;12461.750764984468;13614.387352569356;13689.315534223448;13968.790468142783;14238.145711257357;11664.533418663159;12170.878291217328;12189.707966267917;12275.202111863058;12454.81317780216;11944.906553961888;11974.22167559106;12009.699757506132;12106.394680266128;12243.816342754688;12346.938265308616;12421.937890310852;12431.378431078228;12461.626151215478;12597.93701031489;8893.688720894737;8922.286217102486;9046.140616641409;9072.319576031692;9318.860217096613;9299.349045566745;11645;12117.212381195193;12392.75214495723;12536.247825130522 05:04:33 INFO - PROCESS | 3513 | |3;mootools.html;1343.9193648381092;1499.6400863792687;1526.1453585991846;1624.1879060469764;1765.814589468105;7194.56832590045;8283.171682831713;8583.356248281389;8585.098564650716;8798.384113112084;8278.296344810698;8366.790830229247;8367.2469477747;8367.828504009443;8371.623276952536;2484.2423060966353;2510.259473455326;2512.723600403954;2514.233158886539;2515.811314151437;2399.2682231919257;2530.367408147963;2532.025170309435;2536.69559652841;2539;2428.162284012013;2468.4322605800676;2472.6043832986634;2480.5659009673327;2487.0300582772734;2329.4642232286583;2367.3371455992265;2391.784739373456;2443.2548072837776;2443.5479436304163;2417.7340492545804;2437.9878100609562;2467.7408872068354;2468.6790717206827;2475.7648023437746;7970.800729981739;8597.398182127254;8646.740597782014;8764.912350876473;8794.164554367326;5464.398916119224;5598.468145526209;5601.103823388279;5604.887902241932;5607.186957891124;3307.6361600223954;3405.8126803025825;3416.1118109291515;3448.637893021247;3450.8612157987804;1034.6171916390908;1038.2368958815264;1046.879608844985;1059.8357254625546;1079.9676009719722;11902.047836173086;11926.224795388272;11990.580329688419;11996.280223186637;11999.760004799855;4524.7511386873375;4777.235642297216;4782.3543821584335;4833.806647734052;4872.025594880967;9643.373180743229;9714.271429642806;9723.708288751348;9728.319017668837;9731.951340243395;5437.972810135924;5441.646292990943;5482;5490.203920431515;5490.56075513958;4250.107477429774;4358.150160718693;4575.862724118282;5102.4642412546145;5143.27994080829;3981.7013723970817;4012;4115.71190016702;4120.1553681495225;4120.546739858613;1273.7834568123255;1300.4148133340034;1309.9803502947464;1321.881030707241;1323.2986517145928;816.269438852224;917.2616044084442;925.648253663617;935.9298052646079;946.9431834089977;5797.507211886952;6169.383061693795;6181.5363847710705;6190.071489276645;6223.253209614875;487.1110223841503;489.20015774209423;496.80872863946917;508.75071215104333;512.743628185907;3653.634636536325;3688.317661232627;3731.7014638828828;4246.596573325529;4554.726716397026;10564.894351056391;10669.78660426787;10691.091257243066;10743.086837618734;10745.30155539903;10446;10583.100436462986;10721.30311529748;10729.088027517591;10740.033396994308;7837.3338266246865;8034.276915077554;8039.276465118168;8050.919490805134;8068.757937261891;5866.735996880236;5932.406759324033;5957.046872500552;6002.759889604367;6065.4541091302;9506.95246523763;9853.06395892389;9885.802283954137;9897.752556186153;9903.45530995802;8683.392162548562;8934.955325223593;9905.306628535933;10109.090181883666;10130.341527800669;7646.923530764621;7800.882986755317;7878.330341921001;7957.403194760301;8040.356771458386;8605.440646357967;8626.611802468778;8648.351373647127;8651.52416617067;8657.134286571545;7299.306565876233;7319.817004574716;7379.778606641809;7390.96304518474;7461.477696561188;7528;7611.086669599684;7646.8088297793;7777.533347999138;7908.802279943047;6705.932940670726;6816.863662726619;6818.147731533559;6820.181578210647;6822.522423430312;5056.6713163644245;5155.200943853709;5163;5172.689638621695;5354.063038968243;5118.590512758896;5126.362797195759;5198.428172900903;5224.111900976767;5323.866903327448 05:04:33 INFO - PROCESS | 3513 | |4;prototype.html;341.3855060890397;348.1192582765604;349.38333840771037;355.342616160104;355.4774481512178;5380.896916132193;5428.267183930173;5437.211604317372;5444.21058946453;5451.890962180764;5280.419153893069;5296.682199068058;5350.892982140354;5395.406505284415;5398.16328469087;3993.4009898515164;4014.5784692607294;4149.190907772985;4212.473440819897;4238.470191226097;4186.372044193365;4187.874363769091;4202.97898510507;4220.2192594370135;4226.852060177895;4161.500619925613;4172.207280616673;4185.497740271172;4192.49690037196;4209.473815773028;3913.157620998312;4017.4576432181575;4154.335306350999;4163.3130533462245;4179.1223842993;3718.851245950159;3722.6598424567132;3727.7390582659223;3734.7572407793677;3751.1559899022773;5192.974035129838;5223.1642937130255;5226.477352264781;5227.947720522822;5228.346456692913;4549.158405694957;4754.690945088558;4756.738379389132;4763.737994410306;4791.496892826238;5533.253010843525;5535.972320138414;5545.223668686387;5552.888942221133;5562.221289019541;4062.8984275393054;4075.5924407559305;4079.9592004079877;4082.7754473503946;4099.795010249476;5479.863003424906;5730.885382292373;5757.625754325955;5787.710614469218;5828.1549175369755;4085.4893138357706;4111.568285329998;4119.97940010298;4134.359174327924;4139.91720165595;4197.706160568731;4211.115665710174;4212.347086201644;4218.177455396169;4225.936610950838;4535.705179163344;4715.080559290974;4749.4775574686755;4790.113828941588;4791.760411979387;5570.303712035996;5579.944200558024;5592.5805564582815;5597.824456864023;5601.439856014366;1393.171063217384;1412.569166404236;1424.5939907126626;1426.479335042702;1431.5705288413435;934.9065093490733;974.7270764186039;978.3493976505687;984.2322988069318;993.6919554937992;5222.477752224823;5253.605979551472;5326;5356.3572371315695;5410.783568657288;5671.602987790815;5691.943080569141;5703.885922281531;5706.25818643582;5717.256756621613;5152.3044389007755;5314.8573056792975;5397.676139431646;5431.619786614899;5463.426340234298;2920.7663386928994;2947.6124339285248;2951.2735049995563;2953.8375389353364;2956.51217549102;5584.246126772834;5584.413636568183;5598.720063996865;5621.241132447068;5631.211630371751;5373.489518495737;5576.330840299109;5579.637323573955;5621.18492818539;5641.830745077655;5530.723463826873;5570.97214513933;5609.971950140223;5626.465485778926;5635.774569017275;5162.716050617252;5440.374356949002;5481.109017388994;5519;5521.1442226454965;5415.756290966837;5421.376541697755;5431.891362172655;5460.290162279037;5464.535514481314;5609.270794796814;5612.747426365741;5618.606697531133;5639.464250896158;5641.576881733969;3894.6300101490315;3990.4413382127104;3991.92016159681;4012.518497780285;4051.9797401012806;5467.371252305877;5473.370562385217;5491.368492623399;5510.586705996986;5524.696141712084;5347.679139251657;5374.865628359323;5398.703071331114;5431.34823821144;5476.152400751666;5089.931114465856;5272.736363181749;5379.623426360117;5399.5950303726595;5417.214503896992;5341.130604288468;5349.331333583302;5365.865853353697;5367.973160134331;5369.301990741179;5340.2256672783005;5432.864178395572;5479.397266300624;5586.692731899784;5610.663360198401;5462.863428414322;5489.835304940858;5494.560435165097;5498.3127109111365;5508.44915508446 05:04:33 INFO - PROCESS | 3513 | |5;yui.html;696.1506961506963;714.7105422303968;715.7208688611443;742.3689863615924;745.5377665847172;12528.24830510169;13054.216746995164;13065.934670326658;13101.606951791462;13161.736765264688;12596.370181490935;12690.4923803048;12703.110782245247;12703.936480317609;12714.046446516502;697.5326531224067;712.7469748239378;810.9391795615323;828.1180542722012;829.8755186721979;840.7603832907622;843.6878355008655;843.725789118539;843.7426584891606;844.5734903873536;892.7455675132588;893.3344658229628;894.9731508054737;895.8924929008496;895.995520022399;732.059303794624;751.6054071612419;845.9873101903477;874.0865795243985;875.8335916175906;649.2468736265956;649.6459429610874;649.7043845050491;649.9285078641345;649.9707513161919;13338.333083345891;13456.529021484299;13492.460301587924;13540.187588744708;13544.45822167112;12081.637550873487;12685.873141268561;12842.935785321108;12855.421506032251;13037.608871733863;11164.274322169033;11250.887491125066;11263.43682815856;11333.603323883706;11437.19939604228;4169.56219596941;4180.519240287375;4222.852200172979;4240.215560121356;4245.363195520666;62067.37932620661;62976;63232.68383658052;63453.68273158651;63469;9913.45475998827;10175.236857235737;10209;10248.692539223835;10559.419231942164;17788.221177882107;17809.376671816422;17838.821611783977;17856.55358616019;17866.91066544659;7604.961975190088;7606.163322034572;7768.417368697257;7805.960970195113;7865.370770338359;4318.5681431856565;4321.762303073361;4391;4394.956050439519;4475.1273501666865;2934.662513810939;2988.551717242431;3020.0335892514186;3048.8170709757487;3050.80169788963;565.2933832709114;571.1489880078653;638.6104476269472;650.9772157974448;675.2167485716545;644.9838754031093;648.4423395879539;669.4142625202948;707.5542408282749;722.3931897206267;8975.927788319195;9045.77385565353;9054.954725226464;9448.716538503719;9559.856602150974;654.5025780406925;659.5548005096541;660.9107770450928;677.6239187251024;699.0527834783795;4377.409049778239;4502.752348620857;4636.374089497942;4654.464736555272;4667.346571479996;92489;92773.53613231891;92884.53557732303;93269;95384.52307738418;56846.43153568494;65376.34623653703;76651;80203.59898200589;82681;70223;70597;71286;71338.28661713524;73789.6310518444;9276.62893484253;9354.625814967598;9364.719058428258;9367.718968430958;9428;46686.533134669575;47025.76487117542;47228.52771472241;47381;48261.75869120632;58111;65837;65945.34054659391;67169.63397379154;68634;11250.83123753128;11426.428678566204;11444.141689373164;11746.412679366169;11860.347680877634;12916.22502649844;13163.276019819003;13233.007524435898;13491.123076999964;14564.271786410425;12332.383380831103;12855;12874.420651070912;13206.471741130246;13244.470221191044;11154;11175.497102630563;11601.767964640829;11646.068314534987;11687.649370518899;11853.525858965544;12199.512019519474;12317.753644926872;12360.38198090074;13203.405846737112;10148.13740832008;10163.644272450429;10175.694729158136;10383.376997380181;10400;10076.395416274754;10323.94838025805;10325.535350909076;10357.482125893826;10479.371237725762 05:04:33 INFO - PROCESS | 3513 | __end_tp_report 05:04:33 INFO - PROCESS | 3513 | __start_cc_report 05:04:33 INFO - PROCESS | 3513 | _x_x_mozilla_cycle_collect,1396 05:04:33 INFO - PROCESS | 3513 | __end_cc_report 05:04:33 INFO - PROCESS | 3513 | __startTimestamp1481807073882__endTimestamp 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | ------- Summary: start ------- 05:04:33 INFO - PROCESS | 3513 | Number of tests: 6 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | [#0] dojo.html Cycles:165 Average:5556.92 Median:5798.04 stddev:629.45 (10.9%) stddev-sans-first:603.34 05:04:33 INFO - PROCESS | 3513 | Values: 3188.8 3228.4 3229.3 3242.3 3258.7 5537.4 5565.2 5589.2 5591.7 5639.1 5571.1 5627.1 5631.9 5642.1 5651.2 5090.2 5110.2 5139.9 5167.2 5191.4 4913.5 4928.4 5158.6 5199.8 5221.1 4945.7 4992.3 5000.3 5016.5 5019.0 5083.9 5087.3 5104.1 5116.9 5119.3 5097.8 5098.9 5103.2 5156.7 5158.2 5345.0 5565.9 5595.2 5656.6 5680.1 5841.1 5882.0 5894.7 5898.2 5920.2 5944.4 5977.2 6029.2 6064.9 6070.4 5652.3 5655.1 5659.4 5664.0 5665.2 5814.0 5869.7 6078.2 6122.1 6124.8 5947.0 5952.4 5957.3 5959.3 5967.8 6012.9 6021.5 6023.4 6023.6 6027.4 5800.2 5870.4 5898.4 5953.9 5978.0 5990.0 5996.3 6011.2 6017.2 6040.8 4601.7 4624.9 4652.1 4658.0 4681.2 4023.8 4043.8 4086.0 4094.9 4132.0 5696.8 5728.6 5734.8 5737.9 5776.5 6056.5 6067.2 6081.5 6082.6 6089.0 5436.4 5488.7 5567.6 5706.0 5709.2 4956.8 5051.0 5074.1 5087.0 5095.8 6175.6 6185.8 6185.9 6189.0 6189.3 5783.0 6003.3 6010.4 6046.4 6058.6 5932.4 5998.7 5999.9 6052.3 6110.5 5876.0 5877.1 5877.1 5882.1 5909.5 5974.3 5984.1 5987.8 5987.9 5990.6 5565.8 5690.4 5819.6 5866.7 5894.9 5911.7 5949.0 5952.5 5953.6 5963.8 5905.6 5930.6 5930.7 5931.9 5935.2 5712.8 5719.2 5819.0 5872.7 5932.8 5787.8 5793.5 5798.0 5804.1 5827.7 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | [#1] ext.html Cycles:180 Average:59013.04 Median:38412.62 stddev:114741.51 (298.7%) stddev-sans-first:114979.51 05:04:33 INFO - PROCESS | 3513 | Values: 581.2 632.0 643.0 658.0 669.0 34506.5 35219.5 37363.3 44441.0 45589.5 46347.8 46685.1 46712.3 46836.8 46872.9 8788.6 8922.4 8933.0 8933.6 8934.5 8400.3 8585.5 8799.2 10444.3 10688.5 10723.8 10779.0 10794.0 10801.1 10801.8 10675.0 10709.9 10731.4 10743.0 10756.1 10425.4 10474.8 10492.0 10493.2 10499.7 42873.4 43087.8 43103.4 43110.6 43237.4 3590.3 3748.7 3810.1 3974.7 4143.6 32545.0 33263.2 33694.8 33987.2 34170.7 4365.4 4501.5 4547.7 4577.2 4605.1 347754.0 348885.0 349470.0 349937.0 350492.0 38294.4 39352.6 64199.7 64708.7 64793.0 40522.0 41109.6 41200.8 41253.2 41273.8 15463.8 15728.4 15733.4 15734.4 15742.2 10309.8 12627.7 12826.5 12862.6 12864.8 8901.4 9218.8 9524.7 9528.6 9595.7 3583.9 3593.6 3644.6 3653.2 3672.9 1058.5 1106.8 1167.5 1173.2 1188.9 32442.7 32687.0 32693.7 32802.5 32945.8 980.6 1117.5 1177.3 1179.7 1182.1 16218.9 18214.9 18240.5 18695.8 19101.8 520959.0 523183.0 526903.0 527195.0 527781.0 62939.0 63351.7 63450.4 63497.0 63655.4 1285.1 1339.4 1395.8 1440.8 1459.6 31008.5 34846.7 35374.0 35416.3 35688.0 53534.7 54176.5 54182.5 54200.5 54510.7 403092.0 403272.0 406265.0 409754.0 410286.0 29918.4 30091.2 30629.0 31310.4 32464.5 49890.5 49973.8 50778.5 51260.5 51580.0 41957.8 42112.2 42283.4 43882.3 44363.8 42058.0 42247.4 42613.4 43103.4 43707.8 42994.1 43857.1 44595.8 44701.3 44726.3 35616.0 37863.8 38194.2 38530.8 38533.2 28996.7 29400.3 29661.4 29734.9 29815.3 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | [#2] jquery.html Cycles:180 Average:29114.76 Median:2049.22 stddev:79403.29 (3874.8%) stddev-sans-first:79596.74 05:04:33 INFO - PROCESS | 3513 | Values: 386.4 404.3 408.1 410.9 431.8 15345.5 19808.3 20057.5 20260.8 20276.2 12070.9 12230.0 12632.7 12775.2 12783.4 5212.6 5408.7 5409.1 5410.2 5410.9 3979.3 4324.9 5331.4 5428.0 6607.9 6658.6 6661.1 6663.1 6671.6 6675.2 6094.9 6107.5 6111.5 6234.5 6662.8 5920.6 5944.6 5944.6 5945.0 5947.8 12897.4 12920.5 12940.1 12943.7 12959.6 2407.7 2667.1 2667.2 2713.9 2816.8 10159.6 10486.5 10655.1 10734.3 10848.5 1940.0 1962.0 1991.9 2026.2 2051.9 83600.0 87678.0 90134.5 90631.0 91476.0 11401.4 11475.6 11495.3 11537.3 11766.2 16485.2 16493.2 16521.8 16524.0 16541.6 8388.5 8395.5 8452.4 8553.6 8560.3 7964.7 7979.8 8095.9 8179.4 8208.1 4742.2 4872.4 4890.9 4899.3 5035.9 1982.4 1994.4 2022.4 2031.1 2046.5 970.5 999.7 1051.9 1080.4 1094.6 20046.0 20410.7 20959.5 21004.9 21059.5 1044.2 1062.4 1062.5 1085.1 1089.1 10694.2 11492.7 11514.8 11531.1 11566.1 464693.0 471111.0 483016.0 486843.0 487451.0 97579.0 98763.5 101021.5 101041.0 102131.0 1032.9 1036.2 1039.8 1044.9 1051.5 17831.8 18204.7 18766.6 18779.9 18978.0 44132.0 44365.6 44605.8 44785.6 45016.3 55840.7 59092.0 63401.0 63848.0 64777.4 8830.3 8948.1 9051.8 9090.1 9230.6 12461.8 13614.4 13689.3 13968.8 14238.1 11664.5 12170.9 12189.7 12275.2 12454.8 11944.9 11974.2 12009.7 12106.4 12243.8 12346.9 12421.9 12431.4 12461.6 12597.9 8893.7 8922.3 9046.1 9072.3 9318.9 9299.3 11645.0 12117.2 12392.8 12536.2 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | [#3] mootools.html Cycles:180 Average:5721.30 Median:5159.10 stddev:3171.48 (61.5%) stddev-sans-first:3163.31 05:04:33 INFO - PROCESS | 3513 | Values: 1343.9 1499.6 1526.1 1624.2 1765.8 7194.6 8283.2 8583.4 8585.1 8798.4 8278.3 8366.8 8367.2 8367.8 8371.6 2484.2 2510.3 2512.7 2514.2 2515.8 2399.3 2530.4 2532.0 2536.7 2539.0 2428.2 2468.4 2472.6 2480.6 2487.0 2329.5 2367.3 2391.8 2443.3 2443.5 2417.7 2438.0 2467.7 2468.7 2475.8 7970.8 8597.4 8646.7 8764.9 8794.2 5464.4 5598.5 5601.1 5604.9 5607.2 3307.6 3405.8 3416.1 3448.6 3450.9 1034.6 1038.2 1046.9 1059.8 1080.0 11902.0 11926.2 11990.6 11996.3 11999.8 4524.8 4777.2 4782.4 4833.8 4872.0 9643.4 9714.3 9723.7 9728.3 9732.0 5438.0 5441.6 5482.0 5490.2 5490.6 4250.1 4358.2 4575.9 5102.5 5143.3 3981.7 4012.0 4115.7 4120.2 4120.5 1273.8 1300.4 1310.0 1321.9 1323.3 816.3 917.3 925.6 935.9 946.9 5797.5 6169.4 6181.5 6190.1 6223.3 487.1 489.2 496.8 508.8 512.7 3653.6 3688.3 3731.7 4246.6 4554.7 10564.9 10669.8 10691.1 10743.1 10745.3 10446.0 10583.1 10721.3 10729.1 10740.0 7837.3 8034.3 8039.3 8050.9 8068.8 5866.7 5932.4 5957.0 6002.8 6065.5 9507.0 9853.1 9885.8 9897.8 9903.5 8683.4 8935.0 9905.3 10109.1 10130.3 7646.9 7800.9 7878.3 7957.4 8040.4 8605.4 8626.6 8648.4 8651.5 8657.1 7299.3 7319.8 7379.8 7391.0 7461.5 7528.0 7611.1 7646.8 7777.5 7908.8 6705.9 6816.9 6818.1 6820.2 6822.5 5056.7 5155.2 5163.0 5172.7 5354.1 5118.6 5126.4 5198.4 5224.1 5323.9 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | [#4] prototype.html Cycles:180 Average:4634.92 Median:5361.11 stddev:1329.65 (24.8%) stddev-sans-first:1293.74 05:04:33 INFO - PROCESS | 3513 | Values: 341.4 348.1 349.4 355.3 355.5 5380.9 5428.3 5437.2 5444.2 5451.9 5280.4 5296.7 5350.9 5395.4 5398.2 3993.4 4014.6 4149.2 4212.5 4238.5 4186.4 4187.9 4203.0 4220.2 4226.9 4161.5 4172.2 4185.5 4192.5 4209.5 3913.2 4017.5 4154.3 4163.3 4179.1 3718.9 3722.7 3727.7 3734.8 3751.2 5193.0 5223.2 5226.5 5227.9 5228.3 4549.2 4754.7 4756.7 4763.7 4791.5 5533.3 5536.0 5545.2 5552.9 5562.2 4062.9 4075.6 4080.0 4082.8 4099.8 5479.9 5730.9 5757.6 5787.7 5828.2 4085.5 4111.6 4120.0 4134.4 4139.9 4197.7 4211.1 4212.3 4218.2 4225.9 4535.7 4715.1 4749.5 4790.1 4791.8 5570.3 5579.9 5592.6 5597.8 5601.4 1393.2 1412.6 1424.6 1426.5 1431.6 934.9 974.7 978.3 984.2 993.7 5222.5 5253.6 5326.0 5356.4 5410.8 5671.6 5691.9 5703.9 5706.3 5717.3 5152.3 5314.9 5397.7 5431.6 5463.4 2920.8 2947.6 2951.3 2953.8 2956.5 5584.2 5584.4 5598.7 5621.2 5631.2 5373.5 5576.3 5579.6 5621.2 5641.8 5530.7 5571.0 5610.0 5626.5 5635.8 5162.7 5440.4 5481.1 5519.0 5521.1 5415.8 5421.4 5431.9 5460.3 5464.5 5609.3 5612.7 5618.6 5639.5 5641.6 3894.6 3990.4 3991.9 4012.5 4052.0 5467.4 5473.4 5491.4 5510.6 5524.7 5347.7 5374.9 5398.7 5431.3 5476.2 5089.9 5272.7 5379.6 5399.6 5417.2 5341.1 5349.3 5365.9 5368.0 5369.3 5340.2 5432.9 5479.4 5586.7 5610.7 5462.9 5489.8 5494.6 5498.3 5508.4 05:04:33 INFO - PROCESS | 3513 | 05:04:33 INFO - PROCESS | 3513 | [#5] yui.html Cycles:180 Average:17647.50 Median:47127.15 stddev:24171.43 (51.3%) stddev-sans-first:24205.73 05:04:33 INFO - PROCESS | 3513 | Values: 696.2 714.7 715.7 742.4 745.5 12528.2 13054.2 13065.9 13101.6 13161.7 12596.4 12690.5 12703.1 12703.9 12714.0 697.5 712.7 810.9 828.1 829.9 840.8 843.7 843.7 843.7 844.6 892.7 893.3 895.0 895.9 896.0 732.1 751.6 846.0 874.1 875.8 649.2 649.6 649.7 649.9 650.0 13338.3 13456.5 13492.5 13540.2 13544.5 12081.6 12685.9 12842.9 12855.4 13037.6 11164.3 11250.9 11263.4 11333.6 11437.2 4169.6 4180.5 4222.9 4240.2 4245.4 62067.4 62976.0 63232.7 63453.7 63469.0 9913.5 10175.2 10209.0 10248.7 10559.4 17788.2 17809.4 17838.8 17856.6 17866.9 7605.0 7606.2 7768.4 7806.0 7865.4 4318.6 4321.8 4391.0 4395.0 4475.1 2934.7 2988.6 3020.0 3048.8 3050.8 565.3 571.1 638.6 651.0 675.2 645.0 648.4 669.4 707.6 722.4 8975.9 9045.8 9055.0 9448.7 9559.9 654.5 659.6 660.9 677.6 699.1 4377.4 4502.8 4636.4 4654.5 4667.3 92489.0 92773.5 92884.5 93269.0 95384.5 56846.4 65376.3 76651.0 80203.6 82681.0 70223.0 70597.0 71286.0 71338.3 73789.6 9276.6 9354.6 9364.7 9367.7 9428.0 46686.5 47025.8 47228.5 47381.0 48261.8 58111.0 65837.0 65945.3 67169.6 68634.0 11250.8 11426.4 11444.1 11746.4 11860.3 12916.2 13163.3 13233.0 13491.1 14564.3 12332.4 12855.0 12874.4 13206.5 13244.5 11154.0 11175.5 11601.8 11646.1 11687.6 11853.5 12199.5 12317.8 12360.4 13203.4 10148.1 10163.6 10175.7 10383.4 10400.0 10076.4 10323.9 10325.5 10357.5 10479.4 05:04:33 INFO - PROCESS | 3513 | -------- Summary: end -------- 05:04:33 INFO - PROCESS | 3513 | 05:04:34 INFO - TEST-INFO | 3513: exit 0 05:04:34 INFO - TEST-OK | dromaeo_css | took 1115921ms 05:04:34 INFO - TEST-START | kraken 05:04:34 INFO - operating with platform_type : linux_ 05:04:34 INFO - Initialising browser for kraken test... 05:04:34 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeG83k/profile http://localhost:38014/getInfo.html) 05:04:39 INFO - PROCESS | 3829 | __metrics Screen width/height:1600/1200 05:04:39 INFO - PROCESS | 3829 | colorDepth:24 05:04:39 INFO - PROCESS | 3829 | Browser inner width/height: 1024/697 05:04:39 INFO - PROCESS | 3829 | __metrics 05:04:39 INFO - PROCESS | 3829 | 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" 05:04:39 INFO - PROCESS | 3829 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:40 INFO - PROCESS | 3829 | console.error: PushService: 05:04:40 INFO - PROCESS | 3829 | stateChangeProcessEnqueue: Error transitioning state 05:04:40 INFO - PROCESS | 3829 | UnknownError 05:04:40 INFO - TEST-INFO | 3829: exit 0 05:04:40 INFO - Browser initialized. 05:04:40 INFO - Running cycle 1/1 for kraken test... 05:04:40 INFO - TEST-INFO | started process 3917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeG83k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:52 INFO - PROCESS | 3917 | RSS: Main: 145272832 05:04:52 INFO - PROCESS | 3917 | 05:04:55 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38014/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:56 INFO - PROCESS | 3917 | RSS: Main: 185585664 05:04:56 INFO - PROCESS | 3917 | 05:04:58 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38014/tests/kraken/driver.html?testName=audio-dft) 05:04:59 INFO - PROCESS | 3917 | RSS: Main: 175194112 05:04:59 INFO - PROCESS | 3917 | 05:05:02 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38014/tests/kraken/driver.html?testName=audio-fft) 05:05:02 INFO - PROCESS | 3917 | RSS: Main: 266219520 05:05:02 INFO - PROCESS | 3917 | 05:05:04 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38014/tests/kraken/driver.html?testName=audio-oscillator) 05:05:05 INFO - PROCESS | 3917 | RSS: Main: 172765184 05:05:05 INFO - PROCESS | 3917 | 05:05:07 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38014/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:08 INFO - PROCESS | 3917 | RSS: Main: 175398912 05:05:08 INFO - PROCESS | 3917 | 05:05:10 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38014/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:11 INFO - PROCESS | 3917 | RSS: Main: 214339584 05:05:11 INFO - PROCESS | 3917 | 05:05:14 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38014/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:15 INFO - PROCESS | 3917 | RSS: Main: 213012480 05:05:15 INFO - PROCESS | 3917 | 05:05:18 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38014/tests/kraken/driver.html?testName=json-parse-financial) 05:05:18 INFO - PROCESS | 3917 | RSS: Main: 211431424 05:05:18 INFO - PROCESS | 3917 | 05:05:20 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38014/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:20 INFO - PROCESS | 3917 | RSS: Main: 173600768 05:05:20 INFO - PROCESS | 3917 | 05:05:22 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:23 INFO - PROCESS | 3917 | RSS: Main: 180600832 05:05:23 INFO - PROCESS | 3917 | 05:05:25 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:25 INFO - PROCESS | 3917 | RSS: Main: 189857792 05:05:25 INFO - PROCESS | 3917 | 05:05:28 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:28 INFO - PROCESS | 3917 | RSS: Main: 198979584 05:05:28 INFO - PROCESS | 3917 | 05:05:31 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:32 INFO - PROCESS | 3917 | RSS: Main: 195141632 05:05:32 INFO - PROCESS | 3917 | 05:05:33 INFO - PROCESS | 3917 | Cycle 1(1): loaded http://localhost:38014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38014/tests/kraken/driver.html?testName=ai-astar) 05:05:34 INFO - PROCESS | 3917 | RSS: Main: 246415360 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | __start_tp_report 05:05:34 INFO - PROCESS | 3917 | _x_x_mozilla_page_load 05:05:34 INFO - PROCESS | 3917 | _x_x_mozilla_page_load_details 05:05:34 INFO - PROCESS | 3917 | |i|pagename|runs| 05:05:34 INFO - PROCESS | 3917 | |0;ai-astar;102;112;111;113;110;112;111;109;110;109 05:05:34 INFO - PROCESS | 3917 | |1;audio-beat-detection;147;118;119;156;122;120;118;117;147;122 05:05:34 INFO - PROCESS | 3917 | |2;audio-dft;160;161;160;159;163;160;160;162;160;160 05:05:34 INFO - PROCESS | 3917 | |3;audio-fft;74;75;75;106;76;76;74;76;103;75 05:05:34 INFO - PROCESS | 3917 | |4;audio-oscillator;81;80;116;82;82;81;105;82;82;115 05:05:34 INFO - PROCESS | 3917 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 05:05:34 INFO - PROCESS | 3917 | |6;imaging-darkroom;145;147;146;146;145;146;146;146;146;146 05:05:34 INFO - PROCESS | 3917 | |7;imaging-desaturate;84;84;85;85;85;84;84;85;84;85 05:05:34 INFO - PROCESS | 3917 | |8;json-parse-financial;50;51;50;50;50;50;50;51;50;50 05:05:34 INFO - PROCESS | 3917 | |9;json-stringify-tinderbox;58;59;58;58;60;59;58;59;59;58 05:05:34 INFO - PROCESS | 3917 | |10;stanford-crypto-aes;76;75;74;77;74;74;80;74;74;76 05:05:34 INFO - PROCESS | 3917 | |11;stanford-crypto-ccm;129;122;124;125;120;128;120;121;159;135 05:05:34 INFO - PROCESS | 3917 | |12;stanford-crypto-pbkdf2;154;159;156;156;156;158;156;159;155;155 05:05:34 INFO - PROCESS | 3917 | |13;stanford-crypto-sha256-iterative;67;63;62;60;61;63;60;65;62;59 05:05:34 INFO - PROCESS | 3917 | __end_tp_report 05:05:34 INFO - PROCESS | 3917 | __start_cc_report 05:05:34 INFO - PROCESS | 3917 | _x_x_mozilla_cycle_collect,1589 05:05:34 INFO - PROCESS | 3917 | __end_cc_report 05:05:34 INFO - PROCESS | 3917 | __startTimestamp1481807134049__endTimestamp 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | ------- Summary: start ------- 05:05:34 INFO - PROCESS | 3917 | Number of tests: 14 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.07 (2.8%) stddev-sans-first:1.39 05:05:34 INFO - PROCESS | 3917 | Values: 102.0 112.0 111.0 113.0 110.0 112.0 111.0 109.0 110.0 109.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:122.00 stddev:15.06 (12.3%) stddev-sans-first:14.42 05:05:34 INFO - PROCESS | 3917 | Values: 147.0 118.0 119.0 156.0 122.0 120.0 118.0 117.0 147.0 122.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 05:05:34 INFO - PROCESS | 3917 | Values: 160.0 161.0 160.0 159.0 163.0 160.0 160.0 162.0 160.0 160.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:12.43 (16.6%) stddev-sans-first:12.92 05:05:34 INFO - PROCESS | 3917 | Values: 74.0 75.0 75.0 106.0 76.0 76.0 74.0 76.0 103.0 75.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:15.06 (18.5%) stddev-sans-first:15.56 05:05:34 INFO - PROCESS | 3917 | Values: 81.0 80.0 116.0 82.0 82.0 81.0 105.0 82.0 82.0 115.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:05:34 INFO - PROCESS | 3917 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:05:34 INFO - PROCESS | 3917 | Values: 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:05:34 INFO - PROCESS | 3917 | Values: 84.0 84.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 05:05:34 INFO - PROCESS | 3917 | Values: 50.0 51.0 50.0 50.0 50.0 50.0 50.0 51.0 50.0 50.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 05:05:34 INFO - PROCESS | 3917 | Values: 58.0 59.0 58.0 58.0 60.0 59.0 58.0 59.0 59.0 58.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.50 stddev:1.96 (2.6%) stddev-sans-first:2.06 05:05:34 INFO - PROCESS | 3917 | Values: 76.0 75.0 74.0 77.0 74.0 74.0 80.0 74.0 74.0 76.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.50 stddev:11.78 (9.3%) stddev-sans-first:12.49 05:05:34 INFO - PROCESS | 3917 | Values: 129.0 122.0 124.0 125.0 120.0 128.0 120.0 121.0 159.0 135.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:156.00 stddev:1.71 (1.1%) stddev-sans-first:1.58 05:05:34 INFO - PROCESS | 3917 | Values: 154.0 159.0 156.0 156.0 156.0 158.0 156.0 159.0 155.0 155.0 05:05:34 INFO - PROCESS | 3917 | 05:05:34 INFO - PROCESS | 3917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:2.44 (3.9%) stddev-sans-first:1.87 05:05:34 INFO - PROCESS | 3917 | Values: 67.0 63.0 62.0 60.0 61.0 63.0 60.0 65.0 62.0 59.0 05:05:34 INFO - PROCESS | 3917 | -------- Summary: end -------- 05:05:34 INFO - PROCESS | 3917 | 05:05:35 INFO - TEST-INFO | 3917: exit 0 05:05:35 INFO - TEST-OK | kraken | took 60367ms 05:05:35 INFO - SUITE-END | took 1176s 05:05:35 INFO - Completed test suite (00:19:36) 05:05:35 INFO - javascript benchmark 05:05:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.7767856250066, 3228.4188846007723, 3229.2572708277094, 3242.3191129862726, 3258.690424409682, 5537.3632032316245, 5565.220869078327, 5589.217509548656, 5591.664500129995, 5639.125935480002, 5571.13647384655, 5627.127795191742, 5631.943680563203, 5642.125470552071, 5651.1523271509195, 5090.211017292317, 5110.182370820669, 5139.871503212412, 5167.173252279636, 5191.351081114861, 4913.459519452876, 4928.359313289286, 5158.613104017195, 5199.818006369778, 5221.112410890139, 4945.678530895499, 4992.301077849104, 5000.349954505909, 5016.49835016499, 5018.996200759862, 5083.8983220335385, 5087.313212716273, 5104.132297509433, 5116.872078198037, 5119.283300337956, 5097.847064588068, 5098.898022039575, 5103.157978933508, 5156.690598564098, 5158.226266060084, 5345.037893179227, 5565.916511252334, 5595.160725891108, 5656.632318899258, 5680.091185410356, 5841.094630332305, 5882.0, 5894.705264736746, 5898.174255604176, 5920.200772895647, 5944.405559444021, 5977.193078934375, 6029.155918171459, 6064.878702425971, 6070.362611925772, 5652.3217213934595, 5655.123455864347, 5659.40576239493, 5664.0, 5665.178549110438, 5814.0, 5869.706514674249, 6078.240219972504, 6122.093225952662, 6124.846878828065, 5947.0, 5952.4047595241, 5957.344692083867, 5959.314678811992, 5967.8209653710455, 6012.909806352908, 6021.5182785377065, 6023.367546407651, 6023.608465449819, 6027.367126451747, 5800.245968024215, 5870.442307980735, 5898.380670029671, 5953.880922381528, 5978.0, 5990.011648078018, 5996.310424301174, 6011.158437818709, 6017.247844019497, 6040.848978775566, 4601.677882548256, 4624.861254162381, 4652.092841895866, 4657.951960808791, 4681.227597446451, 4023.75857448554, 4043.8180281887385, 4085.9795701021303, 4094.9181016379507, 4132.008318003657, 5696.772129114872, 5728.598998070179, 5734.77060917567, 5737.913931291034, 5776.537876969916, 6056.515478761688, 6067.211262535842, 6081.513478921675, 6082.635041897501, 6089.0, 5436.429174936575, 5488.69812160327, 5567.554595632339, 5706.0, 5709.229254050733, 4956.776945037482, 5050.974745126251, 5074.086664400444, 5086.974565127225, 5095.770690318945, 6175.567710260329, 6185.84535386619, 6185.938140618537, 6189.04069869171, 6189.319174890758, 5783.0, 6003.279606447254, 6010.429009244115, 6046.395360463918, 6058.5758996871555, 5932.436418540232, 5998.7300571473515, 5999.88000239984, 6052.303985041776, 6110.467630727307, 5875.970620146872, 5877.059670452707, 5877.147813566923, 5882.1470886722045, 5909.497692696169, 5974.342822289632, 5984.1323008164445, 5987.820365389045, 5987.9401205989125, 5990.580659353804, 5565.833025009256, 5690.402507736793, 5819.563532734977, 5866.67733274674, 5894.911576326444, 5911.674857882857, 5948.970255148696, 5952.494038006818, 5953.553483488842, 5963.7912673056235, 5905.645661260338, 5930.584859059824, 5930.673812940329, 5931.9110213345975, 5935.198748168942, 5712.800051998326, 5719.170720245625, 5819.0, 5872.677002764889, 5932.79235226765, 5787.826365209051, 5793.507551858139, 5798.043322851851, 5804.071348584206, 5827.737751801264], "value": 5514.461755378756, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1631250998562, 631.9652419116948, 642.9549931504795, 658.0458335413648, 669.0132055218556, 34506.48240276395, 35219.47170792437, 37363.25273494529, 44441.0, 45589.54410455895, 46347.76826115865, 46685.066298674006, 46712.29931551021, 46836.765816170955, 46872.8907199176, 8788.604512796923, 8922.375433719642, 8933.0, 8933.55332233389, 8934.508602026886, 8400.327973762085, 8585.484870907765, 8799.208071273584, 10444.26890117692, 10688.519016644232, 10723.839142412831, 10779.0, 10794.0, 10801.135909127252, 10801.83797243042, 10675.0, 10709.892901070967, 10731.409772462512, 10742.979416955377, 10756.139508839275, 10425.426601536912, 10474.790504189874, 10492.0, 10493.160547156285, 10499.73750656232, 42873.35689964653, 43087.784561076995, 43103.35344969828, 43110.568894311284, 43237.35143972843, 3590.299891521154, 3748.7001039917013, 3810.0665336992615, 3974.721769476138, 4143.585641435832, 32545.0, 33263.16842078943, 33694.831525842455, 33987.15032124192, 34170.65829341725, 4365.4106695596, 4501.4598248210095, 4547.681662283641, 4577.153226653079, 4605.148047611203, 347754.0, 348885.0, 349470.0, 349937.0, 350492.0, 38294.42558361627, 39352.60647393547, 64199.679001604694, 64708.67645661742, 64793.0, 40522.0, 41109.58890411058, 41200.793996029824, 41253.1749365011, 41273.79363103165, 15463.84536154624, 15728.370865165265, 15733.44932927342, 15734.449294274646, 15742.212889355487, 10309.793804124025, 12627.747445051047, 12826.486940522274, 12862.614121576367, 12864.807027894589, 8901.376903616814, 9218.76953076165, 9524.666636667822, 9528.618855245713, 9595.664151754656, 3583.910402239913, 3593.6226696196522, 3644.562652481666, 3653.159773252167, 3672.944905826415, 1058.4919238765435, 1106.8118419868642, 1167.4979758703669, 1173.2139466557428, 1188.851393575803, 32442.675573243967, 32687.019389418354, 32693.67306326954, 32802.50796238059, 32945.835270823496, 980.5930538826307, 1117.4692021289984, 1177.3406892140429, 1179.728662407651, 1182.1370399608334, 16218.918905405397, 18214.90892545529, 18240.543986400182, 18695.81304186968, 19101.808981910282, 520959.0, 523183.0, 526903.0, 527195.0, 527781.0, 62939.0, 63351.68324158442, 63450.36549634537, 63497.0, 63655.36344636587, 1285.1453783234044, 1339.4106593099004, 1395.7836535336835, 1440.7622742247622, 1459.6350912271932, 31008.53487197739, 34846.65153348434, 35374.0, 35416.291674165856, 35688.0, 53534.732326339676, 54176.458235418715, 54182.45817541932, 54200.45799541954, 54510.727446362514, 403092.0, 403272.0, 406265.0, 409754.0, 410286.0, 29918.401631967674, 30091.247718807204, 30629.0, 31310.37379252448, 32464.51303230406, 49890.501094988584, 49973.75013124911, 50778.49221507738, 51260.48739512557, 51580.0, 41957.79021104875, 42112.15775684531, 42283.36574951317, 43882.34176487419, 44363.778181108886, 42058.0, 42247.366289506295, 42613.36079958865, 43103.35344969891, 43707.78146109249, 42994.140117196854, 43857.122857543305, 44595.777021114685, 44701.32948005848, 44726.329105062796, 35616.0, 37863.81068094642, 38194.23611527698, 38530.80734596309, 38533.22933541369, 28996.710032899402, 29400.26499337534, 29661.40677186401, 29734.851325744097, 29815.254618634706], "value": 19899.72283498134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3702165470283, 404.2662567440098, 408.12457279136254, 410.93630487274476, 431.77547675208893, 15345.53963381099, 19808.30670926518, 20057.498562535944, 20260.797392026074, 20276.188952441884, 12070.939645301783, 12230.021598272138, 12632.747345053116, 12775.169613975086, 12783.360831958387, 5212.635115541913, 5408.675479471244, 5409.107497262947, 5410.242566040757, 5410.864728381803, 3979.2638361902996, 4324.913501729963, 5331.440198779131, 5427.972860135694, 6607.900881486781, 6658.567193132455, 6661.100751398548, 6663.100481434993, 6671.59970401775, 6675.198976122872, 6094.878102437927, 6107.5113990880845, 6111.54163437744, 6234.470070044029, 6662.800115996503, 5920.615160014585, 5944.583879128462, 5944.613600116022, 5945.0, 5947.791827286068, 12897.35513224335, 12920.54778082772, 12940.094193406465, 12943.741125177443, 12959.611211663665, 2407.687000689899, 2667.093188315982, 2667.199840047978, 2713.877875495588, 2816.7746580273733, 10159.644412445603, 10486.475676216234, 10655.147588193004, 10734.302270352402, 10848.457577121113, 1939.9612007759906, 1962.0484065228352, 1991.9004049797597, 2026.230032587622, 2051.8974051297523, 83600.0, 87678.0, 90134.5493272536, 90631.0, 91476.0, 11401.429928503541, 11475.598354057567, 11495.252808567417, 11537.250078744855, 11766.235194712317, 16485.17574121289, 16493.17534123313, 16521.83478165227, 16524.0, 16541.58646033859, 8388.538630375266, 8395.496270223806, 8452.366072544584, 8553.572321383906, 8560.315174786003, 7964.721234756756, 7979.8404031919035, 8095.878561821577, 8179.386546009073, 8208.138145494637, 4742.241241401359, 4872.4153101628035, 4890.902181956341, 4899.289603007615, 5035.874103147451, 1982.3953694123431, 1994.4216177308417, 2022.4236092713506, 2031.0961622078328, 2046.5395286060518, 970.4565443351746, 999.6786394086994, 1051.854953688466, 1080.443571560647, 1094.63876920616, 20046.0, 20410.69383959242, 20959.47601309949, 21004.894975525025, 21059.473513161985, 1044.2220545693508, 1062.3625824505389, 1062.4900047977014, 1085.0505807418508, 1089.0525243038608, 10694.19793515474, 11492.655220343404, 11514.76970460603, 11531.13516486267, 11566.132540059529, 464693.0, 471111.0, 483016.0, 486843.0, 487451.0, 97579.0, 98763.50618247007, 101021.49489252653, 101041.0, 102131.0, 1032.9225308101923, 1036.18659352408, 1039.8163855902694, 1044.8798388185455, 1051.4637534857125, 17831.821681783014, 18204.72692909581, 18766.6246675063, 18779.924463961623, 18978.0, 44131.99999999871, 44365.55634443614, 44605.77697111623, 44785.55214447814, 45016.32475512935, 55840.720796395755, 59092.0, 63401.0, 63848.0, 64777.35222647713, 8830.293576513992, 8948.105189481, 9051.818963620823, 9090.09099090112, 9230.584623691815, 12461.750764984468, 13614.387352569356, 13689.315534223448, 13968.790468142783, 14238.145711257357, 11664.533418663159, 12170.878291217328, 12189.707966267917, 12275.202111863058, 12454.81317780216, 11944.906553961888, 11974.22167559106, 12009.699757506132, 12106.394680266128, 12243.816342754688, 12346.938265308616, 12421.937890310852, 12431.378431078228, 12461.626151215478, 12597.93701031489, 8893.688720894737, 8922.286217102486, 9046.140616641409, 9072.319576031692, 9318.860217096613, 9299.349045566745, 11645.0, 12117.212381195193, 12392.75214495723, 12536.247825130522], "value": 9340.480999374748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.9193648381092, 1499.6400863792687, 1526.1453585991846, 1624.1879060469764, 1765.814589468105, 7194.56832590045, 8283.171682831713, 8583.356248281389, 8585.098564650716, 8798.384113112084, 8278.296344810698, 8366.790830229247, 8367.2469477747, 8367.828504009443, 8371.623276952536, 2484.2423060966353, 2510.259473455326, 2512.723600403954, 2514.233158886539, 2515.811314151437, 2399.2682231919257, 2530.367408147963, 2532.025170309435, 2536.69559652841, 2539.0, 2428.162284012013, 2468.4322605800676, 2472.6043832986634, 2480.5659009673327, 2487.0300582772734, 2329.4642232286583, 2367.3371455992265, 2391.784739373456, 2443.2548072837776, 2443.5479436304163, 2417.7340492545804, 2437.9878100609562, 2467.7408872068354, 2468.6790717206827, 2475.7648023437746, 7970.800729981739, 8597.398182127254, 8646.740597782014, 8764.912350876473, 8794.164554367326, 5464.398916119224, 5598.468145526209, 5601.103823388279, 5604.887902241932, 5607.186957891124, 3307.6361600223954, 3405.8126803025825, 3416.1118109291515, 3448.637893021247, 3450.8612157987804, 1034.6171916390908, 1038.2368958815264, 1046.879608844985, 1059.8357254625546, 1079.9676009719722, 11902.047836173086, 11926.224795388272, 11990.580329688419, 11996.280223186637, 11999.760004799855, 4524.7511386873375, 4777.235642297216, 4782.3543821584335, 4833.806647734052, 4872.025594880967, 9643.373180743229, 9714.271429642806, 9723.708288751348, 9728.319017668837, 9731.951340243395, 5437.972810135924, 5441.646292990943, 5482.0, 5490.203920431515, 5490.56075513958, 4250.107477429774, 4358.150160718693, 4575.862724118282, 5102.4642412546145, 5143.27994080829, 3981.7013723970817, 4012.0, 4115.71190016702, 4120.1553681495225, 4120.546739858613, 1273.7834568123255, 1300.4148133340034, 1309.9803502947464, 1321.881030707241, 1323.2986517145928, 816.269438852224, 917.2616044084442, 925.648253663617, 935.9298052646079, 946.9431834089977, 5797.507211886952, 6169.383061693795, 6181.5363847710705, 6190.071489276645, 6223.253209614875, 487.1110223841503, 489.20015774209423, 496.80872863946917, 508.75071215104333, 512.743628185907, 3653.634636536325, 3688.317661232627, 3731.7014638828828, 4246.596573325529, 4554.726716397026, 10564.894351056391, 10669.78660426787, 10691.091257243066, 10743.086837618734, 10745.30155539903, 10446.0, 10583.100436462986, 10721.30311529748, 10729.088027517591, 10740.033396994308, 7837.3338266246865, 8034.276915077554, 8039.276465118168, 8050.919490805134, 8068.757937261891, 5866.735996880236, 5932.406759324033, 5957.046872500552, 6002.759889604367, 6065.4541091302, 9506.95246523763, 9853.06395892389, 9885.802283954137, 9897.752556186153, 9903.45530995802, 8683.392162548562, 8934.955325223593, 9905.306628535933, 10109.090181883666, 10130.341527800669, 7646.923530764621, 7800.882986755317, 7878.330341921001, 7957.403194760301, 8040.356771458386, 8605.440646357967, 8626.611802468778, 8648.351373647127, 8651.52416617067, 8657.134286571545, 7299.306565876233, 7319.817004574716, 7379.778606641809, 7390.96304518474, 7461.477696561188, 7528.0, 7611.086669599684, 7646.8088297793, 7777.533347999138, 7908.802279943047, 6705.932940670726, 6816.863662726619, 6818.147731533559, 6820.181578210647, 6822.522423430312, 5056.6713163644245, 5155.200943853709, 5163.0, 5172.689638621695, 5354.063038968243, 5118.590512758896, 5126.362797195759, 5198.428172900903, 5224.111900976767, 5323.866903327448], "value": 4552.910587392546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.3855060890397, 348.1192582765604, 349.38333840771037, 355.342616160104, 355.4774481512178, 5380.896916132193, 5428.267183930173, 5437.211604317372, 5444.21058946453, 5451.890962180764, 5280.419153893069, 5296.682199068058, 5350.892982140354, 5395.406505284415, 5398.16328469087, 3993.4009898515164, 4014.5784692607294, 4149.190907772985, 4212.473440819897, 4238.470191226097, 4186.372044193365, 4187.874363769091, 4202.97898510507, 4220.2192594370135, 4226.852060177895, 4161.500619925613, 4172.207280616673, 4185.497740271172, 4192.49690037196, 4209.473815773028, 3913.157620998312, 4017.4576432181575, 4154.335306350999, 4163.3130533462245, 4179.1223842993, 3718.851245950159, 3722.6598424567132, 3727.7390582659223, 3734.7572407793677, 3751.1559899022773, 5192.974035129838, 5223.1642937130255, 5226.477352264781, 5227.947720522822, 5228.346456692913, 4549.158405694957, 4754.690945088558, 4756.738379389132, 4763.737994410306, 4791.496892826238, 5533.253010843525, 5535.972320138414, 5545.223668686387, 5552.888942221133, 5562.221289019541, 4062.8984275393054, 4075.5924407559305, 4079.9592004079877, 4082.7754473503946, 4099.795010249476, 5479.863003424906, 5730.885382292373, 5757.625754325955, 5787.710614469218, 5828.1549175369755, 4085.4893138357706, 4111.568285329998, 4119.97940010298, 4134.359174327924, 4139.91720165595, 4197.706160568731, 4211.115665710174, 4212.347086201644, 4218.177455396169, 4225.936610950838, 4535.705179163344, 4715.080559290974, 4749.4775574686755, 4790.113828941588, 4791.760411979387, 5570.303712035996, 5579.944200558024, 5592.5805564582815, 5597.824456864023, 5601.439856014366, 1393.171063217384, 1412.569166404236, 1424.5939907126626, 1426.479335042702, 1431.5705288413435, 934.9065093490733, 974.7270764186039, 978.3493976505687, 984.2322988069318, 993.6919554937992, 5222.477752224823, 5253.605979551472, 5326.0, 5356.3572371315695, 5410.783568657288, 5671.602987790815, 5691.943080569141, 5703.885922281531, 5706.25818643582, 5717.256756621613, 5152.3044389007755, 5314.8573056792975, 5397.676139431646, 5431.619786614899, 5463.426340234298, 2920.7663386928994, 2947.6124339285248, 2951.2735049995563, 2953.8375389353364, 2956.51217549102, 5584.246126772834, 5584.413636568183, 5598.720063996865, 5621.241132447068, 5631.211630371751, 5373.489518495737, 5576.330840299109, 5579.637323573955, 5621.18492818539, 5641.830745077655, 5530.723463826873, 5570.97214513933, 5609.971950140223, 5626.465485778926, 5635.774569017275, 5162.716050617252, 5440.374356949002, 5481.109017388994, 5519.0, 5521.1442226454965, 5415.756290966837, 5421.376541697755, 5431.891362172655, 5460.290162279037, 5464.535514481314, 5609.270794796814, 5612.747426365741, 5618.606697531133, 5639.464250896158, 5641.576881733969, 3894.6300101490315, 3990.4413382127104, 3991.92016159681, 4012.518497780285, 4051.9797401012806, 5467.371252305877, 5473.370562385217, 5491.368492623399, 5510.586705996986, 5524.696141712084, 5347.679139251657, 5374.865628359323, 5398.703071331114, 5431.34823821144, 5476.152400751666, 5089.931114465856, 5272.736363181749, 5379.623426360117, 5399.5950303726595, 5417.214503896992, 5341.130604288468, 5349.331333583302, 5365.865853353697, 5367.973160134331, 5369.301990741179, 5340.2256672783005, 5432.864178395572, 5479.397266300624, 5586.692731899784, 5610.663360198401, 5462.863428414322, 5489.835304940858, 5494.560435165097, 5498.3127109111365, 5508.44915508446], "value": 4217.5283313365335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.1506961506963, 714.7105422303968, 715.7208688611443, 742.3689863615924, 745.5377665847172, 12528.24830510169, 13054.216746995164, 13065.934670326658, 13101.606951791462, 13161.736765264688, 12596.370181490935, 12690.4923803048, 12703.110782245247, 12703.936480317609, 12714.046446516502, 697.5326531224067, 712.7469748239378, 810.9391795615323, 828.1180542722012, 829.8755186721979, 840.7603832907622, 843.6878355008655, 843.725789118539, 843.7426584891606, 844.5734903873536, 892.7455675132588, 893.3344658229628, 894.9731508054737, 895.8924929008496, 895.995520022399, 732.059303794624, 751.6054071612419, 845.9873101903477, 874.0865795243985, 875.8335916175906, 649.2468736265956, 649.6459429610874, 649.7043845050491, 649.9285078641345, 649.9707513161919, 13338.333083345891, 13456.529021484299, 13492.460301587924, 13540.187588744708, 13544.45822167112, 12081.637550873487, 12685.873141268561, 12842.935785321108, 12855.421506032251, 13037.608871733863, 11164.274322169033, 11250.887491125066, 11263.43682815856, 11333.603323883706, 11437.19939604228, 4169.56219596941, 4180.519240287375, 4222.852200172979, 4240.215560121356, 4245.363195520666, 62067.37932620661, 62976.0, 63232.68383658052, 63453.68273158651, 63469.0, 9913.45475998827, 10175.236857235737, 10209.0, 10248.692539223835, 10559.419231942164, 17788.221177882107, 17809.376671816422, 17838.821611783977, 17856.55358616019, 17866.91066544659, 7604.961975190088, 7606.163322034572, 7768.417368697257, 7805.960970195113, 7865.370770338359, 4318.5681431856565, 4321.762303073361, 4391.0, 4394.956050439519, 4475.1273501666865, 2934.662513810939, 2988.551717242431, 3020.0335892514186, 3048.8170709757487, 3050.80169788963, 565.2933832709114, 571.1489880078653, 638.6104476269472, 650.9772157974448, 675.2167485716545, 644.9838754031093, 648.4423395879539, 669.4142625202948, 707.5542408282749, 722.3931897206267, 8975.927788319195, 9045.77385565353, 9054.954725226464, 9448.716538503719, 9559.856602150974, 654.5025780406925, 659.5548005096541, 660.9107770450928, 677.6239187251024, 699.0527834783795, 4377.409049778239, 4502.752348620857, 4636.374089497942, 4654.464736555272, 4667.346571479996, 92489.0, 92773.53613231891, 92884.53557732303, 93269.0, 95384.52307738418, 56846.43153568494, 65376.34623653703, 76651.0, 80203.59898200589, 82681.0, 70223.0, 70597.0, 71286.0, 71338.28661713524, 73789.6310518444, 9276.62893484253, 9354.625814967598, 9364.719058428258, 9367.718968430958, 9428.0, 46686.533134669575, 47025.76487117542, 47228.52771472241, 47381.0, 48261.75869120632, 58111.0, 65837.0, 65945.34054659391, 67169.63397379154, 68634.0, 11250.83123753128, 11426.428678566204, 11444.141689373164, 11746.412679366169, 11860.347680877634, 12916.22502649844, 13163.276019819003, 13233.007524435898, 13491.123076999964, 14564.271786410425, 12332.383380831103, 12855.0, 12874.420651070912, 13206.471741130246, 13244.470221191044, 11154.0, 11175.497102630563, 11601.767964640829, 11646.068314534987, 11687.649370518899, 11853.525858965544, 12199.512019519474, 12317.753644926872, 12360.38198090074, 13203.405846737112, 10148.13740832008, 10163.644272450429, 10175.694729158136, 10383.376997380181, 10400.0, 10076.395416274754, 10323.94838025805, 10325.535350909076, 10357.482125893826, 10479.371237725762], "value": 6921.633521971314, "unit": "score"}], "name": "dromaeo_css", "value": 7173.316726202746, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 113.0, 110.0, 112.0, 111.0, 109.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 119.0, 156.0, 122.0, 120.0, 118.0, 117.0, 147.0, 122.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 163.0, 160.0, 160.0, 162.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 106.0, 76.0, 76.0, 74.0, 76.0, 103.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 116.0, 82.0, 82.0, 81.0, 105.0, 82.0, 82.0, 115.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 50.0, 50.0, 50.0, 51.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 60.0, 59.0, 58.0, 59.0, 59.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 77.0, 74.0, 74.0, 80.0, 74.0, 74.0, 76.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 124.0, 125.0, 120.0, 128.0, 120.0, 121.0, 159.0, 135.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 159.0, 156.0, 156.0, 156.0, 158.0, 156.0, 159.0, 155.0, 155.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 62.0, 60.0, 61.0, 63.0, 60.0, 65.0, 62.0, 59.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1448.9, "alertThreshold": 2.0}]} 05:05:35 INFO - Return code: 0 05:05:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:35 INFO - # TBPL SUCCESS # 05:05:35 INFO - Running post-action listener: _resource_record_post_action 05:05:35 INFO - [mozharness: 2016-12-15 13:05:35.380136Z] Finished run-tests step (success) 05:05:35 INFO - Running post-run listener: _resource_record_post_run 05:05:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 363864064; Read time: 28; Write time: 451636 05:05:35 INFO - TinderboxPrint: CPU usage
13.0% 05:05:35 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 05:05:35 INFO - TinderboxPrint: I/O write bytes / time
363,864,064 / 451,636 05:05:35 INFO - TinderboxPrint: CPU idle
8,274.9 (87.0%) 05:05:35 INFO - TinderboxPrint: CPU user
1,193.4 (12.5%) 05:05:35 INFO - TinderboxPrint: Swap in / out
0 / 0 05:05:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118661120; Read time: 0; Write time: 143696 05:05:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 262144; Write bytes: 245202944; Read time: 12; Write time: 307940 05:05:36 INFO - Running post-run listener: _upload_blobber_files 05:05:36 INFO - Blob upload gear active. 05:05:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:36 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 05:05:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:05:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:39 INFO - (blobuploader) - INFO - Done attempting. 05:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:40 INFO - (blobuploader) - INFO - Done attempting. 05:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:05:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:41 INFO - (blobuploader) - INFO - Done attempting. 05:05:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:41 INFO - Return code: 0 05:05:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3a20c28f330872ce94c323efe1d45e4fc5c5876df653fc194be577445ee4f2a0e8612963d0ab527cfd77f691ecf7dcffdbef8f8bbd72fa6716111be3d4b4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d0303e404f8eb783f5d8b2167060752f1b34a5711b52433b36b9fd09ef4845f6a957ef02e81e0e651f8c11ca968f9c6f3971bca14e0fb7feaa8e5cd6aff7e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d1628b948139f7647bc827d70ee652b9228fe9fb6a7499db0fd4fef13a6a033e21c849dfcdae7af68569c2ff733354abd5aaadc718e290bb8ae9ec4fb91b38"} 05:05:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:41 INFO - Contents: 05:05:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3a20c28f330872ce94c323efe1d45e4fc5c5876df653fc194be577445ee4f2a0e8612963d0ab527cfd77f691ecf7dcffdbef8f8bbd72fa6716111be3d4b4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d0303e404f8eb783f5d8b2167060752f1b34a5711b52433b36b9fd09ef4845f6a957ef02e81e0e651f8c11ca968f9c6f3971bca14e0fb7feaa8e5cd6aff7e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d1628b948139f7647bc827d70ee652b9228fe9fb6a7499db0fd4fef13a6a033e21c849dfcdae7af68569c2ff733354abd5aaadc718e290bb8ae9ec4fb91b38"} 05:05:41 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:41 INFO - Copying logs to upload dir... 05:05:41 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.902076 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-15 05:05:40.881952) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:40.885228) ========= 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=745a4373a2a16df560f216e000000264-1481799855.761566-1232380804 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-Aurora/sha512/c3a20c28f330872ce94c323efe1d45e4fc5c5876df653fc194be577445ee4f2a0e8612963d0ab527cfd77f691ecf7dcffdbef8f8bbd72fa6716111be3d4b4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d0303e404f8eb783f5d8b2167060752f1b34a5711b52433b36b9fd09ef4845f6a957ef02e81e0e651f8c11ca968f9c6f3971bca14e0fb7feaa8e5cd6aff7e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d1628b948139f7647bc827d70ee652b9228fe9fb6a7499db0fd4fef13a6a033e21c849dfcdae7af68569c2ff733354abd5aaadc718e290bb8ae9ec4fb91b38"} build_url:https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011525 build_url: 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3a20c28f330872ce94c323efe1d45e4fc5c5876df653fc194be577445ee4f2a0e8612963d0ab527cfd77f691ecf7dcffdbef8f8bbd72fa6716111be3d4b4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d0303e404f8eb783f5d8b2167060752f1b34a5711b52433b36b9fd09ef4845f6a957ef02e81e0e651f8c11ca968f9c6f3971bca14e0fb7feaa8e5cd6aff7e78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d1628b948139f7647bc827d70ee652b9228fe9fb6a7499db0fd4fef13a6a033e21c849dfcdae7af68569c2ff733354abd5aaadc718e290bb8ae9ec4fb91b38"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:40.910720) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:40.911091) ========= 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=745a4373a2a16df560f216e000000264-1481799855.761566-1232380804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:40.993687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:05:40.994012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:05:40.994302) ========= ========= Total master_lag: 0.17 =========