builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1478971510.65 results: success (0) buildid: 20161112063010 builduid: 98ce3f53e6f94665a67bb91e2a1f5b35 revision: d96967030071dd928ed0460c1ec7edcc213b6419 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.650996) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.651433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.651707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.672561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.672876) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-12 09:25:10-- 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% 220M=0s 2016-11-12 09:25:11 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.817948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.821264) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016795 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.875386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:10.875726) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d96967030071dd928ed0460c1ec7edcc213b6419 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d96967030071dd928ed0460c1ec7edcc213b6419 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-12 09:25:11,192 truncating revision to first 12 chars 2016-11-12 09:25:11,192 Setting DEBUG logging. 2016-11-12 09:25:11,192 attempt 1/10 2016-11-12 09:25:11,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d96967030071?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-12 09:25:11,505 unpacking tar archive at: mozilla-inbound-d96967030071/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:11.520320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:11.520619) ========= script_repo_revision: d96967030071dd928ed0460c1ec7edcc213b6419 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:11.520996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:11.521276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 09:25:11.530967) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-12 09:25:11.531245) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:25:11 INFO - MultiFileLogger online at 20161112 09:25:11 in /builds/slave/test 09:25:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:25:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:25:11 INFO - {'append_to_log': False, 09:25:11 INFO - 'base_work_dir': '/builds/slave/test', 09:25:11 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:25:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:25:11 INFO - 'branch': 'Mozilla-Inbound', 09:25:11 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:11 INFO - 'config_files': ('talos/linux_config.py',), 09:25:11 INFO - 'default_actions': ('clobber', 09:25:11 INFO - 'read-buildbot-config', 09:25:11 INFO - 'download-and-extract', 09:25:11 INFO - 'populate-webroot', 09:25:11 INFO - 'create-virtualenv', 09:25:11 INFO - 'install', 09:25:11 INFO - 'run-tests'), 09:25:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:11 INFO - 'download_minidump_stackwalk': True, 09:25:11 INFO - 'download_symbols': 'ondemand', 09:25:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:11 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:11 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:11 INFO - 'installer_path': 'installer.exe', 09:25:11 INFO - 'log_level': 'info', 09:25:11 INFO - 'log_name': 'talos', 09:25:11 INFO - 'log_to_console': True, 09:25:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:25:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:25:11 INFO - 'opt_config_files': (), 09:25:11 INFO - 'pip_index': False, 09:25:11 INFO - 'sps_profile': False, 09:25:11 INFO - 'sps_profile_interval': 0, 09:25:11 INFO - 'suite': 'dromaeojs', 09:25:11 INFO - 'system_bits': '32', 09:25:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:11 INFO - 'title': 'talos-linux64-ix-052', 09:25:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:11 INFO - 'use_talos_json': True, 09:25:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:25:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:11 INFO - 'work_dir': 'build'} 09:25:11 INFO - [mozharness: 2016-11-12 17:25:11.940933Z] Running clobber step. 09:25:11 INFO - Running pre-action listener: _resource_record_pre_action 09:25:11 INFO - Running main action method: clobber 09:25:11 INFO - rmtree: /builds/slave/test/build 09:25:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:25:12 INFO - Running post-action listener: _resource_record_post_action 09:25:12 INFO - [mozharness: 2016-11-12 17:25:12.397481Z] Finished clobber step (success) 09:25:12 INFO - [mozharness: 2016-11-12 17:25:12.397579Z] Running read-buildbot-config step. 09:25:12 INFO - Running pre-action listener: _resource_record_pre_action 09:25:12 INFO - Running main action method: read_buildbot_config 09:25:12 INFO - Using buildbot properties: 09:25:12 INFO - { 09:25:12 INFO - "project": "", 09:25:12 INFO - "product": "firefox", 09:25:12 INFO - "script_repo_revision": "production", 09:25:12 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:25:12 INFO - "repository": "", 09:25:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:25:12 INFO - "buildid": "20161112063010", 09:25:12 INFO - "pgo_build": "True", 09:25:12 INFO - "basedir": "/builds/slave/test", 09:25:12 INFO - "buildnumber": 2045, 09:25:12 INFO - "slavename": "talos-linux64-ix-052", 09:25:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:25:12 INFO - "platform": "ubuntu64_hw", 09:25:12 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:25:12 INFO - "branch": "mozilla-inbound", 09:25:12 INFO - "repo_path": "integration/mozilla-inbound", 09:25:12 INFO - "revision": "d96967030071dd928ed0460c1ec7edcc213b6419", 09:25:12 INFO - "stage_platform": "linux64-pgo", 09:25:12 INFO - "builduid": "98ce3f53e6f94665a67bb91e2a1f5b35", 09:25:12 INFO - "slavebuilddir": "test" 09:25:12 INFO - } 09:25:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:25:12 INFO - Running post-action listener: _resource_record_post_action 09:25:12 INFO - [mozharness: 2016-11-12 17:25:12.399981Z] Finished read-buildbot-config step (success) 09:25:12 INFO - [mozharness: 2016-11-12 17:25:12.400069Z] Running download-and-extract step. 09:25:12 INFO - Running pre-action listener: _resource_record_pre_action 09:25:12 INFO - Running main action method: download_and_extract 09:25:12 INFO - mkdir: /builds/slave/test/build/tests 09:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:12 INFO - trying https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:12 INFO - Downloading https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:25:12 INFO - Downloaded 1361 bytes. 09:25:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:12 INFO - Using the following test package requirements: 09:25:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:25:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:25:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'jsshell-linux-x86_64.zip'], 09:25:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:25:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:25:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:25:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:25:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:25:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:25:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:25:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:25:12 INFO - Fetch https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:25:13 INFO - Http code: 200 09:25:13 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:25:13 INFO - x-amz-cf-id: cPkdSiPl2Pto-eYpXl7rGotwLhd-VgTvcTk0INljl93K_B7clbjk7w== 09:25:13 INFO - x-amz-version-id: PpXR3ByyyRnRrcBJuembs3b.K4dmQkIr 09:25:13 INFO - Expected file size: 21974570 09:25:13 INFO - Obtained file size: 21974570 09:25:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:25:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:25:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:25:17 INFO - Fetch https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:25:18 INFO - Http code: 200 09:25:18 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 09:25:18 INFO - x-amz-cf-id: N9qK6dYyOsuXSg_YMw_aYTzhdqo-uXWen_nz1LitoAbgvWk7ipY3yA== 09:25:18 INFO - x-amz-version-id: PpXR3ByyyRnRrcBJuembs3b.K4dmQkIr 09:25:18 INFO - Expected file size: 21974570 09:25:18 INFO - Obtained file size: 21974570 09:25:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:25:23 INFO - Fetch https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:25:23 INFO - Http code: 200 09:25:23 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 09:25:23 INFO - x-amz-cf-id: z2cdXW4BU9VK8SWCsM-G7467maWQXSb4pi8U5dVibjCbat1Nm1iA4w== 09:25:23 INFO - x-amz-version-id: FVwifB3vKyUDT62V550h8TLKYstkiIa6 09:25:23 INFO - Expected file size: 14409038 09:25:23 INFO - Obtained file size: 14409038 09:25:24 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')]} 09:25:24 INFO - trying https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:24 INFO - Downloading https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:25:25 INFO - Downloaded 59597453 bytes. 09:25:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:25 INFO - mkdir: /builds/slave/test/properties 09:25:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:25:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:25:25 INFO - Contents: 09:25:25 INFO - build_url:https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:26 INFO - Running post-action listener: _resource_record_post_action 09:25:26 INFO - Running post-action listener: set_extra_try_arguments 09:25:26 INFO - [mozharness: 2016-11-12 17:25:26.014588Z] Finished download-and-extract step (success) 09:25:26 INFO - [mozharness: 2016-11-12 17:25:26.014886Z] Running populate-webroot step. 09:25:26 INFO - Running pre-action listener: _resource_record_pre_action 09:25:26 INFO - Running main action method: populate_webroot 09:25:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:26 INFO - '--tppagecycles', 09:25:26 INFO - '7'], 09:25:26 INFO - 'tests': ['tsvgm']}}, 09:25:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:25:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:25:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:25:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['damp', 'tps']}, 09:25:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'tests': ['damp', 'tps']}, 09:25:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['dromaeo_dom']}, 09:25:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['basic_compositor_video']}, 09:25:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:25:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other-e10s': {'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tsvgx', 09:25:26 INFO - 'tsvgr_opacity', 09:25:26 INFO - 'tart', 09:25:26 INFO - 'tscrollx', 09:25:26 INFO - 'cart']}, 09:25:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:25:26 INFO - 'tsvgr_opacity', 09:25:26 INFO - 'tart', 09:25:26 INFO - 'tscrollx', 09:25:26 INFO - 'cart']}, 09:25:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tp5o']}, 09:25:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'tests': ['tp5o']}, 09:25:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s', 09:25:26 INFO - '--xperf_path', 09:25:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:26 INFO - 'tests': ['tp5n']}, 09:25:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--xperf_path', 09:25:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:26 INFO - 'tests': ['tp5n']}}, 09:25:26 INFO - 'talos.zip': {'path': '', 09:25:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:26 INFO - Running post-action listener: _resource_record_post_action 09:25:26 INFO - [mozharness: 2016-11-12 17:25:26.035952Z] Finished populate-webroot step (success) 09:25:26 INFO - [mozharness: 2016-11-12 17:25:26.036043Z] Running create-virtualenv step. 09:25:26 INFO - Running pre-action listener: _resource_record_pre_action 09:25:26 INFO - Running main action method: create_virtualenv 09:25:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:25:26 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 09:25:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:25:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:26 INFO - Using real prefix '/usr' 09:25:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:25:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:28 INFO - Installing pip.................done. 09:25:28 INFO - Return code: 0 09:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:25:28 INFO - Reading from file tmpfile_stdout 09:25:28 INFO - Output received: 09:25:28 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) 09:25:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:25:28 INFO - Using env: {'DISPLAY': ':0', 09:25:28 INFO - 'HOME': '/home/cltbld', 09:25:28 INFO - 'LANG': 'en_US.UTF-8', 09:25:28 INFO - 'LANGUAGE': 'en_US:en', 09:25:28 INFO - 'LOGNAME': 'cltbld', 09:25:28 INFO - 'MAIL': '/var/mail/cltbld', 09:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:28 INFO - 'MOZ_NO_REMOTE': '1', 09:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:28 INFO - 'NO_EM_RESTART': '1', 09:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:28 INFO - 'PWD': '/builds/slave/test', 09:25:28 INFO - 'SHELL': '/bin/bash', 09:25:28 INFO - 'SHLVL': '1', 09:25:28 INFO - 'TERM': 'linux', 09:25:28 INFO - 'TMOUT': '86400', 09:25:28 INFO - 'USER': 'cltbld', 09:25:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:28 INFO - '_': '/tools/buildbot/bin/python'} 09:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:29 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 09:25:29 INFO - Cleaning up... 09:25:29 INFO - Return code: 0 09:25:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:25:29 INFO - Using env: {'DISPLAY': ':0', 09:25:29 INFO - 'HOME': '/home/cltbld', 09:25:29 INFO - 'LANG': 'en_US.UTF-8', 09:25:29 INFO - 'LANGUAGE': 'en_US:en', 09:25:29 INFO - 'LOGNAME': 'cltbld', 09:25:29 INFO - 'MAIL': '/var/mail/cltbld', 09:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:29 INFO - 'MOZ_NO_REMOTE': '1', 09:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:29 INFO - 'NO_EM_RESTART': '1', 09:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:29 INFO - 'PWD': '/builds/slave/test', 09:25:29 INFO - 'SHELL': '/bin/bash', 09:25:29 INFO - 'SHLVL': '1', 09:25:29 INFO - 'TERM': 'linux', 09:25:29 INFO - 'TMOUT': '86400', 09:25:29 INFO - 'USER': 'cltbld', 09:25:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:29 INFO - '_': '/tools/buildbot/bin/python'} 09:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:29 INFO - Downloading/unpacking psutil>=3.1.1 09:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:31 INFO - Installing collected packages: psutil 09:25:31 INFO - Running setup.py install for psutil 09:25:31 INFO - building 'psutil._psutil_linux' extension 09:25:31 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 09:25:31 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 09:25:31 INFO - building 'psutil._psutil_posix' extension 09:25:31 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 09:25:31 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 09:25:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:31 INFO - Successfully installed psutil 09:25:31 INFO - Cleaning up... 09:25:31 INFO - Return code: 0 09:25:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:31 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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:31 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 09:25:31 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 09:25:31 INFO - Using env: {'DISPLAY': ':0', 09:25:31 INFO - 'HOME': '/home/cltbld', 09:25:31 INFO - 'LANG': 'en_US.UTF-8', 09:25:31 INFO - 'LANGUAGE': 'en_US:en', 09:25:31 INFO - 'LOGNAME': 'cltbld', 09:25:31 INFO - 'MAIL': '/var/mail/cltbld', 09:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:31 INFO - 'MOZ_NO_REMOTE': '1', 09:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:31 INFO - 'NO_EM_RESTART': '1', 09:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:31 INFO - 'PWD': '/builds/slave/test', 09:25:31 INFO - 'SHELL': '/bin/bash', 09:25:31 INFO - 'SHLVL': '1', 09:25:31 INFO - 'TERM': 'linux', 09:25:31 INFO - 'TMOUT': '86400', 09:25:31 INFO - 'USER': 'cltbld', 09:25:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:31 INFO - '_': '/tools/buildbot/bin/python'} 09:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:25:34 INFO - Installing collected packages: mozsystemmonitor 09:25:34 INFO - Running setup.py install for mozsystemmonitor 09:25:34 INFO - Successfully installed mozsystemmonitor 09:25:34 INFO - Cleaning up... 09:25:34 INFO - Return code: 0 09:25:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:34 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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:34 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 09:25:34 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 09:25:34 INFO - Using env: {'DISPLAY': ':0', 09:25:34 INFO - 'HOME': '/home/cltbld', 09:25:34 INFO - 'LANG': 'en_US.UTF-8', 09:25:34 INFO - 'LANGUAGE': 'en_US:en', 09:25:34 INFO - 'LOGNAME': 'cltbld', 09:25:34 INFO - 'MAIL': '/var/mail/cltbld', 09:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:34 INFO - 'MOZ_NO_REMOTE': '1', 09:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:34 INFO - 'NO_EM_RESTART': '1', 09:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:34 INFO - 'PWD': '/builds/slave/test', 09:25:34 INFO - 'SHELL': '/bin/bash', 09:25:34 INFO - 'SHLVL': '1', 09:25:34 INFO - 'TERM': 'linux', 09:25:34 INFO - 'TMOUT': '86400', 09:25:34 INFO - 'USER': 'cltbld', 09:25:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:34 INFO - '_': '/tools/buildbot/bin/python'} 09:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:36 INFO - warning: no files found matching '*.txt' 09:25:36 INFO - no previously-included directories found matching 'build' 09:25:36 INFO - no previously-included directories found matching 'dist' 09:25:36 INFO - no previously-included directories found matching '.git*' 09:25:36 INFO - Installing collected packages: jsonschema, functools32 09:25:36 INFO - Running setup.py install for functools32 09:25:36 INFO - warning: no files found matching '*.txt' 09:25:36 INFO - no previously-included directories found matching 'build' 09:25:36 INFO - no previously-included directories found matching 'dist' 09:25:36 INFO - no previously-included directories found matching '.git*' 09:25:36 INFO - Successfully installed jsonschema functools32 09:25:36 INFO - Cleaning up... 09:25:36 INFO - Return code: 0 09:25:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:25:36 INFO - Using env: {'DISPLAY': ':0', 09:25:36 INFO - 'HOME': '/home/cltbld', 09:25:36 INFO - 'LANG': 'en_US.UTF-8', 09:25:36 INFO - 'LANGUAGE': 'en_US:en', 09:25:36 INFO - 'LOGNAME': 'cltbld', 09:25:36 INFO - 'MAIL': '/var/mail/cltbld', 09:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:36 INFO - 'MOZ_NO_REMOTE': '1', 09:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:36 INFO - 'NO_EM_RESTART': '1', 09:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:36 INFO - 'PWD': '/builds/slave/test', 09:25:36 INFO - 'SHELL': '/bin/bash', 09:25:36 INFO - 'SHLVL': '1', 09:25:36 INFO - 'TERM': 'linux', 09:25:36 INFO - 'TMOUT': '86400', 09:25:36 INFO - 'USER': 'cltbld', 09:25:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:36 INFO - '_': '/tools/buildbot/bin/python'} 09:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:25:37 INFO - Cleaning up... 09:25:37 INFO - Return code: 0 09:25:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:37 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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:37 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 09:25:37 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 09:25:37 INFO - Using env: {'DISPLAY': ':0', 09:25:37 INFO - 'HOME': '/home/cltbld', 09:25:37 INFO - 'LANG': 'en_US.UTF-8', 09:25:37 INFO - 'LANGUAGE': 'en_US:en', 09:25:37 INFO - 'LOGNAME': 'cltbld', 09:25:37 INFO - 'MAIL': '/var/mail/cltbld', 09:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:37 INFO - 'MOZ_NO_REMOTE': '1', 09:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:37 INFO - 'NO_EM_RESTART': '1', 09:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:37 INFO - 'PWD': '/builds/slave/test', 09:25:37 INFO - 'SHELL': '/bin/bash', 09:25:37 INFO - 'SHLVL': '1', 09:25:37 INFO - 'TERM': 'linux', 09:25:37 INFO - 'TMOUT': '86400', 09:25:37 INFO - 'USER': 'cltbld', 09:25:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:37 INFO - '_': '/tools/buildbot/bin/python'} 09:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:25:37 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 09:25:37 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 09:25:37 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 09:25:37 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 09:25:37 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 09:25:37 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 09:25:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25: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 09:25:39 INFO - Downloading docopt-0.6.1.tar.gz 09:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:39 INFO - Running setup.py install for blobuploader 09:25:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:40 INFO - Running setup.py install for requests 09:25:40 INFO - Running setup.py install for docopt 09:25:40 INFO - Successfully installed blobuploader requests docopt 09:25:40 INFO - Cleaning up... 09:25:40 INFO - Return code: 0 09:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:40 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')]} 09:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:40 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')]} 09:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:40 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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:40 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 09:25:40 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 09:25:40 INFO - Using env: {'DISPLAY': ':0', 09:25:40 INFO - 'HOME': '/home/cltbld', 09:25:40 INFO - 'LANG': 'en_US.UTF-8', 09:25:40 INFO - 'LANGUAGE': 'en_US:en', 09:25:40 INFO - 'LOGNAME': 'cltbld', 09:25:40 INFO - 'MAIL': '/var/mail/cltbld', 09:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:40 INFO - 'MOZ_NO_REMOTE': '1', 09:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:40 INFO - 'NO_EM_RESTART': '1', 09:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:40 INFO - 'PWD': '/builds/slave/test', 09:25:40 INFO - 'SHELL': '/bin/bash', 09:25:40 INFO - 'SHLVL': '1', 09:25:40 INFO - 'TERM': 'linux', 09:25:40 INFO - 'TMOUT': '86400', 09:25:40 INFO - 'USER': 'cltbld', 09:25:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:40 INFO - '_': '/tools/buildbot/bin/python'} 09:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:40 INFO - Running setup.py (path:/tmp/pip-SrJkCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:40 INFO - Running setup.py (path:/tmp/pip-uGpQPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:40 INFO - Running setup.py (path:/tmp/pip-MkmJnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:40 INFO - Running setup.py (path:/tmp/pip-ydU_9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:41 INFO - Running setup.py (path:/tmp/pip-WP973R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:41 INFO - Running setup.py (path:/tmp/pip-EsMO3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:41 INFO - Running setup.py (path:/tmp/pip-DiLg07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:41 INFO - Running setup.py (path:/tmp/pip-VtuPSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:41 INFO - Running setup.py (path:/tmp/pip-8WI0xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:41 INFO - Running setup.py (path:/tmp/pip-8JG5v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:41 INFO - Running setup.py (path:/tmp/pip-Ga5ZIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:41 INFO - Running setup.py (path:/tmp/pip-V0Mdx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:41 INFO - Running setup.py (path:/tmp/pip-X5evJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:41 INFO - Running setup.py (path:/tmp/pip-xjVxPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:41 INFO - Running setup.py (path:/tmp/pip-ZZstu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:41 INFO - Running setup.py (path:/tmp/pip-OhNStz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:41 INFO - Running setup.py (path:/tmp/pip-q3FZbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:41 INFO - Running setup.py install for manifestparser 09:25:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Running setup.py install for mozcrash 09:25:42 INFO - Running setup.py install for mozdebug 09:25:42 INFO - Running setup.py install for mozdevice 09:25:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Running setup.py install for mozfile 09:25:42 INFO - Running setup.py install for mozhttpd 09:25:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Running setup.py install for mozinfo 09:25:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Running setup.py install for mozInstall 09:25:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Running setup.py install for mozleak 09:25:42 INFO - Running setup.py install for mozlog 09:25:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for moznetwork 09:25:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozprocess 09:25:43 INFO - Running setup.py install for mozprofile 09:25:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozrunner 09:25:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozscreenshot 09:25:43 INFO - Running setup.py install for moztest 09:25:43 INFO - Running setup.py install for mozversion 09:25:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:43 INFO - Cleaning up... 09:25:43 INFO - Return code: 0 09:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:43 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')]} 09:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:43 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')]} 09:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:43 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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:43 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 09:25:43 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 09:25:43 INFO - Using env: {'DISPLAY': ':0', 09:25:43 INFO - 'HOME': '/home/cltbld', 09:25:43 INFO - 'LANG': 'en_US.UTF-8', 09:25:43 INFO - 'LANGUAGE': 'en_US:en', 09:25:43 INFO - 'LOGNAME': 'cltbld', 09:25:43 INFO - 'MAIL': '/var/mail/cltbld', 09:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:43 INFO - 'MOZ_NO_REMOTE': '1', 09:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:43 INFO - 'NO_EM_RESTART': '1', 09:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:43 INFO - 'PWD': '/builds/slave/test', 09:25:43 INFO - 'SHELL': '/bin/bash', 09:25:43 INFO - 'SHLVL': '1', 09:25:43 INFO - 'TERM': 'linux', 09:25:43 INFO - 'TMOUT': '86400', 09:25:43 INFO - 'USER': 'cltbld', 09:25:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:43 INFO - '_': '/tools/buildbot/bin/python'} 09:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:43 INFO - Running setup.py (path:/tmp/pip-MEkRmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:44 INFO - Running setup.py (path:/tmp/pip-7JZ_1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:44 INFO - Running setup.py (path:/tmp/pip-2MP5xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:44 INFO - Running setup.py (path:/tmp/pip-pomke6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:44 INFO - Running setup.py (path:/tmp/pip-tsYI8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:44 INFO - Running setup.py (path:/tmp/pip-x8BN3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:44 INFO - Running setup.py (path:/tmp/pip-3vncvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:44 INFO - Running setup.py (path:/tmp/pip-vBvgDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:44 INFO - Running setup.py (path:/tmp/pip-CI9Fgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:44 INFO - Running setup.py (path:/tmp/pip-tpYtMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:44 INFO - Running setup.py (path:/tmp/pip-jAO89r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:44 INFO - Running setup.py (path:/tmp/pip-e9wujA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:44 INFO - Running setup.py (path:/tmp/pip-7A2iap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:44 INFO - Running setup.py (path:/tmp/pip-Wq4Bsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:45 INFO - Running setup.py (path:/tmp/pip-eo_f8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:45 INFO - Running setup.py (path:/tmp/pip-CSm2bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:45 INFO - Running setup.py (path:/tmp/pip-dKEqNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:45 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 09:25:45 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 09:25:45 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 09:25:45 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 09:25:45 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 09:25:45 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 09:25:47 INFO - Downloading blessings-1.6.tar.gz 09:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:47 INFO - Installing collected packages: blessings 09:25:47 INFO - Running setup.py install for blessings 09:25:47 INFO - Successfully installed blessings 09:25:47 INFO - Cleaning up... 09:25:47 INFO - Return code: 0 09:25:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:47 INFO - Reading from file tmpfile_stdout 09:25:47 INFO - Current package versions: 09:25:47 INFO - argparse == 1.2.1 09:25:47 INFO - blessings == 1.6 09:25:47 INFO - blobuploader == 1.2.4 09:25:47 INFO - docopt == 0.6.1 09:25:47 INFO - functools32 == 3.2.3-2 09:25:47 INFO - jsonschema == 2.5.1 09:25:47 INFO - manifestparser == 1.1 09:25:47 INFO - mozInstall == 1.12 09:25:47 INFO - mozcrash == 1.0 09:25:47 INFO - mozdebug == 0.1 09:25:47 INFO - mozdevice == 0.48 09:25:47 INFO - mozfile == 1.2 09:25:47 INFO - mozhttpd == 0.7 09:25:47 INFO - mozinfo == 0.9 09:25:47 INFO - mozleak == 0.1 09:25:47 INFO - mozlog == 3.4 09:25:47 INFO - moznetwork == 0.27 09:25:47 INFO - mozprocess == 0.23 09:25:47 INFO - mozprofile == 0.28 09:25:47 INFO - mozrunner == 6.13 09:25:47 INFO - mozscreenshot == 0.1 09:25:47 INFO - mozsystemmonitor == 0.3 09:25:47 INFO - moztest == 0.7 09:25:47 INFO - mozversion == 1.4 09:25:47 INFO - psutil == 3.1.1 09:25:47 INFO - requests == 1.2.3 09:25:47 INFO - wsgiref == 0.1.2 09:25:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:47 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')]} 09:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:47 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')]} 09:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:47 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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:47 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 09:25:47 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 09:25:47 INFO - Using env: {'DISPLAY': ':0', 09:25:47 INFO - 'HOME': '/home/cltbld', 09:25:47 INFO - 'LANG': 'en_US.UTF-8', 09:25:47 INFO - 'LANGUAGE': 'en_US:en', 09:25:47 INFO - 'LOGNAME': 'cltbld', 09:25:47 INFO - 'MAIL': '/var/mail/cltbld', 09:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:47 INFO - 'MOZ_NO_REMOTE': '1', 09:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:47 INFO - 'NO_EM_RESTART': '1', 09:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:47 INFO - 'PWD': '/builds/slave/test', 09:25:47 INFO - 'SHELL': '/bin/bash', 09:25:47 INFO - 'SHLVL': '1', 09:25:47 INFO - 'TERM': 'linux', 09:25:47 INFO - 'TMOUT': '86400', 09:25:47 INFO - 'USER': 'cltbld', 09:25:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:47 INFO - '_': '/tools/buildbot/bin/python'} 09:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 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)) 09:25:47 INFO - Cleaning up... 09:25:47 INFO - Return code: 0 09:25:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25:47 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')]} 09:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:47 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')]} 09:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:47 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 0x7faf5f7d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1daaca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', '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 09:25:47 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 09:25:47 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 09:25:47 INFO - Using env: {'DISPLAY': ':0', 09:25:47 INFO - 'HOME': '/home/cltbld', 09:25:47 INFO - 'LANG': 'en_US.UTF-8', 09:25:47 INFO - 'LANGUAGE': 'en_US:en', 09:25:47 INFO - 'LOGNAME': 'cltbld', 09:25:47 INFO - 'MAIL': '/var/mail/cltbld', 09:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:47 INFO - 'MOZ_NO_REMOTE': '1', 09:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:47 INFO - 'NO_EM_RESTART': '1', 09:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:47 INFO - 'PWD': '/builds/slave/test', 09:25:47 INFO - 'SHELL': '/bin/bash', 09:25:47 INFO - 'SHLVL': '1', 09:25:47 INFO - 'TERM': 'linux', 09:25:47 INFO - 'TMOUT': '86400', 09:25:47 INFO - 'USER': 'cltbld', 09:25:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:47 INFO - '_': '/tools/buildbot/bin/python'} 09:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:25:48 INFO - Cleaning up... 09:25:48 INFO - Return code: 0 09:25:48 INFO - Running post-action listener: _resource_record_post_action 09:25:48 INFO - Running post-action listener: _start_resource_monitoring 09:25:48 INFO - Starting resource monitoring. 09:25:48 INFO - [mozharness: 2016-11-12 17:25:48.096644Z] Finished create-virtualenv step (success) 09:25:48 INFO - [mozharness: 2016-11-12 17:25:48.097156Z] Running install step. 09:25:48 INFO - Running pre-action listener: _resource_record_pre_action 09:25:48 INFO - Running main action method: install 09:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:48 INFO - Reading from file tmpfile_stdout 09:25:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:48 INFO - Reading from file tmpfile_stdout 09:25:48 INFO - Output received: 09:25:48 INFO - Usage: mozinstall [options] installer 09:25:48 INFO - Options: 09:25:48 INFO - -h, --help show this help message and exit 09:25:48 INFO - -d DEST, --destination=DEST 09:25:48 INFO - Directory to install application into. [default: 09:25:48 INFO - "/builds/slave/test"] 09:25:48 INFO - --app=APP Application being installed. [default: firefox] 09:25:48 INFO - mkdir: /builds/slave/test/build/application 09:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:26:05 INFO - Reading from file tmpfile_stdout 09:26:05 INFO - Output received: 09:26:05 INFO - /builds/slave/test/build/application/firefox/firefox 09:26:05 INFO - Running post-action listener: _resource_record_post_action 09:26:05 INFO - [mozharness: 2016-11-12 17:26:05.288702Z] Finished install step (success) 09:26:05 INFO - [mozharness: 2016-11-12 17:26:05.288945Z] Running run-tests step. 09:26:05 INFO - Running pre-action listener: _resource_record_pre_action 09:26:05 INFO - Running main action method: run_tests 09:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:26:05 INFO - Python 2.7.3 09:26:05 INFO - Return code: 0 09:26:05 INFO - grabbing minidump binary from tooltool 09:26: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')]} 09:26:05 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 0x1da7f60>, '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 0x1da8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:26:05 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 09:26:05 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 09:26:05 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 09:26:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:26:05 INFO - Return code: 0 09:26:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:26:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:26:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:26:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:26:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:26:05 INFO - Using env: {'DISPLAY': ':0', 09:26:05 INFO - 'HOME': '/home/cltbld', 09:26:05 INFO - 'LANG': 'en_US.UTF-8', 09:26:05 INFO - 'LANGUAGE': 'en_US:en', 09:26:05 INFO - 'LOGNAME': 'cltbld', 09:26:05 INFO - 'MAIL': '/var/mail/cltbld', 09:26:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:26:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:05 INFO - 'MOZ_NO_REMOTE': '1', 09:26:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:05 INFO - 'NO_EM_RESTART': '1', 09:26:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:05 INFO - 'PWD': '/builds/slave/test', 09:26:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:26:05 INFO - 'SHELL': '/bin/bash', 09:26:05 INFO - 'SHLVL': '1', 09:26:05 INFO - 'TERM': 'linux', 09:26:05 INFO - 'TMOUT': '86400', 09:26:05 INFO - 'USER': 'cltbld', 09:26:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219', 09:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:05 INFO - '_': '/tools/buildbot/bin/python'} 09:26:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:26:05 INFO - mozversion application_buildid: 20161112063010 09:26:05 INFO - mozversion application_changeset: d96967030071dd928ed0460c1ec7edcc213b6419 09:26:05 INFO - mozversion application_display_name: Nightly 09:26:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:26:05 INFO - mozversion application_name: Firefox 09:26:05 INFO - mozversion application_remotingname: firefox 09:26:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:26:05 INFO - mozversion application_vendor: Mozilla 09:26:05 INFO - mozversion application_version: 52.0a1 09:26:05 INFO - mozversion platform_buildid: 20161112063010 09:26:05 INFO - mozversion platform_changeset: d96967030071dd928ed0460c1ec7edcc213b6419 09:26:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:26:05 INFO - mozversion platform_version: 52.0a1 09:26:05 INFO - using testdate: 1478971565 09:26:05 INFO - actual date: 1478971565 09:26:05 INFO - starting webserver on 'localhost:56753' 09:26:05 INFO - SUITE-START | Running 2 tests 09:26:05 INFO - TEST-START | dromaeo_css 09:26:05 INFO - operating with platform_type : linux_ 09:26:05 INFO - Initialising browser for dromaeo_css test... 09:26:05 INFO - TEST-INFO | started process 7225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdbkj3/profile http://localhost:56753/getInfo.html) 09:26:09 INFO - PROCESS | 7225 | __metrics Screen width/height:1600/1200 09:26:09 INFO - PROCESS | 7225 | colorDepth:24 09:26:09 INFO - PROCESS | 7225 | Browser inner width/height: 1024/697 09:26:09 INFO - PROCESS | 7225 | __metrics 09:26:10 INFO - PROCESS | 7225 | 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" 09:26:10 INFO - PROCESS | 7225 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:26:10 INFO - PROCESS | 7225 | console.error: PushService: 09:26:10 INFO - PROCESS | 7225 | stateChangeProcessEnqueue: Error transitioning state 09:26:10 INFO - PROCESS | 7225 | UnknownError 09:26:11 INFO - TEST-INFO | 7225: exit 0 09:26:11 INFO - Browser initialized. 09:26:11 INFO - Running cycle 1/1 for dromaeo_css test... 09:26:11 INFO - TEST-INFO | started process 7310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdbkj3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:23 INFO - PROCESS | 7310 | RSS: Main: 172871680 09:26:23 INFO - PROCESS | 7310 | 09:27:14 INFO - PROCESS | 7310 | 1478971634925 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] 09:29:24 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:56753/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56753/tests/dromaeo/cssquery-ext.html) 09:29:27 INFO - PROCESS | 7310 | RSS: Main: 448925696 09:29:27 INFO - PROCESS | 7310 | 09:32:30 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:56753/tests/dromaeo/cssquery-ext.html (next: http://localhost:56753/tests/dromaeo/cssquery-jquery.html) 09:32:31 INFO - PROCESS | 7310 | RSS: Main: 286842880 09:32:31 INFO - PROCESS | 7310 | 09:35:33 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:56753/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56753/tests/dromaeo/cssquery-mootools.html) 09:35:33 INFO - PROCESS | 7310 | RSS: Main: 258973696 09:35:33 INFO - PROCESS | 7310 | 09:38:35 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:56753/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56753/tests/dromaeo/cssquery-prototype.html) 09:38:36 INFO - PROCESS | 7310 | RSS: Main: 225161216 09:38:36 INFO - PROCESS | 7310 | 09:41:39 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:56753/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56753/tests/dromaeo/cssquery-yui.html) 09:41:39 INFO - PROCESS | 7310 | RSS: Main: 222609408 09:41:39 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:56753/tests/dromaeo/cssquery-yui.html (next: http://localhost:56753/tests/dromaeo/cssquery-dojo.html) 09:44:42 INFO - PROCESS | 7310 | RSS: Main: 315428864 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | __start_tp_report 09:44:42 INFO - PROCESS | 7310 | _x_x_mozilla_page_load 09:44:42 INFO - PROCESS | 7310 | _x_x_mozilla_page_load_details 09:44:42 INFO - PROCESS | 7310 | |i|pagename|runs| 09:44:42 INFO - PROCESS | 7310 | |0;dojo.html;3038.4378889905365;3067.6932306769313;3088.4286407014706;3105.3944480826235;3111.066679996002;5211.270422140903;5288.127458969266;5383.838484845456;5459.20841477986;5492.588055895804;5327.627066105364;5369.838904832852;5426.593005524582;5428.565714742821;5529.060059789836;4930.704157750529;4942.87642808929;4944.283078953541;4953.950460495403;4960.107180707471;4938.135826230413;4978.87552811179;4984.177610694231;5050.318207042039;5064.2403639454005;5104.310918026074;5108.565771909392;5108.8978220435565;5136.409312929024;5154.74226288686;4801.423829140491;4846.345743324641;4850;4956.776945037482;4970.502949705001;4860.465348811628;4863;4868.537488938545;4869.902601947942;4873.585745211662;5296.761645725913;5335.359756829166;5364.678119312854;5364.785408583652;5398.055340315468;5842.269716285465;5886.969780288475;5901.763929442817;5916.053431450947;5917.940820591782;5824.621399609012;5856.326522449887;5882.000059989769;5891.528677705774;5924.911126333109;5405.972970135124;5450.836474905759;5460.153676180238;5463.945360546423;5467.808626698086;5688;5760.251167348301;5819.359870414251;5899.292084949748;5958.582899197015;5732.082866741302;5831.037878750044;5832.562557808182;5835.824925252249;5838.1242813577455;5828.562857785683;5854.648721076749;5854.882902342015;5860.677662728591;5866.208061911672;5771.8557036074435;5787;5794.652320860761;5801.361850196475;5805.506531944748;5582.525485333711;5636.210930469738;5739.053056245672;5769.365369809318;5780.959427303126;4457.621102206349;4459.732416055047;4460.710053846489;4484.215262329079;4499.235130027903;3936;3957.0700885291935;3959.1289916218384;3986.0832008638176;3995.06116062725;5331.200319952039;5332.840014799563;5548.9722551386985;5555.30558680165;5570.108782594765;5914.408559144051;5919.644821310735;5926.525877929756;5943.851403714942;5981.461668449861;5617.045102332531;5624.3813180550105;5662.915056274159;5670.461306175906;5677.971610141923;4874.317595536628;4903.779329930162;4916.115099282163;5137.255098010767;5144.176931690911;5876.676782776988;5928.347881733006;5932.851678708067;5939.138824870456;5939.70301484924;5728.971355143198;5738.971305143447;5743.798967036134;5746.856328591819;5760.510356619734;5839.678817665069;5907.85230369227;5919.289685237799;5921.230240068763;5924.31870334917;5600.495955363874;5603.187537807076;5606.18710286998;5607.775688972395;5612.915806262828;5720.74256658443;5746.569007324551;5748.540116790563;5749.8275051748515;5750.7987220447085;5588.050031494575;5589;5595.916061259166;5755.510781583613;5762.855928601818;5755.36690964002;5764.884702306014;5765.250517432707;5765.7693692253515;5774.538036956949;5436.429174936733;5704.80033198836;5717.313922329347;5717.37108918027;5719.48524632785;5551.528120109836;5623.522000629992;5631.070873305859;5674.886502269849;5685.516731077904;5625.128105143709;5628.380878103323;5635.239242702347;5650.491455769001;5687.203791469115 09:44:42 INFO - PROCESS | 7310 | |1;ext.html;587.9059350503919;612.5803824380298;619.6994457688021;638.7285403703428;641.099255545958;31685.94041387311;41965;42993.785031074876;43025;45970.54029459713;44707.55292447074;45058;45078.77460612692;45146;45178.32232516515;8496.150384961486;8642.395032347738;8648.610812513452;8655.913440865605;8658;8569.485830850137;8666.566671666424;8667.21995020448;8670.653173873037;8671.956640216822;8682.43564168327;8738.30093592511;8744.606492707844;8745.300375969908;8750.3874728769;8648.437851539662;8672.826543469158;8690.04409514956;8694.826103477959;8702.34732395073;8453.112423195538;8474.322054235647;8496.405251632388;8522.232999030117;8525.914740852573;40859.182816343506;41131.38302925458;41225.58774412247;41353.58646413557;41363.1727365451;3413.6927676508985;3493.3886569850174;3525.11872031992;3527.5061491391225;3566.8038257895805;29508.26229344262;30386.240343991358;30516.389672206653;30559.38881222363;30926.381472370427;4169;4277.8288868445225;4369.541198174209;4455.1757924784015;4465.910681786346;356059;356533;356631;357796.21101894585;358042;34010;55297.1705424419;55629.165562516595;55666;55747.16379254314;35639.28721425557;36918.815405922796;37210.25579488395;37328.62671373306;37471.81264093662;14736.410543578351;14805.555833325017;14837.703245935021;14846.554603361916;14853.48012819546;12219.327936963553;12300.753984920251;12306.753864922652;12314.568990085305;12329.260244385365;8469.788255293666;8575.742727718178;8640.222379985831;8687.218150366498;8704.434211776213;3324.1191084362663;3402.3875702373316;3413.5221069050353;3423.17843717506;3424.3493736190044;1003.2375394699934;1010.2120346130031;1057.4395570347729;1070.2668671959732;1078.196743426137;30503.542446863314;30989.845050775053;31177.68822311748;31312;31730.841345793124;897.2239013253488;1067.7597540553313;1073.2648136026846;1073.9624113156;1113.109512390101;15465;16675.24961376741;16688.74966875498;16705.83294167067;16938.576535586708;519176;520030;522074;522940;524330;56771.43228567744;57349.426505735246;57388.426115739145;57388.713056435285;57507.712461437426;1179.475133565555;1219.621917205669;1279.6672865055152;1341.6645838540364;1342.8589998050259;29872.701272986993;31934.84032579822;31956.20109497281;32103.197420063752;32534.51198231981;48030.519694802606;48388.51611483981;48404.75797620989;48431;48574.75712621414;383372;385465;385856;386145;387222;27596.586051209648;28051.43897122087;28187.295317616405;28654.14037578876;29286;44979.77510112429;45400.77299613481;45463.77268113771;45640;45723.771381142884;38174.555961587226;39116.804415977735;39395.803020985855;39696.404553931134;40937.18125637411;37877.129044998066;38496.230075397776;38800.80599596984;39462;40130.1973960525;38383.80808095942;38930;39938.400923986745;39971;40136.59863401329;31688.5246721304;34969.82515087408;35248;35680.464793028645;35877;26014;26713.46573068489;26837;26858.194254172406;26970.460590787683 09:44:42 INFO - PROCESS | 7310 | |2;jquery.html;373.2385932697298;391.66512631699896;398.9122393073523;404.16741512484276;417.8029944209838;13869.167849929012;18293.908530457327;18441.354552590663;18455.261789528435;18561.164747586357;18123.275068997256;18354.449366519028;18452.630947381076;18814.52963675909;18856.90571547144;5455.481729235717;5476.315460567429;5686.715664216793;5692.345380281279;5694.943050569504;5551.417101204376;5552.583556233279;5604.579656525756;5608.775648974036;5650.26546548948;5399.325084364455;5591.4688104630195;5592.273004509408;5594.888102237953;5626.240457538221;5480.506754392104;5576.832695019156;5612.550995920316;5620.747066382022;5620.971895140518;4972.229304457815;5022;5036.672616279967;5044.192929131358;5048.1418158913075;22253.332400027863;22306;22375.328740137822;22528.04383035746;22802.201922932618;2362.569718236155;2417.8549287042656;2465.864377459239;2475.740047295044;2536.594144936801;13631.863681363258;13874.653133671638;13893.166410015432;14060.226687532182;14694.11835289886;1869.3270422647836;1870.1771220662865;1883.416140996282;1901.254230539521;1960.4608732598506;82371;82581.17418825795;82615;83249;84579.57710211471;10345.896541034645;10477.999999999847;10560.577576896992;10585.364878107339;10646.361218326925;14757.852421475647;14758.40966361355;14848.925755371154;14865.628359290888;14906;7563.205863384265;7645.923540764632;7935.841283174304;7948.483348582324;7994.080680721675;7202.7118915243855;7250.1299844018;7291.635418229067;7526.435517336112;7549.698012079565;6349.841253968688;6385.712642931079;6464.644444555501;6494.88245642085;6604.570702904296;1754.2193723793046;1797.6224992751668;1815.3464752689022;1850.2136591948367;1918.8944608046413;957.2724729205714;979.8481235408523;985.3102828020415;1001.6544292219173;1022.5500779656927;17966;18837.152328145265;18901.12084675093;18942.24231030771;19203.711944320847;1005.7636455432968;1016.3952448293254;1022.6318525330875;1042.2495803021811;1075.1130317488103;10424.478776061318;10952.671419857257;10975.890241097486;11080.279781814157;11097.611583594697;341912;427584;440520;441358;442015;95949;98828;100262.4986875061;102003;102691.48654256831;1039.3867618105203;1043.7442826507554;1047.8899715529913;1051.93688378696;1076.7577295108695;16528.83471165321;16555.25501352418;17112;17425;17677.91161044238;40811.79594102011;40813.795931020155;40926.38610420906;41199.58800412077;42503.574964249965;56933.43066569281;57472.425275746704;58736;59051.11423328739;59493.405065948784;7838.3337416320255;7980.521168729895;8050.758477245692;8113.959430203047;8341.374396920377;12237.816432753694;12413.93793031029;12629.873701263237;13237.139585926883;13404.061715679809;11807.940960295144;12048.819267710816;12117.636470905887;12224.633261002184;12280.815787763013;11182.944085279521;11329.546818127183;11449.771004580029;11600.477978490819;12068.577599783965;11686.18196726221;11728.530858765555;11983.880161198276;12106.455209515418;12324.691882703004;7979.401544884273;8351.081381048201;8372.581370931552;8605.95697021511;8677.134416100569;8264.586770661563;11029.172812039289;11471.4264286787;11661.416929153338;12019.939900300442 09:44:42 INFO - PROCESS | 7310 | |3;mootools.html;1326.4959315460123;1455.8980871339006;1480.4670318685273;1584.7226735321317;1771.521689143931;6998.895016574749;7852.489588176772;8069.1527389624125;8115.63479643416;8403.117672644375;8204.138565450632;8267.29727973123;8270.793230169249;8278.875816862752;8278.95860520698;2251.3808702606793;2272.375096848372;2272.8295377846725;2277.635578307471;2277.6925115109498;2217.5786600545925;2261.852979556332;2294.701688780456;2296.5406918616345;2297.9080836766593;2223.344113486525;2236.2955668964305;2250.2349201271563;2254.222293308814;2267.138487374795;2208.0615738311153;2227.721534808149;2238;2242.136777340719;2245.045855511409;2217.523232505019;2218.1127548980376;2227.3318004598555;2231.319447568491;2234.5419189066365;7927.5243485391065;8022.879656805153;8032.799180020488;8167.469114507538;8235.629396677165;4900;4983.177775667047;4995.225740010304;5084.339035925343;5086.77109530072;3084.400053575181;3257.7068063874126;3277.6394596594355;3295.2915123248376;3330.1008727643402;1033.2818691009677;1051.390193687667;1070.1438848920832;1093.1691914145306;1098.4343063322394;11134.944325278322;11171.16216283782;11241.606543771011;11242.269252498643;11245.775084498346;4093.2222877653153;4347.695661303678;4372.431583894074;4423.314386270134;4434.600885920283;8783;8831.955840220759;8833.205011548991;8837.116288371111;8844.867326990101;4901.926471102936;4921.827736029221;4922.040202160544;4922.50774922512;4923.507649235048;3972.4239985201984;4076.612721791425;4448.088141930896;4514.413126293561;4521.4853024237245;3581.1405262736757;3656.6160553142067;3703;3737.570179429346;3775.86784462548;1148.2249481599886;1155.3760969076773;1156.5489459110954;1162.1342100135284;1166.1836714300025;826.3182874128868;934.4766930518931;951.6288647427509;957.3346524165638;961.293449314753;5249.2126181073145;5386.784528618811;5598.384177740445;5660.235868157828;5763.366029736726;882.7042940614966;924.246738907788;939.0890835889177;963.9759006024765;996.3822430093388;3630.2920930418313;3808.2383523295453;3811.5235595550557;3851.30676478231;3876.4185372194397;9724.854127188099;9849.113579777855;10004.349717268355;10098.798024039477;10103.898961010444;9829.655962041294;9956.452395118193;10099.899001010042;10107.140893024029;10157.390556566483;7535.321821036133;7573.46985710995;7679.308862202317;7725.652345644459;7748.573828439377;5305.469453054664;5335.673454008225;5343.866403339792;5441.319835020622;5457.399686034453;8991.23574496149;9178.357514973888;9240.584173712334;9250;9266.027067157851;8704.738857834274;8869.423487473294;8985.955070224607;9187.310951678784;9205.125513076247;5982.282126144891;6383.329750376143;7036.085308909809;7167.319104685047;7174.282571742784;8049.557274349967;8112.269895709414;8113.959430202811;8118.741595052777;8124.55314957683;7090.858182836418;7195.615916130578;7311.305425984523;7325.926740732524;7410.777676669709;6992.545484543489;6993.720251189896;7003.26465721092;7030.50786444944;7173.641317934187;6676.532642714963;6807.761728339485;6810.829729256809;6813.591184528944;6820.420264277592;4641.86074417768;4749.382580264543;4749.691270067435;4822.7829747660735;4823.421189457287;4640.303954406866;4674.088552732184;4698.365720627671;4735.502772208868;4908.705477671351 09:44:42 INFO - PROCESS | 7310 | |4;prototype.html;330.8024167227002;338.65288079718283;345.25080575151924;349.059285226315;350.60206665434754;5041.596672266219;5100.821471248507;5163.967206558689;5206.713630750312;5209.973950130254;4949.604031677466;5062.493750624935;5108.310378098956;5119.513646203614;5127.641065125434;4078.6125318094732;4086.5300490443533;4089.284375234337;4092.4884389451317;4102.118044620399;3806.7906265155543;3842.8078596070222;4080.224757296104;4107.876763697094;4121.732087414323;4006.779627120507;4011.97994010031;4014.518257809067;4019.839206431739;4031.8185681644395;4003.959960400388;4005.7396269242554;4013.9397909031386;4015.959840401617;4032.737872038308;3579.319929213441;3581.767185132958;3589.8743543976097;3596.6762991330643;3600.0919512658334;4955.355803745526;5017.949820501784;5028.572571331405;5031.396232452093;5042.924356134661;4479.664025198123;4511.774411279423;4536.117511232835;4557.430321209848;4589.449266088091;5242.449542797989;5282.260483532308;5292.735363231823;5297.205419187114;5318.654287471302;3781.4516895050065;3881.5342158941107;3897.649211570972;3900.1224724436775;3921.8039098044983;5536.280283563111;5537.640053396516;5545.944540554583;5551.916721249185;5561.1648156108795;3978.3236849735613;3982.5220973482787;3988.4216788565495;3993.281209382339;4001.4998125234347;3970.4242884782125;3995.5205375355144;4017.774578753508;4030.6372426481757;4058.6550143237564;4544.750038747835;4547.590716835501;4555.886102847456;4557.635389168859;4565.497795242521;5364.60520264734;5389.461053894657;5391.757370918318;5398.78404863801;5400.540954018952;1282.5318758653211;1310.6264714556496;1356.9185848849102;1363.8158848555518;1368.60310509953;961.6345788600287;963.4315753705348;976.2190247801872;980.7744218829566;995.5022488755623;5069.366329208849;5084.56781173597;5088.414832294334;5110;5111.977604479119;5277.340332458442;5281.656692314988;5290.470952904756;5296.894062118813;5311.548518375904;4925.975370123127;5048.6718363307;5077.365329333833;5094.5669618082875;5097.592192624581;2777.972220277771;2778.9166325010283;2787.972120278812;2790.3024243939017;2806.1020473448707;5405.486448801247;5460.088968860867;5487.478689524489;5492.862678433071;5497.5601951843755;5341.172118321666;5398.541124004503;5414.756335964891;5641.548676105902;5724.542036637143;5823.79616713413;5825.834833033495;5828.154917536934;5832.096025116114;5832.620879642895;5504.862378440571;5618.4662457066515;5621.8594535136945;5640.576956728344;5644.491995720405;5484.698341591251;5542.473465020817;5551.278333816578;5557.388687244319;5559.805406810742;5717.456841600041;5748;5768.826935191951;5776.249087618583;5781.277340332458;3938.133610605662;4044.8584299549375;4050.6354428101613;4061.756294622332;4069.206504731549;5297.602679799107;5509.752061157177;5536.474034966672;5551.444855514416;5569.805056822992;5300.761465734128;5323.813666521653;5436.945630543644;5453.209284653783;5455.809046683347;5409.513143817076;5412.566994640498;5422.62041657096;5423.5932305076485;5432.511074003359;5225.5819534437915;5326.174442961347;5359.490848369399;5367.1680889462195;5375.220593013913;5426.755795989269;5441.619086663895;5455.536279416294;5457.235986961908;5463.344398672185;5335.413104558573;5340.732963351895;5355.598330125178;5364.570834333166;5366.946330536644 09:44:42 INFO - PROCESS | 7310 | |5;yui.html;709.9751508697195;725.3834240895238;753.4838635534659;809.3808236698923;828.5898480252276;15675.686486270282;16487.917560412196;16534.83465165348;16875.324987000506;17094.401695940644;14321.212333321662;14338.354774035168;14349.856501434982;14353.784693229583;14391.136531808099;678.2877978122951;792.5720111139992;809.3201710563126;809.5628360685223;811.3063330852125;689.9344562266576;697.1390332938817;697.7174244430988;698.7659134190027;783.2285199078902;834.8038211020436;841.1840514700731;841.3437518735396;842.3471809347743;842.5492361586553;825.983480330396;832.9125441828581;833.9874901876477;839.0099682374795;839.1105428246049;515.7962604771132;531.532251618577;604.7127614383177;606.2694453183902;611.0254144639293;13200.471981120743;13662;13681.657958551017;14095.154290742588;14119.71760564783;13431.597052088453;13565;13799.379027943767;13826.170429774145;13948.930255348658;11409.315441073562;11489.770204595945;11548.653540393801;11703.765924681544;11892.583759568373;3620.131168519563;3633.8001409922445;3659.9451008234896;3672.6143754905615;3733.9439908401396;64344.034839477914;64718.676406618135;67533.3246667532;67842;67900.66049669769;10107.595696172071;10145.695629131138;10152.839513538876;10261.640842570474;10475.266731328733;19368.128434220493;19501.609967800563;19585.510362241057;19967.900160499394;20004.19983200685;8080.757577272691;8125.309348705427;8293.792655183668;8388;8482.321414286842;4617.468991066004;4628.097520983376;4634.281686338623;4677.22825733757;4813.7593120343845;3287.4904389819617;3313.801171929692;3377.7973321600784;3391.762576619613;3408.4887266910164;597.9431953964366;601.4406601860312;606.3996643323078;607.6506009044817;614.3395849461847;514.8687084793429;533.405253142743;567.2472061330509;575.91937128802;599.706143989442;8738.126187381211;8799.956000219958;8945.776355591031;9101.499417531966;9156.404833685789;524.4231345519897;571.034950932922;583.9854003649858;665.7657299574701;707.5259576084036;4288.89277768052;4292.570742925683;4347.500037495728;4381.145676593033;4430.446194225722;83920;84485;87366;87970.56014720013;88605.55697221472;73277;75477;75661;77851.22148778553;81926.18073819185;69121;69249.65375173092;69823.65088174527;70867;74841.6257918707;8354.415190936576;8475.406721529434;8489.95755021221;8531.445456045338;8561.14388561139;47044.52955470538;47474.52525474701;48156.759216203696;48386.75806620944;48450.27324590205;54615;54814.45185548093;59300;59925.40074599198;63725.6813715947;11794.705132371759;11869.643910682693;12012.63962081139;12037.578684745991;12631.621051368473;12796.296203708886;12915.540003181377;12936.223826570436;12950.740985180055;13085.280309583064;11786.646400607995;12051.698707532381;12283.201591896855;12744.235345879277;12820.551280705131;11267.26762760418;11666.300021998708;11829.408529573659;11985.34080625574;12067.456964436446;12252.019838413084;12409.503619855466;12472.438740256892;12606.93696531548;13411;10148.289619726549;10404.895951040393;10518.579256829642;10636.202284828823;10966.670999870017;9654.2276617869;10079.996012659629;10243.7439064024;10309.587616495257;10384.273100883167 09:44:42 INFO - PROCESS | 7310 | __end_tp_report 09:44:42 INFO - PROCESS | 7310 | __start_cc_report 09:44:42 INFO - PROCESS | 7310 | _x_x_mozilla_cycle_collect,2929 09:44:42 INFO - PROCESS | 7310 | __end_cc_report 09:44:42 INFO - PROCESS | 7310 | __startTimestamp1478972682855__endTimestamp 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | ------- Summary: start ------- 09:44:42 INFO - PROCESS | 7310 | Number of tests: 6 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | [#0] dojo.html Cycles:165 Average:5394.42 Median:5623.52 stddev:613.78 (10.9%) stddev-sans-first:587.18 09:44:42 INFO - PROCESS | 7310 | Values: 3038.4 3067.7 3088.4 3105.4 3111.1 5211.3 5288.1 5383.8 5459.2 5492.6 5327.6 5369.8 5426.6 5428.6 5529.1 4930.7 4942.9 4944.3 4954.0 4960.1 4938.1 4978.9 4984.2 5050.3 5064.2 5104.3 5108.6 5108.9 5136.4 5154.7 4801.4 4846.3 4850.0 4956.8 4970.5 4860.5 4863.0 4868.5 4869.9 4873.6 5296.8 5335.4 5364.7 5364.8 5398.1 5842.3 5887.0 5901.8 5916.1 5917.9 5824.6 5856.3 5882.0 5891.5 5924.9 5406.0 5450.8 5460.2 5463.9 5467.8 5688.0 5760.3 5819.4 5899.3 5958.6 5732.1 5831.0 5832.6 5835.8 5838.1 5828.6 5854.6 5854.9 5860.7 5866.2 5771.9 5787.0 5794.7 5801.4 5805.5 5582.5 5636.2 5739.1 5769.4 5781.0 4457.6 4459.7 4460.7 4484.2 4499.2 3936.0 3957.1 3959.1 3986.1 3995.1 5331.2 5332.8 5549.0 5555.3 5570.1 5914.4 5919.6 5926.5 5943.9 5981.5 5617.0 5624.4 5662.9 5670.5 5678.0 4874.3 4903.8 4916.1 5137.3 5144.2 5876.7 5928.3 5932.9 5939.1 5939.7 5729.0 5739.0 5743.8 5746.9 5760.5 5839.7 5907.9 5919.3 5921.2 5924.3 5600.5 5603.2 5606.2 5607.8 5612.9 5720.7 5746.6 5748.5 5749.8 5750.8 5588.1 5589.0 5595.9 5755.5 5762.9 5755.4 5764.9 5765.3 5765.8 5774.5 5436.4 5704.8 5717.3 5717.4 5719.5 5551.5 5623.5 5631.1 5674.9 5685.5 5625.1 5628.4 5635.2 5650.5 5687.2 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | [#1] ext.html Cycles:180 Average:56733.42 Median:38865.40 stddev:113483.71 (292.0%) stddev-sans-first:113723.77 09:44:42 INFO - PROCESS | 7310 | Values: 587.9 612.6 619.7 638.7 641.1 31685.9 41965.0 42993.8 43025.0 45970.5 44707.6 45058.0 45078.8 45146.0 45178.3 8496.2 8642.4 8648.6 8655.9 8658.0 8569.5 8666.6 8667.2 8670.7 8672.0 8682.4 8738.3 8744.6 8745.3 8750.4 8648.4 8672.8 8690.0 8694.8 8702.3 8453.1 8474.3 8496.4 8522.2 8525.9 40859.2 41131.4 41225.6 41353.6 41363.2 3413.7 3493.4 3525.1 3527.5 3566.8 29508.3 30386.2 30516.4 30559.4 30926.4 4169.0 4277.8 4369.5 4455.2 4465.9 356059.0 356533.0 356631.0 357796.2 358042.0 34010.0 55297.2 55629.2 55666.0 55747.2 35639.3 36918.8 37210.3 37328.6 37471.8 14736.4 14805.6 14837.7 14846.6 14853.5 12219.3 12300.8 12306.8 12314.6 12329.3 8469.8 8575.7 8640.2 8687.2 8704.4 3324.1 3402.4 3413.5 3423.2 3424.3 1003.2 1010.2 1057.4 1070.3 1078.2 30503.5 30989.8 31177.7 31312.0 31730.8 897.2 1067.8 1073.3 1074.0 1113.1 15465.0 16675.2 16688.7 16705.8 16938.6 519176.0 520030.0 522074.0 522940.0 524330.0 56771.4 57349.4 57388.4 57388.7 57507.7 1179.5 1219.6 1279.7 1341.7 1342.9 29872.7 31934.8 31956.2 32103.2 32534.5 48030.5 48388.5 48404.8 48431.0 48574.8 383372.0 385465.0 385856.0 386145.0 387222.0 27596.6 28051.4 28187.3 28654.1 29286.0 44979.8 45400.8 45463.8 45640.0 45723.8 38174.6 39116.8 39395.8 39696.4 40937.2 37877.1 38496.2 38800.8 39462.0 40130.2 38383.8 38930.0 39938.4 39971.0 40136.6 31688.5 34969.8 35248.0 35680.5 35877.0 26014.0 26713.5 26837.0 26858.2 26970.5 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | [#2] jquery.html Cycles:180 Average:27230.06 Median:22340.66 stddev:70059.34 (313.6%) stddev-sans-first:70226.86 09:44:42 INFO - PROCESS | 7310 | Values: 373.2 391.7 398.9 404.2 417.8 13869.2 18293.9 18441.4 18455.3 18561.2 18123.3 18354.4 18452.6 18814.5 18856.9 5455.5 5476.3 5686.7 5692.3 5694.9 5551.4 5552.6 5604.6 5608.8 5650.3 5399.3 5591.5 5592.3 5594.9 5626.2 5480.5 5576.8 5612.6 5620.7 5621.0 4972.2 5022.0 5036.7 5044.2 5048.1 22253.3 22306.0 22375.3 22528.0 22802.2 2362.6 2417.9 2465.9 2475.7 2536.6 13631.9 13874.7 13893.2 14060.2 14694.1 1869.3 1870.2 1883.4 1901.3 1960.5 82371.0 82581.2 82615.0 83249.0 84579.6 10345.9 10478.0 10560.6 10585.4 10646.4 14757.9 14758.4 14848.9 14865.6 14906.0 7563.2 7645.9 7935.8 7948.5 7994.1 7202.7 7250.1 7291.6 7526.4 7549.7 6349.8 6385.7 6464.6 6494.9 6604.6 1754.2 1797.6 1815.3 1850.2 1918.9 957.3 979.8 985.3 1001.7 1022.6 17966.0 18837.2 18901.1 18942.2 19203.7 1005.8 1016.4 1022.6 1042.2 1075.1 10424.5 10952.7 10975.9 11080.3 11097.6 341912.0 427584.0 440520.0 441358.0 442015.0 95949.0 98828.0 100262.5 102003.0 102691.5 1039.4 1043.7 1047.9 1051.9 1076.8 16528.8 16555.3 17112.0 17425.0 17677.9 40811.8 40813.8 40926.4 41199.6 42503.6 56933.4 57472.4 58736.0 59051.1 59493.4 7838.3 7980.5 8050.8 8114.0 8341.4 12237.8 12413.9 12629.9 13237.1 13404.1 11807.9 12048.8 12117.6 12224.6 12280.8 11182.9 11329.5 11449.8 11600.5 12068.6 11686.2 11728.5 11983.9 12106.5 12324.7 7979.4 8351.1 8372.6 8606.0 8677.1 8264.6 11029.2 11471.4 11661.4 12019.9 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | [#3] mootools.html Cycles:180 Average:5349.59 Median:4923.01 stddev:2963.42 (60.2%) stddev-sans-first:2956.31 09:44:42 INFO - PROCESS | 7310 | Values: 1326.5 1455.9 1480.5 1584.7 1771.5 6998.9 7852.5 8069.2 8115.6 8403.1 8204.1 8267.3 8270.8 8278.9 8279.0 2251.4 2272.4 2272.8 2277.6 2277.7 2217.6 2261.9 2294.7 2296.5 2297.9 2223.3 2236.3 2250.2 2254.2 2267.1 2208.1 2227.7 2238.0 2242.1 2245.0 2217.5 2218.1 2227.3 2231.3 2234.5 7927.5 8022.9 8032.8 8167.5 8235.6 4900.0 4983.2 4995.2 5084.3 5086.8 3084.4 3257.7 3277.6 3295.3 3330.1 1033.3 1051.4 1070.1 1093.2 1098.4 11134.9 11171.2 11241.6 11242.3 11245.8 4093.2 4347.7 4372.4 4423.3 4434.6 8783.0 8832.0 8833.2 8837.1 8844.9 4901.9 4921.8 4922.0 4922.5 4923.5 3972.4 4076.6 4448.1 4514.4 4521.5 3581.1 3656.6 3703.0 3737.6 3775.9 1148.2 1155.4 1156.5 1162.1 1166.2 826.3 934.5 951.6 957.3 961.3 5249.2 5386.8 5598.4 5660.2 5763.4 882.7 924.2 939.1 964.0 996.4 3630.3 3808.2 3811.5 3851.3 3876.4 9724.9 9849.1 10004.3 10098.8 10103.9 9829.7 9956.5 10099.9 10107.1 10157.4 7535.3 7573.5 7679.3 7725.7 7748.6 5305.5 5335.7 5343.9 5441.3 5457.4 8991.2 9178.4 9240.6 9250.0 9266.0 8704.7 8869.4 8986.0 9187.3 9205.1 5982.3 6383.3 7036.1 7167.3 7174.3 8049.6 8112.3 8114.0 8118.7 8124.6 7090.9 7195.6 7311.3 7325.9 7410.8 6992.5 6993.7 7003.3 7030.5 7173.6 6676.5 6807.8 6810.8 6813.6 6820.4 4641.9 4749.4 4749.7 4822.8 4823.4 4640.3 4674.1 4698.4 4735.5 4908.7 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | [#4] prototype.html Cycles:180 Average:4532.81 Median:5123.58 stddev:1325.15 (25.9%) stddev-sans-first:1290.79 09:44:42 INFO - PROCESS | 7310 | Values: 330.8 338.7 345.3 349.1 350.6 5041.6 5100.8 5164.0 5206.7 5210.0 4949.6 5062.5 5108.3 5119.5 5127.6 4078.6 4086.5 4089.3 4092.5 4102.1 3806.8 3842.8 4080.2 4107.9 4121.7 4006.8 4012.0 4014.5 4019.8 4031.8 4004.0 4005.7 4013.9 4016.0 4032.7 3579.3 3581.8 3589.9 3596.7 3600.1 4955.4 5017.9 5028.6 5031.4 5042.9 4479.7 4511.8 4536.1 4557.4 4589.4 5242.4 5282.3 5292.7 5297.2 5318.7 3781.5 3881.5 3897.6 3900.1 3921.8 5536.3 5537.6 5545.9 5551.9 5561.2 3978.3 3982.5 3988.4 3993.3 4001.5 3970.4 3995.5 4017.8 4030.6 4058.7 4544.8 4547.6 4555.9 4557.6 4565.5 5364.6 5389.5 5391.8 5398.8 5400.5 1282.5 1310.6 1356.9 1363.8 1368.6 961.6 963.4 976.2 980.8 995.5 5069.4 5084.6 5088.4 5110.0 5112.0 5277.3 5281.7 5290.5 5296.9 5311.5 4926.0 5048.7 5077.4 5094.6 5097.6 2778.0 2778.9 2788.0 2790.3 2806.1 5405.5 5460.1 5487.5 5492.9 5497.6 5341.2 5398.5 5414.8 5641.5 5724.5 5823.8 5825.8 5828.2 5832.1 5832.6 5504.9 5618.5 5621.9 5640.6 5644.5 5484.7 5542.5 5551.3 5557.4 5559.8 5717.5 5748.0 5768.8 5776.2 5781.3 3938.1 4044.9 4050.6 4061.8 4069.2 5297.6 5509.8 5536.5 5551.4 5569.8 5300.8 5323.8 5436.9 5453.2 5455.8 5409.5 5412.6 5422.6 5423.6 5432.5 5225.6 5326.2 5359.5 5367.2 5375.2 5426.8 5441.6 5455.5 5457.2 5463.3 5335.4 5340.7 5355.6 5364.6 5366.9 09:44:42 INFO - PROCESS | 7310 | 09:44:42 INFO - PROCESS | 7310 | [#5] yui.html Cycles:180 Average:17701.20 Median:26485.26 stddev:23651.45 (89.3%) stddev-sans-first:23683.39 09:44:42 INFO - PROCESS | 7310 | Values: 710.0 725.4 753.5 809.4 828.6 15675.7 16487.9 16534.8 16875.3 17094.4 14321.2 14338.4 14349.9 14353.8 14391.1 678.3 792.6 809.3 809.6 811.3 689.9 697.1 697.7 698.8 783.2 834.8 841.2 841.3 842.3 842.5 826.0 832.9 834.0 839.0 839.1 515.8 531.5 604.7 606.3 611.0 13200.5 13662.0 13681.7 14095.2 14119.7 13431.6 13565.0 13799.4 13826.2 13948.9 11409.3 11489.8 11548.7 11703.8 11892.6 3620.1 3633.8 3659.9 3672.6 3733.9 64344.0 64718.7 67533.3 67842.0 67900.7 10107.6 10145.7 10152.8 10261.6 10475.3 19368.1 19501.6 19585.5 19967.9 20004.2 8080.8 8125.3 8293.8 8388.0 8482.3 4617.5 4628.1 4634.3 4677.2 4813.8 3287.5 3313.8 3377.8 3391.8 3408.5 597.9 601.4 606.4 607.7 614.3 514.9 533.4 567.2 575.9 599.7 8738.1 8800.0 8945.8 9101.5 9156.4 524.4 571.0 584.0 665.8 707.5 4288.9 4292.6 4347.5 4381.1 4430.4 83920.0 84485.0 87366.0 87970.6 88605.6 73277.0 75477.0 75661.0 77851.2 81926.2 69121.0 69249.7 69823.7 70867.0 74841.6 8354.4 8475.4 8490.0 8531.4 8561.1 47044.5 47474.5 48156.8 48386.8 48450.3 54615.0 54814.5 59300.0 59925.4 63725.7 11794.7 11869.6 12012.6 12037.6 12631.6 12796.3 12915.5 12936.2 12950.7 13085.3 11786.6 12051.7 12283.2 12744.2 12820.6 11267.3 11666.3 11829.4 11985.3 12067.5 12252.0 12409.5 12472.4 12606.9 13411.0 10148.3 10404.9 10518.6 10636.2 10966.7 9654.2 10080.0 10243.7 10309.6 10384.3 09:44:42 INFO - PROCESS | 7310 | -------- Summary: end -------- 09:44:42 INFO - PROCESS | 7310 | 09:44:43 INFO - TEST-INFO | 7310: exit 0 09:44:43 INFO - TEST-OK | dromaeo_css | took 1118216ms 09:44:43 INFO - TEST-START | kraken 09:44:43 INFO - operating with platform_type : linux_ 09:44:43 INFO - Initialising browser for kraken test... 09:44:43 INFO - TEST-INFO | started process 7616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpGosq/profile http://localhost:56753/getInfo.html) 09:44:47 INFO - PROCESS | 7616 | __metrics Screen width/height:1600/1200 09:44:47 INFO - PROCESS | 7616 | colorDepth:24 09:44:47 INFO - PROCESS | 7616 | Browser inner width/height: 1024/697 09:44:47 INFO - PROCESS | 7616 | __metrics 09:44:48 INFO - PROCESS | 7616 | 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" 09:44:48 INFO - PROCESS | 7616 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:48 INFO - PROCESS | 7616 | console.error: PushService: 09:44:48 INFO - PROCESS | 7616 | stateChangeProcessEnqueue: Error transitioning state 09:44:48 INFO - PROCESS | 7616 | UnknownError 09:44:49 INFO - TEST-INFO | 7616: exit 0 09:44:49 INFO - Browser initialized. 09:44:49 INFO - Running cycle 1/1 for kraken test... 09:44:49 INFO - TEST-INFO | started process 7701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpGosq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:01 INFO - PROCESS | 7701 | RSS: Main: 172896256 09:45:01 INFO - PROCESS | 7701 | 09:45:03 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56753/tests/kraken/driver.html?testName=audio-beat-detection) 09:45:04 INFO - PROCESS | 7701 | RSS: Main: 238075904 09:45:04 INFO - PROCESS | 7701 | 09:45:07 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56753/tests/kraken/driver.html?testName=audio-dft) 09:45:08 INFO - PROCESS | 7701 | RSS: Main: 216498176 09:45:08 INFO - PROCESS | 7701 | 09:45:11 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56753/tests/kraken/driver.html?testName=audio-fft) 09:45:11 INFO - PROCESS | 7701 | RSS: Main: 298139648 09:45:11 INFO - PROCESS | 7701 | 09:45:13 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56753/tests/kraken/driver.html?testName=audio-oscillator) 09:45:14 INFO - PROCESS | 7701 | RSS: Main: 207159296 09:45:14 INFO - PROCESS | 7701 | 09:45:16 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56753/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:45:17 INFO - PROCESS | 7701 | RSS: Main: 212783104 09:45:17 INFO - PROCESS | 7701 | 09:45:20 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56753/tests/kraken/driver.html?testName=imaging-darkroom) 09:45:20 INFO - PROCESS | 7701 | RSS: Main: 251969536 09:45:20 INFO - PROCESS | 7701 | 09:45:24 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56753/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:24 INFO - PROCESS | 7701 | RSS: Main: 251760640 09:45:24 INFO - PROCESS | 7701 | 09:45:27 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56753/tests/kraken/driver.html?testName=json-parse-financial) 09:45:28 INFO - PROCESS | 7701 | RSS: Main: 251437056 09:45:28 INFO - PROCESS | 7701 | 09:45:29 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56753/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:30 INFO - PROCESS | 7701 | RSS: Main: 213639168 09:45:30 INFO - PROCESS | 7701 | 09:45:31 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:32 INFO - PROCESS | 7701 | RSS: Main: 220647424 09:45:32 INFO - PROCESS | 7701 | 09:45:34 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:35 INFO - PROCESS | 7701 | RSS: Main: 229326848 09:45:35 INFO - PROCESS | 7701 | 09:45:37 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:38 INFO - PROCESS | 7701 | RSS: Main: 238198784 09:45:38 INFO - PROCESS | 7701 | 09:45:41 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:41 INFO - PROCESS | 7701 | RSS: Main: 234414080 09:45:41 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:56753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56753/tests/kraken/driver.html?testName=ai-astar) 09:45:43 INFO - PROCESS | 7701 | RSS: Main: 286769152 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | __start_tp_report 09:45:43 INFO - PROCESS | 7701 | _x_x_mozilla_page_load 09:45:43 INFO - PROCESS | 7701 | _x_x_mozilla_page_load_details 09:45:43 INFO - PROCESS | 7701 | |i|pagename|runs| 09:45:43 INFO - PROCESS | 7701 | |0;ai-astar;115;112;112;111;113;113;112;112;112;112 09:45:43 INFO - PROCESS | 7701 | |1;audio-beat-detection;152;124;126;168;126;124;124;131;166;133 09:45:43 INFO - PROCESS | 7701 | |2;audio-dft;161;160;161;160;159;162;159;160;160;162 09:45:43 INFO - PROCESS | 7701 | |3;audio-fft;74;75;75;112;78;77;77;76;99;74 09:45:43 INFO - PROCESS | 7701 | |4;audio-oscillator;83;82;107;82;81;82;117;82;82;108 09:45:43 INFO - PROCESS | 7701 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;116;117 09:45:43 INFO - PROCESS | 7701 | |6;imaging-darkroom;145;145;145;145;145;146;145;146;145;146 09:45:43 INFO - PROCESS | 7701 | |7;imaging-desaturate;85;85;84;85;85;84;84;84;84;84 09:45:43 INFO - PROCESS | 7701 | |8;json-parse-financial;53;51;51;51;51;52;54;54;53;54 09:45:43 INFO - PROCESS | 7701 | |9;json-stringify-tinderbox;62;63;62;63;63;63;63;63;63;62 09:45:43 INFO - PROCESS | 7701 | |10;stanford-crypto-aes;79;80;79;80;79;82;80;79;79;79 09:45:43 INFO - PROCESS | 7701 | |11;stanford-crypto-ccm;130;141;140;129;131;141;140;143;174;131 09:45:43 INFO - PROCESS | 7701 | |12;stanford-crypto-pbkdf2;168;168;162;166;164;168;162;161;166;168 09:45:43 INFO - PROCESS | 7701 | |13;stanford-crypto-sha256-iterative;64;65;66;65;65;64;64;63;67;64 09:45:43 INFO - PROCESS | 7701 | __end_tp_report 09:45:43 INFO - PROCESS | 7701 | __start_cc_report 09:45:43 INFO - PROCESS | 7701 | _x_x_mozilla_cycle_collect,1702 09:45:43 INFO - PROCESS | 7701 | __end_cc_report 09:45:43 INFO - PROCESS | 7701 | __startTimestamp1478972743810__endTimestamp 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | ------- Summary: start ------- 09:45:43 INFO - PROCESS | 7701 | Number of tests: 14 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:1.07 (1.0%) stddev-sans-first:0.60 09:45:43 INFO - PROCESS | 7701 | Values: 115.0 112.0 112.0 111.0 113.0 113.0 112.0 112.0 112.0 112.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:132.00 stddev:17.72 (13.4%) stddev-sans-first:17.99 09:45:43 INFO - PROCESS | 7701 | Values: 152.0 124.0 126.0 168.0 126.0 124.0 124.0 131.0 166.0 133.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 09:45:43 INFO - PROCESS | 7701 | Values: 161.0 160.0 161.0 160.0 159.0 162.0 159.0 160.0 160.0 162.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.50 stddev:12.98 (17.0%) stddev-sans-first:13.46 09:45:43 INFO - PROCESS | 7701 | Values: 74.0 75.0 75.0 112.0 78.0 77.0 77.0 76.0 99.0 74.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:14.10 (17.2%) stddev-sans-first:14.68 09:45:43 INFO - PROCESS | 7701 | Values: 83.0 82.0 107.0 82.0 81.0 82.0 117.0 82.0 82.0 108.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:45:43 INFO - PROCESS | 7701 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:45:43 INFO - PROCESS | 7701 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 09:45:43 INFO - PROCESS | 7701 | Values: 85.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:1.35 (2.5%) stddev-sans-first:1.41 09:45:43 INFO - PROCESS | 7701 | Values: 53.0 51.0 51.0 51.0 51.0 52.0 54.0 54.0 53.0 54.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 09:45:43 INFO - PROCESS | 7701 | Values: 62.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:0.97 (1.2%) stddev-sans-first:1.00 09:45:43 INFO - PROCESS | 7701 | Values: 79.0 80.0 79.0 80.0 79.0 82.0 80.0 79.0 79.0 79.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:140.50 stddev:13.12 (9.3%) stddev-sans-first:13.41 09:45:43 INFO - PROCESS | 7701 | Values: 130.0 141.0 140.0 129.0 131.0 141.0 140.0 143.0 174.0 131.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:167.00 stddev:2.83 (1.7%) stddev-sans-first:2.83 09:45:43 INFO - PROCESS | 7701 | Values: 168.0 168.0 162.0 166.0 164.0 168.0 162.0 161.0 166.0 168.0 09:45:43 INFO - PROCESS | 7701 | 09:45:43 INFO - PROCESS | 7701 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 09:45:43 INFO - PROCESS | 7701 | Values: 64.0 65.0 66.0 65.0 65.0 64.0 64.0 63.0 67.0 64.0 09:45:43 INFO - PROCESS | 7701 | -------- Summary: end -------- 09:45:43 INFO - PROCESS | 7701 | 09:45:44 INFO - TEST-INFO | 7701: exit 0 09:45:44 INFO - TEST-OK | kraken | took 61176ms 09:45:44 INFO - SUITE-END | took 1179s 09:45:44 INFO - Completed test suite (00:19:39) 09:45:44 INFO - javascript benchmark 09:45:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.4378889905365, 3067.6932306769313, 3088.4286407014706, 3105.3944480826235, 3111.066679996002, 5211.270422140903, 5288.127458969266, 5383.838484845456, 5459.20841477986, 5492.588055895804, 5327.627066105364, 5369.838904832852, 5426.593005524582, 5428.565714742821, 5529.060059789836, 4930.704157750529, 4942.87642808929, 4944.283078953541, 4953.950460495403, 4960.107180707471, 4938.135826230413, 4978.87552811179, 4984.177610694231, 5050.318207042039, 5064.2403639454005, 5104.310918026074, 5108.565771909392, 5108.8978220435565, 5136.409312929024, 5154.74226288686, 4801.423829140491, 4846.345743324641, 4850.0, 4956.776945037482, 4970.502949705001, 4860.465348811628, 4863.0, 4868.537488938545, 4869.902601947942, 4873.585745211662, 5296.761645725913, 5335.359756829166, 5364.678119312854, 5364.785408583652, 5398.055340315468, 5842.269716285465, 5886.969780288475, 5901.763929442817, 5916.053431450947, 5917.940820591782, 5824.621399609012, 5856.326522449887, 5882.000059989769, 5891.528677705774, 5924.911126333109, 5405.972970135124, 5450.836474905759, 5460.153676180238, 5463.945360546423, 5467.808626698086, 5688.0, 5760.251167348301, 5819.359870414251, 5899.292084949748, 5958.582899197015, 5732.082866741302, 5831.037878750044, 5832.562557808182, 5835.824925252249, 5838.1242813577455, 5828.562857785683, 5854.648721076749, 5854.882902342015, 5860.677662728591, 5866.208061911672, 5771.8557036074435, 5787.0, 5794.652320860761, 5801.361850196475, 5805.506531944748, 5582.525485333711, 5636.210930469738, 5739.053056245672, 5769.365369809318, 5780.959427303126, 4457.621102206349, 4459.732416055047, 4460.710053846489, 4484.215262329079, 4499.235130027903, 3936.0, 3957.0700885291935, 3959.1289916218384, 3986.0832008638176, 3995.06116062725, 5331.200319952039, 5332.840014799563, 5548.9722551386985, 5555.30558680165, 5570.108782594765, 5914.408559144051, 5919.644821310735, 5926.525877929756, 5943.851403714942, 5981.461668449861, 5617.045102332531, 5624.3813180550105, 5662.915056274159, 5670.461306175906, 5677.971610141923, 4874.317595536628, 4903.779329930162, 4916.115099282163, 5137.255098010767, 5144.176931690911, 5876.676782776988, 5928.347881733006, 5932.851678708067, 5939.138824870456, 5939.70301484924, 5728.971355143198, 5738.971305143447, 5743.798967036134, 5746.856328591819, 5760.510356619734, 5839.678817665069, 5907.85230369227, 5919.289685237799, 5921.230240068763, 5924.31870334917, 5600.495955363874, 5603.187537807076, 5606.18710286998, 5607.775688972395, 5612.915806262828, 5720.74256658443, 5746.569007324551, 5748.540116790563, 5749.8275051748515, 5750.7987220447085, 5588.050031494575, 5589.0, 5595.916061259166, 5755.510781583613, 5762.855928601818, 5755.36690964002, 5764.884702306014, 5765.250517432707, 5765.7693692253515, 5774.538036956949, 5436.429174936733, 5704.80033198836, 5717.313922329347, 5717.37108918027, 5719.48524632785, 5551.528120109836, 5623.522000629992, 5631.070873305859, 5674.886502269849, 5685.516731077904, 5625.128105143709, 5628.380878103323, 5635.239242702347, 5650.491455769001, 5687.203791469115], "value": 5352.382000589067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9059350503919, 612.5803824380298, 619.6994457688021, 638.7285403703428, 641.099255545958, 31685.94041387311, 41965.0, 42993.785031074876, 43025.0, 45970.54029459713, 44707.55292447074, 45058.0, 45078.77460612692, 45146.0, 45178.32232516515, 8496.150384961486, 8642.395032347738, 8648.610812513452, 8655.913440865605, 8658.0, 8569.485830850137, 8666.566671666424, 8667.21995020448, 8670.653173873037, 8671.956640216822, 8682.43564168327, 8738.30093592511, 8744.606492707844, 8745.300375969908, 8750.3874728769, 8648.437851539662, 8672.826543469158, 8690.04409514956, 8694.826103477959, 8702.34732395073, 8453.112423195538, 8474.322054235647, 8496.405251632388, 8522.232999030117, 8525.914740852573, 40859.182816343506, 41131.38302925458, 41225.58774412247, 41353.58646413557, 41363.1727365451, 3413.6927676508985, 3493.3886569850174, 3525.11872031992, 3527.5061491391225, 3566.8038257895805, 29508.26229344262, 30386.240343991358, 30516.389672206653, 30559.38881222363, 30926.381472370427, 4169.0, 4277.8288868445225, 4369.541198174209, 4455.1757924784015, 4465.910681786346, 356059.0, 356533.0, 356631.0, 357796.21101894585, 358042.0, 34010.0, 55297.1705424419, 55629.165562516595, 55666.0, 55747.16379254314, 35639.28721425557, 36918.815405922796, 37210.25579488395, 37328.62671373306, 37471.81264093662, 14736.410543578351, 14805.555833325017, 14837.703245935021, 14846.554603361916, 14853.48012819546, 12219.327936963553, 12300.753984920251, 12306.753864922652, 12314.568990085305, 12329.260244385365, 8469.788255293666, 8575.742727718178, 8640.222379985831, 8687.218150366498, 8704.434211776213, 3324.1191084362663, 3402.3875702373316, 3413.5221069050353, 3423.17843717506, 3424.3493736190044, 1003.2375394699934, 1010.2120346130031, 1057.4395570347729, 1070.2668671959732, 1078.196743426137, 30503.542446863314, 30989.845050775053, 31177.68822311748, 31312.0, 31730.841345793124, 897.2239013253488, 1067.7597540553313, 1073.2648136026846, 1073.9624113156, 1113.109512390101, 15465.0, 16675.24961376741, 16688.74966875498, 16705.83294167067, 16938.576535586708, 519176.0, 520030.0, 522074.0, 522940.0, 524330.0, 56771.43228567744, 57349.426505735246, 57388.426115739145, 57388.713056435285, 57507.712461437426, 1179.475133565555, 1219.621917205669, 1279.6672865055152, 1341.6645838540364, 1342.8589998050259, 29872.701272986993, 31934.84032579822, 31956.20109497281, 32103.197420063752, 32534.51198231981, 48030.519694802606, 48388.51611483981, 48404.75797620989, 48431.0, 48574.75712621414, 383372.0, 385465.0, 385856.0, 386145.0, 387222.0, 27596.586051209648, 28051.43897122087, 28187.295317616405, 28654.14037578876, 29286.0, 44979.77510112429, 45400.77299613481, 45463.77268113771, 45640.0, 45723.771381142884, 38174.555961587226, 39116.804415977735, 39395.803020985855, 39696.404553931134, 40937.18125637411, 37877.129044998066, 38496.230075397776, 38800.80599596984, 39462.0, 40130.1973960525, 38383.80808095942, 38930.0, 39938.400923986745, 39971.0, 40136.59863401329, 31688.5246721304, 34969.82515087408, 35248.0, 35680.464793028645, 35877.0, 26014.0, 26713.46573068489, 26837.0, 26858.194254172406, 26970.460590787683], "value": 18407.643477681428, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.2385932697298, 391.66512631699896, 398.9122393073523, 404.16741512484276, 417.8029944209838, 13869.167849929012, 18293.908530457327, 18441.354552590663, 18455.261789528435, 18561.164747586357, 18123.275068997256, 18354.449366519028, 18452.630947381076, 18814.52963675909, 18856.90571547144, 5455.481729235717, 5476.315460567429, 5686.715664216793, 5692.345380281279, 5694.943050569504, 5551.417101204376, 5552.583556233279, 5604.579656525756, 5608.775648974036, 5650.26546548948, 5399.325084364455, 5591.4688104630195, 5592.273004509408, 5594.888102237953, 5626.240457538221, 5480.506754392104, 5576.832695019156, 5612.550995920316, 5620.747066382022, 5620.971895140518, 4972.229304457815, 5022.0, 5036.672616279967, 5044.192929131358, 5048.1418158913075, 22253.332400027863, 22306.0, 22375.328740137822, 22528.04383035746, 22802.201922932618, 2362.569718236155, 2417.8549287042656, 2465.864377459239, 2475.740047295044, 2536.594144936801, 13631.863681363258, 13874.653133671638, 13893.166410015432, 14060.226687532182, 14694.11835289886, 1869.3270422647836, 1870.1771220662865, 1883.416140996282, 1901.254230539521, 1960.4608732598506, 82371.0, 82581.17418825795, 82615.0, 83249.0, 84579.57710211471, 10345.896541034645, 10477.999999999847, 10560.577576896992, 10585.364878107339, 10646.361218326925, 14757.852421475647, 14758.40966361355, 14848.925755371154, 14865.628359290888, 14906.0, 7563.205863384265, 7645.923540764632, 7935.841283174304, 7948.483348582324, 7994.080680721675, 7202.7118915243855, 7250.1299844018, 7291.635418229067, 7526.435517336112, 7549.698012079565, 6349.841253968688, 6385.712642931079, 6464.644444555501, 6494.88245642085, 6604.570702904296, 1754.2193723793046, 1797.6224992751668, 1815.3464752689022, 1850.2136591948367, 1918.8944608046413, 957.2724729205714, 979.8481235408523, 985.3102828020415, 1001.6544292219173, 1022.5500779656927, 17966.0, 18837.152328145265, 18901.12084675093, 18942.24231030771, 19203.711944320847, 1005.7636455432968, 1016.3952448293254, 1022.6318525330875, 1042.2495803021811, 1075.1130317488103, 10424.478776061318, 10952.671419857257, 10975.890241097486, 11080.279781814157, 11097.611583594697, 341912.0, 427584.0, 440520.0, 441358.0, 442015.0, 95949.0, 98828.0, 100262.4986875061, 102003.0, 102691.48654256831, 1039.3867618105203, 1043.7442826507554, 1047.8899715529913, 1051.93688378696, 1076.7577295108695, 16528.83471165321, 16555.25501352418, 17112.0, 17425.0, 17677.91161044238, 40811.79594102011, 40813.795931020155, 40926.38610420906, 41199.58800412077, 42503.574964249965, 56933.43066569281, 57472.425275746704, 58736.0, 59051.11423328739, 59493.405065948784, 7838.3337416320255, 7980.521168729895, 8050.758477245692, 8113.959430203047, 8341.374396920377, 12237.816432753694, 12413.93793031029, 12629.873701263237, 13237.139585926883, 13404.061715679809, 11807.940960295144, 12048.819267710816, 12117.636470905887, 12224.633261002184, 12280.815787763013, 11182.944085279521, 11329.546818127183, 11449.771004580029, 11600.477978490819, 12068.577599783965, 11686.18196726221, 11728.530858765555, 11983.880161198276, 12106.455209515418, 12324.691882703004, 7979.401544884273, 8351.081381048201, 8372.581370931552, 8605.95697021511, 8677.134416100569, 8264.586770661563, 11029.172812039289, 11471.4264286787, 11661.416929153338, 12019.939900300442], "value": 9194.242685269082, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.4959315460123, 1455.8980871339006, 1480.4670318685273, 1584.7226735321317, 1771.521689143931, 6998.895016574749, 7852.489588176772, 8069.1527389624125, 8115.63479643416, 8403.117672644375, 8204.138565450632, 8267.29727973123, 8270.793230169249, 8278.875816862752, 8278.95860520698, 2251.3808702606793, 2272.375096848372, 2272.8295377846725, 2277.635578307471, 2277.6925115109498, 2217.5786600545925, 2261.852979556332, 2294.701688780456, 2296.5406918616345, 2297.9080836766593, 2223.344113486525, 2236.2955668964305, 2250.2349201271563, 2254.222293308814, 2267.138487374795, 2208.0615738311153, 2227.721534808149, 2238.0, 2242.136777340719, 2245.045855511409, 2217.523232505019, 2218.1127548980376, 2227.3318004598555, 2231.319447568491, 2234.5419189066365, 7927.5243485391065, 8022.879656805153, 8032.799180020488, 8167.469114507538, 8235.629396677165, 4900.0, 4983.177775667047, 4995.225740010304, 5084.339035925343, 5086.77109530072, 3084.400053575181, 3257.7068063874126, 3277.6394596594355, 3295.2915123248376, 3330.1008727643402, 1033.2818691009677, 1051.390193687667, 1070.1438848920832, 1093.1691914145306, 1098.4343063322394, 11134.944325278322, 11171.16216283782, 11241.606543771011, 11242.269252498643, 11245.775084498346, 4093.2222877653153, 4347.695661303678, 4372.431583894074, 4423.314386270134, 4434.600885920283, 8783.0, 8831.955840220759, 8833.205011548991, 8837.116288371111, 8844.867326990101, 4901.926471102936, 4921.827736029221, 4922.040202160544, 4922.50774922512, 4923.507649235048, 3972.4239985201984, 4076.612721791425, 4448.088141930896, 4514.413126293561, 4521.4853024237245, 3581.1405262736757, 3656.6160553142067, 3703.0, 3737.570179429346, 3775.86784462548, 1148.2249481599886, 1155.3760969076773, 1156.5489459110954, 1162.1342100135284, 1166.1836714300025, 826.3182874128868, 934.4766930518931, 951.6288647427509, 957.3346524165638, 961.293449314753, 5249.2126181073145, 5386.784528618811, 5598.384177740445, 5660.235868157828, 5763.366029736726, 882.7042940614966, 924.246738907788, 939.0890835889177, 963.9759006024765, 996.3822430093388, 3630.2920930418313, 3808.2383523295453, 3811.5235595550557, 3851.30676478231, 3876.4185372194397, 9724.854127188099, 9849.113579777855, 10004.349717268355, 10098.798024039477, 10103.898961010444, 9829.655962041294, 9956.452395118193, 10099.899001010042, 10107.140893024029, 10157.390556566483, 7535.321821036133, 7573.46985710995, 7679.308862202317, 7725.652345644459, 7748.573828439377, 5305.469453054664, 5335.673454008225, 5343.866403339792, 5441.319835020622, 5457.399686034453, 8991.23574496149, 9178.357514973888, 9240.584173712334, 9250.0, 9266.027067157851, 8704.738857834274, 8869.423487473294, 8985.955070224607, 9187.310951678784, 9205.125513076247, 5982.282126144891, 6383.329750376143, 7036.085308909809, 7167.319104685047, 7174.282571742784, 8049.557274349967, 8112.269895709414, 8113.959430202811, 8118.741595052777, 8124.55314957683, 7090.858182836418, 7195.615916130578, 7311.305425984523, 7325.926740732524, 7410.777676669709, 6992.545484543489, 6993.720251189896, 7003.26465721092, 7030.50786444944, 7173.641317934187, 6676.532642714963, 6807.761728339485, 6810.829729256809, 6813.591184528944, 6820.420264277592, 4641.86074417768, 4749.382580264543, 4749.691270067435, 4822.7829747660735, 4823.421189457287, 4640.303954406866, 4674.088552732184, 4698.365720627671, 4735.502772208868, 4908.705477671351], "value": 4331.577346169691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.8024167227002, 338.65288079718283, 345.25080575151924, 349.059285226315, 350.60206665434754, 5041.596672266219, 5100.821471248507, 5163.967206558689, 5206.713630750312, 5209.973950130254, 4949.604031677466, 5062.493750624935, 5108.310378098956, 5119.513646203614, 5127.641065125434, 4078.6125318094732, 4086.5300490443533, 4089.284375234337, 4092.4884389451317, 4102.118044620399, 3806.7906265155543, 3842.8078596070222, 4080.224757296104, 4107.876763697094, 4121.732087414323, 4006.779627120507, 4011.97994010031, 4014.518257809067, 4019.839206431739, 4031.8185681644395, 4003.959960400388, 4005.7396269242554, 4013.9397909031386, 4015.959840401617, 4032.737872038308, 3579.319929213441, 3581.767185132958, 3589.8743543976097, 3596.6762991330643, 3600.0919512658334, 4955.355803745526, 5017.949820501784, 5028.572571331405, 5031.396232452093, 5042.924356134661, 4479.664025198123, 4511.774411279423, 4536.117511232835, 4557.430321209848, 4589.449266088091, 5242.449542797989, 5282.260483532308, 5292.735363231823, 5297.205419187114, 5318.654287471302, 3781.4516895050065, 3881.5342158941107, 3897.649211570972, 3900.1224724436775, 3921.8039098044983, 5536.280283563111, 5537.640053396516, 5545.944540554583, 5551.916721249185, 5561.1648156108795, 3978.3236849735613, 3982.5220973482787, 3988.4216788565495, 3993.281209382339, 4001.4998125234347, 3970.4242884782125, 3995.5205375355144, 4017.774578753508, 4030.6372426481757, 4058.6550143237564, 4544.750038747835, 4547.590716835501, 4555.886102847456, 4557.635389168859, 4565.497795242521, 5364.60520264734, 5389.461053894657, 5391.757370918318, 5398.78404863801, 5400.540954018952, 1282.5318758653211, 1310.6264714556496, 1356.9185848849102, 1363.8158848555518, 1368.60310509953, 961.6345788600287, 963.4315753705348, 976.2190247801872, 980.7744218829566, 995.5022488755623, 5069.366329208849, 5084.56781173597, 5088.414832294334, 5110.0, 5111.977604479119, 5277.340332458442, 5281.656692314988, 5290.470952904756, 5296.894062118813, 5311.548518375904, 4925.975370123127, 5048.6718363307, 5077.365329333833, 5094.5669618082875, 5097.592192624581, 2777.972220277771, 2778.9166325010283, 2787.972120278812, 2790.3024243939017, 2806.1020473448707, 5405.486448801247, 5460.088968860867, 5487.478689524489, 5492.862678433071, 5497.5601951843755, 5341.172118321666, 5398.541124004503, 5414.756335964891, 5641.548676105902, 5724.542036637143, 5823.79616713413, 5825.834833033495, 5828.154917536934, 5832.096025116114, 5832.620879642895, 5504.862378440571, 5618.4662457066515, 5621.8594535136945, 5640.576956728344, 5644.491995720405, 5484.698341591251, 5542.473465020817, 5551.278333816578, 5557.388687244319, 5559.805406810742, 5717.456841600041, 5748.0, 5768.826935191951, 5776.249087618583, 5781.277340332458, 3938.133610605662, 4044.8584299549375, 4050.6354428101613, 4061.756294622332, 4069.206504731549, 5297.602679799107, 5509.752061157177, 5536.474034966672, 5551.444855514416, 5569.805056822992, 5300.761465734128, 5323.813666521653, 5436.945630543644, 5453.209284653783, 5455.809046683347, 5409.513143817076, 5412.566994640498, 5422.62041657096, 5423.5932305076485, 5432.511074003359, 5225.5819534437915, 5326.174442961347, 5359.490848369399, 5367.1680889462195, 5375.220593013913, 5426.755795989269, 5441.619086663895, 5455.536279416294, 5457.235986961908, 5463.344398672185, 5335.413104558573, 5340.732963351895, 5355.598330125178, 5364.570834333166, 5366.946330536644], "value": 4118.145824818808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9751508697195, 725.3834240895238, 753.4838635534659, 809.3808236698923, 828.5898480252276, 15675.686486270282, 16487.917560412196, 16534.83465165348, 16875.324987000506, 17094.401695940644, 14321.212333321662, 14338.354774035168, 14349.856501434982, 14353.784693229583, 14391.136531808099, 678.2877978122951, 792.5720111139992, 809.3201710563126, 809.5628360685223, 811.3063330852125, 689.9344562266576, 697.1390332938817, 697.7174244430988, 698.7659134190027, 783.2285199078902, 834.8038211020436, 841.1840514700731, 841.3437518735396, 842.3471809347743, 842.5492361586553, 825.983480330396, 832.9125441828581, 833.9874901876477, 839.0099682374795, 839.1105428246049, 515.7962604771132, 531.532251618577, 604.7127614383177, 606.2694453183902, 611.0254144639293, 13200.471981120743, 13662.0, 13681.657958551017, 14095.154290742588, 14119.71760564783, 13431.597052088453, 13565.0, 13799.379027943767, 13826.170429774145, 13948.930255348658, 11409.315441073562, 11489.770204595945, 11548.653540393801, 11703.765924681544, 11892.583759568373, 3620.131168519563, 3633.8001409922445, 3659.9451008234896, 3672.6143754905615, 3733.9439908401396, 64344.034839477914, 64718.676406618135, 67533.3246667532, 67842.0, 67900.66049669769, 10107.595696172071, 10145.695629131138, 10152.839513538876, 10261.640842570474, 10475.266731328733, 19368.128434220493, 19501.609967800563, 19585.510362241057, 19967.900160499394, 20004.19983200685, 8080.757577272691, 8125.309348705427, 8293.792655183668, 8388.0, 8482.321414286842, 4617.468991066004, 4628.097520983376, 4634.281686338623, 4677.22825733757, 4813.7593120343845, 3287.4904389819617, 3313.801171929692, 3377.7973321600784, 3391.762576619613, 3408.4887266910164, 597.9431953964366, 601.4406601860312, 606.3996643323078, 607.6506009044817, 614.3395849461847, 514.8687084793429, 533.405253142743, 567.2472061330509, 575.91937128802, 599.706143989442, 8738.126187381211, 8799.956000219958, 8945.776355591031, 9101.499417531966, 9156.404833685789, 524.4231345519897, 571.034950932922, 583.9854003649858, 665.7657299574701, 707.5259576084036, 4288.89277768052, 4292.570742925683, 4347.500037495728, 4381.145676593033, 4430.446194225722, 83920.0, 84485.0, 87366.0, 87970.56014720013, 88605.55697221472, 73277.0, 75477.0, 75661.0, 77851.22148778553, 81926.18073819185, 69121.0, 69249.65375173092, 69823.65088174527, 70867.0, 74841.6257918707, 8354.415190936576, 8475.406721529434, 8489.95755021221, 8531.445456045338, 8561.14388561139, 47044.52955470538, 47474.52525474701, 48156.759216203696, 48386.75806620944, 48450.27324590205, 54615.0, 54814.45185548093, 59300.0, 59925.40074599198, 63725.6813715947, 11794.705132371759, 11869.643910682693, 12012.63962081139, 12037.578684745991, 12631.621051368473, 12796.296203708886, 12915.540003181377, 12936.223826570436, 12950.740985180055, 13085.280309583064, 11786.646400607995, 12051.698707532381, 12283.201591896855, 12744.235345879277, 12820.551280705131, 11267.26762760418, 11666.300021998708, 11829.408529573659, 11985.34080625574, 12067.456964436446, 12252.019838413084, 12409.503619855466, 12472.438740256892, 12606.93696531548, 13411.0, 10148.289619726549, 10404.895951040393, 10518.579256829642, 10636.202284828823, 10966.670999870017, 9654.2276617869, 10079.996012659629, 10243.7439064024, 10309.587616495257, 10384.273100883167], "value": 6898.833634250636, "unit": "score"}], "name": "dromaeo_css", "value": 6937.531346366851, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 112.0, 111.0, 113.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 126.0, 168.0, 126.0, 124.0, 124.0, 131.0, 166.0, 133.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 159.0, 162.0, 159.0, 160.0, 160.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 112.0, 78.0, 77.0, 77.0, 76.0, 99.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 82.0, 81.0, 82.0, 117.0, 82.0, 82.0, 108.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 51.0, 52.0, 54.0, 54.0, 53.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 79.0, 82.0, 80.0, 79.0, 79.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 141.0, 140.0, 129.0, 131.0, 141.0, 140.0, 143.0, 174.0, 131.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 162.0, 166.0, 164.0, 168.0, 162.0, 161.0, 166.0, 168.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0, 63.0, 67.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1493.6, "alertThreshold": 2.0}]} 09:45:45 INFO - Return code: 0 09:45:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:45 INFO - # TBPL SUCCESS # 09:45:45 INFO - Running post-action listener: _resource_record_post_action 09:45:45 INFO - [mozharness: 2016-11-12 17:45:45.134881Z] Finished run-tests step (success) 09:45:45 INFO - Running post-run listener: _resource_record_post_run 09:45:45 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403640320; Read time: 20; Write time: 281500 09:45:45 INFO - TinderboxPrint: CPU usage
13.1% 09:45:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:45:45 INFO - TinderboxPrint: I/O write bytes / time
403,640,320 / 281,500 09:45:45 INFO - TinderboxPrint: CPU idle
8,293.8 (86.9%) 09:45:45 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 09:45:45 INFO - TinderboxPrint: Swap in / out
0 / 0 09:45:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114282496; Read time: 0; Write time: 62512 09:45:45 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288104448; Read time: 0; Write time: 218860 09:45:45 INFO - Running post-run listener: _upload_blobber_files 09:45:45 INFO - Blob upload gear active. 09:45:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:45 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 09:45:45 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:45:45 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:45:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:46 INFO - (blobuploader) - INFO - Done attempting. 09:45:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:50 INFO - (blobuploader) - INFO - Done attempting. 09:45:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:51 INFO - (blobuploader) - INFO - Done attempting. 09:45:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:51 INFO - Return code: 0 09:45:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd098c5cc9ce581ff4007b27ffee23552c0bf98b3ffd326ca2239c9f576f8661268fca6cb4fd759b3d53ee0780d9ce81585d908b060a11a672eeceaae02a87b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72c69584f83d6fe6f30710aff4fcadaf72f8c53e3f207ef57dfdae1a13d65b37ab7c1baa3c9b57b5b0fba0c86e5c3c704d9d9959437ccdeb970d57e4e3786c64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/859de7d8e0a7ae959a9a346a43b42dc0757018665553e029356a3a764d4de55cab7b86083ea6f33f5d8036a36e12805c5e1f0e779e3e4e6ef5475026cd373503"} 09:45:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:51 INFO - Contents: 09:45:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd098c5cc9ce581ff4007b27ffee23552c0bf98b3ffd326ca2239c9f576f8661268fca6cb4fd759b3d53ee0780d9ce81585d908b060a11a672eeceaae02a87b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72c69584f83d6fe6f30710aff4fcadaf72f8c53e3f207ef57dfdae1a13d65b37ab7c1baa3c9b57b5b0fba0c86e5c3c704d9d9959437ccdeb970d57e4e3786c64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/859de7d8e0a7ae959a9a346a43b42dc0757018665553e029356a3a764d4de55cab7b86083ea6f33f5d8036a36e12805c5e1f0e779e3e4e6ef5475026cd373503"} 09:45:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:51 INFO - Copying logs to upload dir... 09:45:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.085760 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-12 09:45:51.621964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 09:45:51.625542) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219 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-Inbound/sha512/fd098c5cc9ce581ff4007b27ffee23552c0bf98b3ffd326ca2239c9f576f8661268fca6cb4fd759b3d53ee0780d9ce81585d908b060a11a672eeceaae02a87b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72c69584f83d6fe6f30710aff4fcadaf72f8c53e3f207ef57dfdae1a13d65b37ab7c1baa3c9b57b5b0fba0c86e5c3c704d9d9959437ccdeb970d57e4e3786c64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/859de7d8e0a7ae959a9a346a43b42dc0757018665553e029356a3a764d4de55cab7b86083ea6f33f5d8036a36e12805c5e1f0e779e3e4e6ef5475026cd373503"} build_url:https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/HhBraB96TXOPrC-mfte-wQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd098c5cc9ce581ff4007b27ffee23552c0bf98b3ffd326ca2239c9f576f8661268fca6cb4fd759b3d53ee0780d9ce81585d908b060a11a672eeceaae02a87b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72c69584f83d6fe6f30710aff4fcadaf72f8c53e3f207ef57dfdae1a13d65b37ab7c1baa3c9b57b5b0fba0c86e5c3c704d9d9959437ccdeb970d57e4e3786c64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/859de7d8e0a7ae959a9a346a43b42dc0757018665553e029356a3a764d4de55cab7b86083ea6f33f5d8036a36e12805c5e1f0e779e3e4e6ef5475026cd373503"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 09:45:51.650895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:45:51.651225) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1478970913.556195-1338800219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 09:45:51.735617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 09:45:51.735911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 09:45:51.736206) ========= ========= Total master_lag: 0.17 =========