builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1467982009.43 results: success (0) buildid: 20160708023010 builduid: 951ccdffcfe945dbaac7aee7cbc09f20 revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.430620) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.431172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.431477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.444216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.444731) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 05:46:49-- 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% 226M=0s 2016-07-08 05:46:49 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.529728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.530088) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018531 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.580950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:49.581371) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 806cd7a7b68de8777caf419239e2f4e671aaa80b --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 806cd7a7b68de8777caf419239e2f4e671aaa80b --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=c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 05:46:49,936 truncating revision to first 12 chars 2016-07-08 05:46:49,936 Setting DEBUG logging. 2016-07-08 05:46:49,936 attempt 1/10 2016-07-08 05:46:49,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/806cd7a7b68d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 05:46:50,539 unpacking tar archive at: fx-team-806cd7a7b68d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.940636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:50.537051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:50.537421) ========= script_repo_revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:50.537888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:50.538192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:46:50.548119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-08 05:46:50.548542) ========= /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=c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:50 INFO - MultiFileLogger online at 20160708 05:46:50 in /builds/slave/test 05:46:50 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:46:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:50 INFO - {'append_to_log': False, 05:46:50 INFO - 'base_work_dir': '/builds/slave/test', 05:46:50 INFO - 'blob_upload_branch': 'Fx-Team', 05:46:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:50 INFO - 'branch': 'Fx-Team', 05:46:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:50 INFO - 'config_files': ('talos/linux_config.py',), 05:46:50 INFO - 'default_actions': ('clobber', 05:46:50 INFO - 'read-buildbot-config', 05:46:50 INFO - 'download-and-extract', 05:46:50 INFO - 'populate-webroot', 05:46:50 INFO - 'create-virtualenv', 05:46:50 INFO - 'install', 05:46:51 INFO - 'run-tests'), 05:46:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:51 INFO - 'download_minidump_stackwalk': True, 05:46:51 INFO - 'download_symbols': 'ondemand', 05:46:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:51 INFO - 'installer_path': 'installer.exe', 05:46:51 INFO - 'log_level': 'info', 05:46:51 INFO - 'log_name': 'talos', 05:46:51 INFO - 'log_to_console': True, 05:46:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:51 INFO - 'opt_config_files': (), 05:46:51 INFO - 'pip_index': False, 05:46:51 INFO - 'sps_profile': False, 05:46:51 INFO - 'sps_profile_interval': 0, 05:46:51 INFO - 'suite': 'dromaeojs', 05:46:51 INFO - 'system_bits': '32', 05:46:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:51 INFO - 'title': 'talos-linux64-ix-004', 05:46:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:51 INFO - 'use_talos_json': True, 05:46:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:51 INFO - 'work_dir': 'build'} 05:46:51 INFO - ##### 05:46:51 INFO - ##### Running clobber step. 05:46:51 INFO - ##### 05:46:51 INFO - Running pre-action listener: _resource_record_pre_action 05:46:51 INFO - Running main action method: clobber 05:46:51 INFO - rmtree: /builds/slave/test/build 05:46:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:51 INFO - Running post-action listener: _resource_record_post_action 05:46:51 INFO - ##### 05:46:51 INFO - ##### Finished clobber step (success) 05:46:51 INFO - ##### 05:46:51 INFO - ##### 05:46:51 INFO - ##### Running read-buildbot-config step. 05:46:51 INFO - ##### 05:46:51 INFO - Running pre-action listener: _resource_record_pre_action 05:46:51 INFO - Running main action method: read_buildbot_config 05:46:51 INFO - Using buildbot properties: 05:46:51 INFO - { 05:46:51 INFO - "project": "", 05:46:51 INFO - "product": "firefox", 05:46:51 INFO - "script_repo_revision": "production", 05:46:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:46:51 INFO - "repository": "", 05:46:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:46:51 INFO - "buildid": "20160708023010", 05:46:51 INFO - "pgo_build": "True", 05:46:51 INFO - "basedir": "/builds/slave/test", 05:46:51 INFO - "buildnumber": 871, 05:46:51 INFO - "slavename": "talos-linux64-ix-004", 05:46:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:46:51 INFO - "platform": "ubuntu64_hw", 05:46:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:46:51 INFO - "branch": "fx-team", 05:46:51 INFO - "repo_path": "integration/fx-team", 05:46:51 INFO - "revision": "806cd7a7b68de8777caf419239e2f4e671aaa80b", 05:46:51 INFO - "stage_platform": "linux64-pgo", 05:46:51 INFO - "builduid": "951ccdffcfe945dbaac7aee7cbc09f20", 05:46:51 INFO - "slavebuilddir": "test" 05:46:51 INFO - } 05:46:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:46:51 INFO - Running post-action listener: _resource_record_post_action 05:46:51 INFO - ##### 05:46:51 INFO - ##### Finished read-buildbot-config step (success) 05:46:51 INFO - ##### 05:46:51 INFO - ##### 05:46:51 INFO - ##### Running download-and-extract step. 05:46:51 INFO - ##### 05:46:51 INFO - Running pre-action listener: _resource_record_pre_action 05:46:51 INFO - Running main action method: download_and_extract 05:46:51 INFO - mkdir: /builds/slave/test/build/tests 05:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:51 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:52 INFO - Downloaded 1361 bytes. 05:46:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:46:52 INFO - Using the following test package requirements: 05:46:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:46:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:46:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'jsshell-linux-x86_64.zip'], 05:46:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:46:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:46:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:46:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:46:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:46:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:46:52 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:46:52 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:53 INFO - Downloaded 24304672 bytes. 05:46:53 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:46:53 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:46:54 INFO - Return code: 0 05:46:54 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:46:54 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:46:54 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:55 INFO - Downloaded 24304672 bytes. 05:46:55 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:46:55 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:46:56 INFO - Return code: 0 05:46:56 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:46:56 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:46:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:57 INFO - Downloaded 14403333 bytes. 05:46:57 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:46:57 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:46:58 INFO - Return code: 0 05:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:58 INFO - https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZYUvIaIQ4mF3GQJABPKng/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:47:00 INFO - Downloaded 60450888 bytes. 05:47:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:00 INFO - mkdir: /builds/slave/test/properties 05:47:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:00 INFO - Contents: 05:47:00 INFO - build_url:https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:01 INFO - Running post-action listener: _resource_record_post_action 05:47:01 INFO - Running post-action listener: set_extra_try_arguments 05:47:01 INFO - ##### 05:47:01 INFO - ##### Finished download-and-extract step (success) 05:47:01 INFO - ##### 05:47:01 INFO - ##### 05:47:01 INFO - ##### Running populate-webroot step. 05:47:01 INFO - ##### 05:47:01 INFO - Running pre-action listener: _resource_record_pre_action 05:47:01 INFO - Running main action method: populate_webroot 05:47:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:01 INFO - '--tppagecycles', 05:47:01 INFO - '7'], 05:47:01 INFO - 'tests': ['tsvgm']}}, 05:47:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:47:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['damp', 'tps']}, 05:47:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'tests': ['damp', 'tps']}, 05:47:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['dromaeo_dom']}, 05:47:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['basic_compositor_video']}, 05:47:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:47:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['a11yr', 05:47:01 INFO - 'ts_paint', 05:47:01 INFO - 'tpaint', 05:47:01 INFO - 'sessionrestore', 05:47:01 INFO - 'sessionrestore_no_auto_restore', 05:47:01 INFO - 'tabpaint']}, 05:47:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:01 INFO - 'ts_paint', 05:47:01 INFO - 'tpaint', 05:47:01 INFO - 'sessionrestore', 05:47:01 INFO - 'sessionrestore_no_auto_restore', 05:47:01 INFO - 'tabpaint']}, 05:47:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:47:01 INFO - 'ts_paint', 05:47:01 INFO - 'tpaint', 05:47:01 INFO - 'sessionrestore', 05:47:01 INFO - 'sessionrestore_no_auto_restore', 05:47:01 INFO - 'tabpaint']}, 05:47:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:47:01 INFO - 'ts_paint', 05:47:01 INFO - 'tpaint', 05:47:01 INFO - 'sessionrestore', 05:47:01 INFO - 'sessionrestore_no_auto_restore', 05:47:01 INFO - 'tabpaint']}, 05:47:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['a11yr', 05:47:01 INFO - 'ts_paint', 05:47:01 INFO - 'tpaint', 05:47:01 INFO - 'sessionrestore', 05:47:01 INFO - 'sessionrestore_no_auto_restore', 05:47:01 INFO - 'tabpaint']}, 05:47:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['a11yr', 05:47:01 INFO - 'ts_paint', 05:47:01 INFO - 'tpaint', 05:47:01 INFO - 'sessionrestore', 05:47:01 INFO - 'sessionrestore_no_auto_restore', 05:47:01 INFO - 'tabpaint']}, 05:47:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['tsvgx', 05:47:01 INFO - 'tsvgr_opacity', 05:47:01 INFO - 'tart', 05:47:01 INFO - 'tscrollx', 05:47:01 INFO - 'cart']}, 05:47:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:01 INFO - 'tsvgr_opacity', 05:47:01 INFO - 'tart', 05:47:01 INFO - 'tscrollx', 05:47:01 INFO - 'cart']}, 05:47:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'talos_options': ['--disable-e10s'], 05:47:01 INFO - 'tests': ['tp5o']}, 05:47:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'tests': ['tp5o']}, 05:47:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'talos_options': ['--disable-e10s', 05:47:01 INFO - '--xperf_path', 05:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:01 INFO - 'tests': ['tp5n']}, 05:47:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:01 INFO - 'talos_options': ['--xperf_path', 05:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:01 INFO - 'tests': ['tp5n']}}, 05:47:01 INFO - 'talos.zip': {'path': '', 05:47:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:01 INFO - Running post-action listener: _resource_record_post_action 05:47:01 INFO - ##### 05:47:01 INFO - ##### Finished populate-webroot step (success) 05:47:01 INFO - ##### 05:47:01 INFO - ##### 05:47:01 INFO - ##### Running create-virtualenv step. 05:47:01 INFO - ##### 05:47:01 INFO - Running pre-action listener: _resource_record_pre_action 05:47:01 INFO - Running main action method: create_virtualenv 05:47:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47:01 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:47:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:47:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:01 INFO - Using real prefix '/usr' 05:47:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:47:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:04 INFO - Installing pip.................done. 05:47:04 INFO - Return code: 0 05:47:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:47:04 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:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:04 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:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:04 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:04 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:47:04 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:47:04 INFO - Using env: {'DISPLAY': ':0', 05:47:04 INFO - 'HOME': '/home/cltbld', 05:47:04 INFO - 'LANG': 'en_US.UTF-8', 05:47:04 INFO - 'LANGUAGE': 'en_US:en', 05:47:04 INFO - 'LOGNAME': 'cltbld', 05:47:04 INFO - 'MAIL': '/var/mail/cltbld', 05:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:04 INFO - 'MOZ_NO_REMOTE': '1', 05:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:04 INFO - 'NO_EM_RESTART': '1', 05:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:04 INFO - 'PWD': '/builds/slave/test', 05:47:04 INFO - 'SHELL': '/bin/bash', 05:47:04 INFO - 'SHLVL': '1', 05:47:04 INFO - 'TERM': 'linux', 05:47:04 INFO - 'TMOUT': '86400', 05:47:04 INFO - 'USER': 'cltbld', 05:47:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:04 INFO - '_': '/tools/buildbot/bin/python'} 05:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:04 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:47:04 INFO - Cleaning up... 05:47:04 INFO - Return code: 0 05:47:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:47:04 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:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:04 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:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:04 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:04 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:47:04 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:47:04 INFO - Using env: {'DISPLAY': ':0', 05:47:04 INFO - 'HOME': '/home/cltbld', 05:47:04 INFO - 'LANG': 'en_US.UTF-8', 05:47:04 INFO - 'LANGUAGE': 'en_US:en', 05:47:04 INFO - 'LOGNAME': 'cltbld', 05:47:04 INFO - 'MAIL': '/var/mail/cltbld', 05:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:04 INFO - 'MOZ_NO_REMOTE': '1', 05:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:04 INFO - 'NO_EM_RESTART': '1', 05:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:04 INFO - 'PWD': '/builds/slave/test', 05:47:04 INFO - 'SHELL': '/bin/bash', 05:47:04 INFO - 'SHLVL': '1', 05:47:04 INFO - 'TERM': 'linux', 05:47:04 INFO - 'TMOUT': '86400', 05:47:04 INFO - 'USER': 'cltbld', 05:47:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:04 INFO - '_': '/tools/buildbot/bin/python'} 05:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:04 INFO - Downloading/unpacking psutil>=3.1.1 05:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:06 INFO - Installing collected packages: psutil 05:47:06 INFO - Running setup.py install for psutil 05:47:06 INFO - building 'psutil._psutil_linux' extension 05:47:06 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:47:06 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:47:06 INFO - building 'psutil._psutil_posix' extension 05:47:06 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:47:06 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:47:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:07 INFO - Successfully installed psutil 05:47:07 INFO - Cleaning up... 05:47:07 INFO - Return code: 0 05:47:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:07 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:07 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:47:07 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:47:07 INFO - Using env: {'DISPLAY': ':0', 05:47:07 INFO - 'HOME': '/home/cltbld', 05:47:07 INFO - 'LANG': 'en_US.UTF-8', 05:47:07 INFO - 'LANGUAGE': 'en_US:en', 05:47:07 INFO - 'LOGNAME': 'cltbld', 05:47:07 INFO - 'MAIL': '/var/mail/cltbld', 05:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:07 INFO - 'MOZ_NO_REMOTE': '1', 05:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:07 INFO - 'NO_EM_RESTART': '1', 05:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:07 INFO - 'PWD': '/builds/slave/test', 05:47:07 INFO - 'SHELL': '/bin/bash', 05:47:07 INFO - 'SHLVL': '1', 05:47:07 INFO - 'TERM': 'linux', 05:47:07 INFO - 'TMOUT': '86400', 05:47:07 INFO - 'USER': 'cltbld', 05:47:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:07 INFO - '_': '/tools/buildbot/bin/python'} 05:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:09 INFO - Installing collected packages: mozsystemmonitor 05:47:09 INFO - Running setup.py install for mozsystemmonitor 05:47:09 INFO - Successfully installed mozsystemmonitor 05:47:09 INFO - Cleaning up... 05:47:09 INFO - Return code: 0 05:47:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:47: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:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:09 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:09 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:47:09 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:47:09 INFO - Using env: {'DISPLAY': ':0', 05:47:09 INFO - 'HOME': '/home/cltbld', 05:47:09 INFO - 'LANG': 'en_US.UTF-8', 05:47:09 INFO - 'LANGUAGE': 'en_US:en', 05:47:09 INFO - 'LOGNAME': 'cltbld', 05:47:09 INFO - 'MAIL': '/var/mail/cltbld', 05:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:09 INFO - 'MOZ_NO_REMOTE': '1', 05:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:09 INFO - 'NO_EM_RESTART': '1', 05:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:09 INFO - 'PWD': '/builds/slave/test', 05:47:09 INFO - 'SHELL': '/bin/bash', 05:47:09 INFO - 'SHLVL': '1', 05:47:09 INFO - 'TERM': 'linux', 05:47:09 INFO - 'TMOUT': '86400', 05:47:09 INFO - 'USER': 'cltbld', 05:47:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:09 INFO - '_': '/tools/buildbot/bin/python'} 05:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:09 INFO - Downloading/unpacking jsonschema==2.5.1 05:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:11 INFO - warning: no files found matching '*.txt' 05:47:11 INFO - no previously-included directories found matching 'build' 05:47:11 INFO - no previously-included directories found matching 'dist' 05:47:11 INFO - no previously-included directories found matching '.git*' 05:47:11 INFO - Installing collected packages: jsonschema, functools32 05:47:11 INFO - Running setup.py install for functools32 05:47:11 INFO - warning: no files found matching '*.txt' 05:47:11 INFO - no previously-included directories found matching 'build' 05:47:11 INFO - no previously-included directories found matching 'dist' 05:47:11 INFO - no previously-included directories found matching '.git*' 05:47:11 INFO - Successfully installed jsonschema functools32 05:47:11 INFO - Cleaning up... 05:47:11 INFO - Return code: 0 05:47:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:47:12 INFO - Using env: {'DISPLAY': ':0', 05:47:12 INFO - 'HOME': '/home/cltbld', 05:47:12 INFO - 'LANG': 'en_US.UTF-8', 05:47:12 INFO - 'LANGUAGE': 'en_US:en', 05:47:12 INFO - 'LOGNAME': 'cltbld', 05:47:12 INFO - 'MAIL': '/var/mail/cltbld', 05:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:12 INFO - 'MOZ_NO_REMOTE': '1', 05:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:12 INFO - 'NO_EM_RESTART': '1', 05:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:12 INFO - 'PWD': '/builds/slave/test', 05:47:12 INFO - 'SHELL': '/bin/bash', 05:47:12 INFO - 'SHLVL': '1', 05:47:12 INFO - 'TERM': 'linux', 05:47:12 INFO - 'TMOUT': '86400', 05:47:12 INFO - 'USER': 'cltbld', 05:47:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:12 INFO - '_': '/tools/buildbot/bin/python'} 05:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:14 INFO - Downloading docopt-0.6.1.tar.gz 05:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:14 INFO - Running setup.py install for blobuploader 05:47:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:14 INFO - Running setup.py install for requests 05:47:15 INFO - Running setup.py install for docopt 05:47:15 INFO - Successfully installed blobuploader requests docopt 05:47:15 INFO - Cleaning up... 05:47:15 INFO - Return code: 0 05:47:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:15 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:15 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:47:15 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:47:15 INFO - Using env: {'DISPLAY': ':0', 05:47:15 INFO - 'HOME': '/home/cltbld', 05:47:15 INFO - 'LANG': 'en_US.UTF-8', 05:47:15 INFO - 'LANGUAGE': 'en_US:en', 05:47:15 INFO - 'LOGNAME': 'cltbld', 05:47:15 INFO - 'MAIL': '/var/mail/cltbld', 05:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:15 INFO - 'MOZ_NO_REMOTE': '1', 05:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:15 INFO - 'NO_EM_RESTART': '1', 05:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:15 INFO - 'PWD': '/builds/slave/test', 05:47:15 INFO - 'SHELL': '/bin/bash', 05:47:15 INFO - 'SHLVL': '1', 05:47:15 INFO - 'TERM': 'linux', 05:47:15 INFO - 'TMOUT': '86400', 05:47:15 INFO - 'USER': 'cltbld', 05:47:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:15 INFO - '_': '/tools/buildbot/bin/python'} 05:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:15 INFO - Running setup.py (path:/tmp/pip-6hY6Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:15 INFO - Running setup.py (path:/tmp/pip-W9En0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:15 INFO - Running setup.py (path:/tmp/pip-VUlDXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:15 INFO - Running setup.py (path:/tmp/pip-dma70V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:15 INFO - Running setup.py (path:/tmp/pip-sZdcrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:16 INFO - Running setup.py (path:/tmp/pip-Qu0gn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:16 INFO - Running setup.py (path:/tmp/pip-oAHy4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:16 INFO - Running setup.py (path:/tmp/pip-LWtnCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:16 INFO - Running setup.py (path:/tmp/pip-1rb5kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:16 INFO - Running setup.py (path:/tmp/pip-AYvZhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:16 INFO - Running setup.py (path:/tmp/pip-UUn_2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:16 INFO - Running setup.py (path:/tmp/pip-JeYxkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:16 INFO - Running setup.py (path:/tmp/pip-hxBBqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:16 INFO - Running setup.py (path:/tmp/pip-5KscO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:16 INFO - Running setup.py (path:/tmp/pip-yI_v4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:16 INFO - Running setup.py (path:/tmp/pip-vnXvpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:16 INFO - Running setup.py (path:/tmp/pip-nFX3ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:16 INFO - Running setup.py install for manifestparser 05:47:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for mozcrash 05:47:17 INFO - Running setup.py install for mozdebug 05:47:17 INFO - Running setup.py install for mozdevice 05:47:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for mozfile 05:47:17 INFO - Running setup.py install for mozhttpd 05:47:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for mozinfo 05:47:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for mozInstall 05:47:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for mozleak 05:47:17 INFO - Running setup.py install for mozlog 05:47:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:17 INFO - Running setup.py install for moznetwork 05:47:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:18 INFO - Running setup.py install for mozprocess 05:47:18 INFO - Running setup.py install for mozprofile 05:47:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:18 INFO - Running setup.py install for mozrunner 05:47:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:18 INFO - Running setup.py install for mozscreenshot 05:47:18 INFO - Running setup.py install for moztest 05:47:18 INFO - Running setup.py install for mozversion 05:47:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:18 INFO - Cleaning up... 05:47:18 INFO - Return code: 0 05:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:18 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:18 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:47:18 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:47:18 INFO - Using env: {'DISPLAY': ':0', 05:47:18 INFO - 'HOME': '/home/cltbld', 05:47:18 INFO - 'LANG': 'en_US.UTF-8', 05:47:18 INFO - 'LANGUAGE': 'en_US:en', 05:47:18 INFO - 'LOGNAME': 'cltbld', 05:47:18 INFO - 'MAIL': '/var/mail/cltbld', 05:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:18 INFO - 'MOZ_NO_REMOTE': '1', 05:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:18 INFO - 'NO_EM_RESTART': '1', 05:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:18 INFO - 'PWD': '/builds/slave/test', 05:47:18 INFO - 'SHELL': '/bin/bash', 05:47:18 INFO - 'SHLVL': '1', 05:47:18 INFO - 'TERM': 'linux', 05:47:18 INFO - 'TMOUT': '86400', 05:47:18 INFO - 'USER': 'cltbld', 05:47:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:18 INFO - '_': '/tools/buildbot/bin/python'} 05:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:18 INFO - Running setup.py (path:/tmp/pip-MWsW0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:18 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:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:18 INFO - Running setup.py (path:/tmp/pip-nhfO0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:19 INFO - Running setup.py (path:/tmp/pip-usl81q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:19 INFO - Running setup.py (path:/tmp/pip-JVGtY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:19 INFO - Running setup.py (path:/tmp/pip-HiioDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:19 INFO - Running setup.py (path:/tmp/pip-8ELmLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:19 INFO - Running setup.py (path:/tmp/pip-69S8SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:19 INFO - Running setup.py (path:/tmp/pip-M8a6eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:19 INFO - Running setup.py (path:/tmp/pip-BRJUBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:19 INFO - Running setup.py (path:/tmp/pip-dI9Drv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:19 INFO - Running setup.py (path:/tmp/pip-FLbeoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:19 INFO - Running setup.py (path:/tmp/pip-N7zvZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:19 INFO - Running setup.py (path:/tmp/pip-gewbuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:19 INFO - Running setup.py (path:/tmp/pip-EdY2fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:19 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:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:19 INFO - Running setup.py (path:/tmp/pip-rWQROa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:20 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:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:20 INFO - Running setup.py (path:/tmp/pip-Of8EIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:20 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:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:20 INFO - Running setup.py (path:/tmp/pip-7mXWyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:20 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:47:20 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:47:20 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:47:20 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:47:20 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:47:20 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:47:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:22 INFO - Downloading blessings-1.6.tar.gz 05:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:22 INFO - Installing collected packages: blessings 05:47:22 INFO - Running setup.py install for blessings 05:47:22 INFO - Successfully installed blessings 05:47:22 INFO - Cleaning up... 05:47:22 INFO - Return code: 0 05:47:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:22 INFO - Reading from file tmpfile_stdout 05:47:22 INFO - Current package versions: 05:47:22 INFO - argparse == 1.2.1 05:47:22 INFO - blessings == 1.6 05:47:22 INFO - blobuploader == 1.2.4 05:47:22 INFO - docopt == 0.6.1 05:47:22 INFO - functools32 == 3.2.3-2 05:47:22 INFO - jsonschema == 2.5.1 05:47:22 INFO - manifestparser == 1.1 05:47:22 INFO - mozInstall == 1.12 05:47:22 INFO - mozcrash == 0.17 05:47:22 INFO - mozdebug == 0.1 05:47:22 INFO - mozdevice == 0.48 05:47:22 INFO - mozfile == 1.2 05:47:22 INFO - mozhttpd == 0.7 05:47:22 INFO - mozinfo == 0.9 05:47:22 INFO - mozleak == 0.1 05:47:22 INFO - mozlog == 3.2 05:47:22 INFO - moznetwork == 0.27 05:47:22 INFO - mozprocess == 0.23 05:47:22 INFO - mozprofile == 0.28 05:47:22 INFO - mozrunner == 6.12 05:47:22 INFO - mozscreenshot == 0.1 05:47:22 INFO - mozsystemmonitor == 0.3 05:47:22 INFO - moztest == 0.7 05:47:22 INFO - mozversion == 1.4 05:47:22 INFO - psutil == 3.1.1 05:47:22 INFO - requests == 1.2.3 05:47:22 INFO - wsgiref == 0.1.2 05:47:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:22 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:22 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:47:22 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:47:22 INFO - Using env: {'DISPLAY': ':0', 05:47:22 INFO - 'HOME': '/home/cltbld', 05:47:22 INFO - 'LANG': 'en_US.UTF-8', 05:47:22 INFO - 'LANGUAGE': 'en_US:en', 05:47:22 INFO - 'LOGNAME': 'cltbld', 05:47:22 INFO - 'MAIL': '/var/mail/cltbld', 05:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:22 INFO - 'MOZ_NO_REMOTE': '1', 05:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:22 INFO - 'NO_EM_RESTART': '1', 05:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:22 INFO - 'PWD': '/builds/slave/test', 05:47:22 INFO - 'SHELL': '/bin/bash', 05:47:22 INFO - 'SHLVL': '1', 05:47:22 INFO - 'TERM': 'linux', 05:47:22 INFO - 'TMOUT': '86400', 05:47:22 INFO - 'USER': 'cltbld', 05:47:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:22 INFO - '_': '/tools/buildbot/bin/python'} 05:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 INFO - Cleaning up... 05:47:22 INFO - Return code: 0 05:47:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:22 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 0x2a73030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d34180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', '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:47:22 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:47:22 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:47:22 INFO - Using env: {'DISPLAY': ':0', 05:47:22 INFO - 'HOME': '/home/cltbld', 05:47:22 INFO - 'LANG': 'en_US.UTF-8', 05:47:22 INFO - 'LANGUAGE': 'en_US:en', 05:47:22 INFO - 'LOGNAME': 'cltbld', 05:47:22 INFO - 'MAIL': '/var/mail/cltbld', 05:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:22 INFO - 'MOZ_NO_REMOTE': '1', 05:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:22 INFO - 'NO_EM_RESTART': '1', 05:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:22 INFO - 'PWD': '/builds/slave/test', 05:47:22 INFO - 'SHELL': '/bin/bash', 05:47:22 INFO - 'SHLVL': '1', 05:47:22 INFO - 'TERM': 'linux', 05:47:22 INFO - 'TMOUT': '86400', 05:47:22 INFO - 'USER': 'cltbld', 05:47:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:22 INFO - '_': '/tools/buildbot/bin/python'} 05:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:47:22 INFO - Cleaning up... 05:47:22 INFO - Return code: 0 05:47:22 INFO - Running post-action listener: _resource_record_post_action 05:47:22 INFO - Running post-action listener: _start_resource_monitoring 05:47:22 INFO - Starting resource monitoring. 05:47:22 INFO - ##### 05:47:22 INFO - ##### Finished create-virtualenv step (success) 05:47:22 INFO - ##### 05:47:22 INFO - ##### 05:47:22 INFO - ##### Running install step. 05:47:22 INFO - ##### 05:47:22 INFO - Running pre-action listener: _resource_record_pre_action 05:47:22 INFO - Running main action method: install 05:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:23 INFO - Reading from file tmpfile_stdout 05:47:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:47:23 INFO - Reading from file tmpfile_stdout 05:47:23 INFO - Output received: 05:47:23 INFO - Usage: mozinstall [options] installer 05:47:23 INFO - Options: 05:47:23 INFO - -h, --help show this help message and exit 05:47:23 INFO - -d DEST, --destination=DEST 05:47:23 INFO - Directory to install application into. [default: 05:47:23 INFO - "/builds/slave/test"] 05:47:23 INFO - --app=APP Application being installed. [default: firefox] 05:47:23 INFO - mkdir: /builds/slave/test/build/application 05:47:23 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:47:23 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:47:40 INFO - Reading from file tmpfile_stdout 05:47:40 INFO - Output received: 05:47:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:47:40 INFO - Running post-action listener: _resource_record_post_action 05:47:40 INFO - ##### 05:47:40 INFO - ##### Finished install step (success) 05:47:40 INFO - ##### 05:47:40 INFO - ##### 05:47:40 INFO - ##### Running run-tests step. 05:47:40 INFO - ##### 05:47:40 INFO - Running pre-action listener: _resource_record_pre_action 05:47:40 INFO - Running main action method: run_tests 05:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:40 INFO - Python 2.7.3 05:47:40 INFO - Return code: 0 05:47:40 INFO - grabbing minidump binary from tooltool 05:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:40 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 0x2d323b0>, '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 0x2d332b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d33740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:40 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:47:40 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:47:40 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:47:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:40 INFO - Return code: 0 05:47:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:47:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:47:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:40 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/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:47:40 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/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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:47:40 INFO - Using env: {'DISPLAY': ':0', 05:47:40 INFO - 'HOME': '/home/cltbld', 05:47:40 INFO - 'LANG': 'en_US.UTF-8', 05:47:40 INFO - 'LANGUAGE': 'en_US:en', 05:47:40 INFO - 'LOGNAME': 'cltbld', 05:47:40 INFO - 'MAIL': '/var/mail/cltbld', 05:47:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:40 INFO - 'MOZ_NO_REMOTE': '1', 05:47:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:40 INFO - 'NO_EM_RESTART': '1', 05:47:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:40 INFO - 'PWD': '/builds/slave/test', 05:47:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:40 INFO - 'SHELL': '/bin/bash', 05:47:40 INFO - 'SHLVL': '1', 05:47:40 INFO - 'TERM': 'linux', 05:47:40 INFO - 'TMOUT': '86400', 05:47:40 INFO - 'USER': 'cltbld', 05:47:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992', 05:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:40 INFO - '_': '/tools/buildbot/bin/python'} 05:47:40 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/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:47:40 INFO - mozversion application_buildid: 20160708023010 05:47:40 INFO - mozversion application_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 05:47:40 INFO - mozversion application_display_name: Nightly 05:47:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:40 INFO - mozversion application_name: Firefox 05:47:40 INFO - mozversion application_remotingname: firefox 05:47:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:47:40 INFO - mozversion application_vendor: Mozilla 05:47:40 INFO - mozversion application_version: 50.0a1 05:47:40 INFO - mozversion platform_buildid: 20160708023010 05:47:40 INFO - mozversion platform_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 05:47:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:47:40 INFO - mozversion platform_version: 50.0a1 05:47:40 INFO - using testdate: 1467982060 05:47:40 INFO - actual date: 1467982060 05:47:40 INFO - starting webserver on 'localhost:56970' 05:47:40 INFO - SUITE-START | Running 2 tests 05:47:40 INFO - TEST-START | dromaeo_css 05:47:40 INFO - operating with platform_type : linux_ 05:47:40 INFO - Initialising browser for dromaeo_css test... 05:47:40 INFO - TEST-INFO | started process 11794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf6ZG23/profile http://localhost:56970/getInfo.html) 05:47:44 INFO - PROCESS | 11794 | __metrics Screen width/height:1600/1200 05:47:44 INFO - PROCESS | 11794 | colorDepth:24 05:47:44 INFO - PROCESS | 11794 | Browser inner width/height: 1024/697 05:47:44 INFO - PROCESS | 11794 | __metrics 05:47:45 INFO - PROCESS | 11794 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:46 INFO - TEST-INFO | 11794: exit 0 05:47:46 INFO - Browser initialized. 05:47:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:46 INFO - TEST-INFO | started process 11876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf6ZG23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:58 INFO - PROCESS | 11876 | RSS: Main: 157577216 05:47:58 INFO - PROCESS | 11876 | 05:48:49 INFO - PROCESS | 11876 | 1467982129719 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:50:57 INFO - PROCESS | 11876 | Cycle 1(1): loaded http://localhost:56970/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56970/tests/dromaeo/cssquery-ext.html) 05:50:58 INFO - PROCESS | 11876 | RSS: Main: 258478080 05:50:58 INFO - PROCESS | 11876 | 05:54:01 INFO - PROCESS | 11876 | Cycle 1(1): loaded http://localhost:56970/tests/dromaeo/cssquery-ext.html (next: http://localhost:56970/tests/dromaeo/cssquery-jquery.html) 05:54:01 INFO - PROCESS | 11876 | RSS: Main: 247173120 05:54:01 INFO - PROCESS | 11876 | 05:57:03 INFO - PROCESS | 11876 | Cycle 1(1): loaded http://localhost:56970/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56970/tests/dromaeo/cssquery-mootools.html) 05:57:04 INFO - PROCESS | 11876 | RSS: Main: 240967680 05:57:04 INFO - PROCESS | 11876 | 06:00:06 INFO - PROCESS | 11876 | Cycle 1(1): loaded http://localhost:56970/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56970/tests/dromaeo/cssquery-prototype.html) 06:00:06 INFO - PROCESS | 11876 | RSS: Main: 243081216 06:00:06 INFO - PROCESS | 11876 | 06:03:09 INFO - PROCESS | 11876 | Cycle 1(1): loaded http://localhost:56970/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56970/tests/dromaeo/cssquery-yui.html) 06:03:10 INFO - PROCESS | 11876 | RSS: Main: 228286464 06:03:10 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | Cycle 1(1): loaded http://localhost:56970/tests/dromaeo/cssquery-yui.html (next: http://localhost:56970/tests/dromaeo/cssquery-dojo.html) 06:06:13 INFO - PROCESS | 11876 | RSS: Main: 275263488 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | __start_tp_report 06:06:13 INFO - PROCESS | 11876 | _x_x_mozilla_page_load 06:06:13 INFO - PROCESS | 11876 | _x_x_mozilla_page_load_details 06:06:13 INFO - PROCESS | 11876 | |i|pagename|runs| 06:06:13 INFO - PROCESS | 11876 | |0;dojo.html;3061.4489391909456;3082.2756652186717;3096.4116817804606;3097.411491816556;3121.9853547597036;5253.842384728464;5340.198970154479;5395.892082158354;5457.91813122803;5498.477644623759;5432;5446.754896029678;5456.208849716789;5477.808276710316;5528.336599608043;4891.461939186695;4945.7774400152075;4974.751262436882;4992.425871024824;5078.5175408336145;5026.9497305027035;5041.596672266228;5067.01193267313;5089.974550127245;5090.956353947432;4802.5197480252045;4873.147199240118;4892.461829198785;4925.482824303433;4932.80268789248;4907.754612269372;4936.284238785392;4986.700797952099;4999.075171093323;5031.924521132186;4761.690490118166;4937.580305673986;4957.355543779322;4970.701757894538;5007.874803129915;5318.228856815779;5374.677519348852;5389.622726409153;5439.782408703647;5443.101888188444;5829.067349224104;5849;5852.824415267549;5855.8536036599;5871.970640146815;5667.971660141714;5711.343195532525;5869.090291004901;5912.17229587858;5920.407959204088;5322.04203243416;5397.028534863723;5409.107497262947;5410.188471729232;5412.864678382994;5898.498627616615;5906.852328691731;5916.230889984275;5916.49709774674;5918.082697181943;5501.312335958005;5659.632123912015;5669.291338582677;5672.801451949244;5718.771249149988;5869.20765696634;5916.645001299936;5922.585419020714;5925.614835035709;5928.584999050025;5795.478406943395;5800.1589769484035;5836.533077353886;5836.591438599342;5841.4450627190345;5577.9163312550345;5649.180868774005;5676.574256930747;5684.943150568524;5790.71046447676;4345.174416860787;4347.804348804311;4348.782560871944;4396.648268138541;4417.911641767147;3927.8625248116177;3932.941005884914;3945.5265368156006;3985.5416627088257;3996.9400458993136;5449.182622606561;5472.20653005312;5509.724513774296;5516.365617953907;5572.359178694502;5805.622634528742;5807.622504537191;5817.156512305776;5824.621399609012;5865.2961644602065;5549.5837812164245;5550.72246387679;5559.583031272671;5562;5564.304461942257;4930.975345123252;4944.035912997003;4968.105740966661;4974.875628109254;5008.5993120550265;5980.312264089598;5984.640921544721;6001.969990150109;6011.579189456784;6011.789587364421;5606.915896261477;5832.300123985149;5836.9416305838095;5844.47399734009;5851.502622276984;5959.1657167995645;6015.518758499222;6020.638761674313;6036.517078633787;6040.607360521552;5642.6614403135945;5690.146478028329;5700.914486282792;5702.8289151325525;5702.91644587527;5652.660840349592;5737.770489180386;5804.709764511842;5808.883822323614;5813.912791308049;5612.971935140298;5623.8594035149445;5628.971855140698;5652.689102099424;5729.08334666468;5635.211070450058;5669.489745922887;5680.403557626555;5687.402822703722;5699.287589051369;5442.455754424526;5487.6981766003255;5518.917216241679;5623.1846382273525;5631.493165615114;5659.858503537444;5664.348599911063;5714.542836573148;5717;5741.684207368635;5532.336119665666;5572.0527510324155;5584.553235741212;5585.134304182858;5595.524380427709 06:06:13 INFO - PROCESS | 11876 | |1;ext.html;589.1957478042473;618.3044075415158;629.2606187729423;629.4995478594517;634.1502386801686;31422.84288578557;34280.48579271313;41932.37101443477;42768.786156069255;42796.14407711844;44193.11613767723;44652;44680.55319446813;44716.552834471644;44746.32880506795;8783.472991620507;8884.73345799627;8920.241779448756;8930.285577153812;8933.15135062168;8713.085126061767;8785.077566855483;8800.207981281683;8803.29573634111;8813.42712723674;8827.073157318453;8841.469511829278;8851.690190843321;8861.113888611151;8870.911290887105;8804.735857924272;8845;8849.778755531099;8853.778655533599;8861.069587693328;8699.565021748887;8777.253933415668;8779.165979231962;8780.780480487974;8783.736487905373;41462.79268603668;41584.12871420763;41750.58249417528;41752.1649567007;41783.582164178275;3625.6011838697723;3636.5817930938015;3694.3165514379925;3747.7189210809297;4224.134052519257;31830.522542161885;32222.355552889047;32541.186470338194;32825.6717432825;33427;4343.2182207202695;4440.422745043156;4456.398386217851;4466.620337271336;4497.302918047708;344758;345509;347455;348514;350792;34007.82996085004;34778.652213478046;56549.71725141348;57017;57071.14393284104;35586.28827423489;35943.64056359403;36015.27969440597;36021.09947251287;36023.279534409165;14887.330070146869;15185.772213416807;15192.164430956404;15195.772063419057;15196.468123615841;12265.141440099285;12326;12355.567555135527;12357.196782209128;12365.07261955339;8094.1501142380375;8159.67361305553;8174.877376839352;8189.181081891882;8197.303229225583;3221.9677803221666;3224.967750322514;3245.6105267368066;3246.935061298761;3265.42855000374;986.4525188520297;1020.4438580973388;1055.4247934875357;1163.2264544078093;1242.3477674220926;32510.349793004007;32732.836335818643;32750.836245819097;32863.671363286536;33583;1077.9407132607782;1103.1946678924269;1129.9322040677587;1153.3022521374614;1177.0701146094489;16945.406910758065;17001.574960626083;17068.146592670564;17148.742768858476;17368.82631173672;598896;619501;627866;1064093;1065764;58537.41462585405;59131;60163.39836601578;60200.69899650474;60310.095348569805;1241.1436109084702;1336.365226517416;1379.558541266785;1387.6955661677991;1400.845906950255;29422;31641;34166.487502687974;34324.313513730085;34475.482867757506;51771;52634.736826315624;52706.20940685816;52814.73592632012;52837.47162528326;504020;514016;516984;518039;521282;43928.78035609802;44131;44820;44935.32597011113;47323.52676473191;48171.75914120547;49035.01929961452;49161.75419123025;49198.50801491939;49443.50556494533;41305;42158.36762448504;42418;43141.56858431501;43262.351064733426;41219.38170927379;41912.3713144297;42019.7289756885;42403.575964241194;43006.78496607622;40302.596974031054;40376.79811600923;41005.79497102495;41786.37320440135;42615;36142.8192859034;37548.43677344787;37601.811990939874;38206.808965954995;38425;28349.858250708614;28741.56887646729;28851;28921;28954 06:06:13 INFO - PROCESS | 11876 | |2;jquery.html;361.3784291019449;388.7531417549857;393.7460338081937;395.8673844262171;415.9292920203565;14447.205403702805;16358.509244722662;19009.904950475262;19476.90261548694;19534.41396758096;18490.907545462287;18555.907220463912;18798.718019229724;18843.152058157382;18869.433916982478;4210.810513526899;5568.9443105569035;5755.971220143914;5763.452472015152;5775.913361299584;6173.475254603341;6543.1821022372205;6554.11519444876;6571.901421478682;6579.934200658004;6244.12582238487;6425.710843012076;6427.035944608323;6438.935610643904;6496.870062598745;6244.281907580641;6395.616263024233;6402.071699603554;6405.679716014204;6430.421262086411;5561.610687251894;5588.413216612278;5613.438656134354;5632.7746890124345;5646.435356464362;22429.32712018642;22991.425214369607;23097.653535196987;23163.88418057899;23616.64575031376;2349.8120150387927;2351.776581224781;2382.213869423086;2456.361346050022;2569.0494517028633;14274.14355138695;14508.864208087716;14846.851531484655;14886.404543818235;15120.09279443226;1931.51712071982;1954.775200851906;1985.642584334819;2008.8794672319561;2061.1137210999264;77278.61360693161;79490;79604.60197699032;79818.60090699568;81830.59084704539;10392.740181495523;10781.9460902695;10838.458077096113;10975.28660637056;11267.26762760418;15231.086134831945;15270.541883743506;15366.154861482726;15370.615734606501;15383.692326153414;7652.808679782938;7896.763097107096;8308.875366869503;8504.44721093127;8547.487150770974;8159.755207343789;8186.426950113435;8197.877031844528;8350.707725229588;8383.11977242393;4636.582707556337;4771.5228477152;4781.378420805273;4796.304535842283;4856.538628830255;1920.7503024606713;1924.6728056230475;1947.9805201948082;1972.457574167087;2018.5861898310811;927.1933417926447;965.2133511188359;1011.9747006324901;1020.0768304684273;1036.4817591204398;19653.803461965483;19855.404337869888;19989.800101999084;20016;20563.691544626843;970.9611615535299;994.8955359687274;1012.8936461671566;1017.760826205841;1028.4651980969854;10850.620228291971;11136.498857551429;11137.164712646583;11154.10767138627;11162.162837787198;494156;496762;497724;502143;504213;77028;90392.54803725939;93041.06958930459;93056;99584;1017.3387298256044;1035.2494441529982;1055.4775386183887;1062.697131317571;1062.8405739139191;18282.360117395827;18307.450776476726;18684.532886677942;18748.81251187525;18873.71689424687;44654;44985.550144498135;45605.77197113993;45766.28883956753;46824.297635534815;63684;64645.353546463935;64841.35158648353;65468.672656638315;66407;8611.440256383315;8714.346424018097;8788.296936245213;8958.731238062868;9050.547472626475;13166.736665266833;13656.112352697042;13878.306084695523;14000.369983350978;14025.438982440588;12554.309512976874;12654;12926.159799612995;13008.8048679268;13063.738725225632;12468.438920248793;12529.749405011666;12551.246925184518;12778.87221127814;12852.357382131044;12421.44103515362;12456.875431245571;12855.550055748377;12926;12974.35128243603;8715.782105447415;8841.292696584387;8997.865032024394;9133.725988220363;9208.493532855757;11841.763164736829;12244.265344079384;12513.687157821127;12567.560135395217;12648.557300494438 06:06:13 INFO - PROCESS | 11876 | |3;mootools.html;1427.9428822847083;1493.3354657177556;1587.2381256996641;1742.9651406971852;1762.6915289824285;8382.37132215084;8834.072422395637;8931.687390941319;8936.15106564876;8947;7358.668859901304;8359.623816928253;8586.87119693205;8587.227149556538;8748.300135989122;2255.9210427635035;2279.430142464384;2282.429392651837;2283.817294616435;2284.3261237934767;2271.46620544172;2280.973561897153;2309.6304591265402;2310.803581695558;2312.2947501012186;1839.1539891649857;2166.274298110135;2204.206485665159;2214.678871563622;2226.8886555672234;2236.955260894773;2237.798598126168;2261.7964383205426;2263.343630347197;2263.875486848223;2243.5849367866836;2249.089118906845;2251;2254.7970682638643;2256.6840642309926;8819;8898.688545900926;8902.198802107841;8916.866247006301;8918.063603321623;4960.479149689267;4998;5044.243363495469;5071.847844564669;5085.974570127126;3266.3304022675293;3362.546056282395;3428.160100775301;3432.48512723091;3475.3049390121823;1078.6440474643348;1115.4813011949402;1120.1710734056821;1123.1015187849769;1141.8001849676357;12324.32216228116;12332.198407103599;12342.074344424203;12358.382080895919;12359.876401236052;4267.466566679165;4386.1008493258805;4481.081378317437;4536.977315113403;4552.521985191574;10141.18870490359;10193.745156371002;10194.082532572103;10199.898001020043;10200.43897585625;5061.215511595708;5066.797328106908;5068.163752980717;5071.54356107952;5074.746262686851;4564.543545645409;4625.121226966866;4627.791749371287;4629.907401852011;4684.273937539687;3943.2310699413338;3950.427188057773;3996.2407142643387;4060.7360521566593;4065.654419374327;1128.114430172311;1247.6257122863105;1258.4966013594635;1261.1676293646149;1282.7113899372566;875.0899064972357;959.0074273127279;963.8457846744627;983.7245571240064;1022.4580972084807;5927.703614819242;5954.523638108941;6047.485963693048;6077.9392206078255;6100.542459315569;906.6237511432813;941.110650435332;944.2295695570805;952.5951470624957;984.5667906121283;4080.7755573443746;4144.79276036197;4151.56408577095;4194.2450358935685;4201.474815648044;10615.363078215178;11012.834807477895;11085.612003579836;11190.628498320852;11204;9505;9867.654632087842;11083.72290692723;11091.22361434708;11091.33451992883;7802.414818888606;7856.567888766059;7932.206779322021;7938.325242354349;7943.602819858984;5710.571707122065;5874.5887787854435;6009.669468179292;6174.845628859314;6232.283287422005;9305.86041209396;10232.744181395226;10270.691879243635;10295.94852025735;10336.121429678562;9765.316427849983;9917.404955702681;10003.199744020316;10026.69919902404;10038.046385593358;7433.8141546461775;7534.39724822002;7580.1661817198965;7598.354139898171;7666.884996724942;8479.61841717112;8518.61666225009;8575.828483430172;8581.65673373058;8587.527685977082;7655.119661239029;7862.72480463181;7866.174051724715;7978.800529986796;8007.35941124697;7367;7481.438892083007;7483.513571617827;7635.350995165473;7663.8850417242675;7161.892571611325;7167.713291468492;7209.0988626421695;7215.8556828864175;7221.241769614115;5201.401838788588;5334.253204551444;5345.679259244458;5414.593905457185;5498.862528436821;5293.12663410533;5439.347278326626;5478.780848766005;5499.50504454601;5616.887662246814 06:06:13 INFO - PROCESS | 11876 | |4;prototype.html;293.5816461542303;305.463910836482;310.2615774456792;310.62414478481037;313.0358495832835;5253.4221235664045;5255.421903590607;5292.603054770889;5305.946940530594;5316.813911513098;4944.554990050895;4988.3515143031445;5186.636935414523;5197.142471492209;5208.8697782555455;4061.979690101545;4089.9182016359655;4127.463429754142;4141.668666506672;4141.730787498818;4090.4886889138857;4091.1408604193007;4124.793760311987;4132.896677583054;4138.97930510347;3857.961420385788;3991.7604943703327;4085;4088.34586466164;4105.158442519277;4076.3681629347498;4087.816048277835;4092.836286548549;4099.159672267178;4112.856050038265;3635.836387362575;3652.5069115669576;3657.1588534636917;3666.3034023535442;3666.4500324951205;5053.747312634354;5091.614076639067;5101.336826212569;5149.716765577892;5203.557697595709;4700.764961751899;4713.6464765142755;4724.551167639069;4750.216214324632;4756.6908150970075;5438.293021907166;5443.1835224716215;5451.155070964007;5501.669899806025;5520.806771762969;3887.455756194107;3941.132950750859;3952.347862602667;3966.960330396717;4031.2743706132883;5571.275734154575;5606.607537472379;5614.242077319551;5624.15637654351;5642.492175704207;4026.0941288210506;4057.756534607933;4060.959390406117;4065.8780236592947;4070.7964601769795;4003.8398464061693;4082.1223436960604;4098.569650186747;4103.322951712994;4106.917861642751;4621.1219868224925;4660.57852355035;4667.486576476585;4707.8587642370785;4720.221163507983;5427.538659214011;5453.15476101205;5465.535429488538;5494;5503;1389.9305034748425;1395.8693458298608;1409.83082030155;1416.6175132714316;1425.1876430434552;892.0276898181014;900.6127365232882;920.2362039507193;922.5525620074259;925.6482536636036;4708.964027913854;4729.290606409066;4732.787024583902;4736.64475164364;4749.905001899942;4912.656114072052;4952.331435256267;4964.503549645006;5004.84985450437;5020.974895125574;4537.750423726727;4720.433547974265;4725.763711814396;4751;4761.619070474354;2611.582146856532;2636.5498975563746;2648.3511539672904;2652.4429869727574;2660.3748119191973;5066.873328166826;5076.949230507722;5093.439721630618;5155.407128180233;5167.767450464738;4740.45484769249;5004.274380214849;5021.297018417425;5057.887264801738;5104.438511763703;5084.754235212396;5098.821541246039;5110.48895110486;5112.872178195575;5197.974010129925;4981.427135879276;5004.549590536869;5036.974815125901;5044.949550504448;5065.265536497261;4961.330220420341;4969.577585905238;5012.498750124958;5126.769295381791;5587.860303492283;5837.795677151279;5839.708014599338;5843.181954526284;5859.326177489644;5870.207521984648;3824.388097904322;3987.2623564640635;4040.616141466556;4051.513818341818;4058.431819545207;5531.197976293495;5644.153376993484;5653.378128405954;5659.9151012735665;5717.857053573527;5479.972600136974;5490.286262785812;5500.7524661391135;5566.387697353369;5570.693611851225;5297.708626025606;5526.47498487643;5550.69471179089;5577.470140336662;5581.888362232651;5446.782128714965;5480.6437581557075;5481.753321100639;5492.752826122754;5509.228707980806;5570.6657600544095;5578.693171875586;5588.636738611977;5598.1322894951345;5642.746076426489;5309.7256658402475;5417.674939503642;5420.701861397661;5463.043967305626;5475.151351540518 06:06:13 INFO - PROCESS | 11876 | |5;yui.html;777.8872063550785;781.96872125115;802.1056521977995;810.9513429194247;812.2040400407597;14897.702045959088;15746.370145194207;16367.4271400501;16413.015219086847;16429.83570164298;14057.859421405783;14204.28978551071;14251.643708907282;14256.215908125048;14263.072900261503;651.0787236060968;791.5329955326356;792.8295416485469;811.2414892075899;813.353384059674;794.6702118620766;800.8718605023197;800.9719659811908;801.0227522422664;810.9553974531399;831.094107422912;837.6188834080509;838.2581415447343;838.7022606974527;838.8280402517499;676.1683129750435;831.7047448155938;832.9916700832974;835.6448509383519;845.3913182508584;620.7951376045894;620.8199622109582;621.4469122480996;621.6114928169894;621.878733646939;14013.089149205269;14045.227512486808;14052.297385130805;14072.718545629132;14116.576502704935;14127.505537306144;14564.563063108124;14620.561383158521;14665.120092794466;14670.413183472649;13263.137896036824;13388.93305533466;13417.194968301836;13647;14062;4585.380973568593;4594.862154135381;4657.906841863144;4787.688800227974;4795.880102997418;72093.63953180253;74067;74156.25843741547;75367.62316188439;76775.84836227405;11384.260023098472;11621.100578358017;11720.88279117198;11766.823497647541;12159.756804863853;21527.138914443247;21690.132394704036;21771.45571360697;21776.237831675815;22421.775782242294;8880.51157186361;8977.730668079968;9048.909510904938;9134.451932884049;9341.626334946663;4744.217204161275;4817.638677099231;4844.128056949783;4880.170371036861;5051.116054690415;3487.3199726053176;3587.7488575799966;3590.08452844523;3591.3894637911617;3595.8381872815785;634.6572850660684;637.0094503047712;652.9249136349381;662.063180599456;672.3478226120656;689.7787333154182;721.7509959064115;724.1455083002108;731.7512045904418;742.4802638153315;9749.268804839665;9944.45305508204;9980.80038399228;10015.899841001643;10226;596.7702434562725;682.3483573187594;693.227051837208;716.6022857314241;727.0475676863326;4880.341153944243;4970.751462426936;4972.849956080757;4980.206996665696;5012.5984564410965;114435.42782286035;116836.41581792207;117151;117358.41320793341;120494;57995.54210319004;71107;84100.57949710212;97769;100592.49703751435;77112.2288777105;78107.60946195232;80233;84565.57717211498;91998;9395.248380129437;9589.952050239704;9809.607615695293;9940;10042.297039207186;50942.235866462775;51633.22550161826;52326;52383;52784;73358;77528;78258.60870695837;78356;79153.20846791458;13203.66990825237;13453.327333633475;13526.458941642617;13668;14270.001099922905;14940.124509298406;15119.470818521298;15222.761860911876;15843.287052082453;16090.67818643644;13987;14784.63038424048;14805.703885922436;15207.467738629095;15258.465953691568;13001.349932503148;13430.798538022133;13457.663558410726;13473.528426505025;13476.797848032484;13552.671444820164;13725.794113088512;13784;14302.356393962506;14654.706905862036;10853.891461085605;11061.83407248908;11084.279521831055;11276.041536469493;11474.713132171762;9528;9554;9640.373375730554;9699.896033269286;9753.707388778348 06:06:13 INFO - PROCESS | 11876 | __end_tp_report 06:06:13 INFO - PROCESS | 11876 | __start_cc_report 06:06:13 INFO - PROCESS | 11876 | _x_x_mozilla_cycle_collect,871 06:06:13 INFO - PROCESS | 11876 | __end_cc_report 06:06:13 INFO - PROCESS | 11876 | __startTimestamp1467983173342__endTimestamp 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | ------- Summary: start ------- 06:06:13 INFO - PROCESS | 11876 | Number of tests: 6 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | [#0] dojo.html Cycles:165 Average:5386.89 Median:5584.55 stddev:617.60 (11.1%) stddev-sans-first:591.94 06:06:13 INFO - PROCESS | 11876 | Values: 3061.4 3082.3 3096.4 3097.4 3122.0 5253.8 5340.2 5395.9 5457.9 5498.5 5432.0 5446.8 5456.2 5477.8 5528.3 4891.5 4945.8 4974.8 4992.4 5078.5 5026.9 5041.6 5067.0 5090.0 5091.0 4802.5 4873.1 4892.5 4925.5 4932.8 4907.8 4936.3 4986.7 4999.1 5031.9 4761.7 4937.6 4957.4 4970.7 5007.9 5318.2 5374.7 5389.6 5439.8 5443.1 5829.1 5849.0 5852.8 5855.9 5872.0 5668.0 5711.3 5869.1 5912.2 5920.4 5322.0 5397.0 5409.1 5410.2 5412.9 5898.5 5906.9 5916.2 5916.5 5918.1 5501.3 5659.6 5669.3 5672.8 5718.8 5869.2 5916.6 5922.6 5925.6 5928.6 5795.5 5800.2 5836.5 5836.6 5841.4 5577.9 5649.2 5676.6 5684.9 5790.7 4345.2 4347.8 4348.8 4396.6 4417.9 3927.9 3932.9 3945.5 3985.5 3996.9 5449.2 5472.2 5509.7 5516.4 5572.4 5805.6 5807.6 5817.2 5824.6 5865.3 5549.6 5550.7 5559.6 5562.0 5564.3 4931.0 4944.0 4968.1 4974.9 5008.6 5980.3 5984.6 6002.0 6011.6 6011.8 5606.9 5832.3 5836.9 5844.5 5851.5 5959.2 6015.5 6020.6 6036.5 6040.6 5642.7 5690.1 5700.9 5702.8 5702.9 5652.7 5737.8 5804.7 5808.9 5813.9 5613.0 5623.9 5629.0 5652.7 5729.1 5635.2 5669.5 5680.4 5687.4 5699.3 5442.5 5487.7 5518.9 5623.2 5631.5 5659.9 5664.3 5714.5 5717.0 5741.7 5532.3 5572.1 5584.6 5585.1 5595.5 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | [#1] ext.html Cycles:180 Average:68760.53 Median:41922.37 stddev:161019.24 (384.1%) stddev-sans-first:161389.59 06:06:13 INFO - PROCESS | 11876 | Values: 589.2 618.3 629.3 629.5 634.2 31422.8 34280.5 41932.4 42768.8 42796.1 44193.1 44652.0 44680.6 44716.6 44746.3 8783.5 8884.7 8920.2 8930.3 8933.2 8713.1 8785.1 8800.2 8803.3 8813.4 8827.1 8841.5 8851.7 8861.1 8870.9 8804.7 8845.0 8849.8 8853.8 8861.1 8699.6 8777.3 8779.2 8780.8 8783.7 41462.8 41584.1 41750.6 41752.2 41783.6 3625.6 3636.6 3694.3 3747.7 4224.1 31830.5 32222.4 32541.2 32825.7 33427.0 4343.2 4440.4 4456.4 4466.6 4497.3 344758.0 345509.0 347455.0 348514.0 350792.0 34007.8 34778.7 56549.7 57017.0 57071.1 35586.3 35943.6 36015.3 36021.1 36023.3 14887.3 15185.8 15192.2 15195.8 15196.5 12265.1 12326.0 12355.6 12357.2 12365.1 8094.2 8159.7 8174.9 8189.2 8197.3 3222.0 3225.0 3245.6 3246.9 3265.4 986.5 1020.4 1055.4 1163.2 1242.3 32510.3 32732.8 32750.8 32863.7 33583.0 1077.9 1103.2 1129.9 1153.3 1177.1 16945.4 17001.6 17068.1 17148.7 17368.8 598896.0 619501.0 627866.0 1064093.0 1065764.0 58537.4 59131.0 60163.4 60200.7 60310.1 1241.1 1336.4 1379.6 1387.7 1400.8 29422.0 31641.0 34166.5 34324.3 34475.5 51771.0 52634.7 52706.2 52814.7 52837.5 504020.0 514016.0 516984.0 518039.0 521282.0 43928.8 44131.0 44820.0 44935.3 47323.5 48171.8 49035.0 49161.8 49198.5 49443.5 41305.0 42158.4 42418.0 43141.6 43262.4 41219.4 41912.4 42019.7 42403.6 43006.8 40302.6 40376.8 41005.8 41786.4 42615.0 36142.8 37548.4 37601.8 38206.8 38425.0 28349.9 28741.6 28851.0 28921.0 28954.0 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | [#2] jquery.html Cycles:180 Average:29814.98 Median:2350.79 stddev:82202.60 (3496.8%) stddev-sans-first:82403.45 06:06:13 INFO - PROCESS | 11876 | Values: 361.4 388.8 393.7 395.9 415.9 14447.2 16358.5 19009.9 19476.9 19534.4 18490.9 18555.9 18798.7 18843.2 18869.4 4210.8 5568.9 5756.0 5763.5 5775.9 6173.5 6543.2 6554.1 6571.9 6579.9 6244.1 6425.7 6427.0 6438.9 6496.9 6244.3 6395.6 6402.1 6405.7 6430.4 5561.6 5588.4 5613.4 5632.8 5646.4 22429.3 22991.4 23097.7 23163.9 23616.6 2349.8 2351.8 2382.2 2456.4 2569.0 14274.1 14508.9 14846.9 14886.4 15120.1 1931.5 1954.8 1985.6 2008.9 2061.1 77278.6 79490.0 79604.6 79818.6 81830.6 10392.7 10781.9 10838.5 10975.3 11267.3 15231.1 15270.5 15366.2 15370.6 15383.7 7652.8 7896.8 8308.9 8504.4 8547.5 8159.8 8186.4 8197.9 8350.7 8383.1 4636.6 4771.5 4781.4 4796.3 4856.5 1920.8 1924.7 1948.0 1972.5 2018.6 927.2 965.2 1012.0 1020.1 1036.5 19653.8 19855.4 19989.8 20016.0 20563.7 971.0 994.9 1012.9 1017.8 1028.5 10850.6 11136.5 11137.2 11154.1 11162.2 494156.0 496762.0 497724.0 502143.0 504213.0 77028.0 90392.5 93041.1 93056.0 99584.0 1017.3 1035.2 1055.5 1062.7 1062.8 18282.4 18307.5 18684.5 18748.8 18873.7 44654.0 44985.6 45605.8 45766.3 46824.3 63684.0 64645.4 64841.4 65468.7 66407.0 8611.4 8714.3 8788.3 8958.7 9050.5 13166.7 13656.1 13878.3 14000.4 14025.4 12554.3 12654.0 12926.2 13008.8 13063.7 12468.4 12529.7 12551.2 12778.9 12852.4 12421.4 12456.9 12855.6 12926.0 12974.4 8715.8 8841.3 8997.9 9133.7 9208.5 11841.8 12244.3 12513.7 12567.6 12648.6 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | [#3] mootools.html Cycles:180 Average:5760.62 Median:4822.38 stddev:3278.58 (68.0%) stddev-sans-first:3271.60 06:06:13 INFO - PROCESS | 11876 | Values: 1427.9 1493.3 1587.2 1743.0 1762.7 8382.4 8834.1 8931.7 8936.2 8947.0 7358.7 8359.6 8586.9 8587.2 8748.3 2255.9 2279.4 2282.4 2283.8 2284.3 2271.5 2281.0 2309.6 2310.8 2312.3 1839.2 2166.3 2204.2 2214.7 2226.9 2237.0 2237.8 2261.8 2263.3 2263.9 2243.6 2249.1 2251.0 2254.8 2256.7 8819.0 8898.7 8902.2 8916.9 8918.1 4960.5 4998.0 5044.2 5071.8 5086.0 3266.3 3362.5 3428.2 3432.5 3475.3 1078.6 1115.5 1120.2 1123.1 1141.8 12324.3 12332.2 12342.1 12358.4 12359.9 4267.5 4386.1 4481.1 4537.0 4552.5 10141.2 10193.7 10194.1 10199.9 10200.4 5061.2 5066.8 5068.2 5071.5 5074.7 4564.5 4625.1 4627.8 4629.9 4684.3 3943.2 3950.4 3996.2 4060.7 4065.7 1128.1 1247.6 1258.5 1261.2 1282.7 875.1 959.0 963.8 983.7 1022.5 5927.7 5954.5 6047.5 6077.9 6100.5 906.6 941.1 944.2 952.6 984.6 4080.8 4144.8 4151.6 4194.2 4201.5 10615.4 11012.8 11085.6 11190.6 11204.0 9505.0 9867.7 11083.7 11091.2 11091.3 7802.4 7856.6 7932.2 7938.3 7943.6 5710.6 5874.6 6009.7 6174.8 6232.3 9305.9 10232.7 10270.7 10295.9 10336.1 9765.3 9917.4 10003.2 10026.7 10038.0 7433.8 7534.4 7580.2 7598.4 7666.9 8479.6 8518.6 8575.8 8581.7 8587.5 7655.1 7862.7 7866.2 7978.8 8007.4 7367.0 7481.4 7483.5 7635.4 7663.9 7161.9 7167.7 7209.1 7215.9 7221.2 5201.4 5334.3 5345.7 5414.6 5498.9 5293.1 5439.3 5478.8 5499.5 5616.9 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | [#4] prototype.html Cycles:180 Average:4489.30 Median:5004.70 stddev:1302.02 (26.0%) stddev-sans-first:1267.02 06:06:13 INFO - PROCESS | 11876 | Values: 293.6 305.5 310.3 310.6 313.0 5253.4 5255.4 5292.6 5305.9 5316.8 4944.6 4988.4 5186.6 5197.1 5208.9 4062.0 4089.9 4127.5 4141.7 4141.7 4090.5 4091.1 4124.8 4132.9 4139.0 3858.0 3991.8 4085.0 4088.3 4105.2 4076.4 4087.8 4092.8 4099.2 4112.9 3635.8 3652.5 3657.2 3666.3 3666.5 5053.7 5091.6 5101.3 5149.7 5203.6 4700.8 4713.6 4724.6 4750.2 4756.7 5438.3 5443.2 5451.2 5501.7 5520.8 3887.5 3941.1 3952.3 3967.0 4031.3 5571.3 5606.6 5614.2 5624.2 5642.5 4026.1 4057.8 4061.0 4065.9 4070.8 4003.8 4082.1 4098.6 4103.3 4106.9 4621.1 4660.6 4667.5 4707.9 4720.2 5427.5 5453.2 5465.5 5494.0 5503.0 1389.9 1395.9 1409.8 1416.6 1425.2 892.0 900.6 920.2 922.6 925.6 4709.0 4729.3 4732.8 4736.6 4749.9 4912.7 4952.3 4964.5 5004.8 5021.0 4537.8 4720.4 4725.8 4751.0 4761.6 2611.6 2636.5 2648.4 2652.4 2660.4 5066.9 5076.9 5093.4 5155.4 5167.8 4740.5 5004.3 5021.3 5057.9 5104.4 5084.8 5098.8 5110.5 5112.9 5198.0 4981.4 5004.5 5037.0 5044.9 5065.3 4961.3 4969.6 5012.5 5126.8 5587.9 5837.8 5839.7 5843.2 5859.3 5870.2 3824.4 3987.3 4040.6 4051.5 4058.4 5531.2 5644.2 5653.4 5659.9 5717.9 5480.0 5490.3 5500.8 5566.4 5570.7 5297.7 5526.5 5550.7 5577.5 5581.9 5446.8 5480.6 5481.8 5492.8 5509.2 5570.7 5578.7 5588.6 5598.1 5642.7 5309.7 5417.7 5420.7 5463.0 5475.2 06:06:13 INFO - PROCESS | 11876 | 06:06:13 INFO - PROCESS | 11876 | [#5] yui.html Cycles:180 Average:20481.20 Median:4976.53 stddev:28954.23 (581.8%) stddev-sans-first:28997.66 06:06:13 INFO - PROCESS | 11876 | Values: 777.9 782.0 802.1 811.0 812.2 14897.7 15746.4 16367.4 16413.0 16429.8 14057.9 14204.3 14251.6 14256.2 14263.1 651.1 791.5 792.8 811.2 813.4 794.7 800.9 801.0 801.0 811.0 831.1 837.6 838.3 838.7 838.8 676.2 831.7 833.0 835.6 845.4 620.8 620.8 621.4 621.6 621.9 14013.1 14045.2 14052.3 14072.7 14116.6 14127.5 14564.6 14620.6 14665.1 14670.4 13263.1 13388.9 13417.2 13647.0 14062.0 4585.4 4594.9 4657.9 4787.7 4795.9 72093.6 74067.0 74156.3 75367.6 76775.8 11384.3 11621.1 11720.9 11766.8 12159.8 21527.1 21690.1 21771.5 21776.2 22421.8 8880.5 8977.7 9048.9 9134.5 9341.6 4744.2 4817.6 4844.1 4880.2 5051.1 3487.3 3587.7 3590.1 3591.4 3595.8 634.7 637.0 652.9 662.1 672.3 689.8 721.8 724.1 731.8 742.5 9749.3 9944.5 9980.8 10015.9 10226.0 596.8 682.3 693.2 716.6 727.0 4880.3 4970.8 4972.8 4980.2 5012.6 114435.4 116836.4 117151.0 117358.4 120494.0 57995.5 71107.0 84100.6 97769.0 100592.5 77112.2 78107.6 80233.0 84565.6 91998.0 9395.2 9590.0 9809.6 9940.0 10042.3 50942.2 51633.2 52326.0 52383.0 52784.0 73358.0 77528.0 78258.6 78356.0 79153.2 13203.7 13453.3 13526.5 13668.0 14270.0 14940.1 15119.5 15222.8 15843.3 16090.7 13987.0 14784.6 14805.7 15207.5 15258.5 13001.3 13430.8 13457.7 13473.5 13476.8 13552.7 13725.8 13784.0 14302.4 14654.7 10853.9 11061.8 11084.3 11276.0 11474.7 9528.0 9554.0 9640.4 9699.9 9753.7 06:06:13 INFO - PROCESS | 11876 | -------- Summary: end -------- 06:06:13 INFO - PROCESS | 11876 | 06:06:14 INFO - TEST-INFO | 11876: exit 0 06:06:14 INFO - TEST-OK | dromaeo_css | took 1113421ms 06:06:14 INFO - TEST-START | kraken 06:06:14 INFO - operating with platform_type : linux_ 06:06:14 INFO - Initialising browser for kraken test... 06:06:14 INFO - TEST-INFO | started process 12066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8diNYx/profile http://localhost:56970/getInfo.html) 06:06:18 INFO - PROCESS | 12066 | __metrics Screen width/height:1600/1200 06:06:18 INFO - PROCESS | 12066 | colorDepth:24 06:06:18 INFO - PROCESS | 12066 | Browser inner width/height: 1024/697 06:06:18 INFO - PROCESS | 12066 | __metrics 06:06:18 INFO - PROCESS | 12066 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:19 INFO - TEST-INFO | 12066: exit 0 06:06:19 INFO - Browser initialized. 06:06:19 INFO - Running cycle 1/1 for kraken test... 06:06:19 INFO - TEST-INFO | started process 12147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8diNYx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:31 INFO - PROCESS | 12147 | RSS: Main: 157331456 06:06:31 INFO - PROCESS | 12147 | 06:06:34 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56970/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:35 INFO - PROCESS | 12147 | RSS: Main: 215625728 06:06:35 INFO - PROCESS | 12147 | 06:06:37 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56970/tests/kraken/driver.html?testName=audio-dft) 06:06:38 INFO - PROCESS | 12147 | RSS: Main: 203894784 06:06:38 INFO - PROCESS | 12147 | 06:06:41 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56970/tests/kraken/driver.html?testName=audio-fft) 06:06:42 INFO - PROCESS | 12147 | RSS: Main: 270417920 06:06:42 INFO - PROCESS | 12147 | 06:06:44 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56970/tests/kraken/driver.html?testName=audio-oscillator) 06:06:44 INFO - PROCESS | 12147 | RSS: Main: 180486144 06:06:44 INFO - PROCESS | 12147 | 06:06:46 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56970/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:47 INFO - PROCESS | 12147 | RSS: Main: 184922112 06:06:47 INFO - PROCESS | 12147 | 06:06:50 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56970/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:51 INFO - PROCESS | 12147 | RSS: Main: 219500544 06:06:51 INFO - PROCESS | 12147 | 06:06:54 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56970/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:55 INFO - PROCESS | 12147 | RSS: Main: 221483008 06:06:55 INFO - PROCESS | 12147 | 06:06:57 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56970/tests/kraken/driver.html?testName=json-parse-financial) 06:06:58 INFO - PROCESS | 12147 | RSS: Main: 221769728 06:06:58 INFO - PROCESS | 12147 | 06:06:59 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56970/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:00 INFO - PROCESS | 12147 | RSS: Main: 208048128 06:07:00 INFO - PROCESS | 12147 | 06:07:02 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:02 INFO - PROCESS | 12147 | RSS: Main: 211787776 06:07:02 INFO - PROCESS | 12147 | 06:07:04 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:05 INFO - PROCESS | 12147 | RSS: Main: 214278144 06:07:05 INFO - PROCESS | 12147 | 06:07:08 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:08 INFO - PROCESS | 12147 | RSS: Main: 223457280 06:07:08 INFO - PROCESS | 12147 | 06:07:11 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:12 INFO - PROCESS | 12147 | RSS: Main: 225513472 06:07:12 INFO - PROCESS | 12147 | 06:07:13 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:56970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56970/tests/kraken/driver.html?testName=ai-astar) 06:07:14 INFO - PROCESS | 12147 | RSS: Main: 268320768 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | __start_tp_report 06:07:14 INFO - PROCESS | 12147 | _x_x_mozilla_page_load 06:07:14 INFO - PROCESS | 12147 | _x_x_mozilla_page_load_details 06:07:14 INFO - PROCESS | 12147 | |i|pagename|runs| 06:07:14 INFO - PROCESS | 12147 | |0;ai-astar;105;114;111;112;113;110;112;112;111;111 06:07:14 INFO - PROCESS | 12147 | |1;audio-beat-detection;145;116;120;168;118;120;145;121;163;117 06:07:14 INFO - PROCESS | 12147 | |2;audio-dft;159;161;160;162;161;161;160;162;161;160 06:07:14 INFO - PROCESS | 12147 | |3;audio-fft;75;75;76;126;76;77;76;74;103;75 06:07:14 INFO - PROCESS | 12147 | |4;audio-oscillator;83;85;113;85;83;83;118;84;84;128 06:07:14 INFO - PROCESS | 12147 | |5;imaging-gaussian-blur;116;117;116;116;117;118;117;117;117;117 06:07:14 INFO - PROCESS | 12147 | |6;imaging-darkroom;148;149;149;148;148;148;149;148;148;148 06:07:14 INFO - PROCESS | 12147 | |7;imaging-desaturate;95;95;96;95;96;96;95;95;95;95 06:07:14 INFO - PROCESS | 12147 | |8;json-parse-financial;53;54;53;54;53;53;54;54;54;54 06:07:14 INFO - PROCESS | 12147 | |9;json-stringify-tinderbox;62;63;62;62;63;62;62;62;62;61 06:07:14 INFO - PROCESS | 12147 | |10;stanford-crypto-aes;78;79;78;87;79;78;78;87;78;92 06:07:14 INFO - PROCESS | 12147 | |11;stanford-crypto-ccm;126;142;136;128;129;120;129;117;161;118 06:07:14 INFO - PROCESS | 12147 | |12;stanford-crypto-pbkdf2;162;161;162;158;157;157;159;156;155;160 06:07:14 INFO - PROCESS | 12147 | |13;stanford-crypto-sha256-iterative;62;62;68;62;63;62;62;62;61;65 06:07:14 INFO - PROCESS | 12147 | __end_tp_report 06:07:14 INFO - PROCESS | 12147 | __start_cc_report 06:07:14 INFO - PROCESS | 12147 | _x_x_mozilla_cycle_collect,1673 06:07:14 INFO - PROCESS | 12147 | __end_cc_report 06:07:14 INFO - PROCESS | 12147 | __startTimestamp1467983234020__endTimestamp 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | ------- Summary: start ------- 06:07:14 INFO - PROCESS | 12147 | Number of tests: 14 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.42 (2.2%) stddev-sans-first:1.20 06:07:14 INFO - PROCESS | 12147 | Values: 105.0 114.0 111.0 112.0 113.0 110.0 112.0 112.0 111.0 111.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:133.00 stddev:20.18 (15.2%) stddev-sans-first:20.95 06:07:14 INFO - PROCESS | 12147 | Values: 145.0 116.0 120.0 168.0 118.0 120.0 145.0 121.0 163.0 117.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.78 06:07:14 INFO - PROCESS | 12147 | Values: 159.0 161.0 160.0 162.0 161.0 161.0 160.0 162.0 161.0 160.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.50 stddev:17.33 (23.0%) stddev-sans-first:18.12 06:07:14 INFO - PROCESS | 12147 | Values: 75.0 75.0 76.0 126.0 76.0 77.0 76.0 74.0 103.0 75.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.50 stddev:17.68 (21.2%) stddev-sans-first:18.25 06:07:14 INFO - PROCESS | 12147 | Values: 83.0 85.0 113.0 85.0 83.0 83.0 118.0 84.0 84.0 128.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 06:07:14 INFO - PROCESS | 12147 | Values: 116.0 117.0 116.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:07:14 INFO - PROCESS | 12147 | Values: 148.0 149.0 149.0 148.0 148.0 148.0 149.0 148.0 148.0 148.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:07:14 INFO - PROCESS | 12147 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 06:07:14 INFO - PROCESS | 12147 | Values: 53.0 54.0 53.0 54.0 53.0 53.0 54.0 54.0 54.0 54.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:07:14 INFO - PROCESS | 12147 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 62.0 62.0 62.0 61.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:79.00 stddev:5.21 (6.6%) stddev-sans-first:5.38 06:07:14 INFO - PROCESS | 12147 | Values: 78.0 79.0 78.0 87.0 79.0 78.0 78.0 87.0 78.0 92.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:129.00 stddev:13.22 (10.2%) stddev-sans-first:13.91 06:07:14 INFO - PROCESS | 12147 | Values: 126.0 142.0 136.0 128.0 129.0 120.0 129.0 117.0 161.0 118.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.50 stddev:2.50 (1.6%) stddev-sans-first:2.35 06:07:14 INFO - PROCESS | 12147 | Values: 162.0 161.0 162.0 158.0 157.0 157.0 159.0 156.0 155.0 160.0 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - PROCESS | 12147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.00 stddev:2.08 (3.4%) stddev-sans-first:2.18 06:07:14 INFO - PROCESS | 12147 | Values: 62.0 62.0 68.0 62.0 63.0 62.0 62.0 62.0 61.0 65.0 06:07:14 INFO - PROCESS | 12147 | -------- Summary: end -------- 06:07:14 INFO - PROCESS | 12147 | 06:07:14 INFO - TEST-INFO | 12147: exit 0 06:07:14 INFO - TEST-OK | kraken | took 60862ms 06:07:14 INFO - SUITE-END | took 1174s 06:07:15 INFO - Completed test suite (00:19:34) 06:07:15 INFO - javascript benchmark 06:07:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.4489391909456, 3082.2756652186717, 3096.4116817804606, 3097.411491816556, 3121.9853547597036, 5253.842384728464, 5340.198970154479, 5395.892082158354, 5457.91813122803, 5498.477644623759, 5432.0, 5446.754896029678, 5456.208849716789, 5477.808276710316, 5528.336599608043, 4891.461939186695, 4945.7774400152075, 4974.751262436882, 4992.425871024824, 5078.5175408336145, 5026.9497305027035, 5041.596672266228, 5067.01193267313, 5089.974550127245, 5090.956353947432, 4802.5197480252045, 4873.147199240118, 4892.461829198785, 4925.482824303433, 4932.80268789248, 4907.754612269372, 4936.284238785392, 4986.700797952099, 4999.075171093323, 5031.924521132186, 4761.690490118166, 4937.580305673986, 4957.355543779322, 4970.701757894538, 5007.874803129915, 5318.228856815779, 5374.677519348852, 5389.622726409153, 5439.782408703647, 5443.101888188444, 5829.067349224104, 5849.0, 5852.824415267549, 5855.8536036599, 5871.970640146815, 5667.971660141714, 5711.343195532525, 5869.090291004901, 5912.17229587858, 5920.407959204088, 5322.04203243416, 5397.028534863723, 5409.107497262947, 5410.188471729232, 5412.864678382994, 5898.498627616615, 5906.852328691731, 5916.230889984275, 5916.49709774674, 5918.082697181943, 5501.312335958005, 5659.632123912015, 5669.291338582677, 5672.801451949244, 5718.771249149988, 5869.20765696634, 5916.645001299936, 5922.585419020714, 5925.614835035709, 5928.584999050025, 5795.478406943395, 5800.1589769484035, 5836.533077353886, 5836.591438599342, 5841.4450627190345, 5577.9163312550345, 5649.180868774005, 5676.574256930747, 5684.943150568524, 5790.71046447676, 4345.174416860787, 4347.804348804311, 4348.782560871944, 4396.648268138541, 4417.911641767147, 3927.8625248116177, 3932.941005884914, 3945.5265368156006, 3985.5416627088257, 3996.9400458993136, 5449.182622606561, 5472.20653005312, 5509.724513774296, 5516.365617953907, 5572.359178694502, 5805.622634528742, 5807.622504537191, 5817.156512305776, 5824.621399609012, 5865.2961644602065, 5549.5837812164245, 5550.72246387679, 5559.583031272671, 5562.0, 5564.304461942257, 4930.975345123252, 4944.035912997003, 4968.105740966661, 4974.875628109254, 5008.5993120550265, 5980.312264089598, 5984.640921544721, 6001.969990150109, 6011.579189456784, 6011.789587364421, 5606.915896261477, 5832.300123985149, 5836.9416305838095, 5844.47399734009, 5851.502622276984, 5959.1657167995645, 6015.518758499222, 6020.638761674313, 6036.517078633787, 6040.607360521552, 5642.6614403135945, 5690.146478028329, 5700.914486282792, 5702.8289151325525, 5702.91644587527, 5652.660840349592, 5737.770489180386, 5804.709764511842, 5808.883822323614, 5813.912791308049, 5612.971935140298, 5623.8594035149445, 5628.971855140698, 5652.689102099424, 5729.08334666468, 5635.211070450058, 5669.489745922887, 5680.403557626555, 5687.402822703722, 5699.287589051369, 5442.455754424526, 5487.6981766003255, 5518.917216241679, 5623.1846382273525, 5631.493165615114, 5659.858503537444, 5664.348599911063, 5714.542836573148, 5717.0, 5741.684207368635, 5532.336119665666, 5572.0527510324155, 5584.553235741212, 5585.134304182858, 5595.524380427709], "value": 5344.41165526312, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.1957478042473, 618.3044075415158, 629.2606187729423, 629.4995478594517, 634.1502386801686, 31422.84288578557, 34280.48579271313, 41932.37101443477, 42768.786156069255, 42796.14407711844, 44193.11613767723, 44652.0, 44680.55319446813, 44716.552834471644, 44746.32880506795, 8783.472991620507, 8884.73345799627, 8920.241779448756, 8930.285577153812, 8933.15135062168, 8713.085126061767, 8785.077566855483, 8800.207981281683, 8803.29573634111, 8813.42712723674, 8827.073157318453, 8841.469511829278, 8851.690190843321, 8861.113888611151, 8870.911290887105, 8804.735857924272, 8845.0, 8849.778755531099, 8853.778655533599, 8861.069587693328, 8699.565021748887, 8777.253933415668, 8779.165979231962, 8780.780480487974, 8783.736487905373, 41462.79268603668, 41584.12871420763, 41750.58249417528, 41752.1649567007, 41783.582164178275, 3625.6011838697723, 3636.5817930938015, 3694.3165514379925, 3747.7189210809297, 4224.134052519257, 31830.522542161885, 32222.355552889047, 32541.186470338194, 32825.6717432825, 33427.0, 4343.2182207202695, 4440.422745043156, 4456.398386217851, 4466.620337271336, 4497.302918047708, 344758.0, 345509.0, 347455.0, 348514.0, 350792.0, 34007.82996085004, 34778.652213478046, 56549.71725141348, 57017.0, 57071.14393284104, 35586.28827423489, 35943.64056359403, 36015.27969440597, 36021.09947251287, 36023.279534409165, 14887.330070146869, 15185.772213416807, 15192.164430956404, 15195.772063419057, 15196.468123615841, 12265.141440099285, 12326.0, 12355.567555135527, 12357.196782209128, 12365.07261955339, 8094.1501142380375, 8159.67361305553, 8174.877376839352, 8189.181081891882, 8197.303229225583, 3221.9677803221666, 3224.967750322514, 3245.6105267368066, 3246.935061298761, 3265.42855000374, 986.4525188520297, 1020.4438580973388, 1055.4247934875357, 1163.2264544078093, 1242.3477674220926, 32510.349793004007, 32732.836335818643, 32750.836245819097, 32863.671363286536, 33583.0, 1077.9407132607782, 1103.1946678924269, 1129.9322040677587, 1153.3022521374614, 1177.0701146094489, 16945.406910758065, 17001.574960626083, 17068.146592670564, 17148.742768858476, 17368.82631173672, 598896.0, 619501.0, 627866.0, 1064093.0, 1065764.0, 58537.41462585405, 59131.0, 60163.39836601578, 60200.69899650474, 60310.095348569805, 1241.1436109084702, 1336.365226517416, 1379.558541266785, 1387.6955661677991, 1400.845906950255, 29422.0, 31641.0, 34166.487502687974, 34324.313513730085, 34475.482867757506, 51771.0, 52634.736826315624, 52706.20940685816, 52814.73592632012, 52837.47162528326, 504020.0, 514016.0, 516984.0, 518039.0, 521282.0, 43928.78035609802, 44131.0, 44820.0, 44935.32597011113, 47323.52676473191, 48171.75914120547, 49035.01929961452, 49161.75419123025, 49198.50801491939, 49443.50556494533, 41305.0, 42158.36762448504, 42418.0, 43141.56858431501, 43262.351064733426, 41219.38170927379, 41912.3713144297, 42019.7289756885, 42403.575964241194, 43006.78496607622, 40302.596974031054, 40376.79811600923, 41005.79497102495, 41786.37320440135, 42615.0, 36142.8192859034, 37548.43677344787, 37601.811990939874, 38206.808965954995, 38425.0, 28349.858250708614, 28741.56887646729, 28851.0, 28921.0, 28954.0], "value": 19484.231762258347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.3784291019449, 388.7531417549857, 393.7460338081937, 395.8673844262171, 415.9292920203565, 14447.205403702805, 16358.509244722662, 19009.904950475262, 19476.90261548694, 19534.41396758096, 18490.907545462287, 18555.907220463912, 18798.718019229724, 18843.152058157382, 18869.433916982478, 4210.810513526899, 5568.9443105569035, 5755.971220143914, 5763.452472015152, 5775.913361299584, 6173.475254603341, 6543.1821022372205, 6554.11519444876, 6571.901421478682, 6579.934200658004, 6244.12582238487, 6425.710843012076, 6427.035944608323, 6438.935610643904, 6496.870062598745, 6244.281907580641, 6395.616263024233, 6402.071699603554, 6405.679716014204, 6430.421262086411, 5561.610687251894, 5588.413216612278, 5613.438656134354, 5632.7746890124345, 5646.435356464362, 22429.32712018642, 22991.425214369607, 23097.653535196987, 23163.88418057899, 23616.64575031376, 2349.8120150387927, 2351.776581224781, 2382.213869423086, 2456.361346050022, 2569.0494517028633, 14274.14355138695, 14508.864208087716, 14846.851531484655, 14886.404543818235, 15120.09279443226, 1931.51712071982, 1954.775200851906, 1985.642584334819, 2008.8794672319561, 2061.1137210999264, 77278.61360693161, 79490.0, 79604.60197699032, 79818.60090699568, 81830.59084704539, 10392.740181495523, 10781.9460902695, 10838.458077096113, 10975.28660637056, 11267.26762760418, 15231.086134831945, 15270.541883743506, 15366.154861482726, 15370.615734606501, 15383.692326153414, 7652.808679782938, 7896.763097107096, 8308.875366869503, 8504.44721093127, 8547.487150770974, 8159.755207343789, 8186.426950113435, 8197.877031844528, 8350.707725229588, 8383.11977242393, 4636.582707556337, 4771.5228477152, 4781.378420805273, 4796.304535842283, 4856.538628830255, 1920.7503024606713, 1924.6728056230475, 1947.9805201948082, 1972.457574167087, 2018.5861898310811, 927.1933417926447, 965.2133511188359, 1011.9747006324901, 1020.0768304684273, 1036.4817591204398, 19653.803461965483, 19855.404337869888, 19989.800101999084, 20016.0, 20563.691544626843, 970.9611615535299, 994.8955359687274, 1012.8936461671566, 1017.760826205841, 1028.4651980969854, 10850.620228291971, 11136.498857551429, 11137.164712646583, 11154.10767138627, 11162.162837787198, 494156.0, 496762.0, 497724.0, 502143.0, 504213.0, 77028.0, 90392.54803725939, 93041.06958930459, 93056.0, 99584.0, 1017.3387298256044, 1035.2494441529982, 1055.4775386183887, 1062.697131317571, 1062.8405739139191, 18282.360117395827, 18307.450776476726, 18684.532886677942, 18748.81251187525, 18873.71689424687, 44654.0, 44985.550144498135, 45605.77197113993, 45766.28883956753, 46824.297635534815, 63684.0, 64645.353546463935, 64841.35158648353, 65468.672656638315, 66407.0, 8611.440256383315, 8714.346424018097, 8788.296936245213, 8958.731238062868, 9050.547472626475, 13166.736665266833, 13656.112352697042, 13878.306084695523, 14000.369983350978, 14025.438982440588, 12554.309512976874, 12654.0, 12926.159799612995, 13008.8048679268, 13063.738725225632, 12468.438920248793, 12529.749405011666, 12551.246925184518, 12778.87221127814, 12852.357382131044, 12421.44103515362, 12456.875431245571, 12855.550055748377, 12926.0, 12974.35128243603, 8715.782105447415, 8841.292696584387, 8997.865032024394, 9133.725988220363, 9208.493532855757, 11841.763164736829, 12244.265344079384, 12513.687157821127, 12567.560135395217, 12648.557300494438], "value": 9600.101701834617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.9428822847083, 1493.3354657177556, 1587.2381256996641, 1742.9651406971852, 1762.6915289824285, 8382.37132215084, 8834.072422395637, 8931.687390941319, 8936.15106564876, 8947.0, 7358.668859901304, 8359.623816928253, 8586.87119693205, 8587.227149556538, 8748.300135989122, 2255.9210427635035, 2279.430142464384, 2282.429392651837, 2283.817294616435, 2284.3261237934767, 2271.46620544172, 2280.973561897153, 2309.6304591265402, 2310.803581695558, 2312.2947501012186, 1839.1539891649857, 2166.274298110135, 2204.206485665159, 2214.678871563622, 2226.8886555672234, 2236.955260894773, 2237.798598126168, 2261.7964383205426, 2263.343630347197, 2263.875486848223, 2243.5849367866836, 2249.089118906845, 2251.0, 2254.7970682638643, 2256.6840642309926, 8819.0, 8898.688545900926, 8902.198802107841, 8916.866247006301, 8918.063603321623, 4960.479149689267, 4998.0, 5044.243363495469, 5071.847844564669, 5085.974570127126, 3266.3304022675293, 3362.546056282395, 3428.160100775301, 3432.48512723091, 3475.3049390121823, 1078.6440474643348, 1115.4813011949402, 1120.1710734056821, 1123.1015187849769, 1141.8001849676357, 12324.32216228116, 12332.198407103599, 12342.074344424203, 12358.382080895919, 12359.876401236052, 4267.466566679165, 4386.1008493258805, 4481.081378317437, 4536.977315113403, 4552.521985191574, 10141.18870490359, 10193.745156371002, 10194.082532572103, 10199.898001020043, 10200.43897585625, 5061.215511595708, 5066.797328106908, 5068.163752980717, 5071.54356107952, 5074.746262686851, 4564.543545645409, 4625.121226966866, 4627.791749371287, 4629.907401852011, 4684.273937539687, 3943.2310699413338, 3950.427188057773, 3996.2407142643387, 4060.7360521566593, 4065.654419374327, 1128.114430172311, 1247.6257122863105, 1258.4966013594635, 1261.1676293646149, 1282.7113899372566, 875.0899064972357, 959.0074273127279, 963.8457846744627, 983.7245571240064, 1022.4580972084807, 5927.703614819242, 5954.523638108941, 6047.485963693048, 6077.9392206078255, 6100.542459315569, 906.6237511432813, 941.110650435332, 944.2295695570805, 952.5951470624957, 984.5667906121283, 4080.7755573443746, 4144.79276036197, 4151.56408577095, 4194.2450358935685, 4201.474815648044, 10615.363078215178, 11012.834807477895, 11085.612003579836, 11190.628498320852, 11204.0, 9505.0, 9867.654632087842, 11083.72290692723, 11091.22361434708, 11091.33451992883, 7802.414818888606, 7856.567888766059, 7932.206779322021, 7938.325242354349, 7943.602819858984, 5710.571707122065, 5874.5887787854435, 6009.669468179292, 6174.845628859314, 6232.283287422005, 9305.86041209396, 10232.744181395226, 10270.691879243635, 10295.94852025735, 10336.121429678562, 9765.316427849983, 9917.404955702681, 10003.199744020316, 10026.69919902404, 10038.046385593358, 7433.8141546461775, 7534.39724822002, 7580.1661817198965, 7598.354139898171, 7666.884996724942, 8479.61841717112, 8518.61666225009, 8575.828483430172, 8581.65673373058, 8587.527685977082, 7655.119661239029, 7862.72480463181, 7866.174051724715, 7978.800529986796, 8007.35941124697, 7367.0, 7481.438892083007, 7483.513571617827, 7635.350995165473, 7663.8850417242675, 7161.892571611325, 7167.713291468492, 7209.0988626421695, 7215.8556828864175, 7221.241769614115, 5201.401838788588, 5334.253204551444, 5345.679259244458, 5414.593905457185, 5498.862528436821, 5293.12663410533, 5439.347278326626, 5478.780848766005, 5499.50504454601, 5616.887662246814], "value": 4603.059705337952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.5816461542303, 305.463910836482, 310.2615774456792, 310.62414478481037, 313.0358495832835, 5253.4221235664045, 5255.421903590607, 5292.603054770889, 5305.946940530594, 5316.813911513098, 4944.554990050895, 4988.3515143031445, 5186.636935414523, 5197.142471492209, 5208.8697782555455, 4061.979690101545, 4089.9182016359655, 4127.463429754142, 4141.668666506672, 4141.730787498818, 4090.4886889138857, 4091.1408604193007, 4124.793760311987, 4132.896677583054, 4138.97930510347, 3857.961420385788, 3991.7604943703327, 4085.0, 4088.34586466164, 4105.158442519277, 4076.3681629347498, 4087.816048277835, 4092.836286548549, 4099.159672267178, 4112.856050038265, 3635.836387362575, 3652.5069115669576, 3657.1588534636917, 3666.3034023535442, 3666.4500324951205, 5053.747312634354, 5091.614076639067, 5101.336826212569, 5149.716765577892, 5203.557697595709, 4700.764961751899, 4713.6464765142755, 4724.551167639069, 4750.216214324632, 4756.6908150970075, 5438.293021907166, 5443.1835224716215, 5451.155070964007, 5501.669899806025, 5520.806771762969, 3887.455756194107, 3941.132950750859, 3952.347862602667, 3966.960330396717, 4031.2743706132883, 5571.275734154575, 5606.607537472379, 5614.242077319551, 5624.15637654351, 5642.492175704207, 4026.0941288210506, 4057.756534607933, 4060.959390406117, 4065.8780236592947, 4070.7964601769795, 4003.8398464061693, 4082.1223436960604, 4098.569650186747, 4103.322951712994, 4106.917861642751, 4621.1219868224925, 4660.57852355035, 4667.486576476585, 4707.8587642370785, 4720.221163507983, 5427.538659214011, 5453.15476101205, 5465.535429488538, 5494.0, 5503.0, 1389.9305034748425, 1395.8693458298608, 1409.83082030155, 1416.6175132714316, 1425.1876430434552, 892.0276898181014, 900.6127365232882, 920.2362039507193, 922.5525620074259, 925.6482536636036, 4708.964027913854, 4729.290606409066, 4732.787024583902, 4736.64475164364, 4749.905001899942, 4912.656114072052, 4952.331435256267, 4964.503549645006, 5004.84985450437, 5020.974895125574, 4537.750423726727, 4720.433547974265, 4725.763711814396, 4751.0, 4761.619070474354, 2611.582146856532, 2636.5498975563746, 2648.3511539672904, 2652.4429869727574, 2660.3748119191973, 5066.873328166826, 5076.949230507722, 5093.439721630618, 5155.407128180233, 5167.767450464738, 4740.45484769249, 5004.274380214849, 5021.297018417425, 5057.887264801738, 5104.438511763703, 5084.754235212396, 5098.821541246039, 5110.48895110486, 5112.872178195575, 5197.974010129925, 4981.427135879276, 5004.549590536869, 5036.974815125901, 5044.949550504448, 5065.265536497261, 4961.330220420341, 4969.577585905238, 5012.498750124958, 5126.769295381791, 5587.860303492283, 5837.795677151279, 5839.708014599338, 5843.181954526284, 5859.326177489644, 5870.207521984648, 3824.388097904322, 3987.2623564640635, 4040.616141466556, 4051.513818341818, 4058.431819545207, 5531.197976293495, 5644.153376993484, 5653.378128405954, 5659.9151012735665, 5717.857053573527, 5479.972600136974, 5490.286262785812, 5500.7524661391135, 5566.387697353369, 5570.693611851225, 5297.708626025606, 5526.47498487643, 5550.69471179089, 5577.470140336662, 5581.888362232651, 5446.782128714965, 5480.6437581557075, 5481.753321100639, 5492.752826122754, 5509.228707980806, 5570.6657600544095, 5578.693171875586, 5588.636738611977, 5598.1322894951345, 5642.746076426489, 5309.7256658402475, 5417.674939503642, 5420.701861397661, 5463.043967305626, 5475.151351540518], "value": 4070.370562326674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.8872063550785, 781.96872125115, 802.1056521977995, 810.9513429194247, 812.2040400407597, 14897.702045959088, 15746.370145194207, 16367.4271400501, 16413.015219086847, 16429.83570164298, 14057.859421405783, 14204.28978551071, 14251.643708907282, 14256.215908125048, 14263.072900261503, 651.0787236060968, 791.5329955326356, 792.8295416485469, 811.2414892075899, 813.353384059674, 794.6702118620766, 800.8718605023197, 800.9719659811908, 801.0227522422664, 810.9553974531399, 831.094107422912, 837.6188834080509, 838.2581415447343, 838.7022606974527, 838.8280402517499, 676.1683129750435, 831.7047448155938, 832.9916700832974, 835.6448509383519, 845.3913182508584, 620.7951376045894, 620.8199622109582, 621.4469122480996, 621.6114928169894, 621.878733646939, 14013.089149205269, 14045.227512486808, 14052.297385130805, 14072.718545629132, 14116.576502704935, 14127.505537306144, 14564.563063108124, 14620.561383158521, 14665.120092794466, 14670.413183472649, 13263.137896036824, 13388.93305533466, 13417.194968301836, 13647.0, 14062.0, 4585.380973568593, 4594.862154135381, 4657.906841863144, 4787.688800227974, 4795.880102997418, 72093.63953180253, 74067.0, 74156.25843741547, 75367.62316188439, 76775.84836227405, 11384.260023098472, 11621.100578358017, 11720.88279117198, 11766.823497647541, 12159.756804863853, 21527.138914443247, 21690.132394704036, 21771.45571360697, 21776.237831675815, 22421.775782242294, 8880.51157186361, 8977.730668079968, 9048.909510904938, 9134.451932884049, 9341.626334946663, 4744.217204161275, 4817.638677099231, 4844.128056949783, 4880.170371036861, 5051.116054690415, 3487.3199726053176, 3587.7488575799966, 3590.08452844523, 3591.3894637911617, 3595.8381872815785, 634.6572850660684, 637.0094503047712, 652.9249136349381, 662.063180599456, 672.3478226120656, 689.7787333154182, 721.7509959064115, 724.1455083002108, 731.7512045904418, 742.4802638153315, 9749.268804839665, 9944.45305508204, 9980.80038399228, 10015.899841001643, 10226.0, 596.7702434562725, 682.3483573187594, 693.227051837208, 716.6022857314241, 727.0475676863326, 4880.341153944243, 4970.751462426936, 4972.849956080757, 4980.206996665696, 5012.5984564410965, 114435.42782286035, 116836.41581792207, 117151.0, 117358.41320793341, 120494.0, 57995.54210319004, 71107.0, 84100.57949710212, 97769.0, 100592.49703751435, 77112.2288777105, 78107.60946195232, 80233.0, 84565.57717211498, 91998.0, 9395.248380129437, 9589.952050239704, 9809.607615695293, 9940.0, 10042.297039207186, 50942.235866462775, 51633.22550161826, 52326.0, 52383.0, 52784.0, 73358.0, 77528.0, 78258.60870695837, 78356.0, 79153.20846791458, 13203.66990825237, 13453.327333633475, 13526.458941642617, 13668.0, 14270.001099922905, 14940.124509298406, 15119.470818521298, 15222.761860911876, 15843.287052082453, 16090.67818643644, 13987.0, 14784.63038424048, 14805.703885922436, 15207.467738629095, 15258.465953691568, 13001.349932503148, 13430.798538022133, 13457.663558410726, 13473.528426505025, 13476.797848032484, 13552.671444820164, 13725.794113088512, 13784.0, 14302.356393962506, 14654.706905862036, 10853.891461085605, 11061.83407248908, 11084.279521831055, 11276.041536469493, 11474.713132171762, 9528.0, 9554.0, 9640.373375730554, 9699.896033269286, 9753.707388778348], "value": 7624.564651849955, "unit": "score"}], "name": "dromaeo_css", "value": 7229.920134641594, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 111.0, 112.0, 113.0, 110.0, 112.0, 112.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 120.0, 168.0, 118.0, 120.0, 145.0, 121.0, 163.0, 117.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 126.0, 76.0, 77.0, 76.0, 74.0, 103.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 113.0, 85.0, 83.0, 83.0, 118.0, 84.0, 84.0, 128.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 87.0, 79.0, 78.0, 78.0, 87.0, 78.0, 92.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 142.0, 136.0, 128.0, 129.0, 120.0, 129.0, 117.0, 161.0, 118.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 158.0, 157.0, 157.0, 159.0, 156.0, 155.0, 160.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 68.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 65.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1492.7, "alertThreshold": 2.0}]} 06:07:15 INFO - Return code: 0 06:07:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:15 INFO - # TBPL SUCCESS # 06:07:15 INFO - Running post-action listener: _resource_record_post_action 06:07:15 INFO - ##### 06:07:15 INFO - ##### Finished run-tests step (success) 06:07:15 INFO - ##### 06:07:15 INFO - Running post-run listener: _resource_record_post_run 06:07:15 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555581440; Read time: 20; Write time: 507056 06:07:15 INFO - TinderboxPrint: CPU usage
13.0% 06:07:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:07:15 INFO - TinderboxPrint: I/O write bytes / time
555,581,440 / 507,056 06:07:15 INFO - TinderboxPrint: CPU idle
8,272.1 (86.9%) 06:07:15 INFO - TinderboxPrint: CPU user
1,198.5 (12.6%) 06:07:15 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:15 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258908160; Read time: 0; Write time: 282468 06:07:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296210432; Read time: 0; Write time: 224520 06:07:15 INFO - Running post-run listener: _upload_blobber_files 06:07:15 INFO - Blob upload gear active. 06:07:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:07:16 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:07:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:07:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:17 INFO - (blobuploader) - INFO - Done attempting. 06:07:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:07:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:18 INFO - (blobuploader) - INFO - Done attempting. 06:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:21 INFO - (blobuploader) - INFO - Done attempting. 06:07:21 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:21 INFO - Return code: 0 06:07:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d053caf965ab638e2a4195cef72369ac896fce72145fa557f6df3f9c247555943ac42a7dc1f50fab293957a34c6119f1161c5e799e1d4e2fbccfe9e116208016", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d46cfa2e583e88f644a7fe41101c4d0e81798b74315dd24fd615aa5f211c6135d886be1e13def7bd8c41b8d0d5c4c71a1fc0f5583ce1e80b8647e50641ea991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c598de8c9722d5babdd04c9ccb8c981df31dd37a9e71acb260ddea90695454d12216c21690a1fd3873b3fcafd1a51d73f7e2de19c70cec49bd46b4bf62d932d"} 06:07:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:21 INFO - Contents: 06:07:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d053caf965ab638e2a4195cef72369ac896fce72145fa557f6df3f9c247555943ac42a7dc1f50fab293957a34c6119f1161c5e799e1d4e2fbccfe9e116208016", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d46cfa2e583e88f644a7fe41101c4d0e81798b74315dd24fd615aa5f211c6135d886be1e13def7bd8c41b8d0d5c4c71a1fc0f5583ce1e80b8647e50641ea991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c598de8c9722d5babdd04c9ccb8c981df31dd37a9e71acb260ddea90695454d12216c21690a1fd3873b3fcafd1a51d73f7e2de19c70cec49bd46b4bf62d932d"} 06:07:21 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:21 INFO - Copying logs to upload dir... 06:07:21 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.004931 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-08 06:07:21.569038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:07:21.572757) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992 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/d053caf965ab638e2a4195cef72369ac896fce72145fa557f6df3f9c247555943ac42a7dc1f50fab293957a34c6119f1161c5e799e1d4e2fbccfe9e116208016", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d46cfa2e583e88f644a7fe41101c4d0e81798b74315dd24fd615aa5f211c6135d886be1e13def7bd8c41b8d0d5c4c71a1fc0f5583ce1e80b8647e50641ea991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c598de8c9722d5babdd04c9ccb8c981df31dd37a9e71acb260ddea90695454d12216c21690a1fd3873b3fcafd1a51d73f7e2de19c70cec49bd46b4bf62d932d"} build_url:https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/WZYUvIaIQ4mF3GQJABPKng/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/d053caf965ab638e2a4195cef72369ac896fce72145fa557f6df3f9c247555943ac42a7dc1f50fab293957a34c6119f1161c5e799e1d4e2fbccfe9e116208016", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d46cfa2e583e88f644a7fe41101c4d0e81798b74315dd24fd615aa5f211c6135d886be1e13def7bd8c41b8d0d5c4c71a1fc0f5583ce1e80b8647e50641ea991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c598de8c9722d5babdd04c9ccb8c981df31dd37a9e71acb260ddea90695454d12216c21690a1fd3873b3fcafd1a51d73f7e2de19c70cec49bd46b4bf62d932d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:07:21.598600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:07:21.598952) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467982008.996713-1882282992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:07:21.684602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:07:21.685109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:07:21.685442) ========= ========= Total master_lag: 0.17 =========