builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1468671540.19 results: success (0) buildid: 20160716023022 builduid: 5e4f6a2e2da94ecf903ec2f7ab5a4361 revision: fb5fa9e3a52bf056d922c36f38d4ab8a55380307 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.187995) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.188466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.188740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.205085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.205497) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 05:19:01-- 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% 50.5M=0s 2016-07-16 05:19:01 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.348473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.348757) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019672 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.398041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:00.398397) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb5fa9e3a52bf056d922c36f38d4ab8a55380307 --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 fb5fa9e3a52bf056d922c36f38d4ab8a55380307 --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=97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 05:19:02,020 truncating revision to first 12 chars 2016-07-16 05:19:02,020 Setting DEBUG logging. 2016-07-16 05:19:02,020 attempt 1/10 2016-07-16 05:19:02,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb5fa9e3a52b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 05:19:02,417 unpacking tar archive at: fx-team-fb5fa9e3a52b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.722900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:01.134884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:01.135224) ========= script_repo_revision: fb5fa9e3a52bf056d922c36f38d4ab8a55380307 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:01.135613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:01.135876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 05:19:01.146665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-16 05:19:01.147070) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:19:02 INFO - MultiFileLogger online at 20160716 05:19:02 in /builds/slave/test 05:19:02 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 05:19:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:19:02 INFO - {'append_to_log': False, 05:19:02 INFO - 'base_work_dir': '/builds/slave/test', 05:19:02 INFO - 'blob_upload_branch': 'Fx-Team', 05:19:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:19:02 INFO - 'branch': 'Fx-Team', 05:19:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:02 INFO - 'config_files': ('talos/linux_config.py',), 05:19:02 INFO - 'default_actions': ('clobber', 05:19:02 INFO - 'read-buildbot-config', 05:19:02 INFO - 'download-and-extract', 05:19:02 INFO - 'populate-webroot', 05:19:02 INFO - 'create-virtualenv', 05:19:02 INFO - 'install', 05:19:02 INFO - 'run-tests'), 05:19:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:02 INFO - 'download_minidump_stackwalk': True, 05:19:02 INFO - 'download_symbols': 'ondemand', 05:19:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:19:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:19:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:19:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:19:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:02 INFO - 'installer_path': 'installer.exe', 05:19:02 INFO - 'log_level': 'info', 05:19:02 INFO - 'log_name': 'talos', 05:19:02 INFO - 'log_to_console': True, 05:19:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:19:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:19:02 INFO - 'opt_config_files': (), 05:19:02 INFO - 'pip_index': False, 05:19:02 INFO - 'sps_profile': False, 05:19:02 INFO - 'sps_profile_interval': 0, 05:19:02 INFO - 'suite': 'dromaeojs', 05:19:02 INFO - 'system_bits': '32', 05:19:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:02 INFO - 'title': 'talos-linux64-ix-068', 05:19:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:19:02 INFO - 'use_talos_json': True, 05:19:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:19:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:02 INFO - 'work_dir': 'build'} 05:19:02 INFO - ##### 05:19:02 INFO - ##### Running clobber step. 05:19:02 INFO - ##### 05:19:02 INFO - Running pre-action listener: _resource_record_pre_action 05:19:02 INFO - Running main action method: clobber 05:19:02 INFO - rmtree: /builds/slave/test/build 05:19:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:19:03 INFO - Running post-action listener: _resource_record_post_action 05:19:03 INFO - ##### 05:19:03 INFO - ##### Finished clobber step (success) 05:19:03 INFO - ##### 05:19:03 INFO - ##### 05:19:03 INFO - ##### Running read-buildbot-config step. 05:19:03 INFO - ##### 05:19:03 INFO - Running pre-action listener: _resource_record_pre_action 05:19:03 INFO - Running main action method: read_buildbot_config 05:19:03 INFO - Using buildbot properties: 05:19:03 INFO - { 05:19:03 INFO - "project": "", 05:19:03 INFO - "product": "firefox", 05:19:03 INFO - "script_repo_revision": "production", 05:19:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:19:03 INFO - "repository": "", 05:19:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:19:03 INFO - "buildid": "20160716023022", 05:19:03 INFO - "pgo_build": "True", 05:19:03 INFO - "basedir": "/builds/slave/test", 05:19:03 INFO - "buildnumber": 293, 05:19:03 INFO - "slavename": "talos-linux64-ix-068", 05:19:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:19:03 INFO - "platform": "ubuntu64_hw", 05:19:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:19:03 INFO - "branch": "fx-team", 05:19:03 INFO - "repo_path": "integration/fx-team", 05:19:03 INFO - "revision": "fb5fa9e3a52bf056d922c36f38d4ab8a55380307", 05:19:03 INFO - "stage_platform": "linux64-pgo", 05:19:03 INFO - "builduid": "5e4f6a2e2da94ecf903ec2f7ab5a4361", 05:19:03 INFO - "slavebuilddir": "test" 05:19:03 INFO - } 05:19:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:19:03 INFO - Running post-action listener: _resource_record_post_action 05:19:03 INFO - ##### 05:19:03 INFO - ##### Finished read-buildbot-config step (success) 05:19:03 INFO - ##### 05:19:03 INFO - ##### 05:19:03 INFO - ##### Running download-and-extract step. 05:19:03 INFO - ##### 05:19:03 INFO - Running pre-action listener: _resource_record_pre_action 05:19:03 INFO - Running main action method: download_and_extract 05:19:03 INFO - mkdir: /builds/slave/test/build/tests 05:19: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')]} 05:19:03 INFO - https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:09 INFO - Downloaded 1361 bytes. 05:19:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:19:09 INFO - Using the following test package requirements: 05:19:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:19:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:19:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'jsshell-linux-x86_64.zip'], 05:19:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:19:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:19:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:19:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:19:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:19:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:19:09 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')]} 05:19:09 INFO - https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:12 INFO - Downloaded 24327537 bytes. 05:19:12 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'] 05:19:12 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 05:19:13 INFO - Return code: 0 05:19:13 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 05:19:13 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')]} 05:19:13 INFO - https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:15 INFO - Downloaded 24327537 bytes. 05:19:15 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'] 05:19:15 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 05:19:16 INFO - Return code: 0 05:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:16 INFO - https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:17 INFO - Downloaded 14403317 bytes. 05:19:17 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'] 05:19:17 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 05:19:17 INFO - Return code: 0 05:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:17 INFO - https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:19:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:19:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:19:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqtKWmmJQ_unBotR7Fog0g/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 05:19:20 INFO - Downloaded 60813012 bytes. 05:19:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:19:20 INFO - mkdir: /builds/slave/test/properties 05:19:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:20 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:20 INFO - Contents: 05:19:20 INFO - build_url:https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:19:20 INFO - Running post-action listener: _resource_record_post_action 05:19:20 INFO - Running post-action listener: set_extra_try_arguments 05:19:20 INFO - ##### 05:19:20 INFO - ##### Finished download-and-extract step (success) 05:19:20 INFO - ##### 05:19:20 INFO - ##### 05:19:20 INFO - ##### Running populate-webroot step. 05:19:20 INFO - ##### 05:19:20 INFO - Running pre-action listener: _resource_record_pre_action 05:19:20 INFO - Running main action method: populate_webroot 05:19:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:20 INFO - '--tppagecycles', 05:19:20 INFO - '7'], 05:19:20 INFO - 'tests': ['tsvgm']}}, 05:19:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:19:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:19:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:19:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['damp', 'tps']}, 05:19:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'tests': ['damp', 'tps']}, 05:19:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['dromaeo_dom']}, 05:19:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['basic_compositor_video']}, 05:19:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:19:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['a11yr', 05:19:20 INFO - 'ts_paint', 05:19:20 INFO - 'tpaint', 05:19:20 INFO - 'sessionrestore', 05:19:20 INFO - 'sessionrestore_no_auto_restore', 05:19:20 INFO - 'tabpaint']}, 05:19:20 INFO - 'other-e10s': {'tests': ['a11yr', 05:19:20 INFO - 'ts_paint', 05:19:20 INFO - 'tpaint', 05:19:20 INFO - 'sessionrestore', 05:19:20 INFO - 'sessionrestore_no_auto_restore', 05:19:20 INFO - 'tabpaint']}, 05:19:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:19:20 INFO - 'ts_paint', 05:19:20 INFO - 'tpaint', 05:19:20 INFO - 'sessionrestore', 05:19:20 INFO - 'sessionrestore_no_auto_restore', 05:19:20 INFO - 'tabpaint']}, 05:19:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:19:20 INFO - 'ts_paint', 05:19:20 INFO - 'tpaint', 05:19:20 INFO - 'sessionrestore', 05:19:20 INFO - 'sessionrestore_no_auto_restore', 05:19:20 INFO - 'tabpaint']}, 05:19:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['a11yr', 05:19:20 INFO - 'ts_paint', 05:19:20 INFO - 'tpaint', 05:19:20 INFO - 'sessionrestore', 05:19:20 INFO - 'sessionrestore_no_auto_restore', 05:19:20 INFO - 'tabpaint']}, 05:19:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['a11yr', 05:19:20 INFO - 'ts_paint', 05:19:20 INFO - 'tpaint', 05:19:20 INFO - 'sessionrestore', 05:19:20 INFO - 'sessionrestore_no_auto_restore', 05:19:20 INFO - 'tabpaint']}, 05:19:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['tsvgx', 05:19:20 INFO - 'tsvgr_opacity', 05:19:20 INFO - 'tart', 05:19:20 INFO - 'tscrollx', 05:19:20 INFO - 'cart']}, 05:19:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:19:20 INFO - 'tsvgr_opacity', 05:19:20 INFO - 'tart', 05:19:20 INFO - 'tscrollx', 05:19:20 INFO - 'cart']}, 05:19:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'talos_options': ['--disable-e10s'], 05:19:20 INFO - 'tests': ['tp5o']}, 05:19:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'tests': ['tp5o']}, 05:19:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'talos_options': ['--disable-e10s', 05:19:20 INFO - '--xperf_path', 05:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:20 INFO - 'tests': ['tp5n']}, 05:19:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:20 INFO - 'talos_options': ['--xperf_path', 05:19:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:20 INFO - 'tests': ['tp5n']}}, 05:19:20 INFO - 'talos.zip': {'path': '', 05:19:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:20 INFO - Running post-action listener: _resource_record_post_action 05:19:20 INFO - ##### 05:19:20 INFO - ##### Finished populate-webroot step (success) 05:19:20 INFO - ##### 05:19:20 INFO - ##### 05:19:20 INFO - ##### Running create-virtualenv step. 05:19:20 INFO - ##### 05:19:20 INFO - Running pre-action listener: _resource_record_pre_action 05:19:20 INFO - Running main action method: create_virtualenv 05:19:20 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:20 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 05:19:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:19:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:21 INFO - Using real prefix '/usr' 05:19:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:21 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:23 INFO - Installing pip.................done. 05:19:23 INFO - Return code: 0 05:19:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:23 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 05:19:23 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 05:19:23 INFO - Using env: {'DISPLAY': ':0', 05:19:23 INFO - 'HOME': '/home/cltbld', 05:19:23 INFO - 'LANG': 'en_US.UTF-8', 05:19:23 INFO - 'LANGUAGE': 'en_US:en', 05:19:23 INFO - 'LOGNAME': 'cltbld', 05:19:23 INFO - 'MAIL': '/var/mail/cltbld', 05:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:23 INFO - 'MOZ_NO_REMOTE': '1', 05:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:23 INFO - 'NO_EM_RESTART': '1', 05:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:23 INFO - 'PWD': '/builds/slave/test', 05:19:23 INFO - 'SHELL': '/bin/bash', 05:19:23 INFO - 'SHLVL': '1', 05:19:23 INFO - 'TERM': 'linux', 05:19:23 INFO - 'TMOUT': '86400', 05:19:23 INFO - 'USER': 'cltbld', 05:19:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:23 INFO - '_': '/tools/buildbot/bin/python'} 05:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:23 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 05:19:23 INFO - Cleaning up... 05:19:23 INFO - Return code: 0 05:19:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:23 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 05:19:23 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 05:19:23 INFO - Using env: {'DISPLAY': ':0', 05:19:23 INFO - 'HOME': '/home/cltbld', 05:19:23 INFO - 'LANG': 'en_US.UTF-8', 05:19:23 INFO - 'LANGUAGE': 'en_US:en', 05:19:23 INFO - 'LOGNAME': 'cltbld', 05:19:23 INFO - 'MAIL': '/var/mail/cltbld', 05:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:23 INFO - 'MOZ_NO_REMOTE': '1', 05:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:23 INFO - 'NO_EM_RESTART': '1', 05:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:23 INFO - 'PWD': '/builds/slave/test', 05:19:23 INFO - 'SHELL': '/bin/bash', 05:19:23 INFO - 'SHLVL': '1', 05:19:23 INFO - 'TERM': 'linux', 05:19:23 INFO - 'TMOUT': '86400', 05:19:23 INFO - 'USER': 'cltbld', 05:19:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:23 INFO - '_': '/tools/buildbot/bin/python'} 05:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:23 INFO - Downloading/unpacking psutil>=3.1.1 05:19:23 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 05:19:23 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 05:19:23 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 05:19:23 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 05:19:23 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 05:19:23 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 05:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:25 INFO - Installing collected packages: psutil 05:19:25 INFO - Running setup.py install for psutil 05:19:26 INFO - building 'psutil._psutil_linux' extension 05:19:26 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 05:19:26 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 05:19:26 INFO - building 'psutil._psutil_posix' extension 05:19:26 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 05:19:26 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 05:19:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:26 INFO - Successfully installed psutil 05:19:26 INFO - Cleaning up... 05:19:26 INFO - Return code: 0 05:19:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:26 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:26 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 05:19:26 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 05:19:26 INFO - Using env: {'DISPLAY': ':0', 05:19:26 INFO - 'HOME': '/home/cltbld', 05:19:26 INFO - 'LANG': 'en_US.UTF-8', 05:19:26 INFO - 'LANGUAGE': 'en_US:en', 05:19:26 INFO - 'LOGNAME': 'cltbld', 05:19:26 INFO - 'MAIL': '/var/mail/cltbld', 05:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:26 INFO - 'MOZ_NO_REMOTE': '1', 05:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:26 INFO - 'NO_EM_RESTART': '1', 05:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:26 INFO - 'PWD': '/builds/slave/test', 05:19:26 INFO - 'SHELL': '/bin/bash', 05:19:26 INFO - 'SHLVL': '1', 05:19:26 INFO - 'TERM': 'linux', 05:19:26 INFO - 'TMOUT': '86400', 05:19:26 INFO - 'USER': 'cltbld', 05:19:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:26 INFO - '_': '/tools/buildbot/bin/python'} 05:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:19:26 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 05:19:26 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 05:19:26 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 05:19:26 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 05:19:26 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 05:19:26 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 05:19:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:19:28 INFO - Installing collected packages: mozsystemmonitor 05:19:28 INFO - Running setup.py install for mozsystemmonitor 05:19:28 INFO - Successfully installed mozsystemmonitor 05:19:28 INFO - Cleaning up... 05:19:28 INFO - Return code: 0 05:19:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:19:28 INFO - Using env: {'DISPLAY': ':0', 05:19:28 INFO - 'HOME': '/home/cltbld', 05:19:28 INFO - 'LANG': 'en_US.UTF-8', 05:19:28 INFO - 'LANGUAGE': 'en_US:en', 05:19:28 INFO - 'LOGNAME': 'cltbld', 05:19:28 INFO - 'MAIL': '/var/mail/cltbld', 05:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:28 INFO - 'MOZ_NO_REMOTE': '1', 05:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:28 INFO - 'NO_EM_RESTART': '1', 05:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:28 INFO - 'PWD': '/builds/slave/test', 05:19:28 INFO - 'SHELL': '/bin/bash', 05:19:28 INFO - 'SHLVL': '1', 05:19:28 INFO - 'TERM': 'linux', 05:19:28 INFO - 'TMOUT': '86400', 05:19:28 INFO - 'USER': 'cltbld', 05:19:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:28 INFO - '_': '/tools/buildbot/bin/python'} 05:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:29 INFO - Downloading/unpacking jsonschema==2.5.1 05:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:19:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:19:30 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 05:19:30 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 05:19:30 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 05:19:30 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 05:19:30 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 05:19:30 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 05:19:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:19:31 INFO - warning: no files found matching '*.txt' 05:19:31 INFO - no previously-included directories found matching 'build' 05:19:31 INFO - no previously-included directories found matching 'dist' 05:19:31 INFO - no previously-included directories found matching '.git*' 05:19:31 INFO - Installing collected packages: jsonschema, functools32 05:19:31 INFO - Running setup.py install for functools32 05:19:31 INFO - warning: no files found matching '*.txt' 05:19:31 INFO - no previously-included directories found matching 'build' 05:19:31 INFO - no previously-included directories found matching 'dist' 05:19:31 INFO - no previously-included directories found matching '.git*' 05:19:31 INFO - Successfully installed jsonschema functools32 05:19:31 INFO - Cleaning up... 05:19:31 INFO - Return code: 0 05:19:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:19:31 INFO - Using env: {'DISPLAY': ':0', 05:19:31 INFO - 'HOME': '/home/cltbld', 05:19:31 INFO - 'LANG': 'en_US.UTF-8', 05:19:31 INFO - 'LANGUAGE': 'en_US:en', 05:19:31 INFO - 'LOGNAME': 'cltbld', 05:19:31 INFO - 'MAIL': '/var/mail/cltbld', 05:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:31 INFO - 'MOZ_NO_REMOTE': '1', 05:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:31 INFO - 'NO_EM_RESTART': '1', 05:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:31 INFO - 'PWD': '/builds/slave/test', 05:19:31 INFO - 'SHELL': '/bin/bash', 05:19:31 INFO - 'SHLVL': '1', 05:19:31 INFO - 'TERM': 'linux', 05:19:31 INFO - 'TMOUT': '86400', 05:19:31 INFO - 'USER': 'cltbld', 05:19:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:31 INFO - '_': '/tools/buildbot/bin/python'} 05:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:19:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:19:33 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 05:19:33 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 05:19:33 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 05:19:33 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 05:19:33 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 05:19:33 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 05:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:19:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:34 INFO - Downloading docopt-0.6.1.tar.gz 05:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:19:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:19:34 INFO - Running setup.py install for blobuploader 05:19:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:19:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:19:34 INFO - Running setup.py install for requests 05:19:34 INFO - Running setup.py install for docopt 05:19:34 INFO - Successfully installed blobuploader requests docopt 05:19:34 INFO - Cleaning up... 05:19:34 INFO - Return code: 0 05:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:34 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:34 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 05:19:34 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 05:19:34 INFO - Using env: {'DISPLAY': ':0', 05:19:34 INFO - 'HOME': '/home/cltbld', 05:19:34 INFO - 'LANG': 'en_US.UTF-8', 05:19:34 INFO - 'LANGUAGE': 'en_US:en', 05:19:34 INFO - 'LOGNAME': 'cltbld', 05:19:34 INFO - 'MAIL': '/var/mail/cltbld', 05:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:34 INFO - 'MOZ_NO_REMOTE': '1', 05:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:34 INFO - 'NO_EM_RESTART': '1', 05:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:34 INFO - 'PWD': '/builds/slave/test', 05:19:34 INFO - 'SHELL': '/bin/bash', 05:19:34 INFO - 'SHLVL': '1', 05:19:34 INFO - 'TERM': 'linux', 05:19:34 INFO - 'TMOUT': '86400', 05:19:34 INFO - 'USER': 'cltbld', 05:19:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:34 INFO - '_': '/tools/buildbot/bin/python'} 05:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:35 INFO - Running setup.py (path:/tmp/pip-VUJBJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:35 INFO - Running setup.py (path:/tmp/pip-dlL8N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:35 INFO - Running setup.py (path:/tmp/pip-wjyTe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:35 INFO - Running setup.py (path:/tmp/pip-UiJjTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:35 INFO - Running setup.py (path:/tmp/pip-rKlV7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:35 INFO - Running setup.py (path:/tmp/pip-I6YwOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:35 INFO - Running setup.py (path:/tmp/pip-xWMxAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:35 INFO - Running setup.py (path:/tmp/pip-_45iTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:35 INFO - Running setup.py (path:/tmp/pip-rRn7FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:35 INFO - Running setup.py (path:/tmp/pip-vvQPtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:35 INFO - Running setup.py (path:/tmp/pip-cEvq1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:35 INFO - Running setup.py (path:/tmp/pip-4WEaPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:36 INFO - Running setup.py (path:/tmp/pip-MXhuZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:36 INFO - Running setup.py (path:/tmp/pip-_seRKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:36 INFO - Running setup.py (path:/tmp/pip-TUNQel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:36 INFO - Running setup.py (path:/tmp/pip-1wVfgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:36 INFO - Running setup.py (path:/tmp/pip-zlhxUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:19:36 INFO - Running setup.py install for manifestparser 05:19:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:19:36 INFO - Running setup.py install for mozcrash 05:19:36 INFO - Running setup.py install for mozdebug 05:19:36 INFO - Running setup.py install for mozdevice 05:19:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:19:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:19:36 INFO - Running setup.py install for mozfile 05:19:36 INFO - Running setup.py install for mozhttpd 05:19:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Running setup.py install for mozinfo 05:19:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Running setup.py install for mozInstall 05:19:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Running setup.py install for mozleak 05:19:37 INFO - Running setup.py install for mozlog 05:19:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Running setup.py install for moznetwork 05:19:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Running setup.py install for mozprocess 05:19:37 INFO - Running setup.py install for mozprofile 05:19:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Running setup.py install for mozrunner 05:19:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:19:37 INFO - Running setup.py install for mozscreenshot 05:19:37 INFO - Running setup.py install for moztest 05:19:38 INFO - Running setup.py install for mozversion 05:19:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:19:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:19:38 INFO - Cleaning up... 05:19:38 INFO - Return code: 0 05:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:38 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')]} 05:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:38 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')]} 05:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:38 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:38 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 05:19:38 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 05:19:38 INFO - Using env: {'DISPLAY': ':0', 05:19:38 INFO - 'HOME': '/home/cltbld', 05:19:38 INFO - 'LANG': 'en_US.UTF-8', 05:19:38 INFO - 'LANGUAGE': 'en_US:en', 05:19:38 INFO - 'LOGNAME': 'cltbld', 05:19:38 INFO - 'MAIL': '/var/mail/cltbld', 05:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:38 INFO - 'MOZ_NO_REMOTE': '1', 05:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:38 INFO - 'NO_EM_RESTART': '1', 05:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:38 INFO - 'PWD': '/builds/slave/test', 05:19:38 INFO - 'SHELL': '/bin/bash', 05:19:38 INFO - 'SHLVL': '1', 05:19:38 INFO - 'TERM': 'linux', 05:19:38 INFO - 'TMOUT': '86400', 05:19:38 INFO - 'USER': 'cltbld', 05:19:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:38 INFO - '_': '/tools/buildbot/bin/python'} 05:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:38 INFO - Running setup.py (path:/tmp/pip-V19roC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:38 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)) 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:38 INFO - Running setup.py (path:/tmp/pip-QSc5mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:38 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)) 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:38 INFO - Running setup.py (path:/tmp/pip-QNXKJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:38 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)) 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:38 INFO - Running setup.py (path:/tmp/pip-1teaqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:38 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)) 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:38 INFO - Running setup.py (path:/tmp/pip-IqNKvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:38 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)) 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:38 INFO - Running setup.py (path:/tmp/pip-10DDfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:38 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)) 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:38 INFO - Running setup.py (path:/tmp/pip-YF7u0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:38 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)) 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:38 INFO - Running setup.py (path:/tmp/pip-uAXvi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:39 INFO - Running setup.py (path:/tmp/pip-k9qju0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:39 INFO - Running setup.py (path:/tmp/pip-KT1Bn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:39 INFO - Running setup.py (path:/tmp/pip-0px44B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:39 INFO - Running setup.py (path:/tmp/pip-9hXIbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:39 INFO - Running setup.py (path:/tmp/pip-5c8ese-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:39 INFO - Running setup.py (path:/tmp/pip-vco2tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:39 INFO - Running setup.py (path:/tmp/pip-uSZ1ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:39 INFO - Running setup.py (path:/tmp/pip-FzcMbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:39 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)) 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:39 INFO - Running setup.py (path:/tmp/pip-spYEPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:39 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)) 05:19:39 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)) 05:19:39 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)) 05:19:39 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)) 05:19:39 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)) 05:19:39 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)) 05:19:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:41 INFO - Downloading blessings-1.6.tar.gz 05:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:41 INFO - Installing collected packages: blessings 05:19:41 INFO - Running setup.py install for blessings 05:19:41 INFO - Successfully installed blessings 05:19:41 INFO - Cleaning up... 05:19:41 INFO - Return code: 0 05:19:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:19:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:42 INFO - Reading from file tmpfile_stdout 05:19:42 INFO - Current package versions: 05:19:42 INFO - argparse == 1.2.1 05:19:42 INFO - blessings == 1.6 05:19:42 INFO - blobuploader == 1.2.4 05:19:42 INFO - docopt == 0.6.1 05:19:42 INFO - functools32 == 3.2.3-2 05:19:42 INFO - jsonschema == 2.5.1 05:19:42 INFO - manifestparser == 1.1 05:19:42 INFO - mozInstall == 1.12 05:19:42 INFO - mozcrash == 0.17 05:19:42 INFO - mozdebug == 0.1 05:19:42 INFO - mozdevice == 0.48 05:19:42 INFO - mozfile == 1.2 05:19:42 INFO - mozhttpd == 0.7 05:19:42 INFO - mozinfo == 0.9 05:19:42 INFO - mozleak == 0.1 05:19:42 INFO - mozlog == 3.2 05:19:42 INFO - moznetwork == 0.27 05:19:42 INFO - mozprocess == 0.23 05:19:42 INFO - mozprofile == 0.28 05:19:42 INFO - mozrunner == 6.12 05:19:42 INFO - mozscreenshot == 0.1 05:19:42 INFO - mozsystemmonitor == 0.3 05:19:42 INFO - moztest == 0.7 05:19:42 INFO - mozversion == 1.4 05:19:42 INFO - psutil == 3.1.1 05:19:42 INFO - requests == 1.2.3 05:19:42 INFO - wsgiref == 0.1.2 05:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:42 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:42 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 05:19:42 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 05:19:42 INFO - Using env: {'DISPLAY': ':0', 05:19:42 INFO - 'HOME': '/home/cltbld', 05:19:42 INFO - 'LANG': 'en_US.UTF-8', 05:19:42 INFO - 'LANGUAGE': 'en_US:en', 05:19:42 INFO - 'LOGNAME': 'cltbld', 05:19:42 INFO - 'MAIL': '/var/mail/cltbld', 05:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:42 INFO - 'MOZ_NO_REMOTE': '1', 05:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:42 INFO - 'NO_EM_RESTART': '1', 05:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:42 INFO - 'PWD': '/builds/slave/test', 05:19:42 INFO - 'SHELL': '/bin/bash', 05:19:42 INFO - 'SHLVL': '1', 05:19:42 INFO - 'TERM': 'linux', 05:19:42 INFO - 'TMOUT': '86400', 05:19:42 INFO - 'USER': 'cltbld', 05:19:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:42 INFO - '_': '/tools/buildbot/bin/python'} 05:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 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)) 05:19:42 INFO - Cleaning up... 05:19:42 INFO - Return code: 0 05:19:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:42 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2797180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, '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': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', '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 05:19:42 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 05:19:42 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 05:19:42 INFO - Using env: {'DISPLAY': ':0', 05:19:42 INFO - 'HOME': '/home/cltbld', 05:19:42 INFO - 'LANG': 'en_US.UTF-8', 05:19:42 INFO - 'LANGUAGE': 'en_US:en', 05:19:42 INFO - 'LOGNAME': 'cltbld', 05:19:42 INFO - 'MAIL': '/var/mail/cltbld', 05:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:42 INFO - 'MOZ_NO_REMOTE': '1', 05:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:42 INFO - 'NO_EM_RESTART': '1', 05:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:42 INFO - 'PWD': '/builds/slave/test', 05:19:42 INFO - 'SHELL': '/bin/bash', 05:19:42 INFO - 'SHLVL': '1', 05:19:42 INFO - 'TERM': 'linux', 05:19:42 INFO - 'TMOUT': '86400', 05:19:42 INFO - 'USER': 'cltbld', 05:19:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:42 INFO - '_': '/tools/buildbot/bin/python'} 05:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:19:42 INFO - Cleaning up... 05:19:42 INFO - Return code: 0 05:19:42 INFO - Running post-action listener: _resource_record_post_action 05:19:42 INFO - Running post-action listener: _start_resource_monitoring 05:19:42 INFO - Starting resource monitoring. 05:19:42 INFO - ##### 05:19:42 INFO - ##### Finished create-virtualenv step (success) 05:19:42 INFO - ##### 05:19:42 INFO - ##### 05:19:42 INFO - ##### Running install step. 05:19:42 INFO - ##### 05:19:42 INFO - Running pre-action listener: _resource_record_pre_action 05:19:42 INFO - Running main action method: install 05:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:42 INFO - Reading from file tmpfile_stdout 05:19:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:19:42 INFO - Reading from file tmpfile_stdout 05:19:42 INFO - Output received: 05:19:42 INFO - Usage: mozinstall [options] installer 05:19:42 INFO - Options: 05:19:42 INFO - -h, --help show this help message and exit 05:19:42 INFO - -d DEST, --destination=DEST 05:19:42 INFO - Directory to install application into. [default: 05:19:42 INFO - "/builds/slave/test"] 05:19:42 INFO - --app=APP Application being installed. [default: firefox] 05:19:42 INFO - mkdir: /builds/slave/test/build/application 05:19:42 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'] 05:19:42 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 05:20:00 INFO - Reading from file tmpfile_stdout 05:20:00 INFO - Output received: 05:20:00 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:00 INFO - Running post-action listener: _resource_record_post_action 05:20:00 INFO - ##### 05:20:00 INFO - ##### Finished install step (success) 05:20:00 INFO - ##### 05:20:00 INFO - ##### 05:20:00 INFO - ##### Running run-tests step. 05:20:00 INFO - ##### 05:20:00 INFO - Running pre-action listener: _resource_record_pre_action 05:20:00 INFO - Running main action method: run_tests 05:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:00 INFO - Python 2.7.3 05:20:00 INFO - Return code: 0 05:20:00 INFO - grabbing minidump binary from tooltool 05:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:00 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 0x27953b0>, '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 0x27962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2796740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:00 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 05:20:00 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 05:20:00 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 05:20:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:00 INFO - Return code: 0 05:20:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:00 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/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:20:00 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/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 05:20:00 INFO - Using env: {'DISPLAY': ':0', 05:20:00 INFO - 'HOME': '/home/cltbld', 05:20:00 INFO - 'LANG': 'en_US.UTF-8', 05:20:00 INFO - 'LANGUAGE': 'en_US:en', 05:20:00 INFO - 'LOGNAME': 'cltbld', 05:20:00 INFO - 'MAIL': '/var/mail/cltbld', 05:20:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:00 INFO - 'MOZ_NO_REMOTE': '1', 05:20:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:00 INFO - 'NO_EM_RESTART': '1', 05:20:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:00 INFO - 'PWD': '/builds/slave/test', 05:20:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:00 INFO - 'SHELL': '/bin/bash', 05:20:00 INFO - 'SHLVL': '1', 05:20:00 INFO - 'TERM': 'linux', 05:20:00 INFO - 'TMOUT': '86400', 05:20:00 INFO - 'USER': 'cltbld', 05:20:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524', 05:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:00 INFO - '_': '/tools/buildbot/bin/python'} 05:20:00 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/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:20:00 INFO - mozversion application_buildid: 20160716023022 05:20:00 INFO - mozversion application_changeset: fb5fa9e3a52bf056d922c36f38d4ab8a55380307 05:20:00 INFO - mozversion application_display_name: Nightly 05:20:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:00 INFO - mozversion application_name: Firefox 05:20:00 INFO - mozversion application_remotingname: firefox 05:20:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:20:00 INFO - mozversion application_vendor: Mozilla 05:20:00 INFO - mozversion application_version: 50.0a1 05:20:00 INFO - mozversion platform_buildid: 20160716023022 05:20:00 INFO - mozversion platform_changeset: fb5fa9e3a52bf056d922c36f38d4ab8a55380307 05:20:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:20:00 INFO - mozversion platform_version: 50.0a1 05:20:00 INFO - using testdate: 1468671600 05:20:00 INFO - actual date: 1468671600 05:20:00 INFO - starting webserver on 'localhost:35770' 05:20:00 INFO - SUITE-START | Running 2 tests 05:20:00 INFO - TEST-START | dromaeo_css 05:20:00 INFO - operating with platform_type : linux_ 05:20:00 INFO - Initialising browser for dromaeo_css test... 05:20:00 INFO - TEST-INFO | started process 9925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprvJ63d/profile http://localhost:35770/getInfo.html) 05:20:04 INFO - PROCESS | 9925 | __metrics Screen width/height:1600/1200 05:20:04 INFO - PROCESS | 9925 | colorDepth:24 05:20:04 INFO - PROCESS | 9925 | Browser inner width/height: 1024/697 05:20:04 INFO - PROCESS | 9925 | __metrics 05:20:05 INFO - PROCESS | 9925 | 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" 05:20:05 INFO - PROCESS | 9925 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:06 INFO - TEST-INFO | 9925: exit 0 05:20:06 INFO - Browser initialized. 05:20:06 INFO - Running cycle 1/1 for dromaeo_css test... 05:20:06 INFO - TEST-INFO | started process 10006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprvJ63d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:17 INFO - PROCESS | 10006 | RSS: Main: 157290496 05:20:17 INFO - PROCESS | 10006 | 05:21:09 INFO - PROCESS | 10006 | 1468671669134 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] 05:23:16 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:35770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35770/tests/dromaeo/cssquery-ext.html) 05:23:17 INFO - PROCESS | 10006 | RSS: Main: 289767424 05:23:17 INFO - PROCESS | 10006 | 05:26:20 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:35770/tests/dromaeo/cssquery-ext.html (next: http://localhost:35770/tests/dromaeo/cssquery-jquery.html) 05:26:21 INFO - PROCESS | 10006 | RSS: Main: 241704960 05:26:21 INFO - PROCESS | 10006 | 05:29:23 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:35770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35770/tests/dromaeo/cssquery-mootools.html) 05:29:23 INFO - PROCESS | 10006 | RSS: Main: 242733056 05:29:23 INFO - PROCESS | 10006 | 05:32:25 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:35770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35770/tests/dromaeo/cssquery-prototype.html) 05:32:26 INFO - PROCESS | 10006 | RSS: Main: 239681536 05:32:26 INFO - PROCESS | 10006 | 05:35:28 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:35770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35770/tests/dromaeo/cssquery-yui.html) 05:35:29 INFO - PROCESS | 10006 | RSS: Main: 224841728 05:35:29 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:35770/tests/dromaeo/cssquery-yui.html (next: http://localhost:35770/tests/dromaeo/cssquery-dojo.html) 05:38:32 INFO - PROCESS | 10006 | RSS: Main: 276508672 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | __start_tp_report 05:38:32 INFO - PROCESS | 10006 | _x_x_mozilla_page_load 05:38:32 INFO - PROCESS | 10006 | _x_x_mozilla_page_load_details 05:38:32 INFO - PROCESS | 10006 | |i|pagename|runs| 05:38:32 INFO - PROCESS | 10006 | |0;dojo.html;2953.862762836306;2959.4525012872605;2961.511350627147;3000.2349400902767;3004.879804807808;5077.4160971488245;5083.135866902626;5132.871678208037;5153.742312884355;5203.245529398239;5114.411842638097;5126.71803050832;5126.7436628168625;5156.664816786906;5157.73635459312;4586.174488592061;4702.27114797207;4713.505081966396;4734.313524538939;4847.636427267951;4768.308595253686;4820.903581928359;4832.106060378824;4832.540908613676;4843.346148269974;4607.9308810367875;4633.791479383436;4653.302004699289;4670.8365207217585;4775.3075804008395;4665.2768820832825;4682.6019788318035;4684.578387945067;4743.0988112258565;4788.736619485927;4702.247640377524;4711.10489007091;4730.645201609893;4732.124556956974;4775.2359622460235;5059.747012649353;5101.69389836611;5167.586593072545;5172.844814655567;5202.297689811902;5536.252605898192;5554.389017208104;5557.472040156179;5580.748866301026;5590.608657393984;5580.888382232332;5617.269754931874;5621.18492818539;5630.634008789416;5633.690147041911;5043.646944713872;5085.79656813727;5125.871853203663;5134;5182;5601.103823388238;5632.211490391349;5653.9151912721345;5663.122216056518;5667.688277144714;5432.022235997559;5436.456354364611;5439.5920305976415;5442.455754424526;5442.8911421771345;5321.707306098202;5389.245505629215;5475.534579560703;5480.698561579152;5561.860953476114;5441.347038355423;5443.074677304868;5443.482869127427;5470.316210473691;5517.889642207133;5350.892982140335;5453.727313634303;5460.863478413072;5464.316960379952;5464.3442786865835;4170.83316667336;4181.247375472444;4186.267403204488;4186.748795072244;4213.599708027732;3738.8691395801015;3745.138618117848;3748.83130259139;3773.4528493368307;3779.149691319486;5073.695578265316;5175.223716442564;5185.118529849935;5185.974070129625;5229.581633469314;5475.945240547543;5526.58550608706;5528.861778455571;5531.087370583889;5545.528630066409;5244.790208391698;5251.553617942442;5257.973710131425;5260.2109683547005;5312.574994000471;4668.673192876534;4763.476017638057;4807.927881081787;4809.350737650442;4813.566778989908;5675.091985282335;5744.080947048452;5767.826965191051;5770.913436298459;5818.7672493100645;5559.388467268678;5574.637648552994;5578.107502799533;5579.218909352775;5579.944200558105;5617.354004289559;5620.213170156099;5652.039153343859;5747.626404283708;5764.394738552392;5449.100898351728;5453.64551304164;5456.181572764117;5461.044317244546;5473.507384335429;5477.370102438112;5483.341998960151;5487.972560137334;5491.670499770026;5548.750306236148;5260.868478288074;5275.577953763613;5299.629025968299;5320.893582128413;5360.195970604284;5310.9734451327495;5313.2561441397465;5317.548008419328;5322.600804939568;5329.440408757025;5255.868603284948;5256.658317209369;5272.604554658493;5275.076861549137;5283.682979021271;5266.55234305073;5281.498257665516;5316.946830531645;5365.034293826992;5371.140617501181;5235.738213089407;5246.029484545371;5259.368875734936;5260.368755749335;5300.390455097713 05:38:32 INFO - PROCESS | 10006 | |1;ext.html;560.2324815003443;604.3050491934276;606.7773436525403;607.1954660075402;613.441767991128;44193;45014.32478512821;45045.32432013514;45194.0961180777;45260.77369613152;45848;46409.30386044212;46476;46487;46494.535054649445;8233.300169485601;9013.909860901373;9177.632894684204;10658.360498370123;10873.401962892038;10598.364098154098;10762.192835537327;10769.461526923662;10769.515371808247;10780.51487683056;10877.184211184152;10938.124950003981;10953.561857525689;10954.287971281841;10958.178136639784;10798.946005269963;11050.668479945614;11051.557937682483;11056.226064175511;11068.114550835953;10974.615888443946;11035.503402346914;11036.834447483294;11037.227394082418;11042.558297668083;43843;43907.12185756299;43978.780106099584;44080.77959610213;44150.55849441497;3705.4441833724886;3776.981115094407;4043.1711499142607;4096.877093687194;4124.422580838685;34640.307193856235;34759.30481390384;34842.47736283958;35007.64992350069;35535.28929421423;4431.158079964828;4437.977810110929;4546.8863278417975;4567.543245675439;4655.185342565072;378793;381168;381436.9999999972;381809;381881;65101.67449162724;65209;65573;65642.67178664076;65662;67778.3222167772;68203.61287355018;68405.60580379663;68425.3157468419;68534.65732671304;15243.61890952713;15681;15754.212289385485;15754.448594299145;15756.606084847741;11355.375454349925;11556.422178891022;12312.507499699912;12621.81067283973;12628.81056784149;8430.873536896952;8570.057293697688;8654.740357789276;17355.09734003663;19465.805341946398;7706.537607743553;7815.29662330393;7944.721934732257;8094.433389662785;8124.63439145228;1014.4167103915131;1062.86182796236;1064.2816099133054;1103.8675358956978;1167.9532818687157;33130.66869331324;33275.690353141494;33447;33681.32637347288;33814.15464613404;1138.6413279816998;1142.4230763464398;1143.0224265787504;1176.3412489006014;1253.6803115205564;17769.28922843098;17881.28474861017;17952.281908723766;17972.460826175236;17997;527355;544779;547575;549639;550894;61827;62231.68884155641;62272.68863655653;62301.68849155725;62316.37683623196;1225.914186006971;1320.5114107780182;1390.318743815523;1391.2000599655037;1393.6933874547583;32998.83500582482;34147.65852341445;35009.474857876645;35012.47481287732;35047.64952350546;52904.73547632237;53423.19865201948;53621.65945851385;53662.73168634288;53747.19379209393;410115;421173;421454;421626;422072;25531.23406297814;28110.71889281081;28619.713802862538;28720.138395848157;30837.845810770803;49133.75433122811;49309.75345123395;49616;50822;51028.23457648064;40747.59252407557;43208.35187472127;43314.35028474638;44613.33080003737;44914.55085449234;44812.77593612011;44826.77586612046;45373.773131134134;45647.77176114098;45811.31283030824;43076;43394;43915.12169756651;44461.55538444574;44588.55411445844;38662.80668596639;39101.80449097736;39270.214595708494;39384.6061539381;39820.40269396019;29415.411691766472;29465.85267073651;29690.55464167996;29844.70155298506;29963.55054674138 05:38:32 INFO - PROCESS | 10006 | |2;jquery.html;375.5474653043083;380.9580946095929;383.84262452394523;392;396.2550405238152;15915.44295949642;16067.919660401682;18425.73538914238;20490.2828401006;20977.58044839102;18280.908595457004;19045.0477476126;19251.711224331648;20643;20683.379498615028;5164.561012313958;5268.841934741964;5269.947300527003;5282.788688452477;5309.681419114865;3880.5731369549326;5193.974030129844;6314.810555683337;6589.04458853466;6599.10912026875;5898.233229680136;6601.70292336846;6641.037049627801;6652.733890644393;6654.600723956554;5895.705214739246;5899.351071382144;5913.379095195007;5922.703864806743;5934.821955341346;5514.117741161435;5713.457221563945;5720.6281591696825;5737.340205876336;5739.856503587402;13582.098506209139;13596.796048059286;13678.110922789987;13727.107737997098;21601.78398216029;2308.7806658367426;2372.4780548279523;2416.879156042191;2460.766227208412;2494.8503089814667;9794;10028.949855250678;10093.495325233709;11092.112630989583;15119.244037798066;1918.213532451688;1939.0789375046882;1952.2483843720129;1955.8728682635726;2016.0726066009506;81984.59007704923;82695.5865220676;85507;85926.14073859244;87380.12619873784;10602.787944241227;10740.624078157383;10949;11217.383043932661;11583.76832463363;15775.132367719885;15833.52499425019;15857.207139642971;15872.365105395655;15899.364025439085;7739.148693643695;7985.361171106298;8050.597470126588;8052.355811535063;8109.229623185788;7489.925100749032;7495.587742674096;7560.3573696236435;7638.083429988325;7668.463207575416;4839.2983017462275;4853.95146048542;4873.366462359871;4886.975565122151;4969.378827646544;1888.6317168152352;1917.1564511614845;1920.4622705642441;1940.146335612326;1977.3079422202402;961.9230461563059;997.7006897930592;1003.4330603209163;1012.2104758288547;1058.7564860082225;19705.50736231577;20068.498287542636;20297.49256268605;20800.58398832045;20905.790942090385;1024.1192574386023;1030.9175265978704;1041.099448976645;1042.2131290875493;1075.7902209069314;11103.944480277547;11322.94338528302;11476.88523114775;11570.19008669402;11585.478653460614;475465;485440;486603;501490;501815;76536;89472.5526372377;99726.5013674927;102628;103268;1006.3408467453829;1030.2891005206534;1038.2368958815416;1042.5725452564564;1050.7740835720203;18642.533936651693;18698.252069917053;19075.809241907402;19265.325713599956;19282.7107593389;44610.55389446064;44894.551054489035;44971.77514112408;45664.771676141405;46332.073358533315;64401.677991609744;65221.673891632134;65295.67352163209;66412.33587664062;66723.66638166973;8202.26179643835;8235.547044912588;8299.211574900375;8348.749537513884;8355.58222088881;12659.620211393672;13119.081664283409;13283.535076272285;13312.733745325233;13339.933300333436;11558;11772.411379430823;12020;12031.398430078287;12046.578369757017;11286.322820630789;11366;11444.656660300205;11621.360825154698;11891.048716102518;11684.824727629262;11796.587119450778;11805.82291265649;11814.46834892449;11922.52309907594;7495.213002634645;7603.429742769204;7663.731769388268;8161.061477929877;8261.710840120568;8289.046759622479;10955.287906286067;11594.130440216848;11854.348010859141;11918.582849600223 05:38:32 INFO - PROCESS | 10006 | |3;mootools.html;1400.6848459096702;1485.1757274712534;1622.9837701622987;1749.0555100245867;1760.1991094052207;8091.959540202298;8441.873371899426;8530.91469085309;8533.871991920118;8611.44025638334;7138.821529461766;7262.709491620329;7265.273472652732;7471.850562988737;8756.299496040318;2152.8923553822287;2213.9889300553555;2219.9778002220014;2227.24273746926;2229.9888500557477;2257.9435514112115;2262.3891549281684;2278.3734473019886;2301.9424514387106;2321.9535609287805;1938.3603410874448;2239.1267405711787;2287.656851472276;2302.3323236261463;2303.9193628223015;2250.5273892482514;2269.988650056739;2272.47733021406;2273.27255278311;2274.2494976657663;2217.7449593296815;2245.786650268222;2247.4156719252946;2254.537819746948;2255.9661605075935;8400.537970411626;8483;8513.74458766238;8514.74455766328;8537.274331681814;4889.975550122263;4972.378452693413;5003.699778013331;5004.074246264453;5009.549140577329;3190.96809031909;3241.6272128705264;3290.7038366547126;3303.620083690382;3314.5691060162267;1028.9897101028969;1031.417249254169;1032.8140934631838;1043.8621902126717;1066.0938202527789;11450.770984580346;11466.48400821965;11469.31184128955;11471.082313414907;11475.368854712904;4243.321068629005;4313.590208930209;4447.066116115652;4457.041736026705;4476.888077798016;9189.081091890892;9266.07339266068;9304;9317.39436936597;9335.393199442015;5094.312267843868;5096.847094587169;5097.337346144977;5101.260317254051;5102.540771330598;4676.345311656303;4708.764561771898;4747.572718455286;4762.666613337033;4806.279058141306;3528.3825330567047;3572.69632081276;3645.179834537208;3658.3049220648522;3693.686036686858;1053.6364954090827;1055.8627378440754;1070.277562645227;1078.8219943709357;1111.4442778610694;851.3657325292572;876.8553188723789;908.0828363353061;916.9220616247694;921.2998121427763;5335.359756829128;5421.701806400607;5480.808171713971;5510.834674959758;5552.194931734956;442.47124686000564;445.8016182798688;456.78759376889906;458.6514249170654;990.3463713948903;3697.3159965406485;3724.4599533067553;3756.4928734620476;3766;3898.8440462381186;9779.41323520591;10052.59789608422;10182.694519164437;10198.490075496196;10391.948040259751;10201.540930658139;10262.025107614765;10283.43441110746;10287.845682314772;10332.276740628084;7666.693332266758;7930.1276859545405;7953.840923181504;8173.019237691634;8175.468594541336;5529.668219906657;5708.143778433268;5766.913496297643;5899.705014749159;5906.084556893688;9598.472084035446;9714.077162669535;9725;9725.902740972782;9750.219982401533;8361.95819020901;9463.242940564876;9735.075167859042;9767.511624418892;10011.399316041061;6967.895481567882;7553.773386798405;7586.696532138873;7778.766637000899;7784.610769461618;8285.212904774036;8390.496570205807;8403.579821009047;8404.32765378756;8468.618912149092;7404.074490688664;7626.847463050819;7630.389568834369;7710.267524585155;7735.342495887688;7322.267773222635;7474.215207403362;7491.475596708178;7574.924250757643;7600.391968642385;6998.825029374307;7026.3676269133975;7057.188423331178;7059.541129826544;7069.646517673993;4727.078219747116;4809.591184749335;4809.78355973975;4893.339399181065;4925.039617274597;4820.927686084641;4882.754897501114;4987.825426110068;5021;5113.64204505681 05:38:32 INFO - PROCESS | 10006 | |4;prototype.html;318.2346456771465;324.485690181063;327.5806967082134;331.19684764446197;332.7953308715138;5365.256291705192;5402.460298814834;5420.105682562377;5443.319585051869;5451;5285.709285989269;5319.787208511664;5373.892522149555;5398.217258497515;5410.729463526818;4037.7173597848164;4109;4175.937360939588;4244.660427165819;4254.085371645096;4203.726757760751;4208.663306935453;4231.386448964899;4233.343831706075;4241.2365774160635;4014.518257809067;4211.747295162285;4226.492820861486;4229.725067870594;4240.5759424057505;3948.3485224937995;4117.197146556423;4144.79276036197;4149.896252593694;4178.91642167158;3654.5614526256754;3655.1227705350525;3663.4138537834087;3675.9264814703824;3678.0988657779017;5230.424653288135;5266.920281342315;5272.894542109175;5281.0758117329315;5294.49702278283;4532.365468834366;4750.334953106568;4756.9286460703115;4781.115493633689;4793.54461326177;5539.861503462405;5553.694546799924;5572.693501857396;5639.943600564024;5659.915101273484;3921.254961557295;4007.338789099795;4010.979945100256;4059.4722686050623;4064.6341829235216;5768.3654797972185;5789.392113828072;5789.507891829199;5793.652380857162;5801.448862358111;4190.308599081179;4206.85276015338;4207.0954744729415;4234.872953811329;4244.342126970325;4134.813933373005;4152.8338866445;4156.729812562235;4292.377605247284;4297.09760950204;4741.596964258008;4742.288656701453;4751.714897106184;4766.809327626926;4787.16224660683;5651.378348381675;5651.660900345993;5679.592244653175;5686.346070201897;5713.457221563945;1437.7627691431005;1466.30350583472;1474.3439169569438;1478.8816894648403;1479.9038062525901;906.5421961909194;950.8906475755239;964.8951950017191;973.255459573427;1010.3584224017802;5371.979323928441;5374.435684253097;5380.309845077461;5382.2464854920345;5407.944511351074;5649.954758369715;5650.97174514133;5666.914996275059;5677.069796269206;5679.8864022720145;5157.690538567698;5329.9467005330225;5380.515753582196;5414.023881283303;5445.37378201504;3013.081010291882;3014.231371000381;3029.257831831171;3039.3465404938042;3041.7870749047797;5736.942630573724;5901.409859014064;5901.439363260483;5945.64326140433;5947.345791962881;5840.88318233633;5845.503132233808;5852.151438041546;5877.353491115974;5878.911816322759;5839.788116535889;5888.410129265075;5907.911381329283;5934.495567876606;5944.346121926585;5495;5671.914921276101;5732.684702341245;5802;5808.912866306924;5760.1359796029255;5771.3651498335985;5780.855478613068;5795.710214489343;5800.854978625568;5775.361522241129;5962.135490353961;6096.634201947897;6104.511639068953;6128.927437698474;4087.16077765001;4087.448194493705;4096.177201145461;4107.254416872876;4118.755278373354;5814;5841.153032810304;5841.766329346779;5852.356240813422;5874.911876321773;5486.451354864482;5626.352969408406;5638.971805141112;5711.286089238845;5712.457316554921;5608.9158662619275;5611.410801865909;5646.491815736604;5649.2373529574625;5699.943000569941;5356.705381204071;5433.782648694166;5593;5601.327840659147;5643.379228284967;5696.515796157373;5711.5145212655725;5735.827925162252;5763.94236057634;5773.451522105393;5566.332040155207;5577.135543990688;5578.693171875586;5579.804706835242;5589.944100558942 05:38:32 INFO - PROCESS | 10006 | |5;yui.html;794.9960250198752;831.2643310670055;835.8787975743518;837.2924878477684;851.9659213631455;15406.3837446502;17031;17033.659326813457;17053.65892682147;17057.658846823055;15196.620084497894;15334.386624535033;15500.224988750546;15515.224238788072;15546.222688865568;675.8513127112052;787.7439832054577;793.4128744728916;819.1849110135423;822.880682301066;818.145038434837;820.7619790260848;823.9876401853977;824.8226631274275;825;871.6644092024585;872.4939535069644;872.707642939616;872.7512658892217;873;706.883364244899;843.1863251961855;855.9871601925945;858.3390789092364;872.0886673426285;622.9626222426668;623.5728525959732;626.764963138823;626.9467095296906;628.0986783964979;14587.270636468134;14665.48670796517;14682.265886705729;14723.705525889422;14795.260236988215;15392.076475411512;15964.201789910458;16139.950903191255;16230.756538651929;16390.590235244093;12208.267503949792;12256.203346782431;12261.325627090595;12760.29818359999;13223.404946777418;4810.85567432974;4828.73441960692;4856.344393506866;4859.927101093486;5015.824446144367;72273.6386318065;75394;75453;78469.60765196195;79352.60323698402;12220.816687749691;12450.626481205578;12853.807192892114;12989.41547630359;13239.20564766117;23680.28959131229;23693.289201323987;23725.05099795989;23750.524989500114;23757.168499102794;9319.394239374418;9518.854883541191;9532.094451027142;9689.467079310565;9690.12788848993;4964.851054468371;4973.825916092919;4991.251312303184;5011.298418221452;5187.118189907725;3462.515247865301;3507.982460087683;3531.2760884019226;3556.128748456593;3557.0751604582993;573.8369907196677;574.45713800459;612.8253447767365;635.640862912453;652.6312633362135;638.3903372279462;717.3400471566172;729.7701224114387;741.1698897235132;796.8366484870587;10065.69802905914;10173.54219060144;10205.540750666238;10211.380164628852;10280.691579252634;655.1430213887828;694.4340362604461;717.9317964793337;728.9088863892014;773.6557232031804;4726.125666751594;4901.264810278487;4935.580475659537;4942.233953737176;4965.90068198634;112245.43877280725;114112.42943785228;114117;116487.41756291164;118105.4094729538;82338;94679.52660236793;98444.61665375126;100600.496997516;101073;87300;88900.5554972234;89424.10575894288;91173.54413228024;91447.54276228577;9708.641188536743;9789.853152202864;9807.7979132346;9815.570801125274;9819.054283715;51316.74341628268;52158.95682086413;52349;52431.47568524266;53480;73278;75564;75587.62206188934;75897.62051189708;77616.61191694005;12138.089643276966;12231.574135720688;12650.430730617329;12968.610941671765;13173.47306107745;14397.352119154873;14805.259737013323;14826.481073162387;14827.92586037063;14857.554273371816;13588.59234222975;13673.794893076412;13684;13717.17696938187;13756.105853119516;13558.525451609146;13886.791698124334;13905;13920.721585568435;13973.161610303414;13350.732985340434;13615.387307571382;13628.727425451634;13639.659008524866;13639.795403068763;10346.586136554453;10348.948255258976;10367.222458315506;10408.375497470177;10535.57857685684;10585.735356616146;10959.287646302964;11042.613508527164;11268;11420.200585959235 05:38:32 INFO - PROCESS | 10006 | __end_tp_report 05:38:32 INFO - PROCESS | 10006 | __start_cc_report 05:38:32 INFO - PROCESS | 10006 | _x_x_mozilla_cycle_collect,1117 05:38:32 INFO - PROCESS | 10006 | __end_cc_report 05:38:32 INFO - PROCESS | 10006 | __startTimestamp1468672712376__endTimestamp 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | ------- Summary: start ------- 05:38:32 INFO - PROCESS | 10006 | Number of tests: 6 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | [#0] dojo.html Cycles:165 Average:5117.22 Median:5272.60 stddev:577.43 (11.0%) stddev-sans-first:553.70 05:38:32 INFO - PROCESS | 10006 | Values: 2953.9 2959.5 2961.5 3000.2 3004.9 5077.4 5083.1 5132.9 5153.7 5203.2 5114.4 5126.7 5126.7 5156.7 5157.7 4586.2 4702.3 4713.5 4734.3 4847.6 4768.3 4820.9 4832.1 4832.5 4843.3 4607.9 4633.8 4653.3 4670.8 4775.3 4665.3 4682.6 4684.6 4743.1 4788.7 4702.2 4711.1 4730.6 4732.1 4775.2 5059.7 5101.7 5167.6 5172.8 5202.3 5536.3 5554.4 5557.5 5580.7 5590.6 5580.9 5617.3 5621.2 5630.6 5633.7 5043.6 5085.8 5125.9 5134.0 5182.0 5601.1 5632.2 5653.9 5663.1 5667.7 5432.0 5436.5 5439.6 5442.5 5442.9 5321.7 5389.2 5475.5 5480.7 5561.9 5441.3 5443.1 5443.5 5470.3 5517.9 5350.9 5453.7 5460.9 5464.3 5464.3 4170.8 4181.2 4186.3 4186.7 4213.6 3738.9 3745.1 3748.8 3773.5 3779.1 5073.7 5175.2 5185.1 5186.0 5229.6 5475.9 5526.6 5528.9 5531.1 5545.5 5244.8 5251.6 5258.0 5260.2 5312.6 4668.7 4763.5 4807.9 4809.4 4813.6 5675.1 5744.1 5767.8 5770.9 5818.8 5559.4 5574.6 5578.1 5579.2 5579.9 5617.4 5620.2 5652.0 5747.6 5764.4 5449.1 5453.6 5456.2 5461.0 5473.5 5477.4 5483.3 5488.0 5491.7 5548.8 5260.9 5275.6 5299.6 5320.9 5360.2 5311.0 5313.3 5317.5 5322.6 5329.4 5255.9 5256.7 5272.6 5275.1 5283.7 5266.6 5281.5 5316.9 5365.0 5371.1 5235.7 5246.0 5259.4 5260.4 5300.4 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | [#1] ext.html Cycles:180 Average:62325.77 Median:21931.79 stddev:120018.19 (547.2%) stddev-sans-first:120265.28 05:38:32 INFO - PROCESS | 10006 | Values: 560.2 604.3 606.8 607.2 613.4 44193.0 45014.3 45045.3 45194.1 45260.8 45848.0 46409.3 46476.0 46487.0 46494.5 8233.3 9013.9 9177.6 10658.4 10873.4 10598.4 10762.2 10769.5 10769.5 10780.5 10877.2 10938.1 10953.6 10954.3 10958.2 10798.9 11050.7 11051.6 11056.2 11068.1 10974.6 11035.5 11036.8 11037.2 11042.6 43843.0 43907.1 43978.8 44080.8 44150.6 3705.4 3777.0 4043.2 4096.9 4124.4 34640.3 34759.3 34842.5 35007.6 35535.3 4431.2 4438.0 4546.9 4567.5 4655.2 378793.0 381168.0 381437.0 381809.0 381881.0 65101.7 65209.0 65573.0 65642.7 65662.0 67778.3 68203.6 68405.6 68425.3 68534.7 15243.6 15681.0 15754.2 15754.4 15756.6 11355.4 11556.4 12312.5 12621.8 12628.8 8430.9 8570.1 8654.7 17355.1 19465.8 7706.5 7815.3 7944.7 8094.4 8124.6 1014.4 1062.9 1064.3 1103.9 1168.0 33130.7 33275.7 33447.0 33681.3 33814.2 1138.6 1142.4 1143.0 1176.3 1253.7 17769.3 17881.3 17952.3 17972.5 17997.0 527355.0 544779.0 547575.0 549639.0 550894.0 61827.0 62231.7 62272.7 62301.7 62316.4 1225.9 1320.5 1390.3 1391.2 1393.7 32998.8 34147.7 35009.5 35012.5 35047.6 52904.7 53423.2 53621.7 53662.7 53747.2 410115.0 421173.0 421454.0 421626.0 422072.0 25531.2 28110.7 28619.7 28720.1 30837.8 49133.8 49309.8 49616.0 50822.0 51028.2 40747.6 43208.4 43314.4 44613.3 44914.6 44812.8 44826.8 45373.8 45647.8 45811.3 43076.0 43394.0 43915.1 44461.6 44588.6 38662.8 39101.8 39270.2 39384.6 39820.4 29415.4 29465.9 29690.6 29844.7 29963.6 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | [#2] jquery.html Cycles:180 Average:29355.88 Median:20941.69 stddev:81092.86 (387.2%) stddev-sans-first:81291.15 05:38:32 INFO - PROCESS | 10006 | Values: 375.5 381.0 383.8 392.0 396.3 15915.4 16067.9 18425.7 20490.3 20977.6 18280.9 19045.0 19251.7 20643.0 20683.4 5164.6 5268.8 5269.9 5282.8 5309.7 3880.6 5194.0 6314.8 6589.0 6599.1 5898.2 6601.7 6641.0 6652.7 6654.6 5895.7 5899.4 5913.4 5922.7 5934.8 5514.1 5713.5 5720.6 5737.3 5739.9 13582.1 13596.8 13678.1 13727.1 21601.8 2308.8 2372.5 2416.9 2460.8 2494.9 9794.0 10028.9 10093.5 11092.1 15119.2 1918.2 1939.1 1952.2 1955.9 2016.1 81984.6 82695.6 85507.0 85926.1 87380.1 10602.8 10740.6 10949.0 11217.4 11583.8 15775.1 15833.5 15857.2 15872.4 15899.4 7739.1 7985.4 8050.6 8052.4 8109.2 7489.9 7495.6 7560.4 7638.1 7668.5 4839.3 4854.0 4873.4 4887.0 4969.4 1888.6 1917.2 1920.5 1940.1 1977.3 961.9 997.7 1003.4 1012.2 1058.8 19705.5 20068.5 20297.5 20800.6 20905.8 1024.1 1030.9 1041.1 1042.2 1075.8 11103.9 11322.9 11476.9 11570.2 11585.5 475465.0 485440.0 486603.0 501490.0 501815.0 76536.0 89472.6 99726.5 102628.0 103268.0 1006.3 1030.3 1038.2 1042.6 1050.8 18642.5 18698.3 19075.8 19265.3 19282.7 44610.6 44894.6 44971.8 45664.8 46332.1 64401.7 65221.7 65295.7 66412.3 66723.7 8202.3 8235.5 8299.2 8348.7 8355.6 12659.6 13119.1 13283.5 13312.7 13339.9 11558.0 11772.4 12020.0 12031.4 12046.6 11286.3 11366.0 11444.7 11621.4 11891.0 11684.8 11796.6 11805.8 11814.5 11922.5 7495.2 7603.4 7663.7 8161.1 8261.7 8289.0 10955.3 11594.1 11854.3 11918.6 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | [#3] mootools.html Cycles:180 Average:5504.37 Median:4909.19 stddev:3116.91 (63.5%) stddev-sans-first:3110.40 05:38:32 INFO - PROCESS | 10006 | Values: 1400.7 1485.2 1623.0 1749.1 1760.2 8092.0 8441.9 8530.9 8533.9 8611.4 7138.8 7262.7 7265.3 7471.9 8756.3 2152.9 2214.0 2220.0 2227.2 2230.0 2257.9 2262.4 2278.4 2301.9 2322.0 1938.4 2239.1 2287.7 2302.3 2303.9 2250.5 2270.0 2272.5 2273.3 2274.2 2217.7 2245.8 2247.4 2254.5 2256.0 8400.5 8483.0 8513.7 8514.7 8537.3 4890.0 4972.4 5003.7 5004.1 5009.5 3191.0 3241.6 3290.7 3303.6 3314.6 1029.0 1031.4 1032.8 1043.9 1066.1 11450.8 11466.5 11469.3 11471.1 11475.4 4243.3 4313.6 4447.1 4457.0 4476.9 9189.1 9266.1 9304.0 9317.4 9335.4 5094.3 5096.8 5097.3 5101.3 5102.5 4676.3 4708.8 4747.6 4762.7 4806.3 3528.4 3572.7 3645.2 3658.3 3693.7 1053.6 1055.9 1070.3 1078.8 1111.4 851.4 876.9 908.1 916.9 921.3 5335.4 5421.7 5480.8 5510.8 5552.2 442.5 445.8 456.8 458.7 990.3 3697.3 3724.5 3756.5 3766.0 3898.8 9779.4 10052.6 10182.7 10198.5 10391.9 10201.5 10262.0 10283.4 10287.8 10332.3 7666.7 7930.1 7953.8 8173.0 8175.5 5529.7 5708.1 5766.9 5899.7 5906.1 9598.5 9714.1 9725.0 9725.9 9750.2 8362.0 9463.2 9735.1 9767.5 10011.4 6967.9 7553.8 7586.7 7778.8 7784.6 8285.2 8390.5 8403.6 8404.3 8468.6 7404.1 7626.8 7630.4 7710.3 7735.3 7322.3 7474.2 7491.5 7574.9 7600.4 6998.8 7026.4 7057.2 7059.5 7069.6 4727.1 4809.6 4809.8 4893.3 4925.0 4820.9 4882.8 4987.8 5021.0 5113.6 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | [#4] prototype.html Cycles:180 Average:4743.05 Median:5409.34 stddev:1394.68 (25.8%) stddev-sans-first:1358.48 05:38:32 INFO - PROCESS | 10006 | Values: 318.2 324.5 327.6 331.2 332.8 5365.3 5402.5 5420.1 5443.3 5451.0 5285.7 5319.8 5373.9 5398.2 5410.7 4037.7 4109.0 4175.9 4244.7 4254.1 4203.7 4208.7 4231.4 4233.3 4241.2 4014.5 4211.7 4226.5 4229.7 4240.6 3948.3 4117.2 4144.8 4149.9 4178.9 3654.6 3655.1 3663.4 3675.9 3678.1 5230.4 5266.9 5272.9 5281.1 5294.5 4532.4 4750.3 4756.9 4781.1 4793.5 5539.9 5553.7 5572.7 5639.9 5659.9 3921.3 4007.3 4011.0 4059.5 4064.6 5768.4 5789.4 5789.5 5793.7 5801.4 4190.3 4206.9 4207.1 4234.9 4244.3 4134.8 4152.8 4156.7 4292.4 4297.1 4741.6 4742.3 4751.7 4766.8 4787.2 5651.4 5651.7 5679.6 5686.3 5713.5 1437.8 1466.3 1474.3 1478.9 1479.9 906.5 950.9 964.9 973.3 1010.4 5372.0 5374.4 5380.3 5382.2 5407.9 5650.0 5651.0 5666.9 5677.1 5679.9 5157.7 5329.9 5380.5 5414.0 5445.4 3013.1 3014.2 3029.3 3039.3 3041.8 5736.9 5901.4 5901.4 5945.6 5947.3 5840.9 5845.5 5852.2 5877.4 5878.9 5839.8 5888.4 5907.9 5934.5 5944.3 5495.0 5671.9 5732.7 5802.0 5808.9 5760.1 5771.4 5780.9 5795.7 5800.9 5775.4 5962.1 6096.6 6104.5 6128.9 4087.2 4087.4 4096.2 4107.3 4118.8 5814.0 5841.2 5841.8 5852.4 5874.9 5486.5 5626.4 5639.0 5711.3 5712.5 5608.9 5611.4 5646.5 5649.2 5699.9 5356.7 5433.8 5593.0 5601.3 5643.4 5696.5 5711.5 5735.8 5763.9 5773.5 5566.3 5577.1 5578.7 5579.8 5589.9 05:38:32 INFO - PROCESS | 10006 | 05:38:32 INFO - PROCESS | 10006 | [#5] yui.html Cycles:180 Average:21129.63 Median:4858.14 stddev:29918.99 (615.9%) stddev-sans-first:29963.95 05:38:32 INFO - PROCESS | 10006 | Values: 795.0 831.3 835.9 837.3 852.0 15406.4 17031.0 17033.7 17053.7 17057.7 15196.6 15334.4 15500.2 15515.2 15546.2 675.9 787.7 793.4 819.2 822.9 818.1 820.8 824.0 824.8 825.0 871.7 872.5 872.7 872.8 873.0 706.9 843.2 856.0 858.3 872.1 623.0 623.6 626.8 626.9 628.1 14587.3 14665.5 14682.3 14723.7 14795.3 15392.1 15964.2 16140.0 16230.8 16390.6 12208.3 12256.2 12261.3 12760.3 13223.4 4810.9 4828.7 4856.3 4859.9 5015.8 72273.6 75394.0 75453.0 78469.6 79352.6 12220.8 12450.6 12853.8 12989.4 13239.2 23680.3 23693.3 23725.1 23750.5 23757.2 9319.4 9518.9 9532.1 9689.5 9690.1 4964.9 4973.8 4991.3 5011.3 5187.1 3462.5 3508.0 3531.3 3556.1 3557.1 573.8 574.5 612.8 635.6 652.6 638.4 717.3 729.8 741.2 796.8 10065.7 10173.5 10205.5 10211.4 10280.7 655.1 694.4 717.9 728.9 773.7 4726.1 4901.3 4935.6 4942.2 4965.9 112245.4 114112.4 114117.0 116487.4 118105.4 82338.0 94679.5 98444.6 100600.5 101073.0 87300.0 88900.6 89424.1 91173.5 91447.5 9708.6 9789.9 9807.8 9815.6 9819.1 51316.7 52159.0 52349.0 52431.5 53480.0 73278.0 75564.0 75587.6 75897.6 77616.6 12138.1 12231.6 12650.4 12968.6 13173.5 14397.4 14805.3 14826.5 14827.9 14857.6 13588.6 13673.8 13684.0 13717.2 13756.1 13558.5 13886.8 13905.0 13920.7 13973.2 13350.7 13615.4 13628.7 13639.7 13639.8 10346.6 10348.9 10367.2 10408.4 10535.6 10585.7 10959.3 11042.6 11268.0 11420.2 05:38:32 INFO - PROCESS | 10006 | -------- Summary: end -------- 05:38:32 INFO - PROCESS | 10006 | 05:38:33 INFO - TEST-INFO | 10006: exit 0 05:38:33 INFO - TEST-OK | dromaeo_css | took 1112802ms 05:38:33 INFO - TEST-START | kraken 05:38:33 INFO - operating with platform_type : linux_ 05:38:33 INFO - Initialising browser for kraken test... 05:38:33 INFO - TEST-INFO | started process 10199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6homD/profile http://localhost:35770/getInfo.html) 05:38:37 INFO - PROCESS | 10199 | __metrics Screen width/height:1600/1200 05:38:37 INFO - PROCESS | 10199 | colorDepth:24 05:38:37 INFO - PROCESS | 10199 | Browser inner width/height: 1024/697 05:38:37 INFO - PROCESS | 10199 | __metrics 05:38:37 INFO - PROCESS | 10199 | 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" 05:38:37 INFO - PROCESS | 10199 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:38 INFO - TEST-INFO | 10199: exit 0 05:38:38 INFO - Browser initialized. 05:38:38 INFO - Running cycle 1/1 for kraken test... 05:38:38 INFO - TEST-INFO | started process 10283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6homD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:50 INFO - PROCESS | 10283 | RSS: Main: 157503488 05:38:50 INFO - PROCESS | 10283 | 05:38:53 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35770/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:54 INFO - PROCESS | 10283 | RSS: Main: 216813568 05:38:54 INFO - PROCESS | 10283 | 05:38:56 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35770/tests/kraken/driver.html?testName=audio-dft) 05:38:57 INFO - PROCESS | 10283 | RSS: Main: 204705792 05:38:57 INFO - PROCESS | 10283 | 05:39:00 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35770/tests/kraken/driver.html?testName=audio-fft) 05:39:01 INFO - PROCESS | 10283 | RSS: Main: 269508608 05:39:01 INFO - PROCESS | 10283 | 05:39:03 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35770/tests/kraken/driver.html?testName=audio-oscillator) 05:39:03 INFO - PROCESS | 10283 | RSS: Main: 180400128 05:39:03 INFO - PROCESS | 10283 | 05:39:05 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:06 INFO - PROCESS | 10283 | RSS: Main: 184913920 05:39:06 INFO - PROCESS | 10283 | 05:39:09 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35770/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:10 INFO - PROCESS | 10283 | RSS: Main: 219672576 05:39:10 INFO - PROCESS | 10283 | 05:39:13 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35770/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:14 INFO - PROCESS | 10283 | RSS: Main: 221433856 05:39:14 INFO - PROCESS | 10283 | 05:39:16 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35770/tests/kraken/driver.html?testName=json-parse-financial) 05:39:17 INFO - PROCESS | 10283 | RSS: Main: 221188096 05:39:17 INFO - PROCESS | 10283 | 05:39:19 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:39:19 INFO - PROCESS | 10283 | RSS: Main: 209117184 05:39:19 INFO - PROCESS | 10283 | 05:39:21 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:39:21 INFO - PROCESS | 10283 | RSS: Main: 212418560 05:39:21 INFO - PROCESS | 10283 | 05:39:23 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:39:24 INFO - PROCESS | 10283 | RSS: Main: 209256448 05:39:24 INFO - PROCESS | 10283 | 05:39:27 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:27 INFO - PROCESS | 10283 | RSS: Main: 224235520 05:39:27 INFO - PROCESS | 10283 | 05:39:30 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:39:31 INFO - PROCESS | 10283 | RSS: Main: 225447936 05:39:31 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | Cycle 1(1): loaded http://localhost:35770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35770/tests/kraken/driver.html?testName=ai-astar) 05:39:32 INFO - PROCESS | 10283 | RSS: Main: 267984896 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | __start_tp_report 05:39:32 INFO - PROCESS | 10283 | _x_x_mozilla_page_load 05:39:32 INFO - PROCESS | 10283 | _x_x_mozilla_page_load_details 05:39:32 INFO - PROCESS | 10283 | |i|pagename|runs| 05:39:32 INFO - PROCESS | 10283 | |0;ai-astar;102;112;111;112;111;113;111;112;111;110 05:39:32 INFO - PROCESS | 10283 | |1;audio-beat-detection;140;121;119;170;117;128;163;121;158;116 05:39:32 INFO - PROCESS | 10283 | |2;audio-dft;161;161;161;161;160;161;162;161;161;161 05:39:32 INFO - PROCESS | 10283 | |3;audio-fft;75;75;75;106;74;76;74;73;101;74 05:39:32 INFO - PROCESS | 10283 | |4;audio-oscillator;83;85;114;84;84;84;119;83;84;134 05:39:32 INFO - PROCESS | 10283 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 05:39:32 INFO - PROCESS | 10283 | |6;imaging-darkroom;145;146;145;147;146;145;145;146;145;145 05:39:32 INFO - PROCESS | 10283 | |7;imaging-desaturate;96;96;95;94;95;95;95;94;95;95 05:39:32 INFO - PROCESS | 10283 | |8;json-parse-financial;51;49;49;50;50;55;49;50;50;50 05:39:32 INFO - PROCESS | 10283 | |9;json-stringify-tinderbox;61;61;62;60;63;61;61;61;60;61 05:39:32 INFO - PROCESS | 10283 | |10;stanford-crypto-aes;76;74;81;75;75;74;75;76;74;78 05:39:32 INFO - PROCESS | 10283 | |11;stanford-crypto-ccm;120;118;124;119;117;118;125;121;154;123 05:39:32 INFO - PROCESS | 10283 | |12;stanford-crypto-pbkdf2;161;157;162;162;155;161;159;157;160;158 05:39:32 INFO - PROCESS | 10283 | |13;stanford-crypto-sha256-iterative;62;63;64;64;63;62;62;62;66;62 05:39:32 INFO - PROCESS | 10283 | __end_tp_report 05:39:32 INFO - PROCESS | 10283 | __start_cc_report 05:39:32 INFO - PROCESS | 10283 | _x_x_mozilla_cycle_collect,1672 05:39:32 INFO - PROCESS | 10283 | __end_cc_report 05:39:32 INFO - PROCESS | 10283 | __startTimestamp1468672772912__endTimestamp 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | ------- Summary: start ------- 05:39:32 INFO - PROCESS | 10283 | Number of tests: 14 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.10 (2.8%) stddev-sans-first:0.88 05:39:32 INFO - PROCESS | 10283 | Values: 102.0 112.0 111.0 112.0 111.0 113.0 111.0 112.0 111.0 110.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:134.00 stddev:20.93 (15.6%) stddev-sans-first:22.13 05:39:32 INFO - PROCESS | 10283 | Values: 140.0 121.0 119.0 170.0 117.0 128.0 163.0 121.0 158.0 116.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:39:32 INFO - PROCESS | 10283 | Values: 161.0 161.0 161.0 161.0 160.0 161.0 162.0 161.0 161.0 161.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#3] audio-fft Cycles:10 Average:80.30 Median:74.50 stddev:12.31 (16.5%) stddev-sans-first:12.91 05:39:32 INFO - PROCESS | 10283 | Values: 75.0 75.0 75.0 106.0 74.0 76.0 74.0 73.0 101.0 74.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:19.23 (22.9%) stddev-sans-first:19.87 05:39:32 INFO - PROCESS | 10283 | Values: 83.0 85.0 114.0 84.0 84.0 84.0 119.0 83.0 84.0 134.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:39:32 INFO - PROCESS | 10283 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:39:32 INFO - PROCESS | 10283 | Values: 145.0 146.0 145.0 147.0 146.0 145.0 145.0 146.0 145.0 145.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 05:39:32 INFO - PROCESS | 10283 | Values: 96.0 96.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:1.77 (3.5%) stddev-sans-first:1.86 05:39:32 INFO - PROCESS | 10283 | Values: 51.0 49.0 49.0 50.0 50.0 55.0 49.0 50.0 50.0 50.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 05:39:32 INFO - PROCESS | 10283 | Values: 61.0 61.0 62.0 60.0 63.0 61.0 61.0 61.0 60.0 61.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:2.20 (2.9%) stddev-sans-first:2.33 05:39:32 INFO - PROCESS | 10283 | Values: 76.0 74.0 81.0 75.0 75.0 74.0 75.0 76.0 74.0 78.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:122.00 stddev:10.92 (8.9%) stddev-sans-first:11.49 05:39:32 INFO - PROCESS | 10283 | Values: 120.0 118.0 124.0 119.0 117.0 118.0 125.0 121.0 154.0 123.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.50 stddev:2.39 (1.5%) stddev-sans-first:2.45 05:39:32 INFO - PROCESS | 10283 | Values: 161.0 157.0 162.0 162.0 155.0 161.0 159.0 157.0 160.0 158.0 05:39:32 INFO - PROCESS | 10283 | 05:39:32 INFO - PROCESS | 10283 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 05:39:32 INFO - PROCESS | 10283 | Values: 62.0 63.0 64.0 64.0 63.0 62.0 62.0 62.0 66.0 62.0 05:39:32 INFO - PROCESS | 10283 | -------- Summary: end -------- 05:39:32 INFO - PROCESS | 10283 | 05:39:33 INFO - TEST-INFO | 10283: exit 0 05:39:33 INFO - TEST-OK | kraken | took 60779ms 05:39:33 INFO - SUITE-END | took 1173s 05:39:34 INFO - Completed test suite (00:19:33) 05:39:34 INFO - javascript benchmark 05:39:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2953.862762836306, 2959.4525012872605, 2961.511350627147, 3000.2349400902767, 3004.879804807808, 5077.4160971488245, 5083.135866902626, 5132.871678208037, 5153.742312884355, 5203.245529398239, 5114.411842638097, 5126.71803050832, 5126.7436628168625, 5156.664816786906, 5157.73635459312, 4586.174488592061, 4702.27114797207, 4713.505081966396, 4734.313524538939, 4847.636427267951, 4768.308595253686, 4820.903581928359, 4832.106060378824, 4832.540908613676, 4843.346148269974, 4607.9308810367875, 4633.791479383436, 4653.302004699289, 4670.8365207217585, 4775.3075804008395, 4665.2768820832825, 4682.6019788318035, 4684.578387945067, 4743.0988112258565, 4788.736619485927, 4702.247640377524, 4711.10489007091, 4730.645201609893, 4732.124556956974, 4775.2359622460235, 5059.747012649353, 5101.69389836611, 5167.586593072545, 5172.844814655567, 5202.297689811902, 5536.252605898192, 5554.389017208104, 5557.472040156179, 5580.748866301026, 5590.608657393984, 5580.888382232332, 5617.269754931874, 5621.18492818539, 5630.634008789416, 5633.690147041911, 5043.646944713872, 5085.79656813727, 5125.871853203663, 5134.0, 5182.0, 5601.103823388238, 5632.211490391349, 5653.9151912721345, 5663.122216056518, 5667.688277144714, 5432.022235997559, 5436.456354364611, 5439.5920305976415, 5442.455754424526, 5442.8911421771345, 5321.707306098202, 5389.245505629215, 5475.534579560703, 5480.698561579152, 5561.860953476114, 5441.347038355423, 5443.074677304868, 5443.482869127427, 5470.316210473691, 5517.889642207133, 5350.892982140335, 5453.727313634303, 5460.863478413072, 5464.316960379952, 5464.3442786865835, 4170.83316667336, 4181.247375472444, 4186.267403204488, 4186.748795072244, 4213.599708027732, 3738.8691395801015, 3745.138618117848, 3748.83130259139, 3773.4528493368307, 3779.149691319486, 5073.695578265316, 5175.223716442564, 5185.118529849935, 5185.974070129625, 5229.581633469314, 5475.945240547543, 5526.58550608706, 5528.861778455571, 5531.087370583889, 5545.528630066409, 5244.790208391698, 5251.553617942442, 5257.973710131425, 5260.2109683547005, 5312.574994000471, 4668.673192876534, 4763.476017638057, 4807.927881081787, 4809.350737650442, 4813.566778989908, 5675.091985282335, 5744.080947048452, 5767.826965191051, 5770.913436298459, 5818.7672493100645, 5559.388467268678, 5574.637648552994, 5578.107502799533, 5579.218909352775, 5579.944200558105, 5617.354004289559, 5620.213170156099, 5652.039153343859, 5747.626404283708, 5764.394738552392, 5449.100898351728, 5453.64551304164, 5456.181572764117, 5461.044317244546, 5473.507384335429, 5477.370102438112, 5483.341998960151, 5487.972560137334, 5491.670499770026, 5548.750306236148, 5260.868478288074, 5275.577953763613, 5299.629025968299, 5320.893582128413, 5360.195970604284, 5310.9734451327495, 5313.2561441397465, 5317.548008419328, 5322.600804939568, 5329.440408757025, 5255.868603284948, 5256.658317209369, 5272.604554658493, 5275.076861549137, 5283.682979021271, 5266.55234305073, 5281.498257665516, 5316.946830531645, 5365.034293826992, 5371.140617501181, 5235.738213089407, 5246.029484545371, 5259.368875734936, 5260.368755749335, 5300.390455097713], "value": 5078.284476797984, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.2324815003443, 604.3050491934276, 606.7773436525403, 607.1954660075402, 613.441767991128, 44193.0, 45014.32478512821, 45045.32432013514, 45194.0961180777, 45260.77369613152, 45848.0, 46409.30386044212, 46476.0, 46487.0, 46494.535054649445, 8233.300169485601, 9013.909860901373, 9177.632894684204, 10658.360498370123, 10873.401962892038, 10598.364098154098, 10762.192835537327, 10769.461526923662, 10769.515371808247, 10780.51487683056, 10877.184211184152, 10938.124950003981, 10953.561857525689, 10954.287971281841, 10958.178136639784, 10798.946005269963, 11050.668479945614, 11051.557937682483, 11056.226064175511, 11068.114550835953, 10974.615888443946, 11035.503402346914, 11036.834447483294, 11037.227394082418, 11042.558297668083, 43843.0, 43907.12185756299, 43978.780106099584, 44080.77959610213, 44150.55849441497, 3705.4441833724886, 3776.981115094407, 4043.1711499142607, 4096.877093687194, 4124.422580838685, 34640.307193856235, 34759.30481390384, 34842.47736283958, 35007.64992350069, 35535.28929421423, 4431.158079964828, 4437.977810110929, 4546.8863278417975, 4567.543245675439, 4655.185342565072, 378793.0, 381168.0, 381436.9999999972, 381809.0, 381881.0, 65101.67449162724, 65209.0, 65573.0, 65642.67178664076, 65662.0, 67778.3222167772, 68203.61287355018, 68405.60580379663, 68425.3157468419, 68534.65732671304, 15243.61890952713, 15681.0, 15754.212289385485, 15754.448594299145, 15756.606084847741, 11355.375454349925, 11556.422178891022, 12312.507499699912, 12621.81067283973, 12628.81056784149, 8430.873536896952, 8570.057293697688, 8654.740357789276, 17355.09734003663, 19465.805341946398, 7706.537607743553, 7815.29662330393, 7944.721934732257, 8094.433389662785, 8124.63439145228, 1014.4167103915131, 1062.86182796236, 1064.2816099133054, 1103.8675358956978, 1167.9532818687157, 33130.66869331324, 33275.690353141494, 33447.0, 33681.32637347288, 33814.15464613404, 1138.6413279816998, 1142.4230763464398, 1143.0224265787504, 1176.3412489006014, 1253.6803115205564, 17769.28922843098, 17881.28474861017, 17952.281908723766, 17972.460826175236, 17997.0, 527355.0, 544779.0, 547575.0, 549639.0, 550894.0, 61827.0, 62231.68884155641, 62272.68863655653, 62301.68849155725, 62316.37683623196, 1225.914186006971, 1320.5114107780182, 1390.318743815523, 1391.2000599655037, 1393.6933874547583, 32998.83500582482, 34147.65852341445, 35009.474857876645, 35012.47481287732, 35047.64952350546, 52904.73547632237, 53423.19865201948, 53621.65945851385, 53662.73168634288, 53747.19379209393, 410115.0, 421173.0, 421454.0, 421626.0, 422072.0, 25531.23406297814, 28110.71889281081, 28619.713802862538, 28720.138395848157, 30837.845810770803, 49133.75433122811, 49309.75345123395, 49616.0, 50822.0, 51028.23457648064, 40747.59252407557, 43208.35187472127, 43314.35028474638, 44613.33080003737, 44914.55085449234, 44812.77593612011, 44826.77586612046, 45373.773131134134, 45647.77176114098, 45811.31283030824, 43076.0, 43394.0, 43915.12169756651, 44461.55538444574, 44588.55411445844, 38662.80668596639, 39101.80449097736, 39270.214595708494, 39384.6061539381, 39820.40269396019, 29415.411691766472, 29465.85267073651, 29690.55464167996, 29844.70155298506, 29963.55054674138], "value": 21211.10107083355, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.5474653043083, 380.9580946095929, 383.84262452394523, 392.0, 396.2550405238152, 15915.44295949642, 16067.919660401682, 18425.73538914238, 20490.2828401006, 20977.58044839102, 18280.908595457004, 19045.0477476126, 19251.711224331648, 20643.0, 20683.379498615028, 5164.561012313958, 5268.841934741964, 5269.947300527003, 5282.788688452477, 5309.681419114865, 3880.5731369549326, 5193.974030129844, 6314.810555683337, 6589.04458853466, 6599.10912026875, 5898.233229680136, 6601.70292336846, 6641.037049627801, 6652.733890644393, 6654.600723956554, 5895.705214739246, 5899.351071382144, 5913.379095195007, 5922.703864806743, 5934.821955341346, 5514.117741161435, 5713.457221563945, 5720.6281591696825, 5737.340205876336, 5739.856503587402, 13582.098506209139, 13596.796048059286, 13678.110922789987, 13727.107737997098, 21601.78398216029, 2308.7806658367426, 2372.4780548279523, 2416.879156042191, 2460.766227208412, 2494.8503089814667, 9794.0, 10028.949855250678, 10093.495325233709, 11092.112630989583, 15119.244037798066, 1918.213532451688, 1939.0789375046882, 1952.2483843720129, 1955.8728682635726, 2016.0726066009506, 81984.59007704923, 82695.5865220676, 85507.0, 85926.14073859244, 87380.12619873784, 10602.787944241227, 10740.624078157383, 10949.0, 11217.383043932661, 11583.76832463363, 15775.132367719885, 15833.52499425019, 15857.207139642971, 15872.365105395655, 15899.364025439085, 7739.148693643695, 7985.361171106298, 8050.597470126588, 8052.355811535063, 8109.229623185788, 7489.925100749032, 7495.587742674096, 7560.3573696236435, 7638.083429988325, 7668.463207575416, 4839.2983017462275, 4853.95146048542, 4873.366462359871, 4886.975565122151, 4969.378827646544, 1888.6317168152352, 1917.1564511614845, 1920.4622705642441, 1940.146335612326, 1977.3079422202402, 961.9230461563059, 997.7006897930592, 1003.4330603209163, 1012.2104758288547, 1058.7564860082225, 19705.50736231577, 20068.498287542636, 20297.49256268605, 20800.58398832045, 20905.790942090385, 1024.1192574386023, 1030.9175265978704, 1041.099448976645, 1042.2131290875493, 1075.7902209069314, 11103.944480277547, 11322.94338528302, 11476.88523114775, 11570.19008669402, 11585.478653460614, 475465.0, 485440.0, 486603.0, 501490.0, 501815.0, 76536.0, 89472.5526372377, 99726.5013674927, 102628.0, 103268.0, 1006.3408467453829, 1030.2891005206534, 1038.2368958815416, 1042.5725452564564, 1050.7740835720203, 18642.533936651693, 18698.252069917053, 19075.809241907402, 19265.325713599956, 19282.7107593389, 44610.55389446064, 44894.551054489035, 44971.77514112408, 45664.771676141405, 46332.073358533315, 64401.677991609744, 65221.673891632134, 65295.67352163209, 66412.33587664062, 66723.66638166973, 8202.26179643835, 8235.547044912588, 8299.211574900375, 8348.749537513884, 8355.58222088881, 12659.620211393672, 13119.081664283409, 13283.535076272285, 13312.733745325233, 13339.933300333436, 11558.0, 11772.411379430823, 12020.0, 12031.398430078287, 12046.578369757017, 11286.322820630789, 11366.0, 11444.656660300205, 11621.360825154698, 11891.048716102518, 11684.824727629262, 11796.587119450778, 11805.82291265649, 11814.46834892449, 11922.52309907594, 7495.213002634645, 7603.429742769204, 7663.731769388268, 8161.061477929877, 8261.710840120568, 8289.046759622479, 10955.287906286067, 11594.130440216848, 11854.348010859141, 11918.582849600223], "value": 9255.421414875827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.6848459096702, 1485.1757274712534, 1622.9837701622987, 1749.0555100245867, 1760.1991094052207, 8091.959540202298, 8441.873371899426, 8530.91469085309, 8533.871991920118, 8611.44025638334, 7138.821529461766, 7262.709491620329, 7265.273472652732, 7471.850562988737, 8756.299496040318, 2152.8923553822287, 2213.9889300553555, 2219.9778002220014, 2227.24273746926, 2229.9888500557477, 2257.9435514112115, 2262.3891549281684, 2278.3734473019886, 2301.9424514387106, 2321.9535609287805, 1938.3603410874448, 2239.1267405711787, 2287.656851472276, 2302.3323236261463, 2303.9193628223015, 2250.5273892482514, 2269.988650056739, 2272.47733021406, 2273.27255278311, 2274.2494976657663, 2217.7449593296815, 2245.786650268222, 2247.4156719252946, 2254.537819746948, 2255.9661605075935, 8400.537970411626, 8483.0, 8513.74458766238, 8514.74455766328, 8537.274331681814, 4889.975550122263, 4972.378452693413, 5003.699778013331, 5004.074246264453, 5009.549140577329, 3190.96809031909, 3241.6272128705264, 3290.7038366547126, 3303.620083690382, 3314.5691060162267, 1028.9897101028969, 1031.417249254169, 1032.8140934631838, 1043.8621902126717, 1066.0938202527789, 11450.770984580346, 11466.48400821965, 11469.31184128955, 11471.082313414907, 11475.368854712904, 4243.321068629005, 4313.590208930209, 4447.066116115652, 4457.041736026705, 4476.888077798016, 9189.081091890892, 9266.07339266068, 9304.0, 9317.39436936597, 9335.393199442015, 5094.312267843868, 5096.847094587169, 5097.337346144977, 5101.260317254051, 5102.540771330598, 4676.345311656303, 4708.764561771898, 4747.572718455286, 4762.666613337033, 4806.279058141306, 3528.3825330567047, 3572.69632081276, 3645.179834537208, 3658.3049220648522, 3693.686036686858, 1053.6364954090827, 1055.8627378440754, 1070.277562645227, 1078.8219943709357, 1111.4442778610694, 851.3657325292572, 876.8553188723789, 908.0828363353061, 916.9220616247694, 921.2998121427763, 5335.359756829128, 5421.701806400607, 5480.808171713971, 5510.834674959758, 5552.194931734956, 442.47124686000564, 445.8016182798688, 456.78759376889906, 458.6514249170654, 990.3463713948903, 3697.3159965406485, 3724.4599533067553, 3756.4928734620476, 3766.0, 3898.8440462381186, 9779.41323520591, 10052.59789608422, 10182.694519164437, 10198.490075496196, 10391.948040259751, 10201.540930658139, 10262.025107614765, 10283.43441110746, 10287.845682314772, 10332.276740628084, 7666.693332266758, 7930.1276859545405, 7953.840923181504, 8173.019237691634, 8175.468594541336, 5529.668219906657, 5708.143778433268, 5766.913496297643, 5899.705014749159, 5906.084556893688, 9598.472084035446, 9714.077162669535, 9725.0, 9725.902740972782, 9750.219982401533, 8361.95819020901, 9463.242940564876, 9735.075167859042, 9767.511624418892, 10011.399316041061, 6967.895481567882, 7553.773386798405, 7586.696532138873, 7778.766637000899, 7784.610769461618, 8285.212904774036, 8390.496570205807, 8403.579821009047, 8404.32765378756, 8468.618912149092, 7404.074490688664, 7626.847463050819, 7630.389568834369, 7710.267524585155, 7735.342495887688, 7322.267773222635, 7474.215207403362, 7491.475596708178, 7574.924250757643, 7600.391968642385, 6998.825029374307, 7026.3676269133975, 7057.188423331178, 7059.541129826544, 7069.646517673993, 4727.078219747116, 4809.591184749335, 4809.78355973975, 4893.339399181065, 4925.039617274597, 4820.927686084641, 4882.754897501114, 4987.825426110068, 5021.0, 5113.64204505681], "value": 4356.1611329826355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.2346456771465, 324.485690181063, 327.5806967082134, 331.19684764446197, 332.7953308715138, 5365.256291705192, 5402.460298814834, 5420.105682562377, 5443.319585051869, 5451.0, 5285.709285989269, 5319.787208511664, 5373.892522149555, 5398.217258497515, 5410.729463526818, 4037.7173597848164, 4109.0, 4175.937360939588, 4244.660427165819, 4254.085371645096, 4203.726757760751, 4208.663306935453, 4231.386448964899, 4233.343831706075, 4241.2365774160635, 4014.518257809067, 4211.747295162285, 4226.492820861486, 4229.725067870594, 4240.5759424057505, 3948.3485224937995, 4117.197146556423, 4144.79276036197, 4149.896252593694, 4178.91642167158, 3654.5614526256754, 3655.1227705350525, 3663.4138537834087, 3675.9264814703824, 3678.0988657779017, 5230.424653288135, 5266.920281342315, 5272.894542109175, 5281.0758117329315, 5294.49702278283, 4532.365468834366, 4750.334953106568, 4756.9286460703115, 4781.115493633689, 4793.54461326177, 5539.861503462405, 5553.694546799924, 5572.693501857396, 5639.943600564024, 5659.915101273484, 3921.254961557295, 4007.338789099795, 4010.979945100256, 4059.4722686050623, 4064.6341829235216, 5768.3654797972185, 5789.392113828072, 5789.507891829199, 5793.652380857162, 5801.448862358111, 4190.308599081179, 4206.85276015338, 4207.0954744729415, 4234.872953811329, 4244.342126970325, 4134.813933373005, 4152.8338866445, 4156.729812562235, 4292.377605247284, 4297.09760950204, 4741.596964258008, 4742.288656701453, 4751.714897106184, 4766.809327626926, 4787.16224660683, 5651.378348381675, 5651.660900345993, 5679.592244653175, 5686.346070201897, 5713.457221563945, 1437.7627691431005, 1466.30350583472, 1474.3439169569438, 1478.8816894648403, 1479.9038062525901, 906.5421961909194, 950.8906475755239, 964.8951950017191, 973.255459573427, 1010.3584224017802, 5371.979323928441, 5374.435684253097, 5380.309845077461, 5382.2464854920345, 5407.944511351074, 5649.954758369715, 5650.97174514133, 5666.914996275059, 5677.069796269206, 5679.8864022720145, 5157.690538567698, 5329.9467005330225, 5380.515753582196, 5414.023881283303, 5445.37378201504, 3013.081010291882, 3014.231371000381, 3029.257831831171, 3039.3465404938042, 3041.7870749047797, 5736.942630573724, 5901.409859014064, 5901.439363260483, 5945.64326140433, 5947.345791962881, 5840.88318233633, 5845.503132233808, 5852.151438041546, 5877.353491115974, 5878.911816322759, 5839.788116535889, 5888.410129265075, 5907.911381329283, 5934.495567876606, 5944.346121926585, 5495.0, 5671.914921276101, 5732.684702341245, 5802.0, 5808.912866306924, 5760.1359796029255, 5771.3651498335985, 5780.855478613068, 5795.710214489343, 5800.854978625568, 5775.361522241129, 5962.135490353961, 6096.634201947897, 6104.511639068953, 6128.927437698474, 4087.16077765001, 4087.448194493705, 4096.177201145461, 4107.254416872876, 4118.755278373354, 5814.0, 5841.153032810304, 5841.766329346779, 5852.356240813422, 5874.911876321773, 5486.451354864482, 5626.352969408406, 5638.971805141112, 5711.286089238845, 5712.457316554921, 5608.9158662619275, 5611.410801865909, 5646.491815736604, 5649.2373529574625, 5699.943000569941, 5356.705381204071, 5433.782648694166, 5593.0, 5601.327840659147, 5643.379228284967, 5696.515796157373, 5711.5145212655725, 5735.827925162252, 5763.94236057634, 5773.451522105393, 5566.332040155207, 5577.135543990688, 5578.693171875586, 5579.804706835242, 5589.944100558942], "value": 4296.229470749351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.9960250198752, 831.2643310670055, 835.8787975743518, 837.2924878477684, 851.9659213631455, 15406.3837446502, 17031.0, 17033.659326813457, 17053.65892682147, 17057.658846823055, 15196.620084497894, 15334.386624535033, 15500.224988750546, 15515.224238788072, 15546.222688865568, 675.8513127112052, 787.7439832054577, 793.4128744728916, 819.1849110135423, 822.880682301066, 818.145038434837, 820.7619790260848, 823.9876401853977, 824.8226631274275, 825.0, 871.6644092024585, 872.4939535069644, 872.707642939616, 872.7512658892217, 873.0, 706.883364244899, 843.1863251961855, 855.9871601925945, 858.3390789092364, 872.0886673426285, 622.9626222426668, 623.5728525959732, 626.764963138823, 626.9467095296906, 628.0986783964979, 14587.270636468134, 14665.48670796517, 14682.265886705729, 14723.705525889422, 14795.260236988215, 15392.076475411512, 15964.201789910458, 16139.950903191255, 16230.756538651929, 16390.590235244093, 12208.267503949792, 12256.203346782431, 12261.325627090595, 12760.29818359999, 13223.404946777418, 4810.85567432974, 4828.73441960692, 4856.344393506866, 4859.927101093486, 5015.824446144367, 72273.6386318065, 75394.0, 75453.0, 78469.60765196195, 79352.60323698402, 12220.816687749691, 12450.626481205578, 12853.807192892114, 12989.41547630359, 13239.20564766117, 23680.28959131229, 23693.289201323987, 23725.05099795989, 23750.524989500114, 23757.168499102794, 9319.394239374418, 9518.854883541191, 9532.094451027142, 9689.467079310565, 9690.12788848993, 4964.851054468371, 4973.825916092919, 4991.251312303184, 5011.298418221452, 5187.118189907725, 3462.515247865301, 3507.982460087683, 3531.2760884019226, 3556.128748456593, 3557.0751604582993, 573.8369907196677, 574.45713800459, 612.8253447767365, 635.640862912453, 652.6312633362135, 638.3903372279462, 717.3400471566172, 729.7701224114387, 741.1698897235132, 796.8366484870587, 10065.69802905914, 10173.54219060144, 10205.540750666238, 10211.380164628852, 10280.691579252634, 655.1430213887828, 694.4340362604461, 717.9317964793337, 728.9088863892014, 773.6557232031804, 4726.125666751594, 4901.264810278487, 4935.580475659537, 4942.233953737176, 4965.90068198634, 112245.43877280725, 114112.42943785228, 114117.0, 116487.41756291164, 118105.4094729538, 82338.0, 94679.52660236793, 98444.61665375126, 100600.496997516, 101073.0, 87300.0, 88900.5554972234, 89424.10575894288, 91173.54413228024, 91447.54276228577, 9708.641188536743, 9789.853152202864, 9807.7979132346, 9815.570801125274, 9819.054283715, 51316.74341628268, 52158.95682086413, 52349.0, 52431.47568524266, 53480.0, 73278.0, 75564.0, 75587.62206188934, 75897.62051189708, 77616.61191694005, 12138.089643276966, 12231.574135720688, 12650.430730617329, 12968.610941671765, 13173.47306107745, 14397.352119154873, 14805.259737013323, 14826.481073162387, 14827.92586037063, 14857.554273371816, 13588.59234222975, 13673.794893076412, 13684.0, 13717.17696938187, 13756.105853119516, 13558.525451609146, 13886.791698124334, 13905.0, 13920.721585568435, 13973.161610303414, 13350.732985340434, 13615.387307571382, 13628.727425451634, 13639.659008524866, 13639.795403068763, 10346.586136554453, 10348.948255258976, 10367.222458315506, 10408.375497470177, 10535.57857685684, 10585.735356616146, 10959.287646302964, 11042.613508527164, 11268.0, 11420.200585959235], "value": 7774.536133561279, "unit": "score"}], "name": "dromaeo_css", "value": 7248.788032293298, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 112.0, 111.0, 113.0, 111.0, 112.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 121.0, 119.0, 170.0, 117.0, 128.0, 163.0, 121.0, 158.0, 116.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 106.0, 74.0, 76.0, 74.0, 73.0, 101.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 114.0, 84.0, 84.0, 84.0, 119.0, 83.0, 84.0, 134.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 49.0, 50.0, 50.0, 55.0, 49.0, 50.0, 50.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 60.0, 63.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 81.0, 75.0, 75.0, 74.0, 75.0, 76.0, 74.0, 78.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 124.0, 119.0, 117.0, 118.0, 125.0, 121.0, 154.0, 123.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 162.0, 162.0, 155.0, 161.0, 159.0, 157.0, 160.0, 158.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 64.0, 63.0, 62.0, 62.0, 62.0, 66.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1473.1, "alertThreshold": 2.0}]} 05:39:34 INFO - Return code: 0 05:39:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:39:34 INFO - # TBPL SUCCESS # 05:39:34 INFO - Running post-action listener: _resource_record_post_action 05:39:34 INFO - ##### 05:39:34 INFO - ##### Finished run-tests step (success) 05:39:34 INFO - ##### 05:39:34 INFO - Running post-run listener: _resource_record_post_run 05:39:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552800256; Read time: 20; Write time: 602104 05:39:34 INFO - TinderboxPrint: CPU usage
13.0% 05:39:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:39:34 INFO - TinderboxPrint: I/O write bytes / time
552,800,256 / 602,104 05:39:34 INFO - TinderboxPrint: CPU idle
8,273.8 (87.0%) 05:39:34 INFO - TinderboxPrint: CPU user
1,190.0 (12.5%) 05:39:34 INFO - TinderboxPrint: Swap in / out
0 / 0 05:39:34 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257355776; Read time: 0; Write time: 363252 05:39:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295444480; Read time: 0; Write time: 238852 05:39:34 INFO - Running post-run listener: _upload_blobber_files 05:39:34 INFO - Blob upload gear active. 05:39:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:39:34 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 05:39:34 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'] 05:39:34 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 05:39:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:38 INFO - (blobuploader) - INFO - Done attempting. 05:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:39 INFO - (blobuploader) - INFO - Done attempting. 05:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:40 INFO - (blobuploader) - INFO - Done attempting. 05:39:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:39:40 INFO - Return code: 0 05:39:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:39:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:39:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e84c60fdc4be3dd7751e1670ef5efdbcb5fb1de66c7ce746c65c41c706236214d404d7a6d79373f533c464949787394a0110b96c42093f0d7abc96dc7554f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d6c9328cf67432ad5c079e36d671e750afff482af93656bb9ff39a949b23b9e1c3827d5e9ac24a1905137e46b7e9d3212fbd6b3beb586f21770788fbff3d51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce173107cbd4b7689a519f3f4222eec6781446fd203da08b03a1a1cac2cd91e81cc3668618b6201791ca5817763201b334fa0a824c8c114705cacf03a726439c"} 05:39:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:39:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:39:40 INFO - Contents: 05:39:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e84c60fdc4be3dd7751e1670ef5efdbcb5fb1de66c7ce746c65c41c706236214d404d7a6d79373f533c464949787394a0110b96c42093f0d7abc96dc7554f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d6c9328cf67432ad5c079e36d671e750afff482af93656bb9ff39a949b23b9e1c3827d5e9ac24a1905137e46b7e9d3212fbd6b3beb586f21770788fbff3d51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce173107cbd4b7689a519f3f4222eec6781446fd203da08b03a1a1cac2cd91e81cc3668618b6201791ca5817763201b334fa0a824c8c114705cacf03a726439c"} 05:39:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:39:40 INFO - Copying logs to upload dir... 05:39:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:39:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.753169 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-16 05:39:38.896117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 05:39:38.899673) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524 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/77e84c60fdc4be3dd7751e1670ef5efdbcb5fb1de66c7ce746c65c41c706236214d404d7a6d79373f533c464949787394a0110b96c42093f0d7abc96dc7554f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d6c9328cf67432ad5c079e36d671e750afff482af93656bb9ff39a949b23b9e1c3827d5e9ac24a1905137e46b7e9d3212fbd6b3beb586f21770788fbff3d51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce173107cbd4b7689a519f3f4222eec6781446fd203da08b03a1a1cac2cd91e81cc3668618b6201791ca5817763201b334fa0a824c8c114705cacf03a726439c"} build_url:https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/VqtKWmmJQ_unBotR7Fog0g/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/77e84c60fdc4be3dd7751e1670ef5efdbcb5fb1de66c7ce746c65c41c706236214d404d7a6d79373f533c464949787394a0110b96c42093f0d7abc96dc7554f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5d6c9328cf67432ad5c079e36d671e750afff482af93656bb9ff39a949b23b9e1c3827d5e9ac24a1905137e46b7e9d3212fbd6b3beb586f21770788fbff3d51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce173107cbd4b7689a519f3f4222eec6781446fd203da08b03a1a1cac2cd91e81cc3668618b6201791ca5817763201b334fa0a824c8c114705cacf03a726439c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 05:39:38.924933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:39:38.925381) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1468669363.708190-1301901524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 05:39:39.010159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 05:39:39.010480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 05:39:39.010768) ========= ========= Total master_lag: 0.15 =========