builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1468243235.85 results: success (0) buildid: 20160711031958 builduid: 87c2f2de948e4c8782bb3751d36420ef revision: 89c3e4ca17f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:35.845880) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:35.846319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:35.846611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:35.862706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:35.862968) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 06:20:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224K=0.05s 2016-07-11 06:20:36 (224 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.233556 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.131001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.131400) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.073597 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.218056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.218473) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 89c3e4ca17f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 89c3e4ca17f5 --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=7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 06:20:36,273 Setting DEBUG logging. 2016-07-11 06:20:36,273 attempt 1/10 2016-07-11 06:20:36,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/89c3e4ca17f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 06:20:36,585 unpacking tar archive at: fx-team-89c3e4ca17f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.935499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.935896) ========= script_repo_revision: 89c3e4ca17f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.936441) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.936714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 06:20:36.945858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-11 06:20:36.946329) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:20:37 INFO - MultiFileLogger online at 20160711 06:20:37 in /builds/slave/test 06:20:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:20:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:20:37 INFO - {'append_to_log': False, 06:20:37 INFO - 'base_work_dir': '/builds/slave/test', 06:20:37 INFO - 'blob_upload_branch': 'Fx-Team', 06:20:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:20:37 INFO - 'branch': 'Fx-Team', 06:20:37 INFO - 'buildbot_json_path': 'buildprops.json', 06:20:37 INFO - 'config_files': ('talos/linux_config.py',), 06:20:37 INFO - 'default_actions': ('clobber', 06:20:37 INFO - 'read-buildbot-config', 06:20:37 INFO - 'download-and-extract', 06:20:37 INFO - 'populate-webroot', 06:20:37 INFO - 'create-virtualenv', 06:20:37 INFO - 'install', 06:20:37 INFO - 'run-tests'), 06:20:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:20:37 INFO - 'download_minidump_stackwalk': True, 06:20:37 INFO - 'download_symbols': 'ondemand', 06:20:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:20:37 INFO - 'tooltool.py': '/tools/tooltool.py', 06:20:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:20:37 INFO - '/tools/misc-python/virtualenv.py')}, 06:20:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:20:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:20:37 INFO - 'installer_path': 'installer.exe', 06:20:37 INFO - 'log_level': 'info', 06:20:37 INFO - 'log_name': 'talos', 06:20:37 INFO - 'log_to_console': True, 06:20:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:20:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:20:37 INFO - 'opt_config_files': (), 06:20:37 INFO - 'pip_index': False, 06:20:37 INFO - 'sps_profile': False, 06:20:37 INFO - 'sps_profile_interval': 0, 06:20:37 INFO - 'suite': 'dromaeojs', 06:20:37 INFO - 'system_bits': '32', 06:20:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:20:37 INFO - 'title': 'talos-linux64-ix-005', 06:20:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:20:37 INFO - 'use_talos_json': True, 06:20:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:20:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:20:37 INFO - 'work_dir': 'build'} 06:20:37 INFO - ##### 06:20:37 INFO - ##### Running clobber step. 06:20:37 INFO - ##### 06:20:37 INFO - Running pre-action listener: _resource_record_pre_action 06:20:37 INFO - Running main action method: clobber 06:20:37 INFO - rmtree: /builds/slave/test/build 06:20:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:20:39 INFO - Running post-action listener: _resource_record_post_action 06:20:39 INFO - ##### 06:20:39 INFO - ##### Finished clobber step (success) 06:20:39 INFO - ##### 06:20:39 INFO - ##### 06:20:39 INFO - ##### Running read-buildbot-config step. 06:20:39 INFO - ##### 06:20:39 INFO - Running pre-action listener: _resource_record_pre_action 06:20:39 INFO - Running main action method: read_buildbot_config 06:20:39 INFO - Using buildbot properties: 06:20:39 INFO - { 06:20:39 INFO - "project": "", 06:20:39 INFO - "product": "firefox", 06:20:39 INFO - "script_repo_revision": "production", 06:20:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:20:39 INFO - "repository": "", 06:20:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:20:39 INFO - "buildid": "20160711031958", 06:20:39 INFO - "pgo_build": "True", 06:20:39 INFO - "basedir": "/builds/slave/test", 06:20:39 INFO - "buildnumber": 882, 06:20:39 INFO - "slavename": "talos-linux64-ix-005", 06:20:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:20:39 INFO - "platform": "ubuntu64_hw", 06:20:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:20:39 INFO - "branch": "fx-team", 06:20:39 INFO - "repo_path": "integration/fx-team", 06:20:39 INFO - "revision": "89c3e4ca17f5", 06:20:39 INFO - "stage_platform": "linux64-pgo", 06:20:39 INFO - "builduid": "87c2f2de948e4c8782bb3751d36420ef", 06:20:39 INFO - "slavebuilddir": "test" 06:20:39 INFO - } 06:20:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:20:39 INFO - Running post-action listener: _resource_record_post_action 06:20:39 INFO - ##### 06:20:39 INFO - ##### Finished read-buildbot-config step (success) 06:20:39 INFO - ##### 06:20:39 INFO - ##### 06:20:39 INFO - ##### Running download-and-extract step. 06:20:39 INFO - ##### 06:20:39 INFO - Running pre-action listener: _resource_record_pre_action 06:20:39 INFO - Running main action method: download_and_extract 06:20:39 INFO - mkdir: /builds/slave/test/build/tests 06:20: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')]} 06:20:39 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:40 INFO - Downloaded 1361 bytes. 06:20:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:20:40 INFO - Using the following test package requirements: 06:20:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:20:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:20:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:20:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'jsshell-linux-x86_64.zip'], 06:20:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:20:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:20:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:20:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:20:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:20:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:20:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:20:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:20:40 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:41 INFO - Downloaded 24304312 bytes. 06:20:41 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'] 06:20:41 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 06:20:42 INFO - Return code: 0 06:20:42 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 06:20: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')]} 06:20:42 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:20:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:20:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:20:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:43 INFO - Downloaded 24304312 bytes. 06:20:43 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'] 06:20:43 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 06:20:45 INFO - Return code: 0 06:20:45 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')]} 06:20:45 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:20:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:20:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:20:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:46 INFO - Downloaded 14403333 bytes. 06:20:46 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'] 06:20:46 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 06:20:47 INFO - Return code: 0 06:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:20:47 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:20:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:20:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:20:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/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 06:20:48 INFO - Downloaded 60473274 bytes. 06:20:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:20:48 INFO - mkdir: /builds/slave/test/properties 06:20:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:20:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:20:48 INFO - Contents: 06:20:48 INFO - build_url:https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:20:49 INFO - Running post-action listener: _resource_record_post_action 06:20:49 INFO - Running post-action listener: set_extra_try_arguments 06:20:49 INFO - ##### 06:20:49 INFO - ##### Finished download-and-extract step (success) 06:20:49 INFO - ##### 06:20:49 INFO - ##### 06:20:49 INFO - ##### Running populate-webroot step. 06:20:49 INFO - ##### 06:20:49 INFO - Running pre-action listener: _resource_record_pre_action 06:20:49 INFO - Running main action method: populate_webroot 06:20:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:20:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:20:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:20:49 INFO - '--tppagecycles', 06:20:49 INFO - '7'], 06:20:49 INFO - 'tests': ['tsvgm']}}, 06:20:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:20:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:20:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:20:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:20:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:20:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:20:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['damp', 'tps']}, 06:20:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'tests': ['damp', 'tps']}, 06:20:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['dromaeo_dom']}, 06:20:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:20:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['basic_compositor_video']}, 06:20:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:20:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['a11yr', 06:20:49 INFO - 'ts_paint', 06:20:49 INFO - 'tpaint', 06:20:49 INFO - 'sessionrestore', 06:20:49 INFO - 'sessionrestore_no_auto_restore', 06:20:49 INFO - 'tabpaint']}, 06:20:49 INFO - 'other-e10s': {'tests': ['a11yr', 06:20:49 INFO - 'ts_paint', 06:20:49 INFO - 'tpaint', 06:20:49 INFO - 'sessionrestore', 06:20:49 INFO - 'sessionrestore_no_auto_restore', 06:20:49 INFO - 'tabpaint']}, 06:20:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:20:49 INFO - 'ts_paint', 06:20:49 INFO - 'tpaint', 06:20:49 INFO - 'sessionrestore', 06:20:49 INFO - 'sessionrestore_no_auto_restore', 06:20:49 INFO - 'tabpaint']}, 06:20:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:20:49 INFO - 'ts_paint', 06:20:49 INFO - 'tpaint', 06:20:49 INFO - 'sessionrestore', 06:20:49 INFO - 'sessionrestore_no_auto_restore', 06:20:49 INFO - 'tabpaint']}, 06:20:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['a11yr', 06:20:49 INFO - 'ts_paint', 06:20:49 INFO - 'tpaint', 06:20:49 INFO - 'sessionrestore', 06:20:49 INFO - 'sessionrestore_no_auto_restore', 06:20:49 INFO - 'tabpaint']}, 06:20:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['a11yr', 06:20:49 INFO - 'ts_paint', 06:20:49 INFO - 'tpaint', 06:20:49 INFO - 'sessionrestore', 06:20:49 INFO - 'sessionrestore_no_auto_restore', 06:20:49 INFO - 'tabpaint']}, 06:20:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['tsvgx', 06:20:49 INFO - 'tsvgr_opacity', 06:20:49 INFO - 'tart', 06:20:49 INFO - 'tscrollx', 06:20:49 INFO - 'cart']}, 06:20:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:20:49 INFO - 'tsvgr_opacity', 06:20:49 INFO - 'tart', 06:20:49 INFO - 'tscrollx', 06:20:49 INFO - 'cart']}, 06:20:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'talos_options': ['--disable-e10s'], 06:20:49 INFO - 'tests': ['tp5o']}, 06:20:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'tests': ['tp5o']}, 06:20:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'talos_options': ['--disable-e10s', 06:20:49 INFO - '--xperf_path', 06:20:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:20:49 INFO - 'tests': ['tp5n']}, 06:20:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:49 INFO - 'talos_options': ['--xperf_path', 06:20:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:20:49 INFO - 'tests': ['tp5n']}}, 06:20:49 INFO - 'talos.zip': {'path': '', 06:20:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:20:49 INFO - Running post-action listener: _resource_record_post_action 06:20:49 INFO - ##### 06:20:49 INFO - ##### Finished populate-webroot step (success) 06:20:49 INFO - ##### 06:20:49 INFO - ##### 06:20:49 INFO - ##### Running create-virtualenv step. 06:20:49 INFO - ##### 06:20:49 INFO - Running pre-action listener: _resource_record_pre_action 06:20:49 INFO - Running main action method: create_virtualenv 06:20:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:20:49 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 06:20:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:20:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:20:50 INFO - Using real prefix '/usr' 06:20:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:20:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:20:53 INFO - Installing pip.................done. 06:20:53 INFO - Return code: 0 06:20:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:20:53 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')]} 06:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:53 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')]} 06:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:53 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:20:53 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 06:20:53 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 06:20:53 INFO - Using env: {'DISPLAY': ':0', 06:20:53 INFO - 'HOME': '/home/cltbld', 06:20:53 INFO - 'LANG': 'en_US.UTF-8', 06:20:53 INFO - 'LANGUAGE': 'en_US:en', 06:20:53 INFO - 'LOGNAME': 'cltbld', 06:20:53 INFO - 'MAIL': '/var/mail/cltbld', 06:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:53 INFO - 'MOZ_NO_REMOTE': '1', 06:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:53 INFO - 'NO_EM_RESTART': '1', 06:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:53 INFO - 'PWD': '/builds/slave/test', 06:20:53 INFO - 'SHELL': '/bin/bash', 06:20:53 INFO - 'SHLVL': '1', 06:20:53 INFO - 'TERM': 'linux', 06:20:53 INFO - 'TMOUT': '86400', 06:20:53 INFO - 'USER': 'cltbld', 06:20:53 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:53 INFO - '_': '/tools/buildbot/bin/python'} 06:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:55 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 06:20:55 INFO - Cleaning up... 06:20:55 INFO - Return code: 0 06:20:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:20:55 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')]} 06:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:55 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')]} 06:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:55 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:20:55 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 06:20:55 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 06:20:55 INFO - Using env: {'DISPLAY': ':0', 06:20:55 INFO - 'HOME': '/home/cltbld', 06:20:55 INFO - 'LANG': 'en_US.UTF-8', 06:20:55 INFO - 'LANGUAGE': 'en_US:en', 06:20:55 INFO - 'LOGNAME': 'cltbld', 06:20:55 INFO - 'MAIL': '/var/mail/cltbld', 06:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:55 INFO - 'MOZ_NO_REMOTE': '1', 06:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:55 INFO - 'NO_EM_RESTART': '1', 06:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:55 INFO - 'PWD': '/builds/slave/test', 06:20:55 INFO - 'SHELL': '/bin/bash', 06:20:55 INFO - 'SHLVL': '1', 06:20:55 INFO - 'TERM': 'linux', 06:20:55 INFO - 'TMOUT': '86400', 06:20:55 INFO - 'USER': 'cltbld', 06:20:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:55 INFO - '_': '/tools/buildbot/bin/python'} 06:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:55 INFO - Downloading/unpacking psutil>=3.1.1 06:20:55 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 06:20:55 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 06:20:55 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 06:20:55 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 06:20:55 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 06:20:55 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 06:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:57 INFO - Installing collected packages: psutil 06:20:57 INFO - Running setup.py install for psutil 06:20:57 INFO - building 'psutil._psutil_linux' extension 06:20:57 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 06:20:58 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 06:20:58 INFO - building 'psutil._psutil_posix' extension 06:20:58 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 06:20:58 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 06:20:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:58 INFO - Successfully installed psutil 06:20:58 INFO - Cleaning up... 06:20:58 INFO - Return code: 0 06:20:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:58 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:20:58 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 06:20:58 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 06:20:58 INFO - Using env: {'DISPLAY': ':0', 06:20:58 INFO - 'HOME': '/home/cltbld', 06:20:58 INFO - 'LANG': 'en_US.UTF-8', 06:20:58 INFO - 'LANGUAGE': 'en_US:en', 06:20:58 INFO - 'LOGNAME': 'cltbld', 06:20:58 INFO - 'MAIL': '/var/mail/cltbld', 06:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:58 INFO - 'MOZ_NO_REMOTE': '1', 06:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:58 INFO - 'NO_EM_RESTART': '1', 06:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:58 INFO - 'PWD': '/builds/slave/test', 06:20:58 INFO - 'SHELL': '/bin/bash', 06:20:58 INFO - 'SHLVL': '1', 06:20:58 INFO - 'TERM': 'linux', 06:20:58 INFO - 'TMOUT': '86400', 06:20:58 INFO - 'USER': 'cltbld', 06:20:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:58 INFO - '_': '/tools/buildbot/bin/python'} 06:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:20:59 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 06:21:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:21:01 INFO - Installing collected packages: mozsystemmonitor 06:21:01 INFO - Running setup.py install for mozsystemmonitor 06:21:01 INFO - Successfully installed mozsystemmonitor 06:21:01 INFO - Cleaning up... 06:21:01 INFO - Return code: 0 06:21:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:01 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:21:01 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 06:21:01 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 06:21:01 INFO - Using env: {'DISPLAY': ':0', 06:21:01 INFO - 'HOME': '/home/cltbld', 06:21:01 INFO - 'LANG': 'en_US.UTF-8', 06:21:01 INFO - 'LANGUAGE': 'en_US:en', 06:21:01 INFO - 'LOGNAME': 'cltbld', 06:21:01 INFO - 'MAIL': '/var/mail/cltbld', 06:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:01 INFO - 'MOZ_NO_REMOTE': '1', 06:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:01 INFO - 'NO_EM_RESTART': '1', 06:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:01 INFO - 'PWD': '/builds/slave/test', 06:21:01 INFO - 'SHELL': '/bin/bash', 06:21:01 INFO - 'SHLVL': '1', 06:21:01 INFO - 'TERM': 'linux', 06:21:01 INFO - 'TMOUT': '86400', 06:21:01 INFO - 'USER': 'cltbld', 06:21:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:01 INFO - '_': '/tools/buildbot/bin/python'} 06:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:01 INFO - Downloading/unpacking jsonschema==2.5.1 06:21:01 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 06:21:01 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 06:21:01 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 06:21:01 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 06:21:01 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 06:21:01 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 06:21:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:21:03 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 06:21:03 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 06:21:03 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 06:21:03 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 06:21:03 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 06:21:03 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 06:21:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:03 INFO - warning: no files found matching '*.txt' 06:21:03 INFO - no previously-included directories found matching 'build' 06:21:03 INFO - no previously-included directories found matching 'dist' 06:21:03 INFO - no previously-included directories found matching '.git*' 06:21:03 INFO - Installing collected packages: jsonschema, functools32 06:21:03 INFO - Running setup.py install for functools32 06:21:03 INFO - warning: no files found matching '*.txt' 06:21:03 INFO - no previously-included directories found matching 'build' 06:21:03 INFO - no previously-included directories found matching 'dist' 06:21:03 INFO - no previously-included directories found matching '.git*' 06:21:03 INFO - Successfully installed jsonschema functools32 06:21:03 INFO - Cleaning up... 06:21:03 INFO - Return code: 0 06:21:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21:03 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')]} 06:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:03 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')]} 06:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:03 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:21:03 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 06:21:03 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 06:21:03 INFO - Using env: {'DISPLAY': ':0', 06:21:03 INFO - 'HOME': '/home/cltbld', 06:21:03 INFO - 'LANG': 'en_US.UTF-8', 06:21:03 INFO - 'LANGUAGE': 'en_US:en', 06:21:03 INFO - 'LOGNAME': 'cltbld', 06:21:03 INFO - 'MAIL': '/var/mail/cltbld', 06:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:03 INFO - 'MOZ_NO_REMOTE': '1', 06:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:03 INFO - 'NO_EM_RESTART': '1', 06:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:03 INFO - 'PWD': '/builds/slave/test', 06:21:03 INFO - 'SHELL': '/bin/bash', 06:21:03 INFO - 'SHLVL': '1', 06:21:03 INFO - 'TERM': 'linux', 06:21:03 INFO - 'TMOUT': '86400', 06:21:03 INFO - 'USER': 'cltbld', 06:21:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:03 INFO - '_': '/tools/buildbot/bin/python'} 06:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:21:04 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 06:21:04 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 06:21:04 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 06:21:04 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 06:21:04 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 06:21:04 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 06:21:06 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 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 06:21:06 INFO - Downloading docopt-0.6.1.tar.gz 06:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:06 INFO - Running setup.py install for blobuploader 06:21:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:06 INFO - Running setup.py install for requests 06:21:07 INFO - Running setup.py install for docopt 06:21:07 INFO - Successfully installed blobuploader requests docopt 06:21:07 INFO - Cleaning up... 06:21:07 INFO - Return code: 0 06:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21: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')]} 06:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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')]} 06:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:07 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:21:07 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 06:21:07 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 06:21:07 INFO - Using env: {'DISPLAY': ':0', 06:21:07 INFO - 'HOME': '/home/cltbld', 06:21:07 INFO - 'LANG': 'en_US.UTF-8', 06:21:07 INFO - 'LANGUAGE': 'en_US:en', 06:21:07 INFO - 'LOGNAME': 'cltbld', 06:21:07 INFO - 'MAIL': '/var/mail/cltbld', 06:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:07 INFO - 'MOZ_NO_REMOTE': '1', 06:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:07 INFO - 'NO_EM_RESTART': '1', 06:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:07 INFO - 'PWD': '/builds/slave/test', 06:21:07 INFO - 'SHELL': '/bin/bash', 06:21:07 INFO - 'SHLVL': '1', 06:21:07 INFO - 'TERM': 'linux', 06:21:07 INFO - 'TMOUT': '86400', 06:21:07 INFO - 'USER': 'cltbld', 06:21:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:07 INFO - '_': '/tools/buildbot/bin/python'} 06:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:07 INFO - Running setup.py (path:/tmp/pip-tWU8c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:07 INFO - Running setup.py (path:/tmp/pip-NLd49k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:07 INFO - Running setup.py (path:/tmp/pip-cblUbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:07 INFO - Running setup.py (path:/tmp/pip-9Ddoe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:07 INFO - Running setup.py (path:/tmp/pip-OKhWdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:07 INFO - Running setup.py (path:/tmp/pip-t8a2PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:08 INFO - Running setup.py (path:/tmp/pip-S1aKxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:08 INFO - Running setup.py (path:/tmp/pip-4SWort-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:08 INFO - Running setup.py (path:/tmp/pip-h3ZDVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:08 INFO - Running setup.py (path:/tmp/pip-CfCJcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:08 INFO - Running setup.py (path:/tmp/pip-YeWvpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:08 INFO - Running setup.py (path:/tmp/pip-yKk0TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:08 INFO - Running setup.py (path:/tmp/pip-noyDTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:08 INFO - Running setup.py (path:/tmp/pip-NIn_Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:08 INFO - Running setup.py (path:/tmp/pip-w1H8QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:08 INFO - Running setup.py (path:/tmp/pip-i9ATVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:08 INFO - Running setup.py (path:/tmp/pip-QZpVaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:08 INFO - Running setup.py install for manifestparser 06:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:08 INFO - Running setup.py install for mozcrash 06:21:09 INFO - Running setup.py install for mozdebug 06:21:09 INFO - Running setup.py install for mozdevice 06:21:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Running setup.py install for mozfile 06:21:09 INFO - Running setup.py install for mozhttpd 06:21:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Running setup.py install for mozinfo 06:21:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Running setup.py install for mozInstall 06:21:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Running setup.py install for mozleak 06:21:09 INFO - Running setup.py install for mozlog 06:21:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Running setup.py install for moznetwork 06:21:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:09 INFO - Running setup.py install for mozprocess 06:21:10 INFO - Running setup.py install for mozprofile 06:21:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:10 INFO - Running setup.py install for mozrunner 06:21:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:10 INFO - Running setup.py install for mozscreenshot 06:21:10 INFO - Running setup.py install for moztest 06:21:10 INFO - Running setup.py install for mozversion 06:21:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:10 INFO - Cleaning up... 06:21:10 INFO - Return code: 0 06:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:10 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')]} 06:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:10 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')]} 06:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:10 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:21:10 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 06:21:10 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 06:21:10 INFO - Using env: {'DISPLAY': ':0', 06:21:10 INFO - 'HOME': '/home/cltbld', 06:21:10 INFO - 'LANG': 'en_US.UTF-8', 06:21:10 INFO - 'LANGUAGE': 'en_US:en', 06:21:10 INFO - 'LOGNAME': 'cltbld', 06:21:10 INFO - 'MAIL': '/var/mail/cltbld', 06:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:10 INFO - 'MOZ_NO_REMOTE': '1', 06:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:10 INFO - 'NO_EM_RESTART': '1', 06:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:10 INFO - 'PWD': '/builds/slave/test', 06:21:10 INFO - 'SHELL': '/bin/bash', 06:21:10 INFO - 'SHLVL': '1', 06:21:10 INFO - 'TERM': 'linux', 06:21:10 INFO - 'TMOUT': '86400', 06:21:10 INFO - 'USER': 'cltbld', 06:21:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:10 INFO - '_': '/tools/buildbot/bin/python'} 06:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:10 INFO - Running setup.py (path:/tmp/pip-lYnVo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:10 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)) 06:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:10 INFO - Running setup.py (path:/tmp/pip-YgmqfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:10 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)) 06:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:10 INFO - Running setup.py (path:/tmp/pip-6tantB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:11 INFO - Running setup.py (path:/tmp/pip-4Fn_pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:11 INFO - Running setup.py (path:/tmp/pip-Rmt_Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:11 INFO - Running setup.py (path:/tmp/pip-pNJ7YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:11 INFO - Running setup.py (path:/tmp/pip-Q0B0oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:11 INFO - Running setup.py (path:/tmp/pip-Y2oaX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:11 INFO - Running setup.py (path:/tmp/pip-73xZ7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:11 INFO - Running setup.py (path:/tmp/pip-hzRx0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:11 INFO - Running setup.py (path:/tmp/pip-AceBDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:11 INFO - Running setup.py (path:/tmp/pip-Zek4Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:11 INFO - Running setup.py (path:/tmp/pip-fDdbm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:11 INFO - Running setup.py (path:/tmp/pip-n_5Sy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:11 INFO - Running setup.py (path:/tmp/pip-6xdaVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:11 INFO - Running setup.py (path:/tmp/pip-xT3ups-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:11 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)) 06:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:11 INFO - Running setup.py (path:/tmp/pip-H0fj9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:12 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)) 06:21:12 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)) 06:21:12 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)) 06:21:12 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)) 06:21:12 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)) 06:21:12 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)) 06:21:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:13 INFO - Downloading blessings-1.6.tar.gz 06:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:14 INFO - Installing collected packages: blessings 06:21:14 INFO - Running setup.py install for blessings 06:21:14 INFO - Successfully installed blessings 06:21:14 INFO - Cleaning up... 06:21:14 INFO - Return code: 0 06:21:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:14 INFO - Reading from file tmpfile_stdout 06:21:14 INFO - Current package versions: 06:21:14 INFO - argparse == 1.2.1 06:21:14 INFO - blessings == 1.6 06:21:14 INFO - blobuploader == 1.2.4 06:21:14 INFO - docopt == 0.6.1 06:21:14 INFO - functools32 == 3.2.3-2 06:21:14 INFO - jsonschema == 2.5.1 06:21:14 INFO - manifestparser == 1.1 06:21:14 INFO - mozInstall == 1.12 06:21:14 INFO - mozcrash == 0.17 06:21:14 INFO - mozdebug == 0.1 06:21:14 INFO - mozdevice == 0.48 06:21:14 INFO - mozfile == 1.2 06:21:14 INFO - mozhttpd == 0.7 06:21:14 INFO - mozinfo == 0.9 06:21:14 INFO - mozleak == 0.1 06:21:14 INFO - mozlog == 3.2 06:21:14 INFO - moznetwork == 0.27 06:21:14 INFO - mozprocess == 0.23 06:21:14 INFO - mozprofile == 0.28 06:21:14 INFO - mozrunner == 6.12 06:21:14 INFO - mozscreenshot == 0.1 06:21:14 INFO - mozsystemmonitor == 0.3 06:21:14 INFO - moztest == 0.7 06:21:14 INFO - mozversion == 1.4 06:21:14 INFO - psutil == 3.1.1 06:21:14 INFO - requests == 1.2.3 06:21:14 INFO - wsgiref == 0.1.2 06:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:14 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 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:21:14 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 06:21:14 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 06:21:14 INFO - Using env: {'DISPLAY': ':0', 06:21:14 INFO - 'HOME': '/home/cltbld', 06:21:14 INFO - 'LANG': 'en_US.UTF-8', 06:21:14 INFO - 'LANGUAGE': 'en_US:en', 06:21:14 INFO - 'LOGNAME': 'cltbld', 06:21:14 INFO - 'MAIL': '/var/mail/cltbld', 06:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:14 INFO - 'MOZ_NO_REMOTE': '1', 06:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:14 INFO - 'NO_EM_RESTART': '1', 06:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:14 INFO - 'PWD': '/builds/slave/test', 06:21:14 INFO - 'SHELL': '/bin/bash', 06:21:14 INFO - 'SHLVL': '1', 06:21:14 INFO - 'TERM': 'linux', 06:21:14 INFO - 'TMOUT': '86400', 06:21:14 INFO - 'USER': 'cltbld', 06:21:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:14 INFO - '_': '/tools/buildbot/bin/python'} 06:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 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)) 06:21:14 INFO - Cleaning up... 06:21:14 INFO - Return code: 0 06:21:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', '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 06:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:21:14 INFO - Using env: {'DISPLAY': ':0', 06:21:14 INFO - 'HOME': '/home/cltbld', 06:21:14 INFO - 'LANG': 'en_US.UTF-8', 06:21:14 INFO - 'LANGUAGE': 'en_US:en', 06:21:14 INFO - 'LOGNAME': 'cltbld', 06:21:14 INFO - 'MAIL': '/var/mail/cltbld', 06:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:14 INFO - 'MOZ_NO_REMOTE': '1', 06:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:14 INFO - 'NO_EM_RESTART': '1', 06:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:14 INFO - 'PWD': '/builds/slave/test', 06:21:14 INFO - 'SHELL': '/bin/bash', 06:21:14 INFO - 'SHLVL': '1', 06:21:14 INFO - 'TERM': 'linux', 06:21:14 INFO - 'TMOUT': '86400', 06:21:14 INFO - 'USER': 'cltbld', 06:21:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:14 INFO - '_': '/tools/buildbot/bin/python'} 06:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:21:14 INFO - Cleaning up... 06:21:14 INFO - Return code: 0 06:21:14 INFO - Running post-action listener: _resource_record_post_action 06:21:14 INFO - Running post-action listener: _start_resource_monitoring 06:21:14 INFO - Starting resource monitoring. 06:21:14 INFO - ##### 06:21:14 INFO - ##### Finished create-virtualenv step (success) 06:21:14 INFO - ##### 06:21:14 INFO - ##### 06:21:14 INFO - ##### Running install step. 06:21:14 INFO - ##### 06:21:14 INFO - Running pre-action listener: _resource_record_pre_action 06:21:14 INFO - Running main action method: install 06:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:15 INFO - Reading from file tmpfile_stdout 06:21:15 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:15 INFO - Reading from file tmpfile_stdout 06:21:15 INFO - Output received: 06:21:15 INFO - Usage: mozinstall [options] installer 06:21:15 INFO - Options: 06:21:15 INFO - -h, --help show this help message and exit 06:21:15 INFO - -d DEST, --destination=DEST 06:21:15 INFO - Directory to install application into. [default: 06:21:15 INFO - "/builds/slave/test"] 06:21:15 INFO - --app=APP Application being installed. [default: firefox] 06:21:15 INFO - mkdir: /builds/slave/test/build/application 06:21:15 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'] 06:21:15 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 06:21:32 INFO - Reading from file tmpfile_stdout 06:21:32 INFO - Output received: 06:21:32 INFO - /builds/slave/test/build/application/firefox/firefox 06:21:32 INFO - Running post-action listener: _resource_record_post_action 06:21:32 INFO - ##### 06:21:32 INFO - ##### Finished install step (success) 06:21:32 INFO - ##### 06:21:32 INFO - ##### 06:21:32 INFO - ##### Running run-tests step. 06:21:32 INFO - ##### 06:21:32 INFO - Running pre-action listener: _resource_record_pre_action 06:21:32 INFO - Running main action method: run_tests 06:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:21:32 INFO - Python 2.7.3 06:21:32 INFO - Return code: 0 06:21:32 INFO - grabbing minidump binary from tooltool 06:21:32 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')]} 06:21:32 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 0x1fb13b0>, '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 0x1fb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:21:32 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 06:21:32 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 06:21:32 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 06:21:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:21:32 INFO - Return code: 0 06:21:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:21:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:21:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:21:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:21:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:21:32 INFO - Using env: {'DISPLAY': ':0', 06:21:32 INFO - 'HOME': '/home/cltbld', 06:21:32 INFO - 'LANG': 'en_US.UTF-8', 06:21:32 INFO - 'LANGUAGE': 'en_US:en', 06:21:32 INFO - 'LOGNAME': 'cltbld', 06:21:32 INFO - 'MAIL': '/var/mail/cltbld', 06:21:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:21:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:32 INFO - 'MOZ_NO_REMOTE': '1', 06:21:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:32 INFO - 'NO_EM_RESTART': '1', 06:21:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:32 INFO - 'PWD': '/builds/slave/test', 06:21:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:21:32 INFO - 'SHELL': '/bin/bash', 06:21:32 INFO - 'SHLVL': '1', 06:21:32 INFO - 'TERM': 'linux', 06:21:32 INFO - 'TMOUT': '86400', 06:21:32 INFO - 'USER': 'cltbld', 06:21:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486', 06:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:32 INFO - '_': '/tools/buildbot/bin/python'} 06:21:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:21:32 INFO - mozversion application_buildid: 20160711031958 06:21:32 INFO - mozversion application_changeset: 89c3e4ca17f5c9d01638d49834a81789499e72ce 06:21:32 INFO - mozversion application_display_name: Nightly 06:21:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:32 INFO - mozversion application_name: Firefox 06:21:32 INFO - mozversion application_remotingname: firefox 06:21:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:21:32 INFO - mozversion application_vendor: Mozilla 06:21:32 INFO - mozversion application_version: 50.0a1 06:21:32 INFO - mozversion platform_buildid: 20160711031958 06:21:32 INFO - mozversion platform_changeset: 89c3e4ca17f5c9d01638d49834a81789499e72ce 06:21:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:21:32 INFO - mozversion platform_version: 50.0a1 06:21:32 INFO - using testdate: 1468243292 06:21:32 INFO - actual date: 1468243292 06:21:32 INFO - starting webserver on 'localhost:43523' 06:21:32 INFO - SUITE-START | Running 2 tests 06:21:32 INFO - TEST-START | dromaeo_css 06:21:32 INFO - operating with platform_type : linux_ 06:21:32 INFO - Initialising browser for dromaeo_css test... 06:21:32 INFO - TEST-INFO | started process 3292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPLK2et/profile http://localhost:43523/getInfo.html) 06:21:38 INFO - PROCESS | 3292 | __metrics Screen width/height:1600/1200 06:21:38 INFO - PROCESS | 3292 | colorDepth:24 06:21:38 INFO - PROCESS | 3292 | Browser inner width/height: 1024/697 06:21:38 INFO - PROCESS | 3292 | __metrics 06:21:39 INFO - PROCESS | 3292 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:21:39 INFO - PROCESS | 3292 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:40 INFO - TEST-INFO | 3292: exit 0 06:21:40 INFO - Browser initialized. 06:21:40 INFO - Running cycle 1/1 for dromaeo_css test... 06:21:40 INFO - TEST-INFO | started process 3378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPLK2et/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:51 INFO - PROCESS | 3378 | RSS: Main: 157724672 06:21:51 INFO - PROCESS | 3378 | 06:22:43 INFO - PROCESS | 3378 | 1468243363529 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] 06:24:51 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:43523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43523/tests/dromaeo/cssquery-ext.html) 06:24:52 INFO - PROCESS | 3378 | RSS: Main: 247267328 06:24:52 INFO - PROCESS | 3378 | 06:27:54 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:43523/tests/dromaeo/cssquery-ext.html (next: http://localhost:43523/tests/dromaeo/cssquery-jquery.html) 06:27:55 INFO - PROCESS | 3378 | RSS: Main: 250834944 06:27:55 INFO - PROCESS | 3378 | 06:30:57 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:43523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43523/tests/dromaeo/cssquery-mootools.html) 06:30:58 INFO - PROCESS | 3378 | RSS: Main: 244232192 06:30:58 INFO - PROCESS | 3378 | 06:34:00 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:43523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43523/tests/dromaeo/cssquery-prototype.html) 06:34:00 INFO - PROCESS | 3378 | RSS: Main: 231890944 06:34:00 INFO - PROCESS | 3378 | 06:37:03 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:43523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43523/tests/dromaeo/cssquery-yui.html) 06:37:04 INFO - PROCESS | 3378 | RSS: Main: 227880960 06:37:04 INFO - PROCESS | 3378 | 06:40:06 INFO - PROCESS | 3378 | Cycle 1(1): loaded http://localhost:43523/tests/dromaeo/cssquery-yui.html (next: http://localhost:43523/tests/dromaeo/cssquery-dojo.html) 06:40:07 INFO - PROCESS | 3378 | RSS: Main: 295030784 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | __start_tp_report 06:40:07 INFO - PROCESS | 3378 | _x_x_mozilla_page_load 06:40:07 INFO - PROCESS | 3378 | _x_x_mozilla_page_load_details 06:40:07 INFO - PROCESS | 3378 | |i|pagename|runs| 06:40:07 INFO - PROCESS | 3378 | |0;dojo.html;3126.546650735643;3143.5913331266934;3145.323755392591;3170.9524357134646;3183.506556483746;5348.518633323;5405.567554595633;5434.918476222855;5554.472325129112;5584.441555844409;5370.113931201347;5405.702686352249;5437.809676661318;5457.426970168125;5477.260569823073;4921.778519966592;4988.376452943382;5019.498050194969;5033.169527028036;5149.201873709581;5027.296178535008;5055.898882022358;5098.082345177866;5120.334356533645;5129.948700512984;4812.302216178652;4850.514948505156;4909.950900490985;4968.950310496885;4983.8504844854715;4963.8262660806695;4972.552470277692;4977.129002424597;5015.473375295578;5062.392512898476;4966.801327946878;4989.875253118665;4997.150484417658;5026.2711906773675;5042.924356134661;5291.4708529147165;5366.382865970424;5445;5478.91781623276;5543.473370029881;5863.941360586382;5890.1164825276555;5935.614185077956;5938.049912014057;5953.791617293417;5623.044082505943;5917.289925208959;5919.437653422918;5925.525957923399;5981.5214782817275;5375.247465354853;5440.591955603346;5449.4005659377435;5516.089845175501;5542.418046105182;6021.157038014681;6034.275886893601;6039.06394508843;6039.456448919618;6041.969790151109;5626.634268772516;5661.547076233891;5814.59297849155;5834.854128646818;5836.591438599342;5796.62321949072;5849.093390524476;5849.61977471463;5902;5915.556333274935;5772.047612144033;5826.533877289807;5830.591858569945;5837.066069428871;5872.706364681834;5615.550755939515;5721.742521586539;5750.568707346965;5834.591578589458;5839.970800146057;4463.642908567307;4466.263066593976;4473.955260447419;4503.459584849839;4508.774561271924;3949.2299001694396;3968.1865217630316;3988.2422339755353;4009.3785463253244;4025.3358195897936;5440.319960004999;5454.727263636882;5494.203340515603;5552.056150454432;5554.86112847174;5874.823755287348;5902.2622172228475;5912.526997840162;5916.3787802281;5952.464278214895;5574.247476590689;5583.972080139573;5587.776488940478;5591;5591.3569939456665;4824.155772739757;4874.731889746027;4910.8281210157475;4939.012197560431;4940.061388336205;6088.665123418255;6096.69516524172;6104.26748790148;6111.633302001894;6112.908306375408;5900.881982360243;5915.349311575637;5915.467607915309;5919.704014799329;5921.2006379138265;5832.329282132439;5951.226340575698;5991.221141251609;5993.910091348546;6025.548083893813;5714.342850572238;5732.59871808986;5739.483446489836;5750.597458177887;5755.683437410982;5596.3284405871555;5841.766329346779;5856.238688970407;5861.238039054895;5861.238039054895;5610.691411972381;5642.153676948491;5652.406497317723;5687.317521897398;5743.282089738783;5567.192757050124;5652.332561894169;5654.095344744986;5657.5473962082115;5665.546756259407;5376.489233522809;5612.522935550361;5657.60396772222;5658.745356458887;5661.518770904519;5674.092145256739;5732.742026608896;5741.712914354182;5784.971075144597;5821.301443826768;5613.410591887793;5642.040853054908;5647.830565083054;5654.3497497788285;5656.095024796013 06:40:07 INFO - PROCESS | 3378 | |1;ext.html;620.8913440147975;636.5766765101208;640.3628389752197;646.1922596754055;651.1502489251528;42639.14721705564;44327.77836110819;44462.55537444629;47847;47962.28056579145;45023.32465013027;45480.545194548045;45601.315980260326;45607.77196114023;45614.771926140405;8977.999999999984;9128.132827381422;9128.315376346767;9128.771780705501;9136.954315228415;8949.821003579924;9027.503487308195;9031.322650801183;9043.773905652346;9049.2308153807;9087.863682044775;9119.772005699844;9123.224525915306;9136.497492637902;9139.68011119611;9029.322800789934;9049.547522623843;9070;9083.046280140588;9084.31867609932;8915.68795092175;8979.910200898039;8982.28141748665;8982.640694372218;8984.820303593957;42754.35868461976;42983.35524967128;43001.1399772006;43148;43194.56805431937;3280.9343813123605;3299.554560134375;3540.8406621702084;3665.52348194733;4026.697997650188;33258.33483330344;33494;34209.48685769716;34244.82877585621;34281.828590857134;4342.717723347972;4353.586409291112;4357.586029327209;4410.713303635285;4528.773561321921;384697;385057;386775;388022;388235.0588247069;52127.21809172865;53025.469745302056;53167.73416132972;58222.70888645529;59273.40726592765;58587.414125859046;60832.695836520536;62109;62291.68854155791;68515.31484685189;13756.17462952226;13880.097793643381;13880.791788123186;13894.096883702527;13901.374438150307;10584.57661693539;10692.358458492516;10706.678799636024;10714.51784669676;10723.89276107229;18940;19004.42986710401;19225.807741922683;19253.32613358526;19279.325223617107;6021.939780602225;6983.755568555076;7059.92940070603;7090.893636595455;7383.852322953511;1018.954147063384;1117.7317443813588;1128.7686024364984;1136.2784631758893;1160.2980196980873;33419.3316133676;33583;33621;33774.32451350959;33899.83050084734;1079.8596182496226;1104.691449109921;1175.0834349207632;1190.3334132885611;1230.1020255213743;16920;17138.314467421413;17246.82753172452;17408.912955435397;17429.65140697179;674259;674355;682394;686080.1263943134;688842;57932.131018034765;58062.419375806545;58347.70826145842;58675.11987320193;58730.412695872496;1249.3565813606;1272.8345315109161;1287.658770425838;1346.5421756602802;1367.8700523450257;30350.241243969078;31673.36653266968;34486.31027379489;34577.13557161091;35157.12107197341;52242.47757522376;52693.47306527039;52837.20744188764;53208.467915320354;53229.73385133049;547189;553825;553893;557157;560000;34805.47791783176;42731.14537709291;42892.571074288855;46857.765711171225;47380.289295661285;49483.25775113304;50040.49959500504;50472.747636261585;50596.49403505918;51656.74171629118;41696.3745543811;44886.55113448824;45220;46079.80111870727;46281.768591156826;43838.34242486429;44498.11003779971;45184;45455;45503.31745023761;43869.561304386545;44052;44181.77909110434;44781.55218447904;45411.54588454205;39052.414213787386;39321.2135757289;39699.206015878946;39899.146237954505;40660.59339406568;29785;29859.402811944074;30134.246643834078;30378.54432183563;30390.392192155592 06:40:07 INFO - PROCESS | 3378 | |2;jquery.html;368.90592898810814;377.5101976780674;398.58746197685394;399.1060025542785;414.87761110472405;14921.328540215689;18472.168752406156;18946.526336841587;19944.601107977833;20028.1988720451;18039.909800451012;18425.44723658289;19340.90329548354;19425.708614370797;19458.416247512596;5515.283013208277;5862.824115276549;5901.5278777697895;5909.172715819789;5910;4233.703640745149;5805.390434004432;5828.184054232411;5874.765009399619;6295.779647712331;6528.118703974974;6635.170603674541;6646.501512386591;6647.534672572921;6658.667066646648;6293.5909165904295;6513.478921686254;6520.967395163041;6525.93474065258;6599.10912026875;4996.525330093636;5734.512566431817;5736.508507788005;5736.913946290809;5755.827325180209;13118.016148788878;13530.18818870871;13757.38091785872;13766.862331376658;13773.38019789102;2354.399628094842;2393;2512.723600403954;2608.243609353285;2728.8499132547704;9281.257499400032;9613.855792163124;9868.60525578976;10153.593856245741;14856.702865942621;1773.0159761332454;1885.1045753267088;1904.3905950095975;1922.7788804287406;1924.162989099746;80012.19987800106;88530.11469885283;88645.11354886497;89086;91246.5437672814;10655.84016239757;10695.197860160519;10780.676579702622;10917.126629869592;10982.231243813016;13499;13644.522441714493;15520.146391948325;15535.223238838013;15552.844471555365;5888.764449422061;6198.194234749544;6942.965285173542;7642.885356719654;7757.8448431031065;7227.89158162628;7367.742129025459;7418.258174182646;7480.401567874557;7480.9625951870985;4713.599344055725;4790.7844147012775;4803.447603525569;4808.591269742041;4944.53026962438;1917.88492690439;1919.2227148005081;1943.951401214981;1983.6726940055019;1984.3154111831395;893.6916763716507;942.6842007927421;987.3384832162468;1000.8598796168542;1094.7208461842338;18507.90746046261;19314.32399865998;19349.709754353695;19761.628604567544;20101.798982010285;953.2802733935835;966.8114717629994;995.8257304971746;1010.1565193063874;1059.8622179116664;10522.368657880552;10803.351798892092;10858.67423977282;10910.5090270938;10989.395583242838;557062;559954;572030;573586;574874;97613;97801;98945;99368;102044;963.9759006024765;982.2142286171178;996.865423167863;1000.7948370584013;1006.0693858181153;17467.864588801687;17586.20862061236;17833.643327133643;17850.55373615618;18259.54351141232;30746.692533074383;42088.78955605203;43575;44397.77801110974;45291.54708453005;58808;59014;60410;60509;60637.090443644265;8882.0673829247;11878.346690932081;12496.937515312366;12589.685257868627;12984.15602985803;13548.322583870964;14613.634659133606;14691.926540367229;14803.92598037003;15096.320665569856;12572.371381431074;12668.936655317033;12822.23066616006;12881.8067728986;12906;8324.916750832414;12606.684832879251;12863.807042894177;12968.481260749842;13158.14472059313;8780.560971951249;8939.106089391009;8992.82014359696;9027.09729027092;9109.498977556297;12656;12934.870651293366;13011.349432528146;13047.412866420844;13228.07403481747;6133.785317514044;7712.460127791001;12760.617181484571;12845.972322214013;12958.574556798556 06:40:07 INFO - PROCESS | 3378 | |3;mootools.html;1454.0839271259106;1496.0574837852153;1630.3886042733975;1739.3216645508246;1783.928642854285;8957.10428957104;9456.054394560557;9462.432254064752;9528.809423811537;9565.952170239148;7996.120426753053;8219.178082191778;8224.712135075273;8431.873521897176;9309.115634014757;2252.5832720946596;2327.848689835164;2329.7320808107115;2344.5662552427857;2348.178137651825;2351.8593482161136;2375.7505461926507;2381.833271670984;2395.8802059896934;2396.7243766966762;2068.9068991895324;2312.0867257433306;2348.989934328238;2355.4464700795297;2357.8938947747306;2338.286822519131;2359.7050368703913;2364.9763502364926;2367.0413482539598;2367.0650093213258;2268.5462907418582;2268.875211863347;2299.0229152610073;2299.563083014222;2301.1945818963395;9321.300902432346;9375.671851485233;9377.624895004192;9379.202767764747;9385.906140938572;4977.626677999165;5110.565601923804;5124.333836601218;5155.7679904404395;5157.896842063175;3133.7336326412283;3242.7730058895886;3306.454435018219;3311.9172020699434;3318.7013168814924;1023.8464230365505;1064.5848119233506;1071.876734175572;2207.812335951446;2240.80685023842;13143.40854661533;13207.471701131943;13257.535986240435;13273.938084953277;13289.3355332233;4262.190183865056;4381.671374646914;4515.864524064284;4520.932186017212;4555.954440455553;9920.15678667307;9931.702048938543;9954.153896918699;9971.650992215238;9975;5149.9742501287255;5156.8968620627375;5157.716325602128;5159.1487404578575;5162.070827251056;4047.838086476567;4440.62254708347;4780.95219047805;4783;4785.066911952136;3789.317922773927;3871.1870507193803;3879.728419010642;3895.474110995036;3926.941095883507;1139.7663478986788;1162.4885050577718;1166.1603645375317;1170.4615876696814;1182.4568937536596;951.3673407184145;961.5672947173799;972.6692924405736;975.9316847820727;977.0180968126987;5730.111832665943;5766.250387449605;5868.765249390062;6029.758809647565;6040.275166979991;437.10611798871383;439.29931758844594;447.19951287196204;450.38297532380847;452.7849271596031;3988.541317748496;4000;4016.49793775778;4086.5012701692135;4137.937930931039;11272.21094523392;11597.304161750322;11771.882281177079;11792.52829886795;11803.114766392555;11660.70848228784;11681.824772628417;11688.123390745728;11691.123165762601;11706.1220408468;8274.627641756135;8557.700480483154;8633.093525180017;8641.308695304486;8641.697540586176;5742.885142297214;5795.652260864362;5914.822555323347;6055.485283750931;6070.089486576872;10373.429461379395;10399.32404393712;10690.358578485315;11050.778984420427;11072.39101849406;10155.136813370946;10418.843717344398;10421.895781042396;10523.579056837641;11154.498047587716;6988.895166572607;7759.806004849924;7760.3791696663;7865.84268314619;7921.643526041226;8876.86684699717;8878.822423551623;8889.822203556021;8923.41997770143;8955.014948355805;7115.395191408788;7155.356017958408;7248.021517095125;7376.594287314249;7396.519226250277;7608.31525162738;7633.503822251536;7653.732119376018;7719.035120609924;7817.5309481431295;7206.099237595301;7224.927750722425;7256.129264488084;7266.6729997151315;7278.708851645875;4830.396200474941;5009.373828271466;5051.74741262928;5129.846104616868;5135.075686376488;5150.97424512875;5161.458046905021;5163;5311.973440132774;5328.653637513549 06:40:07 INFO - PROCESS | 3378 | |4;prototype.html;298.5596245537832;304.9130997665665;305.2475647528841;306.90792762171355;309.22847495498735;5387.89224215516;5391.595630327726;5393.164059570768;5393.73031348432;5414.729263536818;5342.679439233639;5351.785928562853;5360.517553420192;5362.8201795605;5369.382521010075;3971.404289356598;3985.3025720498795;4135.958640413603;4138.193052354792;4196.496420429553;4119.217348703752;4139.79301034947;4141.337386018237;4153.916921661565;4185.832566697329;3969.4045893115976;4100.815463304143;4104.630583247507;4115.938260926088;4151.398047283142;3989.900252493682;4027.939580906289;4030.717849750504;4063.573324800883;4076.1440097579543;3555.982220088909;3571.7678350907368;3591.5331006969186;3604.6215147409407;3605.675489205984;5167.328247327823;5208.427073021964;5212.8957420851375;5218.582513398919;5239.476052394768;4427.667924905612;4647.1402790483535;4660.464046634646;4661.370714953472;4710.152172608929;5492.890142197134;5501.669899806025;5529.391766905637;5549.112142057252;5585.357683866367;3738.2523495301048;3867.439221312922;3872.535295764498;3883.475730776337;3889.533256009297;5682.971585142089;5684.459976302244;5698.347479231018;5724.169995350692;5771.422857714237;3847.9230415391535;3862.8261728221737;3865.594112618191;3865.8840234793;3894.2600905827803;3832.616738326145;3929.4065916494974;3935.626115519021;3942.4677668514382;3942.6057394260342;4570.13167498181;4570.382998295254;4576.473705523841;4592;4628.583427491474;5528.419515950848;5549.861253468614;5556.694381809039;5569.192467092249;5575.944240557624;1341.9463221471226;1350.4463170100212;1364.3246592936362;1366.8018137370025;1369.815074964887;851.2253848997383;871.1810897756216;891.8840550728364;918.6371383303691;939.6758118449125;5323.269937270403;5342.839714808562;5369.791796845679;5370.650907690988;5376.569874410038;5637.46444087811;5656.717164141776;5673.461021202979;5689.146628005749;5691.772329106872;5202.115640341151;5226.674130012108;5318.05890849837;5334.733263336818;5392.595555333366;2998.370342228113;3013.72876441117;3021.818690878554;3030.8939187128785;3042.3154790172034;5559.722013899289;5850.561207909339;5880.470757631833;5888.146218798251;5888.852778680482;5703.401142879938;5705.229793977843;5712.200291959129;5720.342160651495;5745.195672605839;5738.713064346766;5746.367899531048;5794.493431707786;5837.416258374129;5869.589128760946;5360.571154307568;5558.9160113777425;5566.137248726453;5614.708617018027;5694;5466.945330546644;5503;5526.364468086222;5555.860993517444;5557.1664250361155;5797.217375654402;5841.386654401226;5854.092615644582;5854.443827836349;5867.383924688017;3751.480650336618;3973.4834471518516;3973.7615743055508;4008.7594744315434;4020.457238272913;5733.655980641175;5744.569157313302;5767.077267637158;5804.506616937608;5814.73833677494;5461.726913654222;5646.124850648156;5656.660600363992;5659.575531835211;5659.773609055592;5512.641678290898;5532.727472681226;5583.860403489945;5592.888142237214;5611.635243709309;5335.759890805;5427.864303392446;5501.944980550144;5507.256520369699;5515.200295957144;5613.242212301287;5628.577856660685;5629.183768353484;5635.830925072254;5636.577256705681;5491.643043202179;5499.697516636624;5517.172424136412;5517.889642207214;5583.850217666309 06:40:07 INFO - PROCESS | 3378 | |5;yui.html;751.8984937033503;770.4837758701669;786.590972694199;799.352524455191;823.6911158315631;14473.782893256597;15273.083614983108;15291.617709557268;15329;15355.3090110945;13623.25072121033;13632;13634.522791702268;13639.522616708417;14280;636.4208570201118;780.4419839814545;795.932345750612;802.9237222463886;804.3123129724089;674.5716470041534;678.396227357652;679.293534723889;751.6579956119953;794.4637369775379;828.7430896422098;829.1708291708292;829.2785276809154;829.9045609754864;830.1698301698302;823.6499487717696;826.3843436639681;827.1645637905729;827.5159031966277;829.6681327469;493.5237495816518;582.3972188784587;604.6946292122494;605.3311091244155;606.2633899811706;15170.772438413433;15212.923935380251;15225.31486083129;15262.08427494354;15277.61805954849;13753.106048106842;14339.42642294307;14476.782848257284;14503.85496145046;14681.77977330341;13579.253141077237;13617.91747589697;13754.518591849237;13801.654958626013;13944.233067181302;4445.666575006855;4471.575200355961;4472.195004899117;4637.234856248715;4656;76656.61671691661;78507.60746196233;79126.20873791246;79761.20238797595;81252.18747812565;11492.770144597062;11740.823887641693;11845.940770296093;11943.16397852142;12036.518539258332;21894.48213455441;22244.11023559072;22293.10827566879;22302.330930072123;22341.553168936854;8396.832063358821;8482.915170848337;8630.180132887366;8655.047944726075;8818.647254109892;4442.378067070613;4493.5281795411665;4524.276115821519;4546.954530454653;4636.211843986531;3304.8182349970984;3409;3413.419718647836;3416.3850506908993;3428.6057103432927;565.3442007271545;581.4534337722528;585.689584520205;592.8695686948864;601.6119602856133;584.9239598852122;593.824228028506;618.2797041446754;649.8050584824533;682.3176823176823;9233.630654773733;9579.616815327448;9895.356801807859;10005.799884002425;10205;635.5741653092439;660.4848218389664;680.5474359550942;702.8840241360118;745.7091734223657;4792.736399497991;4910.779014944336;5058.645894787403;5072.4673909239;5093.923591146136;73582.26417735755;95239;117819;120569.39715301368;121410;101165.49417252866;101765;102623.22456142146;102641;103335.4833225829;57352.42647573471;57511.42488575061;57672.71163644155;87993.56003220071;92977.53511232536;9306.162445379949;9502.809943801223;9528.52357382142;9588;9605.519724013631;42998.14003719846;45216.77391613021;46472.7676361616;47178.52821471879;53237.7338113307;48854;49570.50429495803;51187;76274;80802.59598701968;13291.468341266242;13506.662333441349;13581.932090339486;13604.591862244148;13605.523806666719;13113.27876966776;13196.20822750638;13413;13425.462981480632;14019.29903504841;14091.295435227992;14223.857761422254;14266.358013889607;14773;14821.629459263173;13870.930645347113;14052.859471405154;14161.221132837793;14394;14562.635934101732;13730.45078196901;14109.647258818612;14226.288685565887;14260.073095248776;14418.184269528367;9900.50497475109;10016.006184432721;10309.381437113798;10344.793104138025;10430.895691042992;10848.566057357933;10879.619213327496;11101.611443599435;11121.610743623934;11284.32294062359 06:40:07 INFO - PROCESS | 3378 | __end_tp_report 06:40:07 INFO - PROCESS | 3378 | __start_cc_report 06:40:07 INFO - PROCESS | 3378 | _x_x_mozilla_cycle_collect,928 06:40:07 INFO - PROCESS | 3378 | __end_cc_report 06:40:07 INFO - PROCESS | 3378 | __startTimestamp1468244407048__endTimestamp 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | ------- Summary: start ------- 06:40:07 INFO - PROCESS | 3378 | Number of tests: 6 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | [#0] dojo.html Cycles:165 Average:5428.96 Median:5623.04 stddev:619.07 (11.0%) stddev-sans-first:594.04 06:40:07 INFO - PROCESS | 3378 | Values: 3126.5 3143.6 3145.3 3171.0 3183.5 5348.5 5405.6 5434.9 5554.5 5584.4 5370.1 5405.7 5437.8 5457.4 5477.3 4921.8 4988.4 5019.5 5033.2 5149.2 5027.3 5055.9 5098.1 5120.3 5129.9 4812.3 4850.5 4910.0 4969.0 4983.9 4963.8 4972.6 4977.1 5015.5 5062.4 4966.8 4989.9 4997.2 5026.3 5042.9 5291.5 5366.4 5445.0 5478.9 5543.5 5863.9 5890.1 5935.6 5938.0 5953.8 5623.0 5917.3 5919.4 5925.5 5981.5 5375.2 5440.6 5449.4 5516.1 5542.4 6021.2 6034.3 6039.1 6039.5 6042.0 5626.6 5661.5 5814.6 5834.9 5836.6 5796.6 5849.1 5849.6 5902.0 5915.6 5772.0 5826.5 5830.6 5837.1 5872.7 5615.6 5721.7 5750.6 5834.6 5840.0 4463.6 4466.3 4474.0 4503.5 4508.8 3949.2 3968.2 3988.2 4009.4 4025.3 5440.3 5454.7 5494.2 5552.1 5554.9 5874.8 5902.3 5912.5 5916.4 5952.5 5574.2 5584.0 5587.8 5591.0 5591.4 4824.2 4874.7 4910.8 4939.0 4940.1 6088.7 6096.7 6104.3 6111.6 6112.9 5900.9 5915.3 5915.5 5919.7 5921.2 5832.3 5951.2 5991.2 5993.9 6025.5 5714.3 5732.6 5739.5 5750.6 5755.7 5596.3 5841.8 5856.2 5861.2 5861.2 5610.7 5642.2 5652.4 5687.3 5743.3 5567.2 5652.3 5654.1 5657.5 5665.5 5376.5 5612.5 5657.6 5658.7 5661.5 5674.1 5732.7 5741.7 5785.0 5821.3 5613.4 5642.0 5647.8 5654.3 5656.1 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | [#1] ext.html Cycles:180 Average:69677.60 Median:44639.83 stddev:147889.91 (331.3%) stddev-sans-first:148213.89 06:40:07 INFO - PROCESS | 3378 | Values: 620.9 636.6 640.4 646.2 651.2 42639.1 44327.8 44462.6 47847.0 47962.3 45023.3 45480.5 45601.3 45607.8 45614.8 8978.0 9128.1 9128.3 9128.8 9137.0 8949.8 9027.5 9031.3 9043.8 9049.2 9087.9 9119.8 9123.2 9136.5 9139.7 9029.3 9049.5 9070.0 9083.0 9084.3 8915.7 8979.9 8982.3 8982.6 8984.8 42754.4 42983.4 43001.1 43148.0 43194.6 3280.9 3299.6 3540.8 3665.5 4026.7 33258.3 33494.0 34209.5 34244.8 34281.8 4342.7 4353.6 4357.6 4410.7 4528.8 384697.0 385057.0 386775.0 388022.0 388235.1 52127.2 53025.5 53167.7 58222.7 59273.4 58587.4 60832.7 62109.0 62291.7 68515.3 13756.2 13880.1 13880.8 13894.1 13901.4 10584.6 10692.4 10706.7 10714.5 10723.9 18940.0 19004.4 19225.8 19253.3 19279.3 6021.9 6983.8 7059.9 7090.9 7383.9 1019.0 1117.7 1128.8 1136.3 1160.3 33419.3 33583.0 33621.0 33774.3 33899.8 1079.9 1104.7 1175.1 1190.3 1230.1 16920.0 17138.3 17246.8 17408.9 17429.7 674259.0 674355.0 682394.0 686080.1 688842.0 57932.1 58062.4 58347.7 58675.1 58730.4 1249.4 1272.8 1287.7 1346.5 1367.9 30350.2 31673.4 34486.3 34577.1 35157.1 52242.5 52693.5 52837.2 53208.5 53229.7 547189.0 553825.0 553893.0 557157.0 560000.0 34805.5 42731.1 42892.6 46857.8 47380.3 49483.3 50040.5 50472.7 50596.5 51656.7 41696.4 44886.6 45220.0 46079.8 46281.8 43838.3 44498.1 45184.0 45455.0 45503.3 43869.6 44052.0 44181.8 44781.6 45411.5 39052.4 39321.2 39699.2 39899.1 40660.6 29785.0 29859.4 30134.2 30378.5 30390.4 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | [#2] jquery.html Cycles:180 Average:31472.77 Median:15557.80 stddev:93471.76 (600.8%) stddev-sans-first:93704.80 06:40:07 INFO - PROCESS | 3378 | Values: 368.9 377.5 398.6 399.1 414.9 14921.3 18472.2 18946.5 19944.6 20028.2 18039.9 18425.4 19340.9 19425.7 19458.4 5515.3 5862.8 5901.5 5909.2 5910.0 4233.7 5805.4 5828.2 5874.8 6295.8 6528.1 6635.2 6646.5 6647.5 6658.7 6293.6 6513.5 6521.0 6525.9 6599.1 4996.5 5734.5 5736.5 5736.9 5755.8 13118.0 13530.2 13757.4 13766.9 13773.4 2354.4 2393.0 2512.7 2608.2 2728.8 9281.3 9613.9 9868.6 10153.6 14856.7 1773.0 1885.1 1904.4 1922.8 1924.2 80012.2 88530.1 88645.1 89086.0 91246.5 10655.8 10695.2 10780.7 10917.1 10982.2 13499.0 13644.5 15520.1 15535.2 15552.8 5888.8 6198.2 6943.0 7642.9 7757.8 7227.9 7367.7 7418.3 7480.4 7481.0 4713.6 4790.8 4803.4 4808.6 4944.5 1917.9 1919.2 1944.0 1983.7 1984.3 893.7 942.7 987.3 1000.9 1094.7 18507.9 19314.3 19349.7 19761.6 20101.8 953.3 966.8 995.8 1010.2 1059.9 10522.4 10803.4 10858.7 10910.5 10989.4 557062.0 559954.0 572030.0 573586.0 574874.0 97613.0 97801.0 98945.0 99368.0 102044.0 964.0 982.2 996.9 1000.8 1006.1 17467.9 17586.2 17833.6 17850.6 18259.5 30746.7 42088.8 43575.0 44397.8 45291.5 58808.0 59014.0 60410.0 60509.0 60637.1 8882.1 11878.3 12496.9 12589.7 12984.2 13548.3 14613.6 14691.9 14803.9 15096.3 12572.4 12668.9 12822.2 12881.8 12906.0 8324.9 12606.7 12863.8 12968.5 13158.1 8780.6 8939.1 8992.8 9027.1 9109.5 12656.0 12934.9 13011.3 13047.4 13228.1 6133.8 7712.5 12760.6 12846.0 12958.6 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | [#3] mootools.html Cycles:180 Average:5892.92 Median:4538.44 stddev:3497.18 (77.1%) stddev-sans-first:3491.08 06:40:07 INFO - PROCESS | 3378 | Values: 1454.1 1496.1 1630.4 1739.3 1783.9 8957.1 9456.1 9462.4 9528.8 9566.0 7996.1 8219.2 8224.7 8431.9 9309.1 2252.6 2327.8 2329.7 2344.6 2348.2 2351.9 2375.8 2381.8 2395.9 2396.7 2068.9 2312.1 2349.0 2355.4 2357.9 2338.3 2359.7 2365.0 2367.0 2367.1 2268.5 2268.9 2299.0 2299.6 2301.2 9321.3 9375.7 9377.6 9379.2 9385.9 4977.6 5110.6 5124.3 5155.8 5157.9 3133.7 3242.8 3306.5 3311.9 3318.7 1023.8 1064.6 1071.9 2207.8 2240.8 13143.4 13207.5 13257.5 13273.9 13289.3 4262.2 4381.7 4515.9 4520.9 4556.0 9920.2 9931.7 9954.2 9971.7 9975.0 5150.0 5156.9 5157.7 5159.1 5162.1 4047.8 4440.6 4781.0 4783.0 4785.1 3789.3 3871.2 3879.7 3895.5 3926.9 1139.8 1162.5 1166.2 1170.5 1182.5 951.4 961.6 972.7 975.9 977.0 5730.1 5766.3 5868.8 6029.8 6040.3 437.1 439.3 447.2 450.4 452.8 3988.5 4000.0 4016.5 4086.5 4137.9 11272.2 11597.3 11771.9 11792.5 11803.1 11660.7 11681.8 11688.1 11691.1 11706.1 8274.6 8557.7 8633.1 8641.3 8641.7 5742.9 5795.7 5914.8 6055.5 6070.1 10373.4 10399.3 10690.4 11050.8 11072.4 10155.1 10418.8 10421.9 10523.6 11154.5 6988.9 7759.8 7760.4 7865.8 7921.6 8876.9 8878.8 8889.8 8923.4 8955.0 7115.4 7155.4 7248.0 7376.6 7396.5 7608.3 7633.5 7653.7 7719.0 7817.5 7206.1 7224.9 7256.1 7266.7 7278.7 4830.4 5009.4 5051.7 5129.8 5135.1 5151.0 5161.5 5163.0 5312.0 5328.7 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | [#4] prototype.html Cycles:180 Average:4644.84 Median:5382.23 stddev:1393.57 (25.9%) stddev-sans-first:1358.76 06:40:07 INFO - PROCESS | 3378 | Values: 298.6 304.9 305.2 306.9 309.2 5387.9 5391.6 5393.2 5393.7 5414.7 5342.7 5351.8 5360.5 5362.8 5369.4 3971.4 3985.3 4136.0 4138.2 4196.5 4119.2 4139.8 4141.3 4153.9 4185.8 3969.4 4100.8 4104.6 4115.9 4151.4 3989.9 4027.9 4030.7 4063.6 4076.1 3556.0 3571.8 3591.5 3604.6 3605.7 5167.3 5208.4 5212.9 5218.6 5239.5 4427.7 4647.1 4660.5 4661.4 4710.2 5492.9 5501.7 5529.4 5549.1 5585.4 3738.3 3867.4 3872.5 3883.5 3889.5 5683.0 5684.5 5698.3 5724.2 5771.4 3847.9 3862.8 3865.6 3865.9 3894.3 3832.6 3929.4 3935.6 3942.5 3942.6 4570.1 4570.4 4576.5 4592.0 4628.6 5528.4 5549.9 5556.7 5569.2 5575.9 1341.9 1350.4 1364.3 1366.8 1369.8 851.2 871.2 891.9 918.6 939.7 5323.3 5342.8 5369.8 5370.7 5376.6 5637.5 5656.7 5673.5 5689.1 5691.8 5202.1 5226.7 5318.1 5334.7 5392.6 2998.4 3013.7 3021.8 3030.9 3042.3 5559.7 5850.6 5880.5 5888.1 5888.9 5703.4 5705.2 5712.2 5720.3 5745.2 5738.7 5746.4 5794.5 5837.4 5869.6 5360.6 5558.9 5566.1 5614.7 5694.0 5466.9 5503.0 5526.4 5555.9 5557.2 5797.2 5841.4 5854.1 5854.4 5867.4 3751.5 3973.5 3973.8 4008.8 4020.5 5733.7 5744.6 5767.1 5804.5 5814.7 5461.7 5646.1 5656.7 5659.6 5659.8 5512.6 5532.7 5583.9 5592.9 5611.6 5335.8 5427.9 5501.9 5507.3 5515.2 5613.2 5628.6 5629.2 5635.8 5636.6 5491.6 5499.7 5517.2 5517.9 5583.9 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - PROCESS | 3378 | [#5] yui.html Cycles:180 Average:19864.58 Median:24870.53 stddev:28319.39 (113.9%) stddev-sans-first:28362.47 06:40:07 INFO - PROCESS | 3378 | Values: 751.9 770.5 786.6 799.4 823.7 14473.8 15273.1 15291.6 15329.0 15355.3 13623.3 13632.0 13634.5 13639.5 14280.0 636.4 780.4 795.9 802.9 804.3 674.6 678.4 679.3 751.7 794.5 828.7 829.2 829.3 829.9 830.2 823.6 826.4 827.2 827.5 829.7 493.5 582.4 604.7 605.3 606.3 15170.8 15212.9 15225.3 15262.1 15277.6 13753.1 14339.4 14476.8 14503.9 14681.8 13579.3 13617.9 13754.5 13801.7 13944.2 4445.7 4471.6 4472.2 4637.2 4656.0 76656.6 78507.6 79126.2 79761.2 81252.2 11492.8 11740.8 11845.9 11943.2 12036.5 21894.5 22244.1 22293.1 22302.3 22341.6 8396.8 8482.9 8630.2 8655.0 8818.6 4442.4 4493.5 4524.3 4547.0 4636.2 3304.8 3409.0 3413.4 3416.4 3428.6 565.3 581.5 585.7 592.9 601.6 584.9 593.8 618.3 649.8 682.3 9233.6 9579.6 9895.4 10005.8 10205.0 635.6 660.5 680.5 702.9 745.7 4792.7 4910.8 5058.6 5072.5 5093.9 73582.3 95239.0 117819.0 120569.4 121410.0 101165.5 101765.0 102623.2 102641.0 103335.5 57352.4 57511.4 57672.7 87993.6 92977.5 9306.2 9502.8 9528.5 9588.0 9605.5 42998.1 45216.8 46472.8 47178.5 53237.7 48854.0 49570.5 51187.0 76274.0 80802.6 13291.5 13506.7 13581.9 13604.6 13605.5 13113.3 13196.2 13413.0 13425.5 14019.3 14091.3 14223.9 14266.4 14773.0 14821.6 13870.9 14052.9 14161.2 14394.0 14562.6 13730.5 14109.6 14226.3 14260.1 14418.2 9900.5 10016.0 10309.4 10344.8 10430.9 10848.6 10879.6 11101.6 11121.6 11284.3 06:40:07 INFO - PROCESS | 3378 | -------- Summary: end -------- 06:40:07 INFO - PROCESS | 3378 | 06:40:07 INFO - TEST-INFO | 3378: exit 0 06:40:07 INFO - TEST-OK | dromaeo_css | took 1115026ms 06:40:07 INFO - TEST-START | kraken 06:40:07 INFO - operating with platform_type : linux_ 06:40:07 INFO - Initialising browser for kraken test... 06:40:07 INFO - TEST-INFO | started process 3609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5qdY7q/profile http://localhost:43523/getInfo.html) 06:40:11 INFO - PROCESS | 3609 | __metrics Screen width/height:1600/1200 06:40:11 INFO - PROCESS | 3609 | colorDepth:24 06:40:11 INFO - PROCESS | 3609 | Browser inner width/height: 1024/697 06:40:11 INFO - PROCESS | 3609 | __metrics 06:40:12 INFO - PROCESS | 3609 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:40:12 INFO - PROCESS | 3609 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:40:13 INFO - TEST-INFO | 3609: exit 0 06:40:13 INFO - Browser initialized. 06:40:13 INFO - Running cycle 1/1 for kraken test... 06:40:13 INFO - TEST-INFO | started process 3694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5qdY7q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:25 INFO - PROCESS | 3694 | RSS: Main: 157409280 06:40:25 INFO - PROCESS | 3694 | 06:40:27 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43523/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:28 INFO - PROCESS | 3694 | RSS: Main: 215875584 06:40:28 INFO - PROCESS | 3694 | 06:40:31 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43523/tests/kraken/driver.html?testName=audio-dft) 06:40:31 INFO - PROCESS | 3694 | RSS: Main: 203915264 06:40:31 INFO - PROCESS | 3694 | 06:40:35 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43523/tests/kraken/driver.html?testName=audio-fft) 06:40:35 INFO - PROCESS | 3694 | RSS: Main: 269545472 06:40:35 INFO - PROCESS | 3694 | 06:40:37 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43523/tests/kraken/driver.html?testName=audio-oscillator) 06:40:38 INFO - PROCESS | 3694 | RSS: Main: 180449280 06:40:38 INFO - PROCESS | 3694 | 06:40:40 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:40:41 INFO - PROCESS | 3694 | RSS: Main: 184815616 06:40:41 INFO - PROCESS | 3694 | 06:40:44 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43523/tests/kraken/driver.html?testName=imaging-darkroom) 06:40:44 INFO - PROCESS | 3694 | RSS: Main: 219361280 06:40:44 INFO - PROCESS | 3694 | 06:40:48 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43523/tests/kraken/driver.html?testName=imaging-desaturate) 06:40:48 INFO - PROCESS | 3694 | RSS: Main: 221298688 06:40:48 INFO - PROCESS | 3694 | 06:40:51 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43523/tests/kraken/driver.html?testName=json-parse-financial) 06:40:52 INFO - PROCESS | 3694 | RSS: Main: 221523968 06:40:52 INFO - PROCESS | 3694 | 06:40:53 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:40:54 INFO - PROCESS | 3694 | RSS: Main: 207716352 06:40:54 INFO - PROCESS | 3694 | 06:40:56 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:40:56 INFO - PROCESS | 3694 | RSS: Main: 210952192 06:40:56 INFO - PROCESS | 3694 | 06:40:58 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:40:59 INFO - PROCESS | 3694 | RSS: Main: 210280448 06:40:59 INFO - PROCESS | 3694 | 06:41:01 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:02 INFO - PROCESS | 3694 | RSS: Main: 224006144 06:41:02 INFO - PROCESS | 3694 | 06:41:05 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:05 INFO - PROCESS | 3694 | RSS: Main: 225210368 06:41:05 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:43523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43523/tests/kraken/driver.html?testName=ai-astar) 06:41:07 INFO - PROCESS | 3694 | RSS: Main: 267747328 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | __start_tp_report 06:41:07 INFO - PROCESS | 3694 | _x_x_mozilla_page_load 06:41:07 INFO - PROCESS | 3694 | _x_x_mozilla_page_load_details 06:41:07 INFO - PROCESS | 3694 | |i|pagename|runs| 06:41:07 INFO - PROCESS | 3694 | |0;ai-astar;100;110;109;110;110;109;109;109;109;109 06:41:07 INFO - PROCESS | 3694 | |1;audio-beat-detection;148;119;124;173;119;120;141;117;170;121 06:41:07 INFO - PROCESS | 3694 | |2;audio-dft;161;163;160;160;159;161;161;160;161;161 06:41:07 INFO - PROCESS | 3694 | |3;audio-fft;75;75;75;130;77;75;75;74;98;74 06:41:07 INFO - PROCESS | 3694 | |4;audio-oscillator;84;85;127;84;83;84;123;84;84;135 06:41:07 INFO - PROCESS | 3694 | |5;imaging-gaussian-blur;117;116;116;116;117;116;117;116;117;117 06:41:07 INFO - PROCESS | 3694 | |6;imaging-darkroom;145;146;146;146;145;146;147;146;146;147 06:41:07 INFO - PROCESS | 3694 | |7;imaging-desaturate;95;95;96;95;94;95;95;95;95;95 06:41:07 INFO - PROCESS | 3694 | |8;json-parse-financial;53;51;51;53;54;54;53;54;52;52 06:41:07 INFO - PROCESS | 3694 | |9;json-stringify-tinderbox;61;62;62;61;61;62;62;62;61;63 06:41:07 INFO - PROCESS | 3694 | |10;stanford-crypto-aes;76;76;75;74;77;75;75;75;76;79 06:41:07 INFO - PROCESS | 3694 | |11;stanford-crypto-ccm;121;119;119;119;122;120;121;123;162;121 06:41:07 INFO - PROCESS | 3694 | |12;stanford-crypto-pbkdf2;158;156;155;158;157;155;155;155;157;155 06:41:07 INFO - PROCESS | 3694 | |13;stanford-crypto-sha256-iterative;63;66;63;62;62;63;62;63;62;64 06:41:07 INFO - PROCESS | 3694 | __end_tp_report 06:41:07 INFO - PROCESS | 3694 | __start_cc_report 06:41:07 INFO - PROCESS | 3694 | _x_x_mozilla_cycle_collect,1695 06:41:07 INFO - PROCESS | 3694 | __end_cc_report 06:41:07 INFO - PROCESS | 3694 | __startTimestamp1468244467656__endTimestamp 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | ------- Summary: start ------- 06:41:07 INFO - PROCESS | 3694 | Number of tests: 14 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:2.99 (2.7%) stddev-sans-first:0.50 06:41:07 INFO - PROCESS | 3694 | Values: 100.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:132.50 stddev:21.73 (16.4%) stddev-sans-first:22.55 06:41:07 INFO - PROCESS | 3694 | Values: 148.0 119.0 124.0 173.0 119.0 120.0 141.0 117.0 170.0 121.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 06:41:07 INFO - PROCESS | 3694 | Values: 161.0 163.0 160.0 160.0 159.0 161.0 161.0 160.0 161.0 161.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:18.11 (24.1%) stddev-sans-first:18.99 06:41:07 INFO - PROCESS | 3694 | Values: 75.0 75.0 75.0 130.0 77.0 75.0 75.0 74.0 98.0 74.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:84.00 stddev:21.61 (25.7%) stddev-sans-first:22.38 06:41:07 INFO - PROCESS | 3694 | Values: 84.0 85.0 127.0 84.0 83.0 84.0 123.0 84.0 84.0 135.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:41:07 INFO - PROCESS | 3694 | Values: 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 06:41:07 INFO - PROCESS | 3694 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 147.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:41:07 INFO - PROCESS | 3694 | Values: 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.16 (2.2%) stddev-sans-first:1.22 06:41:07 INFO - PROCESS | 3694 | Values: 53.0 51.0 51.0 53.0 54.0 54.0 53.0 54.0 52.0 52.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:41:07 INFO - PROCESS | 3694 | Values: 61.0 62.0 62.0 61.0 61.0 62.0 62.0 62.0 61.0 63.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.40 (1.8%) stddev-sans-first:1.48 06:41:07 INFO - PROCESS | 3694 | Values: 76.0 76.0 75.0 74.0 77.0 75.0 75.0 75.0 76.0 79.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:121.00 stddev:13.17 (10.9%) stddev-sans-first:13.91 06:41:07 INFO - PROCESS | 3694 | Values: 121.0 119.0 119.0 119.0 122.0 120.0 121.0 123.0 162.0 121.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.50 stddev:1.29 (0.8%) stddev-sans-first:1.17 06:41:07 INFO - PROCESS | 3694 | Values: 158.0 156.0 155.0 158.0 157.0 155.0 155.0 155.0 157.0 155.0 06:41:07 INFO - PROCESS | 3694 | 06:41:07 INFO - PROCESS | 3694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.32 06:41:07 INFO - PROCESS | 3694 | Values: 63.0 66.0 63.0 62.0 62.0 63.0 62.0 63.0 62.0 64.0 06:41:07 INFO - PROCESS | 3694 | -------- Summary: end -------- 06:41:07 INFO - PROCESS | 3694 | 06:41:08 INFO - TEST-INFO | 3694: exit 0 06:41:08 INFO - TEST-OK | kraken | took 60964ms 06:41:08 INFO - SUITE-END | took 1175s 06:41:08 INFO - Completed test suite (00:19:36) 06:41:08 INFO - javascript benchmark 06:41:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.546650735643, 3143.5913331266934, 3145.323755392591, 3170.9524357134646, 3183.506556483746, 5348.518633323, 5405.567554595633, 5434.918476222855, 5554.472325129112, 5584.441555844409, 5370.113931201347, 5405.702686352249, 5437.809676661318, 5457.426970168125, 5477.260569823073, 4921.778519966592, 4988.376452943382, 5019.498050194969, 5033.169527028036, 5149.201873709581, 5027.296178535008, 5055.898882022358, 5098.082345177866, 5120.334356533645, 5129.948700512984, 4812.302216178652, 4850.514948505156, 4909.950900490985, 4968.950310496885, 4983.8504844854715, 4963.8262660806695, 4972.552470277692, 4977.129002424597, 5015.473375295578, 5062.392512898476, 4966.801327946878, 4989.875253118665, 4997.150484417658, 5026.2711906773675, 5042.924356134661, 5291.4708529147165, 5366.382865970424, 5445.0, 5478.91781623276, 5543.473370029881, 5863.941360586382, 5890.1164825276555, 5935.614185077956, 5938.049912014057, 5953.791617293417, 5623.044082505943, 5917.289925208959, 5919.437653422918, 5925.525957923399, 5981.5214782817275, 5375.247465354853, 5440.591955603346, 5449.4005659377435, 5516.089845175501, 5542.418046105182, 6021.157038014681, 6034.275886893601, 6039.06394508843, 6039.456448919618, 6041.969790151109, 5626.634268772516, 5661.547076233891, 5814.59297849155, 5834.854128646818, 5836.591438599342, 5796.62321949072, 5849.093390524476, 5849.61977471463, 5902.0, 5915.556333274935, 5772.047612144033, 5826.533877289807, 5830.591858569945, 5837.066069428871, 5872.706364681834, 5615.550755939515, 5721.742521586539, 5750.568707346965, 5834.591578589458, 5839.970800146057, 4463.642908567307, 4466.263066593976, 4473.955260447419, 4503.459584849839, 4508.774561271924, 3949.2299001694396, 3968.1865217630316, 3988.2422339755353, 4009.3785463253244, 4025.3358195897936, 5440.319960004999, 5454.727263636882, 5494.203340515603, 5552.056150454432, 5554.86112847174, 5874.823755287348, 5902.2622172228475, 5912.526997840162, 5916.3787802281, 5952.464278214895, 5574.247476590689, 5583.972080139573, 5587.776488940478, 5591.0, 5591.3569939456665, 4824.155772739757, 4874.731889746027, 4910.8281210157475, 4939.012197560431, 4940.061388336205, 6088.665123418255, 6096.69516524172, 6104.26748790148, 6111.633302001894, 6112.908306375408, 5900.881982360243, 5915.349311575637, 5915.467607915309, 5919.704014799329, 5921.2006379138265, 5832.329282132439, 5951.226340575698, 5991.221141251609, 5993.910091348546, 6025.548083893813, 5714.342850572238, 5732.59871808986, 5739.483446489836, 5750.597458177887, 5755.683437410982, 5596.3284405871555, 5841.766329346779, 5856.238688970407, 5861.238039054895, 5861.238039054895, 5610.691411972381, 5642.153676948491, 5652.406497317723, 5687.317521897398, 5743.282089738783, 5567.192757050124, 5652.332561894169, 5654.095344744986, 5657.5473962082115, 5665.546756259407, 5376.489233522809, 5612.522935550361, 5657.60396772222, 5658.745356458887, 5661.518770904519, 5674.092145256739, 5732.742026608896, 5741.712914354182, 5784.971075144597, 5821.301443826768, 5613.410591887793, 5642.040853054908, 5647.830565083054, 5654.3497497788285, 5656.095024796013], "value": 5387.043403567557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.8913440147975, 636.5766765101208, 640.3628389752197, 646.1922596754055, 651.1502489251528, 42639.14721705564, 44327.77836110819, 44462.55537444629, 47847.0, 47962.28056579145, 45023.32465013027, 45480.545194548045, 45601.315980260326, 45607.77196114023, 45614.771926140405, 8977.999999999984, 9128.132827381422, 9128.315376346767, 9128.771780705501, 9136.954315228415, 8949.821003579924, 9027.503487308195, 9031.322650801183, 9043.773905652346, 9049.2308153807, 9087.863682044775, 9119.772005699844, 9123.224525915306, 9136.497492637902, 9139.68011119611, 9029.322800789934, 9049.547522623843, 9070.0, 9083.046280140588, 9084.31867609932, 8915.68795092175, 8979.910200898039, 8982.28141748665, 8982.640694372218, 8984.820303593957, 42754.35868461976, 42983.35524967128, 43001.1399772006, 43148.0, 43194.56805431937, 3280.9343813123605, 3299.554560134375, 3540.8406621702084, 3665.52348194733, 4026.697997650188, 33258.33483330344, 33494.0, 34209.48685769716, 34244.82877585621, 34281.828590857134, 4342.717723347972, 4353.586409291112, 4357.586029327209, 4410.713303635285, 4528.773561321921, 384697.0, 385057.0, 386775.0, 388022.0, 388235.0588247069, 52127.21809172865, 53025.469745302056, 53167.73416132972, 58222.70888645529, 59273.40726592765, 58587.414125859046, 60832.695836520536, 62109.0, 62291.68854155791, 68515.31484685189, 13756.17462952226, 13880.097793643381, 13880.791788123186, 13894.096883702527, 13901.374438150307, 10584.57661693539, 10692.358458492516, 10706.678799636024, 10714.51784669676, 10723.89276107229, 18940.0, 19004.42986710401, 19225.807741922683, 19253.32613358526, 19279.325223617107, 6021.939780602225, 6983.755568555076, 7059.92940070603, 7090.893636595455, 7383.852322953511, 1018.954147063384, 1117.7317443813588, 1128.7686024364984, 1136.2784631758893, 1160.2980196980873, 33419.3316133676, 33583.0, 33621.0, 33774.32451350959, 33899.83050084734, 1079.8596182496226, 1104.691449109921, 1175.0834349207632, 1190.3334132885611, 1230.1020255213743, 16920.0, 17138.314467421413, 17246.82753172452, 17408.912955435397, 17429.65140697179, 674259.0, 674355.0, 682394.0, 686080.1263943134, 688842.0, 57932.131018034765, 58062.419375806545, 58347.70826145842, 58675.11987320193, 58730.412695872496, 1249.3565813606, 1272.8345315109161, 1287.658770425838, 1346.5421756602802, 1367.8700523450257, 30350.241243969078, 31673.36653266968, 34486.31027379489, 34577.13557161091, 35157.12107197341, 52242.47757522376, 52693.47306527039, 52837.20744188764, 53208.467915320354, 53229.73385133049, 547189.0, 553825.0, 553893.0, 557157.0, 560000.0, 34805.47791783176, 42731.14537709291, 42892.571074288855, 46857.765711171225, 47380.289295661285, 49483.25775113304, 50040.49959500504, 50472.747636261585, 50596.49403505918, 51656.74171629118, 41696.3745543811, 44886.55113448824, 45220.0, 46079.80111870727, 46281.768591156826, 43838.34242486429, 44498.11003779971, 45184.0, 45455.0, 45503.31745023761, 43869.561304386545, 44052.0, 44181.77909110434, 44781.55218447904, 45411.54588454205, 39052.414213787386, 39321.2135757289, 39699.206015878946, 39899.146237954505, 40660.59339406568, 29785.0, 29859.402811944074, 30134.246643834078, 30378.54432183563, 30390.392192155592], "value": 21031.73560238978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.90592898810814, 377.5101976780674, 398.58746197685394, 399.1060025542785, 414.87761110472405, 14921.328540215689, 18472.168752406156, 18946.526336841587, 19944.601107977833, 20028.1988720451, 18039.909800451012, 18425.44723658289, 19340.90329548354, 19425.708614370797, 19458.416247512596, 5515.283013208277, 5862.824115276549, 5901.5278777697895, 5909.172715819789, 5910.0, 4233.703640745149, 5805.390434004432, 5828.184054232411, 5874.765009399619, 6295.779647712331, 6528.118703974974, 6635.170603674541, 6646.501512386591, 6647.534672572921, 6658.667066646648, 6293.5909165904295, 6513.478921686254, 6520.967395163041, 6525.93474065258, 6599.10912026875, 4996.525330093636, 5734.512566431817, 5736.508507788005, 5736.913946290809, 5755.827325180209, 13118.016148788878, 13530.18818870871, 13757.38091785872, 13766.862331376658, 13773.38019789102, 2354.399628094842, 2393.0, 2512.723600403954, 2608.243609353285, 2728.8499132547704, 9281.257499400032, 9613.855792163124, 9868.60525578976, 10153.593856245741, 14856.702865942621, 1773.0159761332454, 1885.1045753267088, 1904.3905950095975, 1922.7788804287406, 1924.162989099746, 80012.19987800106, 88530.11469885283, 88645.11354886497, 89086.0, 91246.5437672814, 10655.84016239757, 10695.197860160519, 10780.676579702622, 10917.126629869592, 10982.231243813016, 13499.0, 13644.522441714493, 15520.146391948325, 15535.223238838013, 15552.844471555365, 5888.764449422061, 6198.194234749544, 6942.965285173542, 7642.885356719654, 7757.8448431031065, 7227.89158162628, 7367.742129025459, 7418.258174182646, 7480.401567874557, 7480.9625951870985, 4713.599344055725, 4790.7844147012775, 4803.447603525569, 4808.591269742041, 4944.53026962438, 1917.88492690439, 1919.2227148005081, 1943.951401214981, 1983.6726940055019, 1984.3154111831395, 893.6916763716507, 942.6842007927421, 987.3384832162468, 1000.8598796168542, 1094.7208461842338, 18507.90746046261, 19314.32399865998, 19349.709754353695, 19761.628604567544, 20101.798982010285, 953.2802733935835, 966.8114717629994, 995.8257304971746, 1010.1565193063874, 1059.8622179116664, 10522.368657880552, 10803.351798892092, 10858.67423977282, 10910.5090270938, 10989.395583242838, 557062.0, 559954.0, 572030.0, 573586.0, 574874.0, 97613.0, 97801.0, 98945.0, 99368.0, 102044.0, 963.9759006024765, 982.2142286171178, 996.865423167863, 1000.7948370584013, 1006.0693858181153, 17467.864588801687, 17586.20862061236, 17833.643327133643, 17850.55373615618, 18259.54351141232, 30746.692533074383, 42088.78955605203, 43575.0, 44397.77801110974, 45291.54708453005, 58808.0, 59014.0, 60410.0, 60509.0, 60637.090443644265, 8882.0673829247, 11878.346690932081, 12496.937515312366, 12589.685257868627, 12984.15602985803, 13548.322583870964, 14613.634659133606, 14691.926540367229, 14803.92598037003, 15096.320665569856, 12572.371381431074, 12668.936655317033, 12822.23066616006, 12881.8067728986, 12906.0, 8324.916750832414, 12606.684832879251, 12863.807042894177, 12968.481260749842, 13158.14472059313, 8780.560971951249, 8939.106089391009, 8992.82014359696, 9027.09729027092, 9109.498977556297, 12656.0, 12934.870651293366, 13011.349432528146, 13047.412866420844, 13228.07403481747, 6133.785317514044, 7712.460127791001, 12760.617181484571, 12845.972322214013, 12958.574556798556], "value": 9323.83392877799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.0839271259106, 1496.0574837852153, 1630.3886042733975, 1739.3216645508246, 1783.928642854285, 8957.10428957104, 9456.054394560557, 9462.432254064752, 9528.809423811537, 9565.952170239148, 7996.120426753053, 8219.178082191778, 8224.712135075273, 8431.873521897176, 9309.115634014757, 2252.5832720946596, 2327.848689835164, 2329.7320808107115, 2344.5662552427857, 2348.178137651825, 2351.8593482161136, 2375.7505461926507, 2381.833271670984, 2395.8802059896934, 2396.7243766966762, 2068.9068991895324, 2312.0867257433306, 2348.989934328238, 2355.4464700795297, 2357.8938947747306, 2338.286822519131, 2359.7050368703913, 2364.9763502364926, 2367.0413482539598, 2367.0650093213258, 2268.5462907418582, 2268.875211863347, 2299.0229152610073, 2299.563083014222, 2301.1945818963395, 9321.300902432346, 9375.671851485233, 9377.624895004192, 9379.202767764747, 9385.906140938572, 4977.626677999165, 5110.565601923804, 5124.333836601218, 5155.7679904404395, 5157.896842063175, 3133.7336326412283, 3242.7730058895886, 3306.454435018219, 3311.9172020699434, 3318.7013168814924, 1023.8464230365505, 1064.5848119233506, 1071.876734175572, 2207.812335951446, 2240.80685023842, 13143.40854661533, 13207.471701131943, 13257.535986240435, 13273.938084953277, 13289.3355332233, 4262.190183865056, 4381.671374646914, 4515.864524064284, 4520.932186017212, 4555.954440455553, 9920.15678667307, 9931.702048938543, 9954.153896918699, 9971.650992215238, 9975.0, 5149.9742501287255, 5156.8968620627375, 5157.716325602128, 5159.1487404578575, 5162.070827251056, 4047.838086476567, 4440.62254708347, 4780.95219047805, 4783.0, 4785.066911952136, 3789.317922773927, 3871.1870507193803, 3879.728419010642, 3895.474110995036, 3926.941095883507, 1139.7663478986788, 1162.4885050577718, 1166.1603645375317, 1170.4615876696814, 1182.4568937536596, 951.3673407184145, 961.5672947173799, 972.6692924405736, 975.9316847820727, 977.0180968126987, 5730.111832665943, 5766.250387449605, 5868.765249390062, 6029.758809647565, 6040.275166979991, 437.10611798871383, 439.29931758844594, 447.19951287196204, 450.38297532380847, 452.7849271596031, 3988.541317748496, 4000.0, 4016.49793775778, 4086.5012701692135, 4137.937930931039, 11272.21094523392, 11597.304161750322, 11771.882281177079, 11792.52829886795, 11803.114766392555, 11660.70848228784, 11681.824772628417, 11688.123390745728, 11691.123165762601, 11706.1220408468, 8274.627641756135, 8557.700480483154, 8633.093525180017, 8641.308695304486, 8641.697540586176, 5742.885142297214, 5795.652260864362, 5914.822555323347, 6055.485283750931, 6070.089486576872, 10373.429461379395, 10399.32404393712, 10690.358578485315, 11050.778984420427, 11072.39101849406, 10155.136813370946, 10418.843717344398, 10421.895781042396, 10523.579056837641, 11154.498047587716, 6988.895166572607, 7759.806004849924, 7760.3791696663, 7865.84268314619, 7921.643526041226, 8876.86684699717, 8878.822423551623, 8889.822203556021, 8923.41997770143, 8955.014948355805, 7115.395191408788, 7155.356017958408, 7248.021517095125, 7376.594287314249, 7396.519226250277, 7608.31525162738, 7633.503822251536, 7653.732119376018, 7719.035120609924, 7817.5309481431295, 7206.099237595301, 7224.927750722425, 7256.129264488084, 7266.6729997151315, 7278.708851645875, 4830.396200474941, 5009.373828271466, 5051.74741262928, 5129.846104616868, 5135.075686376488, 5150.97424512875, 5161.458046905021, 5163.0, 5311.973440132774, 5328.653637513549], "value": 4604.8459544978095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.5596245537832, 304.9130997665665, 305.2475647528841, 306.90792762171355, 309.22847495498735, 5387.89224215516, 5391.595630327726, 5393.164059570768, 5393.73031348432, 5414.729263536818, 5342.679439233639, 5351.785928562853, 5360.517553420192, 5362.8201795605, 5369.382521010075, 3971.404289356598, 3985.3025720498795, 4135.958640413603, 4138.193052354792, 4196.496420429553, 4119.217348703752, 4139.79301034947, 4141.337386018237, 4153.916921661565, 4185.832566697329, 3969.4045893115976, 4100.815463304143, 4104.630583247507, 4115.938260926088, 4151.398047283142, 3989.900252493682, 4027.939580906289, 4030.717849750504, 4063.573324800883, 4076.1440097579543, 3555.982220088909, 3571.7678350907368, 3591.5331006969186, 3604.6215147409407, 3605.675489205984, 5167.328247327823, 5208.427073021964, 5212.8957420851375, 5218.582513398919, 5239.476052394768, 4427.667924905612, 4647.1402790483535, 4660.464046634646, 4661.370714953472, 4710.152172608929, 5492.890142197134, 5501.669899806025, 5529.391766905637, 5549.112142057252, 5585.357683866367, 3738.2523495301048, 3867.439221312922, 3872.535295764498, 3883.475730776337, 3889.533256009297, 5682.971585142089, 5684.459976302244, 5698.347479231018, 5724.169995350692, 5771.422857714237, 3847.9230415391535, 3862.8261728221737, 3865.594112618191, 3865.8840234793, 3894.2600905827803, 3832.616738326145, 3929.4065916494974, 3935.626115519021, 3942.4677668514382, 3942.6057394260342, 4570.13167498181, 4570.382998295254, 4576.473705523841, 4592.0, 4628.583427491474, 5528.419515950848, 5549.861253468614, 5556.694381809039, 5569.192467092249, 5575.944240557624, 1341.9463221471226, 1350.4463170100212, 1364.3246592936362, 1366.8018137370025, 1369.815074964887, 851.2253848997383, 871.1810897756216, 891.8840550728364, 918.6371383303691, 939.6758118449125, 5323.269937270403, 5342.839714808562, 5369.791796845679, 5370.650907690988, 5376.569874410038, 5637.46444087811, 5656.717164141776, 5673.461021202979, 5689.146628005749, 5691.772329106872, 5202.115640341151, 5226.674130012108, 5318.05890849837, 5334.733263336818, 5392.595555333366, 2998.370342228113, 3013.72876441117, 3021.818690878554, 3030.8939187128785, 3042.3154790172034, 5559.722013899289, 5850.561207909339, 5880.470757631833, 5888.146218798251, 5888.852778680482, 5703.401142879938, 5705.229793977843, 5712.200291959129, 5720.342160651495, 5745.195672605839, 5738.713064346766, 5746.367899531048, 5794.493431707786, 5837.416258374129, 5869.589128760946, 5360.571154307568, 5558.9160113777425, 5566.137248726453, 5614.708617018027, 5694.0, 5466.945330546644, 5503.0, 5526.364468086222, 5555.860993517444, 5557.1664250361155, 5797.217375654402, 5841.386654401226, 5854.092615644582, 5854.443827836349, 5867.383924688017, 3751.480650336618, 3973.4834471518516, 3973.7615743055508, 4008.7594744315434, 4020.457238272913, 5733.655980641175, 5744.569157313302, 5767.077267637158, 5804.506616937608, 5814.73833677494, 5461.726913654222, 5646.124850648156, 5656.660600363992, 5659.575531835211, 5659.773609055592, 5512.641678290898, 5532.727472681226, 5583.860403489945, 5592.888142237214, 5611.635243709309, 5335.759890805, 5427.864303392446, 5501.944980550144, 5507.256520369699, 5515.200295957144, 5613.242212301287, 5628.577856660685, 5629.183768353484, 5635.830925072254, 5636.577256705681, 5491.643043202179, 5499.697516636624, 5517.172424136412, 5517.889642207214, 5583.850217666309], "value": 4188.3042422891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.8984937033503, 770.4837758701669, 786.590972694199, 799.352524455191, 823.6911158315631, 14473.782893256597, 15273.083614983108, 15291.617709557268, 15329.0, 15355.3090110945, 13623.25072121033, 13632.0, 13634.522791702268, 13639.522616708417, 14280.0, 636.4208570201118, 780.4419839814545, 795.932345750612, 802.9237222463886, 804.3123129724089, 674.5716470041534, 678.396227357652, 679.293534723889, 751.6579956119953, 794.4637369775379, 828.7430896422098, 829.1708291708292, 829.2785276809154, 829.9045609754864, 830.1698301698302, 823.6499487717696, 826.3843436639681, 827.1645637905729, 827.5159031966277, 829.6681327469, 493.5237495816518, 582.3972188784587, 604.6946292122494, 605.3311091244155, 606.2633899811706, 15170.772438413433, 15212.923935380251, 15225.31486083129, 15262.08427494354, 15277.61805954849, 13753.106048106842, 14339.42642294307, 14476.782848257284, 14503.85496145046, 14681.77977330341, 13579.253141077237, 13617.91747589697, 13754.518591849237, 13801.654958626013, 13944.233067181302, 4445.666575006855, 4471.575200355961, 4472.195004899117, 4637.234856248715, 4656.0, 76656.61671691661, 78507.60746196233, 79126.20873791246, 79761.20238797595, 81252.18747812565, 11492.770144597062, 11740.823887641693, 11845.940770296093, 11943.16397852142, 12036.518539258332, 21894.48213455441, 22244.11023559072, 22293.10827566879, 22302.330930072123, 22341.553168936854, 8396.832063358821, 8482.915170848337, 8630.180132887366, 8655.047944726075, 8818.647254109892, 4442.378067070613, 4493.5281795411665, 4524.276115821519, 4546.954530454653, 4636.211843986531, 3304.8182349970984, 3409.0, 3413.419718647836, 3416.3850506908993, 3428.6057103432927, 565.3442007271545, 581.4534337722528, 585.689584520205, 592.8695686948864, 601.6119602856133, 584.9239598852122, 593.824228028506, 618.2797041446754, 649.8050584824533, 682.3176823176823, 9233.630654773733, 9579.616815327448, 9895.356801807859, 10005.799884002425, 10205.0, 635.5741653092439, 660.4848218389664, 680.5474359550942, 702.8840241360118, 745.7091734223657, 4792.736399497991, 4910.779014944336, 5058.645894787403, 5072.4673909239, 5093.923591146136, 73582.26417735755, 95239.0, 117819.0, 120569.39715301368, 121410.0, 101165.49417252866, 101765.0, 102623.22456142146, 102641.0, 103335.4833225829, 57352.42647573471, 57511.42488575061, 57672.71163644155, 87993.56003220071, 92977.53511232536, 9306.162445379949, 9502.809943801223, 9528.52357382142, 9588.0, 9605.519724013631, 42998.14003719846, 45216.77391613021, 46472.7676361616, 47178.52821471879, 53237.7338113307, 48854.0, 49570.50429495803, 51187.0, 76274.0, 80802.59598701968, 13291.468341266242, 13506.662333441349, 13581.932090339486, 13604.591862244148, 13605.523806666719, 13113.27876966776, 13196.20822750638, 13413.0, 13425.462981480632, 14019.29903504841, 14091.295435227992, 14223.857761422254, 14266.358013889607, 14773.0, 14821.629459263173, 13870.930645347113, 14052.859471405154, 14161.221132837793, 14394.0, 14562.635934101732, 13730.45078196901, 14109.647258818612, 14226.288685565887, 14260.073095248776, 14418.184269528367, 9900.50497475109, 10016.006184432721, 10309.381437113798, 10344.793104138025, 10430.895691042992, 10848.566057357933, 10879.619213327496, 11101.611443599435, 11121.610743623934, 11284.32294062359], "value": 7408.6975402804, "unit": "score"}], "name": "dromaeo_css", "value": 7296.990451247815, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 124.0, 173.0, 119.0, 120.0, 141.0, 117.0, 170.0, 121.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 160.0, 159.0, 161.0, 161.0, 160.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 130.0, 77.0, 75.0, 75.0, 74.0, 98.0, 74.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 127.0, 84.0, 83.0, 84.0, 123.0, 84.0, 84.0, 135.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 53.0, 54.0, 54.0, 53.0, 54.0, 52.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 74.0, 77.0, 75.0, 75.0, 75.0, 76.0, 79.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 119.0, 119.0, 122.0, 120.0, 121.0, 123.0, 162.0, 121.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 155.0, 158.0, 157.0, 155.0, 155.0, 155.0, 157.0, 155.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 64.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1475.8999999999999, "alertThreshold": 2.0}]} 06:41:08 INFO - Return code: 0 06:41:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:41:08 INFO - # TBPL SUCCESS # 06:41:08 INFO - Running post-action listener: _resource_record_post_action 06:41:08 INFO - ##### 06:41:08 INFO - ##### Finished run-tests step (success) 06:41:08 INFO - ##### 06:41:08 INFO - Running post-run listener: _resource_record_post_run 06:41:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 9867264; Write bytes: 431161344; Read time: 2188; Write time: 298944 06:41:09 INFO - TinderboxPrint: CPU usage
13.0% 06:41:09 INFO - TinderboxPrint: I/O read bytes / time
9,867,264 / 2,188 06:41:09 INFO - TinderboxPrint: I/O write bytes / time
431,161,344 / 298,944 06:41:09 INFO - TinderboxPrint: CPU idle
8,284.3 (87.0%) 06:41:09 INFO - TinderboxPrint: CPU user
1,194.0 (12.5%) 06:41:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:41:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 56664064; Read time: 196; Write time: 40928 06:41:09 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 7622656; Write bytes: 374497280; Read time: 1796; Write time: 258016 06:41:09 INFO - Running post-run listener: _upload_blobber_files 06:41:09 INFO - Blob upload gear active. 06:41:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:09 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 06:41:09 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:41:09 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:41:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:41:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:10 INFO - (blobuploader) - INFO - Done attempting. 06:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:11 INFO - (blobuploader) - INFO - Done attempting. 06:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:15 INFO - (blobuploader) - INFO - Done attempting. 06:41:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:15 INFO - Return code: 0 06:41:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49afcbb3cb6100b14de218c06e3c19878948c1cf97c2a474a460c6ec243a52edc9416a720086829aedcc528937ad75965e59f507545915bd385224c7a6504fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b02bc2e030e01a6519c3c6321908f7851c03bda297d14a247f66298b27613a6895554e4e475a1f8fa7829c9adc6d92686b1f2089adf49dbf7c6b2ca8f41b2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c16a75eac53c7f097331fbc6b9cca7623e8bd20fe9ebb29098260f117cacdedf79b14e1ce7156dec73d094f94059daaf6181b3dfbdbfa6eb7b0e2f4dc687b7"} 06:41:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:15 INFO - Contents: 06:41:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49afcbb3cb6100b14de218c06e3c19878948c1cf97c2a474a460c6ec243a52edc9416a720086829aedcc528937ad75965e59f507545915bd385224c7a6504fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b02bc2e030e01a6519c3c6321908f7851c03bda297d14a247f66298b27613a6895554e4e475a1f8fa7829c9adc6d92686b1f2089adf49dbf7c6b2ca8f41b2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c16a75eac53c7f097331fbc6b9cca7623e8bd20fe9ebb29098260f117cacdedf79b14e1ce7156dec73d094f94059daaf6181b3dfbdbfa6eb7b0e2f4dc687b7"} 06:41:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:15 INFO - Copying logs to upload dir... 06:41:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.663725 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-11 06:41:15.623903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:41:15.627705) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49afcbb3cb6100b14de218c06e3c19878948c1cf97c2a474a460c6ec243a52edc9416a720086829aedcc528937ad75965e59f507545915bd385224c7a6504fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b02bc2e030e01a6519c3c6321908f7851c03bda297d14a247f66298b27613a6895554e4e475a1f8fa7829c9adc6d92686b1f2089adf49dbf7c6b2ca8f41b2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c16a75eac53c7f097331fbc6b9cca7623e8bd20fe9ebb29098260f117cacdedf79b14e1ce7156dec73d094f94059daaf6181b3dfbdbfa6eb7b0e2f4dc687b7"} build_url:https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49afcbb3cb6100b14de218c06e3c19878948c1cf97c2a474a460c6ec243a52edc9416a720086829aedcc528937ad75965e59f507545915bd385224c7a6504fac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b02bc2e030e01a6519c3c6321908f7851c03bda297d14a247f66298b27613a6895554e4e475a1f8fa7829c9adc6d92686b1f2089adf49dbf7c6b2ca8f41b2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54c16a75eac53c7f097331fbc6b9cca7623e8bd20fe9ebb29098260f117cacdedf79b14e1ce7156dec73d094f94059daaf6181b3dfbdbfa6eb7b0e2f4dc687b7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:41:15.652887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:41:15.653207) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468243234.400202-542432486 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004371 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:41:15.736191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:41:15.736529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:41:15.736809) ========= ========= Total master_lag: 0.17 =========