builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1472170539.96 results: success (0) buildid: 20160825143002 builduid: 6e96ea8f83e943969114b27f2b1bd936 revision: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:39.960306) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:39.960739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:39.961063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:40.002492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:40.002930) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 17:15:40-- 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% 110M=0s 2016-08-25 17:15:40 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:40.109298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:40.109660) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021055 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:40.158693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 17:15:40.159059) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 --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=5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 17:15:40,806 truncating revision to first 12 chars 2016-08-25 17:15:40,806 Setting DEBUG logging. 2016-08-25 17:15:40,806 attempt 1/10 2016-08-25 17:15:40,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4988e9ed22f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 17:15:41,651 unpacking tar archive at: fx-team-4988e9ed22f3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.212630 ========= master_lag: 0.46 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 17:15:41.835810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:41.836168) ========= script_repo_revision: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:41.836602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:41.836899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 17:15:41.859563) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-25 17:15:41.859867) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:42 INFO - MultiFileLogger online at 20160825 17:15:42 in /builds/slave/test 17:15:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:15:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:42 INFO - {'append_to_log': False, 17:15:42 INFO - 'base_work_dir': '/builds/slave/test', 17:15:42 INFO - 'blob_upload_branch': 'Fx-Team', 17:15:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:42 INFO - 'branch': 'Fx-Team', 17:15:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:42 INFO - 'config_files': ('talos/linux_config.py',), 17:15:42 INFO - 'default_actions': ('clobber', 17:15:42 INFO - 'read-buildbot-config', 17:15:42 INFO - 'download-and-extract', 17:15:42 INFO - 'populate-webroot', 17:15:42 INFO - 'create-virtualenv', 17:15:42 INFO - 'install', 17:15:42 INFO - 'run-tests'), 17:15:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:42 INFO - 'download_minidump_stackwalk': True, 17:15:42 INFO - 'download_symbols': 'ondemand', 17:15:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:42 INFO - 'installer_path': 'installer.exe', 17:15:42 INFO - 'log_level': 'info', 17:15:42 INFO - 'log_name': 'talos', 17:15:42 INFO - 'log_to_console': True, 17:15:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:42 INFO - 'opt_config_files': (), 17:15:42 INFO - 'pip_index': False, 17:15:42 INFO - 'sps_profile': False, 17:15:42 INFO - 'sps_profile_interval': 0, 17:15:42 INFO - 'suite': 'dromaeojs-e10s', 17:15:42 INFO - 'system_bits': '32', 17:15:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:42 INFO - 'title': 'talos-linux64-ix-051', 17:15:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:42 INFO - 'use_talos_json': True, 17:15:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:42 INFO - 'work_dir': 'build'} 17:15:42 INFO - [mozharness: 2016-08-26 00:15:42.607947Z] Running clobber step. 17:15:42 INFO - Running pre-action listener: _resource_record_pre_action 17:15:42 INFO - Running main action method: clobber 17:15:42 INFO - rmtree: /builds/slave/test/build 17:15:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:43 INFO - Running post-action listener: _resource_record_post_action 17:15:43 INFO - [mozharness: 2016-08-26 00:15:43.070676Z] Finished clobber step (success) 17:15:43 INFO - [mozharness: 2016-08-26 00:15:43.070776Z] Running read-buildbot-config step. 17:15:43 INFO - Running pre-action listener: _resource_record_pre_action 17:15:43 INFO - Running main action method: read_buildbot_config 17:15:43 INFO - Using buildbot properties: 17:15:43 INFO - { 17:15:43 INFO - "project": "", 17:15:43 INFO - "product": "firefox", 17:15:43 INFO - "script_repo_revision": "production", 17:15:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:15:43 INFO - "repository": "", 17:15:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:15:43 INFO - "buildid": "20160825143002", 17:15:43 INFO - "pgo_build": "True", 17:15:43 INFO - "basedir": "/builds/slave/test", 17:15:43 INFO - "buildnumber": 720, 17:15:43 INFO - "slavename": "talos-linux64-ix-051", 17:15:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:15:43 INFO - "platform": "ubuntu64_hw", 17:15:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:15:43 INFO - "branch": "fx-team", 17:15:43 INFO - "repo_path": "integration/fx-team", 17:15:43 INFO - "revision": "4988e9ed22f34ffa92723a16b0be9f82f48fe3e9", 17:15:43 INFO - "stage_platform": "linux64-pgo", 17:15:43 INFO - "builduid": "6e96ea8f83e943969114b27f2b1bd936", 17:15:43 INFO - "slavebuilddir": "test" 17:15:43 INFO - } 17:15:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:15:43 INFO - Running post-action listener: _resource_record_post_action 17:15:43 INFO - [mozharness: 2016-08-26 00:15:43.073192Z] Finished read-buildbot-config step (success) 17:15:43 INFO - [mozharness: 2016-08-26 00:15:43.073279Z] Running download-and-extract step. 17:15:43 INFO - Running pre-action listener: _resource_record_pre_action 17:15:43 INFO - Running main action method: download_and_extract 17:15:43 INFO - mkdir: /builds/slave/test/build/tests 17:15: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')]} 17:15:43 INFO - trying https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:15:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:43 INFO - Downloaded 1361 bytes. 17:15:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:15:43 INFO - Using the following test package requirements: 17:15:43 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'jsshell-linux-x86_64.zip'], 17:15:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:43 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:43 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15: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')]} 17:15:43 INFO - trying https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:15:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:44 INFO - Downloaded 21914633 bytes. 17:15:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:15:48 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 17:15:48 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')]} 17:15:48 INFO - trying https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:15:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:49 INFO - Downloaded 21914633 bytes. 17:15:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:54 INFO - trying https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:54 INFO - Downloaded 14413981 bytes. 17:15:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 17:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:55 INFO - trying https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:15:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/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 17:15:56 INFO - Downloaded 59745811 bytes. 17:15:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:15:56 INFO - mkdir: /builds/slave/test/properties 17:15:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:56 INFO - Contents: 17:15:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:15:57 INFO - Running post-action listener: _resource_record_post_action 17:15:57 INFO - Running post-action listener: set_extra_try_arguments 17:15:57 INFO - [mozharness: 2016-08-26 00:15:57.059600Z] Finished download-and-extract step (success) 17:15:57 INFO - [mozharness: 2016-08-26 00:15:57.059847Z] Running populate-webroot step. 17:15:57 INFO - Running pre-action listener: _resource_record_pre_action 17:15:57 INFO - Running main action method: populate_webroot 17:15:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:57 INFO - '--tppagecycles', 17:15:57 INFO - '7'], 17:15:57 INFO - 'tests': ['tsvgm']}}, 17:15:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['damp', 'tps']}, 17:15:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'tests': ['damp', 'tps']}, 17:15:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['dromaeo_dom']}, 17:15:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['basic_compositor_video']}, 17:15:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:15:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tsvgx', 17:15:57 INFO - 'tsvgr_opacity', 17:15:57 INFO - 'tart', 17:15:57 INFO - 'tscrollx', 17:15:57 INFO - 'cart']}, 17:15:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:57 INFO - 'tsvgr_opacity', 17:15:57 INFO - 'tart', 17:15:57 INFO - 'tscrollx', 17:15:57 INFO - 'cart']}, 17:15:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tp5o']}, 17:15:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'tests': ['tp5o']}, 17:15:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s', 17:15:57 INFO - '--xperf_path', 17:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:57 INFO - 'tests': ['tp5n']}, 17:15:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--xperf_path', 17:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:57 INFO - 'tests': ['tp5n']}}, 17:15:57 INFO - 'talos.zip': {'path': '', 17:15:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:57 INFO - Running post-action listener: _resource_record_post_action 17:15:57 INFO - [mozharness: 2016-08-26 00:15:57.085472Z] Finished populate-webroot step (success) 17:15:57 INFO - [mozharness: 2016-08-26 00:15:57.085559Z] Running create-virtualenv step. 17:15:57 INFO - Running pre-action listener: _resource_record_pre_action 17:15:57 INFO - Running main action method: create_virtualenv 17:15:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:57 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 17:15:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:57 INFO - Using real prefix '/usr' 17:15:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:59 INFO - Installing pip.................done. 17:15:59 INFO - Return code: 0 17:15:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:59 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')]} 17:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 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')]} 17:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:15:59 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 17:15:59 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 17:15:59 INFO - Using env: {'DISPLAY': ':0', 17:15:59 INFO - 'HOME': '/home/cltbld', 17:15:59 INFO - 'LANG': 'en_US.UTF-8', 17:15:59 INFO - 'LANGUAGE': 'en_US:en', 17:15:59 INFO - 'LOGNAME': 'cltbld', 17:15:59 INFO - 'MAIL': '/var/mail/cltbld', 17:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:59 INFO - 'MOZ_NO_REMOTE': '1', 17:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:59 INFO - 'NO_EM_RESTART': '1', 17:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:59 INFO - 'PWD': '/builds/slave/test', 17:15:59 INFO - 'SHELL': '/bin/bash', 17:15:59 INFO - 'SHLVL': '1', 17:15:59 INFO - 'TERM': 'linux', 17:15:59 INFO - 'TMOUT': '86400', 17:15:59 INFO - 'USER': 'cltbld', 17:15:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:59 INFO - '_': '/tools/buildbot/bin/python'} 17:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:59 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 17:15:59 INFO - Cleaning up... 17:15:59 INFO - Return code: 0 17:15:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15:59 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')]} 17:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 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')]} 17:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:59 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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:15:59 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 17:15:59 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 17:15:59 INFO - Using env: {'DISPLAY': ':0', 17:15:59 INFO - 'HOME': '/home/cltbld', 17:15:59 INFO - 'LANG': 'en_US.UTF-8', 17:15:59 INFO - 'LANGUAGE': 'en_US:en', 17:15:59 INFO - 'LOGNAME': 'cltbld', 17:15:59 INFO - 'MAIL': '/var/mail/cltbld', 17:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:59 INFO - 'MOZ_NO_REMOTE': '1', 17:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:59 INFO - 'NO_EM_RESTART': '1', 17:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:59 INFO - 'PWD': '/builds/slave/test', 17:15:59 INFO - 'SHELL': '/bin/bash', 17:15:59 INFO - 'SHLVL': '1', 17:15:59 INFO - 'TERM': 'linux', 17:15:59 INFO - 'TMOUT': '86400', 17:15:59 INFO - 'USER': 'cltbld', 17:15:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:59 INFO - '_': '/tools/buildbot/bin/python'} 17:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:00 INFO - Downloading/unpacking psutil>=3.1.1 17:16:00 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 17:16:00 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 17:16:00 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 17:16:00 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 17:16:00 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 17:16:00 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 17:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:02 INFO - Installing collected packages: psutil 17:16:02 INFO - Running setup.py install for psutil 17:16:02 INFO - building 'psutil._psutil_linux' extension 17:16:02 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 17:16:02 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 17:16:02 INFO - building 'psutil._psutil_posix' extension 17:16:02 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 17:16:02 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 17:16:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:02 INFO - Successfully installed psutil 17:16:02 INFO - Cleaning up... 17:16:02 INFO - Return code: 0 17:16:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:16:02 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')]} 17:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:02 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')]} 17:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:02 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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:02 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 17:16:02 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 17:16:02 INFO - Using env: {'DISPLAY': ':0', 17:16:02 INFO - 'HOME': '/home/cltbld', 17:16:02 INFO - 'LANG': 'en_US.UTF-8', 17:16:02 INFO - 'LANGUAGE': 'en_US:en', 17:16:02 INFO - 'LOGNAME': 'cltbld', 17:16:02 INFO - 'MAIL': '/var/mail/cltbld', 17:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:02 INFO - 'MOZ_NO_REMOTE': '1', 17:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:02 INFO - 'NO_EM_RESTART': '1', 17:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:02 INFO - 'PWD': '/builds/slave/test', 17:16:02 INFO - 'SHELL': '/bin/bash', 17:16:02 INFO - 'SHLVL': '1', 17:16:02 INFO - 'TERM': 'linux', 17:16:02 INFO - 'TMOUT': '86400', 17:16:02 INFO - 'USER': 'cltbld', 17:16:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:02 INFO - '_': '/tools/buildbot/bin/python'} 17:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:16:02 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 17:16:02 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 17:16:02 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 17:16:02 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 17:16:02 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 17:16:02 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 17:16:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:16:04 INFO - Installing collected packages: mozsystemmonitor 17:16:04 INFO - Running setup.py install for mozsystemmonitor 17:16:04 INFO - Successfully installed mozsystemmonitor 17:16:04 INFO - Cleaning up... 17:16:04 INFO - Return code: 0 17:16:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:16:04 INFO - Using env: {'DISPLAY': ':0', 17:16:04 INFO - 'HOME': '/home/cltbld', 17:16:04 INFO - 'LANG': 'en_US.UTF-8', 17:16:04 INFO - 'LANGUAGE': 'en_US:en', 17:16:04 INFO - 'LOGNAME': 'cltbld', 17:16:04 INFO - 'MAIL': '/var/mail/cltbld', 17:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:04 INFO - 'MOZ_NO_REMOTE': '1', 17:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:04 INFO - 'NO_EM_RESTART': '1', 17:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:04 INFO - 'PWD': '/builds/slave/test', 17:16:04 INFO - 'SHELL': '/bin/bash', 17:16:04 INFO - 'SHLVL': '1', 17:16:04 INFO - 'TERM': 'linux', 17:16:04 INFO - 'TMOUT': '86400', 17:16:04 INFO - 'USER': 'cltbld', 17:16:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:04 INFO - '_': '/tools/buildbot/bin/python'} 17:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:16:05 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 17:16:05 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 17:16:05 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 17:16:05 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 17:16:05 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 17:16:05 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 17:16:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:07 INFO - warning: no files found matching '*.txt' 17:16:07 INFO - no previously-included directories found matching 'build' 17:16:07 INFO - no previously-included directories found matching 'dist' 17:16:07 INFO - no previously-included directories found matching '.git*' 17:16:07 INFO - Installing collected packages: jsonschema, functools32 17:16:07 INFO - Running setup.py install for functools32 17:16:07 INFO - warning: no files found matching '*.txt' 17:16:07 INFO - no previously-included directories found matching 'build' 17:16:07 INFO - no previously-included directories found matching 'dist' 17:16:07 INFO - no previously-included directories found matching '.git*' 17:16:07 INFO - Successfully installed jsonschema functools32 17:16:07 INFO - Cleaning up... 17:16:07 INFO - Return code: 0 17:16:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:16:07 INFO - Using env: {'DISPLAY': ':0', 17:16:07 INFO - 'HOME': '/home/cltbld', 17:16:07 INFO - 'LANG': 'en_US.UTF-8', 17:16:07 INFO - 'LANGUAGE': 'en_US:en', 17:16:07 INFO - 'LOGNAME': 'cltbld', 17:16:07 INFO - 'MAIL': '/var/mail/cltbld', 17:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:07 INFO - 'MOZ_NO_REMOTE': '1', 17:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:07 INFO - 'NO_EM_RESTART': '1', 17:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:07 INFO - 'PWD': '/builds/slave/test', 17:16:07 INFO - 'SHELL': '/bin/bash', 17:16:07 INFO - 'SHLVL': '1', 17:16:07 INFO - 'TERM': 'linux', 17:16:07 INFO - 'TMOUT': '86400', 17:16:07 INFO - 'USER': 'cltbld', 17:16:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:07 INFO - '_': '/tools/buildbot/bin/python'} 17:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:16:07 INFO - Cleaning up... 17:16:07 INFO - Return code: 0 17:16:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:16:07 INFO - Using env: {'DISPLAY': ':0', 17:16:07 INFO - 'HOME': '/home/cltbld', 17:16:07 INFO - 'LANG': 'en_US.UTF-8', 17:16:07 INFO - 'LANGUAGE': 'en_US:en', 17:16:07 INFO - 'LOGNAME': 'cltbld', 17:16:07 INFO - 'MAIL': '/var/mail/cltbld', 17:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:07 INFO - 'MOZ_NO_REMOTE': '1', 17:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:07 INFO - 'NO_EM_RESTART': '1', 17:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:07 INFO - 'PWD': '/builds/slave/test', 17:16:07 INFO - 'SHELL': '/bin/bash', 17:16:07 INFO - 'SHLVL': '1', 17:16:07 INFO - 'TERM': 'linux', 17:16:07 INFO - 'TMOUT': '86400', 17:16:07 INFO - 'USER': 'cltbld', 17:16:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:07 INFO - '_': '/tools/buildbot/bin/python'} 17:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:10 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 17:16:10 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 17:16:10 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 17:16:10 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 17:16:10 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 17:16:10 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 17:16:10 INFO - Downloading docopt-0.6.1.tar.gz 17:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:10 INFO - Running setup.py install for blobuploader 17:16:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:10 INFO - Running setup.py install for requests 17:16:10 INFO - Running setup.py install for docopt 17:16:11 INFO - Successfully installed blobuploader requests docopt 17:16:11 INFO - Cleaning up... 17:16:11 INFO - Return code: 0 17:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:11 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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:11 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 17:16:11 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 17:16:11 INFO - Using env: {'DISPLAY': ':0', 17:16:11 INFO - 'HOME': '/home/cltbld', 17:16:11 INFO - 'LANG': 'en_US.UTF-8', 17:16:11 INFO - 'LANGUAGE': 'en_US:en', 17:16:11 INFO - 'LOGNAME': 'cltbld', 17:16:11 INFO - 'MAIL': '/var/mail/cltbld', 17:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:11 INFO - 'MOZ_NO_REMOTE': '1', 17:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:11 INFO - 'NO_EM_RESTART': '1', 17:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:11 INFO - 'PWD': '/builds/slave/test', 17:16:11 INFO - 'SHELL': '/bin/bash', 17:16:11 INFO - 'SHLVL': '1', 17:16:11 INFO - 'TERM': 'linux', 17:16:11 INFO - 'TMOUT': '86400', 17:16:11 INFO - 'USER': 'cltbld', 17:16:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:11 INFO - '_': '/tools/buildbot/bin/python'} 17:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:11 INFO - Running setup.py (path:/tmp/pip-c3HFHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:11 INFO - Running setup.py (path:/tmp/pip-WsmStc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:11 INFO - Running setup.py (path:/tmp/pip-m6SpHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:11 INFO - Running setup.py (path:/tmp/pip-6TTEWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:11 INFO - Running setup.py (path:/tmp/pip-svWHIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:11 INFO - Running setup.py (path:/tmp/pip-BIutCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:11 INFO - Running setup.py (path:/tmp/pip-3fnpSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:11 INFO - Running setup.py (path:/tmp/pip-iLMjfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:11 INFO - Running setup.py (path:/tmp/pip-iI00zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:12 INFO - Running setup.py (path:/tmp/pip-MJcyLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:12 INFO - Running setup.py (path:/tmp/pip-6iTdbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:12 INFO - Running setup.py (path:/tmp/pip-4e6mo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:12 INFO - Running setup.py (path:/tmp/pip-uH8ND4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:12 INFO - Running setup.py (path:/tmp/pip-ne682R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:12 INFO - Running setup.py (path:/tmp/pip-MPmx_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:12 INFO - Running setup.py (path:/tmp/pip-JEhpyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:12 INFO - Running setup.py (path:/tmp/pip-fjfVII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:12 INFO - Running setup.py install for manifestparser 17:16:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:12 INFO - Running setup.py install for mozcrash 17:16:12 INFO - Running setup.py install for mozdebug 17:16:12 INFO - Running setup.py install for mozdevice 17:16:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Running setup.py install for mozfile 17:16:13 INFO - Running setup.py install for mozhttpd 17:16:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Running setup.py install for mozinfo 17:16:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Running setup.py install for mozInstall 17:16:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Running setup.py install for mozleak 17:16:13 INFO - Running setup.py install for mozlog 17:16:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Running setup.py install for moznetwork 17:16:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Running setup.py install for mozprocess 17:16:13 INFO - Running setup.py install for mozprofile 17:16:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:13 INFO - Running setup.py install for mozrunner 17:16:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:14 INFO - Running setup.py install for mozscreenshot 17:16:14 INFO - Running setup.py install for moztest 17:16:14 INFO - Running setup.py install for mozversion 17:16:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:14 INFO - Cleaning up... 17:16:14 INFO - Return code: 0 17:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:14 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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:14 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 17:16:14 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 17:16:14 INFO - Using env: {'DISPLAY': ':0', 17:16:14 INFO - 'HOME': '/home/cltbld', 17:16:14 INFO - 'LANG': 'en_US.UTF-8', 17:16:14 INFO - 'LANGUAGE': 'en_US:en', 17:16:14 INFO - 'LOGNAME': 'cltbld', 17:16:14 INFO - 'MAIL': '/var/mail/cltbld', 17:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:14 INFO - 'MOZ_NO_REMOTE': '1', 17:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:14 INFO - 'NO_EM_RESTART': '1', 17:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:14 INFO - 'PWD': '/builds/slave/test', 17:16:14 INFO - 'SHELL': '/bin/bash', 17:16:14 INFO - 'SHLVL': '1', 17:16:14 INFO - 'TERM': 'linux', 17:16:14 INFO - 'TMOUT': '86400', 17:16:14 INFO - 'USER': 'cltbld', 17:16:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:14 INFO - '_': '/tools/buildbot/bin/python'} 17:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:14 INFO - Running setup.py (path:/tmp/pip-d3BWKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:14 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)) 17:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:14 INFO - Running setup.py (path:/tmp/pip-JWK6zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:14 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)) 17:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:14 INFO - Running setup.py (path:/tmp/pip-OTUTiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:14 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)) 17:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:14 INFO - Running setup.py (path:/tmp/pip-o4Ro5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:14 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)) 17:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:14 INFO - Running setup.py (path:/tmp/pip-W02AF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:14 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)) 17:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:14 INFO - Running setup.py (path:/tmp/pip-ZCoNW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:15 INFO - Running setup.py (path:/tmp/pip-IOzYun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:15 INFO - Running setup.py (path:/tmp/pip-oa9BaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:15 INFO - Running setup.py (path:/tmp/pip-GNBske-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:15 INFO - Running setup.py (path:/tmp/pip-jfOxS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:15 INFO - Running setup.py (path:/tmp/pip-kQSGOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:15 INFO - Running setup.py (path:/tmp/pip-BCu1ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:15 INFO - Running setup.py (path:/tmp/pip-BFiTCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:15 INFO - Running setup.py (path:/tmp/pip-Mu7aFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:15 INFO - Running setup.py (path:/tmp/pip-judf_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:15 INFO - Running setup.py (path:/tmp/pip-kzx6nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:15 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)) 17:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:15 INFO - Running setup.py (path:/tmp/pip-rbggRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:15 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)) 17:16:15 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)) 17:16:15 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)) 17:16:15 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)) 17:16:15 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)) 17:16:15 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)) 17:16:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:15 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 17:16:15 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 17:16:15 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 17:16:15 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 17:16:15 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 17:16:15 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 17:16:17 INFO - Downloading blessings-1.6.tar.gz 17:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:17 INFO - Installing collected packages: blessings 17:16:17 INFO - Running setup.py install for blessings 17:16:17 INFO - Successfully installed blessings 17:16:17 INFO - Cleaning up... 17:16:17 INFO - Return code: 0 17:16:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:18 INFO - Reading from file tmpfile_stdout 17:16:18 INFO - Current package versions: 17:16:18 INFO - argparse == 1.2.1 17:16:18 INFO - blessings == 1.6 17:16:18 INFO - blobuploader == 1.2.4 17:16:18 INFO - docopt == 0.6.1 17:16:18 INFO - functools32 == 3.2.3-2 17:16:18 INFO - jsonschema == 2.5.1 17:16:18 INFO - manifestparser == 1.1 17:16:18 INFO - mozInstall == 1.12 17:16:18 INFO - mozcrash == 0.17 17:16:18 INFO - mozdebug == 0.1 17:16:18 INFO - mozdevice == 0.48 17:16:18 INFO - mozfile == 1.2 17:16:18 INFO - mozhttpd == 0.7 17:16:18 INFO - mozinfo == 0.9 17:16:18 INFO - mozleak == 0.1 17:16:18 INFO - mozlog == 3.3 17:16:18 INFO - moznetwork == 0.27 17:16:18 INFO - mozprocess == 0.23 17:16:18 INFO - mozprofile == 0.28 17:16:18 INFO - mozrunner == 6.12 17:16:18 INFO - mozscreenshot == 0.1 17:16:18 INFO - mozsystemmonitor == 0.3 17:16:18 INFO - moztest == 0.7 17:16:18 INFO - mozversion == 1.4 17:16:18 INFO - psutil == 3.1.1 17:16:18 INFO - requests == 1.2.3 17:16:18 INFO - wsgiref == 0.1.2 17:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:18 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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:18 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 17:16:18 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 17:16:18 INFO - Using env: {'DISPLAY': ':0', 17:16:18 INFO - 'HOME': '/home/cltbld', 17:16:18 INFO - 'LANG': 'en_US.UTF-8', 17:16:18 INFO - 'LANGUAGE': 'en_US:en', 17:16:18 INFO - 'LOGNAME': 'cltbld', 17:16:18 INFO - 'MAIL': '/var/mail/cltbld', 17:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:18 INFO - 'MOZ_NO_REMOTE': '1', 17:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:18 INFO - 'NO_EM_RESTART': '1', 17:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:18 INFO - 'PWD': '/builds/slave/test', 17:16:18 INFO - 'SHELL': '/bin/bash', 17:16:18 INFO - 'SHLVL': '1', 17:16:18 INFO - 'TERM': 'linux', 17:16:18 INFO - 'TMOUT': '86400', 17:16:18 INFO - 'USER': 'cltbld', 17:16:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:18 INFO - '_': '/tools/buildbot/bin/python'} 17:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 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)) 17:16:18 INFO - Cleaning up... 17:16:18 INFO - Return code: 0 17:16:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:18 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 0x7fec441a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2619850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', '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 17:16:18 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 17:16:18 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 17:16:18 INFO - Using env: {'DISPLAY': ':0', 17:16:18 INFO - 'HOME': '/home/cltbld', 17:16:18 INFO - 'LANG': 'en_US.UTF-8', 17:16:18 INFO - 'LANGUAGE': 'en_US:en', 17:16:18 INFO - 'LOGNAME': 'cltbld', 17:16:18 INFO - 'MAIL': '/var/mail/cltbld', 17:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:18 INFO - 'MOZ_NO_REMOTE': '1', 17:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:18 INFO - 'NO_EM_RESTART': '1', 17:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:18 INFO - 'PWD': '/builds/slave/test', 17:16:18 INFO - 'SHELL': '/bin/bash', 17:16:18 INFO - 'SHLVL': '1', 17:16:18 INFO - 'TERM': 'linux', 17:16:18 INFO - 'TMOUT': '86400', 17:16:18 INFO - 'USER': 'cltbld', 17:16:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:18 INFO - '_': '/tools/buildbot/bin/python'} 17:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:16:18 INFO - Cleaning up... 17:16:18 INFO - Return code: 0 17:16:18 INFO - Running post-action listener: _resource_record_post_action 17:16:18 INFO - Running post-action listener: _start_resource_monitoring 17:16:18 INFO - Starting resource monitoring. 17:16:18 INFO - [mozharness: 2016-08-26 00:16:18.661888Z] Finished create-virtualenv step (success) 17:16:18 INFO - [mozharness: 2016-08-26 00:16:18.662401Z] Running install step. 17:16:18 INFO - Running pre-action listener: _resource_record_pre_action 17:16:18 INFO - Running main action method: install 17:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:18 INFO - Reading from file tmpfile_stdout 17:16:18 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:18 INFO - Reading from file tmpfile_stdout 17:16:18 INFO - Output received: 17:16:18 INFO - Usage: mozinstall [options] installer 17:16:18 INFO - Options: 17:16:18 INFO - -h, --help show this help message and exit 17:16:18 INFO - -d DEST, --destination=DEST 17:16:18 INFO - Directory to install application into. [default: 17:16:18 INFO - "/builds/slave/test"] 17:16:18 INFO - --app=APP Application being installed. [default: firefox] 17:16:18 INFO - mkdir: /builds/slave/test/build/application 17:16:18 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'] 17:16:18 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 17:16:36 INFO - Reading from file tmpfile_stdout 17:16:36 INFO - Output received: 17:16:36 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:36 INFO - Running post-action listener: _resource_record_post_action 17:16:36 INFO - [mozharness: 2016-08-26 00:16:36.473221Z] Finished install step (success) 17:16:36 INFO - [mozharness: 2016-08-26 00:16:36.473468Z] Running run-tests step. 17:16:36 INFO - Running pre-action listener: _resource_record_pre_action 17:16:36 INFO - Running main action method: run_tests 17:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:36 INFO - Python 2.7.3 17:16:36 INFO - Return code: 0 17:16:36 INFO - grabbing minidump binary from tooltool 17:16: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')]} 17:16:36 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 0x2614370>, '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 0x26178f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2617d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:36 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 17:16:36 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 17:16:36 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 17:16:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:36 INFO - Return code: 0 17:16:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:16:36 INFO - Using env: {'DISPLAY': ':0', 17:16:36 INFO - 'HOME': '/home/cltbld', 17:16:36 INFO - 'LANG': 'en_US.UTF-8', 17:16:36 INFO - 'LANGUAGE': 'en_US:en', 17:16:36 INFO - 'LOGNAME': 'cltbld', 17:16:36 INFO - 'MAIL': '/var/mail/cltbld', 17:16:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:36 INFO - 'MOZ_NO_REMOTE': '1', 17:16:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:36 INFO - 'NO_EM_RESTART': '1', 17:16:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:36 INFO - 'PWD': '/builds/slave/test', 17:16:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:36 INFO - 'SHELL': '/bin/bash', 17:16:36 INFO - 'SHLVL': '1', 17:16:36 INFO - 'TERM': 'linux', 17:16:36 INFO - 'TMOUT': '86400', 17:16:36 INFO - 'USER': 'cltbld', 17:16:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420', 17:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:36 INFO - '_': '/tools/buildbot/bin/python'} 17:16:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:16:36 INFO - mozversion application_buildid: 20160825143002 17:16:36 INFO - mozversion application_changeset: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 17:16:36 INFO - mozversion application_display_name: Nightly 17:16:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:36 INFO - mozversion application_name: Firefox 17:16:36 INFO - mozversion application_remotingname: firefox 17:16:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:36 INFO - mozversion application_vendor: Mozilla 17:16:36 INFO - mozversion application_version: 51.0a1 17:16:36 INFO - mozversion platform_buildid: 20160825143002 17:16:36 INFO - mozversion platform_changeset: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 17:16:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:36 INFO - mozversion platform_version: 51.0a1 17:16:36 INFO - using testdate: 1472170596 17:16:36 INFO - actual date: 1472170596 17:16:36 INFO - starting webserver on 'localhost:48403' 17:16:36 INFO - SUITE-START | Running 2 tests 17:16:36 INFO - TEST-START | dromaeo_css 17:16:36 INFO - operating with platform_type : linux_ 17:16:36 INFO - Initialising browser for dromaeo_css test... 17:16:36 INFO - TEST-INFO | started process 26664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUr52uW/profile http://localhost:48403/getInfo.html) 17:16:41 INFO - PROCESS | 26664 | __metrics Screen width/height:1600/1200 17:16:41 INFO - PROCESS | 26664 | colorDepth:24 17:16:41 INFO - PROCESS | 26664 | Browser inner width/height: 1024/697 17:16:41 INFO - PROCESS | 26664 | __metrics 17:16:41 ERROR - PROCESS | 26664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 17:16:42 INFO - TEST-INFO | 26664: exit 0 17:16:42 INFO - Browser initialized. 17:16:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:42 INFO - TEST-INFO | started process 26787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUr52uW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:54 INFO - PROCESS | 26787 | RSS: Main: 189792256 17:16:54 INFO - PROCESS | 26787 | 17:17:44 INFO - PROCESS | 26787 | 1472170664624 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] 17:19:54 INFO - PROCESS | 26787 | Cycle 1(1): loaded http://localhost:48403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48403/tests/dromaeo/cssquery-ext.html) 17:19:55 INFO - PROCESS | 26787 | RSS: Main: 211062784 17:19:55 INFO - PROCESS | 26787 | 17:22:57 INFO - PROCESS | 26787 | Cycle 1(1): loaded http://localhost:48403/tests/dromaeo/cssquery-ext.html (next: http://localhost:48403/tests/dromaeo/cssquery-jquery.html) 17:22:58 INFO - PROCESS | 26787 | RSS: Main: 204357632 17:22:58 INFO - PROCESS | 26787 | 17:25:59 INFO - PROCESS | 26787 | Cycle 1(1): loaded http://localhost:48403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48403/tests/dromaeo/cssquery-mootools.html) 17:26:00 INFO - PROCESS | 26787 | RSS: Main: 202911744 17:26:00 INFO - PROCESS | 26787 | 17:29:02 INFO - PROCESS | 26787 | Cycle 1(1): loaded http://localhost:48403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48403/tests/dromaeo/cssquery-prototype.html) 17:29:03 INFO - PROCESS | 26787 | RSS: Main: 195903488 17:29:03 INFO - PROCESS | 26787 | 17:32:05 INFO - PROCESS | 26787 | Cycle 1(1): loaded http://localhost:48403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48403/tests/dromaeo/cssquery-yui.html) 17:32:06 INFO - PROCESS | 26787 | RSS: Main: 198447104 17:32:06 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | Cycle 1(1): loaded http://localhost:48403/tests/dromaeo/cssquery-yui.html (next: http://localhost:48403/tests/dromaeo/cssquery-dojo.html) 17:35:09 INFO - PROCESS | 26787 | RSS: Main: 198516736 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | __start_tp_report 17:35:09 INFO - PROCESS | 26787 | _x_x_mozilla_page_load 17:35:09 INFO - PROCESS | 26787 | _x_x_mozilla_page_load_details 17:35:09 INFO - PROCESS | 26787 | |i|pagename|runs| 17:35:09 INFO - PROCESS | 26787 | |0;dojo.html;3078.245829771706;3101.674324195958;3113.828739419331;3132.169974956637;3134.576832127662;5324.733763311839;5355.598330125242;5434.701091439969;5457.372402173746;5481.369642491115;5355.892882142355;5399.325084364455;5473.0969390050695;5475.123980163175;5479.04116779563;4721.504242054586;4917.213245880669;4952.752362381884;4990.176620857555;5133.383993920735;5055.721935293557;5059.4181669107975;5065.1642478990925;5068.4424713281505;5124.871878203056;4750.691205071659;4814.085323788504;4948.035133149037;4987.251912213161;5016.3227964224725;4835.709857408567;4868.63485238605;4887.584555312803;4898;4936.90126197474;4800.759962001921;4837.7339246341435;4851.175300198975;4858.975705121452;4895.8776030599165;5260.421353651095;5273.762680679379;5302.73486325686;5325.1479763238085;5373.570114390839;5742.712864356766;5783.0747080467345;5793.768249270024;5818.5636077294375;5829.417058294137;5826.737796799154;5841.357450680422;5841.620294680833;5847.853803654943;5855.09246066856;5193.221016847503;5342.332208473941;5424.457554244584;5424.918626220609;5432.592555558349;5851.444112809277;5864.354920958776;5945.613535120204;6002.309734380602;6013.248343957005;5598.608097433222;5598.804041858597;5602.915956260578;5610.831675049755;5612.438756124355;5523.640963337451;5540.307461567304;5700.942990570041;5724;5742.626729262668;5630.802921897796;5637.605367624309;5669.262995810518;5671.688057156896;5740.598158128974;5677.091665333527;5678.375378708339;5683.090705487102;5683.261176047087;5686.687232202268;4321.416608757841;4361.542038086019;4422.7346359218545;4443.333499974965;4444.73331600105;3981.5421226558738;3984.4222587724616;4001.9599804001587;4029.9194016119513;4046.1503084352025;5489.4236105209175;5522.199281104217;5525.613207075467;5533.529649979716;5555.8888822224135;5574.749136288877;5640.210370548127;5666.461686139893;5812.099124635688;5822.039363505059;5396.460353964572;5416.377116631559;5417.26866872975;5457.945420545744;5467.289252397163;4879;4882.707037577757;4883.731394773251;4888.071266459361;4920.581750551243;5815.5929084963645;5818.0981947798155;5818.970905145447;5860.062390017662;5862.648241105548;5680.801171958961;5681.573881958952;5690.174924635988;5739.799107031234;5759.0209664358;5856.736446859816;5870.9412905870395;5896.823095307148;5898.970505147447;5901.29184497863;5519.061759500974;5537.031019571639;5596.41237670055;5604.663720176803;5611.242482264842;5668.348139963792;5736.541076713769;5736.971315143398;5752.654840709571;5786;5556.222128902038;5566.554675625859;5585.273914391103;5587.776488940397;5587.8882422352135;5544.22380866687;5548.140038294071;5597.04850175463;5609.49514543693;5643.238162847963;5575.4424557543925;5632.915506267327;5667.773289068391;5671.432856714296;5711.885762284648;5658.717064146858;5671.631343962629;5724.513416359656;5732.656040637575;5735.684537350319;5406.324209473816;5574.968630803314;5590.440955904377;5609.158626206102;5639.238702775073 17:35:09 INFO - PROCESS | 26787 | |1;ext.html;549.83767355115;574.7528562718031;589.9292084949807;597.5936363272973;618.4372221278637;39021;42742.78628606861;42976.78511607442;43094.353584696255;43264.56735432645;42857;43081;43519.34720979188;43562.346564801555;43591.78204108975;8783;8931.821363572724;8944.865827012567;8948.194662480375;8953.194212520872;8818.86771698425;8900.866487002668;8904.643814247422;8932.33007524435;8932.8660070099;8905.465672059665;8926.884139482565;8959.507227102507;8963.372563920528;8973.057828927966;8687.782805429852;8693.652253909868;8753.912460875374;8757.868631970461;8796.384253102286;8765.254953328975;8836.955815220947;8843.867341989875;8863.822723545492;8865.645374185026;40864;41292.58707412917;41298;41302.1739565207;41376.79311603423;3401.6258211596705;3799.2401519696173;3843.903902402434;3863.3239183142837;4160.45914031177;32298.83850580732;32569.6743032569;32807.83596082004;33004.17489562756;33123.834380828186;4303.354496825501;4456.286994080931;4487.753173575452;4536.364908912755;4631.258998560248;336463;340620;341754.9999999975;342732;345599.2720036409;55416.445835541934;55512;55615.16577251344;55630.443695563335;55669.72165139229;36550.8172459136;37145;37168.44247336292;38869.2226155481;57675.13487297694;15748.212589370714;15929.522114336589;15932.203389830462;16009.519714408354;16026;12983.221006739626;13073.280969546766;13168.736625267633;13178.670533236746;13192.142510736963;18844.717329239797;18848.24607015704;18898.716519252222;19040.143193556323;19113.808861911482;7062.364387205176;7083.060529880145;7091.89362159568;7249.963750181215;7335.853282934311;944.3531181140941;1111.4328796397042;1117.407773879845;1125.9866120491458;1178.9823152652716;32108.19729506781;32159;32295.677043229738;32836.507452388236;33308.50037249443;1116.1126904111252;1135.500379832871;1166.5742004168417;1184.875588063241;1191.9761604767857;16657.3337066516;16783.16084195785;17109.401170958958;17145.399911003056;17163.828361716223;577473;580395;583856;584236;585257;57828.421715783144;58266.70866645724;58379.70810145922;58483.70758146267;58747.118793218135;1296.3388671777461;1343.3820442596516;1362.0874014410172;1383.744007358642;1384.210999730144;30728.69271307258;31590.842045789625;31703.365932681678;32323;32821.50767738438;51180.48819511757;51246.48753512566;51301;51449.742751286;51721.482785173175;448330;449226;449711;451680;453793;27619.379228014004;27719.722802771714;27971.16086517408;28012.719872801827;28275.57586636161;47173;47937;48035.27947080727;48260.75869620629;48936.51063489462;39518.20963580655;40192.397114043895;40318.59681403149;41117.79441102895;42100.36849447199;40331;41048.38427423651;41247.58752412558;41386.37920431136;42327;40801.59198407978;41084.79457602693;41131;41159;42398.36402453904;34118.658813411545;37537.81231093827;37625.43561846629;37692.246155076195;38006.42990355202;28571.42857142887;28887.422251555272;29065.7093429063;29120.7087929118;29202.56196157017 17:35:09 INFO - PROCESS | 26787 | |2;jquery.html;365.5503730411592;375.8979650163003;389.5734171082664;398.59144377013564;424.8767857321377;18557.350492732756;20103.195872165114;20147.798522014775;20288.89855550722;20893.477663058395;17098.658026839486;17214.39749608764;17674.293028278855;18964.715529267072;19316.130774115165;5265.526102650761;5314.441983591725;5372.7313634318325;5422.15956526737;5449.291592093023;5322.973385133069;5334.333208348957;5348.46515348464;5400.432954539776;5401.513863752261;5384.1923711443205;5392.78428862847;5469.425710300421;5782.653040817564;5838.036723940545;5708.971455142719;5768.39431859655;5768.509676677488;5778.942210577882;5827.096799996008;5121.948780512184;5122.974385128088;5253.3958594761325;5263.499967503081;5282;22652.77347226523;23596.882015589985;23736.64395034076;23824.90276264092;24006.759932400626;2374.9287521374386;2453.251758213744;2923.766098712098;3000.4599172149005;3021;10939.453027348602;11166.994970452699;11738.765224695544;14241.287935603179;15705.764413533807;1929.6333696597742;1934.1973081171298;1998.0109845626507;2001.9399418017483;2041.3263623004373;82557.58721206416;84564.57717711372;85613.14386856176;86199.56900215521;86698;11247.493862776195;11376.886231137583;11467.369294688706;11707.121965852595;11714.648560543197;15942.362305507882;16030.278637461342;16091.517254482384;16130.193490325437;16158.838411615734;7930.484518506279;7993.400494962901;8062.113167551564;8063;8200.302974247255;7439.739609113655;7617.923820761832;7817.296443320015;7970.242826931432;8056.395770317133;4672.929906051412;4749.810007599657;4802.27965805132;4839.669091000003;5010.924836127461;1974.19058186143;2068.379486154148;2100.758412782519;2113.50332671822;2131.6589345704615;909.5855944007001;911.3119594705954;955.1833182628752;1031.7111208861531;1032.4063663393579;12284.815727764091;12481.375931203404;12936;13074.542391016268;13079.673008174872;487.8341363936279;491.704977013796;497.31370708422145;501.39832201357785;503.7833731495419;6723.697433615499;6878.965605171942;6890.2420733719255;6925.445964322842;6928.722851086001;489809;511978;520897;523820;529118;88446.67329990055;88671.55664221638;89891;90042.54978725064;91829.54085229665;491.75658049265843;504.1052132464831;506.09409157608206;507.3252574076543;510.22191158482866;11533.135014874086;11720.70698232551;11998.340091295062;12029.4586743595;12289.262644241375;41911;42532.78733606312;43210;43470.34794478149;44123.338149927135;58168.709156453944;58658.7067064662;60276.39723602708;60539.39460605514;61390;8604.526751028754;8823.867641985247;8850.291976641982;8881.111888811067;9051.909480905106;11808.291502509877;13559.932200338935;13770.65573360674;13937.233452160228;13996.300184990914;11007.504662290055;11586.826197607212;12185.451654675384;12312.507499699912;12514.18657787241;10836.241463097824;10892.836607450736;11044.889551104387;11439.656810295704;11474.139439542234;11386.146039046938;11419.02938250258;11759.823602645796;11861.5848445304;12492.688267732121;8846.336524760798;8850.247728943112;8853.822923541364;8856.025837157778;9229.907700922904;5862.530997520103;8864;9033;9278.536073196448;11819.172657913863 17:35:09 INFO - PROCESS | 26787 | |3;mootools.html;1439.5753252790423;1492.3060776738814;1592.7929369182011;1659.104083794751;1774.5297496163519;7555.168931417554;8350.624221910013;8415.831683366328;9065.32010099242;9159.35884488086;8953.05992870749;9001.234895033913;9022.097790220974;9062.682806101788;9071.13824186703;2359.6696462495265;2404.230646193219;2406.5427568761966;2407.4944261705064;2410.927672169838;2329.615613423783;2355.3640517060385;2423.321469988406;2427.7086749590076;2429.708434987804;2377;2402.411409204747;2402.95194096118;2404.2546810488802;2408.1089996701244;2326.9883650581637;2343.261872510154;2349.9295021149305;2352.306069709431;2374.620060790265;2257.4582100295975;2263.377571167942;2274.090363854455;2275.7496675365696;2277.168833375806;9021.819563608757;9052.864207036833;9073.455592664395;9162.404443711137;9192.678256261066;5154.4072431670465;5299.1786273127345;5305.071612467803;5308.495692909168;5311.49540793624;3401.132711158639;3484.1463841358777;3513.472979053137;3522.2427178156818;3523.066387407339;1149.350616901448;1157.560127151677;1167.6905620010618;1169.2224670594044;1173.7206444974934;12220.755584888342;12433.93783031079;12478.251304921734;12506.18709783861;12664.240145591293;4380.386745855582;4572.862814115582;4733.810647574127;4758.357621721023;4758.476567577563;10439.112675422673;10493.685189444328;10517.263791534671;10539.736506587396;10562.155027597773;5308.840734777963;5357.866053348619;5359.624826262202;5376.489233522809;5377.677339359651;4344.587264209895;4727.479977202505;4895.73073480962;4900.779464924087;4911.852644420602;3901.200253947934;4000.9199816004098;4128.4632997710105;4177.122804211089;4181.686373521937;1337.525178561616;1347.198416941918;1354.837419509665;1359.789232668938;1372.5196181336453;920.5765347939889;975.9365641233297;978.6183388478499;989.2333441582687;993.0615568288043;5846.181534585162;5898.557608179403;6121.785737499255;6148.631082135086;6197.101420294032;449.51901465432326;451.525897807301;461.60302140159433;468.94590832354817;970.3789574672215;3968.206358728266;3975.9395506064707;4079.8164082616354;4183.832646694159;4321.114171594815;10632.30889992148;11004.889951100547;11070.059044981106;11077.556897724162;11091.611793587186;10956.233063685466;10966.670999870017;11043.889561104446;11053.28153670009;11058.778824423627;8053.114157442794;8065.274125328749;8123.83752324962;8129.390295727726;8302.626381812834;5702.60081794287;5750.367459579526;5794.913076303943;5881.235439392852;5962.9105563415715;10232.079112879877;10281.845772313272;10289.382637041801;10380;10414.427206503411;10076.546555404877;10235.385876847115;10341.844872327072;10357.9482102589;10524.31591946521;6574.8356291093105;7286.96356518214;7317.15852676949;7460.440466964891;7518.548887066793;8827.867581986147;8895.555222238992;8918.821623567623;8919.241864441596;8923.821523569362;7766.145723970471;7801.843963120819;7930.444868859125;8014.83970320602;8108.918910811052;7674.961625192062;7753.030871141107;7794.376449884109;7804;7871.527708337518;7054.153501579844;7120.501564890616;7157.606331651809;7219.169795473587;7240.239774823778;4863.756812159449;4968.826091086795;5016.272640467185;5033.622478314068;5298.788048478018;5050.671706339076;5066.746662666926;5084.237364395371;5134.4352121267375;5343.064963631271 17:35:09 INFO - PROCESS | 26787 | |4;prototype.html;333.3599488981156;334.4865631256022;343.7696743182068;344.5933798118223;347.0369724015854;5438.945610543893;5521.337439507255;5552.972235138829;5557.499825015748;5569.721513924308;5424.566034717223;5437.184422336652;5469;5474.37044739855;5477.75350109245;4087.366458198969;4201.642860356873;4274.273373526508;4285.142971405716;4293.849715259967;4272.87181384559;4273.722208056482;4283.094023159695;4284.443022407083;4291.892702682442;4284.164587905359;4284.464441944757;4300.612944834964;4326.351047342892;4342.717723347988;4084.6323830855217;4228.640565551932;4259.936100958488;4275.5296917339065;4309.784510774464;3735.2156047230114;3740.8503659853573;3740.9438858417147;3748.6438788315068;3750.1187221003042;5377.4084850666395;5381.165919282517;5396.595255355864;5400.6498375406145;5404.540614047811;4618.284165954283;4840.128776820171;4881.975590122027;4889.657723959324;4902.950970490285;5723.5421166307015;5728.1980522726435;5733.684647344436;5799.710014499258;5800.622959507618;4089.5092588889524;4096.91806163878;4112.136451345221;4117.661759928005;4122.742563518126;5842.649441033552;5904.232449781543;5918.970405147989;6009.729562169713;6042.6978651067275;4139.254934111828;4170.061736109412;4171.311733563928;4201.411802347674;4255.851045213402;4255.638270746959;4286.314189729628;4286.357046442996;4288.378185163134;4292.849750258726;4665.486796452387;4817.301491283814;4844.934114494806;4893.266010098514;4916.72957987307;5715.714214289352;5719.399463056402;5732.914006289909;5747.252857128547;5747.568932330092;1444.3356056214259;1464.0995787590555;1468.2878803780159;1477.394268349993;1485.8781619876925;889.4731287001515;930.1675000874179;945.6831961292906;972.7373609125497;999.2755252442066;5534.584906132056;5539.41836107211;5567.137093750394;5576.776928922879;5630.634008789416;5766.509846663081;5791.681457519877;5910.970445147746;5911.261092363455;5917.408259174134;5352.91970620441;5403.567714582824;5463.48096930791;5464.754086066137;5511.834644960658;3086.151308390166;3113.392888386788;3113.968860311413;3117.4388610049955;3121.3133110715607;5863.970680146572;6057.969710151421;6075.817725468243;6083.239595050619;6107.541934354941;6004.219451471281;6009.609375390585;6019.578629495981;6060.575759696867;6078.079638633057;6009.759609615567;6034.366391528914;6044.214252147192;6070.969645151834;6109.511239100772;5644.6330988485615;5746.224259724883;5758.452946970031;5800.6809625471005;5812.738426770721;5749.642646514909;5819.82540523785;5820.388859169726;5827.679477628772;5848.239728835224;5869.37290645776;5896.587238893408;5967.254093238345;6090.878182436238;6098.298695650057;4178.770167640809;4180.749155050707;4181.540030596571;4202.936955945602;4203.222403855297;5847.736851841592;5851;5874.911876321773;5891.823245302648;5901;5587.12831201552;5635.464630860061;5698.2592263005545;5707.973669347488;5799.420057994167;5596.832095037155;5661.575381846295;5674.205611214516;5683.175939488834;5725.2843394575675;5400.486953739389;5676.17695434168;5708.429157084258;5719.170720245458;5730.828075157752;5746.655200687972;5798.637320229827;5798.913016304843;5799.188113664006;5819.359870414336;5672.901026620177;5687.800926967537;5696.458836410535;5697.923121514335;5714.714264286852 17:35:09 INFO - PROCESS | 26787 | |5;yui.html;690.2269458206807;752.8381397999433;787.374037640076;797.5175019113433;835.9038710548289;16684.41604543841;17619.647607047867;17623.20695568701;17661.82338176621;17704.557386065353;14702.264886755673;14722.337494812733;14731.705365892703;14744.926275368634;14851.034682745614;670.3732010570133;771.8494893495756;806.7660378490231;809.4900212865887;815.0871024452591;815.5392203405087;818.9222023907719;829.4111181061454;829.8049958259804;830.3523251863556;874.4971641306242;877.2981614708208;877.5787621941472;877.9473231606092;878.4509681449094;871.6208449324532;873.9169778870997;876.4565969099135;877.0703054761973;877.2280393253959;635.9109724638554;636.8662580858025;637.2735082006516;639.8912184928527;640.5452128988424;15397.538073857802;15516.612084697972;15593.610159746097;15598;15628.609284767972;15556.922215388964;15627.843721562753;15650;15703.607409814731;15937.521874343789;12283.385830708517;12433.254004759743;12744.299063551502;12947.287899165542;13260.40328185234;3995.40068989651;4012.4382586437923;4039.1921615676983;4065.410515475269;4185.707000509966;85641;86510.56744716299;87622.73281740498;89890.5505472475;92133;12361.258324500559;12427.254364738144;12524.81212781809;12586.118971672078;12664.113512054251;22715;22755.88622056879;22854.885725571265;22927.88536057309;22944.541109178055;8454.535000575028;8466.407351485337;8567.914320856711;8631.827363452696;8734.082921293173;4625.791839367236;4777.832775852898;4803.639727020487;4816.036792641416;4825.396825396825;3511.7717348372275;3652.7077833773233;3653.159773252167;3653.6529029742665;3655.6161603031833;564.4355644355644;566.6854895532937;576.6943519934441;577.4543056811357;577.861313284817;712.2272334517107;750.951188172767;782.1279273609885;785.6739453126888;793.9166387529342;9579.808403831885;10359.689209323733;10425.894039075885;10460.110890574235;10466;725.4414101142091;737.2185483387626;739.9704011839574;756.5838788666211;765.770268919322;4730.195866702668;4982.327385802871;5110.361204849394;5127.179651255781;5173.793048278102;118285.4085729583;120982.395088024;121611;125107;126910;68396.6580167106;69333;70750;83657.58171209105;91949;74721;87884;89481;90196.5490172545;90238;9921.25590580695;10282.691519254435;10338.224633152393;10436.16510679159;10436.478176091317;52282.21576676277;52833.20750188673;53264.73367633137;53687.463125368246;53712.406015037406;71341;76718;76798;77192.22807771851;77466;13483.460661573426;13501.89960713238;13578;13782;13833.584992450242;14635.853641463875;14965.92517037408;15408.614784630474;15569.532914012598;15938.123403212934;13258.535951242045;13481;13716.519921802688;13738.519151829638;14180.220087895264;13363.892981699062;13745.9377698796;13859.861401385857;14048.086874353134;14518.346674399467;14426.495072672406;14448.638784030063;14511.492097776527;14935.477258295907;15156.014859034127;11117.388543630179;11166.944165279121;11171.88828111741;11414.657560273205;11867.940660296643;11484.94257528707;11726.179167458196;11755.941220294186;11820.527178912747;12031.338276394883 17:35:09 INFO - PROCESS | 26787 | __end_tp_report 17:35:09 INFO - PROCESS | 26787 | __start_cc_report 17:35:09 INFO - PROCESS | 26787 | _x_x_mozilla_cycle_collect,325 17:35:09 INFO - PROCESS | 26787 | __end_cc_report 17:35:09 INFO - PROCESS | 26787 | __startTimestamp1472171709255__endTimestamp 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | ------- Summary: start ------- 17:35:09 INFO - PROCESS | 26787 | Number of tests: 6 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | [#0] dojo.html Cycles:165 Average:5340.70 Median:5556.22 stddev:591.23 (10.6%) stddev-sans-first:565.77 17:35:09 INFO - PROCESS | 26787 | Values: 3078.2 3101.7 3113.8 3132.2 3134.6 5324.7 5355.6 5434.7 5457.4 5481.4 5355.9 5399.3 5473.1 5475.1 5479.0 4721.5 4917.2 4952.8 4990.2 5133.4 5055.7 5059.4 5065.2 5068.4 5124.9 4750.7 4814.1 4948.0 4987.3 5016.3 4835.7 4868.6 4887.6 4898.0 4936.9 4800.8 4837.7 4851.2 4859.0 4895.9 5260.4 5273.8 5302.7 5325.1 5373.6 5742.7 5783.1 5793.8 5818.6 5829.4 5826.7 5841.4 5841.6 5847.9 5855.1 5193.2 5342.3 5424.5 5424.9 5432.6 5851.4 5864.4 5945.6 6002.3 6013.2 5598.6 5598.8 5602.9 5610.8 5612.4 5523.6 5540.3 5700.9 5724.0 5742.6 5630.8 5637.6 5669.3 5671.7 5740.6 5677.1 5678.4 5683.1 5683.3 5686.7 4321.4 4361.5 4422.7 4443.3 4444.7 3981.5 3984.4 4002.0 4029.9 4046.2 5489.4 5522.2 5525.6 5533.5 5555.9 5574.7 5640.2 5666.5 5812.1 5822.0 5396.5 5416.4 5417.3 5457.9 5467.3 4879.0 4882.7 4883.7 4888.1 4920.6 5815.6 5818.1 5819.0 5860.1 5862.6 5680.8 5681.6 5690.2 5739.8 5759.0 5856.7 5870.9 5896.8 5899.0 5901.3 5519.1 5537.0 5596.4 5604.7 5611.2 5668.3 5736.5 5737.0 5752.7 5786.0 5556.2 5566.6 5585.3 5587.8 5587.9 5544.2 5548.1 5597.0 5609.5 5643.2 5575.4 5632.9 5667.8 5671.4 5711.9 5658.7 5671.6 5724.5 5732.7 5735.7 5406.3 5575.0 5590.4 5609.2 5639.2 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | [#1] ext.html Cycles:180 Average:61084.50 Median:41295.29 stddev:124579.69 (301.7%) stddev-sans-first:124846.26 17:35:09 INFO - PROCESS | 26787 | Values: 549.8 574.8 589.9 597.6 618.4 39021.0 42742.8 42976.8 43094.4 43264.6 42857.0 43081.0 43519.3 43562.3 43591.8 8783.0 8931.8 8944.9 8948.2 8953.2 8818.9 8900.9 8904.6 8932.3 8932.9 8905.5 8926.9 8959.5 8963.4 8973.1 8687.8 8693.7 8753.9 8757.9 8796.4 8765.3 8837.0 8843.9 8863.8 8865.6 40864.0 41292.6 41298.0 41302.2 41376.8 3401.6 3799.2 3843.9 3863.3 4160.5 32298.8 32569.7 32807.8 33004.2 33123.8 4303.4 4456.3 4487.8 4536.4 4631.3 336463.0 340620.0 341755.0 342732.0 345599.3 55416.4 55512.0 55615.2 55630.4 55669.7 36550.8 37145.0 37168.4 38869.2 57675.1 15748.2 15929.5 15932.2 16009.5 16026.0 12983.2 13073.3 13168.7 13178.7 13192.1 18844.7 18848.2 18898.7 19040.1 19113.8 7062.4 7083.1 7091.9 7250.0 7335.9 944.4 1111.4 1117.4 1126.0 1179.0 32108.2 32159.0 32295.7 32836.5 33308.5 1116.1 1135.5 1166.6 1184.9 1192.0 16657.3 16783.2 17109.4 17145.4 17163.8 577473.0 580395.0 583856.0 584236.0 585257.0 57828.4 58266.7 58379.7 58483.7 58747.1 1296.3 1343.4 1362.1 1383.7 1384.2 30728.7 31590.8 31703.4 32323.0 32821.5 51180.5 51246.5 51301.0 51449.7 51721.5 448330.0 449226.0 449711.0 451680.0 453793.0 27619.4 27719.7 27971.2 28012.7 28275.6 47173.0 47937.0 48035.3 48260.8 48936.5 39518.2 40192.4 40318.6 41117.8 42100.4 40331.0 41048.4 41247.6 41386.4 42327.0 40801.6 41084.8 41131.0 41159.0 42398.4 34118.7 37537.8 37625.4 37692.2 38006.4 28571.4 28887.4 29065.7 29120.7 29202.6 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | [#2] jquery.html Cycles:180 Average:29402.24 Median:4820.97 stddev:84974.54 (1762.6%) stddev-sans-first:85184.95 17:35:09 INFO - PROCESS | 26787 | Values: 365.6 375.9 389.6 398.6 424.9 18557.4 20103.2 20147.8 20288.9 20893.5 17098.7 17214.4 17674.3 18964.7 19316.1 5265.5 5314.4 5372.7 5422.2 5449.3 5323.0 5334.3 5348.5 5400.4 5401.5 5384.2 5392.8 5469.4 5782.7 5838.0 5709.0 5768.4 5768.5 5778.9 5827.1 5121.9 5123.0 5253.4 5263.5 5282.0 22652.8 23596.9 23736.6 23824.9 24006.8 2374.9 2453.3 2923.8 3000.5 3021.0 10939.5 11167.0 11738.8 14241.3 15705.8 1929.6 1934.2 1998.0 2001.9 2041.3 82557.6 84564.6 85613.1 86199.6 86698.0 11247.5 11376.9 11467.4 11707.1 11714.6 15942.4 16030.3 16091.5 16130.2 16158.8 7930.5 7993.4 8062.1 8063.0 8200.3 7439.7 7617.9 7817.3 7970.2 8056.4 4672.9 4749.8 4802.3 4839.7 5010.9 1974.2 2068.4 2100.8 2113.5 2131.7 909.6 911.3 955.2 1031.7 1032.4 12284.8 12481.4 12936.0 13074.5 13079.7 487.8 491.7 497.3 501.4 503.8 6723.7 6879.0 6890.2 6925.4 6928.7 489809.0 511978.0 520897.0 523820.0 529118.0 88446.7 88671.6 89891.0 90042.5 91829.5 491.8 504.1 506.1 507.3 510.2 11533.1 11720.7 11998.3 12029.5 12289.3 41911.0 42532.8 43210.0 43470.3 44123.3 58168.7 58658.7 60276.4 60539.4 61390.0 8604.5 8823.9 8850.3 8881.1 9051.9 11808.3 13559.9 13770.7 13937.2 13996.3 11007.5 11586.8 12185.5 12312.5 12514.2 10836.2 10892.8 11044.9 11439.7 11474.1 11386.1 11419.0 11759.8 11861.6 12492.7 8846.3 8850.2 8853.8 8856.0 9229.9 5862.5 8864.0 9033.0 9278.5 11819.2 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | [#3] mootools.html Cycles:180 Average:5848.09 Median:465.27 stddev:3351.01 (720.2%) stddev-sans-first:3344.03 17:35:09 INFO - PROCESS | 26787 | Values: 1439.6 1492.3 1592.8 1659.1 1774.5 7555.2 8350.6 8415.8 9065.3 9159.4 8953.1 9001.2 9022.1 9062.7 9071.1 2359.7 2404.2 2406.5 2407.5 2410.9 2329.6 2355.4 2423.3 2427.7 2429.7 2377.0 2402.4 2403.0 2404.3 2408.1 2327.0 2343.3 2349.9 2352.3 2374.6 2257.5 2263.4 2274.1 2275.7 2277.2 9021.8 9052.9 9073.5 9162.4 9192.7 5154.4 5299.2 5305.1 5308.5 5311.5 3401.1 3484.1 3513.5 3522.2 3523.1 1149.4 1157.6 1167.7 1169.2 1173.7 12220.8 12433.9 12478.3 12506.2 12664.2 4380.4 4572.9 4733.8 4758.4 4758.5 10439.1 10493.7 10517.3 10539.7 10562.2 5308.8 5357.9 5359.6 5376.5 5377.7 4344.6 4727.5 4895.7 4900.8 4911.9 3901.2 4000.9 4128.5 4177.1 4181.7 1337.5 1347.2 1354.8 1359.8 1372.5 920.6 975.9 978.6 989.2 993.1 5846.2 5898.6 6121.8 6148.6 6197.1 449.5 451.5 461.6 468.9 970.4 3968.2 3975.9 4079.8 4183.8 4321.1 10632.3 11004.9 11070.1 11077.6 11091.6 10956.2 10966.7 11043.9 11053.3 11058.8 8053.1 8065.3 8123.8 8129.4 8302.6 5702.6 5750.4 5794.9 5881.2 5962.9 10232.1 10281.8 10289.4 10380.0 10414.4 10076.5 10235.4 10341.8 10357.9 10524.3 6574.8 7287.0 7317.2 7460.4 7518.5 8827.9 8895.6 8918.8 8919.2 8923.8 7766.1 7801.8 7930.4 8014.8 8108.9 7675.0 7753.0 7794.4 7804.0 7871.5 7054.2 7120.5 7157.6 7219.2 7240.2 4863.8 4968.8 5016.3 5033.6 5298.8 5050.7 5066.7 5084.2 5134.4 5343.1 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | [#4] prototype.html Cycles:180 Average:4827.64 Median:5555.24 stddev:1420.31 (25.6%) stddev-sans-first:1383.66 17:35:09 INFO - PROCESS | 26787 | Values: 333.4 334.5 343.8 344.6 347.0 5438.9 5521.3 5553.0 5557.5 5569.7 5424.6 5437.2 5469.0 5474.4 5477.8 4087.4 4201.6 4274.3 4285.1 4293.8 4272.9 4273.7 4283.1 4284.4 4291.9 4284.2 4284.5 4300.6 4326.4 4342.7 4084.6 4228.6 4259.9 4275.5 4309.8 3735.2 3740.9 3740.9 3748.6 3750.1 5377.4 5381.2 5396.6 5400.6 5404.5 4618.3 4840.1 4882.0 4889.7 4903.0 5723.5 5728.2 5733.7 5799.7 5800.6 4089.5 4096.9 4112.1 4117.7 4122.7 5842.6 5904.2 5919.0 6009.7 6042.7 4139.3 4170.1 4171.3 4201.4 4255.9 4255.6 4286.3 4286.4 4288.4 4292.8 4665.5 4817.3 4844.9 4893.3 4916.7 5715.7 5719.4 5732.9 5747.3 5747.6 1444.3 1464.1 1468.3 1477.4 1485.9 889.5 930.2 945.7 972.7 999.3 5534.6 5539.4 5567.1 5576.8 5630.6 5766.5 5791.7 5911.0 5911.3 5917.4 5352.9 5403.6 5463.5 5464.8 5511.8 3086.2 3113.4 3114.0 3117.4 3121.3 5864.0 6058.0 6075.8 6083.2 6107.5 6004.2 6009.6 6019.6 6060.6 6078.1 6009.8 6034.4 6044.2 6071.0 6109.5 5644.6 5746.2 5758.5 5800.7 5812.7 5749.6 5819.8 5820.4 5827.7 5848.2 5869.4 5896.6 5967.3 6090.9 6098.3 4178.8 4180.7 4181.5 4202.9 4203.2 5847.7 5851.0 5874.9 5891.8 5901.0 5587.1 5635.5 5698.3 5708.0 5799.4 5596.8 5661.6 5674.2 5683.2 5725.3 5400.5 5676.2 5708.4 5719.2 5730.8 5746.7 5798.6 5798.9 5799.2 5819.4 5672.9 5687.8 5696.5 5697.9 5714.7 17:35:09 INFO - PROCESS | 26787 | 17:35:09 INFO - PROCESS | 26787 | [#5] yui.html Cycles:180 Average:21183.95 Median:4052.30 stddev:30035.03 (741.2%) stddev-sans-first:30079.87 17:35:09 INFO - PROCESS | 26787 | Values: 690.2 752.8 787.4 797.5 835.9 16684.4 17619.6 17623.2 17661.8 17704.6 14702.3 14722.3 14731.7 14744.9 14851.0 670.4 771.8 806.8 809.5 815.1 815.5 818.9 829.4 829.8 830.4 874.5 877.3 877.6 877.9 878.5 871.6 873.9 876.5 877.1 877.2 635.9 636.9 637.3 639.9 640.5 15397.5 15516.6 15593.6 15598.0 15628.6 15556.9 15627.8 15650.0 15703.6 15937.5 12283.4 12433.3 12744.3 12947.3 13260.4 3995.4 4012.4 4039.2 4065.4 4185.7 85641.0 86510.6 87622.7 89890.6 92133.0 12361.3 12427.3 12524.8 12586.1 12664.1 22715.0 22755.9 22854.9 22927.9 22944.5 8454.5 8466.4 8567.9 8631.8 8734.1 4625.8 4777.8 4803.6 4816.0 4825.4 3511.8 3652.7 3653.2 3653.7 3655.6 564.4 566.7 576.7 577.5 577.9 712.2 751.0 782.1 785.7 793.9 9579.8 10359.7 10425.9 10460.1 10466.0 725.4 737.2 740.0 756.6 765.8 4730.2 4982.3 5110.4 5127.2 5173.8 118285.4 120982.4 121611.0 125107.0 126910.0 68396.7 69333.0 70750.0 83657.6 91949.0 74721.0 87884.0 89481.0 90196.5 90238.0 9921.3 10282.7 10338.2 10436.2 10436.5 52282.2 52833.2 53264.7 53687.5 53712.4 71341.0 76718.0 76798.0 77192.2 77466.0 13483.5 13501.9 13578.0 13782.0 13833.6 14635.9 14965.9 15408.6 15569.5 15938.1 13258.5 13481.0 13716.5 13738.5 14180.2 13363.9 13745.9 13859.9 14048.1 14518.3 14426.5 14448.6 14511.5 14935.5 15156.0 11117.4 11166.9 11171.9 11414.7 11867.9 11484.9 11726.2 11755.9 11820.5 12031.3 17:35:09 INFO - PROCESS | 26787 | -------- Summary: end -------- 17:35:09 INFO - PROCESS | 26787 | 17:35:10 INFO - TEST-INFO | 26787: exit 0 17:35:10 INFO - TEST-OK | dromaeo_css | took 1113561ms 17:35:10 INFO - TEST-START | kraken 17:35:10 INFO - operating with platform_type : linux_ 17:35:10 INFO - Initialising browser for kraken test... 17:35:10 INFO - TEST-INFO | started process 27154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4h8iv/profile http://localhost:48403/getInfo.html) 17:35:14 INFO - PROCESS | 27154 | __metrics Screen width/height:1600/1200 17:35:14 INFO - PROCESS | 27154 | colorDepth:24 17:35:14 INFO - PROCESS | 27154 | Browser inner width/height: 1024/697 17:35:14 INFO - PROCESS | 27154 | __metrics 17:35:15 ERROR - PROCESS | 27154 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 17:35:16 INFO - TEST-INFO | 27154: exit 0 17:35:16 INFO - Browser initialized. 17:35:16 INFO - Running cycle 1/1 for kraken test... 17:35:16 INFO - TEST-INFO | started process 27276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4h8iv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:28 INFO - PROCESS | 27276 | RSS: Main: 189739008 17:35:28 INFO - PROCESS | 27276 | 17:35:30 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48403/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:31 INFO - PROCESS | 27276 | RSS: Main: 203104256 17:35:31 INFO - PROCESS | 27276 | 17:35:34 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48403/tests/kraken/driver.html?testName=audio-dft) 17:35:35 INFO - PROCESS | 27276 | RSS: Main: 201805824 17:35:35 INFO - PROCESS | 27276 | 17:35:37 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48403/tests/kraken/driver.html?testName=audio-fft) 17:35:38 INFO - PROCESS | 27276 | RSS: Main: 195411968 17:35:38 INFO - PROCESS | 27276 | 17:35:40 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48403/tests/kraken/driver.html?testName=audio-oscillator) 17:35:41 INFO - PROCESS | 27276 | RSS: Main: 196255744 17:35:41 INFO - PROCESS | 27276 | 17:35:43 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:44 INFO - PROCESS | 27276 | RSS: Main: 196472832 17:35:44 INFO - PROCESS | 27276 | 17:35:47 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48403/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:47 INFO - PROCESS | 27276 | RSS: Main: 196767744 17:35:47 INFO - PROCESS | 27276 | 17:35:51 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48403/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:51 INFO - PROCESS | 27276 | RSS: Main: 194789376 17:35:51 INFO - PROCESS | 27276 | 17:35:54 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48403/tests/kraken/driver.html?testName=json-parse-financial) 17:35:55 INFO - PROCESS | 27276 | RSS: Main: 195928064 17:35:55 INFO - PROCESS | 27276 | 17:35:57 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:57 INFO - PROCESS | 27276 | RSS: Main: 195850240 17:35:57 INFO - PROCESS | 27276 | 17:35:59 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:00 INFO - PROCESS | 27276 | RSS: Main: 195870720 17:36:00 INFO - PROCESS | 27276 | 17:36:02 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:02 INFO - PROCESS | 27276 | RSS: Main: 196182016 17:36:02 INFO - PROCESS | 27276 | 17:36:05 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:06 INFO - PROCESS | 27276 | RSS: Main: 196472832 17:36:06 INFO - PROCESS | 27276 | 17:36:09 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:09 INFO - PROCESS | 27276 | RSS: Main: 197353472 17:36:09 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:48403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48403/tests/kraken/driver.html?testName=ai-astar) 17:36:11 INFO - PROCESS | 27276 | RSS: Main: 198537216 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | __start_tp_report 17:36:11 INFO - PROCESS | 27276 | _x_x_mozilla_page_load 17:36:11 INFO - PROCESS | 27276 | _x_x_mozilla_page_load_details 17:36:11 INFO - PROCESS | 27276 | |i|pagename|runs| 17:36:11 INFO - PROCESS | 27276 | |0;ai-astar;109;110;105;114;116;114;99;111;116;112 17:36:11 INFO - PROCESS | 27276 | |1;audio-beat-detection;151;124;146;181;127;155;154;122;196;123 17:36:11 INFO - PROCESS | 27276 | |2;audio-dft;162;163;164;167;161;163;161;163;162;161 17:36:11 INFO - PROCESS | 27276 | |3;audio-fft;77;76;75;180;77;77;76;76;176;78 17:36:11 INFO - PROCESS | 27276 | |4;audio-oscillator;85;85;158;88;85;85;150;84;84;136 17:36:11 INFO - PROCESS | 27276 | |5;imaging-gaussian-blur;117;119;117;119;118;119;119;118;118;119 17:36:11 INFO - PROCESS | 27276 | |6;imaging-darkroom;148;148;148;148;147;147;147;147;148;148 17:36:11 INFO - PROCESS | 27276 | |7;imaging-desaturate;97;96;96;95;96;100;97;96;96;97 17:36:11 INFO - PROCESS | 27276 | |8;json-parse-financial;57;54;55;54;54;54;60;54;54;58 17:36:11 INFO - PROCESS | 27276 | |9;json-stringify-tinderbox;61;62;62;62;62;61;62;62;63;62 17:36:11 INFO - PROCESS | 27276 | |10;stanford-crypto-aes;79;80;79;80;81;79;79;79;79;78 17:36:11 INFO - PROCESS | 27276 | |11;stanford-crypto-ccm;134;141;126;129;135;133;142;137;158;134 17:36:11 INFO - PROCESS | 27276 | |12;stanford-crypto-pbkdf2;164;169;164;172;160;163;164;166;166;164 17:36:11 INFO - PROCESS | 27276 | |13;stanford-crypto-sha256-iterative;70;65;65;66;72;65;64;65;63;71 17:36:11 INFO - PROCESS | 27276 | __end_tp_report 17:36:11 INFO - PROCESS | 27276 | __start_cc_report 17:36:11 INFO - PROCESS | 27276 | _x_x_mozilla_cycle_collect,790 17:36:11 INFO - PROCESS | 27276 | __end_cc_report 17:36:11 INFO - PROCESS | 27276 | __startTimestamp1472171771637__endTimestamp 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | ------- Summary: start ------- 17:36:11 INFO - PROCESS | 27276 | Number of tests: 14 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#0] ai-astar Cycles:10 Average:110.60 Median:114.00 stddev:5.30 (4.6%) stddev-sans-first:5.59 17:36:11 INFO - PROCESS | 27276 | Values: 109.0 110.0 105.0 114.0 116.0 114.0 99.0 111.0 116.0 112.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:152.50 stddev:25.41 (16.7%) stddev-sans-first:26.92 17:36:11 INFO - PROCESS | 27276 | Values: 151.0 124.0 146.0 181.0 127.0 155.0 154.0 122.0 196.0 123.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.83 (1.1%) stddev-sans-first:1.92 17:36:11 INFO - PROCESS | 27276 | Values: 162.0 163.0 164.0 167.0 161.0 163.0 161.0 163.0 162.0 161.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#3] audio-fft Cycles:10 Average:96.80 Median:76.50 stddev:42.81 (56.0%) stddev-sans-first:44.81 17:36:11 INFO - PROCESS | 27276 | Values: 77.0 76.0 75.0 180.0 77.0 77.0 76.0 76.0 176.0 78.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:85.00 stddev:30.83 (36.3%) stddev-sans-first:31.93 17:36:11 INFO - PROCESS | 27276 | Values: 85.0 85.0 158.0 88.0 85.0 85.0 150.0 84.0 84.0 136.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:119.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 17:36:11 INFO - PROCESS | 27276 | Values: 117.0 119.0 117.0 119.0 118.0 119.0 119.0 118.0 118.0 119.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 17:36:11 INFO - PROCESS | 27276 | Values: 148.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 148.0 148.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 17:36:11 INFO - PROCESS | 27276 | Values: 97.0 96.0 96.0 95.0 96.0 100.0 97.0 96.0 96.0 97.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:2.17 (4.0%) stddev-sans-first:2.22 17:36:11 INFO - PROCESS | 27276 | Values: 57.0 54.0 55.0 54.0 54.0 54.0 60.0 54.0 54.0 58.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 17:36:11 INFO - PROCESS | 27276 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 63.0 62.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 17:36:11 INFO - PROCESS | 27276 | Values: 79.0 80.0 79.0 80.0 81.0 79.0 79.0 79.0 79.0 78.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:136.00 stddev:8.85 (6.5%) stddev-sans-first:9.32 17:36:11 INFO - PROCESS | 27276 | Values: 134.0 141.0 126.0 129.0 135.0 133.0 142.0 137.0 158.0 134.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.00 stddev:3.33 (2.0%) stddev-sans-first:3.50 17:36:11 INFO - PROCESS | 27276 | Values: 164.0 169.0 164.0 172.0 160.0 163.0 164.0 166.0 166.0 164.0 17:36:11 INFO - PROCESS | 27276 | 17:36:11 INFO - PROCESS | 27276 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:65.50 stddev:3.17 (4.8%) stddev-sans-first:3.11 17:36:11 INFO - PROCESS | 27276 | Values: 70.0 65.0 65.0 66.0 72.0 65.0 64.0 65.0 63.0 71.0 17:36:11 INFO - PROCESS | 27276 | -------- Summary: end -------- 17:36:11 INFO - PROCESS | 27276 | 17:36:12 INFO - TEST-INFO | 27276: exit 0 17:36:12 INFO - TEST-OK | kraken | took 62458ms 17:36:12 INFO - SUITE-END | took 1176s 17:36:12 INFO - Completed test suite (00:19:36) 17:36:12 INFO - javascript benchmark 17:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.340609618272, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.245829771706, 3101.674324195958, 3113.828739419331, 3132.169974956637, 3134.576832127662, 5324.733763311839, 5355.598330125242, 5434.701091439969, 5457.372402173746, 5481.369642491115, 5355.892882142355, 5399.325084364455, 5473.0969390050695, 5475.123980163175, 5479.04116779563, 4721.504242054586, 4917.213245880669, 4952.752362381884, 4990.176620857555, 5133.383993920735, 5055.721935293557, 5059.4181669107975, 5065.1642478990925, 5068.4424713281505, 5124.871878203056, 4750.691205071659, 4814.085323788504, 4948.035133149037, 4987.251912213161, 5016.3227964224725, 4835.709857408567, 4868.63485238605, 4887.584555312803, 4898.0, 4936.90126197474, 4800.759962001921, 4837.7339246341435, 4851.175300198975, 4858.975705121452, 4895.8776030599165, 5260.421353651095, 5273.762680679379, 5302.73486325686, 5325.1479763238085, 5373.570114390839, 5742.712864356766, 5783.0747080467345, 5793.768249270024, 5818.5636077294375, 5829.417058294137, 5826.737796799154, 5841.357450680422, 5841.620294680833, 5847.853803654943, 5855.09246066856, 5193.221016847503, 5342.332208473941, 5424.457554244584, 5424.918626220609, 5432.592555558349, 5851.444112809277, 5864.354920958776, 5945.613535120204, 6002.309734380602, 6013.248343957005, 5598.608097433222, 5598.804041858597, 5602.915956260578, 5610.831675049755, 5612.438756124355, 5523.640963337451, 5540.307461567304, 5700.942990570041, 5724.0, 5742.626729262668, 5630.802921897796, 5637.605367624309, 5669.262995810518, 5671.688057156896, 5740.598158128974, 5677.091665333527, 5678.375378708339, 5683.090705487102, 5683.261176047087, 5686.687232202268, 4321.416608757841, 4361.542038086019, 4422.7346359218545, 4443.333499974965, 4444.73331600105, 3981.5421226558738, 3984.4222587724616, 4001.9599804001587, 4029.9194016119513, 4046.1503084352025, 5489.4236105209175, 5522.199281104217, 5525.613207075467, 5533.529649979716, 5555.8888822224135, 5574.749136288877, 5640.210370548127, 5666.461686139893, 5812.099124635688, 5822.039363505059, 5396.460353964572, 5416.377116631559, 5417.26866872975, 5457.945420545744, 5467.289252397163, 4879.0, 4882.707037577757, 4883.731394773251, 4888.071266459361, 4920.581750551243, 5815.5929084963645, 5818.0981947798155, 5818.970905145447, 5860.062390017662, 5862.648241105548, 5680.801171958961, 5681.573881958952, 5690.174924635988, 5739.799107031234, 5759.0209664358, 5856.736446859816, 5870.9412905870395, 5896.823095307148, 5898.970505147447, 5901.29184497863, 5519.061759500974, 5537.031019571639, 5596.41237670055, 5604.663720176803, 5611.242482264842, 5668.348139963792, 5736.541076713769, 5736.971315143398, 5752.654840709571, 5786.0, 5556.222128902038, 5566.554675625859, 5585.273914391103, 5587.776488940397, 5587.8882422352135, 5544.22380866687, 5548.140038294071, 5597.04850175463, 5609.49514543693, 5643.238162847963, 5575.4424557543925, 5632.915506267327, 5667.773289068391, 5671.432856714296, 5711.885762284648, 5658.717064146858, 5671.631343962629, 5724.513416359656, 5732.656040637575, 5735.684537350319, 5406.324209473816, 5574.968630803314, 5590.440955904377, 5609.158626206102, 5639.238702775073], "value": 5301.638209218606, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.83767355115, 574.7528562718031, 589.9292084949807, 597.5936363272973, 618.4372221278637, 39021.0, 42742.78628606861, 42976.78511607442, 43094.353584696255, 43264.56735432645, 42857.0, 43081.0, 43519.34720979188, 43562.346564801555, 43591.78204108975, 8783.0, 8931.821363572724, 8944.865827012567, 8948.194662480375, 8953.194212520872, 8818.86771698425, 8900.866487002668, 8904.643814247422, 8932.33007524435, 8932.8660070099, 8905.465672059665, 8926.884139482565, 8959.507227102507, 8963.372563920528, 8973.057828927966, 8687.782805429852, 8693.652253909868, 8753.912460875374, 8757.868631970461, 8796.384253102286, 8765.254953328975, 8836.955815220947, 8843.867341989875, 8863.822723545492, 8865.645374185026, 40864.0, 41292.58707412917, 41298.0, 41302.1739565207, 41376.79311603423, 3401.6258211596705, 3799.2401519696173, 3843.903902402434, 3863.3239183142837, 4160.45914031177, 32298.83850580732, 32569.6743032569, 32807.83596082004, 33004.17489562756, 33123.834380828186, 4303.354496825501, 4456.286994080931, 4487.753173575452, 4536.364908912755, 4631.258998560248, 336463.0, 340620.0, 341754.9999999975, 342732.0, 345599.2720036409, 55416.445835541934, 55512.0, 55615.16577251344, 55630.443695563335, 55669.72165139229, 36550.8172459136, 37145.0, 37168.44247336292, 38869.2226155481, 57675.13487297694, 15748.212589370714, 15929.522114336589, 15932.203389830462, 16009.519714408354, 16026.0, 12983.221006739626, 13073.280969546766, 13168.736625267633, 13178.670533236746, 13192.142510736963, 18844.717329239797, 18848.24607015704, 18898.716519252222, 19040.143193556323, 19113.808861911482, 7062.364387205176, 7083.060529880145, 7091.89362159568, 7249.963750181215, 7335.853282934311, 944.3531181140941, 1111.4328796397042, 1117.407773879845, 1125.9866120491458, 1178.9823152652716, 32108.19729506781, 32159.0, 32295.677043229738, 32836.507452388236, 33308.50037249443, 1116.1126904111252, 1135.500379832871, 1166.5742004168417, 1184.875588063241, 1191.9761604767857, 16657.3337066516, 16783.16084195785, 17109.401170958958, 17145.399911003056, 17163.828361716223, 577473.0, 580395.0, 583856.0, 584236.0, 585257.0, 57828.421715783144, 58266.70866645724, 58379.70810145922, 58483.70758146267, 58747.118793218135, 1296.3388671777461, 1343.3820442596516, 1362.0874014410172, 1383.744007358642, 1384.210999730144, 30728.69271307258, 31590.842045789625, 31703.365932681678, 32323.0, 32821.50767738438, 51180.48819511757, 51246.48753512566, 51301.0, 51449.742751286, 51721.482785173175, 448330.0, 449226.0, 449711.0, 451680.0, 453793.0, 27619.379228014004, 27719.722802771714, 27971.16086517408, 28012.719872801827, 28275.57586636161, 47173.0, 47937.0, 48035.27947080727, 48260.75869620629, 48936.51063489462, 39518.20963580655, 40192.397114043895, 40318.59681403149, 41117.79441102895, 42100.36849447199, 40331.0, 41048.38427423651, 41247.58752412558, 41386.37920431136, 42327.0, 40801.59198407978, 41084.79457602693, 41131.0, 41159.0, 42398.36402453904, 34118.658813411545, 37537.81231093827, 37625.43561846629, 37692.246155076195, 38006.42990355202, 28571.42857142887, 28887.422251555272, 29065.7093429063, 29120.7087929118, 29202.56196157017], "value": 20026.232746035854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.5503730411592, 375.8979650163003, 389.5734171082664, 398.59144377013564, 424.8767857321377, 18557.350492732756, 20103.195872165114, 20147.798522014775, 20288.89855550722, 20893.477663058395, 17098.658026839486, 17214.39749608764, 17674.293028278855, 18964.715529267072, 19316.130774115165, 5265.526102650761, 5314.441983591725, 5372.7313634318325, 5422.15956526737, 5449.291592093023, 5322.973385133069, 5334.333208348957, 5348.46515348464, 5400.432954539776, 5401.513863752261, 5384.1923711443205, 5392.78428862847, 5469.425710300421, 5782.653040817564, 5838.036723940545, 5708.971455142719, 5768.39431859655, 5768.509676677488, 5778.942210577882, 5827.096799996008, 5121.948780512184, 5122.974385128088, 5253.3958594761325, 5263.499967503081, 5282.0, 22652.77347226523, 23596.882015589985, 23736.64395034076, 23824.90276264092, 24006.759932400626, 2374.9287521374386, 2453.251758213744, 2923.766098712098, 3000.4599172149005, 3021.0, 10939.453027348602, 11166.994970452699, 11738.765224695544, 14241.287935603179, 15705.764413533807, 1929.6333696597742, 1934.1973081171298, 1998.0109845626507, 2001.9399418017483, 2041.3263623004373, 82557.58721206416, 84564.57717711372, 85613.14386856176, 86199.56900215521, 86698.0, 11247.493862776195, 11376.886231137583, 11467.369294688706, 11707.121965852595, 11714.648560543197, 15942.362305507882, 16030.278637461342, 16091.517254482384, 16130.193490325437, 16158.838411615734, 7930.484518506279, 7993.400494962901, 8062.113167551564, 8063.0, 8200.302974247255, 7439.739609113655, 7617.923820761832, 7817.296443320015, 7970.242826931432, 8056.395770317133, 4672.929906051412, 4749.810007599657, 4802.27965805132, 4839.669091000003, 5010.924836127461, 1974.19058186143, 2068.379486154148, 2100.758412782519, 2113.50332671822, 2131.6589345704615, 909.5855944007001, 911.3119594705954, 955.1833182628752, 1031.7111208861531, 1032.4063663393579, 12284.815727764091, 12481.375931203404, 12936.0, 13074.542391016268, 13079.673008174872, 487.8341363936279, 491.704977013796, 497.31370708422145, 501.39832201357785, 503.7833731495419, 6723.697433615499, 6878.965605171942, 6890.2420733719255, 6925.445964322842, 6928.722851086001, 489809.0, 511978.0, 520897.0, 523820.0, 529118.0, 88446.67329990055, 88671.55664221638, 89891.0, 90042.54978725064, 91829.54085229665, 491.75658049265843, 504.1052132464831, 506.09409157608206, 507.3252574076543, 510.22191158482866, 11533.135014874086, 11720.70698232551, 11998.340091295062, 12029.4586743595, 12289.262644241375, 41911.0, 42532.78733606312, 43210.0, 43470.34794478149, 44123.338149927135, 58168.709156453944, 58658.7067064662, 60276.39723602708, 60539.39460605514, 61390.0, 8604.526751028754, 8823.867641985247, 8850.291976641982, 8881.111888811067, 9051.909480905106, 11808.291502509877, 13559.932200338935, 13770.65573360674, 13937.233452160228, 13996.300184990914, 11007.504662290055, 11586.826197607212, 12185.451654675384, 12312.507499699912, 12514.18657787241, 10836.241463097824, 10892.836607450736, 11044.889551104387, 11439.656810295704, 11474.139439542234, 11386.146039046938, 11419.02938250258, 11759.823602645796, 11861.5848445304, 12492.688267732121, 8846.336524760798, 8850.247728943112, 8853.822923541364, 8856.025837157778, 9229.907700922904, 5862.530997520103, 8864.0, 9033.0, 9278.536073196448, 11819.172657913863], "value": 8629.723719297004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.5753252790423, 1492.3060776738814, 1592.7929369182011, 1659.104083794751, 1774.5297496163519, 7555.168931417554, 8350.624221910013, 8415.831683366328, 9065.32010099242, 9159.35884488086, 8953.05992870749, 9001.234895033913, 9022.097790220974, 9062.682806101788, 9071.13824186703, 2359.6696462495265, 2404.230646193219, 2406.5427568761966, 2407.4944261705064, 2410.927672169838, 2329.615613423783, 2355.3640517060385, 2423.321469988406, 2427.7086749590076, 2429.708434987804, 2377.0, 2402.411409204747, 2402.95194096118, 2404.2546810488802, 2408.1089996701244, 2326.9883650581637, 2343.261872510154, 2349.9295021149305, 2352.306069709431, 2374.620060790265, 2257.4582100295975, 2263.377571167942, 2274.090363854455, 2275.7496675365696, 2277.168833375806, 9021.819563608757, 9052.864207036833, 9073.455592664395, 9162.404443711137, 9192.678256261066, 5154.4072431670465, 5299.1786273127345, 5305.071612467803, 5308.495692909168, 5311.49540793624, 3401.132711158639, 3484.1463841358777, 3513.472979053137, 3522.2427178156818, 3523.066387407339, 1149.350616901448, 1157.560127151677, 1167.6905620010618, 1169.2224670594044, 1173.7206444974934, 12220.755584888342, 12433.93783031079, 12478.251304921734, 12506.18709783861, 12664.240145591293, 4380.386745855582, 4572.862814115582, 4733.810647574127, 4758.357621721023, 4758.476567577563, 10439.112675422673, 10493.685189444328, 10517.263791534671, 10539.736506587396, 10562.155027597773, 5308.840734777963, 5357.866053348619, 5359.624826262202, 5376.489233522809, 5377.677339359651, 4344.587264209895, 4727.479977202505, 4895.73073480962, 4900.779464924087, 4911.852644420602, 3901.200253947934, 4000.9199816004098, 4128.4632997710105, 4177.122804211089, 4181.686373521937, 1337.525178561616, 1347.198416941918, 1354.837419509665, 1359.789232668938, 1372.5196181336453, 920.5765347939889, 975.9365641233297, 978.6183388478499, 989.2333441582687, 993.0615568288043, 5846.181534585162, 5898.557608179403, 6121.785737499255, 6148.631082135086, 6197.101420294032, 449.51901465432326, 451.525897807301, 461.60302140159433, 468.94590832354817, 970.3789574672215, 3968.206358728266, 3975.9395506064707, 4079.8164082616354, 4183.832646694159, 4321.114171594815, 10632.30889992148, 11004.889951100547, 11070.059044981106, 11077.556897724162, 11091.611793587186, 10956.233063685466, 10966.670999870017, 11043.889561104446, 11053.28153670009, 11058.778824423627, 8053.114157442794, 8065.274125328749, 8123.83752324962, 8129.390295727726, 8302.626381812834, 5702.60081794287, 5750.367459579526, 5794.913076303943, 5881.235439392852, 5962.9105563415715, 10232.079112879877, 10281.845772313272, 10289.382637041801, 10380.0, 10414.427206503411, 10076.546555404877, 10235.385876847115, 10341.844872327072, 10357.9482102589, 10524.31591946521, 6574.8356291093105, 7286.96356518214, 7317.15852676949, 7460.440466964891, 7518.548887066793, 8827.867581986147, 8895.555222238992, 8918.821623567623, 8919.241864441596, 8923.821523569362, 7766.145723970471, 7801.843963120819, 7930.444868859125, 8014.83970320602, 8108.918910811052, 7674.961625192062, 7753.030871141107, 7794.376449884109, 7804.0, 7871.527708337518, 7054.153501579844, 7120.501564890616, 7157.606331651809, 7219.169795473587, 7240.239774823778, 4863.756812159449, 4968.826091086795, 5016.272640467185, 5033.622478314068, 5298.788048478018, 5050.671706339076, 5066.746662666926, 5084.237364395371, 5134.4352121267375, 5343.064963631271], "value": 4628.806691595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.3599488981156, 334.4865631256022, 343.7696743182068, 344.5933798118223, 347.0369724015854, 5438.945610543893, 5521.337439507255, 5552.972235138829, 5557.499825015748, 5569.721513924308, 5424.566034717223, 5437.184422336652, 5469.0, 5474.37044739855, 5477.75350109245, 4087.366458198969, 4201.642860356873, 4274.273373526508, 4285.142971405716, 4293.849715259967, 4272.87181384559, 4273.722208056482, 4283.094023159695, 4284.443022407083, 4291.892702682442, 4284.164587905359, 4284.464441944757, 4300.612944834964, 4326.351047342892, 4342.717723347988, 4084.6323830855217, 4228.640565551932, 4259.936100958488, 4275.5296917339065, 4309.784510774464, 3735.2156047230114, 3740.8503659853573, 3740.9438858417147, 3748.6438788315068, 3750.1187221003042, 5377.4084850666395, 5381.165919282517, 5396.595255355864, 5400.6498375406145, 5404.540614047811, 4618.284165954283, 4840.128776820171, 4881.975590122027, 4889.657723959324, 4902.950970490285, 5723.5421166307015, 5728.1980522726435, 5733.684647344436, 5799.710014499258, 5800.622959507618, 4089.5092588889524, 4096.91806163878, 4112.136451345221, 4117.661759928005, 4122.742563518126, 5842.649441033552, 5904.232449781543, 5918.970405147989, 6009.729562169713, 6042.6978651067275, 4139.254934111828, 4170.061736109412, 4171.311733563928, 4201.411802347674, 4255.851045213402, 4255.638270746959, 4286.314189729628, 4286.357046442996, 4288.378185163134, 4292.849750258726, 4665.486796452387, 4817.301491283814, 4844.934114494806, 4893.266010098514, 4916.72957987307, 5715.714214289352, 5719.399463056402, 5732.914006289909, 5747.252857128547, 5747.568932330092, 1444.3356056214259, 1464.0995787590555, 1468.2878803780159, 1477.394268349993, 1485.8781619876925, 889.4731287001515, 930.1675000874179, 945.6831961292906, 972.7373609125497, 999.2755252442066, 5534.584906132056, 5539.41836107211, 5567.137093750394, 5576.776928922879, 5630.634008789416, 5766.509846663081, 5791.681457519877, 5910.970445147746, 5911.261092363455, 5917.408259174134, 5352.91970620441, 5403.567714582824, 5463.48096930791, 5464.754086066137, 5511.834644960658, 3086.151308390166, 3113.392888386788, 3113.968860311413, 3117.4388610049955, 3121.3133110715607, 5863.970680146572, 6057.969710151421, 6075.817725468243, 6083.239595050619, 6107.541934354941, 6004.219451471281, 6009.609375390585, 6019.578629495981, 6060.575759696867, 6078.079638633057, 6009.759609615567, 6034.366391528914, 6044.214252147192, 6070.969645151834, 6109.511239100772, 5644.6330988485615, 5746.224259724883, 5758.452946970031, 5800.6809625471005, 5812.738426770721, 5749.642646514909, 5819.82540523785, 5820.388859169726, 5827.679477628772, 5848.239728835224, 5869.37290645776, 5896.587238893408, 5967.254093238345, 6090.878182436238, 6098.298695650057, 4178.770167640809, 4180.749155050707, 4181.540030596571, 4202.936955945602, 4203.222403855297, 5847.736851841592, 5851.0, 5874.911876321773, 5891.823245302648, 5901.0, 5587.12831201552, 5635.464630860061, 5698.2592263005545, 5707.973669347488, 5799.420057994167, 5596.832095037155, 5661.575381846295, 5674.205611214516, 5683.175939488834, 5725.2843394575675, 5400.486953739389, 5676.17695434168, 5708.429157084258, 5719.170720245458, 5730.828075157752, 5746.655200687972, 5798.637320229827, 5798.913016304843, 5799.188113664006, 5819.359870414336, 5672.901026620177, 5687.800926967537, 5696.458836410535, 5697.923121514335, 5714.714264286852], "value": 4371.679566285249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.2269458206807, 752.8381397999433, 787.374037640076, 797.5175019113433, 835.9038710548289, 16684.41604543841, 17619.647607047867, 17623.20695568701, 17661.82338176621, 17704.557386065353, 14702.264886755673, 14722.337494812733, 14731.705365892703, 14744.926275368634, 14851.034682745614, 670.3732010570133, 771.8494893495756, 806.7660378490231, 809.4900212865887, 815.0871024452591, 815.5392203405087, 818.9222023907719, 829.4111181061454, 829.8049958259804, 830.3523251863556, 874.4971641306242, 877.2981614708208, 877.5787621941472, 877.9473231606092, 878.4509681449094, 871.6208449324532, 873.9169778870997, 876.4565969099135, 877.0703054761973, 877.2280393253959, 635.9109724638554, 636.8662580858025, 637.2735082006516, 639.8912184928527, 640.5452128988424, 15397.538073857802, 15516.612084697972, 15593.610159746097, 15598.0, 15628.609284767972, 15556.922215388964, 15627.843721562753, 15650.0, 15703.607409814731, 15937.521874343789, 12283.385830708517, 12433.254004759743, 12744.299063551502, 12947.287899165542, 13260.40328185234, 3995.40068989651, 4012.4382586437923, 4039.1921615676983, 4065.410515475269, 4185.707000509966, 85641.0, 86510.56744716299, 87622.73281740498, 89890.5505472475, 92133.0, 12361.258324500559, 12427.254364738144, 12524.81212781809, 12586.118971672078, 12664.113512054251, 22715.0, 22755.88622056879, 22854.885725571265, 22927.88536057309, 22944.541109178055, 8454.535000575028, 8466.407351485337, 8567.914320856711, 8631.827363452696, 8734.082921293173, 4625.791839367236, 4777.832775852898, 4803.639727020487, 4816.036792641416, 4825.396825396825, 3511.7717348372275, 3652.7077833773233, 3653.159773252167, 3653.6529029742665, 3655.6161603031833, 564.4355644355644, 566.6854895532937, 576.6943519934441, 577.4543056811357, 577.861313284817, 712.2272334517107, 750.951188172767, 782.1279273609885, 785.6739453126888, 793.9166387529342, 9579.808403831885, 10359.689209323733, 10425.894039075885, 10460.110890574235, 10466.0, 725.4414101142091, 737.2185483387626, 739.9704011839574, 756.5838788666211, 765.770268919322, 4730.195866702668, 4982.327385802871, 5110.361204849394, 5127.179651255781, 5173.793048278102, 118285.4085729583, 120982.395088024, 121611.0, 125107.0, 126910.0, 68396.6580167106, 69333.0, 70750.0, 83657.58171209105, 91949.0, 74721.0, 87884.0, 89481.0, 90196.5490172545, 90238.0, 9921.25590580695, 10282.691519254435, 10338.224633152393, 10436.16510679159, 10436.478176091317, 52282.21576676277, 52833.20750188673, 53264.73367633137, 53687.463125368246, 53712.406015037406, 71341.0, 76718.0, 76798.0, 77192.22807771851, 77466.0, 13483.460661573426, 13501.89960713238, 13578.0, 13782.0, 13833.584992450242, 14635.853641463875, 14965.92517037408, 15408.614784630474, 15569.532914012598, 15938.123403212934, 13258.535951242045, 13481.0, 13716.519921802688, 13738.519151829638, 14180.220087895264, 13363.892981699062, 13745.9377698796, 13859.861401385857, 14048.086874353134, 14518.346674399467, 14426.495072672406, 14448.638784030063, 14511.492097776527, 14935.477258295907, 15156.014859034127, 11117.388543630179, 11166.944165279121, 11171.88828111741, 11414.657560273205, 11867.940660296643, 11484.94257528707, 11726.179167458196, 11755.941220294186, 11820.527178912747, 12031.338276394883], "value": 7801.644059811166, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 105.0, 114.0, 116.0, 114.0, 99.0, 111.0, 116.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 146.0, 181.0, 127.0, 155.0, 154.0, 122.0, 196.0, 123.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 167.0, 161.0, 163.0, 161.0, 163.0, 162.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 180.0, 77.0, 77.0, 76.0, 76.0, 176.0, 78.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 158.0, 88.0, 85.0, 85.0, 150.0, 84.0, 84.0, 136.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 119.0, 118.0, 119.0, 119.0, 118.0, 118.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 100.0, 97.0, 96.0, 96.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 54.0, 54.0, 54.0, 60.0, 54.0, 54.0, 58.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 81.0, 79.0, 79.0, 79.0, 79.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 126.0, 129.0, 135.0, 133.0, 142.0, 137.0, 158.0, 134.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 164.0, 172.0, 160.0, 163.0, 164.0, 166.0, 166.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 65.0, 66.0, 72.0, 65.0, 64.0, 65.0, 63.0, 71.0], "value": 66.6, "unit": "score"}]}]} 17:36:12 INFO - Return code: 0 17:36:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:36:12 ERROR - # TBPL SUCCESS # 17:36:12 INFO - Running post-action listener: _resource_record_post_action 17:36:12 INFO - [mozharness: 2016-08-26 00:36:12.913445Z] Finished run-tests step (success) 17:36:12 INFO - Running post-run listener: _resource_record_post_run 17:36:12 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417898496; Read time: 12; Write time: 237692 17:36:12 INFO - TinderboxPrint: CPU usage
13.4% 17:36:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:36:12 INFO - TinderboxPrint: I/O write bytes / time
417,898,496 / 237,692 17:36:12 INFO - TinderboxPrint: CPU idle
8,247.0 (86.6%) 17:36:12 INFO - TinderboxPrint: CPU user
1,212.9 (12.7%) 17:36:12 INFO - TinderboxPrint: Swap in / out
0 / 0 17:36:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 129097728; Read time: 0; Write time: 56532 17:36:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288186368; Read time: 12; Write time: 181160 17:36:13 INFO - Running post-run listener: _upload_blobber_files 17:36:13 INFO - Blob upload gear active. 17:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:13 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 17:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:36:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:14 INFO - (blobuploader) - INFO - Done attempting. 17:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:20 INFO - (blobuploader) - INFO - Done attempting. 17:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:20 INFO - (blobuploader) - INFO - Done attempting. 17:36:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:20 INFO - Return code: 0 17:36:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d68825dfd08d4b38f9b7ddfa7ee7382aa13d5dc0cd29696385cfb62d9c4dfd5bd447e46a14533e5fd3e2a22a05b04bddf6c80b679cb44482eb6f4b9f9061fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ea180bb629a26392d2975187b97a1c271cb647e866c5715f5f33b325cf0ccd66109d201f5dfbbc1b591628952ef9c64efc447a8f46c7cd81cc2bf2e6267968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa4410d90bd3c0010b6f6a2810e911068af0e07041946f061d0900ae990c250272df17150f4104fe649c7f81df45370dad8dc1759a7df664301579fcd2e648e"} 17:36:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:20 INFO - Contents: 17:36:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d68825dfd08d4b38f9b7ddfa7ee7382aa13d5dc0cd29696385cfb62d9c4dfd5bd447e46a14533e5fd3e2a22a05b04bddf6c80b679cb44482eb6f4b9f9061fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ea180bb629a26392d2975187b97a1c271cb647e866c5715f5f33b325cf0ccd66109d201f5dfbbc1b591628952ef9c64efc447a8f46c7cd81cc2bf2e6267968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa4410d90bd3c0010b6f6a2810e911068af0e07041946f061d0900ae990c250272df17150f4104fe649c7f81df45370dad8dc1759a7df664301579fcd2e648e"} 17:36:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:20 INFO - Copying logs to upload dir... 17:36:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.373938 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-25 17:36:20.254245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 17:36:20.257677) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d68825dfd08d4b38f9b7ddfa7ee7382aa13d5dc0cd29696385cfb62d9c4dfd5bd447e46a14533e5fd3e2a22a05b04bddf6c80b679cb44482eb6f4b9f9061fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ea180bb629a26392d2975187b97a1c271cb647e866c5715f5f33b325cf0ccd66109d201f5dfbbc1b591628952ef9c64efc447a8f46c7cd81cc2bf2e6267968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa4410d90bd3c0010b6f6a2810e911068af0e07041946f061d0900ae990c250272df17150f4104fe649c7f81df45370dad8dc1759a7df664301579fcd2e648e"} build_url:https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/Dy_jQAfAQ9KKl3gCMVZX8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d68825dfd08d4b38f9b7ddfa7ee7382aa13d5dc0cd29696385cfb62d9c4dfd5bd447e46a14533e5fd3e2a22a05b04bddf6c80b679cb44482eb6f4b9f9061fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ea180bb629a26392d2975187b97a1c271cb647e866c5715f5f33b325cf0ccd66109d201f5dfbbc1b591628952ef9c64efc447a8f46c7cd81cc2bf2e6267968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fa4410d90bd3c0010b6f6a2810e911068af0e07041946f061d0900ae990c250272df17150f4104fe649c7f81df45370dad8dc1759a7df664301579fcd2e648e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 17:36:20.283447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:36:20.283767) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1472170022.213175-2089345420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:36:20.369005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 17:36:20.369317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 17:36:20.369609) ========= ========= Total master_lag: 0.62 =========