builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1470689654.34 results: success (0) buildid: 20160808123926 builduid: 7b8705768fda41729d49795235c6f410 revision: 9daeb2123b995f4543df67c705ac629d9e76e4fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.337655) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.338127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.338411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.357596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.357905) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 13:54:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-08-08 13:54:14 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.485483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.485796) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:14.534737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 13:54:14.535102) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9daeb2123b995f4543df67c705ac629d9e76e4fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 9daeb2123b995f4543df67c705ac629d9e76e4fa --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=e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 13:54:14,927 truncating revision to first 12 chars 2016-08-08 13:54:14,927 Setting DEBUG logging. 2016-08-08 13:54:14,927 attempt 1/10 2016-08-08 13:54:14,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9daeb2123b99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 13:54:16,198 unpacking tar archive at: autoland-9daeb2123b99/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600379 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 13:54:16.152632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:16.153406) ========= script_repo_revision: 9daeb2123b995f4543df67c705ac629d9e76e4fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:16.153813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:16.154073) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 13:54:16.167784) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-08 13:54:16.168137) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:54:16 INFO - MultiFileLogger online at 20160808 13:54:16 in /builds/slave/test 13:54:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 13:54:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:54:16 INFO - {'append_to_log': False, 13:54:16 INFO - 'base_work_dir': '/builds/slave/test', 13:54:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:54:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:54:16 INFO - 'branch': 'Autoland-Non-PGO', 13:54:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:54:16 INFO - 'config_files': ('talos/linux_config.py',), 13:54:16 INFO - 'default_actions': ('clobber', 13:54:16 INFO - 'read-buildbot-config', 13:54:16 INFO - 'download-and-extract', 13:54:16 INFO - 'populate-webroot', 13:54:16 INFO - 'create-virtualenv', 13:54:16 INFO - 'install', 13:54:16 INFO - 'run-tests'), 13:54:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:54:16 INFO - 'download_minidump_stackwalk': True, 13:54:16 INFO - 'download_symbols': 'ondemand', 13:54:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:54:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:54:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:54:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:54:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:54:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:54:16 INFO - 'installer_path': 'installer.exe', 13:54:16 INFO - 'log_level': 'info', 13:54:16 INFO - 'log_name': 'talos', 13:54:16 INFO - 'log_to_console': True, 13:54:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:54:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:54:16 INFO - 'opt_config_files': (), 13:54:16 INFO - 'pip_index': False, 13:54:16 INFO - 'sps_profile': False, 13:54:16 INFO - 'sps_profile_interval': 0, 13:54:16 INFO - 'suite': 'dromaeojs', 13:54:16 INFO - 'system_bits': '32', 13:54:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:54:16 INFO - 'title': 'talos-linux64-ix-006', 13:54:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:54:16 INFO - 'use_talos_json': True, 13:54:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:54:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:54:16 INFO - 'work_dir': 'build'} 13:54:16 INFO - [mozharness: 2016-08-08 20:54:16.645917Z] Running clobber step. 13:54:16 INFO - Running pre-action listener: _resource_record_pre_action 13:54:16 INFO - Running main action method: clobber 13:54:16 INFO - rmtree: /builds/slave/test/build 13:54:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:54:17 INFO - Running post-action listener: _resource_record_post_action 13:54:17 INFO - [mozharness: 2016-08-08 20:54:17.101852Z] Finished clobber step (success) 13:54:17 INFO - [mozharness: 2016-08-08 20:54:17.101952Z] Running read-buildbot-config step. 13:54:17 INFO - Running pre-action listener: _resource_record_pre_action 13:54:17 INFO - Running main action method: read_buildbot_config 13:54:17 INFO - Using buildbot properties: 13:54:17 INFO - { 13:54:17 INFO - "project": "", 13:54:17 INFO - "product": "firefox", 13:54:17 INFO - "script_repo_revision": "production", 13:54:17 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:54:17 INFO - "repository": "", 13:54:17 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:54:17 INFO - "buildid": "20160808123926", 13:54:17 INFO - "pgo_build": "False", 13:54:17 INFO - "basedir": "/builds/slave/test", 13:54:17 INFO - "buildnumber": 325, 13:54:17 INFO - "slavename": "talos-linux64-ix-006", 13:54:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:54:17 INFO - "platform": "ubuntu64_hw", 13:54:17 INFO - "scheduler": "tests-autoland-linux64-talos", 13:54:17 INFO - "branch": "autoland", 13:54:17 INFO - "repo_path": "integration/autoland", 13:54:17 INFO - "revision": "9daeb2123b995f4543df67c705ac629d9e76e4fa", 13:54:17 INFO - "stage_platform": "linux64", 13:54:17 INFO - "builduid": "7b8705768fda41729d49795235c6f410", 13:54:17 INFO - "slavebuilddir": "test" 13:54:17 INFO - } 13:54:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:54:17 INFO - Running post-action listener: _resource_record_post_action 13:54:17 INFO - [mozharness: 2016-08-08 20:54:17.104398Z] Finished read-buildbot-config step (success) 13:54:17 INFO - [mozharness: 2016-08-08 20:54:17.104488Z] Running download-and-extract step. 13:54:17 INFO - Running pre-action listener: _resource_record_pre_action 13:54:17 INFO - Running main action method: download_and_extract 13:54:17 INFO - mkdir: /builds/slave/test/build/tests 13:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:17 INFO - trying https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:54:17 INFO - Downloading https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:54:17 INFO - Downloaded 1361 bytes. 13:54:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:54:17 INFO - Using the following test package requirements: 13:54:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:54:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:54:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:54:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'jsshell-linux-x86_64.zip'], 13:54:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:54:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:54:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:54:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:54:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:54:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:54:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:17 INFO - trying https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:17 INFO - Downloading https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:54:18 INFO - Downloaded 20257866 bytes. 13:54:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:54:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:54:19 INFO - Return code: 0 13:54:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:19 INFO - trying https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:19 INFO - Downloading https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:54:20 INFO - Downloaded 20257866 bytes. 13:54:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:54:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:54:22 INFO - Return code: 0 13:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:22 INFO - trying https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:54:22 INFO - Downloading https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:54:23 INFO - Downloaded 14413723 bytes. 13:54:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:54:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:54:23 INFO - Return code: 0 13:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:23 INFO - trying https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:54:23 INFO - Downloading https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:54:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:54:25 INFO - Downloaded 56137832 bytes. 13:54:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:54:25 INFO - mkdir: /builds/slave/test/properties 13:54:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:54:25 INFO - Writing to file /builds/slave/test/properties/build_url 13:54:25 INFO - Contents: 13:54:25 INFO - build_url:https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:54:26 INFO - Running post-action listener: _resource_record_post_action 13:54:26 INFO - Running post-action listener: set_extra_try_arguments 13:54:26 INFO - [mozharness: 2016-08-08 20:54:26.277824Z] Finished download-and-extract step (success) 13:54:26 INFO - [mozharness: 2016-08-08 20:54:26.278144Z] Running populate-webroot step. 13:54:26 INFO - Running pre-action listener: _resource_record_pre_action 13:54:26 INFO - Running main action method: populate_webroot 13:54:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:54:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:54:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:54:26 INFO - '--tppagecycles', 13:54:26 INFO - '7'], 13:54:26 INFO - 'tests': ['tsvgm']}}, 13:54:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:54:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:54:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:54:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:54:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:54:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:54:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['damp', 'tps']}, 13:54:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'tests': ['damp', 'tps']}, 13:54:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['dromaeo_dom']}, 13:54:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:54:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['basic_compositor_video']}, 13:54:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:54:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['a11yr', 13:54:26 INFO - 'ts_paint', 13:54:26 INFO - 'tpaint', 13:54:26 INFO - 'sessionrestore', 13:54:26 INFO - 'sessionrestore_no_auto_restore', 13:54:26 INFO - 'tabpaint']}, 13:54:26 INFO - 'other-e10s': {'tests': ['a11yr', 13:54:26 INFO - 'ts_paint', 13:54:26 INFO - 'tpaint', 13:54:26 INFO - 'sessionrestore', 13:54:26 INFO - 'sessionrestore_no_auto_restore', 13:54:26 INFO - 'tabpaint']}, 13:54:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:54:26 INFO - 'ts_paint', 13:54:26 INFO - 'tpaint', 13:54:26 INFO - 'sessionrestore', 13:54:26 INFO - 'sessionrestore_no_auto_restore', 13:54:26 INFO - 'tabpaint']}, 13:54:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:54:26 INFO - 'ts_paint', 13:54:26 INFO - 'tpaint', 13:54:26 INFO - 'sessionrestore', 13:54:26 INFO - 'sessionrestore_no_auto_restore', 13:54:26 INFO - 'tabpaint']}, 13:54:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['a11yr', 13:54:26 INFO - 'ts_paint', 13:54:26 INFO - 'tpaint', 13:54:26 INFO - 'sessionrestore', 13:54:26 INFO - 'sessionrestore_no_auto_restore', 13:54:26 INFO - 'tabpaint']}, 13:54:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['a11yr', 13:54:26 INFO - 'ts_paint', 13:54:26 INFO - 'tpaint', 13:54:26 INFO - 'sessionrestore', 13:54:26 INFO - 'sessionrestore_no_auto_restore', 13:54:26 INFO - 'tabpaint']}, 13:54:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['tsvgx', 13:54:26 INFO - 'tsvgr_opacity', 13:54:26 INFO - 'tart', 13:54:26 INFO - 'tscrollx', 13:54:26 INFO - 'cart']}, 13:54:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:54:26 INFO - 'tsvgr_opacity', 13:54:26 INFO - 'tart', 13:54:26 INFO - 'tscrollx', 13:54:26 INFO - 'cart']}, 13:54:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'talos_options': ['--disable-e10s'], 13:54:26 INFO - 'tests': ['tp5o']}, 13:54:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'tests': ['tp5o']}, 13:54:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'talos_options': ['--disable-e10s', 13:54:26 INFO - '--xperf_path', 13:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:54:26 INFO - 'tests': ['tp5n']}, 13:54:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:26 INFO - 'talos_options': ['--xperf_path', 13:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:54:26 INFO - 'tests': ['tp5n']}}, 13:54:26 INFO - 'talos.zip': {'path': '', 13:54:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:54:26 INFO - Running post-action listener: _resource_record_post_action 13:54:26 INFO - [mozharness: 2016-08-08 20:54:26.293860Z] Finished populate-webroot step (success) 13:54:26 INFO - [mozharness: 2016-08-08 20:54:26.293949Z] Running create-virtualenv step. 13:54:26 INFO - Running pre-action listener: _resource_record_pre_action 13:54:26 INFO - Running main action method: create_virtualenv 13:54:26 INFO - Creating virtualenv /builds/slave/test/build/venv 13:54:26 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 13:54:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:54:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:54:26 INFO - Using real prefix '/usr' 13:54:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:54:26 INFO - Installing distribute.............................................................................................................................................................................................done. 13:54:28 INFO - Installing pip.................done. 13:54:28 INFO - Return code: 0 13:54:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:54:28 INFO - Using env: {'DISPLAY': ':0', 13:54:28 INFO - 'HOME': '/home/cltbld', 13:54:28 INFO - 'LANG': 'en_US.UTF-8', 13:54:28 INFO - 'LANGUAGE': 'en_US:en', 13:54:28 INFO - 'LOGNAME': 'cltbld', 13:54:28 INFO - 'MAIL': '/var/mail/cltbld', 13:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:28 INFO - 'MOZ_NO_REMOTE': '1', 13:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:28 INFO - 'NO_EM_RESTART': '1', 13:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:28 INFO - 'PWD': '/builds/slave/test', 13:54:28 INFO - 'SHELL': '/bin/bash', 13:54:28 INFO - 'SHLVL': '1', 13:54:28 INFO - 'TERM': 'linux', 13:54:28 INFO - 'TMOUT': '86400', 13:54:28 INFO - 'USER': 'cltbld', 13:54:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:28 INFO - '_': '/tools/buildbot/bin/python'} 13:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:29 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 13:54:29 INFO - Cleaning up... 13:54:29 INFO - Return code: 0 13:54:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:54:29 INFO - Using env: {'DISPLAY': ':0', 13:54:29 INFO - 'HOME': '/home/cltbld', 13:54:29 INFO - 'LANG': 'en_US.UTF-8', 13:54:29 INFO - 'LANGUAGE': 'en_US:en', 13:54:29 INFO - 'LOGNAME': 'cltbld', 13:54:29 INFO - 'MAIL': '/var/mail/cltbld', 13:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:29 INFO - 'MOZ_NO_REMOTE': '1', 13:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:29 INFO - 'NO_EM_RESTART': '1', 13:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:29 INFO - 'PWD': '/builds/slave/test', 13:54:29 INFO - 'SHELL': '/bin/bash', 13:54:29 INFO - 'SHLVL': '1', 13:54:29 INFO - 'TERM': 'linux', 13:54:29 INFO - 'TMOUT': '86400', 13:54:29 INFO - 'USER': 'cltbld', 13:54:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:29 INFO - '_': '/tools/buildbot/bin/python'} 13:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:29 INFO - Downloading/unpacking psutil>=3.1.1 13:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:54:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:54:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:54:31 INFO - Installing collected packages: psutil 13:54:31 INFO - Running setup.py install for psutil 13:54:31 INFO - building 'psutil._psutil_linux' extension 13:54:31 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 13:54:31 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 13:54:31 INFO - building 'psutil._psutil_posix' extension 13:54:31 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 13:54:31 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 13:54:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:54:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:54:31 INFO - Successfully installed psutil 13:54:31 INFO - Cleaning up... 13:54:31 INFO - Return code: 0 13:54:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:54:31 INFO - Using env: {'DISPLAY': ':0', 13:54:31 INFO - 'HOME': '/home/cltbld', 13:54:31 INFO - 'LANG': 'en_US.UTF-8', 13:54:31 INFO - 'LANGUAGE': 'en_US:en', 13:54:31 INFO - 'LOGNAME': 'cltbld', 13:54:31 INFO - 'MAIL': '/var/mail/cltbld', 13:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:31 INFO - 'MOZ_NO_REMOTE': '1', 13:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:31 INFO - 'NO_EM_RESTART': '1', 13:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:31 INFO - 'PWD': '/builds/slave/test', 13:54:31 INFO - 'SHELL': '/bin/bash', 13:54:31 INFO - 'SHLVL': '1', 13:54:31 INFO - 'TERM': 'linux', 13:54:31 INFO - 'TMOUT': '86400', 13:54:31 INFO - 'USER': 'cltbld', 13:54:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:31 INFO - '_': '/tools/buildbot/bin/python'} 13:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:54:32 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 13:54:32 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 13:54:32 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 13:54:32 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 13:54:32 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 13:54:32 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 13:54:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:54:34 INFO - Installing collected packages: mozsystemmonitor 13:54:34 INFO - Running setup.py install for mozsystemmonitor 13:54:34 INFO - Successfully installed mozsystemmonitor 13:54:34 INFO - Cleaning up... 13:54:34 INFO - Return code: 0 13:54:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:54:34 INFO - Using env: {'DISPLAY': ':0', 13:54:34 INFO - 'HOME': '/home/cltbld', 13:54:34 INFO - 'LANG': 'en_US.UTF-8', 13:54:34 INFO - 'LANGUAGE': 'en_US:en', 13:54:34 INFO - 'LOGNAME': 'cltbld', 13:54:34 INFO - 'MAIL': '/var/mail/cltbld', 13:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:34 INFO - 'MOZ_NO_REMOTE': '1', 13:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:34 INFO - 'NO_EM_RESTART': '1', 13:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:34 INFO - 'PWD': '/builds/slave/test', 13:54:34 INFO - 'SHELL': '/bin/bash', 13:54:34 INFO - 'SHLVL': '1', 13:54:34 INFO - 'TERM': 'linux', 13:54:34 INFO - 'TMOUT': '86400', 13:54:34 INFO - 'USER': 'cltbld', 13:54:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:34 INFO - '_': '/tools/buildbot/bin/python'} 13:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:34 INFO - Downloading/unpacking jsonschema==2.5.1 13:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:54:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:36 INFO - Downloading functools32-3.2.3-2.tar.gz 13:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:54:36 INFO - warning: no files found matching '*.txt' 13:54:36 INFO - no previously-included directories found matching 'build' 13:54:36 INFO - no previously-included directories found matching 'dist' 13:54:36 INFO - no previously-included directories found matching '.git*' 13:54:36 INFO - Installing collected packages: jsonschema, functools32 13:54:36 INFO - Running setup.py install for functools32 13:54:36 INFO - warning: no files found matching '*.txt' 13:54:36 INFO - no previously-included directories found matching 'build' 13:54:36 INFO - no previously-included directories found matching 'dist' 13:54:36 INFO - no previously-included directories found matching '.git*' 13:54:36 INFO - Successfully installed jsonschema functools32 13:54:36 INFO - Cleaning up... 13:54:36 INFO - Return code: 0 13:54:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:54:36 INFO - Using env: {'DISPLAY': ':0', 13:54:36 INFO - 'HOME': '/home/cltbld', 13:54:36 INFO - 'LANG': 'en_US.UTF-8', 13:54:36 INFO - 'LANGUAGE': 'en_US:en', 13:54:36 INFO - 'LOGNAME': 'cltbld', 13:54:36 INFO - 'MAIL': '/var/mail/cltbld', 13:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:36 INFO - 'MOZ_NO_REMOTE': '1', 13:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:36 INFO - 'NO_EM_RESTART': '1', 13:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:36 INFO - 'PWD': '/builds/slave/test', 13:54:36 INFO - 'SHELL': '/bin/bash', 13:54:36 INFO - 'SHLVL': '1', 13:54:36 INFO - 'TERM': 'linux', 13:54:36 INFO - 'TMOUT': '86400', 13:54:36 INFO - 'USER': 'cltbld', 13:54:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:36 INFO - '_': '/tools/buildbot/bin/python'} 13:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:54:36 INFO - Cleaning up... 13:54:36 INFO - Return code: 0 13:54:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:54:36 INFO - Using env: {'DISPLAY': ':0', 13:54:36 INFO - 'HOME': '/home/cltbld', 13:54:36 INFO - 'LANG': 'en_US.UTF-8', 13:54:36 INFO - 'LANGUAGE': 'en_US:en', 13:54:36 INFO - 'LOGNAME': 'cltbld', 13:54:36 INFO - 'MAIL': '/var/mail/cltbld', 13:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:36 INFO - 'MOZ_NO_REMOTE': '1', 13:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:36 INFO - 'NO_EM_RESTART': '1', 13:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:36 INFO - 'PWD': '/builds/slave/test', 13:54:36 INFO - 'SHELL': '/bin/bash', 13:54:36 INFO - 'SHLVL': '1', 13:54:36 INFO - 'TERM': 'linux', 13:54:36 INFO - 'TMOUT': '86400', 13:54:36 INFO - 'USER': 'cltbld', 13:54:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:36 INFO - '_': '/tools/buildbot/bin/python'} 13:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 13:54:37 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 13:54:37 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 13:54:37 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 13:54:37 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 13:54:37 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 13:54:37 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 13:54:39 INFO - Downloading blobuploader-1.2.4.tar.gz 13:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:54:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:54:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:39 INFO - Downloading docopt-0.6.1.tar.gz 13:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:54:39 INFO - Installing collected packages: blobuploader, requests, docopt 13:54:39 INFO - Running setup.py install for blobuploader 13:54:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:54:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:54:39 INFO - Running setup.py install for requests 13:54:40 INFO - Running setup.py install for docopt 13:54:40 INFO - Successfully installed blobuploader requests docopt 13:54:40 INFO - Cleaning up... 13:54:40 INFO - Return code: 0 13:54:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:40 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 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:40 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 13:54:40 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 13:54:40 INFO - Using env: {'DISPLAY': ':0', 13:54:40 INFO - 'HOME': '/home/cltbld', 13:54:40 INFO - 'LANG': 'en_US.UTF-8', 13:54:40 INFO - 'LANGUAGE': 'en_US:en', 13:54:40 INFO - 'LOGNAME': 'cltbld', 13:54:40 INFO - 'MAIL': '/var/mail/cltbld', 13:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:40 INFO - 'MOZ_NO_REMOTE': '1', 13:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:40 INFO - 'NO_EM_RESTART': '1', 13:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:40 INFO - 'PWD': '/builds/slave/test', 13:54:40 INFO - 'SHELL': '/bin/bash', 13:54:40 INFO - 'SHLVL': '1', 13:54:40 INFO - 'TERM': 'linux', 13:54:40 INFO - 'TMOUT': '86400', 13:54:40 INFO - 'USER': 'cltbld', 13:54:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:40 INFO - '_': '/tools/buildbot/bin/python'} 13:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:54:40 INFO - Running setup.py (path:/tmp/pip-XtreuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:54:40 INFO - Running setup.py (path:/tmp/pip-RCP0ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:54:40 INFO - Running setup.py (path:/tmp/pip-VjX6FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:54:40 INFO - Running setup.py (path:/tmp/pip-BjIzK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:54:40 INFO - Running setup.py (path:/tmp/pip-fevJFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:54:41 INFO - Running setup.py (path:/tmp/pip-3Ziq65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:54:41 INFO - Running setup.py (path:/tmp/pip-IsRzai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:54:41 INFO - Running setup.py (path:/tmp/pip-Ggkhl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:54:41 INFO - Running setup.py (path:/tmp/pip-zolZtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:54:41 INFO - Running setup.py (path:/tmp/pip-YADCNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:54:41 INFO - Running setup.py (path:/tmp/pip-YOsbky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:54:41 INFO - Running setup.py (path:/tmp/pip-zXhpUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:54:41 INFO - Running setup.py (path:/tmp/pip-JSDnyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:54:41 INFO - Running setup.py (path:/tmp/pip-n_2Nyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:41 INFO - Running setup.py (path:/tmp/pip-CPYj5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:54:41 INFO - Running setup.py (path:/tmp/pip-txc_ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:54:41 INFO - Running setup.py (path:/tmp/pip-dmDMGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:54:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:54:41 INFO - Running setup.py install for manifestparser 13:54:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:54:41 INFO - Running setup.py install for mozcrash 13:54:42 INFO - Running setup.py install for mozdebug 13:54:42 INFO - Running setup.py install for mozdevice 13:54:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Running setup.py install for mozfile 13:54:42 INFO - Running setup.py install for mozhttpd 13:54:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Running setup.py install for mozinfo 13:54:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Running setup.py install for mozInstall 13:54:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Running setup.py install for mozleak 13:54:42 INFO - Running setup.py install for mozlog 13:54:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Running setup.py install for moznetwork 13:54:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:54:42 INFO - Running setup.py install for mozprocess 13:54:43 INFO - Running setup.py install for mozprofile 13:54:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:54:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:54:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:54:43 INFO - Running setup.py install for mozrunner 13:54:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:54:43 INFO - Running setup.py install for mozscreenshot 13:54:43 INFO - Running setup.py install for moztest 13:54:43 INFO - Running setup.py install for mozversion 13:54:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:54:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:54:43 INFO - Cleaning up... 13:54:43 INFO - Return code: 0 13:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:54:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:43 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 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:43 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 13:54:43 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 13:54:43 INFO - Using env: {'DISPLAY': ':0', 13:54:43 INFO - 'HOME': '/home/cltbld', 13:54:43 INFO - 'LANG': 'en_US.UTF-8', 13:54:43 INFO - 'LANGUAGE': 'en_US:en', 13:54:43 INFO - 'LOGNAME': 'cltbld', 13:54:43 INFO - 'MAIL': '/var/mail/cltbld', 13:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:43 INFO - 'MOZ_NO_REMOTE': '1', 13:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:43 INFO - 'NO_EM_RESTART': '1', 13:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:43 INFO - 'PWD': '/builds/slave/test', 13:54:43 INFO - 'SHELL': '/bin/bash', 13:54:43 INFO - 'SHLVL': '1', 13:54:43 INFO - 'TERM': 'linux', 13:54:43 INFO - 'TMOUT': '86400', 13:54:43 INFO - 'USER': 'cltbld', 13:54:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:43 INFO - '_': '/tools/buildbot/bin/python'} 13:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:54:43 INFO - Running setup.py (path:/tmp/pip-50lVSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:54:43 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)) 13:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:54:43 INFO - Running setup.py (path:/tmp/pip-xe2Aj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:54:44 INFO - Running setup.py (path:/tmp/pip-IPYWQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:54:44 INFO - Running setup.py (path:/tmp/pip-ZsbH5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:54:44 INFO - Running setup.py (path:/tmp/pip-c6dfIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:54:44 INFO - Running setup.py (path:/tmp/pip-CuIMGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:54:44 INFO - Running setup.py (path:/tmp/pip-4C9Lct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:54:44 INFO - Running setup.py (path:/tmp/pip-nxsIoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:54:44 INFO - Running setup.py (path:/tmp/pip-LPTvMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:54:44 INFO - Running setup.py (path:/tmp/pip-elgye6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:54:44 INFO - Running setup.py (path:/tmp/pip-PnAN8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:54:44 INFO - Running setup.py (path:/tmp/pip-tL9QG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:54:44 INFO - Running setup.py (path:/tmp/pip-LxQrNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:54:44 INFO - Running setup.py (path:/tmp/pip-o8UhXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:44 INFO - Running setup.py (path:/tmp/pip-JGDRbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:44 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)) 13:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:54:44 INFO - Running setup.py (path:/tmp/pip-HXLrCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:54:45 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)) 13:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:54:45 INFO - Running setup.py (path:/tmp/pip-QW2tGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:54:45 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)) 13:54:45 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)) 13:54:45 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)) 13:54:45 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)) 13:54:45 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)) 13:54:45 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)) 13:54:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:54:45 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 13:54:45 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 13:54:45 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 13:54:45 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 13:54:45 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 13:54:45 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 13:54:46 INFO - Downloading blessings-1.6.tar.gz 13:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:54:47 INFO - Installing collected packages: blessings 13:54:47 INFO - Running setup.py install for blessings 13:54:47 INFO - Successfully installed blessings 13:54:47 INFO - Cleaning up... 13:54:47 INFO - Return code: 0 13:54:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:54:47 INFO - Reading from file tmpfile_stdout 13:54:47 INFO - Current package versions: 13:54:47 INFO - argparse == 1.2.1 13:54:47 INFO - blessings == 1.6 13:54:47 INFO - blobuploader == 1.2.4 13:54:47 INFO - docopt == 0.6.1 13:54:47 INFO - functools32 == 3.2.3-2 13:54:47 INFO - jsonschema == 2.5.1 13:54:47 INFO - manifestparser == 1.1 13:54:47 INFO - mozInstall == 1.12 13:54:47 INFO - mozcrash == 0.17 13:54:47 INFO - mozdebug == 0.1 13:54:47 INFO - mozdevice == 0.48 13:54:47 INFO - mozfile == 1.2 13:54:47 INFO - mozhttpd == 0.7 13:54:47 INFO - mozinfo == 0.9 13:54:47 INFO - mozleak == 0.1 13:54:47 INFO - mozlog == 3.3 13:54:47 INFO - moznetwork == 0.27 13:54:47 INFO - mozprocess == 0.23 13:54:47 INFO - mozprofile == 0.28 13:54:47 INFO - mozrunner == 6.12 13:54:47 INFO - mozscreenshot == 0.1 13:54:47 INFO - mozsystemmonitor == 0.3 13:54:47 INFO - moztest == 0.7 13:54:47 INFO - mozversion == 1.4 13:54:47 INFO - psutil == 3.1.1 13:54:47 INFO - requests == 1.2.3 13:54:47 INFO - wsgiref == 0.1.2 13:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:47 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 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:47 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 13:54:47 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 13:54:47 INFO - Using env: {'DISPLAY': ':0', 13:54:47 INFO - 'HOME': '/home/cltbld', 13:54:47 INFO - 'LANG': 'en_US.UTF-8', 13:54:47 INFO - 'LANGUAGE': 'en_US:en', 13:54:47 INFO - 'LOGNAME': 'cltbld', 13:54:47 INFO - 'MAIL': '/var/mail/cltbld', 13:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:47 INFO - 'MOZ_NO_REMOTE': '1', 13:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:47 INFO - 'NO_EM_RESTART': '1', 13:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:47 INFO - 'PWD': '/builds/slave/test', 13:54:47 INFO - 'SHELL': '/bin/bash', 13:54:47 INFO - 'SHLVL': '1', 13:54:47 INFO - 'TERM': 'linux', 13:54:47 INFO - 'TMOUT': '86400', 13:54:47 INFO - 'USER': 'cltbld', 13:54:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:47 INFO - '_': '/tools/buildbot/bin/python'} 13:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 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)) 13:54:47 INFO - Cleaning up... 13:54:47 INFO - Return code: 0 13:54:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:47 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 0x253f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', '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 13:54:47 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 13:54:47 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 13:54:47 INFO - Using env: {'DISPLAY': ':0', 13:54:47 INFO - 'HOME': '/home/cltbld', 13:54:47 INFO - 'LANG': 'en_US.UTF-8', 13:54:47 INFO - 'LANGUAGE': 'en_US:en', 13:54:47 INFO - 'LOGNAME': 'cltbld', 13:54:47 INFO - 'MAIL': '/var/mail/cltbld', 13:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:47 INFO - 'MOZ_NO_REMOTE': '1', 13:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:47 INFO - 'NO_EM_RESTART': '1', 13:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:47 INFO - 'PWD': '/builds/slave/test', 13:54:47 INFO - 'SHELL': '/bin/bash', 13:54:47 INFO - 'SHLVL': '1', 13:54:47 INFO - 'TERM': 'linux', 13:54:47 INFO - 'TMOUT': '86400', 13:54:47 INFO - 'USER': 'cltbld', 13:54:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:47 INFO - '_': '/tools/buildbot/bin/python'} 13:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:54:47 INFO - Cleaning up... 13:54:47 INFO - Return code: 0 13:54:47 INFO - Running post-action listener: _resource_record_post_action 13:54:47 INFO - Running post-action listener: _start_resource_monitoring 13:54:47 INFO - Starting resource monitoring. 13:54:47 INFO - [mozharness: 2016-08-08 20:54:47.895933Z] Finished create-virtualenv step (success) 13:54:47 INFO - [mozharness: 2016-08-08 20:54:47.896417Z] Running install step. 13:54:47 INFO - Running pre-action listener: _resource_record_pre_action 13:54:47 INFO - Running main action method: install 13:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:54:48 INFO - Reading from file tmpfile_stdout 13:54:48 INFO - Detecting whether we're running mozinstall >=1.0... 13:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:54:48 INFO - Reading from file tmpfile_stdout 13:54:48 INFO - Output received: 13:54:48 INFO - Usage: mozinstall [options] installer 13:54:48 INFO - Options: 13:54:48 INFO - -h, --help show this help message and exit 13:54:48 INFO - -d DEST, --destination=DEST 13:54:48 INFO - Directory to install application into. [default: 13:54:48 INFO - "/builds/slave/test"] 13:54:48 INFO - --app=APP Application being installed. [default: firefox] 13:54:48 INFO - mkdir: /builds/slave/test/build/application 13:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:55:04 INFO - Reading from file tmpfile_stdout 13:55:04 INFO - Output received: 13:55:04 INFO - /builds/slave/test/build/application/firefox/firefox 13:55:04 INFO - Running post-action listener: _resource_record_post_action 13:55:04 INFO - [mozharness: 2016-08-08 20:55:04.786930Z] Finished install step (success) 13:55:04 INFO - [mozharness: 2016-08-08 20:55:04.787181Z] Running run-tests step. 13:55:04 INFO - Running pre-action listener: _resource_record_pre_action 13:55:04 INFO - Running main action method: run_tests 13:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:55:04 INFO - Python 2.7.3 13:55:04 INFO - Return code: 0 13:55:04 INFO - grabbing minidump binary from tooltool 13:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:04 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 0x27fe3b0>, '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 0x27ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ff740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:55:04 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 13:55:04 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 13:55:04 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 13:55:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:55:04 INFO - Return code: 0 13:55:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:55:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:55:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:55:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:55:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 13:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 13:55:04 INFO - Using env: {'DISPLAY': ':0', 13:55:04 INFO - 'HOME': '/home/cltbld', 13:55:04 INFO - 'LANG': 'en_US.UTF-8', 13:55:04 INFO - 'LANGUAGE': 'en_US:en', 13:55:04 INFO - 'LOGNAME': 'cltbld', 13:55:04 INFO - 'MAIL': '/var/mail/cltbld', 13:55:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:55:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:04 INFO - 'MOZ_NO_REMOTE': '1', 13:55:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:04 INFO - 'NO_EM_RESTART': '1', 13:55:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:04 INFO - 'PWD': '/builds/slave/test', 13:55:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:55:04 INFO - 'SHELL': '/bin/bash', 13:55:04 INFO - 'SHLVL': '1', 13:55:04 INFO - 'TERM': 'linux', 13:55:04 INFO - 'TMOUT': '86400', 13:55:04 INFO - 'USER': 'cltbld', 13:55:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843', 13:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:04 INFO - '_': '/tools/buildbot/bin/python'} 13:55:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 13:55:05 INFO - mozversion application_buildid: 20160808123926 13:55:05 INFO - mozversion application_changeset: 9daeb2123b995f4543df67c705ac629d9e76e4fa 13:55:05 INFO - mozversion application_display_name: Nightly 13:55:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:55:05 INFO - mozversion application_name: Firefox 13:55:05 INFO - mozversion application_remotingname: firefox 13:55:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:55:05 INFO - mozversion application_vendor: Mozilla 13:55:05 INFO - mozversion application_version: 51.0a1 13:55:05 INFO - mozversion platform_buildid: 20160808123926 13:55:05 INFO - mozversion platform_changeset: 9daeb2123b995f4543df67c705ac629d9e76e4fa 13:55:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:55:05 INFO - mozversion platform_version: 51.0a1 13:55:05 INFO - using testdate: 1470689705 13:55:05 INFO - actual date: 1470689705 13:55:05 INFO - starting webserver on 'localhost:58016' 13:55:05 INFO - SUITE-START | Running 2 tests 13:55:05 INFO - TEST-START | dromaeo_css 13:55:05 INFO - operating with platform_type : linux_ 13:55:05 INFO - Initialising browser for dromaeo_css test... 13:55:05 INFO - TEST-INFO | started process 1771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnXKzL/profile http://localhost:58016/getInfo.html) 13:55:09 INFO - PROCESS | 1771 | __metrics Screen width/height:1600/1200 13:55:09 INFO - PROCESS | 1771 | colorDepth:24 13:55:09 INFO - PROCESS | 1771 | Browser inner width/height: 1024/697 13:55:09 INFO - PROCESS | 1771 | __metrics 13:55:09 INFO - PROCESS | 1771 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:55:09 INFO - PROCESS | 1771 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:55:10 INFO - TEST-INFO | 1771: exit 0 13:55:10 INFO - Browser initialized. 13:55:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:55:10 INFO - TEST-INFO | started process 1851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnXKzL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:22 INFO - PROCESS | 1851 | RSS: Main: 157724672 13:55:22 INFO - PROCESS | 1851 | 13:56:15 INFO - PROCESS | 1851 | 1470689775221 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] 13:58:26 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:58016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58016/tests/dromaeo/cssquery-ext.html) 13:58:28 INFO - PROCESS | 1851 | RSS: Main: 249286656 13:58:28 INFO - PROCESS | 1851 | 14:01:30 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:58016/tests/dromaeo/cssquery-ext.html (next: http://localhost:58016/tests/dromaeo/cssquery-jquery.html) 14:01:31 INFO - PROCESS | 1851 | RSS: Main: 246738944 14:01:31 INFO - PROCESS | 1851 | 14:04:33 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:58016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58016/tests/dromaeo/cssquery-mootools.html) 14:04:34 INFO - PROCESS | 1851 | RSS: Main: 208404480 14:04:34 INFO - PROCESS | 1851 | 14:07:36 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:58016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58016/tests/dromaeo/cssquery-prototype.html) 14:07:36 INFO - PROCESS | 1851 | RSS: Main: 191275008 14:07:36 INFO - PROCESS | 1851 | 14:10:39 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:58016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58016/tests/dromaeo/cssquery-yui.html) 14:10:40 INFO - PROCESS | 1851 | RSS: Main: 191016960 14:10:40 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:58016/tests/dromaeo/cssquery-yui.html (next: http://localhost:58016/tests/dromaeo/cssquery-dojo.html) 14:13:43 INFO - PROCESS | 1851 | RSS: Main: 280403968 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | __start_tp_report 14:13:43 INFO - PROCESS | 1851 | _x_x_mozilla_page_load 14:13:43 INFO - PROCESS | 1851 | _x_x_mozilla_page_load_details 14:13:43 INFO - PROCESS | 1851 | |i|pagename|runs| 14:13:43 INFO - PROCESS | 1851 | |0;dojo.html;2614.9215523534294;2615.8692065396726;2657.1364306600353;2675.077098401051;2678.5714285714275;4515.142122996628;4567.383403240561;4716.817018315563;4831.758412079395;4843.878903027422;4721.409823772028;4744.786484608192;4793.233082706759;4794.808207671689;4815.253635686466;4299.91400171998;4327.329263964083;4408.977955110236;4468.106378724252;4513.7517436540975;4426.04839959407;4470.821167153326;4489.1021795641;4497.842575509858;4499.392582001437;4292.7424354538825;4324.610785029331;4327;4385.868423947287;4418.9337159942625;4319.848805291831;4353.869383918487;4354.716943398701;4367.126574685076;4399.186150562125;4323.848665296699;4366.694331396771;4371.082072764723;4372.781360931973;4416.933745993812;4592.357070010201;4775.594074503671;4829.058333624945;4832.73419961902;4835.782389792468;4990.201567749143;5073.289739436482;5074.416442109131;5101.540861322462;5146.9485305146845;5015.14742493777;5061.316722242487;5107.9273352596;5109.718965456898;5114.207297868837;4527.977360113178;4658.976705116453;4762.142814293391;4767.427908650984;4768.284757286435;5187.325647665779;5243.501867322599;5254.028004819121;5277.8416647500635;5278;4992.925106123411;5014.323066386064;5015.097282489187;5058.140116180258;5060.873478163076;4917.827876024322;5028.044671512474;5108.463611320833;5144;5155.407128180307;5098.031374038921;5114.079465696136;5115.283860259567;5152.536271735562;5156;5027.824026159067;5048.671836330626;5050.3434553507805;5059.165237735732;5090.9236361454605;4176.206520761046;4226.873193804191;4357.542458041923;4359.062801497693;4389.890252743707;3759.2293579816073;3808.7524310919703;3815.389537673959;3842.3083844907624;3916.941245881314;4397.31841564558;4398.824047038082;4399.450068741407;4438.289873620205;4450.844220452269;4911.18965370717;5154.829043449643;5159.767810448464;5174.24973378858;5210.218467229945;4299.849505267301;4357.411749413852;4370.650347972155;4421.80101895409;4423.51341352451;4587.9541204588195;4596.195665758479;4600.5169457207185;4616.907661846744;4657.906841863144;4746.311784791117;4783.832565860178;4805.399325084364;4810.4467986181335;4851.830185943475;4906.09237291088;5011.32347133147;5079.72061536619;5081.695098294114;5148.30497882796;4790.137775200497;4799.304100905419;4799.424069111729;4820.783064762164;4859.611231101574;5058.822941197041;5059.519345662156;5061.190209566452;5061.266116413173;5110.207917772751;4805.471398146271;4985.5762260208285;5104.69371837691;5108.131617624938;5180.378354597322;4990.126727822544;4994.550490455877;5004.924926126038;5006.199008158823;5055.241713742968;4979.601631869369;4995.900081998412;5001.099802035668;5008.549230569266;5056.266841307916;4721.811127554859;4817.638677099161;4884.78018489176;4889.413270407574;4928.581070609039;4997.375328083989;5006.799728010838;5009.423916249678;5012.172991456368;5061.240813877947;4899.779509921991;4905.313256144072;4911.607071434205;4914.950850491592;4940.75296235194 14:13:43 INFO - PROCESS | 1851 | |1;ext.html;558.6006005705921;575.9546423241816;578.2367275196742;584.3192680527185;590.06474737541;29039.564406533893;42137.15725685484;43829.561704382984;43829.78085109578;43984.560154398445;39728.80135599318;40017.39973900394;40189.19621607566;40207;40249.396259056135;7307.707691692326;7650.732224372162;7770.650320735552;7783;7787.532748035136;7255.12938447387;7329.853402931938;7330.816729581777;8952;9190.908090919072;9620.470874101922;9623.326367154303;9650.903490965105;9653.469059201741;9673.419594824298;9898.851517227247;9923.255755818307;9962.452065136415;9989.200863930868;10000.549975251131;9931.90068099317;9997.750056248578;10005.49972501372;10013.148882345009;10017.899821001769;38590;38627.61372386268;38859.61140388616;38879;38890.61109388898;2988.895388661408;3093.6596974332806;3100.8759649614212;3158.684131586823;3360.462326027848;29020.709792902013;29341.559876601867;29527;30111.247218819706;30261.69738302611;3051.786374953732;3056.480398332289;3069.554914537402;3074.8616312266004;3162.6679198684037;258103;259261;259548;260777.6961115201;260974;54103.458965409845;54310.728446358306;54496;54515.72742136264;54622.903282253195;33039.83480082584;33298.500522492184;33420.331593368;35553;56324;11796.410179490991;11799.35103569312;11812.763744725058;11821.527138914518;11828.11289153317;10241.692749217535;10307.330023548446;10310.896891031143;10327.431991240554;10328.793424131476;16187;17673.911630442024;18179.272829086687;18312.63374732498;18458.78494580659;5225.686458812484;5264.6314757966575;5271.20931860224;5315.096433606296;5397.379301380313;769.5267410542476;871.3769654696922;936.639393833379;945.2013048973606;982.3369225772718;26880;28164.15507534777;28329.433411331658;28626.71373286282;29088.7091129086;752.7929819299627;759.2066290726204;795.0737390939606;801.9157988411249;960.4909398018922;14303.713925721635;14859.331330090172;14994.550163495112;15089.320980555902;15117.470888518848;390813;394829;395663;398103;399437;49360.75319623379;49504.75247623811;49554.504454954986;49736.25395619069;49864.75067624639;1091.841682955967;1122.3041714137287;1173.6537721372215;1183.6330737471583;1193.7015746063485;27208.72791272062;28307;29400.411991759618;29607.25981850471;29720.405591888473;46497;47952.7602361986;48106.27840582324;52185.7390713044;52307;369749;372164;372893;372924;412873;34761.130971724895;36758.26483470369;36831.81584092062;37062;37603.435948461345;40388.79805601071;40469;40496.392554111124;40617;41394;35175;35208.64791352054;35334.646653533135;35392.823035884656;35861.462078068325;34446.31107377889;34927.12682182966;34969.65030349664;35176.472352914214;35234.47148292726;33492;33838.66161338355;33900.3219935595;34284;34629.82685086558;30000.69999299979;32436.189095272806;32527.18682032968;32712;32720.509192361656;24596;24773.25680229596;24933.252002439956;25403.36491587725;25790.355241119123 14:13:43 INFO - PROCESS | 1851 | |2;jquery.html;318.70042160369235;352.13726370392544;356.3389911713771;361.8299399282337;373.99395625766687;12838.743225135491;15979.360825566979;16277.918610406932;17263.91368043161;18151.455456336298;15174.620634484143;15248.6950260995;15338.846611533909;15573.143477108755;15619;4650.837220697276;4878.975605121969;4967.354243948291;5060.569851562622;5158.8710282243055;5027.924581131286;5098.796048158069;5100.872478188056;5102.336696229485;5109.412417571971;5075.365579302587;5079.847604571869;5090;5180.4301526832205;5440.591955603326;5504.091824848915;5535.280413546254;5547.44525547446;5549.694766787825;5550.333959924795;5272.998130355259;5276.12943864262;5374.355077390738;5383.596230282745;5387.757550910218;12724.0456965727;12926.676833079155;12952.222866627939;13352.465901363934;20754.896225518925;1796.3622913865652;1834.339637730416;1873.091550597959;1912.0726447672866;2360.3980984848927;8966.775830604221;9326.626934922595;9698.205831921117;9755.804883902283;9930.45382503962;1735.6008118132775;1744.7906251249804;1750.649870026;1763.5238485608813;1790.8388245058006;67159.27180397653;68368;68600;69479.30520694779;71103;9990.250731195189;10159.339642923187;10301.433421161759;10431.895681043245;10466.372017678963;14045.438182472792;14045.648858778612;14051.437942482185;14068.226247556482;14110.647233819236;6904.13698287714;7077.7168913242895;7163.964180179066;7184.137903451619;7240.1311842579225;6612.305707900698;6616.305287944792;6773.796786096425;6810.387065164159;6828.795136145924;4302.677299202573;4388.934165987513;4463.866084017484;4481.090329812958;4565.429321334833;1526.3055309834222;1529.3729570875887;1559.9298031588378;1560.539640805965;1564.280431001752;754.5510421299318;796.267433960746;823.9093699693029;878.0867897386646;882.5675419044622;16482.42311519115;16562.83437165613;17076.573085672957;17352.566185845204;17786.110694465482;816.7876352148484;842.943218546744;854.1629203380721;860.8364410761935;923.3905622289257;9251;9740.269479789044;9743.65897193609;9821.165200957856;9981.251406144569;395258;400425;400962;408225;409918;79194;79920;79931.60034199792;80729;81993.18006819974;866.2204016385303;891.0910870911633;893.7318804358666;895.23010211217;896.7309807057857;14338.211398373189;14992.775108373602;15419.768703469681;15590.76613850816;15644.217789110726;39367.40948885826;39460;39598;39717.80141099276;40090.39864402095;49648.503514965836;53490;53575.73212133914;53808.46191538191;54579.45420545903;7572.4699271052705;7630.122535908442;7703.460757746904;7778.805529861799;8037.919620803717;6419.133416988647;8948.73153805387;10918;11194.272372295774;11374.20380573352;9405.858912116188;9428.95285523568;9454.101860323259;9761.121499065119;9899.554520046759;9456.905430945602;9999.35004224723;10018.39889606626;10163.44101074448;10212.642557510451;8492.787680307794;9091.454512729257;9332.30007749435;9428.010058943712;9494;7427.8143046424275;7536.811579710551;7538.773836784905;7549.50928189666;7559.244075592397;7833.843323133619;8906.242969347419;8967.417117887317;9101.544922753703;9376.3905346155 14:13:43 INFO - PROCESS | 1851 | |3;mootools.html;1228.0543981134533;1244.6079484962236;1276.9553065642704;1338.8058731483934;1563.9452619158324;6345.777897773579;7440.7767766966945;7713.460057795956;7760.185180556045;7953.681852725884;7686.9231307686905;7747.380209583234;7766.611669416535;7768.844623107534;7771.650275737591;2161.8162456191203;2182.159868450642;2186.7813218678166;2189.4854709143337;2189.693442917993;2143.2605751015954;2187.671849222613;2188.1794327127327;2194.089452877054;2194.3416974907545;2149.591577600259;2166.1768527959434;2172.250573552122;2174.5324755177635;2194.7805219478005;2105.1895020417173;2108.5255817441107;2111.2716112941166;2113.4610674278038;2113.8308935285218;2020.605981833543;2108.652072408051;2113.365990202933;2115.809577138065;2116.6507526258147;7376.4467664924805;7851.607419629053;7900;7904.446688731791;7916.960415197945;4254.7021708480415;4361.127774445092;4375.037491751809;4376.124775045004;4381.320895261208;2699.9730002699916;2789.330560665446;2819.3233623930314;2832.886684532616;2854.5004624190683;861.5261606116611;874.1782724239258;881.7002219245487;883.5670521444446;892.6652505310509;10284.280100392976;10367.32612380193;10372.740681482948;10381.844272335846;10383.740406489822;3590.964090359063;3788.9431658525145;3906.7851268180525;3923.6076392361106;3930.292547341506;8293.543855088028;8296.460730052648;8304.8339033219;8309.792255193548;8312.25189732927;4211.515675697334;4218.704690671623;4224.471941007374;4226.302660061117;4247.851325203603;3345.849436775351;3834.386498160281;3974.28462876685;3990.341593637075;4034.374671925856;3566.5363502744995;3624.7281453891064;3706.314331848617;3725.1245957200035;3725.5715592706642;1119.0823524709822;1149.706824759681;1162.1342100135284;1162.6744511536783;1174.712195512105;564.9689267090349;617.3641149615813;691.5885048396196;699.8425354295243;711.2567367101392;4810.39870016248;4827;4893.070316639898;4900.583450406684;5057.115004874132;406.33766959855245;406.9186162767399;414.2336677147314;414.48810718762303;414.601982097184;3233.644299127094;3428.468587368962;3432.4508078707786;3559;3578.6533328694463;9701.126898579161;9805.705828825146;9942.80114397708;9954.30319877616;9971.551280192409;9829.705108846745;9846.359986600848;9860.901390986142;9862.852057219148;9864.556094975744;7205.747798827016;7416.7774966751085;7423.962880185564;7426.814329641694;7428.294312040348;5067.341245638044;5129.8974020518635;5253.317068781034;5334.67991920486;5439.401665816836;8849.513276769581;9008.279337653103;9059.68291109808;9078.45529268246;9096.636134554543;8526;8863.601137948937;8875.689350872946;9114.088591140833;9137.908620913706;5400.83797486076;6336.8098957029515;6500.934990650033;6608.933910660832;6615.636140012345;7012.158540975116;7199.964000179965;7240.637968101469;7243.818904527429;7246.89129663066;6485.513586480938;6494.058361537645;6516.250631177475;6548.116004339353;6750.25747167821;6440.6135631862235;6466.030095485715;6474.320196379501;6515.771947981798;6541.476681865344;5973.313068997121;6076.817695469143;6080.939190608037;6082.72627731762;6086.421789929949;4343.001109744713;4412.492563355255;4419.138268037702;4489.102179564165;4518.36742856007;4296.3555466680245;4333.58830911063;4358.76026818528;4413.382126502356;4447.288433850697 14:13:43 INFO - PROCESS | 1851 | |4;prototype.html;279.4313571881222;279.9496090703674;285.50607449113033;286.4633668862225;286.83650319317996;4751.168545504532;4755.809767609291;4788.497207793183;4793.856184314472;4813.2780082987565;4666.626669866411;4698.835540756074;4725.740084295362;4749.240121580548;4762.190427627303;3510.9297814043766;3622.963770362302;3641.8907432776928;3702.5186725725616;3755.3428150073764;3744.6817020553285;3751.249750049987;3756.098536351283;3770.26479836432;3782.5460944686674;3718.498002769632;3723.292574410867;3723.869664561741;3725.012871589031;3731.9253614927684;3532.205253817896;3606.585242697084;3704.4258139988347;3712.2761061593;3727.6645101940953;3258.348330333919;3268.084936217839;3274.361499507573;3274.7707660463775;3279.4097062528735;4623.0984957933215;4623.491415944243;4630.467496237942;4633.212353899845;4642.814287428499;4121.91756164878;4184.937225941613;4193.357642652983;4233.1956928183545;4260.978695106504;4930.556249937523;4948.4309304429735;4951.63829946764;4953.23224900141;4962.280469331927;3571.5535558055244;3573.624769399202;3575.5530558680166;3578.6779189872777;3583.8924832254816;4991.6256280778725;5163.40620828602;5197.428282888879;5225.268462415265;5238.476152384769;3585.085803120188;3619.1856832212543;3634.47300141478;3648.543932008499;3650.379435495972;3682.0978860178893;3687.502187204747;3693.3351996640326;3700.2414505026945;3700.444933259979;4231.80498723468;4235.364695295669;4237.618614324726;4248.660107191417;4257.957420425756;4916.164252077084;4969.950300497021;5021.774020169101;5064.594832413398;5077.669951453217;1263.1347526944073;1283.6213317071486;1285.1325355385266;1286.6268782053287;1286.9549565765153;796.251523567856;804.5213098206558;834.4993004197554;846.4763425833476;846.8094678697244;4271.124419493996;4368.803403846835;4385.101054283864;4393.978030109829;4418.756968366706;5058.822941197114;5093.8726531837;5095.97452012745;5103.387593488805;5115.181570948705;4389.341598760211;4403.4495688039;4415.823367065345;4452.443444569429;4463.66522510813;2539.7333280005705;2665.1737961231693;2688.0188731113394;2691.905783297575;2703.134996801044;4791.904161916742;4795.496472870368;4832.855014349575;4847.733374664427;4873.829415970495;5020.799168033238;5253.4221235664045;5278.129108697099;5281.894362112813;5284.550813180846;4808.855734327975;4809.254565542346;4833.709977401367;4851.58761505276;4856.247281671346;5093.516115968977;5099.3370861787735;5108.28484012246;5129.9743501282255;5152.433232344364;4888.289098815386;5023.899522009467;5049.823256186016;5067.239914012927;5073.8731531712;4773.2601446774415;4805.927911081267;4812.5668689818085;4821.228603423436;4847.927281090857;3655.597884232679;3678.50340204069;3682.797446140488;3686.318031164243;3700.889733080119;5016.874578135576;5071.264666623393;5082.415522214993;5098.949010509996;5148.639595228298;4884.755762211947;4928.728919909439;4928.876778080433;4932.284818701197;4951.97524012392;4960.561437183176;4980.452150263541;4980.900381992267;4983.526564976321;5005.424376196638;4672.48602653701;4924.926126108183;4942.8764280893265;4948.480409556944;4954.405471343462;4780.474147843804;4872.658913875995;4974.651774375759;4991.850244492671;5000.399952005637;4874.246050981184;4900.607951363953;4910.386201724785;4912.901741965212;4919.778609962489 14:13:43 INFO - PROCESS | 1851 | |5;yui.html;562.2155457060414;576.7375843990982;612.8498517863125;655.0240142188138;714.1644276196853;12088.33514156721;12595.559155429562;12668.619941401772;13057.608271751851;13067.150635208705;12662.303573303465;12945.417456214469;12970.156939798906;12973.935130324358;12983.545575904845;624;751.3238085722852;765.8927750114989;765.9425543084263;767.3745897093878;743.1008479739495;760.505671313645;761.6839011810092;765.7779244019227;767.4359345880773;786.3748320085546;787.728233759355;787.7676085554747;788.1763557082862;788.5465857132143;646.9159009328757;780.8282177920848;781.2539025230891;781.663884529652;782.3780094824629;569.0951387294181;581.3343721438971;584.3396961433552;586.0388962102156;586.5776640818603;12122.818157727641;12145.878541214563;12147.696307592292;12163;12169.087318451151;12113.636590902288;12782;13027.934860325639;13223.008274379365;13252.933735331359;12053.63839084829;12239.449224784907;12314.384280785926;12332.81500777489;12880.80678789819;4144.326909143586;4148.543660197376;4209.810558524874;4341.696081274312;4345.456817897762;64581;64950;65583;66152.669236654;66319;10319.793604127875;10394.324368915995;10567.15462762977;10686.625968091079;10721.142308615292;19793;19848.20607175697;19855.503612409804;19879.30422435208;19882.304119355755;6864.691088901011;6965.05971693825;7171.031910692094;7181.820454488575;7185.317394847481;3469.236767911106;3548.538689970339;3578.5347904772734;3641.7997010164695;3657.762245454037;2555.3356127406637;2648.3246772073;2652.164568161023;2663.347479867406;2673.906413275526;458.90363023765383;464.0371229698322;466.7666166916542;467.7427414921779;469.71582192773565;378.4021246430633;393.4707817984806;399.9760014399145;454.8521730437621;511.87459072526724;7260.2739726026975;7353.779386618303;7385.741499047615;7441.962790186123;7679.769606911802;440.8082484119418;470.0997589615916;489.22946359483956;495.11127526090036;505.5677395826589;3423.863045478203;3623.4927110204594;3662.6886714629554;3705.40713485841;3847.3459511883048;56786.432135678115;74008;84336;101426.49286753667;101964;85354.57322713347;86663.56668216619;87337;88267.55866220628;88325;46928.296075558894;48172;53498;55315.72342138264;76346;6720.126383570105;6769.763058292936;6901.89647155283;6960.408365289007;7057.788266352018;44210.55789442064;45567;46023.309650354604;46358.53641463542;46855.53144468512;54197.45802542082;62070;62362;70370.88887333388;71649.64175179091;10691.732706682395;11544.307341559534;11645.59240426581;11697.356645384245;11859.762804744028;12600.243985360908;12739;12749.17130386522;12923.676908076997;12940.15888967214;11619.535218591162;11768.76462470763;11847.76304473923;11951.820722688994;12240.265584064984;11833.82249266279;12286.631401057983;12535.185212961129;12652.557160499338;12675.93662031684;11353.262037967836;11601.245919015575;11976.940115299367;12059.15585909013;12063.21589096706;10044.849327259952;10463.372197668165;10628.468576571295;10715.264046538843;10851.29466584701;8270.297024752963;8302.211289927447;8537.103604121727;8958.372913895964;9364.484953327632 14:13:43 INFO - PROCESS | 1851 | __end_tp_report 14:13:43 INFO - PROCESS | 1851 | __start_cc_report 14:13:43 INFO - PROCESS | 1851 | _x_x_mozilla_cycle_collect,954 14:13:43 INFO - PROCESS | 1851 | __end_cc_report 14:13:43 INFO - PROCESS | 1851 | __startTimestamp1470690823885__endTimestamp 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | ------- Summary: start ------- 14:13:43 INFO - PROCESS | 1851 | Number of tests: 6 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | [#0] dojo.html Cycles:165 Average:4710.79 Median:4831.76 stddev:494.11 (10.2%) stddev-sans-first:467.47 14:13:43 INFO - PROCESS | 1851 | Values: 2614.9 2615.9 2657.1 2675.1 2678.6 4515.1 4567.4 4716.8 4831.8 4843.9 4721.4 4744.8 4793.2 4794.8 4815.3 4299.9 4327.3 4409.0 4468.1 4513.8 4426.0 4470.8 4489.1 4497.8 4499.4 4292.7 4324.6 4327.0 4385.9 4418.9 4319.8 4353.9 4354.7 4367.1 4399.2 4323.8 4366.7 4371.1 4372.8 4416.9 4592.4 4775.6 4829.1 4832.7 4835.8 4990.2 5073.3 5074.4 5101.5 5146.9 5015.1 5061.3 5107.9 5109.7 5114.2 4528.0 4659.0 4762.1 4767.4 4768.3 5187.3 5243.5 5254.0 5277.8 5278.0 4992.9 5014.3 5015.1 5058.1 5060.9 4917.8 5028.0 5108.5 5144.0 5155.4 5098.0 5114.1 5115.3 5152.5 5156.0 5027.8 5048.7 5050.3 5059.2 5090.9 4176.2 4226.9 4357.5 4359.1 4389.9 3759.2 3808.8 3815.4 3842.3 3916.9 4397.3 4398.8 4399.5 4438.3 4450.8 4911.2 5154.8 5159.8 5174.2 5210.2 4299.8 4357.4 4370.7 4421.8 4423.5 4588.0 4596.2 4600.5 4616.9 4657.9 4746.3 4783.8 4805.4 4810.4 4851.8 4906.1 5011.3 5079.7 5081.7 5148.3 4790.1 4799.3 4799.4 4820.8 4859.6 5058.8 5059.5 5061.2 5061.3 5110.2 4805.5 4985.6 5104.7 5108.1 5180.4 4990.1 4994.6 5004.9 5006.2 5055.2 4979.6 4995.9 5001.1 5008.5 5056.3 4721.8 4817.6 4884.8 4889.4 4928.6 4997.4 5006.8 5009.4 5012.2 5061.2 4899.8 4905.3 4911.6 4915.0 4940.8 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | [#1] ext.html Cycles:180 Average:49647.53 Median:36795.04 stddev:92510.61 (251.4%) stddev-sans-first:92696.71 14:13:43 INFO - PROCESS | 1851 | Values: 558.6 576.0 578.2 584.3 590.1 29039.6 42137.2 43829.6 43829.8 43984.6 39728.8 40017.4 40189.2 40207.0 40249.4 7307.7 7650.7 7770.7 7783.0 7787.5 7255.1 7329.9 7330.8 8952.0 9190.9 9620.5 9623.3 9650.9 9653.5 9673.4 9898.9 9923.3 9962.5 9989.2 10000.5 9931.9 9997.8 10005.5 10013.1 10017.9 38590.0 38627.6 38859.6 38879.0 38890.6 2988.9 3093.7 3100.9 3158.7 3360.5 29020.7 29341.6 29527.0 30111.2 30261.7 3051.8 3056.5 3069.6 3074.9 3162.7 258103.0 259261.0 259548.0 260777.7 260974.0 54103.5 54310.7 54496.0 54515.7 54622.9 33039.8 33298.5 33420.3 35553.0 56324.0 11796.4 11799.4 11812.8 11821.5 11828.1 10241.7 10307.3 10310.9 10327.4 10328.8 16187.0 17673.9 18179.3 18312.6 18458.8 5225.7 5264.6 5271.2 5315.1 5397.4 769.5 871.4 936.6 945.2 982.3 26880.0 28164.2 28329.4 28626.7 29088.7 752.8 759.2 795.1 801.9 960.5 14303.7 14859.3 14994.6 15089.3 15117.5 390813.0 394829.0 395663.0 398103.0 399437.0 49360.8 49504.8 49554.5 49736.3 49864.8 1091.8 1122.3 1173.7 1183.6 1193.7 27208.7 28307.0 29400.4 29607.3 29720.4 46497.0 47952.8 48106.3 52185.7 52307.0 369749.0 372164.0 372893.0 372924.0 412873.0 34761.1 36758.3 36831.8 37062.0 37603.4 40388.8 40469.0 40496.4 40617.0 41394.0 35175.0 35208.6 35334.6 35392.8 35861.5 34446.3 34927.1 34969.7 35176.5 35234.5 33492.0 33838.7 33900.3 34284.0 34629.8 30000.7 32436.2 32527.2 32712.0 32720.5 24596.0 24773.3 24933.3 25403.4 25790.4 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | [#2] jquery.html Cycles:180 Average:24498.23 Median:5274.56 stddev:66635.26 (1263.3%) stddev-sans-first:66797.46 14:13:43 INFO - PROCESS | 1851 | Values: 318.7 352.1 356.3 361.8 374.0 12838.7 15979.4 16277.9 17263.9 18151.5 15174.6 15248.7 15338.8 15573.1 15619.0 4650.8 4879.0 4967.4 5060.6 5158.9 5027.9 5098.8 5100.9 5102.3 5109.4 5075.4 5079.8 5090.0 5180.4 5440.6 5504.1 5535.3 5547.4 5549.7 5550.3 5273.0 5276.1 5374.4 5383.6 5387.8 12724.0 12926.7 12952.2 13352.5 20754.9 1796.4 1834.3 1873.1 1912.1 2360.4 8966.8 9326.6 9698.2 9755.8 9930.5 1735.6 1744.8 1750.6 1763.5 1790.8 67159.3 68368.0 68600.0 69479.3 71103.0 9990.3 10159.3 10301.4 10431.9 10466.4 14045.4 14045.6 14051.4 14068.2 14110.6 6904.1 7077.7 7164.0 7184.1 7240.1 6612.3 6616.3 6773.8 6810.4 6828.8 4302.7 4388.9 4463.9 4481.1 4565.4 1526.3 1529.4 1559.9 1560.5 1564.3 754.6 796.3 823.9 878.1 882.6 16482.4 16562.8 17076.6 17352.6 17786.1 816.8 842.9 854.2 860.8 923.4 9251.0 9740.3 9743.7 9821.2 9981.3 395258.0 400425.0 400962.0 408225.0 409918.0 79194.0 79920.0 79931.6 80729.0 81993.2 866.2 891.1 893.7 895.2 896.7 14338.2 14992.8 15419.8 15590.8 15644.2 39367.4 39460.0 39598.0 39717.8 40090.4 49648.5 53490.0 53575.7 53808.5 54579.5 7572.5 7630.1 7703.5 7778.8 8037.9 6419.1 8948.7 10918.0 11194.3 11374.2 9405.9 9429.0 9454.1 9761.1 9899.6 9456.9 9999.4 10018.4 10163.4 10212.6 8492.8 9091.5 9332.3 9428.0 9494.0 7427.8 7536.8 7538.8 7549.5 7559.2 7833.8 8906.2 8967.4 9101.5 9376.4 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | [#3] mootools.html Cycles:180 Average:4987.10 Median:4818.70 stddev:2883.94 (59.8%) stddev-sans-first:2878.19 14:13:43 INFO - PROCESS | 1851 | Values: 1228.1 1244.6 1277.0 1338.8 1563.9 6345.8 7440.8 7713.5 7760.2 7953.7 7686.9 7747.4 7766.6 7768.8 7771.7 2161.8 2182.2 2186.8 2189.5 2189.7 2143.3 2187.7 2188.2 2194.1 2194.3 2149.6 2166.2 2172.3 2174.5 2194.8 2105.2 2108.5 2111.3 2113.5 2113.8 2020.6 2108.7 2113.4 2115.8 2116.7 7376.4 7851.6 7900.0 7904.4 7917.0 4254.7 4361.1 4375.0 4376.1 4381.3 2700.0 2789.3 2819.3 2832.9 2854.5 861.5 874.2 881.7 883.6 892.7 10284.3 10367.3 10372.7 10381.8 10383.7 3591.0 3788.9 3906.8 3923.6 3930.3 8293.5 8296.5 8304.8 8309.8 8312.3 4211.5 4218.7 4224.5 4226.3 4247.9 3345.8 3834.4 3974.3 3990.3 4034.4 3566.5 3624.7 3706.3 3725.1 3725.6 1119.1 1149.7 1162.1 1162.7 1174.7 565.0 617.4 691.6 699.8 711.3 4810.4 4827.0 4893.1 4900.6 5057.1 406.3 406.9 414.2 414.5 414.6 3233.6 3428.5 3432.5 3559.0 3578.7 9701.1 9805.7 9942.8 9954.3 9971.6 9829.7 9846.4 9860.9 9862.9 9864.6 7205.7 7416.8 7424.0 7426.8 7428.3 5067.3 5129.9 5253.3 5334.7 5439.4 8849.5 9008.3 9059.7 9078.5 9096.6 8526.0 8863.6 8875.7 9114.1 9137.9 5400.8 6336.8 6500.9 6608.9 6615.6 7012.2 7200.0 7240.6 7243.8 7246.9 6485.5 6494.1 6516.3 6548.1 6750.3 6440.6 6466.0 6474.3 6515.8 6541.5 5973.3 6076.8 6080.9 6082.7 6086.4 4343.0 4412.5 4419.1 4489.1 4518.4 4296.4 4333.6 4358.8 4413.4 4447.3 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | [#4] prototype.html Cycles:180 Average:4133.55 Median:4753.49 stddev:1200.88 (25.3%) stddev-sans-first:1168.88 14:13:43 INFO - PROCESS | 1851 | Values: 279.4 279.9 285.5 286.5 286.8 4751.2 4755.8 4788.5 4793.9 4813.3 4666.6 4698.8 4725.7 4749.2 4762.2 3510.9 3623.0 3641.9 3702.5 3755.3 3744.7 3751.2 3756.1 3770.3 3782.5 3718.5 3723.3 3723.9 3725.0 3731.9 3532.2 3606.6 3704.4 3712.3 3727.7 3258.3 3268.1 3274.4 3274.8 3279.4 4623.1 4623.5 4630.5 4633.2 4642.8 4121.9 4184.9 4193.4 4233.2 4261.0 4930.6 4948.4 4951.6 4953.2 4962.3 3571.6 3573.6 3575.6 3578.7 3583.9 4991.6 5163.4 5197.4 5225.3 5238.5 3585.1 3619.2 3634.5 3648.5 3650.4 3682.1 3687.5 3693.3 3700.2 3700.4 4231.8 4235.4 4237.6 4248.7 4258.0 4916.2 4970.0 5021.8 5064.6 5077.7 1263.1 1283.6 1285.1 1286.6 1287.0 796.3 804.5 834.5 846.5 846.8 4271.1 4368.8 4385.1 4394.0 4418.8 5058.8 5093.9 5096.0 5103.4 5115.2 4389.3 4403.4 4415.8 4452.4 4463.7 2539.7 2665.2 2688.0 2691.9 2703.1 4791.9 4795.5 4832.9 4847.7 4873.8 5020.8 5253.4 5278.1 5281.9 5284.6 4808.9 4809.3 4833.7 4851.6 4856.2 5093.5 5099.3 5108.3 5130.0 5152.4 4888.3 5023.9 5049.8 5067.2 5073.9 4773.3 4805.9 4812.6 4821.2 4847.9 3655.6 3678.5 3682.8 3686.3 3700.9 5016.9 5071.3 5082.4 5098.9 5148.6 4884.8 4928.7 4928.9 4932.3 4952.0 4960.6 4980.5 4980.9 4983.5 5005.4 4672.5 4924.9 4942.9 4948.5 4954.4 4780.5 4872.7 4974.7 4991.9 5000.4 4874.2 4900.6 4910.4 4912.9 4919.8 14:13:43 INFO - PROCESS | 1851 | 14:13:43 INFO - PROCESS | 1851 | [#5] yui.html Cycles:180 Average:17124.57 Median:22325.68 stddev:23970.12 (107.4%) stddev-sans-first:24005.11 14:13:43 INFO - PROCESS | 1851 | Values: 562.2 576.7 612.8 655.0 714.2 12088.3 12595.6 12668.6 13057.6 13067.2 12662.3 12945.4 12970.2 12973.9 12983.5 624.0 751.3 765.9 765.9 767.4 743.1 760.5 761.7 765.8 767.4 786.4 787.7 787.8 788.2 788.5 646.9 780.8 781.3 781.7 782.4 569.1 581.3 584.3 586.0 586.6 12122.8 12145.9 12147.7 12163.0 12169.1 12113.6 12782.0 13027.9 13223.0 13252.9 12053.6 12239.4 12314.4 12332.8 12880.8 4144.3 4148.5 4209.8 4341.7 4345.5 64581.0 64950.0 65583.0 66152.7 66319.0 10319.8 10394.3 10567.2 10686.6 10721.1 19793.0 19848.2 19855.5 19879.3 19882.3 6864.7 6965.1 7171.0 7181.8 7185.3 3469.2 3548.5 3578.5 3641.8 3657.8 2555.3 2648.3 2652.2 2663.3 2673.9 458.9 464.0 466.8 467.7 469.7 378.4 393.5 400.0 454.9 511.9 7260.3 7353.8 7385.7 7442.0 7679.8 440.8 470.1 489.2 495.1 505.6 3423.9 3623.5 3662.7 3705.4 3847.3 56786.4 74008.0 84336.0 101426.5 101964.0 85354.6 86663.6 87337.0 88267.6 88325.0 46928.3 48172.0 53498.0 55315.7 76346.0 6720.1 6769.8 6901.9 6960.4 7057.8 44210.6 45567.0 46023.3 46358.5 46855.5 54197.5 62070.0 62362.0 70370.9 71649.6 10691.7 11544.3 11645.6 11697.4 11859.8 12600.2 12739.0 12749.2 12923.7 12940.2 11619.5 11768.8 11847.8 11951.8 12240.3 11833.8 12286.6 12535.2 12652.6 12675.9 11353.3 11601.2 11976.9 12059.2 12063.2 10044.8 10463.4 10628.5 10715.3 10851.3 8270.3 8302.2 8537.1 8958.4 9364.5 14:13:43 INFO - PROCESS | 1851 | -------- Summary: end -------- 14:13:43 INFO - PROCESS | 1851 | 14:13:44 INFO - TEST-INFO | 1851: exit 0 14:13:44 INFO - TEST-OK | dromaeo_css | took 1119628ms 14:13:44 INFO - TEST-START | kraken 14:13:44 INFO - operating with platform_type : linux_ 14:13:44 INFO - Initialising browser for kraken test... 14:13:44 INFO - TEST-INFO | started process 2037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5LTRAa/profile http://localhost:58016/getInfo.html) 14:13:48 INFO - PROCESS | 2037 | __metrics Screen width/height:1600/1200 14:13:48 INFO - PROCESS | 2037 | colorDepth:24 14:13:48 INFO - PROCESS | 2037 | Browser inner width/height: 1024/697 14:13:48 INFO - PROCESS | 2037 | __metrics 14:13:49 INFO - PROCESS | 2037 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:13:49 INFO - PROCESS | 2037 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:13:50 INFO - TEST-INFO | 2037: exit 0 14:13:50 INFO - Browser initialized. 14:13:50 INFO - Running cycle 1/1 for kraken test... 14:13:50 INFO - TEST-INFO | started process 2114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5LTRAa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:14:02 INFO - PROCESS | 2114 | RSS: Main: 157769728 14:14:02 INFO - PROCESS | 2114 | 14:14:05 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58016/tests/kraken/driver.html?testName=audio-beat-detection) 14:14:06 INFO - PROCESS | 2114 | RSS: Main: 213803008 14:14:06 INFO - PROCESS | 2114 | 14:14:08 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58016/tests/kraken/driver.html?testName=audio-dft) 14:14:09 INFO - PROCESS | 2114 | RSS: Main: 192253952 14:14:09 INFO - PROCESS | 2114 | 14:14:12 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58016/tests/kraken/driver.html?testName=audio-fft) 14:14:13 INFO - PROCESS | 2114 | RSS: Main: 271458304 14:14:13 INFO - PROCESS | 2114 | 14:14:15 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58016/tests/kraken/driver.html?testName=audio-oscillator) 14:14:16 INFO - PROCESS | 2114 | RSS: Main: 181391360 14:14:16 INFO - PROCESS | 2114 | 14:14:18 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:14:19 INFO - PROCESS | 2114 | RSS: Main: 185217024 14:14:19 INFO - PROCESS | 2114 | 14:14:22 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58016/tests/kraken/driver.html?testName=imaging-darkroom) 14:14:22 INFO - PROCESS | 2114 | RSS: Main: 221437952 14:14:22 INFO - PROCESS | 2114 | 14:14:26 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58016/tests/kraken/driver.html?testName=imaging-desaturate) 14:14:26 INFO - PROCESS | 2114 | RSS: Main: 220643328 14:14:26 INFO - PROCESS | 2114 | 14:14:29 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58016/tests/kraken/driver.html?testName=json-parse-financial) 14:14:30 INFO - PROCESS | 2114 | RSS: Main: 220819456 14:14:30 INFO - PROCESS | 2114 | 14:14:32 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:14:32 INFO - PROCESS | 2114 | RSS: Main: 185745408 14:14:32 INFO - PROCESS | 2114 | 14:14:34 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:14:35 INFO - PROCESS | 2114 | RSS: Main: 190836736 14:14:35 INFO - PROCESS | 2114 | 14:14:37 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:14:38 INFO - PROCESS | 2114 | RSS: Main: 195616768 14:14:38 INFO - PROCESS | 2114 | 14:14:40 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:14:41 INFO - PROCESS | 2114 | RSS: Main: 191123456 14:14:41 INFO - PROCESS | 2114 | 14:14:44 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:14:45 INFO - PROCESS | 2114 | RSS: Main: 193495040 14:14:45 INFO - PROCESS | 2114 | 14:14:46 INFO - PROCESS | 2114 | Cycle 1(1): loaded http://localhost:58016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58016/tests/kraken/driver.html?testName=ai-astar) 14:14:46 INFO - PROCESS | 2114 | RSS: Main: 244027392 14:14:46 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | __start_tp_report 14:14:47 INFO - PROCESS | 2114 | _x_x_mozilla_page_load 14:14:47 INFO - PROCESS | 2114 | _x_x_mozilla_page_load_details 14:14:47 INFO - PROCESS | 2114 | |i|pagename|runs| 14:14:47 INFO - PROCESS | 2114 | |0;ai-astar;105;114;115;112;113;114;113;113;115;113 14:14:47 INFO - PROCESS | 2114 | |1;audio-beat-detection;151;121;122;179;126;128;155;123;177;121 14:14:47 INFO - PROCESS | 2114 | |2;audio-dft;160;161;160;161;162;162;163;162;161;163 14:14:47 INFO - PROCESS | 2114 | |3;audio-fft;75;76;76;114;76;75;74;75;100;75 14:14:47 INFO - PROCESS | 2114 | |4;audio-oscillator;86;85;131;86;85;85;118;85;85;127 14:14:47 INFO - PROCESS | 2114 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;117;117 14:14:47 INFO - PROCESS | 2114 | |6;imaging-darkroom;150;146;146;146;147;146;147;146;148;147 14:14:47 INFO - PROCESS | 2114 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;94;95 14:14:47 INFO - PROCESS | 2114 | |8;json-parse-financial;63;62;63;62;63;63;64;62;62;63 14:14:47 INFO - PROCESS | 2114 | |9;json-stringify-tinderbox;65;66;64;66;65;66;65;66;65;66 14:14:47 INFO - PROCESS | 2114 | |10;stanford-crypto-aes;80;90;79;78;88;79;78;85;79;83 14:14:47 INFO - PROCESS | 2114 | |11;stanford-crypto-ccm;130;133;130;139;134;133;133;134;150;139 14:14:47 INFO - PROCESS | 2114 | |12;stanford-crypto-pbkdf2;167;173;169;166;164;164;166;169;164;165 14:14:47 INFO - PROCESS | 2114 | |13;stanford-crypto-sha256-iterative;67;67;69;70;66;65;66;66;68;67 14:14:47 INFO - PROCESS | 2114 | __end_tp_report 14:14:47 INFO - PROCESS | 2114 | __start_cc_report 14:14:47 INFO - PROCESS | 2114 | _x_x_mozilla_cycle_collect,1975 14:14:47 INFO - PROCESS | 2114 | __end_cc_report 14:14:47 INFO - PROCESS | 2114 | __startTimestamp1470690886999__endTimestamp 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | ------- Summary: start ------- 14:14:47 INFO - PROCESS | 2114 | Number of tests: 14 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:2.87 (2.5%) stddev-sans-first:1.01 14:14:47 INFO - PROCESS | 2114 | Values: 105.0 114.0 115.0 112.0 113.0 114.0 113.0 113.0 115.0 113.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:139.50 stddev:23.36 (16.7%) stddev-sans-first:24.45 14:14:47 INFO - PROCESS | 2114 | Values: 151.0 121.0 122.0 179.0 126.0 128.0 155.0 123.0 177.0 121.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 14:14:47 INFO - PROCESS | 2114 | Values: 160.0 161.0 160.0 161.0 162.0 162.0 163.0 162.0 161.0 163.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:13.80 (18.4%) stddev-sans-first:14.43 14:14:47 INFO - PROCESS | 2114 | Values: 75.0 76.0 76.0 114.0 76.0 75.0 74.0 75.0 100.0 75.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.00 stddev:19.60 (23.1%) stddev-sans-first:20.36 14:14:47 INFO - PROCESS | 2114 | Values: 86.0 85.0 131.0 86.0 85.0 85.0 118.0 85.0 85.0 127.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:14:47 INFO - PROCESS | 2114 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.29 (0.9%) stddev-sans-first:0.73 14:14:47 INFO - PROCESS | 2114 | Values: 150.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 148.0 147.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 14:14:47 INFO - PROCESS | 2114 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 14:14:47 INFO - PROCESS | 2114 | Values: 63.0 62.0 63.0 62.0 63.0 63.0 64.0 62.0 62.0 63.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 14:14:47 INFO - PROCESS | 2114 | Values: 65.0 66.0 64.0 66.0 65.0 66.0 65.0 66.0 65.0 66.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.50 stddev:4.38 (5.4%) stddev-sans-first:4.59 14:14:47 INFO - PROCESS | 2114 | Values: 80.0 90.0 79.0 78.0 88.0 79.0 78.0 85.0 79.0 83.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:134.00 stddev:5.95 (4.4%) stddev-sans-first:5.97 14:14:47 INFO - PROCESS | 2114 | Values: 130.0 133.0 130.0 139.0 134.0 133.0 133.0 134.0 150.0 139.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:166.50 stddev:2.91 (1.7%) stddev-sans-first:3.08 14:14:47 INFO - PROCESS | 2114 | Values: 167.0 173.0 169.0 166.0 164.0 164.0 166.0 169.0 164.0 165.0 14:14:47 INFO - PROCESS | 2114 | 14:14:47 INFO - PROCESS | 2114 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 14:14:47 INFO - PROCESS | 2114 | Values: 67.0 67.0 69.0 70.0 66.0 65.0 66.0 66.0 68.0 67.0 14:14:47 INFO - PROCESS | 2114 | -------- Summary: end -------- 14:14:47 INFO - PROCESS | 2114 | 14:14:48 INFO - TEST-INFO | 2114: exit 0 14:14:48 INFO - TEST-OK | kraken | took 63430ms 14:14:48 INFO - SUITE-END | took 1183s 14:14:48 INFO - Completed test suite (00:19:43) 14:14:48 INFO - javascript benchmark 14:14:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.9215523534294, 2615.8692065396726, 2657.1364306600353, 2675.077098401051, 2678.5714285714275, 4515.142122996628, 4567.383403240561, 4716.817018315563, 4831.758412079395, 4843.878903027422, 4721.409823772028, 4744.786484608192, 4793.233082706759, 4794.808207671689, 4815.253635686466, 4299.91400171998, 4327.329263964083, 4408.977955110236, 4468.106378724252, 4513.7517436540975, 4426.04839959407, 4470.821167153326, 4489.1021795641, 4497.842575509858, 4499.392582001437, 4292.7424354538825, 4324.610785029331, 4327.0, 4385.868423947287, 4418.9337159942625, 4319.848805291831, 4353.869383918487, 4354.716943398701, 4367.126574685076, 4399.186150562125, 4323.848665296699, 4366.694331396771, 4371.082072764723, 4372.781360931973, 4416.933745993812, 4592.357070010201, 4775.594074503671, 4829.058333624945, 4832.73419961902, 4835.782389792468, 4990.201567749143, 5073.289739436482, 5074.416442109131, 5101.540861322462, 5146.9485305146845, 5015.14742493777, 5061.316722242487, 5107.9273352596, 5109.718965456898, 5114.207297868837, 4527.977360113178, 4658.976705116453, 4762.142814293391, 4767.427908650984, 4768.284757286435, 5187.325647665779, 5243.501867322599, 5254.028004819121, 5277.8416647500635, 5278.0, 4992.925106123411, 5014.323066386064, 5015.097282489187, 5058.140116180258, 5060.873478163076, 4917.827876024322, 5028.044671512474, 5108.463611320833, 5144.0, 5155.407128180307, 5098.031374038921, 5114.079465696136, 5115.283860259567, 5152.536271735562, 5156.0, 5027.824026159067, 5048.671836330626, 5050.3434553507805, 5059.165237735732, 5090.9236361454605, 4176.206520761046, 4226.873193804191, 4357.542458041923, 4359.062801497693, 4389.890252743707, 3759.2293579816073, 3808.7524310919703, 3815.389537673959, 3842.3083844907624, 3916.941245881314, 4397.31841564558, 4398.824047038082, 4399.450068741407, 4438.289873620205, 4450.844220452269, 4911.18965370717, 5154.829043449643, 5159.767810448464, 5174.24973378858, 5210.218467229945, 4299.849505267301, 4357.411749413852, 4370.650347972155, 4421.80101895409, 4423.51341352451, 4587.9541204588195, 4596.195665758479, 4600.5169457207185, 4616.907661846744, 4657.906841863144, 4746.311784791117, 4783.832565860178, 4805.399325084364, 4810.4467986181335, 4851.830185943475, 4906.09237291088, 5011.32347133147, 5079.72061536619, 5081.695098294114, 5148.30497882796, 4790.137775200497, 4799.304100905419, 4799.424069111729, 4820.783064762164, 4859.611231101574, 5058.822941197041, 5059.519345662156, 5061.190209566452, 5061.266116413173, 5110.207917772751, 4805.471398146271, 4985.5762260208285, 5104.69371837691, 5108.131617624938, 5180.378354597322, 4990.126727822544, 4994.550490455877, 5004.924926126038, 5006.199008158823, 5055.241713742968, 4979.601631869369, 4995.900081998412, 5001.099802035668, 5008.549230569266, 5056.266841307916, 4721.811127554859, 4817.638677099161, 4884.78018489176, 4889.413270407574, 4928.581070609039, 4997.375328083989, 5006.799728010838, 5009.423916249678, 5012.172991456368, 5061.240813877947, 4899.779509921991, 4905.313256144072, 4911.607071434205, 4914.950850491592, 4940.75296235194], "value": 4679.301895746253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6006005705921, 575.9546423241816, 578.2367275196742, 584.3192680527185, 590.06474737541, 29039.564406533893, 42137.15725685484, 43829.561704382984, 43829.78085109578, 43984.560154398445, 39728.80135599318, 40017.39973900394, 40189.19621607566, 40207.0, 40249.396259056135, 7307.707691692326, 7650.732224372162, 7770.650320735552, 7783.0, 7787.532748035136, 7255.12938447387, 7329.853402931938, 7330.816729581777, 8952.0, 9190.908090919072, 9620.470874101922, 9623.326367154303, 9650.903490965105, 9653.469059201741, 9673.419594824298, 9898.851517227247, 9923.255755818307, 9962.452065136415, 9989.200863930868, 10000.549975251131, 9931.90068099317, 9997.750056248578, 10005.49972501372, 10013.148882345009, 10017.899821001769, 38590.0, 38627.61372386268, 38859.61140388616, 38879.0, 38890.61109388898, 2988.895388661408, 3093.6596974332806, 3100.8759649614212, 3158.684131586823, 3360.462326027848, 29020.709792902013, 29341.559876601867, 29527.0, 30111.247218819706, 30261.69738302611, 3051.786374953732, 3056.480398332289, 3069.554914537402, 3074.8616312266004, 3162.6679198684037, 258103.0, 259261.0, 259548.0, 260777.6961115201, 260974.0, 54103.458965409845, 54310.728446358306, 54496.0, 54515.72742136264, 54622.903282253195, 33039.83480082584, 33298.500522492184, 33420.331593368, 35553.0, 56324.0, 11796.410179490991, 11799.35103569312, 11812.763744725058, 11821.527138914518, 11828.11289153317, 10241.692749217535, 10307.330023548446, 10310.896891031143, 10327.431991240554, 10328.793424131476, 16187.0, 17673.911630442024, 18179.272829086687, 18312.63374732498, 18458.78494580659, 5225.686458812484, 5264.6314757966575, 5271.20931860224, 5315.096433606296, 5397.379301380313, 769.5267410542476, 871.3769654696922, 936.639393833379, 945.2013048973606, 982.3369225772718, 26880.0, 28164.15507534777, 28329.433411331658, 28626.71373286282, 29088.7091129086, 752.7929819299627, 759.2066290726204, 795.0737390939606, 801.9157988411249, 960.4909398018922, 14303.713925721635, 14859.331330090172, 14994.550163495112, 15089.320980555902, 15117.470888518848, 390813.0, 394829.0, 395663.0, 398103.0, 399437.0, 49360.75319623379, 49504.75247623811, 49554.504454954986, 49736.25395619069, 49864.75067624639, 1091.841682955967, 1122.3041714137287, 1173.6537721372215, 1183.6330737471583, 1193.7015746063485, 27208.72791272062, 28307.0, 29400.411991759618, 29607.25981850471, 29720.405591888473, 46497.0, 47952.7602361986, 48106.27840582324, 52185.7390713044, 52307.0, 369749.0, 372164.0, 372893.0, 372924.0, 412873.0, 34761.130971724895, 36758.26483470369, 36831.81584092062, 37062.0, 37603.435948461345, 40388.79805601071, 40469.0, 40496.392554111124, 40617.0, 41394.0, 35175.0, 35208.64791352054, 35334.646653533135, 35392.823035884656, 35861.462078068325, 34446.31107377889, 34927.12682182966, 34969.65030349664, 35176.472352914214, 35234.47148292726, 33492.0, 33838.66161338355, 33900.3219935595, 34284.0, 34629.82685086558, 30000.69999299979, 32436.189095272806, 32527.18682032968, 32712.0, 32720.509192361656, 24596.0, 24773.25680229596, 24933.252002439956, 25403.36491587725, 25790.355241119123], "value": 17628.13991660742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.70042160369235, 352.13726370392544, 356.3389911713771, 361.8299399282337, 373.99395625766687, 12838.743225135491, 15979.360825566979, 16277.918610406932, 17263.91368043161, 18151.455456336298, 15174.620634484143, 15248.6950260995, 15338.846611533909, 15573.143477108755, 15619.0, 4650.837220697276, 4878.975605121969, 4967.354243948291, 5060.569851562622, 5158.8710282243055, 5027.924581131286, 5098.796048158069, 5100.872478188056, 5102.336696229485, 5109.412417571971, 5075.365579302587, 5079.847604571869, 5090.0, 5180.4301526832205, 5440.591955603326, 5504.091824848915, 5535.280413546254, 5547.44525547446, 5549.694766787825, 5550.333959924795, 5272.998130355259, 5276.12943864262, 5374.355077390738, 5383.596230282745, 5387.757550910218, 12724.0456965727, 12926.676833079155, 12952.222866627939, 13352.465901363934, 20754.896225518925, 1796.3622913865652, 1834.339637730416, 1873.091550597959, 1912.0726447672866, 2360.3980984848927, 8966.775830604221, 9326.626934922595, 9698.205831921117, 9755.804883902283, 9930.45382503962, 1735.6008118132775, 1744.7906251249804, 1750.649870026, 1763.5238485608813, 1790.8388245058006, 67159.27180397653, 68368.0, 68600.0, 69479.30520694779, 71103.0, 9990.250731195189, 10159.339642923187, 10301.433421161759, 10431.895681043245, 10466.372017678963, 14045.438182472792, 14045.648858778612, 14051.437942482185, 14068.226247556482, 14110.647233819236, 6904.13698287714, 7077.7168913242895, 7163.964180179066, 7184.137903451619, 7240.1311842579225, 6612.305707900698, 6616.305287944792, 6773.796786096425, 6810.387065164159, 6828.795136145924, 4302.677299202573, 4388.934165987513, 4463.866084017484, 4481.090329812958, 4565.429321334833, 1526.3055309834222, 1529.3729570875887, 1559.9298031588378, 1560.539640805965, 1564.280431001752, 754.5510421299318, 796.267433960746, 823.9093699693029, 878.0867897386646, 882.5675419044622, 16482.42311519115, 16562.83437165613, 17076.573085672957, 17352.566185845204, 17786.110694465482, 816.7876352148484, 842.943218546744, 854.1629203380721, 860.8364410761935, 923.3905622289257, 9251.0, 9740.269479789044, 9743.65897193609, 9821.165200957856, 9981.251406144569, 395258.0, 400425.0, 400962.0, 408225.0, 409918.0, 79194.0, 79920.0, 79931.60034199792, 80729.0, 81993.18006819974, 866.2204016385303, 891.0910870911633, 893.7318804358666, 895.23010211217, 896.7309807057857, 14338.211398373189, 14992.775108373602, 15419.768703469681, 15590.76613850816, 15644.217789110726, 39367.40948885826, 39460.0, 39598.0, 39717.80141099276, 40090.39864402095, 49648.503514965836, 53490.0, 53575.73212133914, 53808.46191538191, 54579.45420545903, 7572.4699271052705, 7630.122535908442, 7703.460757746904, 7778.805529861799, 8037.919620803717, 6419.133416988647, 8948.73153805387, 10918.0, 11194.272372295774, 11374.20380573352, 9405.858912116188, 9428.95285523568, 9454.101860323259, 9761.121499065119, 9899.554520046759, 9456.905430945602, 9999.35004224723, 10018.39889606626, 10163.44101074448, 10212.642557510451, 8492.787680307794, 9091.454512729257, 9332.30007749435, 9428.010058943712, 9494.0, 7427.8143046424275, 7536.811579710551, 7538.773836784905, 7549.50928189666, 7559.244075592397, 7833.843323133619, 8906.242969347419, 8967.417117887317, 9101.544922753703, 9376.3905346155], "value": 7943.905785357101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.0543981134533, 1244.6079484962236, 1276.9553065642704, 1338.8058731483934, 1563.9452619158324, 6345.777897773579, 7440.7767766966945, 7713.460057795956, 7760.185180556045, 7953.681852725884, 7686.9231307686905, 7747.380209583234, 7766.611669416535, 7768.844623107534, 7771.650275737591, 2161.8162456191203, 2182.159868450642, 2186.7813218678166, 2189.4854709143337, 2189.693442917993, 2143.2605751015954, 2187.671849222613, 2188.1794327127327, 2194.089452877054, 2194.3416974907545, 2149.591577600259, 2166.1768527959434, 2172.250573552122, 2174.5324755177635, 2194.7805219478005, 2105.1895020417173, 2108.5255817441107, 2111.2716112941166, 2113.4610674278038, 2113.8308935285218, 2020.605981833543, 2108.652072408051, 2113.365990202933, 2115.809577138065, 2116.6507526258147, 7376.4467664924805, 7851.607419629053, 7900.0, 7904.446688731791, 7916.960415197945, 4254.7021708480415, 4361.127774445092, 4375.037491751809, 4376.124775045004, 4381.320895261208, 2699.9730002699916, 2789.330560665446, 2819.3233623930314, 2832.886684532616, 2854.5004624190683, 861.5261606116611, 874.1782724239258, 881.7002219245487, 883.5670521444446, 892.6652505310509, 10284.280100392976, 10367.32612380193, 10372.740681482948, 10381.844272335846, 10383.740406489822, 3590.964090359063, 3788.9431658525145, 3906.7851268180525, 3923.6076392361106, 3930.292547341506, 8293.543855088028, 8296.460730052648, 8304.8339033219, 8309.792255193548, 8312.25189732927, 4211.515675697334, 4218.704690671623, 4224.471941007374, 4226.302660061117, 4247.851325203603, 3345.849436775351, 3834.386498160281, 3974.28462876685, 3990.341593637075, 4034.374671925856, 3566.5363502744995, 3624.7281453891064, 3706.314331848617, 3725.1245957200035, 3725.5715592706642, 1119.0823524709822, 1149.706824759681, 1162.1342100135284, 1162.6744511536783, 1174.712195512105, 564.9689267090349, 617.3641149615813, 691.5885048396196, 699.8425354295243, 711.2567367101392, 4810.39870016248, 4827.0, 4893.070316639898, 4900.583450406684, 5057.115004874132, 406.33766959855245, 406.9186162767399, 414.2336677147314, 414.48810718762303, 414.601982097184, 3233.644299127094, 3428.468587368962, 3432.4508078707786, 3559.0, 3578.6533328694463, 9701.126898579161, 9805.705828825146, 9942.80114397708, 9954.30319877616, 9971.551280192409, 9829.705108846745, 9846.359986600848, 9860.901390986142, 9862.852057219148, 9864.556094975744, 7205.747798827016, 7416.7774966751085, 7423.962880185564, 7426.814329641694, 7428.294312040348, 5067.341245638044, 5129.8974020518635, 5253.317068781034, 5334.67991920486, 5439.401665816836, 8849.513276769581, 9008.279337653103, 9059.68291109808, 9078.45529268246, 9096.636134554543, 8526.0, 8863.601137948937, 8875.689350872946, 9114.088591140833, 9137.908620913706, 5400.83797486076, 6336.8098957029515, 6500.934990650033, 6608.933910660832, 6615.636140012345, 7012.158540975116, 7199.964000179965, 7240.637968101469, 7243.818904527429, 7246.89129663066, 6485.513586480938, 6494.058361537645, 6516.250631177475, 6548.116004339353, 6750.25747167821, 6440.6135631862235, 6466.030095485715, 6474.320196379501, 6515.771947981798, 6541.476681865344, 5973.313068997121, 6076.817695469143, 6080.939190608037, 6082.72627731762, 6086.421789929949, 4343.001109744713, 4412.492563355255, 4419.138268037702, 4489.102179564165, 4518.36742856007, 4296.3555466680245, 4333.58830911063, 4358.76026818528, 4413.382126502356, 4447.288433850697], "value": 3909.3554375721546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.4313571881222, 279.9496090703674, 285.50607449113033, 286.4633668862225, 286.83650319317996, 4751.168545504532, 4755.809767609291, 4788.497207793183, 4793.856184314472, 4813.2780082987565, 4666.626669866411, 4698.835540756074, 4725.740084295362, 4749.240121580548, 4762.190427627303, 3510.9297814043766, 3622.963770362302, 3641.8907432776928, 3702.5186725725616, 3755.3428150073764, 3744.6817020553285, 3751.249750049987, 3756.098536351283, 3770.26479836432, 3782.5460944686674, 3718.498002769632, 3723.292574410867, 3723.869664561741, 3725.012871589031, 3731.9253614927684, 3532.205253817896, 3606.585242697084, 3704.4258139988347, 3712.2761061593, 3727.6645101940953, 3258.348330333919, 3268.084936217839, 3274.361499507573, 3274.7707660463775, 3279.4097062528735, 4623.0984957933215, 4623.491415944243, 4630.467496237942, 4633.212353899845, 4642.814287428499, 4121.91756164878, 4184.937225941613, 4193.357642652983, 4233.1956928183545, 4260.978695106504, 4930.556249937523, 4948.4309304429735, 4951.63829946764, 4953.23224900141, 4962.280469331927, 3571.5535558055244, 3573.624769399202, 3575.5530558680166, 3578.6779189872777, 3583.8924832254816, 4991.6256280778725, 5163.40620828602, 5197.428282888879, 5225.268462415265, 5238.476152384769, 3585.085803120188, 3619.1856832212543, 3634.47300141478, 3648.543932008499, 3650.379435495972, 3682.0978860178893, 3687.502187204747, 3693.3351996640326, 3700.2414505026945, 3700.444933259979, 4231.80498723468, 4235.364695295669, 4237.618614324726, 4248.660107191417, 4257.957420425756, 4916.164252077084, 4969.950300497021, 5021.774020169101, 5064.594832413398, 5077.669951453217, 1263.1347526944073, 1283.6213317071486, 1285.1325355385266, 1286.6268782053287, 1286.9549565765153, 796.251523567856, 804.5213098206558, 834.4993004197554, 846.4763425833476, 846.8094678697244, 4271.124419493996, 4368.803403846835, 4385.101054283864, 4393.978030109829, 4418.756968366706, 5058.822941197114, 5093.8726531837, 5095.97452012745, 5103.387593488805, 5115.181570948705, 4389.341598760211, 4403.4495688039, 4415.823367065345, 4452.443444569429, 4463.66522510813, 2539.7333280005705, 2665.1737961231693, 2688.0188731113394, 2691.905783297575, 2703.134996801044, 4791.904161916742, 4795.496472870368, 4832.855014349575, 4847.733374664427, 4873.829415970495, 5020.799168033238, 5253.4221235664045, 5278.129108697099, 5281.894362112813, 5284.550813180846, 4808.855734327975, 4809.254565542346, 4833.709977401367, 4851.58761505276, 4856.247281671346, 5093.516115968977, 5099.3370861787735, 5108.28484012246, 5129.9743501282255, 5152.433232344364, 4888.289098815386, 5023.899522009467, 5049.823256186016, 5067.239914012927, 5073.8731531712, 4773.2601446774415, 4805.927911081267, 4812.5668689818085, 4821.228603423436, 4847.927281090857, 3655.597884232679, 3678.50340204069, 3682.797446140488, 3686.318031164243, 3700.889733080119, 5016.874578135576, 5071.264666623393, 5082.415522214993, 5098.949010509996, 5148.639595228298, 4884.755762211947, 4928.728919909439, 4928.876778080433, 4932.284818701197, 4951.97524012392, 4960.561437183176, 4980.452150263541, 4980.900381992267, 4983.526564976321, 5005.424376196638, 4672.48602653701, 4924.926126108183, 4942.8764280893265, 4948.480409556944, 4954.405471343462, 4780.474147843804, 4872.658913875995, 4974.651774375759, 4991.850244492671, 5000.399952005637, 4874.246050981184, 4900.607951363953, 4910.386201724785, 4912.901741965212, 4919.778609962489], "value": 3746.841562406642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2155457060414, 576.7375843990982, 612.8498517863125, 655.0240142188138, 714.1644276196853, 12088.33514156721, 12595.559155429562, 12668.619941401772, 13057.608271751851, 13067.150635208705, 12662.303573303465, 12945.417456214469, 12970.156939798906, 12973.935130324358, 12983.545575904845, 624.0, 751.3238085722852, 765.8927750114989, 765.9425543084263, 767.3745897093878, 743.1008479739495, 760.505671313645, 761.6839011810092, 765.7779244019227, 767.4359345880773, 786.3748320085546, 787.728233759355, 787.7676085554747, 788.1763557082862, 788.5465857132143, 646.9159009328757, 780.8282177920848, 781.2539025230891, 781.663884529652, 782.3780094824629, 569.0951387294181, 581.3343721438971, 584.3396961433552, 586.0388962102156, 586.5776640818603, 12122.818157727641, 12145.878541214563, 12147.696307592292, 12163.0, 12169.087318451151, 12113.636590902288, 12782.0, 13027.934860325639, 13223.008274379365, 13252.933735331359, 12053.63839084829, 12239.449224784907, 12314.384280785926, 12332.81500777489, 12880.80678789819, 4144.326909143586, 4148.543660197376, 4209.810558524874, 4341.696081274312, 4345.456817897762, 64581.0, 64950.0, 65583.0, 66152.669236654, 66319.0, 10319.793604127875, 10394.324368915995, 10567.15462762977, 10686.625968091079, 10721.142308615292, 19793.0, 19848.20607175697, 19855.503612409804, 19879.30422435208, 19882.304119355755, 6864.691088901011, 6965.05971693825, 7171.031910692094, 7181.820454488575, 7185.317394847481, 3469.236767911106, 3548.538689970339, 3578.5347904772734, 3641.7997010164695, 3657.762245454037, 2555.3356127406637, 2648.3246772073, 2652.164568161023, 2663.347479867406, 2673.906413275526, 458.90363023765383, 464.0371229698322, 466.7666166916542, 467.7427414921779, 469.71582192773565, 378.4021246430633, 393.4707817984806, 399.9760014399145, 454.8521730437621, 511.87459072526724, 7260.2739726026975, 7353.779386618303, 7385.741499047615, 7441.962790186123, 7679.769606911802, 440.8082484119418, 470.0997589615916, 489.22946359483956, 495.11127526090036, 505.5677395826589, 3423.863045478203, 3623.4927110204594, 3662.6886714629554, 3705.40713485841, 3847.3459511883048, 56786.432135678115, 74008.0, 84336.0, 101426.49286753667, 101964.0, 85354.57322713347, 86663.56668216619, 87337.0, 88267.55866220628, 88325.0, 46928.296075558894, 48172.0, 53498.0, 55315.72342138264, 76346.0, 6720.126383570105, 6769.763058292936, 6901.89647155283, 6960.408365289007, 7057.788266352018, 44210.55789442064, 45567.0, 46023.309650354604, 46358.53641463542, 46855.53144468512, 54197.45802542082, 62070.0, 62362.0, 70370.88887333388, 71649.64175179091, 10691.732706682395, 11544.307341559534, 11645.59240426581, 11697.356645384245, 11859.762804744028, 12600.243985360908, 12739.0, 12749.17130386522, 12923.676908076997, 12940.15888967214, 11619.535218591162, 11768.76462470763, 11847.76304473923, 11951.820722688994, 12240.265584064984, 11833.82249266279, 12286.631401057983, 12535.185212961129, 12652.557160499338, 12675.93662031684, 11353.262037967836, 11601.245919015575, 11976.940115299367, 12059.15585909013, 12063.21589096706, 10044.849327259952, 10463.372197668165, 10628.468576571295, 10715.264046538843, 10851.29466584701, 8270.297024752963, 8302.211289927447, 8537.103604121727, 8958.372913895964, 9364.484953327632], "value": 6340.61208289954, "unit": "score"}], "name": "dromaeo_css", "value": 6271.853512282274, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 112.0, 113.0, 114.0, 113.0, 113.0, 115.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 122.0, 179.0, 126.0, 128.0, 155.0, 123.0, 177.0, 121.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 162.0, 162.0, 163.0, 162.0, 161.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 76.0, 75.0, 74.0, 75.0, 100.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 131.0, 86.0, 85.0, 85.0, 118.0, 85.0, 85.0, 127.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 64.0, 62.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 90.0, 79.0, 78.0, 88.0, 79.0, 78.0, 85.0, 79.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 133.0, 130.0, 139.0, 134.0, 133.0, 133.0, 134.0, 150.0, 139.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 169.0, 166.0, 164.0, 164.0, 166.0, 169.0, 164.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 70.0, 66.0, 65.0, 66.0, 66.0, 68.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1531.4, "alertThreshold": 2.0}]} 14:14:48 INFO - Return code: 0 14:14:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:14:48 INFO - # TBPL SUCCESS # 14:14:48 INFO - Running post-action listener: _resource_record_post_action 14:14:48 INFO - [mozharness: 2016-08-08 21:14:48.325007Z] Finished run-tests step (success) 14:14:48 INFO - Running post-run listener: _resource_record_post_run 14:14:48 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 528699392; Read time: 216; Write time: 513900 14:14:48 INFO - TinderboxPrint: CPU usage
13.0% 14:14:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 14:14:48 INFO - TinderboxPrint: I/O write bytes / time
528,699,392 / 513,900 14:14:48 INFO - TinderboxPrint: CPU idle
8,333.7 (87.0%) 14:14:48 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 14:14:48 INFO - TinderboxPrint: Swap in / out
0 / 0 14:14:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247070720; Read time: 0; Write time: 267440 14:14:48 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281628672; Read time: 216; Write time: 246460 14:14:48 INFO - Running post-run listener: _upload_blobber_files 14:14:48 INFO - Blob upload gear active. 14:14:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:14:48 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 14:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:14:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:14:53 INFO - (blobuploader) - INFO - Done attempting. 14:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:14:53 INFO - (blobuploader) - INFO - Done attempting. 14:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:14:54 INFO - (blobuploader) - INFO - Done attempting. 14:14:54 INFO - (blobuploader) - INFO - Iteration through files over. 14:14:54 INFO - Return code: 0 14:14:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:14:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:14:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f195c09c225c31b6d305b381cd48a23a3fd94f0b7a62dccb5bb2d35e616f7ecf3d3a86612a7d53db40ed4eafe0d02fd67476a0de82ded4bb69add630ec39a776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ec8b47d520597998a4f8ca93cc9856ae2a0016a63c298135f4fb3ad61a564c1470f04a231f3373fa847aa9f1417b3ac02924b067f8c4dd98fada38abca0acd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ec9b03f926fd90208bbc0fcfea53c9ac181fc929384df7ee021b627dd0b4d9a5e0b89f3df0ad0b4afe26de546fe805699bb51b8d4f6f4c4de001816857e5233c"} 14:14:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:14:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:14:54 INFO - Contents: 14:14:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f195c09c225c31b6d305b381cd48a23a3fd94f0b7a62dccb5bb2d35e616f7ecf3d3a86612a7d53db40ed4eafe0d02fd67476a0de82ded4bb69add630ec39a776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ec8b47d520597998a4f8ca93cc9856ae2a0016a63c298135f4fb3ad61a564c1470f04a231f3373fa847aa9f1417b3ac02924b067f8c4dd98fada38abca0acd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ec9b03f926fd90208bbc0fcfea53c9ac181fc929384df7ee021b627dd0b4d9a5e0b89f3df0ad0b4afe26de546fe805699bb51b8d4f6f4c4de001816857e5233c"} 14:14:54 INFO - Running post-run listener: copy_logs_to_upload_dir 14:14:54 INFO - Copying logs to upload dir... 14:14:54 INFO - mkdir: /builds/slave/test/build/upload/logs 14:14:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.180146 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-08 14:14:54.359094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:14:54.362561) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f195c09c225c31b6d305b381cd48a23a3fd94f0b7a62dccb5bb2d35e616f7ecf3d3a86612a7d53db40ed4eafe0d02fd67476a0de82ded4bb69add630ec39a776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ec8b47d520597998a4f8ca93cc9856ae2a0016a63c298135f4fb3ad61a564c1470f04a231f3373fa847aa9f1417b3ac02924b067f8c4dd98fada38abca0acd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ec9b03f926fd90208bbc0fcfea53c9ac181fc929384df7ee021b627dd0b4d9a5e0b89f3df0ad0b4afe26de546fe805699bb51b8d4f6f4c4de001816857e5233c"} build_url:https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/CcBBJ0uiTOukH2gnhy1-tg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f195c09c225c31b6d305b381cd48a23a3fd94f0b7a62dccb5bb2d35e616f7ecf3d3a86612a7d53db40ed4eafe0d02fd67476a0de82ded4bb69add630ec39a776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ec8b47d520597998a4f8ca93cc9856ae2a0016a63c298135f4fb3ad61a564c1470f04a231f3373fa847aa9f1417b3ac02924b067f8c4dd98fada38abca0acd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ec9b03f926fd90208bbc0fcfea53c9ac181fc929384df7ee021b627dd0b4d9a5e0b89f3df0ad0b4afe26de546fe805699bb51b8d4f6f4c4de001816857e5233c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 14:14:54.386931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:14:54.387235) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470689653.787513-323020843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 14:14:54.472803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:14:54.473092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 14:14:54.473361) ========= ========= Total master_lag: 0.16 =========