builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1467971913.48 results: success (0) buildid: 20160708014125 builduid: 9b8604fedfe74b2ab349b78ecc1657a7 revision: 18cbc19266b4e6f60a35b21d748dbb88c3f03d64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.483778) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.484167) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.484437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.499239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.499517) ========= 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=920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 02:58:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.3M=0.001s 2016-07-08 02:58:34 (20.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.644959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.645264) ========= 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=920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016203 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.712223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:33.712536) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 18cbc19266b4e6f60a35b21d748dbb88c3f03d64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 18cbc19266b4e6f60a35b21d748dbb88c3f03d64 --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=920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 02:58:34,279 truncating revision to first 12 chars 2016-07-08 02:58:34,279 Setting DEBUG logging. 2016-07-08 02:58:34,279 attempt 1/10 2016-07-08 02:58:34,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/18cbc19266b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 02:58:34,572 unpacking tar archive at: autoland-18cbc19266b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:34.349253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:34.349522) ========= script_repo_revision: 18cbc19266b4e6f60a35b21d748dbb88c3f03d64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:34.349888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:34.350169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 02:58:34.361972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-08 02:58:34.362247) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:35 INFO - MultiFileLogger online at 20160708 02:58:35 in /builds/slave/test 02:58:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 02:58:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:35 INFO - {'append_to_log': False, 02:58:35 INFO - 'base_work_dir': '/builds/slave/test', 02:58:35 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:58:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:35 INFO - 'branch': 'Autoland-Non-PGO', 02:58:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:35 INFO - 'config_files': ('talos/linux_config.py',), 02:58:35 INFO - 'default_actions': ('clobber', 02:58:35 INFO - 'read-buildbot-config', 02:58:35 INFO - 'download-and-extract', 02:58:35 INFO - 'populate-webroot', 02:58:35 INFO - 'create-virtualenv', 02:58:35 INFO - 'install', 02:58:35 INFO - 'run-tests'), 02:58:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:35 INFO - 'download_minidump_stackwalk': True, 02:58:35 INFO - 'download_symbols': 'ondemand', 02:58:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:35 INFO - 'installer_path': 'installer.exe', 02:58:35 INFO - 'log_level': 'info', 02:58:35 INFO - 'log_name': 'talos', 02:58:35 INFO - 'log_to_console': True, 02:58:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:35 INFO - 'opt_config_files': (), 02:58:35 INFO - 'pip_index': False, 02:58:35 INFO - 'sps_profile': False, 02:58:35 INFO - 'sps_profile_interval': 0, 02:58:35 INFO - 'suite': 'dromaeojs-e10s', 02:58:35 INFO - 'system_bits': '32', 02:58:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:35 INFO - 'title': 'talos-linux64-ix-053', 02:58:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:35 INFO - 'use_talos_json': True, 02:58:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:35 INFO - 'work_dir': 'build'} 02:58:35 INFO - ##### 02:58:35 INFO - ##### Running clobber step. 02:58:35 INFO - ##### 02:58:35 INFO - Running pre-action listener: _resource_record_pre_action 02:58:35 INFO - Running main action method: clobber 02:58:35 INFO - rmtree: /builds/slave/test/build 02:58:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:35 INFO - Running post-action listener: _resource_record_post_action 02:58:35 INFO - ##### 02:58:35 INFO - ##### Finished clobber step (success) 02:58:35 INFO - ##### 02:58:35 INFO - ##### 02:58:35 INFO - ##### Running read-buildbot-config step. 02:58:35 INFO - ##### 02:58:35 INFO - Running pre-action listener: _resource_record_pre_action 02:58:35 INFO - Running main action method: read_buildbot_config 02:58:35 INFO - Using buildbot properties: 02:58:35 INFO - { 02:58:35 INFO - "project": "", 02:58:35 INFO - "product": "firefox", 02:58:35 INFO - "script_repo_revision": "production", 02:58:35 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 02:58:35 INFO - "repository": "", 02:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 02:58:35 INFO - "buildid": "20160708014125", 02:58:35 INFO - "pgo_build": "False", 02:58:35 INFO - "basedir": "/builds/slave/test", 02:58:35 INFO - "buildnumber": 75, 02:58:35 INFO - "slavename": "talos-linux64-ix-053", 02:58:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:58:35 INFO - "platform": "ubuntu64_hw", 02:58:35 INFO - "scheduler": "tests-autoland-linux64-talos", 02:58:35 INFO - "branch": "autoland", 02:58:35 INFO - "repo_path": "integration/autoland", 02:58:35 INFO - "revision": "18cbc19266b4e6f60a35b21d748dbb88c3f03d64", 02:58:35 INFO - "stage_platform": "linux64", 02:58:35 INFO - "builduid": "9b8604fedfe74b2ab349b78ecc1657a7", 02:58:35 INFO - "slavebuilddir": "test" 02:58:35 INFO - } 02:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:58:35 INFO - Running post-action listener: _resource_record_post_action 02:58:35 INFO - ##### 02:58:35 INFO - ##### Finished read-buildbot-config step (success) 02:58:35 INFO - ##### 02:58:35 INFO - ##### 02:58:35 INFO - ##### Running download-and-extract step. 02:58:35 INFO - ##### 02:58:35 INFO - Running pre-action listener: _resource_record_pre_action 02:58:35 INFO - Running main action method: download_and_extract 02:58:35 INFO - mkdir: /builds/slave/test/build/tests 02:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:58:35 INFO - https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:58:51 INFO - Downloaded 1361 bytes. 02:58:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:58:51 INFO - Using the following test package requirements: 02:58:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:58:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:58:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:58:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'jsshell-linux-x86_64.zip'], 02:58:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:58:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:58:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:58:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:58:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:58:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:58:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:58:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:58:51 INFO - https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:59:00 INFO - Downloaded 22734681 bytes. 02:59:00 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'] 02:59:00 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 02:59:01 INFO - Return code: 0 02:59:01 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 02:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:01 INFO - https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:59:03 INFO - Downloaded 22734681 bytes. 02:59:03 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'] 02:59:03 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 02:59:05 INFO - Return code: 0 02:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:05 INFO - https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:59:06 INFO - Downloaded 14403333 bytes. 02:59:06 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'] 02:59:06 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 02:59:06 INFO - Return code: 0 02:59: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')]} 02:59:06 INFO - https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/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 02:59:07 INFO - Downloaded 56650991 bytes. 02:59:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:59:07 INFO - mkdir: /builds/slave/test/properties 02:59:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:07 INFO - Contents: 02:59:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:59:08 INFO - Running post-action listener: _resource_record_post_action 02:59:08 INFO - Running post-action listener: set_extra_try_arguments 02:59:08 INFO - ##### 02:59:08 INFO - ##### Finished download-and-extract step (success) 02:59:08 INFO - ##### 02:59:08 INFO - ##### 02:59:08 INFO - ##### Running populate-webroot step. 02:59:08 INFO - ##### 02:59:08 INFO - Running pre-action listener: _resource_record_pre_action 02:59:08 INFO - Running main action method: populate_webroot 02:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:08 INFO - '--tppagecycles', 02:59:08 INFO - '7'], 02:59:08 INFO - 'tests': ['tsvgm']}}, 02:59:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:59:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['damp', 'tps']}, 02:59:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'tests': ['damp', 'tps']}, 02:59:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['dromaeo_dom']}, 02:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['basic_compositor_video']}, 02:59:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:59:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['a11yr', 02:59:08 INFO - 'ts_paint', 02:59:08 INFO - 'tpaint', 02:59:08 INFO - 'sessionrestore', 02:59:08 INFO - 'sessionrestore_no_auto_restore', 02:59:08 INFO - 'tabpaint']}, 02:59:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:08 INFO - 'ts_paint', 02:59:08 INFO - 'tpaint', 02:59:08 INFO - 'sessionrestore', 02:59:08 INFO - 'sessionrestore_no_auto_restore', 02:59:08 INFO - 'tabpaint']}, 02:59:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:59:08 INFO - 'ts_paint', 02:59:08 INFO - 'tpaint', 02:59:08 INFO - 'sessionrestore', 02:59:08 INFO - 'sessionrestore_no_auto_restore', 02:59:08 INFO - 'tabpaint']}, 02:59:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:59:08 INFO - 'ts_paint', 02:59:08 INFO - 'tpaint', 02:59:08 INFO - 'sessionrestore', 02:59:08 INFO - 'sessionrestore_no_auto_restore', 02:59:08 INFO - 'tabpaint']}, 02:59:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['a11yr', 02:59:08 INFO - 'ts_paint', 02:59:08 INFO - 'tpaint', 02:59:08 INFO - 'sessionrestore', 02:59:08 INFO - 'sessionrestore_no_auto_restore', 02:59:08 INFO - 'tabpaint']}, 02:59:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['a11yr', 02:59:08 INFO - 'ts_paint', 02:59:08 INFO - 'tpaint', 02:59:08 INFO - 'sessionrestore', 02:59:08 INFO - 'sessionrestore_no_auto_restore', 02:59:08 INFO - 'tabpaint']}, 02:59:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['tsvgx', 02:59:08 INFO - 'tsvgr_opacity', 02:59:08 INFO - 'tart', 02:59:08 INFO - 'tscrollx', 02:59:08 INFO - 'cart']}, 02:59:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:08 INFO - 'tsvgr_opacity', 02:59:08 INFO - 'tart', 02:59:08 INFO - 'tscrollx', 02:59:08 INFO - 'cart']}, 02:59:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'talos_options': ['--disable-e10s'], 02:59:08 INFO - 'tests': ['tp5o']}, 02:59:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'tests': ['tp5o']}, 02:59:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'talos_options': ['--disable-e10s', 02:59:08 INFO - '--xperf_path', 02:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:08 INFO - 'tests': ['tp5n']}, 02:59:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:08 INFO - 'talos_options': ['--xperf_path', 02:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:08 INFO - 'tests': ['tp5n']}}, 02:59:08 INFO - 'talos.zip': {'path': '', 02:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:08 INFO - Running post-action listener: _resource_record_post_action 02:59:08 INFO - ##### 02:59:08 INFO - ##### Finished populate-webroot step (success) 02:59:08 INFO - ##### 02:59:08 INFO - ##### 02:59:08 INFO - ##### Running create-virtualenv step. 02:59:08 INFO - ##### 02:59:08 INFO - Running pre-action listener: _resource_record_pre_action 02:59:08 INFO - Running main action method: create_virtualenv 02:59:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:08 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 02:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:08 INFO - Using real prefix '/usr' 02:59:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:11 INFO - Installing pip.................done. 02:59:11 INFO - Return code: 0 02:59:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:11 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')]} 02:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:11 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')]} 02:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:11 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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:11 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 02:59:11 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 02:59:11 INFO - Using env: {'DISPLAY': ':0', 02:59:11 INFO - 'HOME': '/home/cltbld', 02:59:11 INFO - 'LANG': 'en_US.UTF-8', 02:59:11 INFO - 'LANGUAGE': 'en_US:en', 02:59:11 INFO - 'LOGNAME': 'cltbld', 02:59:11 INFO - 'MAIL': '/var/mail/cltbld', 02:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:11 INFO - 'MOZ_NO_REMOTE': '1', 02:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:11 INFO - 'NO_EM_RESTART': '1', 02:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:11 INFO - 'PWD': '/builds/slave/test', 02:59:11 INFO - 'SHELL': '/bin/bash', 02:59:11 INFO - 'SHLVL': '1', 02:59:11 INFO - 'TERM': 'linux', 02:59:11 INFO - 'TMOUT': '86400', 02:59:11 INFO - 'USER': 'cltbld', 02:59:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:11 INFO - '_': '/tools/buildbot/bin/python'} 02:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:11 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 02:59:11 INFO - Cleaning up... 02:59:11 INFO - Return code: 0 02:59:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:11 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')]} 02:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:11 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')]} 02:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:11 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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:11 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 02:59:11 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 02:59:11 INFO - Using env: {'DISPLAY': ':0', 02:59:11 INFO - 'HOME': '/home/cltbld', 02:59:11 INFO - 'LANG': 'en_US.UTF-8', 02:59:11 INFO - 'LANGUAGE': 'en_US:en', 02:59:11 INFO - 'LOGNAME': 'cltbld', 02:59:11 INFO - 'MAIL': '/var/mail/cltbld', 02:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:11 INFO - 'MOZ_NO_REMOTE': '1', 02:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:11 INFO - 'NO_EM_RESTART': '1', 02:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:11 INFO - 'PWD': '/builds/slave/test', 02:59:11 INFO - 'SHELL': '/bin/bash', 02:59:11 INFO - 'SHLVL': '1', 02:59:11 INFO - 'TERM': 'linux', 02:59:11 INFO - 'TMOUT': '86400', 02:59:11 INFO - 'USER': 'cltbld', 02:59:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:11 INFO - '_': '/tools/buildbot/bin/python'} 02:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:11 INFO - Downloading/unpacking psutil>=3.1.1 02:59:11 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 02:59:11 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 02:59:11 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 02:59:11 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 02:59:11 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 02:59:11 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 02:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:13 INFO - Installing collected packages: psutil 02:59:13 INFO - Running setup.py install for psutil 02:59:13 INFO - building 'psutil._psutil_linux' extension 02:59:13 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 02:59:13 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 02:59:13 INFO - building 'psutil._psutil_posix' extension 02:59:13 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 02:59:13 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 02:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:14 INFO - Successfully installed psutil 02:59:14 INFO - Cleaning up... 02:59:14 INFO - Return code: 0 02:59:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:14 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')]} 02:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:14 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')]} 02:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:14 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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:14 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 02:59:14 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 02:59:14 INFO - Using env: {'DISPLAY': ':0', 02:59:14 INFO - 'HOME': '/home/cltbld', 02:59:14 INFO - 'LANG': 'en_US.UTF-8', 02:59:14 INFO - 'LANGUAGE': 'en_US:en', 02:59:14 INFO - 'LOGNAME': 'cltbld', 02:59:14 INFO - 'MAIL': '/var/mail/cltbld', 02:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:14 INFO - 'MOZ_NO_REMOTE': '1', 02:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:14 INFO - 'NO_EM_RESTART': '1', 02:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:14 INFO - 'PWD': '/builds/slave/test', 02:59:14 INFO - 'SHELL': '/bin/bash', 02:59:14 INFO - 'SHLVL': '1', 02:59:14 INFO - 'TERM': 'linux', 02:59:14 INFO - 'TMOUT': '86400', 02:59:14 INFO - 'USER': 'cltbld', 02:59:14 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:14 INFO - '_': '/tools/buildbot/bin/python'} 02:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:14 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 02:59:14 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 02:59:14 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 02:59:14 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 02:59:14 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 02:59:14 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 02:59:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:16 INFO - Installing collected packages: mozsystemmonitor 02:59:16 INFO - Running setup.py install for mozsystemmonitor 02:59:16 INFO - Successfully installed mozsystemmonitor 02:59:16 INFO - Cleaning up... 02:59:16 INFO - Return code: 0 02:59:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:16 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')]} 02:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:16 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')]} 02:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:16 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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:16 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 02:59:16 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 02:59:16 INFO - Using env: {'DISPLAY': ':0', 02:59:16 INFO - 'HOME': '/home/cltbld', 02:59:16 INFO - 'LANG': 'en_US.UTF-8', 02:59:16 INFO - 'LANGUAGE': 'en_US:en', 02:59:16 INFO - 'LOGNAME': 'cltbld', 02:59:16 INFO - 'MAIL': '/var/mail/cltbld', 02:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:16 INFO - 'MOZ_NO_REMOTE': '1', 02:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:16 INFO - 'NO_EM_RESTART': '1', 02:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:16 INFO - 'PWD': '/builds/slave/test', 02:59:16 INFO - 'SHELL': '/bin/bash', 02:59:16 INFO - 'SHLVL': '1', 02:59:16 INFO - 'TERM': 'linux', 02:59:16 INFO - 'TMOUT': '86400', 02:59:16 INFO - 'USER': 'cltbld', 02:59:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:16 INFO - '_': '/tools/buildbot/bin/python'} 02:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:16 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:16 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 02:59:16 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 02:59:16 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 02:59:16 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 02:59:16 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 02:59:16 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 02:59:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:18 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 02:59:18 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 02:59:18 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 02:59:18 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 02:59:18 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 02:59:18 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 02:59:18 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:18 INFO - warning: no files found matching '*.txt' 02:59:18 INFO - no previously-included directories found matching 'build' 02:59:18 INFO - no previously-included directories found matching 'dist' 02:59:18 INFO - no previously-included directories found matching '.git*' 02:59:18 INFO - Installing collected packages: jsonschema, functools32 02:59:18 INFO - Running setup.py install for functools32 02:59:19 INFO - warning: no files found matching '*.txt' 02:59:19 INFO - no previously-included directories found matching 'build' 02:59:19 INFO - no previously-included directories found matching 'dist' 02:59:19 INFO - no previously-included directories found matching '.git*' 02:59:19 INFO - Successfully installed jsonschema functools32 02:59:19 INFO - Cleaning up... 02:59:19 INFO - Return code: 0 02:59:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:59:19 INFO - Using env: {'DISPLAY': ':0', 02:59:19 INFO - 'HOME': '/home/cltbld', 02:59:19 INFO - 'LANG': 'en_US.UTF-8', 02:59:19 INFO - 'LANGUAGE': 'en_US:en', 02:59:19 INFO - 'LOGNAME': 'cltbld', 02:59:19 INFO - 'MAIL': '/var/mail/cltbld', 02:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:19 INFO - 'MOZ_NO_REMOTE': '1', 02:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:19 INFO - 'NO_EM_RESTART': '1', 02:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:19 INFO - 'PWD': '/builds/slave/test', 02:59:19 INFO - 'SHELL': '/bin/bash', 02:59:19 INFO - 'SHLVL': '1', 02:59:19 INFO - 'TERM': 'linux', 02:59:19 INFO - 'TMOUT': '86400', 02:59:19 INFO - 'USER': 'cltbld', 02:59:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:19 INFO - '_': '/tools/buildbot/bin/python'} 02:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:19 INFO - Downloading/unpacking blobuploader==1.2.4 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:21 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 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 02:59:21 INFO - Downloading docopt-0.6.1.tar.gz 02:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:21 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:21 INFO - Running setup.py install for blobuploader 02:59:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:22 INFO - Running setup.py install for requests 02:59:22 INFO - Running setup.py install for docopt 02:59:22 INFO - Successfully installed blobuploader requests docopt 02:59:22 INFO - Cleaning up... 02:59:22 INFO - Return code: 0 02:59:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:22 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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:22 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 02:59:22 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 02:59:22 INFO - Using env: {'DISPLAY': ':0', 02:59:22 INFO - 'HOME': '/home/cltbld', 02:59:22 INFO - 'LANG': 'en_US.UTF-8', 02:59:22 INFO - 'LANGUAGE': 'en_US:en', 02:59:22 INFO - 'LOGNAME': 'cltbld', 02:59:22 INFO - 'MAIL': '/var/mail/cltbld', 02:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:22 INFO - 'MOZ_NO_REMOTE': '1', 02:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:22 INFO - 'NO_EM_RESTART': '1', 02:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:22 INFO - 'PWD': '/builds/slave/test', 02:59:22 INFO - 'SHELL': '/bin/bash', 02:59:22 INFO - 'SHLVL': '1', 02:59:22 INFO - 'TERM': 'linux', 02:59:22 INFO - 'TMOUT': '86400', 02:59:22 INFO - 'USER': 'cltbld', 02:59:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:22 INFO - '_': '/tools/buildbot/bin/python'} 02:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:22 INFO - Running setup.py (path:/tmp/pip-MRKgi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:22 INFO - Running setup.py (path:/tmp/pip-Zh1GBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:22 INFO - Running setup.py (path:/tmp/pip-XCzf97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:22 INFO - Running setup.py (path:/tmp/pip-bVIQl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:23 INFO - Running setup.py (path:/tmp/pip-sVbBOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:23 INFO - Running setup.py (path:/tmp/pip-aHeH__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:23 INFO - Running setup.py (path:/tmp/pip-Y9CF8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:23 INFO - Running setup.py (path:/tmp/pip-UFMpfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:23 INFO - Running setup.py (path:/tmp/pip-gmWewq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:23 INFO - Running setup.py (path:/tmp/pip-2wPIMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:23 INFO - Running setup.py (path:/tmp/pip-LViHaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:23 INFO - Running setup.py (path:/tmp/pip-wrG0au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:23 INFO - Running setup.py (path:/tmp/pip-0nUfpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:23 INFO - Running setup.py (path:/tmp/pip-EL77R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:23 INFO - Running setup.py (path:/tmp/pip-LGkRNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:23 INFO - Running setup.py (path:/tmp/pip-4qtv0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:23 INFO - Running setup.py (path:/tmp/pip-0XZGRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:23 INFO - Running setup.py install for manifestparser 02:59:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Running setup.py install for mozcrash 02:59:24 INFO - Running setup.py install for mozdebug 02:59:24 INFO - Running setup.py install for mozdevice 02:59:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Running setup.py install for mozfile 02:59:24 INFO - Running setup.py install for mozhttpd 02:59:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Running setup.py install for mozinfo 02:59:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Running setup.py install for mozInstall 02:59:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:24 INFO - Running setup.py install for mozleak 02:59:24 INFO - Running setup.py install for mozlog 02:59:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:25 INFO - Running setup.py install for moznetwork 02:59:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:25 INFO - Running setup.py install for mozprocess 02:59:25 INFO - Running setup.py install for mozprofile 02:59:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:25 INFO - Running setup.py install for mozrunner 02:59:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:25 INFO - Running setup.py install for mozscreenshot 02:59:25 INFO - Running setup.py install for moztest 02:59:25 INFO - Running setup.py install for mozversion 02:59:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:25 INFO - Cleaning up... 02:59:25 INFO - Return code: 0 02:59:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:25 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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:25 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 02:59:25 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 02:59:25 INFO - Using env: {'DISPLAY': ':0', 02:59:25 INFO - 'HOME': '/home/cltbld', 02:59:25 INFO - 'LANG': 'en_US.UTF-8', 02:59:25 INFO - 'LANGUAGE': 'en_US:en', 02:59:25 INFO - 'LOGNAME': 'cltbld', 02:59:25 INFO - 'MAIL': '/var/mail/cltbld', 02:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:25 INFO - 'MOZ_NO_REMOTE': '1', 02:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:25 INFO - 'NO_EM_RESTART': '1', 02:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:25 INFO - 'PWD': '/builds/slave/test', 02:59:25 INFO - 'SHELL': '/bin/bash', 02:59:25 INFO - 'SHLVL': '1', 02:59:25 INFO - 'TERM': 'linux', 02:59:25 INFO - 'TMOUT': '86400', 02:59:25 INFO - 'USER': 'cltbld', 02:59:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:25 INFO - '_': '/tools/buildbot/bin/python'} 02:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:26 INFO - Running setup.py (path:/tmp/pip-MdgbYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:26 INFO - Running setup.py (path:/tmp/pip-FAf4l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:26 INFO - Running setup.py (path:/tmp/pip-LgPTK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:26 INFO - Running setup.py (path:/tmp/pip-Xyup6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:26 INFO - Running setup.py (path:/tmp/pip-1ac7bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:26 INFO - Running setup.py (path:/tmp/pip-Ovndkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:26 INFO - Running setup.py (path:/tmp/pip-Vey47E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:26 INFO - Running setup.py (path:/tmp/pip-RHfqgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:26 INFO - Running setup.py (path:/tmp/pip-qXJ8gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:26 INFO - Running setup.py (path:/tmp/pip-tFJjBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:26 INFO - Running setup.py (path:/tmp/pip-EzGphm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:26 INFO - Running setup.py (path:/tmp/pip-7r6TCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:26 INFO - Running setup.py (path:/tmp/pip-scSL9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:26 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)) 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:26 INFO - Running setup.py (path:/tmp/pip-wcFgcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:27 INFO - Running setup.py (path:/tmp/pip-dbRlzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:27 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)) 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:27 INFO - Running setup.py (path:/tmp/pip-I7vFUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:27 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)) 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:27 INFO - Running setup.py (path:/tmp/pip-I7ILUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:27 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)) 02:59:27 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)) 02:59:27 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)) 02:59:27 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)) 02:59:27 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)) 02:59:27 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)) 02:59:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:29 INFO - Downloading blessings-1.6.tar.gz 02:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:29 INFO - Installing collected packages: blessings 02:59:29 INFO - Running setup.py install for blessings 02:59:29 INFO - Successfully installed blessings 02:59:29 INFO - Cleaning up... 02:59:29 INFO - Return code: 0 02:59:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:29 INFO - Reading from file tmpfile_stdout 02:59:29 INFO - Current package versions: 02:59:29 INFO - argparse == 1.2.1 02:59:29 INFO - blessings == 1.6 02:59:29 INFO - blobuploader == 1.2.4 02:59:29 INFO - docopt == 0.6.1 02:59:29 INFO - functools32 == 3.2.3-2 02:59:29 INFO - jsonschema == 2.5.1 02:59:29 INFO - manifestparser == 1.1 02:59:29 INFO - mozInstall == 1.12 02:59:29 INFO - mozcrash == 0.17 02:59:29 INFO - mozdebug == 0.1 02:59:29 INFO - mozdevice == 0.48 02:59:29 INFO - mozfile == 1.2 02:59:29 INFO - mozhttpd == 0.7 02:59:29 INFO - mozinfo == 0.9 02:59:29 INFO - mozleak == 0.1 02:59:29 INFO - mozlog == 3.2 02:59:29 INFO - moznetwork == 0.27 02:59:29 INFO - mozprocess == 0.23 02:59:29 INFO - mozprofile == 0.28 02:59:29 INFO - mozrunner == 6.12 02:59:29 INFO - mozscreenshot == 0.1 02:59:29 INFO - mozsystemmonitor == 0.3 02:59:29 INFO - moztest == 0.7 02:59:29 INFO - mozversion == 1.4 02:59:29 INFO - psutil == 3.1.1 02:59:29 INFO - requests == 1.2.3 02:59:29 INFO - wsgiref == 0.1.2 02:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:29 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 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:29 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 02:59:29 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 02:59:29 INFO - Using env: {'DISPLAY': ':0', 02:59:29 INFO - 'HOME': '/home/cltbld', 02:59:29 INFO - 'LANG': 'en_US.UTF-8', 02:59:29 INFO - 'LANGUAGE': 'en_US:en', 02:59:29 INFO - 'LOGNAME': 'cltbld', 02:59:29 INFO - 'MAIL': '/var/mail/cltbld', 02:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:29 INFO - 'MOZ_NO_REMOTE': '1', 02:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:29 INFO - 'NO_EM_RESTART': '1', 02:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:29 INFO - 'PWD': '/builds/slave/test', 02:59:29 INFO - 'SHELL': '/bin/bash', 02:59:29 INFO - 'SHLVL': '1', 02:59:29 INFO - 'TERM': 'linux', 02:59:29 INFO - 'TMOUT': '86400', 02:59:29 INFO - 'USER': 'cltbld', 02:59:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:29 INFO - '_': '/tools/buildbot/bin/python'} 02:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 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)) 02:59:29 INFO - Cleaning up... 02:59:29 INFO - Return code: 0 02:59:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, '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': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', '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 02:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:59:29 INFO - Using env: {'DISPLAY': ':0', 02:59:29 INFO - 'HOME': '/home/cltbld', 02:59:29 INFO - 'LANG': 'en_US.UTF-8', 02:59:29 INFO - 'LANGUAGE': 'en_US:en', 02:59:29 INFO - 'LOGNAME': 'cltbld', 02:59:29 INFO - 'MAIL': '/var/mail/cltbld', 02:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:29 INFO - 'MOZ_NO_REMOTE': '1', 02:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:29 INFO - 'NO_EM_RESTART': '1', 02:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:29 INFO - 'PWD': '/builds/slave/test', 02:59:29 INFO - 'SHELL': '/bin/bash', 02:59:29 INFO - 'SHLVL': '1', 02:59:29 INFO - 'TERM': 'linux', 02:59:29 INFO - 'TMOUT': '86400', 02:59:29 INFO - 'USER': 'cltbld', 02:59:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:29 INFO - '_': '/tools/buildbot/bin/python'} 02:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:59:30 INFO - Cleaning up... 02:59:30 INFO - Return code: 0 02:59:30 INFO - Running post-action listener: _resource_record_post_action 02:59:30 INFO - Running post-action listener: _start_resource_monitoring 02:59:30 INFO - Starting resource monitoring. 02:59:30 INFO - ##### 02:59:30 INFO - ##### Finished create-virtualenv step (success) 02:59:30 INFO - ##### 02:59:30 INFO - ##### 02:59:30 INFO - ##### Running install step. 02:59:30 INFO - ##### 02:59:30 INFO - Running pre-action listener: _resource_record_pre_action 02:59:30 INFO - Running main action method: install 02:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:30 INFO - Reading from file tmpfile_stdout 02:59:30 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:59:30 INFO - Reading from file tmpfile_stdout 02:59:30 INFO - Output received: 02:59:30 INFO - Usage: mozinstall [options] installer 02:59:30 INFO - Options: 02:59:30 INFO - -h, --help show this help message and exit 02:59:30 INFO - -d DEST, --destination=DEST 02:59:30 INFO - Directory to install application into. [default: 02:59:30 INFO - "/builds/slave/test"] 02:59:30 INFO - --app=APP Application being installed. [default: firefox] 02:59:30 INFO - mkdir: /builds/slave/test/build/application 02:59:30 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'] 02:59:30 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 02:59:46 INFO - Reading from file tmpfile_stdout 02:59:46 INFO - Output received: 02:59:46 INFO - /builds/slave/test/build/application/firefox/firefox 02:59:46 INFO - Running post-action listener: _resource_record_post_action 02:59:46 INFO - ##### 02:59:46 INFO - ##### Finished install step (success) 02:59:46 INFO - ##### 02:59:46 INFO - ##### 02:59:46 INFO - ##### Running run-tests step. 02:59:46 INFO - ##### 02:59:46 INFO - Running pre-action listener: _resource_record_pre_action 02:59:46 INFO - Running main action method: run_tests 02:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:59:46 INFO - Python 2.7.3 02:59:46 INFO - Return code: 0 02:59:46 INFO - grabbing minidump binary from tooltool 02:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:59:46 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 0x2148570>, '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 0x2149470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2149900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:59:46 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 02:59:46 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 02:59:46 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 02:59:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:59:46 INFO - Return code: 0 02:59:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:59:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:59:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:59:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:59:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:59:46 INFO - Using env: {'DISPLAY': ':0', 02:59:46 INFO - 'HOME': '/home/cltbld', 02:59:46 INFO - 'LANG': 'en_US.UTF-8', 02:59:46 INFO - 'LANGUAGE': 'en_US:en', 02:59:46 INFO - 'LOGNAME': 'cltbld', 02:59:46 INFO - 'MAIL': '/var/mail/cltbld', 02:59:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:59:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:46 INFO - 'MOZ_NO_REMOTE': '1', 02:59:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:46 INFO - 'NO_EM_RESTART': '1', 02:59:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:46 INFO - 'PWD': '/builds/slave/test', 02:59:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:59:46 INFO - 'SHELL': '/bin/bash', 02:59:46 INFO - 'SHLVL': '1', 02:59:46 INFO - 'TERM': 'linux', 02:59:46 INFO - 'TMOUT': '86400', 02:59:46 INFO - 'USER': 'cltbld', 02:59:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701', 02:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:46 INFO - '_': '/tools/buildbot/bin/python'} 02:59:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:59:46 INFO - mozversion application_buildid: 20160708014125 02:59:46 INFO - mozversion application_changeset: 18cbc19266b4e6f60a35b21d748dbb88c3f03d64 02:59:46 INFO - mozversion application_display_name: Nightly 02:59:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:59:46 INFO - mozversion application_name: Firefox 02:59:46 INFO - mozversion application_remotingname: firefox 02:59:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:59:46 INFO - mozversion application_vendor: Mozilla 02:59:46 INFO - mozversion application_version: 50.0a1 02:59:46 INFO - mozversion platform_buildid: 20160708014125 02:59:46 INFO - mozversion platform_changeset: 18cbc19266b4e6f60a35b21d748dbb88c3f03d64 02:59:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:59:46 INFO - mozversion platform_version: 50.0a1 02:59:46 INFO - using testdate: 1467971986 02:59:46 INFO - actual date: 1467971986 02:59:46 INFO - starting webserver on 'localhost:50375' 02:59:46 INFO - SUITE-START | Running 2 tests 02:59:46 INFO - TEST-START | dromaeo_css 02:59:46 INFO - operating with platform_type : linux_ 02:59:46 INFO - Initialising browser for dromaeo_css test... 02:59:46 INFO - TEST-INFO | started process 25677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOfQR90/profile http://localhost:50375/getInfo.html) 02:59:52 INFO - PROCESS | 25677 | __metrics Screen width/height:1600/1200 02:59:52 INFO - PROCESS | 25677 | colorDepth:24 02:59:52 INFO - PROCESS | 25677 | Browser inner width/height: 1024/697 02:59:52 INFO - PROCESS | 25677 | __metrics 02:59:52 ERROR - PROCESS | 25677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 02:59:53 INFO - TEST-INFO | 25677: exit 0 02:59:53 INFO - Browser initialized. 02:59:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:59:53 INFO - TEST-INFO | started process 25798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOfQR90/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:05 INFO - PROCESS | 25798 | RSS: Main: 169414656 03:00:05 INFO - PROCESS | 25798 | 03:00:55 INFO - PROCESS | 25798 | 1467972055263 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] 03:03:07 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:50375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50375/tests/dromaeo/cssquery-ext.html) 03:03:08 INFO - PROCESS | 25798 | RSS: Main: 168935424 03:03:08 INFO - PROCESS | 25798 | 03:06:10 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:50375/tests/dromaeo/cssquery-ext.html (next: http://localhost:50375/tests/dromaeo/cssquery-jquery.html) 03:06:11 INFO - PROCESS | 25798 | RSS: Main: 168755200 03:06:11 INFO - PROCESS | 25798 | 03:09:13 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:50375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50375/tests/dromaeo/cssquery-mootools.html) 03:09:13 INFO - PROCESS | 25798 | RSS: Main: 171180032 03:09:13 INFO - PROCESS | 25798 | 03:12:15 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:50375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50375/tests/dromaeo/cssquery-prototype.html) 03:12:16 INFO - PROCESS | 25798 | RSS: Main: 167821312 03:12:16 INFO - PROCESS | 25798 | 03:15:19 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:50375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50375/tests/dromaeo/cssquery-yui.html) 03:15:19 INFO - PROCESS | 25798 | RSS: Main: 169488384 03:15:19 INFO - PROCESS | 25798 | 03:18:22 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:50375/tests/dromaeo/cssquery-yui.html (next: http://localhost:50375/tests/dromaeo/cssquery-dojo.html) 03:18:23 INFO - PROCESS | 25798 | RSS: Main: 170401792 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | __start_tp_report 03:18:23 INFO - PROCESS | 25798 | _x_x_mozilla_page_load 03:18:23 INFO - PROCESS | 25798 | _x_x_mozilla_page_load_details 03:18:23 INFO - PROCESS | 25798 | |i|pagename|runs| 03:18:23 INFO - PROCESS | 25798 | |0;dojo.html;2593.3257353088197;2625.4880298341827;2637.3670319123394;2664.693560240573;2666.4800363929044;4765.166095933211;4768.403949506312;4842.636802239828;4854.85435436937;4855.4416242132165;4738.123447162268;4767.308740232673;4791.065742180276;4814.63890208234;4852.854414367565;4327.7619730914785;4431.977840110795;4436.401085853401;4472.597466228039;4497.7526236057;4482.932756008662;4522.933676266807;4539.954600453986;4545.749983750892;4578.061497393043;4299.634531064863;4380.934285985712;4394.4287242658565;4440.578145076212;4462.509123996358;4422.226110430694;4455.509893911667;4457.242268814277;4462.620677242438;4490.910181796378;4336.111097225062;4421.182081314935;4452;4459.777011149429;4495.280755079171;4740.905181896377;4869.975650121727;4884.120858245515;4885.926711099336;4906.215005599087;5219.71291578963;5222.686638801684;5237.4500677428705;5248.160294352923;5300.09898317287;4995.800167993276;5097.439281679012;5165.992631436871;5172.250023746573;5192.480751924815;4876.195427754416;4906.828261010847;4918.90162196754;4919.065377578248;4971.229459433757;5380.085385484477;5380.757865896044;5392.91910621341;5409.702466364309;5427.995820773091;5034.421041580192;5035.672681275705;5040.143175660147;5151.2273159026445;5164.586833053347;5083.339165908408;5136.409312928986;5182.922256166161;5193.714345711022;5235.947640523622;5151.5363617274625;5168.689878607221;5171.482851714798;5179.766910489037;5183.870403239874;5030.270610761419;5058.949410505921;5062.949370506321;5166.225066240094;5207.062728708869;4277.123189746095;4299.806508707115;4301.333293339538;4336.978315108404;4338.501072376654;3729.384651532521;3730.2539492101687;3736.159364143046;3747.4004159334377;3788.962110378916;4373.059792144704;4392.297232442794;4405.493368262627;4413.470383553994;4463.843765468193;5095.388553373545;5110;5115.38615366151;5126.436092029874;5139.6145289102715;4383.232934236496;4397.274449715761;4401.18578063053;4412.602865742098;4441.111777644484;4520.977395113004;4629.513901040342;4653.325267836212;4693.108309421199;4699.459562150328;4902.338184345139;4907.754612269372;4929.162042452864;4940.036692844861;4974.900501990012;5158.742062896915;5291.153415453509;5297.8145764898045;5304.0976287330395;5310.044192045469;4841.733704646278;4865.708057516419;4872.731999739906;4894;4932.28481870134;5143.3570803649545;5146.871328216675;5148.562372198405;5158.509941555546;5163.173892177234;5135.589152867687;5155.53600175986;5192.143296356059;5217.399999000164;5224.582033437392;4937.086638971802;4977.850664480072;5040.344755181803;5043;5051.419086805065;5059.241113832954;5060.089183946925;5073.264376665436;5079.314292570456;5121.61587880903;4823.662343636052;4924.507549245047;4992.400911890596;4992.825251116194;5004;5112.718800465861;5144.717040562805;5151;5154.639175257696;5180.948190518046;4964.174773256464;4986.650934434555;4987.501249874984;4989.426215985208;5021.874453138701 03:18:23 INFO - PROCESS | 25798 | |1;ext.html;515.9819406320779;544.2897019389695;554.2489926150066;561.3432284227454;567.6594043573856;37613.43579846305;38794;38826.417603735965;38847.223055538874;38952.41571376432;39795;40393.36459718625;40394.79802600983;40425.39361909567;40506.79746601263;7624.771256862303;7744.767656970272;7778.8444231115345;7797.298243158115;7819.609019549028;7475.401967842559;7520.8119797004965;7568.886466703004;7570.583617901013;7572.129205141397;7709.922900771005;7787.922120778805;7790.9610451947665;7795.805104872366;7800.141984381742;7691.1924247954;7710.1904300048245;7731.690732370698;7757.301842834144;7774.1837107104075;7616.619169041581;7647.732329368501;7664.271894170045;7673.884891726629;7677.539347639104;36451.81774091139;37404.812975935216;37589.624103758884;37611.62388376109;37649.62350376516;2612.5036243113746;2860.942781144386;2914.985425072882;2925.0493589583257;3101.457244982119;28367.716322836714;29181.854090729623;29285.26786830325;29347.266318341997;29535.556966645516;3263.184203949013;3322.235885746292;3355.2450698592866;3372.8482218300237;3444.896653100411;260318;261339;261952;263671.68164159247;264127;31205.531917021264;31502.842485787423;31675.524867127013;50172.23708221898;50533.494665053615;32913;33050.33899322048;33112.3377532448;33150.502742458884;33292;10825.891741082645;10860.945695271474;10913.399763012952;10915.454227288605;10926.125909927187;8617.569121543898;8693.782655433664;8719.38964272495;8724.520151391735;8756.8686469703;7610.581418022062;7648.694052237959;7662.693492260359;7778.261065198797;7785.610719464117;2942.1761906666165;3014.743746781548;3025.2890570715863;3049.84750762461;3066.3407367415666;830.9335253179731;892.0900681305162;909.3180114913814;933.9539715518663;934.1639232886529;27099.1870243893;27694.44611107807;27994.720052799617;28242.576361354597;28321;926.8841394825647;927.3786563002805;938.394735395666;949.2785483032807;958.712386284112;14173.220472873885;14608.831293496494;14735.263236838115;14934.850651493563;14959.775603365959;417438;421009;425409;425889;426249;47118;47312;47462;47573;47796.28305575419;1132.7451323452322;1154.9018333441584;1157.3518829455531;1158.0619698044611;1162.3490845126755;25383.238502844943;26914.59628105541;27030.729692702822;27065.1880443587;27069;36196.45705314475;36296.09259768527;36362.8181859089;36367;36538;278350;282684;283215;283945;284359;24132.39669008289;24607.38481537976;24618.384540386633;24658.506829862945;24717.752822472263;40099;41003.794981024905;41247.381289280085;41412;42087;35825.64174358327;35966.280674386886;36268.27463450769;36288.45567316545;36619.267614647026;36384.636153639185;36677;36701.26597468089;36759.81620091882;36899;30936;34218;34578.48132277968;34590.481142783385;35699.10752231215;30212.395752084394;31387.68612313939;31689.52640212161;31814.522782157823;31896.521552176273;23098.653520196873;23520.764792352544;23799.405014874075;24992.875035624704;26272.34319142037 03:18:23 INFO - PROCESS | 25798 | |2;jquery.html;362.82947014903;371.9609441008694;376.12363193758546;376.5124164207351;394.7138324714582;16041.518754437357;16262.43081492148;17494.21276042578;17542.38601648941;17553;16544.83455165448;16779.91610041948;17524.56188595286;17529.21118549665;17605.11974401278;4773.737444440554;5153.252778347138;5162.225666150089;5168.405633352175;5183.17069268917;5067.74661266937;5133.409657889353;5144;5174.922376164361;5184.351956005499;4980.651354405175;5058.49415058493;5098.26075219093;5138.845834624967;5140.66585671932;5036.722980236085;5071.949280507203;5079.4412614612365;5079.822206222783;5117.53942145205;4467.463904331468;4555.929356601196;4574.679772415932;4583.381243532114;4597.264437689987;19406.417807465798;19808.108635111454;19942.700859486973;20084.29704960334;20084.69872951907;1770.238797317153;1866.608012317415;1902.8477721782224;2046.4065421027883;2369.668246445499;9342.953285233598;9520.428774273565;9538.332316737831;12029.03767698582;12418.316992565406;1723.7069698151345;1733.4626265857623;1743.1458585293242;1785.0896043018154;1795.2190797003216;73525;73575;73912.630436848;75047.24952750512;75670.24329756686;10101;10203.234757393226;10228.437435940947;10274.22943279257;10500.527476263587;13991.440342386191;14101.647458813612;14116.364763585663;14117.576472705836;14118.43526258938;6703.564268322543;6732.899006514906;6865.588064716133;7009.509334346547;7015.123109611299;6265.561410701207;6359.300476947532;6370.936290637127;6413.230412350548;6414.935850641527;4281.2293787118615;4297.441332626739;4369.191699535532;4380.167768124046;4434.379186913835;1800.207908520247;1840.6686796376514;1851.4353122297828;1864.4779461750732;1865.309835360925;358.444411162702;365.16195331713783;366.26563739701726;382.367182313272;819.6885183630183;9808.558614862206;10284.897151028394;10313.432761198206;10507.579696812194;10531.860966712757;369.39234958493665;373.7085073642563;376.4560210495862;382.07728336068084;384.23537161049313;5409.080456322435;5416.91874621881;5464.453554644504;5529.502344788988;5533.6956467393875;361153;372401;372541;372607;372715;83271.5836420814;83810;84115;85196.14803852006;85815.570922145;403.558103876255;404.0887798015456;408.9815958281825;412.2846860696689;413.99379009314885;9680.709578712649;9888.851667224853;10029.348092373972;10138.594456221668;10215.846762298721;36828.44757328696;37179.44230836486;37787.81106094452;37805.81097094607;37902.24195516019;53840.46159538511;54395.45604543904;55065.44934550603;55066;55400;7270.382017528569;7498.175200727806;7533.510321829063;7565;7598.430117741302;11771;11950.581729639422;12039.63881083569;12067.336296503425;12433.751324973631;10328.690139295833;10585.417802020655;10759.30064545802;10871.67384978452;11036.834447483454;10185.643502477378;10547.472626368804;10628.946855265674;10749.247552671239;10782.353058816496;10234.897651023692;10448.373097613863;10669.253152279265;10688.625898093529;10752.032317091187;7571.242875712384;7620.276073772982;7798.883016754867;7812.765617031499;7933.722319719013;10192.184625229815;10220.693379198636;10383.896161038292;10510.369377837354;10511.632092876713 03:18:23 INFO - PROCESS | 25798 | |3;mootools.html;1322.7288405876795;1361.5711051018927;1393.9163650180983;1631.7633943078247;1633.975490367644;6795.49033822464;7163.247858974811;7468;7963.323117535009;7996.800079998003;7155.499115061948;7363.042804435416;7419.517731347472;7427.183009868923;7427.7771666850085;2182.4107490977467;2207.7792220777956;2209.215728416413;2214.191819985702;2219.4562332228547;2129.318618042227;2145.442185031887;2188.365374041526;2189.9781002189934;2191.561687662466;2160.4382860456317;2174.4889950861534;2183.290430610058;2188.3106821351303;2188.890555472228;2098.1607357057146;2111.366590022995;2115.217369573252;2116.2487317002474;2130.3182981445943;2018.0313449544153;2044.4990977210678;2047.4983629010987;2050.8974551272377;2058.907349169291;7399.260073992557;7454.360040791017;7469.178390377054;7507.887381689279;7514.872769084626;4531.682782205247;4676.69601475903;4690.663160999099;4694.225452800284;4694.2723877799;2834.9433011339866;2853.5576985567272;2866.0685277284756;2878.3667593129476;2977.865996030162;888.2494292323041;903.3315346643502;924.8011677489372;927.5900631040847;928.4382948316306;10501.897300783461;10568.947155264252;10585.682429527127;10590.68227953155;10597.523111460003;4074.2869997750277;4169.478815148106;4234.534201237861;4242.745435273893;4373.562643735601;9052.547372631474;9101.362904596746;9142.497162656118;9145.222656074307;9147.63409463614;4615.515370886076;4616.3537104805355;4625.190591646448;4631.768411579407;4651.441826980784;3742.607026262258;4094.4472496213225;4153.1486045360625;4196.517400498981;4238.87283381499;3632.7820330780237;3699.5930447650735;3740.8403394947654;3787.8484860605818;3797.35444974355;1183.408295852074;1212.090931801149;1216.7019080325376;1231.384307846077;1232.5562797392931;670.7585269303047;704.0706267726654;708.5429897715944;712.590260600157;718.6550455781254;5182.714950677749;5205.193195054772;5251.76367063483;5258.6581872178185;5340.279062326536;854.6624083486988;875.8292133034124;896.3187977137422;909.7452713240303;935.050923312838;3485.2506711057245;3701.0932321581386;3743.7005039596766;3744.5319335083113;3750.1187221003042;8841.381103322705;8990.55047247635;9038.18656320921;9091.409058411182;9121.635134594675;9010.954945225363;9024.8646270306;9029.819403612022;9041.18629323364;9043.638254469879;7207.459440542085;7258.709651613876;7370.742024029133;7424.109106907205;7426.443016773764;4585.151746926829;4601.12578610063;4612.861614151447;4624.907501850012;4671.556202160789;8659.740207793524;8820.779480513038;8864.670299455134;8883.111688831064;8895.4662720237;8785;8999.280057595246;9024.639014439348;9142.222911052635;9193.080691931022;5747.339056008445;6116.204893363834;6346.904796427965;6460.3862633049785;6585.078089067439;7315.451341149329;7328.890066648898;7375.778726638209;7378.96310518444;7417;6554.80335589933;6747.392734653708;6782.084418603426;6799.558028728117;6946.9652651736415;6640.435562977008;6684;6755.763548275787;6807.965960170168;6836.521443499107;6130.5402094842175;6140.140380346666;6196.938030619636;6214.9689251553455;6222.502199824094;4389.582989615981;4436.44544431946;4543.45478542577;4599.379083823775;4610.6542009350105;4670.276107203389;4684.8287928018;4727.101850648366;4779.426468823764;4820.421549413953 03:18:23 INFO - PROCESS | 25798 | |4;prototype.html;288.4980134565856;288.5902019132831;296.0172228202368;305.3998892176872;307.2595045939284;4884.804607815683;4981.501849815017;5038.798448062078;5118.616103792217;5128.282040514327;5038.697678139314;5046.394432668076;5048.899022019557;5049.495050494948;5078.720670363128;4000.419834165503;4000.8999775005714;4019.769028189354;4028.45615841862;4034.8587799427028;3936.5276166859876;3969.4320743306375;4039.2527382434346;4041.030152763345;4054.1688953764556;3925.5485619153733;3927.8428862845453;3929.5481019682675;3930.8231129599235;3938.4683067785913;3959.940600890989;3968.305546529346;3978.3833505806647;3991.1020020495157;4011.237864805707;3532.894013179609;3533.3993221152464;3546.5744110706883;3546.6098729139776;3549.254656522108;4869.586085182764;4938.691246819596;5000.174971129759;5005.474425185376;5051.191809310492;4484.304932735431;4512.623649786814;4516.21609464263;4526.524714904954;4554.362389265505;5264.447233040552;5280.445553216934;5286.709230992294;5298.125809241471;5333.759980800874;3520.559930008749;3749.3063783200196;3754.5494540655295;3834.213986132836;3846.615338466159;5560.66544029434;5577.442255774431;5627.015272327368;5627.915581266284;5657.236273103078;3814.771113733185;3819.7708137511836;3823.655870971626;3838.5777564467885;3842.2507611016144;3677.889663310105;3867;3871.8064096795047;3879.5344558652578;3883.1068854163136;4353.82584696615;4368.978155109204;4404.647628189737;4415.27148020573;4420.867373978722;5196.376434827769;5215.322008138994;5221.634485586049;5273.815416460406;5303;1260.500004994054;1289.013904363163;1318.4857905416895;1323.6889331007205;1329;887.7558671365297;889.1997202517656;904.7331037344;904.7469255081759;915.1489115123;4529.592336689648;4547.681662283675;4557.521460246693;4573.5426457354;4585.587297143206;5295.841124766263;5317.255584218213;5345.732713364317;5351.438098999549;5352.946470535323;4457.726559454637;4555.248384016666;4562.8631141065825;4580.221362368338;4588.357629931812;2520.2565243252916;2547.6115517043254;2548.4903019396197;2552.923412297634;2570.3060173752983;4471.23988921884;4486.932696009562;4514.968264281021;4523.479799823062;4547.840825571089;4633.536646335407;4864.756762161877;4893.975530122398;4902.352729526016;4906.607471402279;4475.910481790346;4476.679379582965;4482;4499.6400287976885;4515.751633660115;4705.576498115186;4743.691660042086;4747.952520474751;4763.523647635208;4789.257665061921;4632.652551058752;4663.463701674351;4682.441344578077;4686.367340409001;4693.319468677091;4682.836100736458;5116.692998420107;5120.231965205249;5136.691798492103;5148.7425628717665;3784.413415920537;3799.259144466913;3802.885913422602;3809.29528037314;3811.847526099036;5247;5436.510714035756;5492;5500.697461639648;5517.393086760373;4959.231319145538;5285.656432331886;5291;5293.894122117613;5301.575873930154;5176;5234.18870075139;5237.659552129099;5244;5268.525832675077;4961.6030717543235;5164.406093299319;5166.759977605423;5235.539296530625;5245.396779370269;5277.340332458442;5278.126265175807;5287.576993840406;5327;5334.599905007218;5177.731455793204;5188.377394712658;5190.844274671766;5228.320318358741;5250.947490525045 03:18:23 INFO - PROCESS | 25798 | |5;yui.html;556.3601857863456;581.66554231317;584.1908956095812;645.7094307561597;646.3181343682417;11387.089032877371;11733.296002239851;11992.460339284731;12336.62990110297;12355.50577976881;11752.236104653191;11776.234544754585;11828.172027958046;11830.40289560909;11886.881131188686;608.7412849538928;738.6269933683483;740.6926125657845;754.5397307642334;774.4346626962321;775.4726785785664;776.9728059517918;777.172311488266;777.6034222546485;777.7122464688073;801.6192308653401;805.9153788852174;806.3025482957229;807.7859367267649;808.0586117173515;792.6829268292671;795.1015352651525;797.6769408389612;800.8398320335926;802.9518228906285;587.4976894755008;588.4115884115885;588.9087191485327;589.3487696095838;590.1678633127312;11371.090312774959;11411.315321080761;11427.885721142766;11459.36973466459;11464.828027579593;13791.931040344834;13830.446782128703;13845.100068495516;14066.226357550331;14407.855921440756;9262.073792620684;9295.76760580984;9319.534023298876;9336.766580835465;9381.5309234538;3157.873685052595;3199.376121656278;3222.854971526287;3239.9028029159163;3254.332861763333;55260;57510.84978300452;57586.42413575853;63814.36185638177;64713.67643161801;8693.521856297837;8695.304375649934;8700.30397568193;8924.419912705653;9010.27917766577;16822.24299906507;16827.242774075195;16909.7463538047;17115.400960966308;18437.354692585694;6542.280349161589;6641.1366522352755;6656.267810540837;6674.365935236145;6783.287754785775;3586.3544561978574;3595.964040359563;3604.927901442009;3615.6565126312958;3679.2273622539033;2758.158761577738;2875.4967880620807;2877.5971364009056;2882.5964364988918;2884.524053531186;506.7896822818489;530.9973450132802;533.8905524367495;536.9704666243395;538.8818202230387;486.74445915893733;560.3527925246347;578.4360248757512;612.6079309242089;613.2518327640272;8449.32405407566;8534.615942282611;8744.8688269676;8808.427452215585;9042.095790421037;549.1899448313706;562.7552014873461;573.7905664432535;582.0774073094193;601.1943995046659;4140.710150289511;4170.436991006236;4196.643285320782;4196.685248606305;4211.620954114144;59505;93817.53091234637;98345.50827245817;101559;105546.47226763816;53146.468535314154;86490;86597.13402865891;87408.56295718481;87901;46179.53820461752;77943.99999999886;79852;80203.19796802074;81510;7911.564863932309;8175.345972322319;8214.301784348158;8315.83368332642;8317.584120794058;43623;44982.85120041697;45404.54595454003;45427;45566;61782;69117.65441172762;69437.65281173562;69585;69648;9429.811403772022;9626.181774549243;9761.267904907303;9840.458774767456;9860.901390986286;11600.709982250512;11629.59296424621;11660.825087623862;11788.115891308014;11826.704332391759;10267.897321026694;10739.570417183537;10824.891751082703;10869.836952445561;10875.945620271848;11083.168762342695;11379.772404552028;11495.942520287344;11577.942110289394;11882;9957.751056223653;10234.590616375262;10657.307275027099;12255.75488490243;12296.139270250997;10175.49122543855;10624.681259562225;10822.296550724177;10950.233483656068;11007.559697612005;10317.906004780862;11021.944890275498;11190.552377905118;11190.83213751778;11225.943870280596 03:18:23 INFO - PROCESS | 25798 | __end_tp_report 03:18:23 INFO - PROCESS | 25798 | __start_cc_report 03:18:23 INFO - PROCESS | 25798 | _x_x_mozilla_cycle_collect,392 03:18:23 INFO - PROCESS | 25798 | __end_cc_report 03:18:23 INFO - PROCESS | 25798 | __startTimestamp1467973103064__endTimestamp 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | ------- Summary: start ------- 03:18:23 INFO - PROCESS | 25798 | Number of tests: 6 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | [#0] dojo.html Cycles:165 Average:4781.83 Median:4929.16 stddev:525.95 (10.7%) stddev-sans-first:498.76 03:18:23 INFO - PROCESS | 25798 | Values: 2593.3 2625.5 2637.4 2664.7 2666.5 4765.2 4768.4 4842.6 4854.9 4855.4 4738.1 4767.3 4791.1 4814.6 4852.9 4327.8 4432.0 4436.4 4472.6 4497.8 4482.9 4522.9 4540.0 4545.7 4578.1 4299.6 4380.9 4394.4 4440.6 4462.5 4422.2 4455.5 4457.2 4462.6 4490.9 4336.1 4421.2 4452.0 4459.8 4495.3 4740.9 4870.0 4884.1 4885.9 4906.2 5219.7 5222.7 5237.5 5248.2 5300.1 4995.8 5097.4 5166.0 5172.3 5192.5 4876.2 4906.8 4918.9 4919.1 4971.2 5380.1 5380.8 5392.9 5409.7 5428.0 5034.4 5035.7 5040.1 5151.2 5164.6 5083.3 5136.4 5182.9 5193.7 5235.9 5151.5 5168.7 5171.5 5179.8 5183.9 5030.3 5058.9 5062.9 5166.2 5207.1 4277.1 4299.8 4301.3 4337.0 4338.5 3729.4 3730.3 3736.2 3747.4 3789.0 4373.1 4392.3 4405.5 4413.5 4463.8 5095.4 5110.0 5115.4 5126.4 5139.6 4383.2 4397.3 4401.2 4412.6 4441.1 4521.0 4629.5 4653.3 4693.1 4699.5 4902.3 4907.8 4929.2 4940.0 4974.9 5158.7 5291.2 5297.8 5304.1 5310.0 4841.7 4865.7 4872.7 4894.0 4932.3 5143.4 5146.9 5148.6 5158.5 5163.2 5135.6 5155.5 5192.1 5217.4 5224.6 4937.1 4977.9 5040.3 5043.0 5051.4 5059.2 5060.1 5073.3 5079.3 5121.6 4823.7 4924.5 4992.4 4992.8 5004.0 5112.7 5144.7 5151.0 5154.6 5180.9 4964.2 4986.7 4987.5 4989.4 5021.9 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | [#1] ext.html Cycles:180 Average:45706.60 Median:36375.82 stddev:87505.52 (240.6%) stddev-sans-first:87685.22 03:18:23 INFO - PROCESS | 25798 | Values: 516.0 544.3 554.2 561.3 567.7 37613.4 38794.0 38826.4 38847.2 38952.4 39795.0 40393.4 40394.8 40425.4 40506.8 7624.8 7744.8 7778.8 7797.3 7819.6 7475.4 7520.8 7568.9 7570.6 7572.1 7709.9 7787.9 7791.0 7795.8 7800.1 7691.2 7710.2 7731.7 7757.3 7774.2 7616.6 7647.7 7664.3 7673.9 7677.5 36451.8 37404.8 37589.6 37611.6 37649.6 2612.5 2860.9 2915.0 2925.0 3101.5 28367.7 29181.9 29285.3 29347.3 29535.6 3263.2 3322.2 3355.2 3372.8 3444.9 260318.0 261339.0 261952.0 263671.7 264127.0 31205.5 31502.8 31675.5 50172.2 50533.5 32913.0 33050.3 33112.3 33150.5 33292.0 10825.9 10860.9 10913.4 10915.5 10926.1 8617.6 8693.8 8719.4 8724.5 8756.9 7610.6 7648.7 7662.7 7778.3 7785.6 2942.2 3014.7 3025.3 3049.8 3066.3 830.9 892.1 909.3 934.0 934.2 27099.2 27694.4 27994.7 28242.6 28321.0 926.9 927.4 938.4 949.3 958.7 14173.2 14608.8 14735.3 14934.9 14959.8 417438.0 421009.0 425409.0 425889.0 426249.0 47118.0 47312.0 47462.0 47573.0 47796.3 1132.7 1154.9 1157.4 1158.1 1162.3 25383.2 26914.6 27030.7 27065.2 27069.0 36196.5 36296.1 36362.8 36367.0 36538.0 278350.0 282684.0 283215.0 283945.0 284359.0 24132.4 24607.4 24618.4 24658.5 24717.8 40099.0 41003.8 41247.4 41412.0 42087.0 35825.6 35966.3 36268.3 36288.5 36619.3 36384.6 36677.0 36701.3 36759.8 36899.0 30936.0 34218.0 34578.5 34590.5 35699.1 30212.4 31387.7 31689.5 31814.5 31896.5 23098.7 23520.8 23799.4 24992.9 26272.3 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | [#2] jquery.html Cycles:180 Average:23757.99 Median:19082.16 stddev:61738.57 (323.5%) stddev-sans-first:61886.77 03:18:23 INFO - PROCESS | 25798 | Values: 362.8 372.0 376.1 376.5 394.7 16041.5 16262.4 17494.2 17542.4 17553.0 16544.8 16779.9 17524.6 17529.2 17605.1 4773.7 5153.3 5162.2 5168.4 5183.2 5067.7 5133.4 5144.0 5174.9 5184.4 4980.7 5058.5 5098.3 5138.8 5140.7 5036.7 5071.9 5079.4 5079.8 5117.5 4467.5 4555.9 4574.7 4583.4 4597.3 19406.4 19808.1 19942.7 20084.3 20084.7 1770.2 1866.6 1902.8 2046.4 2369.7 9343.0 9520.4 9538.3 12029.0 12418.3 1723.7 1733.5 1743.1 1785.1 1795.2 73525.0 73575.0 73912.6 75047.2 75670.2 10101.0 10203.2 10228.4 10274.2 10500.5 13991.4 14101.6 14116.4 14117.6 14118.4 6703.6 6732.9 6865.6 7009.5 7015.1 6265.6 6359.3 6370.9 6413.2 6414.9 4281.2 4297.4 4369.2 4380.2 4434.4 1800.2 1840.7 1851.4 1864.5 1865.3 358.4 365.2 366.3 382.4 819.7 9808.6 10284.9 10313.4 10507.6 10531.9 369.4 373.7 376.5 382.1 384.2 5409.1 5416.9 5464.5 5529.5 5533.7 361153.0 372401.0 372541.0 372607.0 372715.0 83271.6 83810.0 84115.0 85196.1 85815.6 403.6 404.1 409.0 412.3 414.0 9680.7 9888.9 10029.3 10138.6 10215.8 36828.4 37179.4 37787.8 37805.8 37902.2 53840.5 54395.5 55065.4 55066.0 55400.0 7270.4 7498.2 7533.5 7565.0 7598.4 11771.0 11950.6 12039.6 12067.3 12433.8 10328.7 10585.4 10759.3 10871.7 11036.8 10185.6 10547.5 10628.9 10749.2 10782.4 10234.9 10448.4 10669.3 10688.6 10752.0 7571.2 7620.3 7798.9 7812.8 7933.7 10192.2 10220.7 10383.9 10510.4 10511.6 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | [#3] mootools.html Cycles:180 Average:5040.34 Median:5193.95 stddev:2793.07 (53.8%) stddev-sans-first:2786.93 03:18:23 INFO - PROCESS | 25798 | Values: 1322.7 1361.6 1393.9 1631.8 1634.0 6795.5 7163.2 7468.0 7963.3 7996.8 7155.5 7363.0 7419.5 7427.2 7427.8 2182.4 2207.8 2209.2 2214.2 2219.5 2129.3 2145.4 2188.4 2190.0 2191.6 2160.4 2174.5 2183.3 2188.3 2188.9 2098.2 2111.4 2115.2 2116.2 2130.3 2018.0 2044.5 2047.5 2050.9 2058.9 7399.3 7454.4 7469.2 7507.9 7514.9 4531.7 4676.7 4690.7 4694.2 4694.3 2834.9 2853.6 2866.1 2878.4 2977.9 888.2 903.3 924.8 927.6 928.4 10501.9 10568.9 10585.7 10590.7 10597.5 4074.3 4169.5 4234.5 4242.7 4373.6 9052.5 9101.4 9142.5 9145.2 9147.6 4615.5 4616.4 4625.2 4631.8 4651.4 3742.6 4094.4 4153.1 4196.5 4238.9 3632.8 3699.6 3740.8 3787.8 3797.4 1183.4 1212.1 1216.7 1231.4 1232.6 670.8 704.1 708.5 712.6 718.7 5182.7 5205.2 5251.8 5258.7 5340.3 854.7 875.8 896.3 909.7 935.1 3485.3 3701.1 3743.7 3744.5 3750.1 8841.4 8990.6 9038.2 9091.4 9121.6 9011.0 9024.9 9029.8 9041.2 9043.6 7207.5 7258.7 7370.7 7424.1 7426.4 4585.2 4601.1 4612.9 4624.9 4671.6 8659.7 8820.8 8864.7 8883.1 8895.5 8785.0 8999.3 9024.6 9142.2 9193.1 5747.3 6116.2 6346.9 6460.4 6585.1 7315.5 7328.9 7375.8 7379.0 7417.0 6554.8 6747.4 6782.1 6799.6 6947.0 6640.4 6684.0 6755.8 6808.0 6836.5 6130.5 6140.1 6196.9 6215.0 6222.5 4389.6 4436.4 4543.5 4599.4 4610.7 4670.3 4684.8 4727.1 4779.4 4820.4 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | [#4] prototype.html Cycles:180 Average:4281.92 Median:4633.09 stddev:1238.97 (26.7%) stddev-sans-first:1205.65 03:18:23 INFO - PROCESS | 25798 | Values: 288.5 288.6 296.0 305.4 307.3 4884.8 4981.5 5038.8 5118.6 5128.3 5038.7 5046.4 5048.9 5049.5 5078.7 4000.4 4000.9 4019.8 4028.5 4034.9 3936.5 3969.4 4039.3 4041.0 4054.2 3925.5 3927.8 3929.5 3930.8 3938.5 3959.9 3968.3 3978.4 3991.1 4011.2 3532.9 3533.4 3546.6 3546.6 3549.3 4869.6 4938.7 5000.2 5005.5 5051.2 4484.3 4512.6 4516.2 4526.5 4554.4 5264.4 5280.4 5286.7 5298.1 5333.8 3520.6 3749.3 3754.5 3834.2 3846.6 5560.7 5577.4 5627.0 5627.9 5657.2 3814.8 3819.8 3823.7 3838.6 3842.3 3677.9 3867.0 3871.8 3879.5 3883.1 4353.8 4369.0 4404.6 4415.3 4420.9 5196.4 5215.3 5221.6 5273.8 5303.0 1260.5 1289.0 1318.5 1323.7 1329.0 887.8 889.2 904.7 904.7 915.1 4529.6 4547.7 4557.5 4573.5 4585.6 5295.8 5317.3 5345.7 5351.4 5352.9 4457.7 4555.2 4562.9 4580.2 4588.4 2520.3 2547.6 2548.5 2552.9 2570.3 4471.2 4486.9 4515.0 4523.5 4547.8 4633.5 4864.8 4894.0 4902.4 4906.6 4475.9 4476.7 4482.0 4499.6 4515.8 4705.6 4743.7 4748.0 4763.5 4789.3 4632.7 4663.5 4682.4 4686.4 4693.3 4682.8 5116.7 5120.2 5136.7 5148.7 3784.4 3799.3 3802.9 3809.3 3811.8 5247.0 5436.5 5492.0 5500.7 5517.4 4959.2 5285.7 5291.0 5293.9 5301.6 5176.0 5234.2 5237.7 5244.0 5268.5 4961.6 5164.4 5166.8 5235.5 5245.4 5277.3 5278.1 5287.6 5327.0 5334.6 5177.7 5188.4 5190.8 5228.3 5250.9 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - PROCESS | 25798 | [#5] yui.html Cycles:180 Average:17283.95 Median:27908.18 stddev:25063.59 (89.8%) stddev-sans-first:25102.43 03:18:23 INFO - PROCESS | 25798 | Values: 556.4 581.7 584.2 645.7 646.3 11387.1 11733.3 11992.5 12336.6 12355.5 11752.2 11776.2 11828.2 11830.4 11886.9 608.7 738.6 740.7 754.5 774.4 775.5 777.0 777.2 777.6 777.7 801.6 805.9 806.3 807.8 808.1 792.7 795.1 797.7 800.8 803.0 587.5 588.4 588.9 589.3 590.2 11371.1 11411.3 11427.9 11459.4 11464.8 13791.9 13830.4 13845.1 14066.2 14407.9 9262.1 9295.8 9319.5 9336.8 9381.5 3157.9 3199.4 3222.9 3239.9 3254.3 55260.0 57510.8 57586.4 63814.4 64713.7 8693.5 8695.3 8700.3 8924.4 9010.3 16822.2 16827.2 16909.7 17115.4 18437.4 6542.3 6641.1 6656.3 6674.4 6783.3 3586.4 3596.0 3604.9 3615.7 3679.2 2758.2 2875.5 2877.6 2882.6 2884.5 506.8 531.0 533.9 537.0 538.9 486.7 560.4 578.4 612.6 613.3 8449.3 8534.6 8744.9 8808.4 9042.1 549.2 562.8 573.8 582.1 601.2 4140.7 4170.4 4196.6 4196.7 4211.6 59505.0 93817.5 98345.5 101559.0 105546.5 53146.5 86490.0 86597.1 87408.6 87901.0 46179.5 77944.0 79852.0 80203.2 81510.0 7911.6 8175.3 8214.3 8315.8 8317.6 43623.0 44982.9 45404.5 45427.0 45566.0 61782.0 69117.7 69437.7 69585.0 69648.0 9429.8 9626.2 9761.3 9840.5 9860.9 11600.7 11629.6 11660.8 11788.1 11826.7 10267.9 10739.6 10824.9 10869.8 10875.9 11083.2 11379.8 11495.9 11577.9 11882.0 9957.8 10234.6 10657.3 12255.8 12296.1 10175.5 10624.7 10822.3 10950.2 11007.6 10317.9 11021.9 11190.6 11190.8 11225.9 03:18:23 INFO - PROCESS | 25798 | -------- Summary: end -------- 03:18:23 INFO - PROCESS | 25798 | 03:18:23 INFO - TEST-INFO | 25798: exit 0 03:18:23 INFO - TEST-OK | dromaeo_css | took 1116901ms 03:18:23 INFO - TEST-START | kraken 03:18:23 INFO - operating with platform_type : linux_ 03:18:23 INFO - Initialising browser for kraken test... 03:18:23 INFO - TEST-INFO | started process 26045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoGt1sY/profile http://localhost:50375/getInfo.html) 03:18:28 INFO - PROCESS | 26045 | __metrics Screen width/height:1600/1200 03:18:28 INFO - PROCESS | 26045 | colorDepth:24 03:18:28 INFO - PROCESS | 26045 | Browser inner width/height: 1024/697 03:18:28 INFO - PROCESS | 26045 | __metrics 03:18:29 ERROR - PROCESS | 26045 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 03:18:30 INFO - TEST-INFO | 26045: exit 0 03:18:30 INFO - Browser initialized. 03:18:30 INFO - Running cycle 1/1 for kraken test... 03:18:30 INFO - TEST-INFO | started process 26164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoGt1sY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:42 INFO - PROCESS | 26164 | RSS: Main: 168849408 03:18:42 INFO - PROCESS | 26164 | 03:18:45 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50375/tests/kraken/driver.html?testName=audio-beat-detection) 03:18:46 INFO - PROCESS | 26164 | RSS: Main: 174080000 03:18:46 INFO - PROCESS | 26164 | 03:18:48 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50375/tests/kraken/driver.html?testName=audio-dft) 03:18:49 INFO - PROCESS | 26164 | RSS: Main: 173539328 03:18:49 INFO - PROCESS | 26164 | 03:18:52 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50375/tests/kraken/driver.html?testName=audio-fft) 03:18:53 INFO - PROCESS | 26164 | RSS: Main: 168386560 03:18:53 INFO - PROCESS | 26164 | 03:18:55 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50375/tests/kraken/driver.html?testName=audio-oscillator) 03:18:55 INFO - PROCESS | 26164 | RSS: Main: 169070592 03:18:55 INFO - PROCESS | 26164 | 03:18:58 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:18:58 INFO - PROCESS | 26164 | RSS: Main: 169517056 03:18:58 INFO - PROCESS | 26164 | 03:19:01 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50375/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:02 INFO - PROCESS | 26164 | RSS: Main: 169697280 03:19:02 INFO - PROCESS | 26164 | 03:19:06 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50375/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:06 INFO - PROCESS | 26164 | RSS: Main: 167124992 03:19:06 INFO - PROCESS | 26164 | 03:19:09 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50375/tests/kraken/driver.html?testName=json-parse-financial) 03:19:10 INFO - PROCESS | 26164 | RSS: Main: 168947712 03:19:10 INFO - PROCESS | 26164 | 03:19:12 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:12 INFO - PROCESS | 26164 | RSS: Main: 169046016 03:19:12 INFO - PROCESS | 26164 | 03:19:14 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:15 INFO - PROCESS | 26164 | RSS: Main: 169267200 03:19:15 INFO - PROCESS | 26164 | 03:19:17 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:18 INFO - PROCESS | 26164 | RSS: Main: 169648128 03:19:18 INFO - PROCESS | 26164 | 03:19:20 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:21 INFO - PROCESS | 26164 | RSS: Main: 169832448 03:19:21 INFO - PROCESS | 26164 | 03:19:24 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:24 INFO - PROCESS | 26164 | RSS: Main: 169181184 03:19:24 INFO - PROCESS | 26164 | 03:19:26 INFO - PROCESS | 26164 | Cycle 1(1): loaded http://localhost:50375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50375/tests/kraken/driver.html?testName=ai-astar) 03:19:26 INFO - PROCESS | 26164 | RSS: Main: 170237952 03:19:26 INFO - PROCESS | 26164 | 03:19:26 INFO - PROCESS | 26164 | __start_tp_report 03:19:26 INFO - PROCESS | 26164 | _x_x_mozilla_page_load 03:19:26 INFO - PROCESS | 26164 | _x_x_mozilla_page_load_details 03:19:26 INFO - PROCESS | 26164 | |i|pagename|runs| 03:19:26 INFO - PROCESS | 26164 | |0;ai-astar;105;117;109;117;117;114;118;114;114;113 03:19:26 INFO - PROCESS | 26164 | |1;audio-beat-detection;154;125;147;189;123;158;154;128;194;129 03:19:26 INFO - PROCESS | 26164 | |2;audio-dft;163;163;165;168;166;164;163;163;164;162 03:19:26 INFO - PROCESS | 26164 | |3;audio-fft;76;76;76;170;76;78;77;76;169;77 03:19:26 INFO - PROCESS | 26164 | |4;audio-oscillator;86;87;133;85;85;85;128;84;86;141 03:19:26 INFO - PROCESS | 26164 | |5;imaging-gaussian-blur;117;118;117;121;120;118;118;117;118;118 03:19:26 INFO - PROCESS | 26164 | |6;imaging-darkroom;148;149;147;147;148;147;148;147;148;147 03:19:26 INFO - PROCESS | 26164 | |7;imaging-desaturate;95;96;96;96;96;96;97;96;96;95 03:19:26 INFO - PROCESS | 26164 | |8;json-parse-financial;62;62;62;62;64;62;61;62;62;73 03:19:26 INFO - PROCESS | 26164 | |9;json-stringify-tinderbox;65;70;64;64;65;68;65;64;65;65 03:19:26 INFO - PROCESS | 26164 | |10;stanford-crypto-aes;87;85;79;80;79;80;79;80;84;79 03:19:26 INFO - PROCESS | 26164 | |11;stanford-crypto-ccm;137;134;130;144;134;132;134;134;175;130 03:19:26 INFO - PROCESS | 26164 | |12;stanford-crypto-pbkdf2;166;163;162;162;169;178;162;166;165;165 03:19:26 INFO - PROCESS | 26164 | |13;stanford-crypto-sha256-iterative;67;67;68;69;73;66;69;76;66;66 03:19:26 INFO - PROCESS | 26164 | __end_tp_report 03:19:26 INFO - PROCESS | 26164 | __start_cc_report 03:19:26 INFO - PROCESS | 26164 | _x_x_mozilla_cycle_collect,1001 03:19:26 INFO - PROCESS | 26164 | __end_cc_report 03:19:26 INFO - PROCESS | 26164 | __startTimestamp1467973166991__endTimestamp 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | ------- Summary: start ------- 03:19:27 INFO - PROCESS | 26164 | Number of tests: 14 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.50 stddev:4.08 (3.5%) stddev-sans-first:2.82 03:19:27 INFO - PROCESS | 26164 | Values: 105.0 117.0 109.0 117.0 117.0 114.0 118.0 114.0 114.0 113.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:154.00 stddev:25.48 (16.5%) stddev-sans-first:26.98 03:19:27 INFO - PROCESS | 26164 | Values: 154.0 125.0 147.0 189.0 123.0 158.0 154.0 128.0 194.0 129.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.79 (1.1%) stddev-sans-first:1.86 03:19:27 INFO - PROCESS | 26164 | Values: 163.0 163.0 165.0 168.0 166.0 164.0 163.0 163.0 164.0 162.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:39.22 (51.6%) stddev-sans-first:40.98 03:19:27 INFO - PROCESS | 26164 | Values: 76.0 76.0 76.0 170.0 76.0 78.0 77.0 76.0 169.0 77.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:85.00 stddev:23.68 (27.9%) stddev-sans-first:24.57 03:19:27 INFO - PROCESS | 26164 | Values: 86.0 87.0 133.0 85.0 85.0 85.0 128.0 84.0 86.0 141.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.32 (1.1%) stddev-sans-first:1.32 03:19:27 INFO - PROCESS | 26164 | Values: 117.0 118.0 117.0 121.0 120.0 118.0 118.0 117.0 118.0 118.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:19:27 INFO - PROCESS | 26164 | Values: 148.0 149.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 03:19:27 INFO - PROCESS | 26164 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:62.00 stddev:3.52 (5.7%) stddev-sans-first:3.71 03:19:27 INFO - PROCESS | 26164 | Values: 62.0 62.0 62.0 62.0 64.0 62.0 61.0 62.0 62.0 73.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.96 (3.0%) stddev-sans-first:2.07 03:19:27 INFO - PROCESS | 26164 | Values: 65.0 70.0 64.0 64.0 65.0 68.0 65.0 64.0 65.0 65.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:2.97 (3.7%) stddev-sans-first:2.30 03:19:27 INFO - PROCESS | 26164 | Values: 87.0 85.0 79.0 80.0 79.0 80.0 79.0 80.0 84.0 79.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:134.00 stddev:13.47 (10.1%) stddev-sans-first:14.28 03:19:27 INFO - PROCESS | 26164 | Values: 137.0 134.0 130.0 144.0 134.0 132.0 134.0 134.0 175.0 130.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:165.50 stddev:4.85 (2.9%) stddev-sans-first:5.14 03:19:27 INFO - PROCESS | 26164 | Values: 166.0 163.0 162.0 162.0 169.0 178.0 162.0 166.0 165.0 165.0 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - PROCESS | 26164 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:3.33 (4.9%) stddev-sans-first:3.48 03:19:27 INFO - PROCESS | 26164 | Values: 67.0 67.0 68.0 69.0 73.0 66.0 69.0 76.0 66.0 66.0 03:19:27 INFO - PROCESS | 26164 | -------- Summary: end -------- 03:19:27 INFO - PROCESS | 26164 | 03:19:27 INFO - TEST-INFO | 26164: exit 0 03:19:28 INFO - TEST-OK | kraken | took 64192ms 03:19:28 INFO - SUITE-END | took 1181s 03:19:28 INFO - Completed test suite (00:19:41) 03:19:28 INFO - javascript benchmark 03:19:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6183.237349608025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.3257353088197, 2625.4880298341827, 2637.3670319123394, 2664.693560240573, 2666.4800363929044, 4765.166095933211, 4768.403949506312, 4842.636802239828, 4854.85435436937, 4855.4416242132165, 4738.123447162268, 4767.308740232673, 4791.065742180276, 4814.63890208234, 4852.854414367565, 4327.7619730914785, 4431.977840110795, 4436.401085853401, 4472.597466228039, 4497.7526236057, 4482.932756008662, 4522.933676266807, 4539.954600453986, 4545.749983750892, 4578.061497393043, 4299.634531064863, 4380.934285985712, 4394.4287242658565, 4440.578145076212, 4462.509123996358, 4422.226110430694, 4455.509893911667, 4457.242268814277, 4462.620677242438, 4490.910181796378, 4336.111097225062, 4421.182081314935, 4452.0, 4459.777011149429, 4495.280755079171, 4740.905181896377, 4869.975650121727, 4884.120858245515, 4885.926711099336, 4906.215005599087, 5219.71291578963, 5222.686638801684, 5237.4500677428705, 5248.160294352923, 5300.09898317287, 4995.800167993276, 5097.439281679012, 5165.992631436871, 5172.250023746573, 5192.480751924815, 4876.195427754416, 4906.828261010847, 4918.90162196754, 4919.065377578248, 4971.229459433757, 5380.085385484477, 5380.757865896044, 5392.91910621341, 5409.702466364309, 5427.995820773091, 5034.421041580192, 5035.672681275705, 5040.143175660147, 5151.2273159026445, 5164.586833053347, 5083.339165908408, 5136.409312928986, 5182.922256166161, 5193.714345711022, 5235.947640523622, 5151.5363617274625, 5168.689878607221, 5171.482851714798, 5179.766910489037, 5183.870403239874, 5030.270610761419, 5058.949410505921, 5062.949370506321, 5166.225066240094, 5207.062728708869, 4277.123189746095, 4299.806508707115, 4301.333293339538, 4336.978315108404, 4338.501072376654, 3729.384651532521, 3730.2539492101687, 3736.159364143046, 3747.4004159334377, 3788.962110378916, 4373.059792144704, 4392.297232442794, 4405.493368262627, 4413.470383553994, 4463.843765468193, 5095.388553373545, 5110.0, 5115.38615366151, 5126.436092029874, 5139.6145289102715, 4383.232934236496, 4397.274449715761, 4401.18578063053, 4412.602865742098, 4441.111777644484, 4520.977395113004, 4629.513901040342, 4653.325267836212, 4693.108309421199, 4699.459562150328, 4902.338184345139, 4907.754612269372, 4929.162042452864, 4940.036692844861, 4974.900501990012, 5158.742062896915, 5291.153415453509, 5297.8145764898045, 5304.0976287330395, 5310.044192045469, 4841.733704646278, 4865.708057516419, 4872.731999739906, 4894.0, 4932.28481870134, 5143.3570803649545, 5146.871328216675, 5148.562372198405, 5158.509941555546, 5163.173892177234, 5135.589152867687, 5155.53600175986, 5192.143296356059, 5217.399999000164, 5224.582033437392, 4937.086638971802, 4977.850664480072, 5040.344755181803, 5043.0, 5051.419086805065, 5059.241113832954, 5060.089183946925, 5073.264376665436, 5079.314292570456, 5121.61587880903, 4823.662343636052, 4924.507549245047, 4992.400911890596, 4992.825251116194, 5004.0, 5112.718800465861, 5144.717040562805, 5151.0, 5154.639175257696, 5180.948190518046, 4964.174773256464, 4986.650934434555, 4987.501249874984, 4989.426215985208, 5021.874453138701], "value": 4746.348036733693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.9819406320779, 544.2897019389695, 554.2489926150066, 561.3432284227454, 567.6594043573856, 37613.43579846305, 38794.0, 38826.417603735965, 38847.223055538874, 38952.41571376432, 39795.0, 40393.36459718625, 40394.79802600983, 40425.39361909567, 40506.79746601263, 7624.771256862303, 7744.767656970272, 7778.8444231115345, 7797.298243158115, 7819.609019549028, 7475.401967842559, 7520.8119797004965, 7568.886466703004, 7570.583617901013, 7572.129205141397, 7709.922900771005, 7787.922120778805, 7790.9610451947665, 7795.805104872366, 7800.141984381742, 7691.1924247954, 7710.1904300048245, 7731.690732370698, 7757.301842834144, 7774.1837107104075, 7616.619169041581, 7647.732329368501, 7664.271894170045, 7673.884891726629, 7677.539347639104, 36451.81774091139, 37404.812975935216, 37589.624103758884, 37611.62388376109, 37649.62350376516, 2612.5036243113746, 2860.942781144386, 2914.985425072882, 2925.0493589583257, 3101.457244982119, 28367.716322836714, 29181.854090729623, 29285.26786830325, 29347.266318341997, 29535.556966645516, 3263.184203949013, 3322.235885746292, 3355.2450698592866, 3372.8482218300237, 3444.896653100411, 260318.0, 261339.0, 261952.0, 263671.68164159247, 264127.0, 31205.531917021264, 31502.842485787423, 31675.524867127013, 50172.23708221898, 50533.494665053615, 32913.0, 33050.33899322048, 33112.3377532448, 33150.502742458884, 33292.0, 10825.891741082645, 10860.945695271474, 10913.399763012952, 10915.454227288605, 10926.125909927187, 8617.569121543898, 8693.782655433664, 8719.38964272495, 8724.520151391735, 8756.8686469703, 7610.581418022062, 7648.694052237959, 7662.693492260359, 7778.261065198797, 7785.610719464117, 2942.1761906666165, 3014.743746781548, 3025.2890570715863, 3049.84750762461, 3066.3407367415666, 830.9335253179731, 892.0900681305162, 909.3180114913814, 933.9539715518663, 934.1639232886529, 27099.1870243893, 27694.44611107807, 27994.720052799617, 28242.576361354597, 28321.0, 926.8841394825647, 927.3786563002805, 938.394735395666, 949.2785483032807, 958.712386284112, 14173.220472873885, 14608.831293496494, 14735.263236838115, 14934.850651493563, 14959.775603365959, 417438.0, 421009.0, 425409.0, 425889.0, 426249.0, 47118.0, 47312.0, 47462.0, 47573.0, 47796.28305575419, 1132.7451323452322, 1154.9018333441584, 1157.3518829455531, 1158.0619698044611, 1162.3490845126755, 25383.238502844943, 26914.59628105541, 27030.729692702822, 27065.1880443587, 27069.0, 36196.45705314475, 36296.09259768527, 36362.8181859089, 36367.0, 36538.0, 278350.0, 282684.0, 283215.0, 283945.0, 284359.0, 24132.39669008289, 24607.38481537976, 24618.384540386633, 24658.506829862945, 24717.752822472263, 40099.0, 41003.794981024905, 41247.381289280085, 41412.0, 42087.0, 35825.64174358327, 35966.280674386886, 36268.27463450769, 36288.45567316545, 36619.267614647026, 36384.636153639185, 36677.0, 36701.26597468089, 36759.81620091882, 36899.0, 30936.0, 34218.0, 34578.48132277968, 34590.481142783385, 35699.10752231215, 30212.395752084394, 31387.68612313939, 31689.52640212161, 31814.522782157823, 31896.521552176273, 23098.653520196873, 23520.764792352544, 23799.405014874075, 24992.875035624704, 26272.34319142037], "value": 15791.00153933772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.82947014903, 371.9609441008694, 376.12363193758546, 376.5124164207351, 394.7138324714582, 16041.518754437357, 16262.43081492148, 17494.21276042578, 17542.38601648941, 17553.0, 16544.83455165448, 16779.91610041948, 17524.56188595286, 17529.21118549665, 17605.11974401278, 4773.737444440554, 5153.252778347138, 5162.225666150089, 5168.405633352175, 5183.17069268917, 5067.74661266937, 5133.409657889353, 5144.0, 5174.922376164361, 5184.351956005499, 4980.651354405175, 5058.49415058493, 5098.26075219093, 5138.845834624967, 5140.66585671932, 5036.722980236085, 5071.949280507203, 5079.4412614612365, 5079.822206222783, 5117.53942145205, 4467.463904331468, 4555.929356601196, 4574.679772415932, 4583.381243532114, 4597.264437689987, 19406.417807465798, 19808.108635111454, 19942.700859486973, 20084.29704960334, 20084.69872951907, 1770.238797317153, 1866.608012317415, 1902.8477721782224, 2046.4065421027883, 2369.668246445499, 9342.953285233598, 9520.428774273565, 9538.332316737831, 12029.03767698582, 12418.316992565406, 1723.7069698151345, 1733.4626265857623, 1743.1458585293242, 1785.0896043018154, 1795.2190797003216, 73525.0, 73575.0, 73912.630436848, 75047.24952750512, 75670.24329756686, 10101.0, 10203.234757393226, 10228.437435940947, 10274.22943279257, 10500.527476263587, 13991.440342386191, 14101.647458813612, 14116.364763585663, 14117.576472705836, 14118.43526258938, 6703.564268322543, 6732.899006514906, 6865.588064716133, 7009.509334346547, 7015.123109611299, 6265.561410701207, 6359.300476947532, 6370.936290637127, 6413.230412350548, 6414.935850641527, 4281.2293787118615, 4297.441332626739, 4369.191699535532, 4380.167768124046, 4434.379186913835, 1800.207908520247, 1840.6686796376514, 1851.4353122297828, 1864.4779461750732, 1865.309835360925, 358.444411162702, 365.16195331713783, 366.26563739701726, 382.367182313272, 819.6885183630183, 9808.558614862206, 10284.897151028394, 10313.432761198206, 10507.579696812194, 10531.860966712757, 369.39234958493665, 373.7085073642563, 376.4560210495862, 382.07728336068084, 384.23537161049313, 5409.080456322435, 5416.91874621881, 5464.453554644504, 5529.502344788988, 5533.6956467393875, 361153.0, 372401.0, 372541.0, 372607.0, 372715.0, 83271.5836420814, 83810.0, 84115.0, 85196.14803852006, 85815.570922145, 403.558103876255, 404.0887798015456, 408.9815958281825, 412.2846860696689, 413.99379009314885, 9680.709578712649, 9888.851667224853, 10029.348092373972, 10138.594456221668, 10215.846762298721, 36828.44757328696, 37179.44230836486, 37787.81106094452, 37805.81097094607, 37902.24195516019, 53840.46159538511, 54395.45604543904, 55065.44934550603, 55066.0, 55400.0, 7270.382017528569, 7498.175200727806, 7533.510321829063, 7565.0, 7598.430117741302, 11771.0, 11950.581729639422, 12039.63881083569, 12067.336296503425, 12433.751324973631, 10328.690139295833, 10585.417802020655, 10759.30064545802, 10871.67384978452, 11036.834447483454, 10185.643502477378, 10547.472626368804, 10628.946855265674, 10749.247552671239, 10782.353058816496, 10234.897651023692, 10448.373097613863, 10669.253152279265, 10688.625898093529, 10752.032317091187, 7571.242875712384, 7620.276073772982, 7798.883016754867, 7812.765617031499, 7933.722319719013, 10192.184625229815, 10220.693379198636, 10383.896161038292, 10510.369377837354, 10511.632092876713], "value": 7413.367267049019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.7288405876795, 1361.5711051018927, 1393.9163650180983, 1631.7633943078247, 1633.975490367644, 6795.49033822464, 7163.247858974811, 7468.0, 7963.323117535009, 7996.800079998003, 7155.499115061948, 7363.042804435416, 7419.517731347472, 7427.183009868923, 7427.7771666850085, 2182.4107490977467, 2207.7792220777956, 2209.215728416413, 2214.191819985702, 2219.4562332228547, 2129.318618042227, 2145.442185031887, 2188.365374041526, 2189.9781002189934, 2191.561687662466, 2160.4382860456317, 2174.4889950861534, 2183.290430610058, 2188.3106821351303, 2188.890555472228, 2098.1607357057146, 2111.366590022995, 2115.217369573252, 2116.2487317002474, 2130.3182981445943, 2018.0313449544153, 2044.4990977210678, 2047.4983629010987, 2050.8974551272377, 2058.907349169291, 7399.260073992557, 7454.360040791017, 7469.178390377054, 7507.887381689279, 7514.872769084626, 4531.682782205247, 4676.69601475903, 4690.663160999099, 4694.225452800284, 4694.2723877799, 2834.9433011339866, 2853.5576985567272, 2866.0685277284756, 2878.3667593129476, 2977.865996030162, 888.2494292323041, 903.3315346643502, 924.8011677489372, 927.5900631040847, 928.4382948316306, 10501.897300783461, 10568.947155264252, 10585.682429527127, 10590.68227953155, 10597.523111460003, 4074.2869997750277, 4169.478815148106, 4234.534201237861, 4242.745435273893, 4373.562643735601, 9052.547372631474, 9101.362904596746, 9142.497162656118, 9145.222656074307, 9147.63409463614, 4615.515370886076, 4616.3537104805355, 4625.190591646448, 4631.768411579407, 4651.441826980784, 3742.607026262258, 4094.4472496213225, 4153.1486045360625, 4196.517400498981, 4238.87283381499, 3632.7820330780237, 3699.5930447650735, 3740.8403394947654, 3787.8484860605818, 3797.35444974355, 1183.408295852074, 1212.090931801149, 1216.7019080325376, 1231.384307846077, 1232.5562797392931, 670.7585269303047, 704.0706267726654, 708.5429897715944, 712.590260600157, 718.6550455781254, 5182.714950677749, 5205.193195054772, 5251.76367063483, 5258.6581872178185, 5340.279062326536, 854.6624083486988, 875.8292133034124, 896.3187977137422, 909.7452713240303, 935.050923312838, 3485.2506711057245, 3701.0932321581386, 3743.7005039596766, 3744.5319335083113, 3750.1187221003042, 8841.381103322705, 8990.55047247635, 9038.18656320921, 9091.409058411182, 9121.635134594675, 9010.954945225363, 9024.8646270306, 9029.819403612022, 9041.18629323364, 9043.638254469879, 7207.459440542085, 7258.709651613876, 7370.742024029133, 7424.109106907205, 7426.443016773764, 4585.151746926829, 4601.12578610063, 4612.861614151447, 4624.907501850012, 4671.556202160789, 8659.740207793524, 8820.779480513038, 8864.670299455134, 8883.111688831064, 8895.4662720237, 8785.0, 8999.280057595246, 9024.639014439348, 9142.222911052635, 9193.080691931022, 5747.339056008445, 6116.204893363834, 6346.904796427965, 6460.3862633049785, 6585.078089067439, 7315.451341149329, 7328.890066648898, 7375.778726638209, 7378.96310518444, 7417.0, 6554.80335589933, 6747.392734653708, 6782.084418603426, 6799.558028728117, 6946.9652651736415, 6640.435562977008, 6684.0, 6755.763548275787, 6807.965960170168, 6836.521443499107, 6130.5402094842175, 6140.140380346666, 6196.938030619636, 6214.9689251553455, 6222.502199824094, 4389.582989615981, 4436.44544431946, 4543.45478542577, 4599.379083823775, 4610.6542009350105, 4670.276107203389, 4684.8287928018, 4727.101850648366, 4779.426468823764, 4820.421549413953], "value": 4068.065744013304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.4980134565856, 288.5902019132831, 296.0172228202368, 305.3998892176872, 307.2595045939284, 4884.804607815683, 4981.501849815017, 5038.798448062078, 5118.616103792217, 5128.282040514327, 5038.697678139314, 5046.394432668076, 5048.899022019557, 5049.495050494948, 5078.720670363128, 4000.419834165503, 4000.8999775005714, 4019.769028189354, 4028.45615841862, 4034.8587799427028, 3936.5276166859876, 3969.4320743306375, 4039.2527382434346, 4041.030152763345, 4054.1688953764556, 3925.5485619153733, 3927.8428862845453, 3929.5481019682675, 3930.8231129599235, 3938.4683067785913, 3959.940600890989, 3968.305546529346, 3978.3833505806647, 3991.1020020495157, 4011.237864805707, 3532.894013179609, 3533.3993221152464, 3546.5744110706883, 3546.6098729139776, 3549.254656522108, 4869.586085182764, 4938.691246819596, 5000.174971129759, 5005.474425185376, 5051.191809310492, 4484.304932735431, 4512.623649786814, 4516.21609464263, 4526.524714904954, 4554.362389265505, 5264.447233040552, 5280.445553216934, 5286.709230992294, 5298.125809241471, 5333.759980800874, 3520.559930008749, 3749.3063783200196, 3754.5494540655295, 3834.213986132836, 3846.615338466159, 5560.66544029434, 5577.442255774431, 5627.015272327368, 5627.915581266284, 5657.236273103078, 3814.771113733185, 3819.7708137511836, 3823.655870971626, 3838.5777564467885, 3842.2507611016144, 3677.889663310105, 3867.0, 3871.8064096795047, 3879.5344558652578, 3883.1068854163136, 4353.82584696615, 4368.978155109204, 4404.647628189737, 4415.27148020573, 4420.867373978722, 5196.376434827769, 5215.322008138994, 5221.634485586049, 5273.815416460406, 5303.0, 1260.500004994054, 1289.013904363163, 1318.4857905416895, 1323.6889331007205, 1329.0, 887.7558671365297, 889.1997202517656, 904.7331037344, 904.7469255081759, 915.1489115123, 4529.592336689648, 4547.681662283675, 4557.521460246693, 4573.5426457354, 4585.587297143206, 5295.841124766263, 5317.255584218213, 5345.732713364317, 5351.438098999549, 5352.946470535323, 4457.726559454637, 4555.248384016666, 4562.8631141065825, 4580.221362368338, 4588.357629931812, 2520.2565243252916, 2547.6115517043254, 2548.4903019396197, 2552.923412297634, 2570.3060173752983, 4471.23988921884, 4486.932696009562, 4514.968264281021, 4523.479799823062, 4547.840825571089, 4633.536646335407, 4864.756762161877, 4893.975530122398, 4902.352729526016, 4906.607471402279, 4475.910481790346, 4476.679379582965, 4482.0, 4499.6400287976885, 4515.751633660115, 4705.576498115186, 4743.691660042086, 4747.952520474751, 4763.523647635208, 4789.257665061921, 4632.652551058752, 4663.463701674351, 4682.441344578077, 4686.367340409001, 4693.319468677091, 4682.836100736458, 5116.692998420107, 5120.231965205249, 5136.691798492103, 5148.7425628717665, 3784.413415920537, 3799.259144466913, 3802.885913422602, 3809.29528037314, 3811.847526099036, 5247.0, 5436.510714035756, 5492.0, 5500.697461639648, 5517.393086760373, 4959.231319145538, 5285.656432331886, 5291.0, 5293.894122117613, 5301.575873930154, 5176.0, 5234.18870075139, 5237.659552129099, 5244.0, 5268.525832675077, 4961.6030717543235, 5164.406093299319, 5166.759977605423, 5235.539296530625, 5245.396779370269, 5277.340332458442, 5278.126265175807, 5287.576993840406, 5327.0, 5334.599905007218, 5177.731455793204, 5188.377394712658, 5190.844274671766, 5228.320318358741, 5250.947490525045], "value": 3885.8226893922015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.3601857863456, 581.66554231317, 584.1908956095812, 645.7094307561597, 646.3181343682417, 11387.089032877371, 11733.296002239851, 11992.460339284731, 12336.62990110297, 12355.50577976881, 11752.236104653191, 11776.234544754585, 11828.172027958046, 11830.40289560909, 11886.881131188686, 608.7412849538928, 738.6269933683483, 740.6926125657845, 754.5397307642334, 774.4346626962321, 775.4726785785664, 776.9728059517918, 777.172311488266, 777.6034222546485, 777.7122464688073, 801.6192308653401, 805.9153788852174, 806.3025482957229, 807.7859367267649, 808.0586117173515, 792.6829268292671, 795.1015352651525, 797.6769408389612, 800.8398320335926, 802.9518228906285, 587.4976894755008, 588.4115884115885, 588.9087191485327, 589.3487696095838, 590.1678633127312, 11371.090312774959, 11411.315321080761, 11427.885721142766, 11459.36973466459, 11464.828027579593, 13791.931040344834, 13830.446782128703, 13845.100068495516, 14066.226357550331, 14407.855921440756, 9262.073792620684, 9295.76760580984, 9319.534023298876, 9336.766580835465, 9381.5309234538, 3157.873685052595, 3199.376121656278, 3222.854971526287, 3239.9028029159163, 3254.332861763333, 55260.0, 57510.84978300452, 57586.42413575853, 63814.36185638177, 64713.67643161801, 8693.521856297837, 8695.304375649934, 8700.30397568193, 8924.419912705653, 9010.27917766577, 16822.24299906507, 16827.242774075195, 16909.7463538047, 17115.400960966308, 18437.354692585694, 6542.280349161589, 6641.1366522352755, 6656.267810540837, 6674.365935236145, 6783.287754785775, 3586.3544561978574, 3595.964040359563, 3604.927901442009, 3615.6565126312958, 3679.2273622539033, 2758.158761577738, 2875.4967880620807, 2877.5971364009056, 2882.5964364988918, 2884.524053531186, 506.7896822818489, 530.9973450132802, 533.8905524367495, 536.9704666243395, 538.8818202230387, 486.74445915893733, 560.3527925246347, 578.4360248757512, 612.6079309242089, 613.2518327640272, 8449.32405407566, 8534.615942282611, 8744.8688269676, 8808.427452215585, 9042.095790421037, 549.1899448313706, 562.7552014873461, 573.7905664432535, 582.0774073094193, 601.1943995046659, 4140.710150289511, 4170.436991006236, 4196.643285320782, 4196.685248606305, 4211.620954114144, 59505.0, 93817.53091234637, 98345.50827245817, 101559.0, 105546.47226763816, 53146.468535314154, 86490.0, 86597.13402865891, 87408.56295718481, 87901.0, 46179.53820461752, 77943.99999999886, 79852.0, 80203.19796802074, 81510.0, 7911.564863932309, 8175.345972322319, 8214.301784348158, 8315.83368332642, 8317.584120794058, 43623.0, 44982.85120041697, 45404.54595454003, 45427.0, 45566.0, 61782.0, 69117.65441172762, 69437.65281173562, 69585.0, 69648.0, 9429.811403772022, 9626.181774549243, 9761.267904907303, 9840.458774767456, 9860.901390986286, 11600.709982250512, 11629.59296424621, 11660.825087623862, 11788.115891308014, 11826.704332391759, 10267.897321026694, 10739.570417183537, 10824.891751082703, 10869.836952445561, 10875.945620271848, 11083.168762342695, 11379.772404552028, 11495.942520287344, 11577.942110289394, 11882.0, 9957.751056223653, 10234.590616375262, 10657.307275027099, 12255.75488490243, 12296.139270250997, 10175.49122543855, 10624.681259562225, 10822.296550724177, 10950.233483656068, 11007.559697612005, 10317.906004780862, 11021.944890275498, 11190.552377905118, 11190.83213751778, 11225.943870280596], "value": 6362.04677517916, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 109.0, 117.0, 117.0, 114.0, 118.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 147.0, 189.0, 123.0, 158.0, 154.0, 128.0, 194.0, 129.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 168.0, 166.0, 164.0, 163.0, 163.0, 164.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 170.0, 76.0, 78.0, 77.0, 76.0, 169.0, 77.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 133.0, 85.0, 85.0, 85.0, 128.0, 84.0, 86.0, 141.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 121.0, 120.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 64.0, 62.0, 61.0, 62.0, 62.0, 73.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 64.0, 64.0, 65.0, 68.0, 65.0, 64.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 79.0, 80.0, 79.0, 80.0, 79.0, 80.0, 84.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 130.0, 144.0, 134.0, 132.0, 134.0, 134.0, 175.0, 130.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 162.0, 169.0, 178.0, 162.0, 166.0, 165.0, 165.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 73.0, 66.0, 69.0, 76.0, 66.0, 66.0], "value": 68.7, "unit": "score"}]}]} 03:19:28 INFO - Return code: 0 03:19:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:19:28 ERROR - # TBPL SUCCESS # 03:19:28 INFO - Running post-action listener: _resource_record_post_action 03:19:28 INFO - ##### 03:19:28 INFO - ##### Finished run-tests step (success) 03:19:28 INFO - ##### 03:19:28 INFO - Running post-run listener: _resource_record_post_run 03:19:28 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547299328; Read time: 16; Write time: 494828 03:19:28 INFO - TinderboxPrint: CPU usage
13.3% 03:19:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:19:28 INFO - TinderboxPrint: I/O write bytes / time
547,299,328 / 494,828 03:19:28 INFO - TinderboxPrint: CPU idle
8,282.8 (86.6%) 03:19:28 INFO - TinderboxPrint: CPU user
1,222.0 (12.8%) 03:19:28 INFO - TinderboxPrint: Swap in / out
0 / 0 03:19:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246534144; Read time: 0; Write time: 285312 03:19:28 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 300765184; Read time: 0; Write time: 209516 03:19:28 INFO - Running post-run listener: _upload_blobber_files 03:19:28 INFO - Blob upload gear active. 03:19:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:19:28 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 03:19:28 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:19:28 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:19:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:19:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:19:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:30 INFO - (blobuploader) - INFO - Done attempting. 03:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:30 INFO - (blobuploader) - INFO - Done attempting. 03:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:34 INFO - (blobuploader) - INFO - Done attempting. 03:19:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:19:34 INFO - Return code: 0 03:19:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:19:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:19:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6c18e2352ce99fdfd20876cedeb7833dac537d8f9470bd61ad9ecb883b74df57920622ff1c1e966255e9bf21625d3fa120caf9dd11103bde3a3f8cc0abb42e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb1ebde08ddc5207bfa301eddadf5029afee4ed8e0857e54aa31f655da9b2a303e8f991188abfba1fbd89dc52d4fc9c55f1acf59e1c78dc687f535e1991547f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b84ff134acc2f7a534725843cbe2381976789033266d08b06aafe95c00cc7246c5585b9ce1f43c5b9fdc40a6dbe26d3fe80f92ada7d9a55000e62bdc5140b4e"} 03:19:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:19:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:19:34 INFO - Contents: 03:19:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6c18e2352ce99fdfd20876cedeb7833dac537d8f9470bd61ad9ecb883b74df57920622ff1c1e966255e9bf21625d3fa120caf9dd11103bde3a3f8cc0abb42e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb1ebde08ddc5207bfa301eddadf5029afee4ed8e0857e54aa31f655da9b2a303e8f991188abfba1fbd89dc52d4fc9c55f1acf59e1c78dc687f535e1991547f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b84ff134acc2f7a534725843cbe2381976789033266d08b06aafe95c00cc7246c5585b9ce1f43c5b9fdc40a6dbe26d3fe80f92ada7d9a55000e62bdc5140b4e"} 03:19:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:19:34 INFO - Copying logs to upload dir... 03:19:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:19:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.522229 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-08 03:19:33.889952) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:19:33.893561) ========= 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=920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6c18e2352ce99fdfd20876cedeb7833dac537d8f9470bd61ad9ecb883b74df57920622ff1c1e966255e9bf21625d3fa120caf9dd11103bde3a3f8cc0abb42e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb1ebde08ddc5207bfa301eddadf5029afee4ed8e0857e54aa31f655da9b2a303e8f991188abfba1fbd89dc52d4fc9c55f1acf59e1c78dc687f535e1991547f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b84ff134acc2f7a534725843cbe2381976789033266d08b06aafe95c00cc7246c5585b9ce1f43c5b9fdc40a6dbe26d3fe80f92ada7d9a55000e62bdc5140b4e"} build_url:https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/Vtvy8-PSRh6OTjzxaFFmyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6c18e2352ce99fdfd20876cedeb7833dac537d8f9470bd61ad9ecb883b74df57920622ff1c1e966255e9bf21625d3fa120caf9dd11103bde3a3f8cc0abb42e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb1ebde08ddc5207bfa301eddadf5029afee4ed8e0857e54aa31f655da9b2a303e8f991188abfba1fbd89dc52d4fc9c55f1acf59e1c78dc687f535e1991547f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0b84ff134acc2f7a534725843cbe2381976789033266d08b06aafe95c00cc7246c5585b9ce1f43c5b9fdc40a6dbe26d3fe80f92ada7d9a55000e62bdc5140b4e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:19:33.918760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:19:33.919333) ========= 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=920470bf432669ad7e3a5387000001ca-1467969185.882011-363481701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:19:34.001302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:19:34.001647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:19:34.001941) ========= ========= Total master_lag: 0.18 =========