builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1468016836.01 results: success (0) buildid: 20160708123001 builduid: e5682ae8fb4d4a71ba053086377bf329 revision: 53b24e115c194df3cc9cbd9a99959209637a4beb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.007064) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.007676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.008057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.024216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.024752) ========= 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=923d835db2ba3686ebe126b700000192-1468016835.462334-721472653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 15:27:16-- 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% 46.3M=0s 2016-07-08 15:27:16 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.114378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.114833) ========= 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=923d835db2ba3686ebe126b700000192-1468016835.462334-721472653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014203 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:16.166619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 15:27:16.167169) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 53b24e115c194df3cc9cbd9a99959209637a4beb --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 53b24e115c194df3cc9cbd9a99959209637a4beb --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=923d835db2ba3686ebe126b700000192-1468016835.462334-721472653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 15:27:16,326 truncating revision to first 12 chars 2016-07-08 15:27:16,326 Setting DEBUG logging. 2016-07-08 15:27:16,326 attempt 1/10 2016-07-08 15:27:16,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/53b24e115c19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 15:27:17,276 unpacking tar archive at: autoland-53b24e115c19/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 15:27:17.454264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:17.454602) ========= script_repo_revision: 53b24e115c194df3cc9cbd9a99959209637a4beb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:17.454985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:17.455262) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 15:27:17.466057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-08 15:27:17.466465) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=923d835db2ba3686ebe126b700000192-1468016835.462334-721472653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:27:17 INFO - MultiFileLogger online at 20160708 15:27:17 in /builds/slave/test 15:27:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:27:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:27:17 INFO - {'append_to_log': False, 15:27:17 INFO - 'base_work_dir': '/builds/slave/test', 15:27:17 INFO - 'blob_upload_branch': 'Autoland', 15:27:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:27:17 INFO - 'branch': 'Autoland', 15:27:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:27:17 INFO - 'config_files': ('talos/linux_config.py',), 15:27:17 INFO - 'default_actions': ('clobber', 15:27:17 INFO - 'read-buildbot-config', 15:27:17 INFO - 'download-and-extract', 15:27:17 INFO - 'populate-webroot', 15:27:17 INFO - 'create-virtualenv', 15:27:17 INFO - 'install', 15:27:17 INFO - 'run-tests'), 15:27:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:27:17 INFO - 'download_minidump_stackwalk': True, 15:27:17 INFO - 'download_symbols': 'ondemand', 15:27:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:27:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:27:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:27:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:27:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:27:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:27:17 INFO - 'installer_path': 'installer.exe', 15:27:17 INFO - 'log_level': 'info', 15:27:17 INFO - 'log_name': 'talos', 15:27:17 INFO - 'log_to_console': True, 15:27:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:27:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:27:17 INFO - 'opt_config_files': (), 15:27:17 INFO - 'pip_index': False, 15:27:17 INFO - 'sps_profile': False, 15:27:17 INFO - 'sps_profile_interval': 0, 15:27:17 INFO - 'suite': 'dromaeojs-e10s', 15:27:17 INFO - 'system_bits': '32', 15:27:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:27:17 INFO - 'title': 'talos-linux64-ix-007', 15:27:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:27:17 INFO - 'use_talos_json': True, 15:27:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:27:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:27:17 INFO - 'work_dir': 'build'} 15:27:17 INFO - ##### 15:27:17 INFO - ##### Running clobber step. 15:27:17 INFO - ##### 15:27:17 INFO - Running pre-action listener: _resource_record_pre_action 15:27:17 INFO - Running main action method: clobber 15:27:17 INFO - rmtree: /builds/slave/test/build 15:27:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:27:18 INFO - Running post-action listener: _resource_record_post_action 15:27:18 INFO - ##### 15:27:18 INFO - ##### Finished clobber step (success) 15:27:18 INFO - ##### 15:27:18 INFO - ##### 15:27:18 INFO - ##### Running read-buildbot-config step. 15:27:18 INFO - ##### 15:27:18 INFO - Running pre-action listener: _resource_record_pre_action 15:27:18 INFO - Running main action method: read_buildbot_config 15:27:18 INFO - Using buildbot properties: 15:27:18 INFO - { 15:27:18 INFO - "project": "", 15:27:18 INFO - "product": "firefox", 15:27:18 INFO - "script_repo_revision": "production", 15:27:18 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:27:18 INFO - "repository": "", 15:27:18 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:27:18 INFO - "buildid": "20160708123001", 15:27:18 INFO - "pgo_build": "True", 15:27:18 INFO - "basedir": "/builds/slave/test", 15:27:18 INFO - "buildnumber": 22, 15:27:18 INFO - "slavename": "talos-linux64-ix-007", 15:27:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:27:18 INFO - "platform": "ubuntu64_hw", 15:27:18 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:27:18 INFO - "branch": "autoland", 15:27:18 INFO - "repo_path": "integration/autoland", 15:27:18 INFO - "revision": "53b24e115c194df3cc9cbd9a99959209637a4beb", 15:27:18 INFO - "stage_platform": "linux64-pgo", 15:27:18 INFO - "builduid": "e5682ae8fb4d4a71ba053086377bf329", 15:27:18 INFO - "slavebuilddir": "test" 15:27:18 INFO - } 15:27:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:27:18 INFO - Running post-action listener: _resource_record_post_action 15:27:18 INFO - ##### 15:27:18 INFO - ##### Finished read-buildbot-config step (success) 15:27:18 INFO - ##### 15:27:18 INFO - ##### 15:27:18 INFO - ##### Running download-and-extract step. 15:27:18 INFO - ##### 15:27:18 INFO - Running pre-action listener: _resource_record_pre_action 15:27:18 INFO - Running main action method: download_and_extract 15:27:18 INFO - mkdir: /builds/slave/test/build/tests 15:27:18 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')]} 15:27:18 INFO - https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:18 INFO - Downloaded 1361 bytes. 15:27:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:27:18 INFO - Using the following test package requirements: 15:27:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:27:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:27:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:27:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'jsshell-linux-x86_64.zip'], 15:27:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:27:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:27:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:27:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:27:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:27:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:27:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:27:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:27:18 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')]} 15:27:18 INFO - https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:19 INFO - Downloaded 24302271 bytes. 15:27:19 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'] 15:27:19 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 15:27:21 INFO - Return code: 0 15:27:21 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 15:27:21 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')]} 15:27:21 INFO - https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:27:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:27:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:27:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:22 INFO - Downloaded 24302271 bytes. 15:27:22 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'] 15:27:22 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 15:27:23 INFO - Return code: 0 15:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:23 INFO - https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:27:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:27:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:27:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:24 INFO - Downloaded 14403333 bytes. 15:27:24 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'] 15:27:24 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 15:27:24 INFO - Return code: 0 15:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:24 INFO - https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:27:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TnRGNj66Td66oamM_F5vKQ/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 15:27:27 INFO - Downloaded 60435012 bytes. 15:27:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:27:27 INFO - mkdir: /builds/slave/test/properties 15:27:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:27:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:27:27 INFO - Contents: 15:27:27 INFO - build_url:https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:27:28 INFO - Running post-action listener: _resource_record_post_action 15:27:28 INFO - Running post-action listener: set_extra_try_arguments 15:27:28 INFO - ##### 15:27:28 INFO - ##### Finished download-and-extract step (success) 15:27:28 INFO - ##### 15:27:28 INFO - ##### 15:27:28 INFO - ##### Running populate-webroot step. 15:27:28 INFO - ##### 15:27:28 INFO - Running pre-action listener: _resource_record_pre_action 15:27:28 INFO - Running main action method: populate_webroot 15:27:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:27:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:27:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:27:28 INFO - '--tppagecycles', 15:27:28 INFO - '7'], 15:27:28 INFO - 'tests': ['tsvgm']}}, 15:27:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:27:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:27:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:27:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:27:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['damp', 'tps']}, 15:27:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'tests': ['damp', 'tps']}, 15:27:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['dromaeo_dom']}, 15:27:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:27:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['basic_compositor_video']}, 15:27:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:27:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['a11yr', 15:27:28 INFO - 'ts_paint', 15:27:28 INFO - 'tpaint', 15:27:28 INFO - 'sessionrestore', 15:27:28 INFO - 'sessionrestore_no_auto_restore', 15:27:28 INFO - 'tabpaint']}, 15:27:28 INFO - 'other-e10s': {'tests': ['a11yr', 15:27:28 INFO - 'ts_paint', 15:27:28 INFO - 'tpaint', 15:27:28 INFO - 'sessionrestore', 15:27:28 INFO - 'sessionrestore_no_auto_restore', 15:27:28 INFO - 'tabpaint']}, 15:27:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:27:28 INFO - 'ts_paint', 15:27:28 INFO - 'tpaint', 15:27:28 INFO - 'sessionrestore', 15:27:28 INFO - 'sessionrestore_no_auto_restore', 15:27:28 INFO - 'tabpaint']}, 15:27:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:27:28 INFO - 'ts_paint', 15:27:28 INFO - 'tpaint', 15:27:28 INFO - 'sessionrestore', 15:27:28 INFO - 'sessionrestore_no_auto_restore', 15:27:28 INFO - 'tabpaint']}, 15:27:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['a11yr', 15:27:28 INFO - 'ts_paint', 15:27:28 INFO - 'tpaint', 15:27:28 INFO - 'sessionrestore', 15:27:28 INFO - 'sessionrestore_no_auto_restore', 15:27:28 INFO - 'tabpaint']}, 15:27:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['a11yr', 15:27:28 INFO - 'ts_paint', 15:27:28 INFO - 'tpaint', 15:27:28 INFO - 'sessionrestore', 15:27:28 INFO - 'sessionrestore_no_auto_restore', 15:27:28 INFO - 'tabpaint']}, 15:27:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['tsvgx', 15:27:28 INFO - 'tsvgr_opacity', 15:27:28 INFO - 'tart', 15:27:28 INFO - 'tscrollx', 15:27:28 INFO - 'cart']}, 15:27:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:27:28 INFO - 'tsvgr_opacity', 15:27:28 INFO - 'tart', 15:27:28 INFO - 'tscrollx', 15:27:28 INFO - 'cart']}, 15:27:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'talos_options': ['--disable-e10s'], 15:27:28 INFO - 'tests': ['tp5o']}, 15:27:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'tests': ['tp5o']}, 15:27:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'talos_options': ['--disable-e10s', 15:27:28 INFO - '--xperf_path', 15:27:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:28 INFO - 'tests': ['tp5n']}, 15:27:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:28 INFO - 'talos_options': ['--xperf_path', 15:27:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:28 INFO - 'tests': ['tp5n']}}, 15:27:28 INFO - 'talos.zip': {'path': '', 15:27:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:27:28 INFO - Running post-action listener: _resource_record_post_action 15:27:28 INFO - ##### 15:27:28 INFO - ##### Finished populate-webroot step (success) 15:27:28 INFO - ##### 15:27:28 INFO - ##### 15:27:28 INFO - ##### Running create-virtualenv step. 15:27:28 INFO - ##### 15:27:28 INFO - Running pre-action listener: _resource_record_pre_action 15:27:28 INFO - Running main action method: create_virtualenv 15:27:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:27:28 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 15:27:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:27:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:27:28 INFO - Using real prefix '/usr' 15:27:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:27:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:27:30 INFO - Installing pip.................done. 15:27:30 INFO - Return code: 0 15:27:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:27:30 INFO - Using env: {'DISPLAY': ':0', 15:27:30 INFO - 'HOME': '/home/cltbld', 15:27:30 INFO - 'LANG': 'en_US.UTF-8', 15:27:30 INFO - 'LANGUAGE': 'en_US:en', 15:27:30 INFO - 'LOGNAME': 'cltbld', 15:27:30 INFO - 'MAIL': '/var/mail/cltbld', 15:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:30 INFO - 'MOZ_NO_REMOTE': '1', 15:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:30 INFO - 'NO_EM_RESTART': '1', 15:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:30 INFO - 'PWD': '/builds/slave/test', 15:27:30 INFO - 'SHELL': '/bin/bash', 15:27:30 INFO - 'SHLVL': '1', 15:27:30 INFO - 'TERM': 'linux', 15:27:30 INFO - 'TMOUT': '86400', 15:27:30 INFO - 'USER': 'cltbld', 15:27:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:30 INFO - '_': '/tools/buildbot/bin/python'} 15:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:30 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 15:27:30 INFO - Cleaning up... 15:27:30 INFO - Return code: 0 15:27:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:27:30 INFO - Using env: {'DISPLAY': ':0', 15:27:30 INFO - 'HOME': '/home/cltbld', 15:27:30 INFO - 'LANG': 'en_US.UTF-8', 15:27:30 INFO - 'LANGUAGE': 'en_US:en', 15:27:30 INFO - 'LOGNAME': 'cltbld', 15:27:30 INFO - 'MAIL': '/var/mail/cltbld', 15:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:30 INFO - 'MOZ_NO_REMOTE': '1', 15:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:30 INFO - 'NO_EM_RESTART': '1', 15:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:30 INFO - 'PWD': '/builds/slave/test', 15:27:30 INFO - 'SHELL': '/bin/bash', 15:27:30 INFO - 'SHLVL': '1', 15:27:30 INFO - 'TERM': 'linux', 15:27:30 INFO - 'TMOUT': '86400', 15:27:30 INFO - 'USER': 'cltbld', 15:27:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:30 INFO - '_': '/tools/buildbot/bin/python'} 15:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:31 INFO - Downloading/unpacking psutil>=3.1.1 15:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:27:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:33 INFO - Installing collected packages: psutil 15:27:33 INFO - Running setup.py install for psutil 15:27:33 INFO - building 'psutil._psutil_linux' extension 15:27:33 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 15:27:33 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 15:27:33 INFO - building 'psutil._psutil_posix' extension 15:27:33 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 15:27:33 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 15:27:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:33 INFO - Successfully installed psutil 15:27:33 INFO - Cleaning up... 15:27:34 INFO - Return code: 0 15:27:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:27:34 INFO - Using env: {'DISPLAY': ':0', 15:27:34 INFO - 'HOME': '/home/cltbld', 15:27:34 INFO - 'LANG': 'en_US.UTF-8', 15:27:34 INFO - 'LANGUAGE': 'en_US:en', 15:27:34 INFO - 'LOGNAME': 'cltbld', 15:27:34 INFO - 'MAIL': '/var/mail/cltbld', 15:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:34 INFO - 'MOZ_NO_REMOTE': '1', 15:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:34 INFO - 'NO_EM_RESTART': '1', 15:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:34 INFO - 'PWD': '/builds/slave/test', 15:27:34 INFO - 'SHELL': '/bin/bash', 15:27:34 INFO - 'SHLVL': '1', 15:27:34 INFO - 'TERM': 'linux', 15:27:34 INFO - 'TMOUT': '86400', 15:27:34 INFO - 'USER': 'cltbld', 15:27:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:34 INFO - '_': '/tools/buildbot/bin/python'} 15:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:27:36 INFO - Installing collected packages: mozsystemmonitor 15:27:36 INFO - Running setup.py install for mozsystemmonitor 15:27:36 INFO - Successfully installed mozsystemmonitor 15:27:36 INFO - Cleaning up... 15:27:36 INFO - Return code: 0 15:27:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:27:36 INFO - Using env: {'DISPLAY': ':0', 15:27:36 INFO - 'HOME': '/home/cltbld', 15:27:36 INFO - 'LANG': 'en_US.UTF-8', 15:27:36 INFO - 'LANGUAGE': 'en_US:en', 15:27:36 INFO - 'LOGNAME': 'cltbld', 15:27:36 INFO - 'MAIL': '/var/mail/cltbld', 15:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:36 INFO - 'MOZ_NO_REMOTE': '1', 15:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:36 INFO - 'NO_EM_RESTART': '1', 15:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:36 INFO - 'PWD': '/builds/slave/test', 15:27:36 INFO - 'SHELL': '/bin/bash', 15:27:36 INFO - 'SHLVL': '1', 15:27:36 INFO - 'TERM': 'linux', 15:27:36 INFO - 'TMOUT': '86400', 15:27:36 INFO - 'USER': 'cltbld', 15:27:36 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:36 INFO - '_': '/tools/buildbot/bin/python'} 15:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:36 INFO - Downloading/unpacking jsonschema==2.5.1 15:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:27:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:27:38 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 15:27:38 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 15:27:38 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 15:27:38 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 15:27:38 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 15:27:38 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 15:27:39 INFO - Downloading functools32-3.2.3-2.tar.gz 15:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:27:39 INFO - warning: no files found matching '*.txt' 15:27:39 INFO - no previously-included directories found matching 'build' 15:27:39 INFO - no previously-included directories found matching 'dist' 15:27:39 INFO - no previously-included directories found matching '.git*' 15:27:39 INFO - Installing collected packages: jsonschema, functools32 15:27:39 INFO - Running setup.py install for functools32 15:27:39 INFO - warning: no files found matching '*.txt' 15:27:39 INFO - no previously-included directories found matching 'build' 15:27:39 INFO - no previously-included directories found matching 'dist' 15:27:39 INFO - no previously-included directories found matching '.git*' 15:27:39 INFO - Successfully installed jsonschema functools32 15:27:39 INFO - Cleaning up... 15:27:39 INFO - Return code: 0 15:27:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:27:39 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')]} 15:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:39 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')]} 15:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:39 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 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:39 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 15:27:39 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 15:27:39 INFO - Using env: {'DISPLAY': ':0', 15:27:39 INFO - 'HOME': '/home/cltbld', 15:27:39 INFO - 'LANG': 'en_US.UTF-8', 15:27:39 INFO - 'LANGUAGE': 'en_US:en', 15:27:39 INFO - 'LOGNAME': 'cltbld', 15:27:39 INFO - 'MAIL': '/var/mail/cltbld', 15:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:39 INFO - 'MOZ_NO_REMOTE': '1', 15:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:39 INFO - 'NO_EM_RESTART': '1', 15:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:39 INFO - 'PWD': '/builds/slave/test', 15:27:39 INFO - 'SHELL': '/bin/bash', 15:27:39 INFO - 'SHLVL': '1', 15:27:39 INFO - 'TERM': 'linux', 15:27:39 INFO - 'TMOUT': '86400', 15:27:39 INFO - 'USER': 'cltbld', 15:27:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:39 INFO - '_': '/tools/buildbot/bin/python'} 15:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:27:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:27:41 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 15:27:41 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 15:27:41 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 15:27:41 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 15:27:41 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 15:27:41 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 15:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:27:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:27:41 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 15:27:41 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 15:27:41 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 15:27:41 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 15:27:41 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 15:27:41 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 15:27:42 INFO - Downloading docopt-0.6.1.tar.gz 15:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:42 INFO - Running setup.py install for blobuploader 15:27:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:42 INFO - Running setup.py install for requests 15:27:42 INFO - Running setup.py install for docopt 15:27:42 INFO - Successfully installed blobuploader requests docopt 15:27:42 INFO - Cleaning up... 15:27:42 INFO - Return code: 0 15:27:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:42 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 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:42 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 15:27:42 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 15:27:42 INFO - Using env: {'DISPLAY': ':0', 15:27:42 INFO - 'HOME': '/home/cltbld', 15:27:42 INFO - 'LANG': 'en_US.UTF-8', 15:27:42 INFO - 'LANGUAGE': 'en_US:en', 15:27:42 INFO - 'LOGNAME': 'cltbld', 15:27:42 INFO - 'MAIL': '/var/mail/cltbld', 15:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:42 INFO - 'MOZ_NO_REMOTE': '1', 15:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:42 INFO - 'NO_EM_RESTART': '1', 15:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:42 INFO - 'PWD': '/builds/slave/test', 15:27:42 INFO - 'SHELL': '/bin/bash', 15:27:42 INFO - 'SHLVL': '1', 15:27:42 INFO - 'TERM': 'linux', 15:27:42 INFO - 'TMOUT': '86400', 15:27:42 INFO - 'USER': 'cltbld', 15:27:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:42 INFO - '_': '/tools/buildbot/bin/python'} 15:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:43 INFO - Running setup.py (path:/tmp/pip-NCKG9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:43 INFO - Running setup.py (path:/tmp/pip-ZgX1Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:43 INFO - Running setup.py (path:/tmp/pip-VDEDac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:43 INFO - Running setup.py (path:/tmp/pip-VtYs_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:43 INFO - Running setup.py (path:/tmp/pip-8Z1ivB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:43 INFO - Running setup.py (path:/tmp/pip-s1arpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:43 INFO - Running setup.py (path:/tmp/pip-ncLg9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:43 INFO - Running setup.py (path:/tmp/pip-luzQ0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:43 INFO - Running setup.py (path:/tmp/pip-wHHOnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:43 INFO - Running setup.py (path:/tmp/pip-UM_mG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:43 INFO - Running setup.py (path:/tmp/pip-bkSOru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:43 INFO - Running setup.py (path:/tmp/pip-7mCjYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:43 INFO - Running setup.py (path:/tmp/pip-ar6Rcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:43 INFO - Running setup.py (path:/tmp/pip-BtZ0lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:44 INFO - Running setup.py (path:/tmp/pip-5Gi0E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:44 INFO - Running setup.py (path:/tmp/pip-DZV9SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:44 INFO - Running setup.py (path:/tmp/pip-_vDGTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:44 INFO - Running setup.py install for manifestparser 15:27:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:44 INFO - Running setup.py install for mozcrash 15:27:44 INFO - Running setup.py install for mozdebug 15:27:44 INFO - Running setup.py install for mozdevice 15:27:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:44 INFO - Running setup.py install for mozfile 15:27:44 INFO - Running setup.py install for mozhttpd 15:27:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:44 INFO - Running setup.py install for mozinfo 15:27:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:44 INFO - Running setup.py install for mozInstall 15:27:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Running setup.py install for mozleak 15:27:45 INFO - Running setup.py install for mozlog 15:27:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Running setup.py install for moznetwork 15:27:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Running setup.py install for mozprocess 15:27:45 INFO - Running setup.py install for mozprofile 15:27:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Running setup.py install for mozrunner 15:27:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:45 INFO - Running setup.py install for mozscreenshot 15:27:45 INFO - Running setup.py install for moztest 15:27:45 INFO - Running setup.py install for mozversion 15:27:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:46 INFO - Cleaning up... 15:27:46 INFO - Return code: 0 15:27:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:46 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 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:46 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 15:27:46 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 15:27:46 INFO - Using env: {'DISPLAY': ':0', 15:27:46 INFO - 'HOME': '/home/cltbld', 15:27:46 INFO - 'LANG': 'en_US.UTF-8', 15:27:46 INFO - 'LANGUAGE': 'en_US:en', 15:27:46 INFO - 'LOGNAME': 'cltbld', 15:27:46 INFO - 'MAIL': '/var/mail/cltbld', 15:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:46 INFO - 'MOZ_NO_REMOTE': '1', 15:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:46 INFO - 'NO_EM_RESTART': '1', 15:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:46 INFO - 'PWD': '/builds/slave/test', 15:27:46 INFO - 'SHELL': '/bin/bash', 15:27:46 INFO - 'SHLVL': '1', 15:27:46 INFO - 'TERM': 'linux', 15:27:46 INFO - 'TMOUT': '86400', 15:27:46 INFO - 'USER': 'cltbld', 15:27:46 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:46 INFO - '_': '/tools/buildbot/bin/python'} 15:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:46 INFO - Running setup.py (path:/tmp/pip-G_CWct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:46 INFO - Running setup.py (path:/tmp/pip-8PBUEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:46 INFO - Running setup.py (path:/tmp/pip-R1rmhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:46 INFO - Running setup.py (path:/tmp/pip-c3pPiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:46 INFO - Running setup.py (path:/tmp/pip-_E9zVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:46 INFO - Running setup.py (path:/tmp/pip-dyikiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:46 INFO - Running setup.py (path:/tmp/pip-k28N_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:46 INFO - Running setup.py (path:/tmp/pip-NkEXMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:46 INFO - Running setup.py (path:/tmp/pip-889IKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:46 INFO - Running setup.py (path:/tmp/pip-9oeW8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:46 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)) 15:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:46 INFO - Running setup.py (path:/tmp/pip-jBJP4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:47 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)) 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:47 INFO - Running setup.py (path:/tmp/pip-mSNNnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:47 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)) 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:47 INFO - Running setup.py (path:/tmp/pip-YtBaeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:47 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)) 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:47 INFO - Running setup.py (path:/tmp/pip-Dq7mLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:47 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)) 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:47 INFO - Running setup.py (path:/tmp/pip-5uFl5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:47 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)) 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:47 INFO - Running setup.py (path:/tmp/pip-aiOCMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:47 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)) 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:47 INFO - Running setup.py (path:/tmp/pip-yg1JGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:47 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)) 15:27:47 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)) 15:27:47 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)) 15:27:47 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)) 15:27:47 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)) 15:27:47 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)) 15:27:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:47 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 15:27:47 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 15:27:47 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 15:27:47 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 15:27:47 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 15:27:47 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 15:27:49 INFO - Downloading blessings-1.6.tar.gz 15:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:49 INFO - Installing collected packages: blessings 15:27:49 INFO - Running setup.py install for blessings 15:27:49 INFO - Successfully installed blessings 15:27:49 INFO - Cleaning up... 15:27:49 INFO - Return code: 0 15:27:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:49 INFO - Reading from file tmpfile_stdout 15:27:49 INFO - Current package versions: 15:27:49 INFO - argparse == 1.2.1 15:27:49 INFO - blessings == 1.6 15:27:49 INFO - blobuploader == 1.2.4 15:27:49 INFO - docopt == 0.6.1 15:27:49 INFO - functools32 == 3.2.3-2 15:27:49 INFO - jsonschema == 2.5.1 15:27:49 INFO - manifestparser == 1.1 15:27:49 INFO - mozInstall == 1.12 15:27:49 INFO - mozcrash == 0.17 15:27:49 INFO - mozdebug == 0.1 15:27:49 INFO - mozdevice == 0.48 15:27:49 INFO - mozfile == 1.2 15:27:49 INFO - mozhttpd == 0.7 15:27:49 INFO - mozinfo == 0.9 15:27:49 INFO - mozleak == 0.1 15:27:49 INFO - mozlog == 3.2 15:27:49 INFO - moznetwork == 0.27 15:27:49 INFO - mozprocess == 0.23 15:27:49 INFO - mozprofile == 0.28 15:27:49 INFO - mozrunner == 6.12 15:27:49 INFO - mozscreenshot == 0.1 15:27:49 INFO - mozsystemmonitor == 0.3 15:27:49 INFO - moztest == 0.7 15:27:49 INFO - mozversion == 1.4 15:27:49 INFO - psutil == 3.1.1 15:27:49 INFO - requests == 1.2.3 15:27:49 INFO - wsgiref == 0.1.2 15:27:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:49 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 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:49 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 15:27:49 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 15:27:49 INFO - Using env: {'DISPLAY': ':0', 15:27:49 INFO - 'HOME': '/home/cltbld', 15:27:49 INFO - 'LANG': 'en_US.UTF-8', 15:27:49 INFO - 'LANGUAGE': 'en_US:en', 15:27:49 INFO - 'LOGNAME': 'cltbld', 15:27:49 INFO - 'MAIL': '/var/mail/cltbld', 15:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:49 INFO - 'MOZ_NO_REMOTE': '1', 15:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:49 INFO - 'NO_EM_RESTART': '1', 15:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:49 INFO - 'PWD': '/builds/slave/test', 15:27:49 INFO - 'SHELL': '/bin/bash', 15:27:49 INFO - 'SHLVL': '1', 15:27:49 INFO - 'TERM': 'linux', 15:27:49 INFO - 'TMOUT': '86400', 15:27:49 INFO - 'USER': 'cltbld', 15:27:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:49 INFO - '_': '/tools/buildbot/bin/python'} 15:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 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)) 15:27:50 INFO - Cleaning up... 15:27:50 INFO - Return code: 0 15:27:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27:50 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')]} 15:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:50 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')]} 15:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:50 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 0x1765030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a26180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, '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': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', '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 15:27:50 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 15:27:50 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 15:27:50 INFO - Using env: {'DISPLAY': ':0', 15:27:50 INFO - 'HOME': '/home/cltbld', 15:27:50 INFO - 'LANG': 'en_US.UTF-8', 15:27:50 INFO - 'LANGUAGE': 'en_US:en', 15:27:50 INFO - 'LOGNAME': 'cltbld', 15:27:50 INFO - 'MAIL': '/var/mail/cltbld', 15:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:50 INFO - 'MOZ_NO_REMOTE': '1', 15:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:50 INFO - 'NO_EM_RESTART': '1', 15:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:50 INFO - 'PWD': '/builds/slave/test', 15:27:50 INFO - 'SHELL': '/bin/bash', 15:27:50 INFO - 'SHLVL': '1', 15:27:50 INFO - 'TERM': 'linux', 15:27:50 INFO - 'TMOUT': '86400', 15:27:50 INFO - 'USER': 'cltbld', 15:27:50 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:50 INFO - '_': '/tools/buildbot/bin/python'} 15:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:27:50 INFO - Cleaning up... 15:27:50 INFO - Return code: 0 15:27:50 INFO - Running post-action listener: _resource_record_post_action 15:27:50 INFO - Running post-action listener: _start_resource_monitoring 15:27:50 INFO - Starting resource monitoring. 15:27:50 INFO - ##### 15:27:50 INFO - ##### Finished create-virtualenv step (success) 15:27:50 INFO - ##### 15:27:50 INFO - ##### 15:27:50 INFO - ##### Running install step. 15:27:50 INFO - ##### 15:27:50 INFO - Running pre-action listener: _resource_record_pre_action 15:27:50 INFO - Running main action method: install 15:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:50 INFO - Reading from file tmpfile_stdout 15:27:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:50 INFO - Reading from file tmpfile_stdout 15:27:50 INFO - Output received: 15:27:50 INFO - Usage: mozinstall [options] installer 15:27:50 INFO - Options: 15:27:50 INFO - -h, --help show this help message and exit 15:27:50 INFO - -d DEST, --destination=DEST 15:27:50 INFO - Directory to install application into. [default: 15:27:50 INFO - "/builds/slave/test"] 15:27:50 INFO - --app=APP Application being installed. [default: firefox] 15:27:50 INFO - mkdir: /builds/slave/test/build/application 15:27:50 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'] 15:27:50 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 15:28:07 INFO - Reading from file tmpfile_stdout 15:28:07 INFO - Output received: 15:28:07 INFO - /builds/slave/test/build/application/firefox/firefox 15:28:07 INFO - Running post-action listener: _resource_record_post_action 15:28:07 INFO - ##### 15:28:07 INFO - ##### Finished install step (success) 15:28:07 INFO - ##### 15:28:07 INFO - ##### 15:28:07 INFO - ##### Running run-tests step. 15:28:07 INFO - ##### 15:28:07 INFO - Running pre-action listener: _resource_record_pre_action 15:28:07 INFO - Running main action method: run_tests 15:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:28:07 INFO - Python 2.7.3 15:28:07 INFO - Return code: 0 15:28:07 INFO - grabbing minidump binary from tooltool 15:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:07 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 0x1a243b0>, '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 0x1a252b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a25740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:28:07 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 15:28:07 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 15:28:07 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 15:28:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:28:07 INFO - Return code: 0 15:28:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:28:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:28:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:28:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:28:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 15:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 15:28:07 INFO - Using env: {'DISPLAY': ':0', 15:28:07 INFO - 'HOME': '/home/cltbld', 15:28:07 INFO - 'LANG': 'en_US.UTF-8', 15:28:07 INFO - 'LANGUAGE': 'en_US:en', 15:28:07 INFO - 'LOGNAME': 'cltbld', 15:28:07 INFO - 'MAIL': '/var/mail/cltbld', 15:28:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:28:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:07 INFO - 'MOZ_NO_REMOTE': '1', 15:28:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:07 INFO - 'NO_EM_RESTART': '1', 15:28:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:07 INFO - 'PWD': '/builds/slave/test', 15:28:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:28:07 INFO - 'SHELL': '/bin/bash', 15:28:07 INFO - 'SHLVL': '1', 15:28:07 INFO - 'TERM': 'linux', 15:28:07 INFO - 'TMOUT': '86400', 15:28:07 INFO - 'USER': 'cltbld', 15:28:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468016835.462334-721472653', 15:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:07 INFO - '_': '/tools/buildbot/bin/python'} 15:28:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 15:28:07 INFO - mozversion application_buildid: 20160708123001 15:28:07 INFO - mozversion application_changeset: 53b24e115c194df3cc9cbd9a99959209637a4beb 15:28:07 INFO - mozversion application_display_name: Nightly 15:28:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:28:07 INFO - mozversion application_name: Firefox 15:28:07 INFO - mozversion application_remotingname: firefox 15:28:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:28:07 INFO - mozversion application_vendor: Mozilla 15:28:07 INFO - mozversion application_version: 50.0a1 15:28:07 INFO - mozversion platform_buildid: 20160708123001 15:28:07 INFO - mozversion platform_changeset: 53b24e115c194df3cc9cbd9a99959209637a4beb 15:28:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:28:07 INFO - mozversion platform_version: 50.0a1 15:28:07 INFO - using testdate: 1468016887 15:28:07 INFO - actual date: 1468016887 15:28:07 INFO - starting webserver on 'localhost:54458' 15:28:07 INFO - SUITE-START | Running 2 tests 15:28:07 INFO - TEST-START | dromaeo_css 15:28:07 INFO - operating with platform_type : linux_ 15:28:07 INFO - Initialising browser for dromaeo_css test... 15:28:07 INFO - TEST-INFO | started process 8461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtek2e/profile http://localhost:54458/getInfo.html) 15:28:12 INFO - PROCESS | 8461 | __metrics Screen width/height:1600/1200 15:28:12 INFO - PROCESS | 8461 | colorDepth:24 15:28:12 INFO - PROCESS | 8461 | Browser inner width/height: 1024/697 15:28:12 INFO - PROCESS | 8461 | __metrics 15:28:12 ERROR - PROCESS | 8461 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 15:28:13 INFO - TEST-INFO | 8461: exit 0 15:28:13 INFO - Browser initialized. 15:28:13 INFO - Running cycle 1/1 for dromaeo_css test... 15:28:13 INFO - TEST-INFO | started process 8585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAtek2e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:25 INFO - PROCESS | 8585 | RSS: Main: 167682048 15:28:25 INFO - PROCESS | 8585 | 15:29:14 INFO - PROCESS | 8585 | 1468016954949 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] 15:31:23 INFO - PROCESS | 8585 | Cycle 1(1): loaded http://localhost:54458/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54458/tests/dromaeo/cssquery-ext.html) 15:31:24 INFO - PROCESS | 8585 | RSS: Main: 171601920 15:31:24 INFO - PROCESS | 8585 | 15:34:26 INFO - PROCESS | 8585 | Cycle 1(1): loaded http://localhost:54458/tests/dromaeo/cssquery-ext.html (next: http://localhost:54458/tests/dromaeo/cssquery-jquery.html) 15:34:27 INFO - PROCESS | 8585 | RSS: Main: 168312832 15:34:27 INFO - PROCESS | 8585 | 15:37:29 INFO - PROCESS | 8585 | Cycle 1(1): loaded http://localhost:54458/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54458/tests/dromaeo/cssquery-mootools.html) 15:37:29 INFO - PROCESS | 8585 | RSS: Main: 171528192 15:37:29 INFO - PROCESS | 8585 | 15:40:31 INFO - PROCESS | 8585 | Cycle 1(1): loaded http://localhost:54458/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54458/tests/dromaeo/cssquery-prototype.html) 15:40:32 INFO - PROCESS | 8585 | RSS: Main: 167170048 15:40:32 INFO - PROCESS | 8585 | 15:43:35 INFO - PROCESS | 8585 | Cycle 1(1): loaded http://localhost:54458/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54458/tests/dromaeo/cssquery-yui.html) 15:43:35 INFO - PROCESS | 8585 | RSS: Main: 168996864 15:43:35 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | Cycle 1(1): loaded http://localhost:54458/tests/dromaeo/cssquery-yui.html (next: http://localhost:54458/tests/dromaeo/cssquery-dojo.html) 15:46:38 INFO - PROCESS | 8585 | RSS: Main: 170016768 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | __start_tp_report 15:46:38 INFO - PROCESS | 8585 | _x_x_mozilla_page_load 15:46:38 INFO - PROCESS | 8585 | _x_x_mozilla_page_load_details 15:46:38 INFO - PROCESS | 8585 | |i|pagename|runs| 15:46:38 INFO - PROCESS | 8585 | |0;dojo.html;3079.6612372639006;3082.152408087775;3104.3325684977726;3123.141136187548;3132.8590213440407;5566.526845218162;5572.136318870576;5603.775848966036;5621.606487545873;5639.8590035249135;5400.894485670736;5483.424240454755;5535.114381698929;5546.278983732109;5559.305086864142;5007.49925007499;5022.59819214462;5079.3650793650795;5134.537891589756;5162.870928226786;5001.399832020163;5164.070467315882;5212.973935130319;5234.979179060085;5236;4988.925166122511;5040.1935690289565;5068.771905264272;5084.9745751271;5104.948950510485;5097.898042039175;5118.616103792193;5123.795048198068;5129;5179.559737422286;4869.683470574401;5068.290439338495;5090.134677104864;5091.821786237464;5097.49025097491;5418.729063546846;5454.427285135083;5483.698396588186;5561.721913904329;5574.749136288836;5919.615225010403;5929.911051334234;5930.406959304079;5932.050871860525;5961.821145365646;5816.447437493432;5910.408959104098;5949.464548190684;5961.940380596182;5982.461578457916;5518.448155184449;5520.06158952979;5535.972320138454;5552.361478430033;5631.380548139701;6116.143739876421;6116.29662588808;6119.632822030692;6120.571559990847;6121.47967422774;5626.071698169838;5731.168980497888;5733.971330143323;5871.794487192928;5872.853178670567;5896;5899.7050147492455;5900.675462849585;5906.3207731110615;5947.732352044169;5785.218995435646;5786.479216870502;5802.593818432753;5843.912341314884;5853.619514731528;5732.570057245724;5774.133879917962;5818.970905145447;5884.941150588525;5896.616719913192;4405.449318835145;4410.80151393188;4463.12968971054;4481.260592002348;4487.775611219491;3938.7439816411843;3947.8420863165725;3955.090329224237;3977.3636218204947;3983.7410568312966;5589.496945274864;5629.4652008059165;5636.2954630671165;5659.292588426447;5750.30996280449;5900;5951.137085122633;5972.940270597325;5974.880502390015;5989.670568118795;5690.886182276414;5704.22992895962;5725.914111288334;5739.454751798572;5759.452851979139;4981.850544483599;5139.794408223629;5143.948560514347;5170.663906846043;5200.427952925175;6099.09793686549;6117.553376797837;6136.20229370179;6185.969070154621;6278.6860656966965;6053.515718742402;6059.21230240066;6077.5745697802495;6078.26686987141;6133.294671112879;5896.587238893408;6022.427869352405;6107.236595425572;6165.568410211242;6187.907181392193;5658.122990936411;5750.453706898005;5791.160281759206;5792.681402522733;5836.095405212199;5878.970605146947;5886.117082437669;5889.322727886348;5893.764249430146;5913.970430147821;5572.804951826666;5718.542516598745;5746.798862039808;5754.9424505754405;5805;5765.682887441231;5771.567132465166;5784.2191304175085;5812.418758124154;5816.389279125631;5704.11586204139;5727.627704199213;5740.712964351849;5742.138679198154;5770.567207459541;5639.746211420578;5667.518260947865;5705.971470142623;5729.9713501432225;5758.62568933018;5649.915251271316;5671.291088613923;5672.602917795714;5682.971585142048;5687.374388817309 15:46:38 INFO - PROCESS | 8585 | |1;ext.html;555.6607345702388;578.46203031181;593.285091464785;603.8188543436968;630.6688988281155;38744.61255387449;42845;42866.57133428665;42884.78557607208;42896.78551607246;41946.79026604863;42348;42353.576464235346;42361.788191059;42441.787791061004;8707.521086340248;8838.469691818511;8857.822843543125;8863.423877447978;8863.734087977371;8779.912200877974;8833.11668833118;8833.20501154896;8840.248578870804;8846.5134417607;8894.288456923463;8912.287017038654;8918.687845925393;8923.286137109015;8938.240249578794;8727.301815854747;8754.343424243207;8777.912220877804;8807.899012623422;8820.823583528325;8837.29301655866;8851.867221991675;8872.201501864864;8913.955430222808;8918.464892106495;40623.18753624911;40629.79685101585;40642.390364144565;40812.795936020426;41273.38089928654;3610.855565777366;3615.7830530168276;3708.8887333380044;3749.5875453700346;3825.61743825618;32000.839995800106;32665.673343266502;32723.50914736281;32799.50800737991;32908.6709132908;3714.9814250928844;3907.550631677365;3968.8015599219925;4029.395590661424;4049.2104039712267;376131;376630;376975;377609;379501;55312.72343638336;55526.72236638791;55778.16332755012;55783.442165578635;55822.44177558173;34995.475067874;35939.640603594155;35968.28063438716;64439.355606443336;64678.67660661667;16772.916135419244;16960.321587136623;16960.74558881618;16975.74536381955;17016.404425845038;12875.420606072748;12916.289604071866;12933.353332333534;12963.481460741654;12977.805332920014;19607.607847842963;19674.901625492068;19752.802471975385;19801.207951681772;19856.60286794256;7197.928020719831;7253.56478611285;7296.270372962767;7392.74125405619;7406.296401841816;940.722486866376;951.1249650321721;1024.5696807340935;1038.8597539332093;1045.1951996962296;32201.03396898097;32594.185145371557;33058;33112.834435827666;33306.83346583252;1071.5820829876354;1107.64001699448;1126.2735535579668;1183.508843829801;1208.7522057978094;17217.91391043062;17526.211320490354;17555.38556150554;17573.384931527336;17584.38454654081;582867;590797;592336;593038;594239;58732.70633646804;59750;60029.69985150133;60105.39894601086;60190.69904650449;1351.9256440895845;1368.0833841326335;1386.9930650346885;1388.7986241994854;1394.3376895974332;30726.701026290004;32721;32880.83559582283;32890.83554582212;33342.333153337284;51789.7410512945;51846.703832402985;51888.221676674126;51971.74014129905;52015.479845201065;436401;444552;447038;447592;447794;28344.14967550977;28653.856730716212;28696;28701.425971480872;28715.856420717762;48409.27386089282;48955;49025.5097449021;49842.25236621526;49882.75058624684;41942.37086443767;42517.362239567046;43005.35491967561;43701.34447983346;44215.778921106474;41189.382159268236;41425.79287103545;41862.372064419666;42164.78917605392;43044.78477607592;29754.851225743732;40655.59344406518;41164.58835411607;41508.377374340016;41857.162856742085;34352.656473434945;37199.25601488009;37294;37468.62531374651;38309.6169038306;28189;28476.572851407658;28648;28717.569236461888;28814.423711526073 15:46:38 INFO - PROCESS | 8585 | |2;jquery.html;380.29437970701406;380.7163663071012;385.4776777466533;395.29834543684956;406.12885360900884;17725.82274177258;19381.903090484528;19942.202311907542;19986.800131998694;20006.399808005764;17124.31502739892;17407.564810879736;18135.183916723745;18216.544586385346;18494.630107397843;5560.471755183271;5720.971395143039;5760.74076666551;5779.682117483537;5817.592768506206;5368.946310536903;5654.830355089333;5665.206871038058;5745.396733342981;5747.626404283729;5651.389354034101;5696.316442026962;5716.228309178249;5731.885362292752;5755.856103597423;5828.271466066742;5889.057750759858;5920.40795920411;5958.046712525975;5962.314333851619;5643.322801263875;5683.687397193153;5718.513926316268;5727.599068065237;5763.193152958589;17065.488035358958;22244.88877555618;22749.43126421836;22867.885660571756;23478;2154.709114269585;2276.977230227693;2442.364985103868;2582.5609646360163;2977.8064425812254;10395.116415104725;10487.895121048768;10673.946630266877;10680.25238233324;10984;1848.9167987440596;1851.2224865556498;1853.8516918646476;1887.1036257777582;1941.8737782044122;80498.59750701267;85029.14970850274;86577.56711216403;86638;87436;10742.194335424874;10885.510152043176;11234.10127189823;11301.886981130083;11427.885721142848;15645.452409165624;15726.370945162065;15731;15754;15817.288222030036;8120.918790812135;8232.62953167109;8247.546384948766;8392.118827523022;8392.580370981548;7906.090799558125;7937.245961633751;8061.758147255592;8077.071136819223;8123.065847427503;3909.9413508797393;4148.771817550003;4785.856424307276;4858.17411040124;4890.095332363524;1980.1089509720684;1990.333238365135;1996.2913165825923;2027.878327300337;2038.9388318350473;948.4546385828177;981.5681100315838;986.363795351994;1025.5333823110466;1087.483445363462;19478.123484443233;19705.211791528465;19764.50588735293;20006.69989950152;20421.89789051075;996.4270544436978;1024.3188279794003;1048.2400259811727;1055.7466208110152;1060.6552870317178;10515.26393152472;10915.727106822234;11036.11711063113;11160.386178760245;11219.214654974074;485399;503592;508015;511665;519795;94447.05552944382;94471.52764236135;95221;95393.5230323844;95672;975.2393133355852;992.6674564021134;997.8902320744712;997.9700608981742;1005.1406047829001;17494.212760426068;17752.289908404036;17996.460106196835;18116.637667246843;18350.174242159403;42310.5768942319;42396;42707.786461067495;43111.35332969945;43956.34065489084;53187;53479.73260133674;57004.42995570157;64788.35211647823;65510;8928.10718928102;8947.194752472049;9032.187103160748;9105.726828195166;9170.495622740813;13300.334983250992;14118.152910825384;14294.070885392417;14501.78247326312;14602.707945840812;12736.490540378652;12803.48786048585;12839.743205135657;13021.283829389475;13117.819396254383;11378.772424551627;12122.33327166979;12428.130030898112;12510.562130325396;12958.67603309887;11632.651020469399;12730.299833509245;12782.296973666165;12825.935870320962;12989.740205195654;8925.821483570422;9060.411073280216;9096.805176673211;9287.582058807235;9412.529373531434;9377.718668439958;12104.75790484203;12230.32733199647;12271.631851044483;12304.630861074182 15:46:38 INFO - PROCESS | 8585 | |3;mootools.html;1496.6408062065104;1531.2649928034546;1662.1273831238598;1802.6124383257597;1802.9278828846848;7966.362690984722;8684.088170742076;8765.737027889158;9240.491772952484;9261.536923153832;8763.56182190891;8991.280697544196;9027.954860225705;9089;9092.77268068297;2295.942601434969;2321.3152120124605;2330.720313562375;2334.043042352636;2339.1812865497027;2281.851679640826;2295.494991101955;2330.265966220635;2344.19125401737;2347.6595893595418;2280;2286.599845027122;2290;2323.488832456857;2333.8949747261413;2268.977310226893;2273.8521996070285;2274.4882401459704;2278.6354183330586;2280.2361208995007;2258.898349574273;2264.8980795864227;2268.6597010448563;2290.083966413448;2298.2071185440996;9106.908930910673;9110.772230694285;9179.036201198845;9183;9183.403078799856;5274.393444753826;5403.621746477748;5409;5422.783088676449;5467.863303417406;3327.168207948013;3334.6331903490595;3439.4840773883866;3451.706604938583;3469.5489586353865;1074.570820808323;1094.9288296260718;1098.0337303173158;1110.5285496716883;1113.4265853085667;12678.746425071538;12693.492260309577;12814.16707913992;12855.16441431304;12862.163959342613;4578.633709303248;4675.251959686434;4829.855104346875;4885.340479035356;4891.902161956741;10685.626003089854;10695.144388448905;10717.732056698645;10744.462776861283;10767.730806729895;5346.091164502044;5359.008583412081;5365.839024829262;5382.058139825514;5384.246205531229;4360.454943132108;4622.86131416058;4755.809767609257;4783.354247176656;4940.308356830046;3947.4078888167005;3961.6632586230494;3999.060220848098;4153.273177193979;4208.137331847025;1211.5032836536977;1213.538855235005;1217.5738491527895;1228.2875931959443;1280.0975312404732;838.9790255243668;944.7118628818276;950.1875896108866;951.5183485781906;953.2469349214182;5653.9151912721345;5674.858128546819;5818.592698511064;5824.737886795105;6041.969790151021;468.7867020505662;470.6587723900145;481.8169095743665;491.0179640718563;491.05471966464415;4068.4100805383055;4136.751794892316;4185.121124563815;4187.413762073312;4224.640905523003;10697.679069627924;11385.544578216945;11440;11458.541658333574;11524.827127593093;11312.321260724382;11312.377819219857;11394.886051139383;11401.144914131473;11414.315141091562;7876.212378762078;8215.876761848696;8435.873461898076;8529.65881364751;8547.444416113058;6065.363136870565;6274;6313.337099604475;6332.873342533216;6365.490760739222;10315.432651203955;10596.47017649099;10612.787744245226;10713.625023124154;10733.302335348177;10549.702930750596;10757.784844303227;10779.19156063314;10790.406527641055;10945.671629851116;7405.592692401754;7878.448508604342;8109.107998120084;8134.145914678874;8280.420370574002;8578.485290882318;8617.48295102296;8622.655093796178;8656.177663121993;8700.434471759316;7605.277498637842;7732.729354472566;7803.8829417557645;7843.764687059397;8038.397120216124;7624.656890440055;7814.33578145864;7830.412719046209;7923.445358824827;7936.682532698627;6978.441724661913;7078.256783037707;7162.856742865218;7202.423806095395;7208.387287080657;5063.772130254221;5096.643234973664;5151.330327057459;5171.172612382001;5233.345831771028;5145.048166089286;5159.96800639866;5290.266607498099;5318.175682769177;5329.866753331198 15:46:38 INFO - PROCESS | 8585 | |4;prototype.html;323.6601568353229;326.4857848888;335.54366062155464;337.18737841801254;345.34384669128667;5404.54077399103;5510;5538.889222215554;5614.578906582007;5683.8579035524135;5563.972180139093;5593.78357444469;5647.181158731992;5653.378128405872;5678.34699009614;4370.650347972162;4402.141582391435;4403.6256918161835;4403.889902752425;4410.823567057314;4156.6051225133715;4401.383806267125;4404.229259879524;4404.757738324391;4410.55894410558;4303.8063287152;4324.935125973113;4362.236608593499;4372.3878656988045;4389.100234451929;4229.0273237155625;4373.978130109361;4390.814480090374;4407.294832826765;4409.581089796464;3766.114962983697;3773.52830896138;3782.6406491383273;3784.791836448994;3785.337565925952;5519.172124181365;5551;5562.888742225133;5580.414056524047;5581.6930068846195;4833.371661683958;4947.158982972904;4971.801127954877;4998.875028124289;5010.298558201855;5799;5840.3355043812735;5855.268091488564;5871.530277577784;5899.46904778572;4190.392393103013;4201.894952626179;4207.1165055338415;4208.621224089816;4215.59951804578;5965.970170149121;6056.788012419588;6138.938610613882;6175.475084617813;6190.347694860055;4256.510501292391;4267.295896177158;4267.658587313008;4300.935485967713;4339.240632889295;4332;4356.0198955235455;4365.825366985348;4366.279563871989;4366.585174408426;4726.19654658702;5014;5026.673266237683;5029.1953287473825;5059.873503162376;5727.828165155052;5850.444207800252;5876.41235876409;5892.29123554173;5920.200772895604;1488.9627759306104;1504.1952555383036;1512.2967819963549;1513.160196091158;1516.3707061569326;895.0199531512983;931.8788557487484;935.1350001248818;939.0890835889177;951.3388195204404;4986.401631804134;4989.725565093882;4998.925016124761;5028.64799464034;5064.518870707277;5307.6284660073425;5414.8917021659345;5421;5502.119660854244;5519.724013799294;5039.748012599355;5128.230765385148;5138.640295179376;5353.4646535346155;5801;3166.477531207371;3226.04831574686;3233.547303377529;3240.9675903241136;3246.5454836322933;6115.816525504242;6240.438360547481;6249;6265.96867015662;6277.372262773777;6119.173911521976;6151.2618485781095;6152.846178845564;6154.846128846814;6169.907451388232;6171.197744293213;6192.133101365813;6260.812175634738;6263.311035785969;6263.31103578606;5877.73550190251;6103.877922441615;6130.938690613037;6135.785247516315;6170.938290617216;6000.279966404059;6042.486388656837;6059.54570902989;6069.027566041143;6080.48315893154;5933.317668468181;6330.40453414098;6334.303226645157;6339.270983836917;6359.236891573041;4321.373400856921;4335.352566025016;4362.1395065368015;4373.890652733707;4410.272305069628;5932.16949627044;5993.730282137227;6234.875302494015;6238.407351301619;6249.9062514063235;5878.853028674146;5948.613340132878;5954.880902381841;5955.493783028491;5978.461938425563;5894.764209431746;5898.616589921641;5920.023196172583;5930.614510056833;6003.3996600339615;5691.743871525874;5847.415258474289;5914.881702365842;5915.8168366326045;5947.197128387612;5870.324912635102;5952.970235148797;6013.496625843539;6051.394860513913;6055.666938318434;5669.659820410789;5799.217105690678;5817.2146760188525;5818.272715910512;5831 15:46:38 INFO - PROCESS | 8585 | |5;yui.html;738.8448425830576;768.3852917665866;782.9217078292176;830.6926437218231;850.3834719828124;15156.848431515682;16228.918855405707;16283.51149465515;16354.345826166955;16363.75454368184;15354.616134596641;15582.610434739108;15589.922050389732;15619.297131629075;15661.060336379825;651.8663673946829;788.6056971514242;794.9284564389189;821.8150916043872;825.2696363718093;797.8165022044933;799.1289494451047;806.681360862459;807.5477732469835;808.022293025437;856.5631527920743;861.6897916749965;862.7196161247588;863.5639002303827;864.0365991918997;852.3309202276183;858.2147335188296;859.0636206534845;859.1966511311912;860.4751101827849;624.5191202773839;627.3068259573151;628.2586547873508;628.9968550157266;630.9116723658691;15428.614284642974;15445.922770386189;15566.377344906303;15580.766288505682;15582.922085389613;15383.923080384526;15411.691766164615;15793.368265269375;15944;16225.2698628562;12267.815982760176;12300.876991230152;12362.75274494514;12412.503499859995;12760.234385936874;3875.7093218008763;3881.7282790204695;3921.9215615687813;3926.096997690547;3960.6237407446247;71767.28232717658;72008.27991720068;72255;72630.63684681595;76135.61932190359;11571.132165087653;11574.421278936019;11755.823662645067;11759.941200294115;11826.290422574673;22401.66397504039;22421.32736017922;22505.54988900213;22556.887215563816;22579.09683612637;8629.611667474854;8849.247813935888;8946.060663630355;8986.775330616656;9170.587323570455;4832.830850920272;4946.233333833262;4979.950200498021;4995.375578052744;5097.209932460474;3657.5428071491065;3762.8494860205287;3782.8865134046023;3806.314863324573;3818.045488627843;627.1308762411984;631.6620607974711;638.5179189711738;644.4747530762413;659.0049025970818;630.4735545819201;641.4547634510722;663.797541749771;683.3747121383878;704.6758491094154;9320.30097742672;10058.698239052841;10101.747456313651;10112.898871011343;10215.693529194135;572.364675210516;630.9779157729457;665.195113912162;677.5155763629028;681.5127184063418;4513.909721805546;4639.930401043987;4661.510541393172;4723.929141062887;4749;70194;110549;117888.41055794666;118115;124674;60037.69981150154;62504;89084;104143.4792826031;104601;59581.10628340578;79447;80666.19333806704;90814;91059.08940910638;9195.632174712937;9467.242620590474;9568.76078098053;9813.852792208265;9915.603375865174;43647.56352436562;43651.781741091094;48678;55001.1749823761;55658.72170639121;76153;76540;76980.6150969264;79769.20230797617;81427.59286203531;12963.546275880299;13110.868891311346;13408.865911340761;13632;13712.3829427678;13278.80081798793;14983.325750341042;15081.321340539922;15108.471203507825;15321.846781532042;13443.46226150943;13462.29160366647;13480.662983425493;13582.524611638546;13849.79225311601;13412.195268283935;13585.932070339584;13711.45154193861;13919.23444210578;14170.362333694802;13716.0398772089;14246.035478936077;14396.640083997983;14446.061006034573;14612.853871461575;11280.2667826591;11651.941740291244;11908.940455297668;11945.641630751092;12252.75494490123;11667.533298667959;11677.591284305008;12034.217775844541;12122;12194.817077743663 15:46:38 INFO - PROCESS | 8585 | __end_tp_report 15:46:38 INFO - PROCESS | 8585 | __start_cc_report 15:46:38 INFO - PROCESS | 8585 | _x_x_mozilla_cycle_collect,348 15:46:38 INFO - PROCESS | 8585 | __end_cc_report 15:46:38 INFO - PROCESS | 8585 | __startTimestamp1468017998623__endTimestamp 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | ------- Summary: start ------- 15:46:38 INFO - PROCESS | 8585 | Number of tests: 6 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | [#0] dojo.html Cycles:165 Average:5500.11 Median:5705.97 stddev:637.92 (11.2%) stddev-sans-first:610.96 15:46:38 INFO - PROCESS | 8585 | Values: 3079.7 3082.2 3104.3 3123.1 3132.9 5566.5 5572.1 5603.8 5621.6 5639.9 5400.9 5483.4 5535.1 5546.3 5559.3 5007.5 5022.6 5079.4 5134.5 5162.9 5001.4 5164.1 5213.0 5235.0 5236.0 4988.9 5040.2 5068.8 5085.0 5104.9 5097.9 5118.6 5123.8 5129.0 5179.6 4869.7 5068.3 5090.1 5091.8 5097.5 5418.7 5454.4 5483.7 5561.7 5574.7 5919.6 5929.9 5930.4 5932.1 5961.8 5816.4 5910.4 5949.5 5961.9 5982.5 5518.4 5520.1 5536.0 5552.4 5631.4 6116.1 6116.3 6119.6 6120.6 6121.5 5626.1 5731.2 5734.0 5871.8 5872.9 5896.0 5899.7 5900.7 5906.3 5947.7 5785.2 5786.5 5802.6 5843.9 5853.6 5732.6 5774.1 5819.0 5884.9 5896.6 4405.4 4410.8 4463.1 4481.3 4487.8 3938.7 3947.8 3955.1 3977.4 3983.7 5589.5 5629.5 5636.3 5659.3 5750.3 5900.0 5951.1 5972.9 5974.9 5989.7 5690.9 5704.2 5725.9 5739.5 5759.5 4981.9 5139.8 5143.9 5170.7 5200.4 6099.1 6117.6 6136.2 6186.0 6278.7 6053.5 6059.2 6077.6 6078.3 6133.3 5896.6 6022.4 6107.2 6165.6 6187.9 5658.1 5750.5 5791.2 5792.7 5836.1 5879.0 5886.1 5889.3 5893.8 5914.0 5572.8 5718.5 5746.8 5754.9 5805.0 5765.7 5771.6 5784.2 5812.4 5816.4 5704.1 5727.6 5740.7 5742.1 5770.6 5639.7 5667.5 5706.0 5730.0 5758.6 5649.9 5671.3 5672.6 5683.0 5687.4 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | [#1] ext.html Cycles:180 Average:62446.05 Median:41349.59 stddev:127403.91 (308.1%) stddev-sans-first:127676.57 15:46:38 INFO - PROCESS | 8585 | Values: 555.7 578.5 593.3 603.8 630.7 38744.6 42845.0 42866.6 42884.8 42896.8 41946.8 42348.0 42353.6 42361.8 42441.8 8707.5 8838.5 8857.8 8863.4 8863.7 8779.9 8833.1 8833.2 8840.2 8846.5 8894.3 8912.3 8918.7 8923.3 8938.2 8727.3 8754.3 8777.9 8807.9 8820.8 8837.3 8851.9 8872.2 8914.0 8918.5 40623.2 40629.8 40642.4 40812.8 41273.4 3610.9 3615.8 3708.9 3749.6 3825.6 32000.8 32665.7 32723.5 32799.5 32908.7 3715.0 3907.6 3968.8 4029.4 4049.2 376131.0 376630.0 376975.0 377609.0 379501.0 55312.7 55526.7 55778.2 55783.4 55822.4 34995.5 35939.6 35968.3 64439.4 64678.7 16772.9 16960.3 16960.7 16975.7 17016.4 12875.4 12916.3 12933.4 12963.5 12977.8 19607.6 19674.9 19752.8 19801.2 19856.6 7197.9 7253.6 7296.3 7392.7 7406.3 940.7 951.1 1024.6 1038.9 1045.2 32201.0 32594.2 33058.0 33112.8 33306.8 1071.6 1107.6 1126.3 1183.5 1208.8 17217.9 17526.2 17555.4 17573.4 17584.4 582867.0 590797.0 592336.0 593038.0 594239.0 58732.7 59750.0 60029.7 60105.4 60190.7 1351.9 1368.1 1387.0 1388.8 1394.3 30726.7 32721.0 32880.8 32890.8 33342.3 51789.7 51846.7 51888.2 51971.7 52015.5 436401.0 444552.0 447038.0 447592.0 447794.0 28344.1 28653.9 28696.0 28701.4 28715.9 48409.3 48955.0 49025.5 49842.3 49882.8 41942.4 42517.4 43005.4 43701.3 44215.8 41189.4 41425.8 41862.4 42164.8 43044.8 29754.9 40655.6 41164.6 41508.4 41857.2 34352.7 37199.3 37294.0 37468.6 38309.6 28189.0 28476.6 28648.0 28717.6 28814.4 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | [#2] jquery.html Cycles:180 Average:29833.52 Median:1679.05 stddev:83441.34 (4969.6%) stddev-sans-first:83646.11 15:46:38 INFO - PROCESS | 8585 | Values: 380.3 380.7 385.5 395.3 406.1 17725.8 19381.9 19942.2 19986.8 20006.4 17124.3 17407.6 18135.2 18216.5 18494.6 5560.5 5721.0 5760.7 5779.7 5817.6 5368.9 5654.8 5665.2 5745.4 5747.6 5651.4 5696.3 5716.2 5731.9 5755.9 5828.3 5889.1 5920.4 5958.0 5962.3 5643.3 5683.7 5718.5 5727.6 5763.2 17065.5 22244.9 22749.4 22867.9 23478.0 2154.7 2277.0 2442.4 2582.6 2977.8 10395.1 10487.9 10673.9 10680.3 10984.0 1848.9 1851.2 1853.9 1887.1 1941.9 80498.6 85029.1 86577.6 86638.0 87436.0 10742.2 10885.5 11234.1 11301.9 11427.9 15645.5 15726.4 15731.0 15754.0 15817.3 8120.9 8232.6 8247.5 8392.1 8392.6 7906.1 7937.2 8061.8 8077.1 8123.1 3909.9 4148.8 4785.9 4858.2 4890.1 1980.1 1990.3 1996.3 2027.9 2038.9 948.5 981.6 986.4 1025.5 1087.5 19478.1 19705.2 19764.5 20006.7 20421.9 996.4 1024.3 1048.2 1055.7 1060.7 10515.3 10915.7 11036.1 11160.4 11219.2 485399.0 503592.0 508015.0 511665.0 519795.0 94447.1 94471.5 95221.0 95393.5 95672.0 975.2 992.7 997.9 998.0 1005.1 17494.2 17752.3 17996.5 18116.6 18350.2 42310.6 42396.0 42707.8 43111.4 43956.3 53187.0 53479.7 57004.4 64788.4 65510.0 8928.1 8947.2 9032.2 9105.7 9170.5 13300.3 14118.2 14294.1 14501.8 14602.7 12736.5 12803.5 12839.7 13021.3 13117.8 11378.8 12122.3 12428.1 12510.6 12958.7 11632.7 12730.3 12782.3 12825.9 12989.7 8925.8 9060.4 9096.8 9287.6 9412.5 9377.7 12104.8 12230.3 12271.6 12304.6 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | [#3] mootools.html Cycles:180 Average:5926.10 Median:2613.23 stddev:3464.80 (132.6%) stddev-sans-first:3458.54 15:46:38 INFO - PROCESS | 8585 | Values: 1496.6 1531.3 1662.1 1802.6 1802.9 7966.4 8684.1 8765.7 9240.5 9261.5 8763.6 8991.3 9028.0 9089.0 9092.8 2295.9 2321.3 2330.7 2334.0 2339.2 2281.9 2295.5 2330.3 2344.2 2347.7 2280.0 2286.6 2290.0 2323.5 2333.9 2269.0 2273.9 2274.5 2278.6 2280.2 2258.9 2264.9 2268.7 2290.1 2298.2 9106.9 9110.8 9179.0 9183.0 9183.4 5274.4 5403.6 5409.0 5422.8 5467.9 3327.2 3334.6 3439.5 3451.7 3469.5 1074.6 1094.9 1098.0 1110.5 1113.4 12678.7 12693.5 12814.2 12855.2 12862.2 4578.6 4675.3 4829.9 4885.3 4891.9 10685.6 10695.1 10717.7 10744.5 10767.7 5346.1 5359.0 5365.8 5382.1 5384.2 4360.5 4622.9 4755.8 4783.4 4940.3 3947.4 3961.7 3999.1 4153.3 4208.1 1211.5 1213.5 1217.6 1228.3 1280.1 839.0 944.7 950.2 951.5 953.2 5653.9 5674.9 5818.6 5824.7 6042.0 468.8 470.7 481.8 491.0 491.1 4068.4 4136.8 4185.1 4187.4 4224.6 10697.7 11385.5 11440.0 11458.5 11524.8 11312.3 11312.4 11394.9 11401.1 11414.3 7876.2 8215.9 8435.9 8529.7 8547.4 6065.4 6274.0 6313.3 6332.9 6365.5 10315.4 10596.5 10612.8 10713.6 10733.3 10549.7 10757.8 10779.2 10790.4 10945.7 7405.6 7878.4 8109.1 8134.1 8280.4 8578.5 8617.5 8622.7 8656.2 8700.4 7605.3 7732.7 7803.9 7843.8 8038.4 7624.7 7814.3 7830.4 7923.4 7936.7 6978.4 7078.3 7162.9 7202.4 7208.4 5063.8 5096.6 5151.3 5171.2 5233.3 5145.0 5160.0 5290.3 5318.2 5329.9 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | [#4] prototype.html Cycles:180 Average:4925.10 Median:5572.19 stddev:1460.17 (26.2%) stddev-sans-first:1422.84 15:46:38 INFO - PROCESS | 8585 | Values: 323.7 326.5 335.5 337.2 345.3 5404.5 5510.0 5538.9 5614.6 5683.9 5564.0 5593.8 5647.2 5653.4 5678.3 4370.7 4402.1 4403.6 4403.9 4410.8 4156.6 4401.4 4404.2 4404.8 4410.6 4303.8 4324.9 4362.2 4372.4 4389.1 4229.0 4374.0 4390.8 4407.3 4409.6 3766.1 3773.5 3782.6 3784.8 3785.3 5519.2 5551.0 5562.9 5580.4 5581.7 4833.4 4947.2 4971.8 4998.9 5010.3 5799.0 5840.3 5855.3 5871.5 5899.5 4190.4 4201.9 4207.1 4208.6 4215.6 5966.0 6056.8 6138.9 6175.5 6190.3 4256.5 4267.3 4267.7 4300.9 4339.2 4332.0 4356.0 4365.8 4366.3 4366.6 4726.2 5014.0 5026.7 5029.2 5059.9 5727.8 5850.4 5876.4 5892.3 5920.2 1489.0 1504.2 1512.3 1513.2 1516.4 895.0 931.9 935.1 939.1 951.3 4986.4 4989.7 4998.9 5028.6 5064.5 5307.6 5414.9 5421.0 5502.1 5519.7 5039.7 5128.2 5138.6 5353.5 5801.0 3166.5 3226.0 3233.5 3241.0 3246.5 6115.8 6240.4 6249.0 6266.0 6277.4 6119.2 6151.3 6152.8 6154.8 6169.9 6171.2 6192.1 6260.8 6263.3 6263.3 5877.7 6103.9 6130.9 6135.8 6170.9 6000.3 6042.5 6059.5 6069.0 6080.5 5933.3 6330.4 6334.3 6339.3 6359.2 4321.4 4335.4 4362.1 4373.9 4410.3 5932.2 5993.7 6234.9 6238.4 6249.9 5878.9 5948.6 5954.9 5955.5 5978.5 5894.8 5898.6 5920.0 5930.6 6003.4 5691.7 5847.4 5914.9 5915.8 5947.2 5870.3 5953.0 6013.5 6051.4 6055.7 5669.7 5799.2 5817.2 5818.3 5831.0 15:46:38 INFO - PROCESS | 8585 | 15:46:38 INFO - PROCESS | 8585 | [#5] yui.html Cycles:180 Average:20238.32 Median:43649.67 stddev:28308.31 (64.9%) stddev-sans-first:28349.85 15:46:38 INFO - PROCESS | 8585 | Values: 738.8 768.4 782.9 830.7 850.4 15156.8 16228.9 16283.5 16354.3 16363.8 15354.6 15582.6 15589.9 15619.3 15661.1 651.9 788.6 794.9 821.8 825.3 797.8 799.1 806.7 807.5 808.0 856.6 861.7 862.7 863.6 864.0 852.3 858.2 859.1 859.2 860.5 624.5 627.3 628.3 629.0 630.9 15428.6 15445.9 15566.4 15580.8 15582.9 15383.9 15411.7 15793.4 15944.0 16225.3 12267.8 12300.9 12362.8 12412.5 12760.2 3875.7 3881.7 3921.9 3926.1 3960.6 71767.3 72008.3 72255.0 72630.6 76135.6 11571.1 11574.4 11755.8 11759.9 11826.3 22401.7 22421.3 22505.5 22556.9 22579.1 8629.6 8849.2 8946.1 8986.8 9170.6 4832.8 4946.2 4980.0 4995.4 5097.2 3657.5 3762.8 3782.9 3806.3 3818.0 627.1 631.7 638.5 644.5 659.0 630.5 641.5 663.8 683.4 704.7 9320.3 10058.7 10101.7 10112.9 10215.7 572.4 631.0 665.2 677.5 681.5 4513.9 4639.9 4661.5 4723.9 4749.0 70194.0 110549.0 117888.4 118115.0 124674.0 60037.7 62504.0 89084.0 104143.5 104601.0 59581.1 79447.0 80666.2 90814.0 91059.1 9195.6 9467.2 9568.8 9813.9 9915.6 43647.6 43651.8 48678.0 55001.2 55658.7 76153.0 76540.0 76980.6 79769.2 81427.6 12963.5 13110.9 13408.9 13632.0 13712.4 13278.8 14983.3 15081.3 15108.5 15321.8 13443.5 13462.3 13480.7 13582.5 13849.8 13412.2 13585.9 13711.5 13919.2 14170.4 13716.0 14246.0 14396.6 14446.1 14612.9 11280.3 11651.9 11908.9 11945.6 12252.8 11667.5 11677.6 12034.2 12122.0 12194.8 15:46:38 INFO - PROCESS | 8585 | -------- Summary: end -------- 15:46:38 INFO - PROCESS | 8585 | 15:46:39 INFO - TEST-INFO | 8585: exit 0 15:46:39 INFO - TEST-OK | dromaeo_css | took 1111422ms 15:46:39 INFO - TEST-START | kraken 15:46:39 INFO - operating with platform_type : linux_ 15:46:39 INFO - Initialising browser for kraken test... 15:46:39 INFO - TEST-INFO | started process 8833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIjoORY/profile http://localhost:54458/getInfo.html) 15:46:43 INFO - PROCESS | 8833 | __metrics Screen width/height:1600/1200 15:46:43 INFO - PROCESS | 8833 | colorDepth:24 15:46:43 INFO - PROCESS | 8833 | Browser inner width/height: 1024/697 15:46:43 INFO - PROCESS | 8833 | __metrics 15:46:43 ERROR - PROCESS | 8833 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 15:46:44 INFO - TEST-INFO | 8833: exit 0 15:46:44 INFO - Browser initialized. 15:46:44 INFO - Running cycle 1/1 for kraken test... 15:46:44 INFO - TEST-INFO | started process 8954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIjoORY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:56 INFO - PROCESS | 8954 | RSS: Main: 167690240 15:46:56 INFO - PROCESS | 8954 | 15:46:59 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54458/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:59 INFO - PROCESS | 8954 | RSS: Main: 173686784 15:46:59 INFO - PROCESS | 8954 | 15:47:02 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54458/tests/kraken/driver.html?testName=audio-dft) 15:47:03 INFO - PROCESS | 8954 | RSS: Main: 172367872 15:47:03 INFO - PROCESS | 8954 | 15:47:06 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54458/tests/kraken/driver.html?testName=audio-fft) 15:47:06 INFO - PROCESS | 8954 | RSS: Main: 166752256 15:47:06 INFO - PROCESS | 8954 | 15:47:08 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54458/tests/kraken/driver.html?testName=audio-oscillator) 15:47:09 INFO - PROCESS | 8954 | RSS: Main: 167768064 15:47:09 INFO - PROCESS | 8954 | 15:47:11 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54458/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:47:12 INFO - PROCESS | 8954 | RSS: Main: 168296448 15:47:12 INFO - PROCESS | 8954 | 15:47:15 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54458/tests/kraken/driver.html?testName=imaging-darkroom) 15:47:15 INFO - PROCESS | 8954 | RSS: Main: 168038400 15:47:15 INFO - PROCESS | 8954 | 15:47:19 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54458/tests/kraken/driver.html?testName=imaging-desaturate) 15:47:20 INFO - PROCESS | 8954 | RSS: Main: 165875712 15:47:20 INFO - PROCESS | 8954 | 15:47:22 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54458/tests/kraken/driver.html?testName=json-parse-financial) 15:47:23 INFO - PROCESS | 8954 | RSS: Main: 167677952 15:47:23 INFO - PROCESS | 8954 | 15:47:25 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54458/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:25 INFO - PROCESS | 8954 | RSS: Main: 167911424 15:47:25 INFO - PROCESS | 8954 | 15:47:27 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:28 INFO - PROCESS | 8954 | RSS: Main: 168345600 15:47:28 INFO - PROCESS | 8954 | 15:47:30 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:30 INFO - PROCESS | 8954 | RSS: Main: 168685568 15:47:30 INFO - PROCESS | 8954 | 15:47:33 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:34 INFO - PROCESS | 8954 | RSS: Main: 168943616 15:47:34 INFO - PROCESS | 8954 | 15:47:36 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:37 INFO - PROCESS | 8954 | RSS: Main: 168644608 15:47:37 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | Cycle 1(1): loaded http://localhost:54458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54458/tests/kraken/driver.html?testName=ai-astar) 15:47:39 INFO - PROCESS | 8954 | RSS: Main: 169197568 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | __start_tp_report 15:47:39 INFO - PROCESS | 8954 | _x_x_mozilla_page_load 15:47:39 INFO - PROCESS | 8954 | _x_x_mozilla_page_load_details 15:47:39 INFO - PROCESS | 8954 | |i|pagename|runs| 15:47:39 INFO - PROCESS | 8954 | |0;ai-astar;101;110;103;111;110;111;113;109;110;111 15:47:39 INFO - PROCESS | 8954 | |1;audio-beat-detection;152;125;146;180;118;159;150;122;183;122 15:47:39 INFO - PROCESS | 8954 | |2;audio-dft;164;163;161;162;160;166;169;168;162;162 15:47:39 INFO - PROCESS | 8954 | |3;audio-fft;75;76;75;149;81;76;78;75;159;78 15:47:39 INFO - PROCESS | 8954 | |4;audio-oscillator;85;85;156;86;86;86;138;84;84;149 15:47:39 INFO - PROCESS | 8954 | |5;imaging-gaussian-blur;118;119;118;118;117;117;117;117;117;117 15:47:39 INFO - PROCESS | 8954 | |6;imaging-darkroom;147;148;147;147;149;146;147;148;147;148 15:47:39 INFO - PROCESS | 8954 | |7;imaging-desaturate;95;98;97;97;95;95;96;96;96;95 15:47:39 INFO - PROCESS | 8954 | |8;json-parse-financial;56;59;58;58;60;57;57;56;58;58 15:47:39 INFO - PROCESS | 8954 | |9;json-stringify-tinderbox;61;61;62;62;62;61;61;62;63;62 15:47:39 INFO - PROCESS | 8954 | |10;stanford-crypto-aes;77;81;76;75;82;76;77;77;82;76 15:47:39 INFO - PROCESS | 8954 | |11;stanford-crypto-ccm;131;121;121;127;121;120;120;125;155;134 15:47:39 INFO - PROCESS | 8954 | |12;stanford-crypto-pbkdf2;162;159;166;161;161;158;156;167;156;157 15:47:39 INFO - PROCESS | 8954 | |13;stanford-crypto-sha256-iterative;68;68;65;64;65;63;65;64;62;62 15:47:39 INFO - PROCESS | 8954 | __end_tp_report 15:47:39 INFO - PROCESS | 8954 | __start_cc_report 15:47:39 INFO - PROCESS | 8954 | _x_x_mozilla_cycle_collect,933 15:47:39 INFO - PROCESS | 8954 | __end_cc_report 15:47:39 INFO - PROCESS | 8954 | __startTimestamp1468018059322__endTimestamp 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | ------- Summary: start ------- 15:47:39 INFO - PROCESS | 8954 | Number of tests: 14 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.81 (3.5%) stddev-sans-first:2.77 15:47:39 INFO - PROCESS | 8954 | Values: 101.0 110.0 103.0 111.0 110.0 111.0 113.0 109.0 110.0 111.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.00 stddev:23.86 (15.8%) stddev-sans-first:25.19 15:47:39 INFO - PROCESS | 8954 | Values: 152.0 125.0 146.0 180.0 118.0 159.0 150.0 122.0 183.0 122.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:3.02 (1.8%) stddev-sans-first:3.20 15:47:39 INFO - PROCESS | 8954 | Values: 164.0 163.0 161.0 162.0 160.0 166.0 169.0 168.0 162.0 162.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:32.71 (43.0%) stddev-sans-first:34.10 15:47:39 INFO - PROCESS | 8954 | Values: 75.0 76.0 75.0 149.0 81.0 76.0 78.0 75.0 159.0 78.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.00 stddev:30.51 (35.9%) stddev-sans-first:31.59 15:47:39 INFO - PROCESS | 8954 | Values: 85.0 85.0 156.0 86.0 86.0 86.0 138.0 84.0 84.0 149.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 15:47:39 INFO - PROCESS | 8954 | Values: 118.0 119.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 15:47:39 INFO - PROCESS | 8954 | Values: 147.0 148.0 147.0 147.0 149.0 146.0 147.0 148.0 147.0 148.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.05 (1.1%) stddev-sans-first:1.05 15:47:39 INFO - PROCESS | 8954 | Values: 95.0 98.0 97.0 97.0 95.0 95.0 96.0 96.0 96.0 95.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:1.25 (2.2%) stddev-sans-first:1.17 15:47:39 INFO - PROCESS | 8954 | Values: 56.0 59.0 58.0 58.0 60.0 57.0 57.0 56.0 58.0 58.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 15:47:39 INFO - PROCESS | 8954 | Values: 61.0 61.0 62.0 62.0 62.0 61.0 61.0 62.0 63.0 62.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.00 stddev:2.69 (3.5%) stddev-sans-first:2.83 15:47:39 INFO - PROCESS | 8954 | Values: 77.0 81.0 76.0 75.0 82.0 76.0 77.0 77.0 82.0 76.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:126.00 stddev:10.83 (8.6%) stddev-sans-first:11.42 15:47:39 INFO - PROCESS | 8954 | Values: 131.0 121.0 121.0 127.0 121.0 120.0 120.0 125.0 155.0 134.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.00 stddev:3.89 (2.4%) stddev-sans-first:4.08 15:47:39 INFO - PROCESS | 8954 | Values: 162.0 159.0 166.0 161.0 161.0 158.0 156.0 167.0 156.0 157.0 15:47:39 INFO - PROCESS | 8954 | 15:47:39 INFO - PROCESS | 8954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:2.12 (3.3%) stddev-sans-first:1.86 15:47:39 INFO - PROCESS | 8954 | Values: 68.0 68.0 65.0 64.0 65.0 63.0 65.0 64.0 62.0 62.0 15:47:39 INFO - PROCESS | 8954 | -------- Summary: end -------- 15:47:39 INFO - PROCESS | 8954 | 15:47:40 INFO - TEST-INFO | 8954: exit 0 15:47:40 INFO - TEST-OK | kraken | took 60907ms 15:47:40 INFO - SUITE-END | took 1172s 15:47:40 INFO - Completed test suite (00:19:32) 15:47:40 INFO - javascript benchmark 15:47:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7382.69682269115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.6612372639006, 3082.152408087775, 3104.3325684977726, 3123.141136187548, 3132.8590213440407, 5566.526845218162, 5572.136318870576, 5603.775848966036, 5621.606487545873, 5639.8590035249135, 5400.894485670736, 5483.424240454755, 5535.114381698929, 5546.278983732109, 5559.305086864142, 5007.49925007499, 5022.59819214462, 5079.3650793650795, 5134.537891589756, 5162.870928226786, 5001.399832020163, 5164.070467315882, 5212.973935130319, 5234.979179060085, 5236.0, 4988.925166122511, 5040.1935690289565, 5068.771905264272, 5084.9745751271, 5104.948950510485, 5097.898042039175, 5118.616103792193, 5123.795048198068, 5129.0, 5179.559737422286, 4869.683470574401, 5068.290439338495, 5090.134677104864, 5091.821786237464, 5097.49025097491, 5418.729063546846, 5454.427285135083, 5483.698396588186, 5561.721913904329, 5574.749136288836, 5919.615225010403, 5929.911051334234, 5930.406959304079, 5932.050871860525, 5961.821145365646, 5816.447437493432, 5910.408959104098, 5949.464548190684, 5961.940380596182, 5982.461578457916, 5518.448155184449, 5520.06158952979, 5535.972320138454, 5552.361478430033, 5631.380548139701, 6116.143739876421, 6116.29662588808, 6119.632822030692, 6120.571559990847, 6121.47967422774, 5626.071698169838, 5731.168980497888, 5733.971330143323, 5871.794487192928, 5872.853178670567, 5896.0, 5899.7050147492455, 5900.675462849585, 5906.3207731110615, 5947.732352044169, 5785.218995435646, 5786.479216870502, 5802.593818432753, 5843.912341314884, 5853.619514731528, 5732.570057245724, 5774.133879917962, 5818.970905145447, 5884.941150588525, 5896.616719913192, 4405.449318835145, 4410.80151393188, 4463.12968971054, 4481.260592002348, 4487.775611219491, 3938.7439816411843, 3947.8420863165725, 3955.090329224237, 3977.3636218204947, 3983.7410568312966, 5589.496945274864, 5629.4652008059165, 5636.2954630671165, 5659.292588426447, 5750.30996280449, 5900.0, 5951.137085122633, 5972.940270597325, 5974.880502390015, 5989.670568118795, 5690.886182276414, 5704.22992895962, 5725.914111288334, 5739.454751798572, 5759.452851979139, 4981.850544483599, 5139.794408223629, 5143.948560514347, 5170.663906846043, 5200.427952925175, 6099.09793686549, 6117.553376797837, 6136.20229370179, 6185.969070154621, 6278.6860656966965, 6053.515718742402, 6059.21230240066, 6077.5745697802495, 6078.26686987141, 6133.294671112879, 5896.587238893408, 6022.427869352405, 6107.236595425572, 6165.568410211242, 6187.907181392193, 5658.122990936411, 5750.453706898005, 5791.160281759206, 5792.681402522733, 5836.095405212199, 5878.970605146947, 5886.117082437669, 5889.322727886348, 5893.764249430146, 5913.970430147821, 5572.804951826666, 5718.542516598745, 5746.798862039808, 5754.9424505754405, 5805.0, 5765.682887441231, 5771.567132465166, 5784.2191304175085, 5812.418758124154, 5816.389279125631, 5704.11586204139, 5727.627704199213, 5740.712964351849, 5742.138679198154, 5770.567207459541, 5639.746211420578, 5667.518260947865, 5705.971470142623, 5729.9713501432225, 5758.62568933018, 5649.915251271316, 5671.291088613923, 5672.602917795714, 5682.971585142048, 5687.374388817309], "value": 5455.181726268988, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6607345702388, 578.46203031181, 593.285091464785, 603.8188543436968, 630.6688988281155, 38744.61255387449, 42845.0, 42866.57133428665, 42884.78557607208, 42896.78551607246, 41946.79026604863, 42348.0, 42353.576464235346, 42361.788191059, 42441.787791061004, 8707.521086340248, 8838.469691818511, 8857.822843543125, 8863.423877447978, 8863.734087977371, 8779.912200877974, 8833.11668833118, 8833.20501154896, 8840.248578870804, 8846.5134417607, 8894.288456923463, 8912.287017038654, 8918.687845925393, 8923.286137109015, 8938.240249578794, 8727.301815854747, 8754.343424243207, 8777.912220877804, 8807.899012623422, 8820.823583528325, 8837.29301655866, 8851.867221991675, 8872.201501864864, 8913.955430222808, 8918.464892106495, 40623.18753624911, 40629.79685101585, 40642.390364144565, 40812.795936020426, 41273.38089928654, 3610.855565777366, 3615.7830530168276, 3708.8887333380044, 3749.5875453700346, 3825.61743825618, 32000.839995800106, 32665.673343266502, 32723.50914736281, 32799.50800737991, 32908.6709132908, 3714.9814250928844, 3907.550631677365, 3968.8015599219925, 4029.395590661424, 4049.2104039712267, 376131.0, 376630.0, 376975.0, 377609.0, 379501.0, 55312.72343638336, 55526.72236638791, 55778.16332755012, 55783.442165578635, 55822.44177558173, 34995.475067874, 35939.640603594155, 35968.28063438716, 64439.355606443336, 64678.67660661667, 16772.916135419244, 16960.321587136623, 16960.74558881618, 16975.74536381955, 17016.404425845038, 12875.420606072748, 12916.289604071866, 12933.353332333534, 12963.481460741654, 12977.805332920014, 19607.607847842963, 19674.901625492068, 19752.802471975385, 19801.207951681772, 19856.60286794256, 7197.928020719831, 7253.56478611285, 7296.270372962767, 7392.74125405619, 7406.296401841816, 940.722486866376, 951.1249650321721, 1024.5696807340935, 1038.8597539332093, 1045.1951996962296, 32201.03396898097, 32594.185145371557, 33058.0, 33112.834435827666, 33306.83346583252, 1071.5820829876354, 1107.64001699448, 1126.2735535579668, 1183.508843829801, 1208.7522057978094, 17217.91391043062, 17526.211320490354, 17555.38556150554, 17573.384931527336, 17584.38454654081, 582867.0, 590797.0, 592336.0, 593038.0, 594239.0, 58732.70633646804, 59750.0, 60029.69985150133, 60105.39894601086, 60190.69904650449, 1351.9256440895845, 1368.0833841326335, 1386.9930650346885, 1388.7986241994854, 1394.3376895974332, 30726.701026290004, 32721.0, 32880.83559582283, 32890.83554582212, 33342.333153337284, 51789.7410512945, 51846.703832402985, 51888.221676674126, 51971.74014129905, 52015.479845201065, 436401.0, 444552.0, 447038.0, 447592.0, 447794.0, 28344.14967550977, 28653.856730716212, 28696.0, 28701.425971480872, 28715.856420717762, 48409.27386089282, 48955.0, 49025.5097449021, 49842.25236621526, 49882.75058624684, 41942.37086443767, 42517.362239567046, 43005.35491967561, 43701.34447983346, 44215.778921106474, 41189.382159268236, 41425.79287103545, 41862.372064419666, 42164.78917605392, 43044.78477607592, 29754.851225743732, 40655.59344406518, 41164.58835411607, 41508.377374340016, 41857.162856742085, 34352.656473434945, 37199.25601488009, 37294.0, 37468.62531374651, 38309.6169038306, 28189.0, 28476.572851407658, 28648.0, 28717.569236461888, 28814.423711526073], "value": 20131.68684983621, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.29437970701406, 380.7163663071012, 385.4776777466533, 395.29834543684956, 406.12885360900884, 17725.82274177258, 19381.903090484528, 19942.202311907542, 19986.800131998694, 20006.399808005764, 17124.31502739892, 17407.564810879736, 18135.183916723745, 18216.544586385346, 18494.630107397843, 5560.471755183271, 5720.971395143039, 5760.74076666551, 5779.682117483537, 5817.592768506206, 5368.946310536903, 5654.830355089333, 5665.206871038058, 5745.396733342981, 5747.626404283729, 5651.389354034101, 5696.316442026962, 5716.228309178249, 5731.885362292752, 5755.856103597423, 5828.271466066742, 5889.057750759858, 5920.40795920411, 5958.046712525975, 5962.314333851619, 5643.322801263875, 5683.687397193153, 5718.513926316268, 5727.599068065237, 5763.193152958589, 17065.488035358958, 22244.88877555618, 22749.43126421836, 22867.885660571756, 23478.0, 2154.709114269585, 2276.977230227693, 2442.364985103868, 2582.5609646360163, 2977.8064425812254, 10395.116415104725, 10487.895121048768, 10673.946630266877, 10680.25238233324, 10984.0, 1848.9167987440596, 1851.2224865556498, 1853.8516918646476, 1887.1036257777582, 1941.8737782044122, 80498.59750701267, 85029.14970850274, 86577.56711216403, 86638.0, 87436.0, 10742.194335424874, 10885.510152043176, 11234.10127189823, 11301.886981130083, 11427.885721142848, 15645.452409165624, 15726.370945162065, 15731.0, 15754.0, 15817.288222030036, 8120.918790812135, 8232.62953167109, 8247.546384948766, 8392.118827523022, 8392.580370981548, 7906.090799558125, 7937.245961633751, 8061.758147255592, 8077.071136819223, 8123.065847427503, 3909.9413508797393, 4148.771817550003, 4785.856424307276, 4858.17411040124, 4890.095332363524, 1980.1089509720684, 1990.333238365135, 1996.2913165825923, 2027.878327300337, 2038.9388318350473, 948.4546385828177, 981.5681100315838, 986.363795351994, 1025.5333823110466, 1087.483445363462, 19478.123484443233, 19705.211791528465, 19764.50588735293, 20006.69989950152, 20421.89789051075, 996.4270544436978, 1024.3188279794003, 1048.2400259811727, 1055.7466208110152, 1060.6552870317178, 10515.26393152472, 10915.727106822234, 11036.11711063113, 11160.386178760245, 11219.214654974074, 485399.0, 503592.0, 508015.0, 511665.0, 519795.0, 94447.05552944382, 94471.52764236135, 95221.0, 95393.5230323844, 95672.0, 975.2393133355852, 992.6674564021134, 997.8902320744712, 997.9700608981742, 1005.1406047829001, 17494.212760426068, 17752.289908404036, 17996.460106196835, 18116.637667246843, 18350.174242159403, 42310.5768942319, 42396.0, 42707.786461067495, 43111.35332969945, 43956.34065489084, 53187.0, 53479.73260133674, 57004.42995570157, 64788.35211647823, 65510.0, 8928.10718928102, 8947.194752472049, 9032.187103160748, 9105.726828195166, 9170.495622740813, 13300.334983250992, 14118.152910825384, 14294.070885392417, 14501.78247326312, 14602.707945840812, 12736.490540378652, 12803.48786048585, 12839.743205135657, 13021.283829389475, 13117.819396254383, 11378.772424551627, 12122.33327166979, 12428.130030898112, 12510.562130325396, 12958.67603309887, 11632.651020469399, 12730.299833509245, 12782.296973666165, 12825.935870320962, 12989.740205195654, 8925.821483570422, 9060.411073280216, 9096.805176673211, 9287.582058807235, 9412.529373531434, 9377.718668439958, 12104.75790484203, 12230.32733199647, 12271.631851044483, 12304.630861074182], "value": 9404.202146613767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.6408062065104, 1531.2649928034546, 1662.1273831238598, 1802.6124383257597, 1802.9278828846848, 7966.362690984722, 8684.088170742076, 8765.737027889158, 9240.491772952484, 9261.536923153832, 8763.56182190891, 8991.280697544196, 9027.954860225705, 9089.0, 9092.77268068297, 2295.942601434969, 2321.3152120124605, 2330.720313562375, 2334.043042352636, 2339.1812865497027, 2281.851679640826, 2295.494991101955, 2330.265966220635, 2344.19125401737, 2347.6595893595418, 2280.0, 2286.599845027122, 2290.0, 2323.488832456857, 2333.8949747261413, 2268.977310226893, 2273.8521996070285, 2274.4882401459704, 2278.6354183330586, 2280.2361208995007, 2258.898349574273, 2264.8980795864227, 2268.6597010448563, 2290.083966413448, 2298.2071185440996, 9106.908930910673, 9110.772230694285, 9179.036201198845, 9183.0, 9183.403078799856, 5274.393444753826, 5403.621746477748, 5409.0, 5422.783088676449, 5467.863303417406, 3327.168207948013, 3334.6331903490595, 3439.4840773883866, 3451.706604938583, 3469.5489586353865, 1074.570820808323, 1094.9288296260718, 1098.0337303173158, 1110.5285496716883, 1113.4265853085667, 12678.746425071538, 12693.492260309577, 12814.16707913992, 12855.16441431304, 12862.163959342613, 4578.633709303248, 4675.251959686434, 4829.855104346875, 4885.340479035356, 4891.902161956741, 10685.626003089854, 10695.144388448905, 10717.732056698645, 10744.462776861283, 10767.730806729895, 5346.091164502044, 5359.008583412081, 5365.839024829262, 5382.058139825514, 5384.246205531229, 4360.454943132108, 4622.86131416058, 4755.809767609257, 4783.354247176656, 4940.308356830046, 3947.4078888167005, 3961.6632586230494, 3999.060220848098, 4153.273177193979, 4208.137331847025, 1211.5032836536977, 1213.538855235005, 1217.5738491527895, 1228.2875931959443, 1280.0975312404732, 838.9790255243668, 944.7118628818276, 950.1875896108866, 951.5183485781906, 953.2469349214182, 5653.9151912721345, 5674.858128546819, 5818.592698511064, 5824.737886795105, 6041.969790151021, 468.7867020505662, 470.6587723900145, 481.8169095743665, 491.0179640718563, 491.05471966464415, 4068.4100805383055, 4136.751794892316, 4185.121124563815, 4187.413762073312, 4224.640905523003, 10697.679069627924, 11385.544578216945, 11440.0, 11458.541658333574, 11524.827127593093, 11312.321260724382, 11312.377819219857, 11394.886051139383, 11401.144914131473, 11414.315141091562, 7876.212378762078, 8215.876761848696, 8435.873461898076, 8529.65881364751, 8547.444416113058, 6065.363136870565, 6274.0, 6313.337099604475, 6332.873342533216, 6365.490760739222, 10315.432651203955, 10596.47017649099, 10612.787744245226, 10713.625023124154, 10733.302335348177, 10549.702930750596, 10757.784844303227, 10779.19156063314, 10790.406527641055, 10945.671629851116, 7405.592692401754, 7878.448508604342, 8109.107998120084, 8134.145914678874, 8280.420370574002, 8578.485290882318, 8617.48295102296, 8622.655093796178, 8656.177663121993, 8700.434471759316, 7605.277498637842, 7732.729354472566, 7803.8829417557645, 7843.764687059397, 8038.397120216124, 7624.656890440055, 7814.33578145864, 7830.412719046209, 7923.445358824827, 7936.682532698627, 6978.441724661913, 7078.256783037707, 7162.856742865218, 7202.423806095395, 7208.387287080657, 5063.772130254221, 5096.643234973664, 5151.330327057459, 5171.172612382001, 5233.345831771028, 5145.048166089286, 5159.96800639866, 5290.266607498099, 5318.175682769177, 5329.866753331198], "value": 4621.122672989902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.6601568353229, 326.4857848888, 335.54366062155464, 337.18737841801254, 345.34384669128667, 5404.54077399103, 5510.0, 5538.889222215554, 5614.578906582007, 5683.8579035524135, 5563.972180139093, 5593.78357444469, 5647.181158731992, 5653.378128405872, 5678.34699009614, 4370.650347972162, 4402.141582391435, 4403.6256918161835, 4403.889902752425, 4410.823567057314, 4156.6051225133715, 4401.383806267125, 4404.229259879524, 4404.757738324391, 4410.55894410558, 4303.8063287152, 4324.935125973113, 4362.236608593499, 4372.3878656988045, 4389.100234451929, 4229.0273237155625, 4373.978130109361, 4390.814480090374, 4407.294832826765, 4409.581089796464, 3766.114962983697, 3773.52830896138, 3782.6406491383273, 3784.791836448994, 3785.337565925952, 5519.172124181365, 5551.0, 5562.888742225133, 5580.414056524047, 5581.6930068846195, 4833.371661683958, 4947.158982972904, 4971.801127954877, 4998.875028124289, 5010.298558201855, 5799.0, 5840.3355043812735, 5855.268091488564, 5871.530277577784, 5899.46904778572, 4190.392393103013, 4201.894952626179, 4207.1165055338415, 4208.621224089816, 4215.59951804578, 5965.970170149121, 6056.788012419588, 6138.938610613882, 6175.475084617813, 6190.347694860055, 4256.510501292391, 4267.295896177158, 4267.658587313008, 4300.935485967713, 4339.240632889295, 4332.0, 4356.0198955235455, 4365.825366985348, 4366.279563871989, 4366.585174408426, 4726.19654658702, 5014.0, 5026.673266237683, 5029.1953287473825, 5059.873503162376, 5727.828165155052, 5850.444207800252, 5876.41235876409, 5892.29123554173, 5920.200772895604, 1488.9627759306104, 1504.1952555383036, 1512.2967819963549, 1513.160196091158, 1516.3707061569326, 895.0199531512983, 931.8788557487484, 935.1350001248818, 939.0890835889177, 951.3388195204404, 4986.401631804134, 4989.725565093882, 4998.925016124761, 5028.64799464034, 5064.518870707277, 5307.6284660073425, 5414.8917021659345, 5421.0, 5502.119660854244, 5519.724013799294, 5039.748012599355, 5128.230765385148, 5138.640295179376, 5353.4646535346155, 5801.0, 3166.477531207371, 3226.04831574686, 3233.547303377529, 3240.9675903241136, 3246.5454836322933, 6115.816525504242, 6240.438360547481, 6249.0, 6265.96867015662, 6277.372262773777, 6119.173911521976, 6151.2618485781095, 6152.846178845564, 6154.846128846814, 6169.907451388232, 6171.197744293213, 6192.133101365813, 6260.812175634738, 6263.311035785969, 6263.31103578606, 5877.73550190251, 6103.877922441615, 6130.938690613037, 6135.785247516315, 6170.938290617216, 6000.279966404059, 6042.486388656837, 6059.54570902989, 6069.027566041143, 6080.48315893154, 5933.317668468181, 6330.40453414098, 6334.303226645157, 6339.270983836917, 6359.236891573041, 4321.373400856921, 4335.352566025016, 4362.1395065368015, 4373.890652733707, 4410.272305069628, 5932.16949627044, 5993.730282137227, 6234.875302494015, 6238.407351301619, 6249.9062514063235, 5878.853028674146, 5948.613340132878, 5954.880902381841, 5955.493783028491, 5978.461938425563, 5894.764209431746, 5898.616589921641, 5920.023196172583, 5930.614510056833, 6003.3996600339615, 5691.743871525874, 5847.415258474289, 5914.881702365842, 5915.8168366326045, 5947.197128387612, 5870.324912635102, 5952.970235148797, 6013.496625843539, 6051.394860513913, 6055.666938318434, 5669.659820410789, 5799.217105690678, 5817.2146760188525, 5818.272715910512, 5831.0], "value": 4451.181451516811, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.8448425830576, 768.3852917665866, 782.9217078292176, 830.6926437218231, 850.3834719828124, 15156.848431515682, 16228.918855405707, 16283.51149465515, 16354.345826166955, 16363.75454368184, 15354.616134596641, 15582.610434739108, 15589.922050389732, 15619.297131629075, 15661.060336379825, 651.8663673946829, 788.6056971514242, 794.9284564389189, 821.8150916043872, 825.2696363718093, 797.8165022044933, 799.1289494451047, 806.681360862459, 807.5477732469835, 808.022293025437, 856.5631527920743, 861.6897916749965, 862.7196161247588, 863.5639002303827, 864.0365991918997, 852.3309202276183, 858.2147335188296, 859.0636206534845, 859.1966511311912, 860.4751101827849, 624.5191202773839, 627.3068259573151, 628.2586547873508, 628.9968550157266, 630.9116723658691, 15428.614284642974, 15445.922770386189, 15566.377344906303, 15580.766288505682, 15582.922085389613, 15383.923080384526, 15411.691766164615, 15793.368265269375, 15944.0, 16225.2698628562, 12267.815982760176, 12300.876991230152, 12362.75274494514, 12412.503499859995, 12760.234385936874, 3875.7093218008763, 3881.7282790204695, 3921.9215615687813, 3926.096997690547, 3960.6237407446247, 71767.28232717658, 72008.27991720068, 72255.0, 72630.63684681595, 76135.61932190359, 11571.132165087653, 11574.421278936019, 11755.823662645067, 11759.941200294115, 11826.290422574673, 22401.66397504039, 22421.32736017922, 22505.54988900213, 22556.887215563816, 22579.09683612637, 8629.611667474854, 8849.247813935888, 8946.060663630355, 8986.775330616656, 9170.587323570455, 4832.830850920272, 4946.233333833262, 4979.950200498021, 4995.375578052744, 5097.209932460474, 3657.5428071491065, 3762.8494860205287, 3782.8865134046023, 3806.314863324573, 3818.045488627843, 627.1308762411984, 631.6620607974711, 638.5179189711738, 644.4747530762413, 659.0049025970818, 630.4735545819201, 641.4547634510722, 663.797541749771, 683.3747121383878, 704.6758491094154, 9320.30097742672, 10058.698239052841, 10101.747456313651, 10112.898871011343, 10215.693529194135, 572.364675210516, 630.9779157729457, 665.195113912162, 677.5155763629028, 681.5127184063418, 4513.909721805546, 4639.930401043987, 4661.510541393172, 4723.929141062887, 4749.0, 70194.0, 110549.0, 117888.41055794666, 118115.0, 124674.0, 60037.69981150154, 62504.0, 89084.0, 104143.4792826031, 104601.0, 59581.10628340578, 79447.0, 80666.19333806704, 90814.0, 91059.08940910638, 9195.632174712937, 9467.242620590474, 9568.76078098053, 9813.852792208265, 9915.603375865174, 43647.56352436562, 43651.781741091094, 48678.0, 55001.1749823761, 55658.72170639121, 76153.0, 76540.0, 76980.6150969264, 79769.20230797617, 81427.59286203531, 12963.546275880299, 13110.868891311346, 13408.865911340761, 13632.0, 13712.3829427678, 13278.80081798793, 14983.325750341042, 15081.321340539922, 15108.471203507825, 15321.846781532042, 13443.46226150943, 13462.29160366647, 13480.662983425493, 13582.524611638546, 13849.79225311601, 13412.195268283935, 13585.932070339584, 13711.45154193861, 13919.23444210578, 14170.362333694802, 13716.0398772089, 14246.035478936077, 14396.640083997983, 14446.061006034573, 14612.853871461575, 11280.2667826591, 11651.941740291244, 11908.940455297668, 11945.641630751092, 12252.75494490123, 11667.533298667959, 11677.591284305008, 12034.217775844541, 12122.0, 12194.817077743663], "value": 7621.0205171116095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 103.0, 111.0, 110.0, 111.0, 113.0, 109.0, 110.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 146.0, 180.0, 118.0, 159.0, 150.0, 122.0, 183.0, 122.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 162.0, 160.0, 166.0, 169.0, 168.0, 162.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 149.0, 81.0, 76.0, 78.0, 75.0, 159.0, 78.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 156.0, 86.0, 86.0, 86.0, 138.0, 84.0, 84.0, 149.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 149.0, 146.0, 147.0, 148.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 97.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 58.0, 58.0, 60.0, 57.0, 57.0, 56.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 63.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 75.0, 82.0, 76.0, 77.0, 77.0, 82.0, 76.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 121.0, 121.0, 127.0, 121.0, 120.0, 120.0, 125.0, 155.0, 134.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 166.0, 161.0, 161.0, 158.0, 156.0, 167.0, 156.0, 157.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 65.0, 64.0, 65.0, 63.0, 65.0, 64.0, 62.0, 62.0], "value": 64.6, "unit": "score"}]}]} 15:47:40 INFO - Return code: 0 15:47:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:47:40 ERROR - # TBPL SUCCESS # 15:47:40 INFO - Running post-action listener: _resource_record_post_action 15:47:40 INFO - ##### 15:47:40 INFO - ##### Finished run-tests step (success) 15:47:40 INFO - ##### 15:47:40 INFO - Running post-run listener: _resource_record_post_run 15:47:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 495616; Write bytes: 310583296; Read time: 40; Write time: 181752 15:47:40 INFO - TinderboxPrint: CPU usage
13.2% 15:47:40 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 40 15:47:40 INFO - TinderboxPrint: I/O write bytes / time
310,583,296 / 181,752 15:47:40 INFO - TinderboxPrint: CPU idle
8,237.4 (86.7%) 15:47:40 INFO - TinderboxPrint: CPU user
1,206.7 (12.7%) 15:47:40 INFO - TinderboxPrint: Swap in / out
0 / 0 15:47:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13873152; Read time: 0; Write time: 1936 15:47:40 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 495616; Write bytes: 296710144; Read time: 40; Write time: 179816 15:47:41 INFO - Running post-run listener: _upload_blobber_files 15:47:41 INFO - Blob upload gear active. 15:47:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:41 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 15:47:41 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:47:41 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:47:41 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:47:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:47:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:42 INFO - (blobuploader) - INFO - Done attempting. 15:47:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:47:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:45 INFO - (blobuploader) - INFO - Done attempting. 15:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:46 INFO - (blobuploader) - INFO - Done attempting. 15:47:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:46 INFO - Return code: 0 15:47:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/05684f406c7733f639b4720202efc17901575b5ce04059374cdf5379c3b393d8ce6a1ebc70fec94f2a9d9952bc0892888639b739ef543683058e08ca688982f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4e979b1f697048202a099b86fb326b1e494842f70263cebe516e9a65d757a47d9d679589098c5141ed39aa59d6a80ea09080e1ca99c76458af68ab695218468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/125af859fbf4bb23515f618fe7d6827474bfccf2c330b3198a9a5a95a13691de61b9fa81dc021f8aa3c8a14b18a4017f8feed8ea0ad61823ea47ae2aa42881b7"} 15:47:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:46 INFO - Contents: 15:47:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/05684f406c7733f639b4720202efc17901575b5ce04059374cdf5379c3b393d8ce6a1ebc70fec94f2a9d9952bc0892888639b739ef543683058e08ca688982f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4e979b1f697048202a099b86fb326b1e494842f70263cebe516e9a65d757a47d9d679589098c5141ed39aa59d6a80ea09080e1ca99c76458af68ab695218468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/125af859fbf4bb23515f618fe7d6827474bfccf2c330b3198a9a5a95a13691de61b9fa81dc021f8aa3c8a14b18a4017f8feed8ea0ad61823ea47ae2aa42881b7"} 15:47:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:46 INFO - Copying logs to upload dir... 15:47:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.176664 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-08 15:47:46.653827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 15:47:46.657038) ========= 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=923d835db2ba3686ebe126b700000192-1468016835.462334-721472653 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/sha512/05684f406c7733f639b4720202efc17901575b5ce04059374cdf5379c3b393d8ce6a1ebc70fec94f2a9d9952bc0892888639b739ef543683058e08ca688982f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4e979b1f697048202a099b86fb326b1e494842f70263cebe516e9a65d757a47d9d679589098c5141ed39aa59d6a80ea09080e1ca99c76458af68ab695218468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/125af859fbf4bb23515f618fe7d6827474bfccf2c330b3198a9a5a95a13691de61b9fa81dc021f8aa3c8a14b18a4017f8feed8ea0ad61823ea47ae2aa42881b7"} build_url:https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/TnRGNj66Td66oamM_F5vKQ/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/sha512/05684f406c7733f639b4720202efc17901575b5ce04059374cdf5379c3b393d8ce6a1ebc70fec94f2a9d9952bc0892888639b739ef543683058e08ca688982f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4e979b1f697048202a099b86fb326b1e494842f70263cebe516e9a65d757a47d9d679589098c5141ed39aa59d6a80ea09080e1ca99c76458af68ab695218468", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/125af859fbf4bb23515f618fe7d6827474bfccf2c330b3198a9a5a95a13691de61b9fa81dc021f8aa3c8a14b18a4017f8feed8ea0ad61823ea47ae2aa42881b7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 15:47:46.682794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 15:47:46.683226) ========= 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=923d835db2ba3686ebe126b700000192-1468016835.462334-721472653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 15:47:46.766024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 15:47:46.766363) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 15:47:46.766772) ========= ========= Total master_lag: 0.17 =========