builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1467736557.48 results: success (0) buildid: 20160702073132 builduid: edde2c72410b49e98288152e64ee5222 revision: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.484883) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.485374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.485666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.502490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.502759) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 09:35:57-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-05 09:35:57 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113316 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.633938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.634293) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019419 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.688129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:57.688476) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 --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 d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 09:35:58,122 truncating revision to first 12 chars 2016-07-05 09:35:58,122 Setting DEBUG logging. 2016-07-05 09:35:58,122 attempt 1/10 2016-07-05 09:35:58,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d9ecb9d04a90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 09:35:58,439 unpacking tar archive at: mozilla-inbound-d9ecb9d04a90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:58.378696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:58.379654) ========= script_repo_revision: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:58.380842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:58.381648) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:35:58.394294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-05 09:35:58.395020) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:58 INFO - MultiFileLogger online at 20160705 09:35:58 in /builds/slave/test 09:35:58 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:35:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:58 INFO - {'append_to_log': False, 09:35:58 INFO - 'base_work_dir': '/builds/slave/test', 09:35:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:35:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:58 INFO - 'branch': 'Mozilla-Inbound', 09:35:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:58 INFO - 'config_files': ('talos/linux_config.py',), 09:35:58 INFO - 'default_actions': ('clobber', 09:35:58 INFO - 'read-buildbot-config', 09:35:58 INFO - 'download-and-extract', 09:35:58 INFO - 'populate-webroot', 09:35:58 INFO - 'create-virtualenv', 09:35:58 INFO - 'install', 09:35:58 INFO - 'run-tests'), 09:35:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:58 INFO - 'download_minidump_stackwalk': True, 09:35:58 INFO - 'download_symbols': 'ondemand', 09:35:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:58 INFO - 'installer_path': 'installer.exe', 09:35:58 INFO - 'log_level': 'info', 09:35:58 INFO - 'log_name': 'talos', 09:35:58 INFO - 'log_to_console': True, 09:35:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:58 INFO - 'opt_config_files': (), 09:35:58 INFO - 'pip_index': False, 09:35:58 INFO - 'sps_profile': False, 09:35:58 INFO - 'sps_profile_interval': 0, 09:35:58 INFO - 'suite': 'dromaeojs', 09:35:58 INFO - 'system_bits': '32', 09:35:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:58 INFO - 'title': 'talos-linux64-ix-069', 09:35:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:58 INFO - 'use_talos_json': True, 09:35:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:58 INFO - 'work_dir': 'build'} 09:35:58 INFO - ##### 09:35:58 INFO - ##### Running clobber step. 09:35:58 INFO - ##### 09:35:58 INFO - Running pre-action listener: _resource_record_pre_action 09:35:58 INFO - Running main action method: clobber 09:35:58 INFO - rmtree: /builds/slave/test/build 09:35:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:59 INFO - Running post-action listener: _resource_record_post_action 09:35:59 INFO - ##### 09:35:59 INFO - ##### Finished clobber step (success) 09:35:59 INFO - ##### 09:35:59 INFO - ##### 09:35:59 INFO - ##### Running read-buildbot-config step. 09:35:59 INFO - ##### 09:35:59 INFO - Running pre-action listener: _resource_record_pre_action 09:35:59 INFO - Running main action method: read_buildbot_config 09:35:59 INFO - Using buildbot properties: 09:35:59 INFO - { 09:35:59 INFO - "project": "", 09:35:59 INFO - "product": "firefox", 09:35:59 INFO - "script_repo_revision": "production", 09:35:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:35:59 INFO - "repository": "", 09:35:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:35:59 INFO - "buildid": "20160702073132", 09:35:59 INFO - "pgo_build": "True", 09:35:59 INFO - "basedir": "/builds/slave/test", 09:35:59 INFO - "buildnumber": 1279, 09:35:59 INFO - "slavename": "talos-linux64-ix-069", 09:35:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:35:59 INFO - "platform": "ubuntu64_hw", 09:35:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:35:59 INFO - "branch": "mozilla-inbound", 09:35:59 INFO - "repo_path": "integration/mozilla-inbound", 09:35:59 INFO - "revision": "d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7", 09:35:59 INFO - "stage_platform": "linux64-pgo", 09:35:59 INFO - "builduid": "edde2c72410b49e98288152e64ee5222", 09:35:59 INFO - "slavebuilddir": "test" 09:35:59 INFO - } 09:35:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:35:59 INFO - Running post-action listener: _resource_record_post_action 09:35:59 INFO - ##### 09:35:59 INFO - ##### Finished read-buildbot-config step (success) 09:35:59 INFO - ##### 09:35:59 INFO - ##### 09:35:59 INFO - ##### Running download-and-extract step. 09:35:59 INFO - ##### 09:35:59 INFO - Running pre-action listener: _resource_record_pre_action 09:35:59 INFO - Running main action method: download_and_extract 09:35:59 INFO - mkdir: /builds/slave/test/build/tests 09:35:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:59 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:35:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:35:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:35:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:36:00 INFO - Downloaded 1361 bytes. 09:36:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:36:00 INFO - Using the following test package requirements: 09:36:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:36:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:36:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'jsshell-linux-x86_64.zip'], 09:36:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:36:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:36:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:36:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:36:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:36:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:00 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:01 INFO - Downloaded 24271881 bytes. 09:36:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:36:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:36:02 INFO - Return code: 0 09:36:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:36:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:02 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:04 INFO - Downloaded 24271881 bytes. 09:36:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:36:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:36:06 INFO - Return code: 0 09:36:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:06 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:36:07 INFO - Downloaded 14405327 bytes. 09:36:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:36:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:36:07 INFO - Return code: 0 09:36:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:07 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:36:08 INFO - Downloaded 60363702 bytes. 09:36:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:08 INFO - mkdir: /builds/slave/test/properties 09:36:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:08 INFO - Contents: 09:36:08 INFO - build_url:https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:09 INFO - Running post-action listener: _resource_record_post_action 09:36:09 INFO - Running post-action listener: set_extra_try_arguments 09:36:09 INFO - ##### 09:36:09 INFO - ##### Finished download-and-extract step (success) 09:36:09 INFO - ##### 09:36:09 INFO - ##### 09:36:09 INFO - ##### Running populate-webroot step. 09:36:09 INFO - ##### 09:36:09 INFO - Running pre-action listener: _resource_record_pre_action 09:36:09 INFO - Running main action method: populate_webroot 09:36:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:09 INFO - '--tppagecycles', 09:36:09 INFO - '7'], 09:36:09 INFO - 'tests': ['tsvgm']}}, 09:36:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:36:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:36:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['damp', 'tps']}, 09:36:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'tests': ['damp', 'tps']}, 09:36:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['dromaeo_dom']}, 09:36:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['basic_compositor_video']}, 09:36:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:36:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tsvgx', 09:36:09 INFO - 'tsvgr_opacity', 09:36:09 INFO - 'tart', 09:36:09 INFO - 'tscrollx', 09:36:09 INFO - 'cart']}, 09:36:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:36:09 INFO - 'tsvgr_opacity', 09:36:09 INFO - 'tart', 09:36:09 INFO - 'tscrollx', 09:36:09 INFO - 'cart']}, 09:36:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tp5o']}, 09:36:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'tests': ['tp5o']}, 09:36:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s', 09:36:09 INFO - '--xperf_path', 09:36:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:09 INFO - 'tests': ['tp5n']}, 09:36:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--xperf_path', 09:36:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:09 INFO - 'tests': ['tp5n']}}, 09:36:09 INFO - 'talos.zip': {'path': '', 09:36:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:09 INFO - Running post-action listener: _resource_record_post_action 09:36:09 INFO - ##### 09:36:09 INFO - ##### Finished populate-webroot step (success) 09:36:09 INFO - ##### 09:36:09 INFO - ##### 09:36:09 INFO - ##### Running create-virtualenv step. 09:36:09 INFO - ##### 09:36:09 INFO - Running pre-action listener: _resource_record_pre_action 09:36:09 INFO - Running main action method: create_virtualenv 09:36:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:09 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:36:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:09 INFO - Using real prefix '/usr' 09:36:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:12 INFO - Installing pip.................done. 09:36:12 INFO - Return code: 0 09:36:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:12 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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:12 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:36:12 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:36:12 INFO - Using env: {'DISPLAY': ':0', 09:36:12 INFO - 'HOME': '/home/cltbld', 09:36:12 INFO - 'LANG': 'en_US.UTF-8', 09:36:12 INFO - 'LANGUAGE': 'en_US:en', 09:36:12 INFO - 'LOGNAME': 'cltbld', 09:36:12 INFO - 'MAIL': '/var/mail/cltbld', 09:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:12 INFO - 'MOZ_NO_REMOTE': '1', 09:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:12 INFO - 'NO_EM_RESTART': '1', 09:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:12 INFO - 'PWD': '/builds/slave/test', 09:36:12 INFO - 'SHELL': '/bin/bash', 09:36:12 INFO - 'SHLVL': '1', 09:36:12 INFO - 'TERM': 'linux', 09:36:12 INFO - 'TMOUT': '86400', 09:36:12 INFO - 'USER': 'cltbld', 09:36:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:12 INFO - '_': '/tools/buildbot/bin/python'} 09:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:12 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:36:12 INFO - Cleaning up... 09:36:12 INFO - Return code: 0 09:36:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:12 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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:12 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:36:12 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:36:12 INFO - Using env: {'DISPLAY': ':0', 09:36:12 INFO - 'HOME': '/home/cltbld', 09:36:12 INFO - 'LANG': 'en_US.UTF-8', 09:36:12 INFO - 'LANGUAGE': 'en_US:en', 09:36:12 INFO - 'LOGNAME': 'cltbld', 09:36:12 INFO - 'MAIL': '/var/mail/cltbld', 09:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:12 INFO - 'MOZ_NO_REMOTE': '1', 09:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:12 INFO - 'NO_EM_RESTART': '1', 09:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:12 INFO - 'PWD': '/builds/slave/test', 09:36:12 INFO - 'SHELL': '/bin/bash', 09:36:12 INFO - 'SHLVL': '1', 09:36:12 INFO - 'TERM': 'linux', 09:36:12 INFO - 'TMOUT': '86400', 09:36:12 INFO - 'USER': 'cltbld', 09:36:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:12 INFO - '_': '/tools/buildbot/bin/python'} 09:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:12 INFO - Downloading/unpacking psutil>=3.1.1 09:36:12 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:36:12 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:36:12 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:36:12 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:36:12 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:36:12 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:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:14 INFO - Installing collected packages: psutil 09:36:14 INFO - Running setup.py install for psutil 09:36:14 INFO - building 'psutil._psutil_linux' extension 09:36:14 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:36:14 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:36:14 INFO - building 'psutil._psutil_posix' extension 09:36:14 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:36:15 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:36:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:15 INFO - Successfully installed psutil 09:36:15 INFO - Cleaning up... 09:36:15 INFO - Return code: 0 09:36:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:15 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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:15 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:36:15 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:36:15 INFO - Using env: {'DISPLAY': ':0', 09:36:15 INFO - 'HOME': '/home/cltbld', 09:36:15 INFO - 'LANG': 'en_US.UTF-8', 09:36:15 INFO - 'LANGUAGE': 'en_US:en', 09:36:15 INFO - 'LOGNAME': 'cltbld', 09:36:15 INFO - 'MAIL': '/var/mail/cltbld', 09:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:15 INFO - 'MOZ_NO_REMOTE': '1', 09:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:15 INFO - 'NO_EM_RESTART': '1', 09:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:15 INFO - 'PWD': '/builds/slave/test', 09:36:15 INFO - 'SHELL': '/bin/bash', 09:36:15 INFO - 'SHLVL': '1', 09:36:15 INFO - 'TERM': 'linux', 09:36:15 INFO - 'TMOUT': '86400', 09:36:15 INFO - 'USER': 'cltbld', 09:36:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:15 INFO - '_': '/tools/buildbot/bin/python'} 09:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:36:15 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:36:15 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:36:15 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:36:15 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:36:15 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:36:15 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:36:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:36:17 INFO - Installing collected packages: mozsystemmonitor 09:36:17 INFO - Running setup.py install for mozsystemmonitor 09:36:17 INFO - Successfully installed mozsystemmonitor 09:36:17 INFO - Cleaning up... 09:36:17 INFO - Return code: 0 09:36:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:36:17 INFO - Using env: {'DISPLAY': ':0', 09:36:17 INFO - 'HOME': '/home/cltbld', 09:36:17 INFO - 'LANG': 'en_US.UTF-8', 09:36:17 INFO - 'LANGUAGE': 'en_US:en', 09:36:17 INFO - 'LOGNAME': 'cltbld', 09:36:17 INFO - 'MAIL': '/var/mail/cltbld', 09:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:17 INFO - 'MOZ_NO_REMOTE': '1', 09:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:17 INFO - 'NO_EM_RESTART': '1', 09:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:17 INFO - 'PWD': '/builds/slave/test', 09:36:17 INFO - 'SHELL': '/bin/bash', 09:36:17 INFO - 'SHLVL': '1', 09:36:17 INFO - 'TERM': 'linux', 09:36:17 INFO - 'TMOUT': '86400', 09:36:17 INFO - 'USER': 'cltbld', 09:36:17 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:17 INFO - '_': '/tools/buildbot/bin/python'} 09:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:36:19 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:36:19 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:36:19 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:36:19 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:36:19 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:36:19 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:36:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:19 INFO - warning: no files found matching '*.txt' 09:36:19 INFO - no previously-included directories found matching 'build' 09:36:19 INFO - no previously-included directories found matching 'dist' 09:36:19 INFO - no previously-included directories found matching '.git*' 09:36:19 INFO - Installing collected packages: jsonschema, functools32 09:36:19 INFO - Running setup.py install for functools32 09:36:20 INFO - warning: no files found matching '*.txt' 09:36:20 INFO - no previously-included directories found matching 'build' 09:36:20 INFO - no previously-included directories found matching 'dist' 09:36:20 INFO - no previously-included directories found matching '.git*' 09:36:20 INFO - Successfully installed jsonschema functools32 09:36:20 INFO - Cleaning up... 09:36:20 INFO - Return code: 0 09:36:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:36:20 INFO - Using env: {'DISPLAY': ':0', 09:36:20 INFO - 'HOME': '/home/cltbld', 09:36:20 INFO - 'LANG': 'en_US.UTF-8', 09:36:20 INFO - 'LANGUAGE': 'en_US:en', 09:36:20 INFO - 'LOGNAME': 'cltbld', 09:36:20 INFO - 'MAIL': '/var/mail/cltbld', 09:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:20 INFO - 'MOZ_NO_REMOTE': '1', 09:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:20 INFO - 'NO_EM_RESTART': '1', 09:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:20 INFO - 'PWD': '/builds/slave/test', 09:36:20 INFO - 'SHELL': '/bin/bash', 09:36:20 INFO - 'SHLVL': '1', 09:36:20 INFO - 'TERM': 'linux', 09:36:20 INFO - 'TMOUT': '86400', 09:36:20 INFO - 'USER': 'cltbld', 09:36:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:20 INFO - '_': '/tools/buildbot/bin/python'} 09:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:22 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:22 INFO - Downloading docopt-0.6.1.tar.gz 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:23 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:23 INFO - Running setup.py install for blobuploader 09:36:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:23 INFO - Running setup.py install for requests 09:36:23 INFO - Running setup.py install for docopt 09:36:23 INFO - Successfully installed blobuploader requests docopt 09:36:23 INFO - Cleaning up... 09:36:23 INFO - Return code: 0 09:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:23 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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:23 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:36:23 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:36:23 INFO - Using env: {'DISPLAY': ':0', 09:36:23 INFO - 'HOME': '/home/cltbld', 09:36:23 INFO - 'LANG': 'en_US.UTF-8', 09:36:23 INFO - 'LANGUAGE': 'en_US:en', 09:36:23 INFO - 'LOGNAME': 'cltbld', 09:36:23 INFO - 'MAIL': '/var/mail/cltbld', 09:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:23 INFO - 'MOZ_NO_REMOTE': '1', 09:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:23 INFO - 'NO_EM_RESTART': '1', 09:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:23 INFO - 'PWD': '/builds/slave/test', 09:36:23 INFO - 'SHELL': '/bin/bash', 09:36:23 INFO - 'SHLVL': '1', 09:36:23 INFO - 'TERM': 'linux', 09:36:23 INFO - 'TMOUT': '86400', 09:36:23 INFO - 'USER': 'cltbld', 09:36:23 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:23 INFO - '_': '/tools/buildbot/bin/python'} 09:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:23 INFO - Running setup.py (path:/tmp/pip-AsNDZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:23 INFO - Running setup.py (path:/tmp/pip-6yCXPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:24 INFO - Running setup.py (path:/tmp/pip-GyQyuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:24 INFO - Running setup.py (path:/tmp/pip-a80tJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:24 INFO - Running setup.py (path:/tmp/pip-X0Bhd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:24 INFO - Running setup.py (path:/tmp/pip-J2k11u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:24 INFO - Running setup.py (path:/tmp/pip-PzB1WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:24 INFO - Running setup.py (path:/tmp/pip-k9r8Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:24 INFO - Running setup.py (path:/tmp/pip-sjYk9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:24 INFO - Running setup.py (path:/tmp/pip-4mdySt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:24 INFO - Running setup.py (path:/tmp/pip-YJP6Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:24 INFO - Running setup.py (path:/tmp/pip-u83QCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:24 INFO - Running setup.py (path:/tmp/pip-_8I5ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:24 INFO - Running setup.py (path:/tmp/pip-PI0dQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:24 INFO - Running setup.py (path:/tmp/pip-mrnru3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:24 INFO - Running setup.py (path:/tmp/pip-SWQOw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:25 INFO - Running setup.py (path:/tmp/pip-b5Ex7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:25 INFO - Running setup.py install for manifestparser 09:36:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozcrash 09:36:25 INFO - Running setup.py install for mozdebug 09:36:25 INFO - Running setup.py install for mozdevice 09:36:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozfile 09:36:25 INFO - Running setup.py install for mozhttpd 09:36:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozinfo 09:36:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozInstall 09:36:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozleak 09:36:25 INFO - Running setup.py install for mozlog 09:36:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Running setup.py install for moznetwork 09:36:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Running setup.py install for mozprocess 09:36:26 INFO - Running setup.py install for mozprofile 09:36:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Running setup.py install for mozrunner 09:36:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Running setup.py install for mozscreenshot 09:36:26 INFO - Running setup.py install for moztest 09:36:26 INFO - Running setup.py install for mozversion 09:36:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:26 INFO - Cleaning up... 09:36:26 INFO - Return code: 0 09:36:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:26 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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:26 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:36:26 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:36:26 INFO - Using env: {'DISPLAY': ':0', 09:36:26 INFO - 'HOME': '/home/cltbld', 09:36:26 INFO - 'LANG': 'en_US.UTF-8', 09:36:26 INFO - 'LANGUAGE': 'en_US:en', 09:36:26 INFO - 'LOGNAME': 'cltbld', 09:36:26 INFO - 'MAIL': '/var/mail/cltbld', 09:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:26 INFO - 'MOZ_NO_REMOTE': '1', 09:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:26 INFO - 'NO_EM_RESTART': '1', 09:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:26 INFO - 'PWD': '/builds/slave/test', 09:36:26 INFO - 'SHELL': '/bin/bash', 09:36:26 INFO - 'SHLVL': '1', 09:36:26 INFO - 'TERM': 'linux', 09:36:26 INFO - 'TMOUT': '86400', 09:36:26 INFO - 'USER': 'cltbld', 09:36:26 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:26 INFO - '_': '/tools/buildbot/bin/python'} 09:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:27 INFO - Running setup.py (path:/tmp/pip-tcpdQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:27 INFO - Running setup.py (path:/tmp/pip-_Bt_pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:27 INFO - Running setup.py (path:/tmp/pip-Ku2Mtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:27 INFO - Running setup.py (path:/tmp/pip-cZ40jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:27 INFO - Running setup.py (path:/tmp/pip-ZBsee4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:27 INFO - Running setup.py (path:/tmp/pip-IiKVDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:27 INFO - Running setup.py (path:/tmp/pip-ffYyEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:27 INFO - Running setup.py (path:/tmp/pip-LhRJ2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:27 INFO - Running setup.py (path:/tmp/pip-3lFTMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:27 INFO - Running setup.py (path:/tmp/pip-GbhMdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:27 INFO - Running setup.py (path:/tmp/pip-3Xmmbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:27 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:27 INFO - Running setup.py (path:/tmp/pip-OEdspy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:27 INFO - Running setup.py (path:/tmp/pip-Sl7nuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:28 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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:28 INFO - Running setup.py (path:/tmp/pip-I5bXku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:28 INFO - Running setup.py (path:/tmp/pip-k9WhWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:28 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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:28 INFO - Running setup.py (path:/tmp/pip-CeGol8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:28 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:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:28 INFO - Running setup.py (path:/tmp/pip-kJ8Y1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:28 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:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:28 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:36:28 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:36:28 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:36:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:30 INFO - Downloading blessings-1.6.tar.gz 09:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:30 INFO - Installing collected packages: blessings 09:36:30 INFO - Running setup.py install for blessings 09:36:30 INFO - Successfully installed blessings 09:36:30 INFO - Cleaning up... 09:36:30 INFO - Return code: 0 09:36:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:30 INFO - Reading from file tmpfile_stdout 09:36:30 INFO - Current package versions: 09:36:30 INFO - argparse == 1.2.1 09:36:30 INFO - blessings == 1.6 09:36:30 INFO - blobuploader == 1.2.4 09:36:30 INFO - docopt == 0.6.1 09:36:30 INFO - functools32 == 3.2.3-2 09:36:30 INFO - jsonschema == 2.5.1 09:36:30 INFO - manifestparser == 1.1 09:36:30 INFO - mozInstall == 1.12 09:36:30 INFO - mozcrash == 0.17 09:36:30 INFO - mozdebug == 0.1 09:36:30 INFO - mozdevice == 0.48 09:36:30 INFO - mozfile == 1.2 09:36:30 INFO - mozhttpd == 0.7 09:36:30 INFO - mozinfo == 0.9 09:36:30 INFO - mozleak == 0.1 09:36:30 INFO - mozlog == 3.2 09:36:30 INFO - moznetwork == 0.27 09:36:30 INFO - mozprocess == 0.22 09:36:30 INFO - mozprofile == 0.28 09:36:30 INFO - mozrunner == 6.11 09:36:30 INFO - mozscreenshot == 0.1 09:36:30 INFO - mozsystemmonitor == 0.3 09:36:30 INFO - moztest == 0.7 09:36:30 INFO - mozversion == 1.4 09:36:30 INFO - psutil == 3.1.1 09:36:30 INFO - requests == 1.2.3 09:36:30 INFO - wsgiref == 0.1.2 09:36:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 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 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:30 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:36:30 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:36:30 INFO - Using env: {'DISPLAY': ':0', 09:36:30 INFO - 'HOME': '/home/cltbld', 09:36:30 INFO - 'LANG': 'en_US.UTF-8', 09:36:30 INFO - 'LANGUAGE': 'en_US:en', 09:36:30 INFO - 'LOGNAME': 'cltbld', 09:36:30 INFO - 'MAIL': '/var/mail/cltbld', 09:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:30 INFO - 'MOZ_NO_REMOTE': '1', 09:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:30 INFO - 'NO_EM_RESTART': '1', 09:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:30 INFO - 'PWD': '/builds/slave/test', 09:36:30 INFO - 'SHELL': '/bin/bash', 09:36:30 INFO - 'SHLVL': '1', 09:36:30 INFO - 'TERM': 'linux', 09:36:30 INFO - 'TMOUT': '86400', 09:36:30 INFO - 'USER': 'cltbld', 09:36:30 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:30 INFO - '_': '/tools/buildbot/bin/python'} 09:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 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:36:30 INFO - Cleaning up... 09:36:30 INFO - Return code: 0 09:36:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2635030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', '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:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:36:30 INFO - Using env: {'DISPLAY': ':0', 09:36:30 INFO - 'HOME': '/home/cltbld', 09:36:30 INFO - 'LANG': 'en_US.UTF-8', 09:36:30 INFO - 'LANGUAGE': 'en_US:en', 09:36:30 INFO - 'LOGNAME': 'cltbld', 09:36:30 INFO - 'MAIL': '/var/mail/cltbld', 09:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:30 INFO - 'MOZ_NO_REMOTE': '1', 09:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:30 INFO - 'NO_EM_RESTART': '1', 09:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:30 INFO - 'PWD': '/builds/slave/test', 09:36:30 INFO - 'SHELL': '/bin/bash', 09:36:30 INFO - 'SHLVL': '1', 09:36:30 INFO - 'TERM': 'linux', 09:36:30 INFO - 'TMOUT': '86400', 09:36:30 INFO - 'USER': 'cltbld', 09:36:30 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:30 INFO - '_': '/tools/buildbot/bin/python'} 09:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:36:31 INFO - Cleaning up... 09:36:31 INFO - Return code: 0 09:36:31 INFO - Running post-action listener: _resource_record_post_action 09:36:31 INFO - Running post-action listener: _start_resource_monitoring 09:36:31 INFO - Starting resource monitoring. 09:36:31 INFO - ##### 09:36:31 INFO - ##### Finished create-virtualenv step (success) 09:36:31 INFO - ##### 09:36:31 INFO - ##### 09:36:31 INFO - ##### Running install step. 09:36:31 INFO - ##### 09:36:31 INFO - Running pre-action listener: _resource_record_pre_action 09:36:31 INFO - Running main action method: install 09:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:31 INFO - Reading from file tmpfile_stdout 09:36:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:31 INFO - Reading from file tmpfile_stdout 09:36:31 INFO - Output received: 09:36:31 INFO - Usage: mozinstall [options] installer 09:36:31 INFO - Options: 09:36:31 INFO - -h, --help show this help message and exit 09:36:31 INFO - -d DEST, --destination=DEST 09:36:31 INFO - Directory to install application into. [default: 09:36:31 INFO - "/builds/slave/test"] 09:36:31 INFO - --app=APP Application being installed. [default: firefox] 09:36:31 INFO - mkdir: /builds/slave/test/build/application 09:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:36:48 INFO - Reading from file tmpfile_stdout 09:36:48 INFO - Output received: 09:36:48 INFO - /builds/slave/test/build/application/firefox/firefox 09:36:48 INFO - Running post-action listener: _resource_record_post_action 09:36:48 INFO - ##### 09:36:48 INFO - ##### Finished install step (success) 09:36:48 INFO - ##### 09:36:48 INFO - ##### 09:36:48 INFO - ##### Running run-tests step. 09:36:48 INFO - ##### 09:36:48 INFO - Running pre-action listener: _resource_record_pre_action 09:36:48 INFO - Running main action method: run_tests 09:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:36:48 INFO - Python 2.7.3 09:36:48 INFO - Return code: 0 09:36:48 INFO - grabbing minidump binary from tooltool 09:36:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:48 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 0x28f43b0>, '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 0x28f52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:36:48 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:36:48 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:36:48 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:36:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:48 INFO - Return code: 0 09:36:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:36:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:36:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:36:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:36:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:36:48 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/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:36:48 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/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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:36:48 INFO - Using env: {'DISPLAY': ':0', 09:36:48 INFO - 'HOME': '/home/cltbld', 09:36:48 INFO - 'LANG': 'en_US.UTF-8', 09:36:48 INFO - 'LANGUAGE': 'en_US:en', 09:36:48 INFO - 'LOGNAME': 'cltbld', 09:36:48 INFO - 'MAIL': '/var/mail/cltbld', 09:36:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:36:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:48 INFO - 'MOZ_NO_REMOTE': '1', 09:36:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:48 INFO - 'NO_EM_RESTART': '1', 09:36:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:48 INFO - 'PWD': '/builds/slave/test', 09:36:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:36:48 INFO - 'SHELL': '/bin/bash', 09:36:48 INFO - 'SHLVL': '1', 09:36:48 INFO - 'TERM': 'linux', 09:36:48 INFO - 'TMOUT': '86400', 09:36:48 INFO - 'USER': 'cltbld', 09:36:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276', 09:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:48 INFO - '_': '/tools/buildbot/bin/python'} 09:36:48 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/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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:36:48 INFO - mozversion application_buildid: 20160702073132 09:36:48 INFO - mozversion application_changeset: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 09:36:48 INFO - mozversion application_display_name: Nightly 09:36:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:48 INFO - mozversion application_name: Firefox 09:36:48 INFO - mozversion application_remotingname: firefox 09:36:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:36:48 INFO - mozversion application_vendor: Mozilla 09:36:48 INFO - mozversion application_version: 50.0a1 09:36:48 INFO - mozversion platform_buildid: 20160702073132 09:36:48 INFO - mozversion platform_changeset: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 09:36:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:36:48 INFO - mozversion platform_version: 50.0a1 09:36:48 INFO - using testdate: 1467736608 09:36:48 INFO - actual date: 1467736608 09:36:48 INFO - starting webserver on 'localhost:58459' 09:36:48 INFO - SUITE-START | Running 2 tests 09:36:48 INFO - TEST-START | dromaeo_css 09:36:48 INFO - operating with platform_type : linux_ 09:36:48 INFO - Initialising browser for dromaeo_css test... 09:36:48 INFO - TEST-INFO | started process 7314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsuslDe/profile http://localhost:58459/getInfo.html) 09:36:53 INFO - PROCESS | 7314 | __metrics Screen width/height:1600/1200 09:36:53 INFO - PROCESS | 7314 | colorDepth:24 09:36:53 INFO - PROCESS | 7314 | Browser inner width/height: 1024/697 09:36:53 INFO - PROCESS | 7314 | __metrics 09:36:54 INFO - PROCESS | 7314 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:55 INFO - TEST-INFO | 7314: exit 0 09:36:55 INFO - Browser initialized. 09:36:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:55 INFO - TEST-INFO | started process 7395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsuslDe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:06 INFO - PROCESS | 7395 | RSS: Main: 156790784 09:37:06 INFO - PROCESS | 7395 | 09:37:57 INFO - PROCESS | 7395 | 1467736677528 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:40:06 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58459/tests/dromaeo/cssquery-ext.html) 09:40:07 INFO - PROCESS | 7395 | RSS: Main: 246878208 09:40:07 INFO - PROCESS | 7395 | 09:43:09 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-ext.html (next: http://localhost:58459/tests/dromaeo/cssquery-jquery.html) 09:43:10 INFO - PROCESS | 7395 | RSS: Main: 256253952 09:43:10 INFO - PROCESS | 7395 | 09:46:12 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58459/tests/dromaeo/cssquery-mootools.html) 09:46:12 INFO - PROCESS | 7395 | RSS: Main: 245784576 09:46:12 INFO - PROCESS | 7395 | 09:49:14 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58459/tests/dromaeo/cssquery-prototype.html) 09:49:15 INFO - PROCESS | 7395 | RSS: Main: 241889280 09:49:15 INFO - PROCESS | 7395 | 09:52:18 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58459/tests/dromaeo/cssquery-yui.html) 09:52:18 INFO - PROCESS | 7395 | RSS: Main: 223051776 09:52:18 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-yui.html (next: http://localhost:58459/tests/dromaeo/cssquery-dojo.html) 09:55:21 INFO - PROCESS | 7395 | RSS: Main: 323592192 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | __start_tp_report 09:55:21 INFO - PROCESS | 7395 | _x_x_mozilla_page_load 09:55:21 INFO - PROCESS | 7395 | _x_x_mozilla_page_load_details 09:55:21 INFO - PROCESS | 7395 | |i|pagename|runs| 09:55:21 INFO - PROCESS | 7395 | |0;dojo.html;3131.639861415937;3153.5585018097454;3174.06365122289;3176.158318045717;3194.680531946804;5304.177852432869;5381.48875856794;5406.945930540694;5475.479829416204;5524.613277070606;5366.865828354284;5371.75827087781;5403.432639572848;5427.701476418795;5474.616776825624;4822.4936381679945;4859.173940430135;4890.926636100461;4896;5071.391433028042;4971.527704868032;4978.55193032627;5012.774425150877;5033.395992480908;5033.647644664875;4813.590844778198;4858.246971719389;4874.634402419832;4895.828645997373;4954.331165292675;4894;4920.0651876143775;4932.186189278765;4985.152524070917;5030.723310217936;4889.315495830587;4898.436679781835;4922.630802689777;4927.605791536705;4981.825636102755;5314.4951229633125;5404.08130617792;5470.17947307903;5484.067708489566;5498.697571633558;5854.297484301868;5874.23634927461;5882.264716910387;5899.085641725539;5909.822705318805;5719.628224165416;5863.560232982501;5880.088586269135;5915.674637894914;5920.052791553374;5431.429699881495;5478.205660179292;5492.093804522249;5567.8886422272135;5576.358718747315;6035.547333949971;6050.273967123973;6050.788222412194;6057.7879774207695;6060.575759696867;5583.246261754693;5630.943690563124;5772.365039845614;5792.073268277056;5800.1299805029585;5768.394318596571;5851.122331650201;5851.736671849777;5851.765929362863;5852.356240813507;5761.942380576224;5805.10020946754;5809.88380232393;5810;5856.677882716492;5627.71861406928;5712.742926568231;5815.127730840408;5822.737976791054;5826.563007774434;4401.889952751143;4429.402030725875;4430.490493593214;4456.9331460028125;4474.6867719259335;3908.804559772057;3925.1953349563273;3925.2345792570177;3945.8027098644952;3964.623360780721;5376.704281264568;5384.865378365494;5448.673079615157;5479.205515200274;5527.088030474926;5830.125481177857;5842.970785146047;5875.647461152259;5886.293644762656;5912.201852749909;5532.585056120807;5547.639403438763;5548.611597188158;5552.69460179694;5553.4724201200825;4905.484924082992;4963.677360971526;4993.525615066563;5027.421846487628;5088.287639730441;5992.970035149797;6027.9095813562835;6029.336772954972;6034.48706859913;6070.848228794315;5833.183354330312;5839.7372118255635;5840.2115714379715;5845.473907348359;5846.327672317738;5817.418258174149;5985.790497332572;6007.038873780174;6034;6051.727672254847;5725.370209277059;5790.10253410722;5790.276215473066;5796.82609521715;5797.681127538026;5833;5901.3213480450295;5901.527877769682;5903.114532820111;5905.379935106752;5552.916706249491;5564.304461942257;5580.2745643067765;5615.803446879339;5637.295338082739;5615.691136987505;5626.409227031267;5627.803026894203;5627.859303517281;5627.88744225105;5493.533049690821;5564.387917329172;5584.4136365681015;5589.357223919302;5592.077307244422;5643.379228284967;5697.943020569907;5699.0311647020935;5700.315962084576;5782.595218334676;5573.5819813513335;5576.776928922797;5594.104943209067;5606.103023516218;5613.186088017296 09:55:21 INFO - PROCESS | 7395 | |1;ext.html;621.5493767018912;633.4710516718538;643.0354468297554;646.4053071174521;652.8498445357565;43686.344704829455;45299.77350113249;45508.3173752394;48405;48520;45297.54702452975;45393.77303113488;45536.77231613838;45969;45984.77007614965;8817.691380801658;8939.910600893973;8957.77605559863;8960.641574337018;8963.462192268453;8864.423812452202;8939;8948.776280593005;8951.552422378887;8952.686655967042;8999.415038022507;9032.593533290985;9034.638614455414;9040.864387034168;9041;8898.688545900926;8915.108489151098;8947.418417802886;8956.507392093465;8956.8656470153;8793.868091978626;8843.955780221122;8855.690050848254;8858.86711699325;8866.86699699505;43181.35227971583;43305.35041974373;43438;43542.56457435417;43599.78200108979;3413.7951722896455;4165.146145040259;4176.436181115541;4318;4340.934885976713;32943.176420589436;33904.83047584746;34001.659983400095;34149.829250853836;34514;4417.403650507173;4428.40216570762;4433.179861725591;4515.841945531891;4658.254679251304;363758;369821;370262;370347;371690.9999999973;61564;62391;62460.37539624546;62476.375236247055;62507;57535.42464575385;63620.36379636237;65380;65648;71656.64171679213;17381.652366952843;17501.7374739379;17608.031558264163;17620.118994050503;17620.647587048188;13649.044566880222;13736.313184340743;13742.519011834538;13744.106633068819;13744.312784360742;17329.227323628158;19359.87041425442;19696.70454943177;19714.70427943582;20334.389968300973;7191.820204494825;7257.665615772403;7269.3094156055095;7274.854502909912;7310.59791711461;1020.2705065877784;1039.9116075133547;1080.810858099845;1130.6042884990188;1142.1091548592112;33260.682649817005;33474.66525334716;33965;33974.66025339765;34466.31067378689;1105.1987309200927;1129.5030186717818;1136.9943150284196;1138.425095326871;1179.5930404010603;17342.219600118024;17374;17492.47522574325;17516.737248941277;17594.82405175932;536359;538608;539112;542599;550551;58479.4152058474;59061;59066.70466647725;59083.40916590865;59096.704516478;1347.7169794343101;1396.4902810474307;1400.3348409505404;1403.7473254814026;1412.0539238709885;31639.20901977469;31990.52014219742;32450.149140381327;32701.34597307993;32955.34089318248;52490.21264680957;52741.208881866034;52777;52875;52968.73515632397;428765;429249;433086;433740;435448;23810.642840357756;25192.622110668723;28438.289042773267;28526.57210141808;28845.27886802847;48600;48947;49277.26084108813;49576.752116239186;49776;39813;42278.154436910474;42815.14369712651;43017.139657206055;43792.12415751731;42490.57509424866;42784.786076069424;42916.570834292506;43256.567434325254;43276.35085473784;41139.177216454904;41505.37741933813;42349.36475952801;42542.149157016065;42554.148917020866;36772;37495;37495.25009499849;38148;38274.80862595669;28255.57616635711;28287.717122828508;28392.290192745346;28424.715752842207;28701.138965831058 09:55:21 INFO - PROCESS | 7395 | |2;jquery.html;385.8205934240578;389.11864626620707;392.6956608628313;394.5236591824649;419.1637682822767;14719.411223551046;18242.908785456053;18692.15885285162;20442.693359599598;20455.284065057745;15261.618459538517;17532;18894;19442.611147777072;19672.508187295323;5614.29821272342;5719.771209151629;5720.513756330717;5724.198612194296;5782.496550896755;4164.916701665965;5632.4085970972865;5701.429857014306;6174.660393678346;6456.709448074825;6470.579412338207;6503.154589903306;6536.117624120754;6540.901886471706;6547.57440766351;6274.529410294223;6348.206474190703;6403.96798016007;6419.8395040123905;6433.388828061326;5416.295881535415;5574.275344205268;5603.80386686464;5609.411011843738;5610.709536806517;22932.541349172923;23111.422214444607;23131;23574;23788.167414140422;2226.576950379439;2273.4316420894775;2310.90756369745;2415.275417374798;2453.815963802704;9231.123043310874;9737.415755054648;14095.295235238196;14760.261986900612;15341.156236406992;1910.4459706685184;1911.8757280776706;1966.8918209498472;1969.094216660338;1969.615924894646;83886.58056709738;85466.99999999937;85471;86734;87448.56275718645;10913.727156820984;10988.71654410672;11027.779444411228;11075.833862492069;11141.554337826557;14950.327235274439;15110.924445377703;15117.697646047018;15139.848601514064;15173.393064277305;8203.58982050907;8234.176582341717;8491.363147763943;8536.530490822941;8570.657173713107;7359.8160045999275;8057.194280571896;8159.3681263747485;8269.95865020671;8333.66665333392;4314.158739045919;4562;4631.096936097496;4652.1626107300335;4708.576228139415;1881.0782716468832;1898.9555744340557;1913.9138339210049;1930.855185861066;1937.5543624966338;922.4787994782927;956.9473678947725;991.8016396720685;1045.1012129568564;1059.427908929185;18882.24471021144;19624.41126766199;19990.20039198445;20043;21315.25396611111;1023.8924912884189;1031.5306535526317;1053.5733028123623;1054.7152268887357;1094.2941802537318;10589.84115238272;11100.722481938015;11172.217944743952;11224.326540407601;11266.66200014001;369338;370263;370454;515007;519982;58333.708331458074;96338;100431.49784251179;103081;104072;1013.083159740436;1032.2722480651123;1057.746140926172;1058.4919238765283;1062.3466568060587;18273.543161420537;18514.16686249095;18774.812251877305;18814.52963675919;18940.715889261948;37310.81344593368;43114;43591.34612980745;45428;46964;64710.38224044248;64833.35166648462;65654;67036;67078.66460667666;8823.69117080899;8845.867311990196;9065.365424420228;9098.226650734761;9112.544372781202;13088.28014459214;13543.729125417634;13639.79540306916;13651.726965460437;14042.1574705518;11450.713732156762;11496.367699776592;11530.365829879102;11617.593384231512;11652.417379131179;11471.655850324503;12068.215565988183;12068.336241506802;12519.123661343618;12568.811467828173;7525.962370188114;11384.772304554028;11565.710857228636;11573;11778.469968851594;8794.692185773467;8803.471791692518;8857.955710221408;8934.86597701022;8990.415622984485;8714.259287960595;10634.361938283728;11149.944250278697;11342.546298147981;11454.770904582028 09:55:21 INFO - PROCESS | 7395 | |3;mootools.html;1323.0672375974939;1467.8018467506886;1490.1506141499347;1634.3707672546066;1768.9911550442246;7674.309312161904;8066.59667016649;8068.31419329357;8310.958445207765;8317.293030092434;8092.231238032392;8261.29778968787;8263.876041859377;8264.669413223479;8265.214804593568;2003.47909543519;2074.222166687492;2075.8131768140865;2284.4403121235277;2312.144506532577;2048.3445297504804;2249.5051088760447;2317.8725170115636;2319.420144963759;2339.8596084234914;2281.7490076091617;2292.3695983604475;2308.746037935826;2310.595645761993;2316.2819525946925;1918.6354592627356;2223.8999245033933;2227.40973641985;2227.599032174216;2229.6766968789516;2146.2702681088504;2188.4091295350327;2212.4800671842104;2218.4786575154826;2224.288227767115;8286.378521610903;8339.916600833974;8340.37447191463;8343.874841877378;8345.874811877828;4790.329353890458;4893.290472881448;4902.877428064291;4902.950970490285;4906.043321552299;3221.7100460958627;3249.902502924916;3341.4319565673895;3343.0639420961925;3346.6486018967903;1046.4349251404233;1066.4720963123227;1076.6769969009265;1086.3319058778873;1091.0235339371297;11205.887941120647;11214.551417943354;11226.32642041472;11226.887731122666;11228;4292.205941900758;4363.170997510463;4436.800343984529;4463.152001119842;4486.75322857246;9485.668001620048;9570.712878613653;9580.760480987892;9590.136887680143;9595.568199431042;5020.3724534433195;5021.7740201690285;5027.044861476308;5030.119729047402;5033.320501732219;4404.141192467502;4542.364069030338;4664.720116793003;4667.533246675373;4668.673192876534;3417.5898892133105;3479.5128681984543;3491.4937334086417;3541.5041894134843;3564.7326450516316;1096.309325125166;1103.2623617801994;1116.7264020315074;1120.7758448310371;1131.2703306367348;855.5251835231506;902.6524787956683;967.1392460709974;983.2969426859829;1000.0999100809184;5651.717414129277;5675.77296908119;5678.4605462480995;5768.990426675315;5887.264091988502;423.42414316529494;433.9002029533225;435.5252774475837;444.97775111244306;452.4480134236226;3943.6253555912144;3961.3859851723028;4001.3997900314603;4120.7321524100835;4127.050778321003;9926.851097233548;10201.132903703268;10240.129588985019;10246.692599222035;10280;10202.183825293958;10219;10225.130863876506;10244.436555989343;10246.077852993267;7690.15408305086;7739.226077392215;7885.842283154419;7913;7919.920800792033;5651.943480565142;5680.602357835077;5695.003374409379;5707.086866101404;5789.102689083199;9256.398334108262;9612.903870961482;9631.951840240754;9655.227581793299;9665.758356041155;8253.669853206045;9407.576659050223;9625.855612165684;9627.9037209627;9802.16681582045;6519.511036672174;6691.565048272041;6700.765473208415;6821.386075253251;6833.214180369321;7599.240075992357;7599.582022988568;7675.462717609714;7774.650140743794;7776.766696999099;7124.501284910007;7155.749548765768;7242.89135662955;7317.19510853795;7383.852322953619;7107.253738357398;7111;7162.534435261691;7245.239249878898;7274.127104747464;6548.1814773153355;6568.441682457044;6573;6605.240397354173;6607.273199948098;4867.780949857336;5004.924926126184;5064.215046667772;5105.591552675703;5114.258432527337;4875.366202393666;4903.8528844134735;4925;4979.402471703419;5027.949720502895 09:55:21 INFO - PROCESS | 7395 | |4;prototype.html;327.02383385594015;330.31624537207983;335.2490421455938;342.5221815567285;342.8868473403777;5394.406615272317;5397.379301380342;5409.594280428969;5421.512063914247;5421.647592906464;5309.469053094688;5332.493413125747;5355.544778693816;5368.087425137726;5373.7581808818595;4007.9198416031663;4053.169100334439;4151.377293405998;4195.447684356777;4222.261104306749;4143.472481786108;4160.396742472355;4169.416281720546;4188.748675079505;4208.747475151486;3980.3432433648413;4121.670266378683;4148.875533733978;4152.1730438607065;4171.290880550298;4036.495438070241;4043.6158564936286;4082.816273267695;4140.441040459529;4186.330187170069;3680.815959202056;3693.593704692482;3694.704423646102;3709.59035566483;3714.7956862372557;5057.620678449094;5140.871478213037;5153.2270159476;5160.716160611165;5167;4653.6044436222965;4765.952340476586;4771.6898401603785;4778.784954677048;4801.423829140491;5483.616146869721;5498.917516237259;5512.80705175317;5523.475269849358;5596.888062238732;3835.347990841564;4018.3168861293652;4038.6567141792984;4038.9192216155807;4085.20338533986;5711.828645140652;5728.455796699307;5770.509506691937;5779.624324418899;5800.564957628152;4023.657989070903;4070.2063097695664;4074.6129117733767;4078.959210407858;4080.081981554186;3916.177602703407;4103.5691252418665;4131.5455299916985;4144;4162.313218318944;4687.6249900007915;4713.010267843722;4724.881877953078;4736.218523943511;4779.593734532534;5515.200295957064;5548.750306236229;5569.832905012856;5575.191597218381;5611;1356.9796453053211;1398.1401438115486;1408.9225092620004;1418.4964337660188;1423.679672073775;897.8787863638325;916.8441364967971;921.203159267229;923.7829110159107;958.3004406783087;5290.867728306823;5324.520793128637;5324.6986868142;5332.92000619991;5339.46605339463;5589.860253493695;5620.269364982526;5627.943720562742;5629.493345598834;5654.4062873398525;5143.074246635641;5325.786968521294;5339.679619222859;5358.606762241845;5358.892822143535;3010.638723353212;3016.1705530978716;3020.8036477629325;3031;3037.179961410451;5793.681347525927;5811.79658711943;5825.300963884276;5848.4151584841175;5854.326752423441;5552.167174923794;5820;5860.560457965669;5876.941230587725;5896.992533807789;5891.764329426861;5900.557458190567;5905.143754155623;5916.792912248136;5938.287405511366;5578.330600327987;5731.684757338387;5759.942400576108;5770.538356931352;5813.505852002627;5665.433456654301;5693.5160511357;5698.914516282342;5708.743106560131;5715.542756579381;5944.346121926671;5958.314793798769;5972.850678733066;5977.222961015214;5993.910091348546;3894.6300101490315;4101;4101.91796164081;4117.649999750055;4121.855735049379;5688.40271771458;5719.5138413235345;5766.347480159174;5772.105323674838;5789.507891829073;5386.569074473954;5512;5567.747256867335;5610.298712660918;5631.267935168402;5518.503334699896;5545.3622833373065;5569.526590239875;5578.609497335147;5597.832065038056;5311.787528498971;5519.889602207853;5525.364583072837;5539.362973258127;5582.325302409342;5514.6691198528215;5593.776248949996;5624.325080990144;5635.774569017193;5649.293838270216;5487.451254874481;5498.890022199614;5519.144532597454;5574.777008919597;5580.804671836466 09:55:21 INFO - PROCESS | 7395 | |5;yui.html;783.4554984285924;801.7113839017952;805.8630032894407;862.9827403451935;867.0852250875326;15174.468893588726;15630.29663665135;15634.84365156348;15704.371825126995;15752.054876707405;14681.706365872677;14718.779218311734;14744.778828317583;14749.336279867404;14752.33614487348;662.6322391072953;785.8742601183811;809.8785182222655;814.7474282972267;817.4686453805044;798.2137594469443;809.3323008517967;810.5784991804259;812.1431889356726;813.446856137826;865.1002956924822;865.7229686500291;865.9826803463927;866.3891956170885;867.5488745852153;695.8503921656843;831.6340810043562;860.096898256831;862.2627653356353;866.3805379153872;628.915096461981;631.3749388105788;632.1055706175756;632.6235889645653;633.1199632510813;12975.351232438341;13215.405306761219;13221.801672974912;13270.867291327157;13271.601851944457;14182.85817141836;14450.205238711867;14698.267476142279;14766.48317308889;14808.481703140445;13292;13304;13368.665783355396;13377.398017089157;13420.725031122029;4406.69153159279;4421.093675796454;4454.933176002362;4474.7023363224625;4507.4365704286965;81763;82769;83868.16131838664;84152.57923710342;84233;11796.431407212087;11849.526018959317;11937;12077.335746534025;12144.089193310361;22831.429214269443;22869.771302287096;22992.425189370064;22995.96518156687;23024;8909.777255568533;9029.41308814925;9112.498812565373;9217.354785164975;9302.348835581444;4791.257355109963;5021.096202683552;5034.84895453137;5185.781341384772;5243.134882744381;3507.5615548056494;3590.1742599201807;3595.2449985502813;3623.293457775761;3624.0939765058733;619.2074145094286;629.4869681209891;636.1316802564467;638.5849198021323;641.8267067891643;674.7672053141658;716.183550752143;719.6905330707846;741.9332260096617;743.9144498382647;9538.9475367883;9556.23550116003;9636.373635713657;9719.65981190655;9846.507674616383;693.4279219643814;698.598305974067;710.7796583059268;728.8177955511122;761.4479502360855;4609.631229501631;4669.34629151919;4694.906101877943;4731.432228132646;4832.637552183601;70619.64690176517;78334.21665783384;108692;118869;119220.40389798168;93925.5303723477;98714;99078.5046074765;99292.50353748185;99743;78427;85687;87068;92149;92328.45894263218;8946.150115738994;10176.18590512772;10374.481275936323;10415.895841041493;10499.212559057949;44159.55840441683;51298.23052654139;51330.23004655008;51548.48451515437;52750.47249527455;51165.48834511607;51373;62273.68863155655;74902;78276.60861695655;13441.126326788728;13703.794443083163;13714.38285277145;13977.301134943416;14238.715225695221;10320.535575899252;15633.76549351738;15738.213089345716;16438;16495;14249.430022798972;14786.6303342413;14824.03643763152;14875.702485950003;15315.387384504495;13769.449222031408;14258.429662813785;14731.631709207355;14757.92621036888;14849;14393.136411815325;14407.639809004859;15137.697246054797;15568.532944011698;15722.13528255957;12014.939925300318;12355.876441235472;12528.561500347445;12575.308358040396;13195.406206720912;12352.814707779211;12368.1960672556;12726.300053497147;12785.552505662257;12884.549040783902 09:55:21 INFO - PROCESS | 7395 | __end_tp_report 09:55:21 INFO - PROCESS | 7395 | __start_cc_report 09:55:21 INFO - PROCESS | 7395 | _x_x_mozilla_cycle_collect,842 09:55:21 INFO - PROCESS | 7395 | __end_cc_report 09:55:21 INFO - PROCESS | 7395 | __startTimestamp1467737721643__endTimestamp 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | ------- Summary: start ------- 09:55:21 INFO - PROCESS | 7395 | Number of tests: 6 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | [#0] dojo.html Cycles:165 Average:5404.47 Median:5583.25 stddev:621.40 (11.1%) stddev-sans-first:597.18 09:55:21 INFO - PROCESS | 7395 | Values: 3131.6 3153.6 3174.1 3176.2 3194.7 5304.2 5381.5 5406.9 5475.5 5524.6 5366.9 5371.8 5403.4 5427.7 5474.6 4822.5 4859.2 4890.9 4896.0 5071.4 4971.5 4978.6 5012.8 5033.4 5033.6 4813.6 4858.2 4874.6 4895.8 4954.3 4894.0 4920.1 4932.2 4985.2 5030.7 4889.3 4898.4 4922.6 4927.6 4981.8 5314.5 5404.1 5470.2 5484.1 5498.7 5854.3 5874.2 5882.3 5899.1 5909.8 5719.6 5863.6 5880.1 5915.7 5920.1 5431.4 5478.2 5492.1 5567.9 5576.4 6035.5 6050.3 6050.8 6057.8 6060.6 5583.2 5630.9 5772.4 5792.1 5800.1 5768.4 5851.1 5851.7 5851.8 5852.4 5761.9 5805.1 5809.9 5810.0 5856.7 5627.7 5712.7 5815.1 5822.7 5826.6 4401.9 4429.4 4430.5 4456.9 4474.7 3908.8 3925.2 3925.2 3945.8 3964.6 5376.7 5384.9 5448.7 5479.2 5527.1 5830.1 5843.0 5875.6 5886.3 5912.2 5532.6 5547.6 5548.6 5552.7 5553.5 4905.5 4963.7 4993.5 5027.4 5088.3 5993.0 6027.9 6029.3 6034.5 6070.8 5833.2 5839.7 5840.2 5845.5 5846.3 5817.4 5985.8 6007.0 6034.0 6051.7 5725.4 5790.1 5790.3 5796.8 5797.7 5833.0 5901.3 5901.5 5903.1 5905.4 5552.9 5564.3 5580.3 5615.8 5637.3 5615.7 5626.4 5627.8 5627.9 5627.9 5493.5 5564.4 5584.4 5589.4 5592.1 5643.4 5697.9 5699.0 5700.3 5782.6 5573.6 5576.8 5594.1 5606.1 5613.2 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | [#1] ext.html Cycles:180 Average:61644.31 Median:43290.85 stddev:120012.59 (277.2%) stddev-sans-first:120261.80 09:55:21 INFO - PROCESS | 7395 | Values: 621.5 633.5 643.0 646.4 652.8 43686.3 45299.8 45508.3 48405.0 48520.0 45297.5 45393.8 45536.8 45969.0 45984.8 8817.7 8939.9 8957.8 8960.6 8963.5 8864.4 8939.0 8948.8 8951.6 8952.7 8999.4 9032.6 9034.6 9040.9 9041.0 8898.7 8915.1 8947.4 8956.5 8956.9 8793.9 8844.0 8855.7 8858.9 8866.9 43181.4 43305.4 43438.0 43542.6 43599.8 3413.8 4165.1 4176.4 4318.0 4340.9 32943.2 33904.8 34001.7 34149.8 34514.0 4417.4 4428.4 4433.2 4515.8 4658.3 363758.0 369821.0 370262.0 370347.0 371691.0 61564.0 62391.0 62460.4 62476.4 62507.0 57535.4 63620.4 65380.0 65648.0 71656.6 17381.7 17501.7 17608.0 17620.1 17620.6 13649.0 13736.3 13742.5 13744.1 13744.3 17329.2 19359.9 19696.7 19714.7 20334.4 7191.8 7257.7 7269.3 7274.9 7310.6 1020.3 1039.9 1080.8 1130.6 1142.1 33260.7 33474.7 33965.0 33974.7 34466.3 1105.2 1129.5 1137.0 1138.4 1179.6 17342.2 17374.0 17492.5 17516.7 17594.8 536359.0 538608.0 539112.0 542599.0 550551.0 58479.4 59061.0 59066.7 59083.4 59096.7 1347.7 1396.5 1400.3 1403.7 1412.1 31639.2 31990.5 32450.1 32701.3 32955.3 52490.2 52741.2 52777.0 52875.0 52968.7 428765.0 429249.0 433086.0 433740.0 435448.0 23810.6 25192.6 28438.3 28526.6 28845.3 48600.0 48947.0 49277.3 49576.8 49776.0 39813.0 42278.2 42815.1 43017.1 43792.1 42490.6 42784.8 42916.6 43256.6 43276.4 41139.2 41505.4 42349.4 42542.1 42554.1 36772.0 37495.0 37495.3 38148.0 38274.8 28255.6 28287.7 28392.3 28424.7 28701.1 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | [#2] jquery.html Cycles:180 Average:27831.06 Median:23121.21 stddev:72396.69 (313.1%) stddev-sans-first:72570.45 09:55:21 INFO - PROCESS | 7395 | Values: 385.8 389.1 392.7 394.5 419.2 14719.4 18242.9 18692.2 20442.7 20455.3 15261.6 17532.0 18894.0 19442.6 19672.5 5614.3 5719.8 5720.5 5724.2 5782.5 4164.9 5632.4 5701.4 6174.7 6456.7 6470.6 6503.2 6536.1 6540.9 6547.6 6274.5 6348.2 6404.0 6419.8 6433.4 5416.3 5574.3 5603.8 5609.4 5610.7 22932.5 23111.4 23131.0 23574.0 23788.2 2226.6 2273.4 2310.9 2415.3 2453.8 9231.1 9737.4 14095.3 14760.3 15341.2 1910.4 1911.9 1966.9 1969.1 1969.6 83886.6 85467.0 85471.0 86734.0 87448.6 10913.7 10988.7 11027.8 11075.8 11141.6 14950.3 15110.9 15117.7 15139.8 15173.4 8203.6 8234.2 8491.4 8536.5 8570.7 7359.8 8057.2 8159.4 8270.0 8333.7 4314.2 4562.0 4631.1 4652.2 4708.6 1881.1 1899.0 1913.9 1930.9 1937.6 922.5 956.9 991.8 1045.1 1059.4 18882.2 19624.4 19990.2 20043.0 21315.3 1023.9 1031.5 1053.6 1054.7 1094.3 10589.8 11100.7 11172.2 11224.3 11266.7 369338.0 370263.0 370454.0 515007.0 519982.0 58333.7 96338.0 100431.5 103081.0 104072.0 1013.1 1032.3 1057.7 1058.5 1062.3 18273.5 18514.2 18774.8 18814.5 18940.7 37310.8 43114.0 43591.3 45428.0 46964.0 64710.4 64833.4 65654.0 67036.0 67078.7 8823.7 8845.9 9065.4 9098.2 9112.5 13088.3 13543.7 13639.8 13651.7 14042.2 11450.7 11496.4 11530.4 11617.6 11652.4 11471.7 12068.2 12068.3 12519.1 12568.8 7526.0 11384.8 11565.7 11573.0 11778.5 8794.7 8803.5 8858.0 8934.9 8990.4 8714.3 10634.4 11149.9 11342.5 11454.8 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | [#3] mootools.html Cycles:180 Average:5424.99 Median:4903.40 stddev:3060.03 (62.4%) stddev-sans-first:3053.08 09:55:21 INFO - PROCESS | 7395 | Values: 1323.1 1467.8 1490.2 1634.4 1769.0 7674.3 8066.6 8068.3 8311.0 8317.3 8092.2 8261.3 8263.9 8264.7 8265.2 2003.5 2074.2 2075.8 2284.4 2312.1 2048.3 2249.5 2317.9 2319.4 2339.9 2281.7 2292.4 2308.7 2310.6 2316.3 1918.6 2223.9 2227.4 2227.6 2229.7 2146.3 2188.4 2212.5 2218.5 2224.3 8286.4 8339.9 8340.4 8343.9 8345.9 4790.3 4893.3 4902.9 4903.0 4906.0 3221.7 3249.9 3341.4 3343.1 3346.6 1046.4 1066.5 1076.7 1086.3 1091.0 11205.9 11214.6 11226.3 11226.9 11228.0 4292.2 4363.2 4436.8 4463.2 4486.8 9485.7 9570.7 9580.8 9590.1 9595.6 5020.4 5021.8 5027.0 5030.1 5033.3 4404.1 4542.4 4664.7 4667.5 4668.7 3417.6 3479.5 3491.5 3541.5 3564.7 1096.3 1103.3 1116.7 1120.8 1131.3 855.5 902.7 967.1 983.3 1000.1 5651.7 5675.8 5678.5 5769.0 5887.3 423.4 433.9 435.5 445.0 452.4 3943.6 3961.4 4001.4 4120.7 4127.1 9926.9 10201.1 10240.1 10246.7 10280.0 10202.2 10219.0 10225.1 10244.4 10246.1 7690.2 7739.2 7885.8 7913.0 7919.9 5651.9 5680.6 5695.0 5707.1 5789.1 9256.4 9612.9 9632.0 9655.2 9665.8 8253.7 9407.6 9625.9 9627.9 9802.2 6519.5 6691.6 6700.8 6821.4 6833.2 7599.2 7599.6 7675.5 7774.7 7776.8 7124.5 7155.7 7242.9 7317.2 7383.9 7107.3 7111.0 7162.5 7245.2 7274.1 6548.2 6568.4 6573.0 6605.2 6607.3 4867.8 5004.9 5064.2 5105.6 5114.3 4875.4 4903.9 4925.0 4979.4 5027.9 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | [#4] prototype.html Cycles:180 Average:4694.81 Median:5380.16 stddev:1384.77 (25.7%) stddev-sans-first:1349.29 09:55:21 INFO - PROCESS | 7395 | Values: 327.0 330.3 335.2 342.5 342.9 5394.4 5397.4 5409.6 5421.5 5421.6 5309.5 5332.5 5355.5 5368.1 5373.8 4007.9 4053.2 4151.4 4195.4 4222.3 4143.5 4160.4 4169.4 4188.7 4208.7 3980.3 4121.7 4148.9 4152.2 4171.3 4036.5 4043.6 4082.8 4140.4 4186.3 3680.8 3693.6 3694.7 3709.6 3714.8 5057.6 5140.9 5153.2 5160.7 5167.0 4653.6 4766.0 4771.7 4778.8 4801.4 5483.6 5498.9 5512.8 5523.5 5596.9 3835.3 4018.3 4038.7 4038.9 4085.2 5711.8 5728.5 5770.5 5779.6 5800.6 4023.7 4070.2 4074.6 4079.0 4080.1 3916.2 4103.6 4131.5 4144.0 4162.3 4687.6 4713.0 4724.9 4736.2 4779.6 5515.2 5548.8 5569.8 5575.2 5611.0 1357.0 1398.1 1408.9 1418.5 1423.7 897.9 916.8 921.2 923.8 958.3 5290.9 5324.5 5324.7 5332.9 5339.5 5589.9 5620.3 5627.9 5629.5 5654.4 5143.1 5325.8 5339.7 5358.6 5358.9 3010.6 3016.2 3020.8 3031.0 3037.2 5793.7 5811.8 5825.3 5848.4 5854.3 5552.2 5820.0 5860.6 5876.9 5897.0 5891.8 5900.6 5905.1 5916.8 5938.3 5578.3 5731.7 5759.9 5770.5 5813.5 5665.4 5693.5 5698.9 5708.7 5715.5 5944.3 5958.3 5972.9 5977.2 5993.9 3894.6 4101.0 4101.9 4117.6 4121.9 5688.4 5719.5 5766.3 5772.1 5789.5 5386.6 5512.0 5567.7 5610.3 5631.3 5518.5 5545.4 5569.5 5578.6 5597.8 5311.8 5519.9 5525.4 5539.4 5582.3 5514.7 5593.8 5624.3 5635.8 5649.3 5487.5 5498.9 5519.1 5574.8 5580.8 09:55:21 INFO - PROCESS | 7395 | 09:55:21 INFO - PROCESS | 7395 | [#5] yui.html Cycles:180 Average:20545.26 Median:4713.17 stddev:28667.43 (608.2%) stddev-sans-first:28709.45 09:55:21 INFO - PROCESS | 7395 | Values: 783.5 801.7 805.9 863.0 867.1 15174.5 15630.3 15634.8 15704.4 15752.1 14681.7 14718.8 14744.8 14749.3 14752.3 662.6 785.9 809.9 814.7 817.5 798.2 809.3 810.6 812.1 813.4 865.1 865.7 866.0 866.4 867.5 695.9 831.6 860.1 862.3 866.4 628.9 631.4 632.1 632.6 633.1 12975.4 13215.4 13221.8 13270.9 13271.6 14182.9 14450.2 14698.3 14766.5 14808.5 13292.0 13304.0 13368.7 13377.4 13420.7 4406.7 4421.1 4454.9 4474.7 4507.4 81763.0 82769.0 83868.2 84152.6 84233.0 11796.4 11849.5 11937.0 12077.3 12144.1 22831.4 22869.8 22992.4 22996.0 23024.0 8909.8 9029.4 9112.5 9217.4 9302.3 4791.3 5021.1 5034.8 5185.8 5243.1 3507.6 3590.2 3595.2 3623.3 3624.1 619.2 629.5 636.1 638.6 641.8 674.8 716.2 719.7 741.9 743.9 9538.9 9556.2 9636.4 9719.7 9846.5 693.4 698.6 710.8 728.8 761.4 4609.6 4669.3 4694.9 4731.4 4832.6 70619.6 78334.2 108692.0 118869.0 119220.4 93925.5 98714.0 99078.5 99292.5 99743.0 78427.0 85687.0 87068.0 92149.0 92328.5 8946.2 10176.2 10374.5 10415.9 10499.2 44159.6 51298.2 51330.2 51548.5 52750.5 51165.5 51373.0 62273.7 74902.0 78276.6 13441.1 13703.8 13714.4 13977.3 14238.7 10320.5 15633.8 15738.2 16438.0 16495.0 14249.4 14786.6 14824.0 14875.7 15315.4 13769.4 14258.4 14731.6 14757.9 14849.0 14393.1 14407.6 15137.7 15568.5 15722.1 12014.9 12355.9 12528.6 12575.3 13195.4 12352.8 12368.2 12726.3 12785.6 12884.5 09:55:21 INFO - PROCESS | 7395 | -------- Summary: end -------- 09:55:21 INFO - PROCESS | 7395 | 09:55:22 INFO - TEST-INFO | 7395: exit 0 09:55:22 INFO - TEST-OK | dromaeo_css | took 1113366ms 09:55:22 INFO - TEST-START | kraken 09:55:22 INFO - operating with platform_type : linux_ 09:55:22 INFO - Initialising browser for kraken test... 09:55:22 INFO - TEST-INFO | started process 7579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp71Xb34/profile http://localhost:58459/getInfo.html) 09:55:26 INFO - PROCESS | 7579 | __metrics Screen width/height:1600/1200 09:55:26 INFO - PROCESS | 7579 | colorDepth:24 09:55:26 INFO - PROCESS | 7579 | Browser inner width/height: 1024/697 09:55:26 INFO - PROCESS | 7579 | __metrics 09:55:27 INFO - PROCESS | 7579 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:55:28 INFO - TEST-INFO | 7579: exit 0 09:55:28 INFO - Browser initialized. 09:55:28 INFO - Running cycle 1/1 for kraken test... 09:55:28 INFO - TEST-INFO | started process 7662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp71Xb34/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:39 INFO - PROCESS | 7662 | RSS: Main: 157192192 09:55:39 INFO - PROCESS | 7662 | 09:55:42 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:43 INFO - PROCESS | 7662 | RSS: Main: 215318528 09:55:43 INFO - PROCESS | 7662 | 09:55:45 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-dft) 09:55:46 INFO - PROCESS | 7662 | RSS: Main: 203386880 09:55:46 INFO - PROCESS | 7662 | 09:55:49 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-fft) 09:55:50 INFO - PROCESS | 7662 | RSS: Main: 269819904 09:55:50 INFO - PROCESS | 7662 | 09:55:52 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-oscillator) 09:55:52 INFO - PROCESS | 7662 | RSS: Main: 179367936 09:55:52 INFO - PROCESS | 7662 | 09:55:55 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:55 INFO - PROCESS | 7662 | RSS: Main: 183783424 09:55:55 INFO - PROCESS | 7662 | 09:55:58 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58459/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:59 INFO - PROCESS | 7662 | RSS: Main: 218693632 09:55:59 INFO - PROCESS | 7662 | 09:56:02 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58459/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:03 INFO - PROCESS | 7662 | RSS: Main: 220753920 09:56:03 INFO - PROCESS | 7662 | 09:56:06 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58459/tests/kraken/driver.html?testName=json-parse-financial) 09:56:06 INFO - PROCESS | 7662 | RSS: Main: 221102080 09:56:06 INFO - PROCESS | 7662 | 09:56:08 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:08 INFO - PROCESS | 7662 | RSS: Main: 208506880 09:56:08 INFO - PROCESS | 7662 | 09:56:10 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:11 INFO - PROCESS | 7662 | RSS: Main: 211132416 09:56:11 INFO - PROCESS | 7662 | 09:56:13 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:13 INFO - PROCESS | 7662 | RSS: Main: 209805312 09:56:13 INFO - PROCESS | 7662 | 09:56:16 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:16 INFO - PROCESS | 7662 | RSS: Main: 225062912 09:56:16 INFO - PROCESS | 7662 | 09:56:19 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:20 INFO - PROCESS | 7662 | RSS: Main: 224854016 09:56:20 INFO - PROCESS | 7662 | 09:56:21 INFO - PROCESS | 7662 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58459/tests/kraken/driver.html?testName=ai-astar) 09:56:22 INFO - PROCESS | 7662 | RSS: Main: 267915264 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | __start_tp_report 09:56:22 INFO - PROCESS | 7662 | _x_x_mozilla_page_load 09:56:22 INFO - PROCESS | 7662 | _x_x_mozilla_page_load_details 09:56:22 INFO - PROCESS | 7662 | |i|pagename|runs| 09:56:22 INFO - PROCESS | 7662 | |0;ai-astar;103;111;112;110;112;111;111;111;111;110 09:56:22 INFO - PROCESS | 7662 | |1;audio-beat-detection;150;115;119;175;120;119;144;116;151;115 09:56:22 INFO - PROCESS | 7662 | |2;audio-dft;161;162;161;161;162;161;162;164;161;161 09:56:22 INFO - PROCESS | 7662 | |3;audio-fft;74;74;74;126;76;75;74;76;99;74 09:56:22 INFO - PROCESS | 7662 | |4;audio-oscillator;85;83;111;83;84;85;110;83;84;121 09:56:22 INFO - PROCESS | 7662 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;118 09:56:22 INFO - PROCESS | 7662 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;147;145 09:56:22 INFO - PROCESS | 7662 | |7;imaging-desaturate;94;95;94;95;95;95;95;94;94;95 09:56:22 INFO - PROCESS | 7662 | |8;json-parse-financial;50;52;51;52;51;53;52;52;53;52 09:56:22 INFO - PROCESS | 7662 | |9;json-stringify-tinderbox;61;62;61;62;63;62;63;62;62;63 09:56:22 INFO - PROCESS | 7662 | |10;stanford-crypto-aes;76;75;78;77;77;76;76;75;74;80 09:56:22 INFO - PROCESS | 7662 | |11;stanford-crypto-ccm;129;117;118;133;125;125;120;126;156;123 09:56:22 INFO - PROCESS | 7662 | |12;stanford-crypto-pbkdf2;157;160;155;167;156;157;158;155;163;155 09:56:22 INFO - PROCESS | 7662 | |13;stanford-crypto-sha256-iterative;62;62;63;63;62;63;62;62;66;67 09:56:22 INFO - PROCESS | 7662 | __end_tp_report 09:56:22 INFO - PROCESS | 7662 | __start_cc_report 09:56:22 INFO - PROCESS | 7662 | _x_x_mozilla_cycle_collect,1623 09:56:22 INFO - PROCESS | 7662 | __end_cc_report 09:56:22 INFO - PROCESS | 7662 | __startTimestamp1467737782095__endTimestamp 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | ------- Summary: start ------- 09:56:22 INFO - PROCESS | 7662 | Number of tests: 14 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.62 (2.4%) stddev-sans-first:0.71 09:56:22 INFO - PROCESS | 7662 | Values: 103.0 111.0 112.0 110.0 112.0 111.0 111.0 111.0 111.0 110.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:132.00 stddev:21.06 (16.0%) stddev-sans-first:21.35 09:56:22 INFO - PROCESS | 7662 | Values: 150.0 115.0 119.0 175.0 120.0 119.0 144.0 116.0 151.0 115.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.00 09:56:22 INFO - PROCESS | 7662 | Values: 161.0 162.0 161.0 161.0 162.0 161.0 162.0 164.0 161.0 161.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:17.21 (23.1%) stddev-sans-first:18.00 09:56:22 INFO - PROCESS | 7662 | Values: 74.0 74.0 74.0 126.0 76.0 75.0 74.0 76.0 99.0 74.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:83.50 stddev:14.86 (17.8%) stddev-sans-first:15.48 09:56:22 INFO - PROCESS | 7662 | Values: 85.0 83.0 111.0 83.0 84.0 85.0 110.0 83.0 84.0 121.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:56:22 INFO - PROCESS | 7662 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 09:56:22 INFO - PROCESS | 7662 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 145.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:56:22 INFO - PROCESS | 7662 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.71 09:56:22 INFO - PROCESS | 7662 | Values: 50.0 52.0 51.0 52.0 51.0 53.0 52.0 52.0 53.0 52.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 09:56:22 INFO - PROCESS | 7662 | Values: 61.0 62.0 61.0 62.0 63.0 62.0 63.0 62.0 62.0 63.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.50 stddev:1.71 (2.2%) stddev-sans-first:1.81 09:56:22 INFO - PROCESS | 7662 | Values: 76.0 75.0 78.0 77.0 77.0 76.0 76.0 75.0 74.0 80.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:125.50 stddev:11.23 (9.0%) stddev-sans-first:11.90 09:56:22 INFO - PROCESS | 7662 | Values: 129.0 117.0 118.0 133.0 125.0 125.0 120.0 126.0 156.0 123.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:157.50 stddev:3.97 (2.5%) stddev-sans-first:4.19 09:56:22 INFO - PROCESS | 7662 | Values: 157.0 160.0 155.0 167.0 156.0 157.0 158.0 155.0 163.0 155.0 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - PROCESS | 7662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.87 09:56:22 INFO - PROCESS | 7662 | Values: 62.0 62.0 63.0 63.0 62.0 63.0 62.0 62.0 66.0 67.0 09:56:22 INFO - PROCESS | 7662 | -------- Summary: end -------- 09:56:22 INFO - PROCESS | 7662 | 09:56:22 INFO - TEST-INFO | 7662: exit 0 09:56:23 INFO - TEST-OK | kraken | took 60694ms 09:56:23 INFO - SUITE-END | took 1174s 09:56:23 INFO - Completed test suite (00:19:34) 09:56:23 INFO - javascript benchmark 09:56:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.639861415937, 3153.5585018097454, 3174.06365122289, 3176.158318045717, 3194.680531946804, 5304.177852432869, 5381.48875856794, 5406.945930540694, 5475.479829416204, 5524.613277070606, 5366.865828354284, 5371.75827087781, 5403.432639572848, 5427.701476418795, 5474.616776825624, 4822.4936381679945, 4859.173940430135, 4890.926636100461, 4896.0, 5071.391433028042, 4971.527704868032, 4978.55193032627, 5012.774425150877, 5033.395992480908, 5033.647644664875, 4813.590844778198, 4858.246971719389, 4874.634402419832, 4895.828645997373, 4954.331165292675, 4894.0, 4920.0651876143775, 4932.186189278765, 4985.152524070917, 5030.723310217936, 4889.315495830587, 4898.436679781835, 4922.630802689777, 4927.605791536705, 4981.825636102755, 5314.4951229633125, 5404.08130617792, 5470.17947307903, 5484.067708489566, 5498.697571633558, 5854.297484301868, 5874.23634927461, 5882.264716910387, 5899.085641725539, 5909.822705318805, 5719.628224165416, 5863.560232982501, 5880.088586269135, 5915.674637894914, 5920.052791553374, 5431.429699881495, 5478.205660179292, 5492.093804522249, 5567.8886422272135, 5576.358718747315, 6035.547333949971, 6050.273967123973, 6050.788222412194, 6057.7879774207695, 6060.575759696867, 5583.246261754693, 5630.943690563124, 5772.365039845614, 5792.073268277056, 5800.1299805029585, 5768.394318596571, 5851.122331650201, 5851.736671849777, 5851.765929362863, 5852.356240813507, 5761.942380576224, 5805.10020946754, 5809.88380232393, 5810.0, 5856.677882716492, 5627.71861406928, 5712.742926568231, 5815.127730840408, 5822.737976791054, 5826.563007774434, 4401.889952751143, 4429.402030725875, 4430.490493593214, 4456.9331460028125, 4474.6867719259335, 3908.804559772057, 3925.1953349563273, 3925.2345792570177, 3945.8027098644952, 3964.623360780721, 5376.704281264568, 5384.865378365494, 5448.673079615157, 5479.205515200274, 5527.088030474926, 5830.125481177857, 5842.970785146047, 5875.647461152259, 5886.293644762656, 5912.201852749909, 5532.585056120807, 5547.639403438763, 5548.611597188158, 5552.69460179694, 5553.4724201200825, 4905.484924082992, 4963.677360971526, 4993.525615066563, 5027.421846487628, 5088.287639730441, 5992.970035149797, 6027.9095813562835, 6029.336772954972, 6034.48706859913, 6070.848228794315, 5833.183354330312, 5839.7372118255635, 5840.2115714379715, 5845.473907348359, 5846.327672317738, 5817.418258174149, 5985.790497332572, 6007.038873780174, 6034.0, 6051.727672254847, 5725.370209277059, 5790.10253410722, 5790.276215473066, 5796.82609521715, 5797.681127538026, 5833.0, 5901.3213480450295, 5901.527877769682, 5903.114532820111, 5905.379935106752, 5552.916706249491, 5564.304461942257, 5580.2745643067765, 5615.803446879339, 5637.295338082739, 5615.691136987505, 5626.409227031267, 5627.803026894203, 5627.859303517281, 5627.88744225105, 5493.533049690821, 5564.387917329172, 5584.4136365681015, 5589.357223919302, 5592.077307244422, 5643.379228284967, 5697.943020569907, 5699.0311647020935, 5700.315962084576, 5782.595218334676, 5573.5819813513335, 5576.776928922797, 5594.104943209067, 5606.103023516218, 5613.186088017296], "value": 5362.177476198941, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.5493767018912, 633.4710516718538, 643.0354468297554, 646.4053071174521, 652.8498445357565, 43686.344704829455, 45299.77350113249, 45508.3173752394, 48405.0, 48520.0, 45297.54702452975, 45393.77303113488, 45536.77231613838, 45969.0, 45984.77007614965, 8817.691380801658, 8939.910600893973, 8957.77605559863, 8960.641574337018, 8963.462192268453, 8864.423812452202, 8939.0, 8948.776280593005, 8951.552422378887, 8952.686655967042, 8999.415038022507, 9032.593533290985, 9034.638614455414, 9040.864387034168, 9041.0, 8898.688545900926, 8915.108489151098, 8947.418417802886, 8956.507392093465, 8956.8656470153, 8793.868091978626, 8843.955780221122, 8855.690050848254, 8858.86711699325, 8866.86699699505, 43181.35227971583, 43305.35041974373, 43438.0, 43542.56457435417, 43599.78200108979, 3413.7951722896455, 4165.146145040259, 4176.436181115541, 4318.0, 4340.934885976713, 32943.176420589436, 33904.83047584746, 34001.659983400095, 34149.829250853836, 34514.0, 4417.403650507173, 4428.40216570762, 4433.179861725591, 4515.841945531891, 4658.254679251304, 363758.0, 369821.0, 370262.0, 370347.0, 371690.9999999973, 61564.0, 62391.0, 62460.37539624546, 62476.375236247055, 62507.0, 57535.42464575385, 63620.36379636237, 65380.0, 65648.0, 71656.64171679213, 17381.652366952843, 17501.7374739379, 17608.031558264163, 17620.118994050503, 17620.647587048188, 13649.044566880222, 13736.313184340743, 13742.519011834538, 13744.106633068819, 13744.312784360742, 17329.227323628158, 19359.87041425442, 19696.70454943177, 19714.70427943582, 20334.389968300973, 7191.820204494825, 7257.665615772403, 7269.3094156055095, 7274.854502909912, 7310.59791711461, 1020.2705065877784, 1039.9116075133547, 1080.810858099845, 1130.6042884990188, 1142.1091548592112, 33260.682649817005, 33474.66525334716, 33965.0, 33974.66025339765, 34466.31067378689, 1105.1987309200927, 1129.5030186717818, 1136.9943150284196, 1138.425095326871, 1179.5930404010603, 17342.219600118024, 17374.0, 17492.47522574325, 17516.737248941277, 17594.82405175932, 536359.0, 538608.0, 539112.0, 542599.0, 550551.0, 58479.4152058474, 59061.0, 59066.70466647725, 59083.40916590865, 59096.704516478, 1347.7169794343101, 1396.4902810474307, 1400.3348409505404, 1403.7473254814026, 1412.0539238709885, 31639.20901977469, 31990.52014219742, 32450.149140381327, 32701.34597307993, 32955.34089318248, 52490.21264680957, 52741.208881866034, 52777.0, 52875.0, 52968.73515632397, 428765.0, 429249.0, 433086.0, 433740.0, 435448.0, 23810.642840357756, 25192.622110668723, 28438.289042773267, 28526.57210141808, 28845.27886802847, 48600.0, 48947.0, 49277.26084108813, 49576.752116239186, 49776.0, 39813.0, 42278.154436910474, 42815.14369712651, 43017.139657206055, 43792.12415751731, 42490.57509424866, 42784.786076069424, 42916.570834292506, 43256.567434325254, 43276.35085473784, 41139.177216454904, 41505.37741933813, 42349.36475952801, 42542.149157016065, 42554.148917020866, 36772.0, 37495.0, 37495.25009499849, 38148.0, 38274.80862595669, 28255.57616635711, 28287.717122828508, 28392.290192745346, 28424.715752842207, 28701.138965831058], "value": 20776.083521602468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.8205934240578, 389.11864626620707, 392.6956608628313, 394.5236591824649, 419.1637682822767, 14719.411223551046, 18242.908785456053, 18692.15885285162, 20442.693359599598, 20455.284065057745, 15261.618459538517, 17532.0, 18894.0, 19442.611147777072, 19672.508187295323, 5614.29821272342, 5719.771209151629, 5720.513756330717, 5724.198612194296, 5782.496550896755, 4164.916701665965, 5632.4085970972865, 5701.429857014306, 6174.660393678346, 6456.709448074825, 6470.579412338207, 6503.154589903306, 6536.117624120754, 6540.901886471706, 6547.57440766351, 6274.529410294223, 6348.206474190703, 6403.96798016007, 6419.8395040123905, 6433.388828061326, 5416.295881535415, 5574.275344205268, 5603.80386686464, 5609.411011843738, 5610.709536806517, 22932.541349172923, 23111.422214444607, 23131.0, 23574.0, 23788.167414140422, 2226.576950379439, 2273.4316420894775, 2310.90756369745, 2415.275417374798, 2453.815963802704, 9231.123043310874, 9737.415755054648, 14095.295235238196, 14760.261986900612, 15341.156236406992, 1910.4459706685184, 1911.8757280776706, 1966.8918209498472, 1969.094216660338, 1969.615924894646, 83886.58056709738, 85466.99999999937, 85471.0, 86734.0, 87448.56275718645, 10913.727156820984, 10988.71654410672, 11027.779444411228, 11075.833862492069, 11141.554337826557, 14950.327235274439, 15110.924445377703, 15117.697646047018, 15139.848601514064, 15173.393064277305, 8203.58982050907, 8234.176582341717, 8491.363147763943, 8536.530490822941, 8570.657173713107, 7359.8160045999275, 8057.194280571896, 8159.3681263747485, 8269.95865020671, 8333.66665333392, 4314.158739045919, 4562.0, 4631.096936097496, 4652.1626107300335, 4708.576228139415, 1881.0782716468832, 1898.9555744340557, 1913.9138339210049, 1930.855185861066, 1937.5543624966338, 922.4787994782927, 956.9473678947725, 991.8016396720685, 1045.1012129568564, 1059.427908929185, 18882.24471021144, 19624.41126766199, 19990.20039198445, 20043.0, 21315.25396611111, 1023.8924912884189, 1031.5306535526317, 1053.5733028123623, 1054.7152268887357, 1094.2941802537318, 10589.84115238272, 11100.722481938015, 11172.217944743952, 11224.326540407601, 11266.66200014001, 369338.0, 370263.0, 370454.0, 515007.0, 519982.0, 58333.708331458074, 96338.0, 100431.49784251179, 103081.0, 104072.0, 1013.083159740436, 1032.2722480651123, 1057.746140926172, 1058.4919238765283, 1062.3466568060587, 18273.543161420537, 18514.16686249095, 18774.812251877305, 18814.52963675919, 18940.715889261948, 37310.81344593368, 43114.0, 43591.34612980745, 45428.0, 46964.0, 64710.38224044248, 64833.35166648462, 65654.0, 67036.0, 67078.66460667666, 8823.69117080899, 8845.867311990196, 9065.365424420228, 9098.226650734761, 9112.544372781202, 13088.28014459214, 13543.729125417634, 13639.79540306916, 13651.726965460437, 14042.1574705518, 11450.713732156762, 11496.367699776592, 11530.365829879102, 11617.593384231512, 11652.417379131179, 11471.655850324503, 12068.215565988183, 12068.336241506802, 12519.123661343618, 12568.811467828173, 7525.962370188114, 11384.772304554028, 11565.710857228636, 11573.0, 11778.469968851594, 8794.692185773467, 8803.471791692518, 8857.955710221408, 8934.86597701022, 8990.415622984485, 8714.259287960595, 10634.361938283728, 11149.944250278697, 11342.546298147981, 11454.770904582028], "value": 9380.76411532829, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.0672375974939, 1467.8018467506886, 1490.1506141499347, 1634.3707672546066, 1768.9911550442246, 7674.309312161904, 8066.59667016649, 8068.31419329357, 8310.958445207765, 8317.293030092434, 8092.231238032392, 8261.29778968787, 8263.876041859377, 8264.669413223479, 8265.214804593568, 2003.47909543519, 2074.222166687492, 2075.8131768140865, 2284.4403121235277, 2312.144506532577, 2048.3445297504804, 2249.5051088760447, 2317.8725170115636, 2319.420144963759, 2339.8596084234914, 2281.7490076091617, 2292.3695983604475, 2308.746037935826, 2310.595645761993, 2316.2819525946925, 1918.6354592627356, 2223.8999245033933, 2227.40973641985, 2227.599032174216, 2229.6766968789516, 2146.2702681088504, 2188.4091295350327, 2212.4800671842104, 2218.4786575154826, 2224.288227767115, 8286.378521610903, 8339.916600833974, 8340.37447191463, 8343.874841877378, 8345.874811877828, 4790.329353890458, 4893.290472881448, 4902.877428064291, 4902.950970490285, 4906.043321552299, 3221.7100460958627, 3249.902502924916, 3341.4319565673895, 3343.0639420961925, 3346.6486018967903, 1046.4349251404233, 1066.4720963123227, 1076.6769969009265, 1086.3319058778873, 1091.0235339371297, 11205.887941120647, 11214.551417943354, 11226.32642041472, 11226.887731122666, 11228.0, 4292.205941900758, 4363.170997510463, 4436.800343984529, 4463.152001119842, 4486.75322857246, 9485.668001620048, 9570.712878613653, 9580.760480987892, 9590.136887680143, 9595.568199431042, 5020.3724534433195, 5021.7740201690285, 5027.044861476308, 5030.119729047402, 5033.320501732219, 4404.141192467502, 4542.364069030338, 4664.720116793003, 4667.533246675373, 4668.673192876534, 3417.5898892133105, 3479.5128681984543, 3491.4937334086417, 3541.5041894134843, 3564.7326450516316, 1096.309325125166, 1103.2623617801994, 1116.7264020315074, 1120.7758448310371, 1131.2703306367348, 855.5251835231506, 902.6524787956683, 967.1392460709974, 983.2969426859829, 1000.0999100809184, 5651.717414129277, 5675.77296908119, 5678.4605462480995, 5768.990426675315, 5887.264091988502, 423.42414316529494, 433.9002029533225, 435.5252774475837, 444.97775111244306, 452.4480134236226, 3943.6253555912144, 3961.3859851723028, 4001.3997900314603, 4120.7321524100835, 4127.050778321003, 9926.851097233548, 10201.132903703268, 10240.129588985019, 10246.692599222035, 10280.0, 10202.183825293958, 10219.0, 10225.130863876506, 10244.436555989343, 10246.077852993267, 7690.15408305086, 7739.226077392215, 7885.842283154419, 7913.0, 7919.920800792033, 5651.943480565142, 5680.602357835077, 5695.003374409379, 5707.086866101404, 5789.102689083199, 9256.398334108262, 9612.903870961482, 9631.951840240754, 9655.227581793299, 9665.758356041155, 8253.669853206045, 9407.576659050223, 9625.855612165684, 9627.9037209627, 9802.16681582045, 6519.511036672174, 6691.565048272041, 6700.765473208415, 6821.386075253251, 6833.214180369321, 7599.240075992357, 7599.582022988568, 7675.462717609714, 7774.650140743794, 7776.766696999099, 7124.501284910007, 7155.749548765768, 7242.89135662955, 7317.19510853795, 7383.852322953619, 7107.253738357398, 7111.0, 7162.534435261691, 7245.239249878898, 7274.127104747464, 6548.1814773153355, 6568.441682457044, 6573.0, 6605.240397354173, 6607.273199948098, 4867.780949857336, 5004.924926126184, 5064.215046667772, 5105.591552675703, 5114.258432527337, 4875.366202393666, 4903.8528844134735, 4925.0, 4979.402471703419, 5027.949720502895], "value": 4288.852650936744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.02383385594015, 330.31624537207983, 335.2490421455938, 342.5221815567285, 342.8868473403777, 5394.406615272317, 5397.379301380342, 5409.594280428969, 5421.512063914247, 5421.647592906464, 5309.469053094688, 5332.493413125747, 5355.544778693816, 5368.087425137726, 5373.7581808818595, 4007.9198416031663, 4053.169100334439, 4151.377293405998, 4195.447684356777, 4222.261104306749, 4143.472481786108, 4160.396742472355, 4169.416281720546, 4188.748675079505, 4208.747475151486, 3980.3432433648413, 4121.670266378683, 4148.875533733978, 4152.1730438607065, 4171.290880550298, 4036.495438070241, 4043.6158564936286, 4082.816273267695, 4140.441040459529, 4186.330187170069, 3680.815959202056, 3693.593704692482, 3694.704423646102, 3709.59035566483, 3714.7956862372557, 5057.620678449094, 5140.871478213037, 5153.2270159476, 5160.716160611165, 5167.0, 4653.6044436222965, 4765.952340476586, 4771.6898401603785, 4778.784954677048, 4801.423829140491, 5483.616146869721, 5498.917516237259, 5512.80705175317, 5523.475269849358, 5596.888062238732, 3835.347990841564, 4018.3168861293652, 4038.6567141792984, 4038.9192216155807, 4085.20338533986, 5711.828645140652, 5728.455796699307, 5770.509506691937, 5779.624324418899, 5800.564957628152, 4023.657989070903, 4070.2063097695664, 4074.6129117733767, 4078.959210407858, 4080.081981554186, 3916.177602703407, 4103.5691252418665, 4131.5455299916985, 4144.0, 4162.313218318944, 4687.6249900007915, 4713.010267843722, 4724.881877953078, 4736.218523943511, 4779.593734532534, 5515.200295957064, 5548.750306236229, 5569.832905012856, 5575.191597218381, 5611.0, 1356.9796453053211, 1398.1401438115486, 1408.9225092620004, 1418.4964337660188, 1423.679672073775, 897.8787863638325, 916.8441364967971, 921.203159267229, 923.7829110159107, 958.3004406783087, 5290.867728306823, 5324.520793128637, 5324.6986868142, 5332.92000619991, 5339.46605339463, 5589.860253493695, 5620.269364982526, 5627.943720562742, 5629.493345598834, 5654.4062873398525, 5143.074246635641, 5325.786968521294, 5339.679619222859, 5358.606762241845, 5358.892822143535, 3010.638723353212, 3016.1705530978716, 3020.8036477629325, 3031.0, 3037.179961410451, 5793.681347525927, 5811.79658711943, 5825.300963884276, 5848.4151584841175, 5854.326752423441, 5552.167174923794, 5820.0, 5860.560457965669, 5876.941230587725, 5896.992533807789, 5891.764329426861, 5900.557458190567, 5905.143754155623, 5916.792912248136, 5938.287405511366, 5578.330600327987, 5731.684757338387, 5759.942400576108, 5770.538356931352, 5813.505852002627, 5665.433456654301, 5693.5160511357, 5698.914516282342, 5708.743106560131, 5715.542756579381, 5944.346121926671, 5958.314793798769, 5972.850678733066, 5977.222961015214, 5993.910091348546, 3894.6300101490315, 4101.0, 4101.91796164081, 4117.649999750055, 4121.855735049379, 5688.40271771458, 5719.5138413235345, 5766.347480159174, 5772.105323674838, 5789.507891829073, 5386.569074473954, 5512.0, 5567.747256867335, 5610.298712660918, 5631.267935168402, 5518.503334699896, 5545.3622833373065, 5569.526590239875, 5578.609497335147, 5597.832065038056, 5311.787528498971, 5519.889602207853, 5525.364583072837, 5539.362973258127, 5582.325302409342, 5514.6691198528215, 5593.776248949996, 5624.325080990144, 5635.774569017193, 5649.293838270216, 5487.451254874481, 5498.890022199614, 5519.144532597454, 5574.777008919597, 5580.804671836466], "value": 4251.054585387649, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.4554984285924, 801.7113839017952, 805.8630032894407, 862.9827403451935, 867.0852250875326, 15174.468893588726, 15630.29663665135, 15634.84365156348, 15704.371825126995, 15752.054876707405, 14681.706365872677, 14718.779218311734, 14744.778828317583, 14749.336279867404, 14752.33614487348, 662.6322391072953, 785.8742601183811, 809.8785182222655, 814.7474282972267, 817.4686453805044, 798.2137594469443, 809.3323008517967, 810.5784991804259, 812.1431889356726, 813.446856137826, 865.1002956924822, 865.7229686500291, 865.9826803463927, 866.3891956170885, 867.5488745852153, 695.8503921656843, 831.6340810043562, 860.096898256831, 862.2627653356353, 866.3805379153872, 628.915096461981, 631.3749388105788, 632.1055706175756, 632.6235889645653, 633.1199632510813, 12975.351232438341, 13215.405306761219, 13221.801672974912, 13270.867291327157, 13271.601851944457, 14182.85817141836, 14450.205238711867, 14698.267476142279, 14766.48317308889, 14808.481703140445, 13292.0, 13304.0, 13368.665783355396, 13377.398017089157, 13420.725031122029, 4406.69153159279, 4421.093675796454, 4454.933176002362, 4474.7023363224625, 4507.4365704286965, 81763.0, 82769.0, 83868.16131838664, 84152.57923710342, 84233.0, 11796.431407212087, 11849.526018959317, 11937.0, 12077.335746534025, 12144.089193310361, 22831.429214269443, 22869.771302287096, 22992.425189370064, 22995.96518156687, 23024.0, 8909.777255568533, 9029.41308814925, 9112.498812565373, 9217.354785164975, 9302.348835581444, 4791.257355109963, 5021.096202683552, 5034.84895453137, 5185.781341384772, 5243.134882744381, 3507.5615548056494, 3590.1742599201807, 3595.2449985502813, 3623.293457775761, 3624.0939765058733, 619.2074145094286, 629.4869681209891, 636.1316802564467, 638.5849198021323, 641.8267067891643, 674.7672053141658, 716.183550752143, 719.6905330707846, 741.9332260096617, 743.9144498382647, 9538.9475367883, 9556.23550116003, 9636.373635713657, 9719.65981190655, 9846.507674616383, 693.4279219643814, 698.598305974067, 710.7796583059268, 728.8177955511122, 761.4479502360855, 4609.631229501631, 4669.34629151919, 4694.906101877943, 4731.432228132646, 4832.637552183601, 70619.64690176517, 78334.21665783384, 108692.0, 118869.0, 119220.40389798168, 93925.5303723477, 98714.0, 99078.5046074765, 99292.50353748185, 99743.0, 78427.0, 85687.0, 87068.0, 92149.0, 92328.45894263218, 8946.150115738994, 10176.18590512772, 10374.481275936323, 10415.895841041493, 10499.212559057949, 44159.55840441683, 51298.23052654139, 51330.23004655008, 51548.48451515437, 52750.47249527455, 51165.48834511607, 51373.0, 62273.68863155655, 74902.0, 78276.60861695655, 13441.126326788728, 13703.794443083163, 13714.38285277145, 13977.301134943416, 14238.715225695221, 10320.535575899252, 15633.76549351738, 15738.213089345716, 16438.0, 16495.0, 14249.430022798972, 14786.6303342413, 14824.03643763152, 14875.702485950003, 15315.387384504495, 13769.449222031408, 14258.429662813785, 14731.631709207355, 14757.92621036888, 14849.0, 14393.136411815325, 14407.639809004859, 15137.697246054797, 15568.532944011698, 15722.13528255957, 12014.939925300318, 12355.876441235472, 12528.561500347445, 12575.308358040396, 13195.406206720912, 12352.814707779211, 12368.1960672556, 12726.300053497147, 12785.552505662257, 12884.549040783902], "value": 7742.771171815965, "unit": "score"}], "name": "dromaeo_css", "value": 7269.219059852929, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 110.0, 112.0, 111.0, 111.0, 111.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 119.0, 175.0, 120.0, 119.0, 144.0, 116.0, 151.0, 115.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 164.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 126.0, 76.0, 75.0, 74.0, 76.0, 99.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 111.0, 83.0, 84.0, 85.0, 110.0, 83.0, 84.0, 121.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 51.0, 52.0, 51.0, 53.0, 52.0, 52.0, 53.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 77.0, 77.0, 76.0, 76.0, 75.0, 74.0, 80.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 117.0, 118.0, 133.0, 125.0, 125.0, 120.0, 126.0, 156.0, 123.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 155.0, 167.0, 156.0, 157.0, 158.0, 155.0, 163.0, 155.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 66.0, 67.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1475.8000000000002, "alertThreshold": 2.0}]} 09:56:23 INFO - Return code: 0 09:56:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:56:23 INFO - # TBPL SUCCESS # 09:56:23 INFO - Running post-action listener: _resource_record_post_action 09:56:23 INFO - ##### 09:56:23 INFO - ##### Finished run-tests step (success) 09:56:23 INFO - ##### 09:56:23 INFO - Running post-run listener: _resource_record_post_run 09:56:23 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556433408; Read time: 12; Write time: 746364 09:56:23 INFO - TinderboxPrint: CPU usage
12.9% 09:56:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:56:23 INFO - TinderboxPrint: I/O write bytes / time
556,433,408 / 746,364 09:56:23 INFO - TinderboxPrint: CPU idle
8,282.0 (87.0%) 09:56:23 INFO - TinderboxPrint: CPU user
1,187.3 (12.5%) 09:56:23 INFO - TinderboxPrint: Swap in / out
0 / 0 09:56:23 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 260677632; Read time: 0; Write time: 439360 09:56:23 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295751680; Read time: 0; Write time: 306980 09:56:23 INFO - Running post-run listener: _upload_blobber_files 09:56:23 INFO - Blob upload gear active. 09:56:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:23 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:56:23 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:56:23 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:56:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:25 INFO - (blobuploader) - INFO - Done attempting. 09:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:56:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:29 INFO - (blobuploader) - INFO - Done attempting. 09:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:56:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:30 INFO - (blobuploader) - INFO - Done attempting. 09:56:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:30 INFO - Return code: 0 09:56:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69e5a17f137b3f28ed1a1df4b3d5237058a99e4f6e900043beec2caa3a472e5a3e7c18861cc2794544acfe1211f51aa1270e7be713ff93cc87856524433d68db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c40ee59b3b5257ab52c8ad4f23dcab14b3ccf7e0cfa4e0f760d8a4629cd25e7e20a409bbf67814a8517c07f29c5b56370b4b9844bb83e616c1effbc1963ce4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dde125d5a712c2023efe7b6caa2324034c8d799f78ae6b690220a9d7fc367ed520f6e51fcdfb332c41c6d5688ba5bd121a5a68820bf2242b560b23dc6415fd1f"} 09:56:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:30 INFO - Contents: 09:56:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69e5a17f137b3f28ed1a1df4b3d5237058a99e4f6e900043beec2caa3a472e5a3e7c18861cc2794544acfe1211f51aa1270e7be713ff93cc87856524433d68db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c40ee59b3b5257ab52c8ad4f23dcab14b3ccf7e0cfa4e0f760d8a4629cd25e7e20a409bbf67814a8517c07f29c5b56370b4b9844bb83e616c1effbc1963ce4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dde125d5a712c2023efe7b6caa2324034c8d799f78ae6b690220a9d7fc367ed520f6e51fcdfb332c41c6d5688ba5bd121a5a68820bf2242b560b23dc6415fd1f"} 09:56:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:30 INFO - Copying logs to upload dir... 09:56:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.287203 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-05 09:56:29.679138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:29.682736) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276 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/69e5a17f137b3f28ed1a1df4b3d5237058a99e4f6e900043beec2caa3a472e5a3e7c18861cc2794544acfe1211f51aa1270e7be713ff93cc87856524433d68db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c40ee59b3b5257ab52c8ad4f23dcab14b3ccf7e0cfa4e0f760d8a4629cd25e7e20a409bbf67814a8517c07f29c5b56370b4b9844bb83e616c1effbc1963ce4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dde125d5a712c2023efe7b6caa2324034c8d799f78ae6b690220a9d7fc367ed520f6e51fcdfb332c41c6d5688ba5bd121a5a68820bf2242b560b23dc6415fd1f"} build_url:https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69e5a17f137b3f28ed1a1df4b3d5237058a99e4f6e900043beec2caa3a472e5a3e7c18861cc2794544acfe1211f51aa1270e7be713ff93cc87856524433d68db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6c40ee59b3b5257ab52c8ad4f23dcab14b3ccf7e0cfa4e0f760d8a4629cd25e7e20a409bbf67814a8517c07f29c5b56370b4b9844bb83e616c1effbc1963ce4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dde125d5a712c2023efe7b6caa2324034c8d799f78ae6b690220a9d7fc367ed520f6e51fcdfb332c41c6d5688ba5bd121a5a68820bf2242b560b23dc6415fd1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:29.707922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:29.708263) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467736555.312223-142705276 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:29.793185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:56:29.793508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:56:29.793792) ========= ========= Total master_lag: 0.16 =========