builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1470648044.42 results: success (0) buildid: 20160807233010 builduid: 40de1f71a62c4b2f8f2522f480f471bd revision: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.419753) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.420152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.420453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.435539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.435896) ========= 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=52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 02:20:47-- 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% 219M=0s 2016-08-08 02:20:47 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.622515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.622803) ========= 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=52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014852 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.672732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:44.673061) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 --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 c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 --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=52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 02:20:47,758 truncating revision to first 12 chars 2016-08-08 02:20:47,758 Setting DEBUG logging. 2016-08-08 02:20:47,758 attempt 1/10 2016-08-08 02:20:47,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c0e4639e98b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 02:20:48,080 unpacking tar archive at: fx-team-c0e4639e98b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:45.333204) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:45.333526) ========= script_repo_revision: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:45.333915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:45.334174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 02:20:45.342969) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-08 02:20:45.343255) ========= /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=52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:48 INFO - MultiFileLogger online at 20160808 02:20:48 in /builds/slave/test 02:20:48 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 02:20:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:48 INFO - {'append_to_log': False, 02:20:48 INFO - 'base_work_dir': '/builds/slave/test', 02:20:48 INFO - 'blob_upload_branch': 'Fx-Team', 02:20:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:48 INFO - 'branch': 'Fx-Team', 02:20:48 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:48 INFO - 'config_files': ('talos/linux_config.py',), 02:20:48 INFO - 'default_actions': ('clobber', 02:20:48 INFO - 'read-buildbot-config', 02:20:48 INFO - 'download-and-extract', 02:20:48 INFO - 'populate-webroot', 02:20:48 INFO - 'create-virtualenv', 02:20:48 INFO - 'install', 02:20:48 INFO - 'run-tests'), 02:20:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:48 INFO - 'download_minidump_stackwalk': True, 02:20:48 INFO - 'download_symbols': 'ondemand', 02:20:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:48 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:48 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:48 INFO - 'installer_path': 'installer.exe', 02:20:48 INFO - 'log_level': 'info', 02:20:48 INFO - 'log_name': 'talos', 02:20:48 INFO - 'log_to_console': True, 02:20:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:48 INFO - 'opt_config_files': (), 02:20:48 INFO - 'pip_index': False, 02:20:48 INFO - 'sps_profile': False, 02:20:48 INFO - 'sps_profile_interval': 0, 02:20:48 INFO - 'suite': 'dromaeojs-e10s', 02:20:48 INFO - 'system_bits': '32', 02:20:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:48 INFO - 'title': 'talos-linux64-ix-056', 02:20:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:48 INFO - 'use_talos_json': True, 02:20:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:48 INFO - 'work_dir': 'build'} 02:20:48 INFO - [mozharness: 2016-08-08 09:20:48.520277Z] Running clobber step. 02:20:48 INFO - Running pre-action listener: _resource_record_pre_action 02:20:48 INFO - Running main action method: clobber 02:20:48 INFO - rmtree: /builds/slave/test/build 02:20:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:49 INFO - Running post-action listener: _resource_record_post_action 02:20:49 INFO - [mozharness: 2016-08-08 09:20:49.014561Z] Finished clobber step (success) 02:20:49 INFO - [mozharness: 2016-08-08 09:20:49.014663Z] Running read-buildbot-config step. 02:20:49 INFO - Running pre-action listener: _resource_record_pre_action 02:20:49 INFO - Running main action method: read_buildbot_config 02:20:49 INFO - Using buildbot properties: 02:20:49 INFO - { 02:20:49 INFO - "project": "", 02:20:49 INFO - "product": "firefox", 02:20:49 INFO - "script_repo_revision": "production", 02:20:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:20:49 INFO - "repository": "", 02:20:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:20:49 INFO - "buildid": "20160807233010", 02:20:49 INFO - "pgo_build": "True", 02:20:49 INFO - "basedir": "/builds/slave/test", 02:20:49 INFO - "buildnumber": 1025, 02:20:49 INFO - "slavename": "talos-linux64-ix-056", 02:20:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:20:49 INFO - "platform": "ubuntu64_hw", 02:20:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:20:49 INFO - "branch": "fx-team", 02:20:49 INFO - "repo_path": "integration/fx-team", 02:20:49 INFO - "revision": "c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7", 02:20:49 INFO - "stage_platform": "linux64-pgo", 02:20:49 INFO - "builduid": "40de1f71a62c4b2f8f2522f480f471bd", 02:20:49 INFO - "slavebuilddir": "test" 02:20:49 INFO - } 02:20:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:20:49 INFO - Running post-action listener: _resource_record_post_action 02:20:49 INFO - [mozharness: 2016-08-08 09:20:49.017420Z] Finished read-buildbot-config step (success) 02:20:49 INFO - [mozharness: 2016-08-08 09:20:49.017507Z] Running download-and-extract step. 02:20:49 INFO - Running pre-action listener: _resource_record_pre_action 02:20:49 INFO - Running main action method: download_and_extract 02:20:49 INFO - mkdir: /builds/slave/test/build/tests 02:20:49 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')]} 02:20:49 INFO - trying https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:20:49 INFO - Downloading https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:49 INFO - Downloaded 1361 bytes. 02:20:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:20:49 INFO - Using the following test package requirements: 02:20:49 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:49 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:49 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:49 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'jsshell-linux-x86_64.zip'], 02:20:49 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:49 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:49 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:49 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:49 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:49 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:49 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')]} 02:20:49 INFO - trying https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:49 INFO - Downloading https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:50 INFO - Downloaded 21828612 bytes. 02:20:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:51 INFO - Return code: 0 02:20:51 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 02:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:51 INFO - trying https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:51 INFO - Downloading https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:52 INFO - Downloaded 21828612 bytes. 02:20:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:53 INFO - Return code: 0 02:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:53 INFO - trying https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:53 INFO - Downloading https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:54 INFO - Downloaded 14413723 bytes. 02:20:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:20:54 INFO - Return code: 0 02:20: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')]} 02:20:54 INFO - trying https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:20:54 INFO - Downloading https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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 02:20:56 INFO - Downloaded 59971815 bytes. 02:20:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:20:56 INFO - mkdir: /builds/slave/test/properties 02:20:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:56 INFO - Contents: 02:20:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:20:57 INFO - Running post-action listener: _resource_record_post_action 02:20:57 INFO - Running post-action listener: set_extra_try_arguments 02:20:57 INFO - [mozharness: 2016-08-08 09:20:57.751996Z] Finished download-and-extract step (success) 02:20:57 INFO - [mozharness: 2016-08-08 09:20:57.752270Z] Running populate-webroot step. 02:20:57 INFO - Running pre-action listener: _resource_record_pre_action 02:20:57 INFO - Running main action method: populate_webroot 02:20:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:57 INFO - '--tppagecycles', 02:20:57 INFO - '7'], 02:20:57 INFO - 'tests': ['tsvgm']}}, 02:20:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['damp', 'tps']}, 02:20:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'tests': ['damp', 'tps']}, 02:20:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['dromaeo_dom']}, 02:20:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['basic_compositor_video']}, 02:20:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:20:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['a11yr', 02:20:57 INFO - 'ts_paint', 02:20:57 INFO - 'tpaint', 02:20:57 INFO - 'sessionrestore', 02:20:57 INFO - 'sessionrestore_no_auto_restore', 02:20:57 INFO - 'tabpaint']}, 02:20:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:57 INFO - 'ts_paint', 02:20:57 INFO - 'tpaint', 02:20:57 INFO - 'sessionrestore', 02:20:57 INFO - 'sessionrestore_no_auto_restore', 02:20:57 INFO - 'tabpaint']}, 02:20:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:57 INFO - 'ts_paint', 02:20:57 INFO - 'tpaint', 02:20:57 INFO - 'sessionrestore', 02:20:57 INFO - 'sessionrestore_no_auto_restore', 02:20:57 INFO - 'tabpaint']}, 02:20:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:57 INFO - 'ts_paint', 02:20:57 INFO - 'tpaint', 02:20:57 INFO - 'sessionrestore', 02:20:57 INFO - 'sessionrestore_no_auto_restore', 02:20:57 INFO - 'tabpaint']}, 02:20:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['a11yr', 02:20:57 INFO - 'ts_paint', 02:20:57 INFO - 'tpaint', 02:20:57 INFO - 'sessionrestore', 02:20:57 INFO - 'sessionrestore_no_auto_restore', 02:20:57 INFO - 'tabpaint']}, 02:20:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['a11yr', 02:20:57 INFO - 'ts_paint', 02:20:57 INFO - 'tpaint', 02:20:57 INFO - 'sessionrestore', 02:20:57 INFO - 'sessionrestore_no_auto_restore', 02:20:57 INFO - 'tabpaint']}, 02:20:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['tsvgx', 02:20:57 INFO - 'tsvgr_opacity', 02:20:57 INFO - 'tart', 02:20:57 INFO - 'tscrollx', 02:20:57 INFO - 'cart']}, 02:20:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:57 INFO - 'tsvgr_opacity', 02:20:57 INFO - 'tart', 02:20:57 INFO - 'tscrollx', 02:20:57 INFO - 'cart']}, 02:20:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'talos_options': ['--disable-e10s'], 02:20:57 INFO - 'tests': ['tp5o']}, 02:20:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'tests': ['tp5o']}, 02:20:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'talos_options': ['--disable-e10s', 02:20:57 INFO - '--xperf_path', 02:20:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:57 INFO - 'tests': ['tp5n']}, 02:20:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:57 INFO - 'talos_options': ['--xperf_path', 02:20:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:57 INFO - 'tests': ['tp5n']}}, 02:20:57 INFO - 'talos.zip': {'path': '', 02:20:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:57 INFO - Running post-action listener: _resource_record_post_action 02:20:57 INFO - [mozharness: 2016-08-08 09:20:57.768237Z] Finished populate-webroot step (success) 02:20:57 INFO - [mozharness: 2016-08-08 09:20:57.768326Z] Running create-virtualenv step. 02:20:57 INFO - Running pre-action listener: _resource_record_pre_action 02:20:57 INFO - Running main action method: create_virtualenv 02:20:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20: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 02:20:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:57 INFO - Using real prefix '/usr' 02:20:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:00 INFO - Installing pip.................done. 02:21:00 INFO - Return code: 0 02:21:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:00 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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:00 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 02:21:00 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 02:21:00 INFO - Using env: {'DISPLAY': ':0', 02:21:00 INFO - 'HOME': '/home/cltbld', 02:21:00 INFO - 'LANG': 'en_US.UTF-8', 02:21:00 INFO - 'LANGUAGE': 'en_US:en', 02:21:00 INFO - 'LOGNAME': 'cltbld', 02:21:00 INFO - 'MAIL': '/var/mail/cltbld', 02:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:00 INFO - 'MOZ_NO_REMOTE': '1', 02:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:00 INFO - 'NO_EM_RESTART': '1', 02:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:00 INFO - 'PWD': '/builds/slave/test', 02:21:00 INFO - 'SHELL': '/bin/bash', 02:21:00 INFO - 'SHLVL': '1', 02:21:00 INFO - 'TERM': 'linux', 02:21:00 INFO - 'TMOUT': '86400', 02:21:00 INFO - 'USER': 'cltbld', 02:21:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:00 INFO - '_': '/tools/buildbot/bin/python'} 02:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:00 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 02:21:00 INFO - Cleaning up... 02:21:00 INFO - Return code: 0 02:21:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:00 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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:00 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 02:21:00 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 02:21:00 INFO - Using env: {'DISPLAY': ':0', 02:21:00 INFO - 'HOME': '/home/cltbld', 02:21:00 INFO - 'LANG': 'en_US.UTF-8', 02:21:00 INFO - 'LANGUAGE': 'en_US:en', 02:21:00 INFO - 'LOGNAME': 'cltbld', 02:21:00 INFO - 'MAIL': '/var/mail/cltbld', 02:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:00 INFO - 'MOZ_NO_REMOTE': '1', 02:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:00 INFO - 'NO_EM_RESTART': '1', 02:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:00 INFO - 'PWD': '/builds/slave/test', 02:21:00 INFO - 'SHELL': '/bin/bash', 02:21:00 INFO - 'SHLVL': '1', 02:21:00 INFO - 'TERM': 'linux', 02:21:00 INFO - 'TMOUT': '86400', 02:21:00 INFO - 'USER': 'cltbld', 02:21:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:00 INFO - '_': '/tools/buildbot/bin/python'} 02:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:00 INFO - Downloading/unpacking psutil>=3.1.1 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:21:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:03 INFO - Installing collected packages: psutil 02:21:03 INFO - Running setup.py install for psutil 02:21:03 INFO - building 'psutil._psutil_linux' extension 02:21:03 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 02:21:03 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 02:21:03 INFO - building 'psutil._psutil_posix' extension 02:21:03 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 02:21:03 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 02:21:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:03 INFO - Successfully installed psutil 02:21:03 INFO - Cleaning up... 02:21:03 INFO - Return code: 0 02:21:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:21:03 INFO - Using env: {'DISPLAY': ':0', 02:21:03 INFO - 'HOME': '/home/cltbld', 02:21:03 INFO - 'LANG': 'en_US.UTF-8', 02:21:03 INFO - 'LANGUAGE': 'en_US:en', 02:21:03 INFO - 'LOGNAME': 'cltbld', 02:21:03 INFO - 'MAIL': '/var/mail/cltbld', 02:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:03 INFO - 'MOZ_NO_REMOTE': '1', 02:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:03 INFO - 'NO_EM_RESTART': '1', 02:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:03 INFO - 'PWD': '/builds/slave/test', 02:21:03 INFO - 'SHELL': '/bin/bash', 02:21:03 INFO - 'SHLVL': '1', 02:21:03 INFO - 'TERM': 'linux', 02:21:03 INFO - 'TMOUT': '86400', 02:21:03 INFO - 'USER': 'cltbld', 02:21:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:03 INFO - '_': '/tools/buildbot/bin/python'} 02:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:21:06 INFO - Installing collected packages: mozsystemmonitor 02:21:06 INFO - Running setup.py install for mozsystemmonitor 02:21:06 INFO - Successfully installed mozsystemmonitor 02:21:06 INFO - Cleaning up... 02:21:06 INFO - Return code: 0 02:21:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:21:06 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')]} 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:06 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')]} 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:06 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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:06 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 02:21:06 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 02:21:06 INFO - Using env: {'DISPLAY': ':0', 02:21:06 INFO - 'HOME': '/home/cltbld', 02:21:06 INFO - 'LANG': 'en_US.UTF-8', 02:21:06 INFO - 'LANGUAGE': 'en_US:en', 02:21:06 INFO - 'LOGNAME': 'cltbld', 02:21:06 INFO - 'MAIL': '/var/mail/cltbld', 02:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:06 INFO - 'MOZ_NO_REMOTE': '1', 02:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:06 INFO - 'NO_EM_RESTART': '1', 02:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:06 INFO - 'PWD': '/builds/slave/test', 02:21:06 INFO - 'SHELL': '/bin/bash', 02:21:06 INFO - 'SHLVL': '1', 02:21:06 INFO - 'TERM': 'linux', 02:21:06 INFO - 'TMOUT': '86400', 02:21:06 INFO - 'USER': 'cltbld', 02:21:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:06 INFO - '_': '/tools/buildbot/bin/python'} 02:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:21:08 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 02:21:08 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 02:21:08 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 02:21:08 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 02:21:08 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 02:21:08 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 02:21:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:08 INFO - warning: no files found matching '*.txt' 02:21:08 INFO - no previously-included directories found matching 'build' 02:21:08 INFO - no previously-included directories found matching 'dist' 02:21:08 INFO - no previously-included directories found matching '.git*' 02:21:08 INFO - Installing collected packages: jsonschema, functools32 02:21:09 INFO - Running setup.py install for functools32 02:21:09 INFO - warning: no files found matching '*.txt' 02:21:09 INFO - no previously-included directories found matching 'build' 02:21:09 INFO - no previously-included directories found matching 'dist' 02:21:09 INFO - no previously-included directories found matching '.git*' 02:21:09 INFO - Successfully installed jsonschema functools32 02:21:09 INFO - Cleaning up... 02:21:09 INFO - Return code: 0 02:21:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:21:09 INFO - Using env: {'DISPLAY': ':0', 02:21:09 INFO - 'HOME': '/home/cltbld', 02:21:09 INFO - 'LANG': 'en_US.UTF-8', 02:21:09 INFO - 'LANGUAGE': 'en_US:en', 02:21:09 INFO - 'LOGNAME': 'cltbld', 02:21:09 INFO - 'MAIL': '/var/mail/cltbld', 02:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:09 INFO - 'MOZ_NO_REMOTE': '1', 02:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:09 INFO - 'NO_EM_RESTART': '1', 02:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:09 INFO - 'PWD': '/builds/slave/test', 02:21:09 INFO - 'SHELL': '/bin/bash', 02:21:09 INFO - 'SHLVL': '1', 02:21:09 INFO - 'TERM': 'linux', 02:21:09 INFO - 'TMOUT': '86400', 02:21:09 INFO - 'USER': 'cltbld', 02:21:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:09 INFO - '_': '/tools/buildbot/bin/python'} 02:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:21:09 INFO - Cleaning up... 02:21:09 INFO - Return code: 0 02:21:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:21:09 INFO - Using env: {'DISPLAY': ':0', 02:21:09 INFO - 'HOME': '/home/cltbld', 02:21:09 INFO - 'LANG': 'en_US.UTF-8', 02:21:09 INFO - 'LANGUAGE': 'en_US:en', 02:21:09 INFO - 'LOGNAME': 'cltbld', 02:21:09 INFO - 'MAIL': '/var/mail/cltbld', 02:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:09 INFO - 'MOZ_NO_REMOTE': '1', 02:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:09 INFO - 'NO_EM_RESTART': '1', 02:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:09 INFO - 'PWD': '/builds/slave/test', 02:21:09 INFO - 'SHELL': '/bin/bash', 02:21:09 INFO - 'SHLVL': '1', 02:21:09 INFO - 'TERM': 'linux', 02:21:09 INFO - 'TMOUT': '86400', 02:21:09 INFO - 'USER': 'cltbld', 02:21:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:09 INFO - '_': '/tools/buildbot/bin/python'} 02:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:12 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:12 INFO - Downloading docopt-0.6.1.tar.gz 02:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:12 INFO - Running setup.py install for blobuploader 02:21:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:12 INFO - Running setup.py install for requests 02:21:13 INFO - Running setup.py install for docopt 02:21:13 INFO - Successfully installed blobuploader requests docopt 02:21:13 INFO - Cleaning up... 02:21:13 INFO - Return code: 0 02:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:13 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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:13 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 02:21:13 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 02:21:13 INFO - Using env: {'DISPLAY': ':0', 02:21:13 INFO - 'HOME': '/home/cltbld', 02:21:13 INFO - 'LANG': 'en_US.UTF-8', 02:21:13 INFO - 'LANGUAGE': 'en_US:en', 02:21:13 INFO - 'LOGNAME': 'cltbld', 02:21:13 INFO - 'MAIL': '/var/mail/cltbld', 02:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:13 INFO - 'MOZ_NO_REMOTE': '1', 02:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:13 INFO - 'NO_EM_RESTART': '1', 02:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:13 INFO - 'PWD': '/builds/slave/test', 02:21:13 INFO - 'SHELL': '/bin/bash', 02:21:13 INFO - 'SHLVL': '1', 02:21:13 INFO - 'TERM': 'linux', 02:21:13 INFO - 'TMOUT': '86400', 02:21:13 INFO - 'USER': 'cltbld', 02:21:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:13 INFO - '_': '/tools/buildbot/bin/python'} 02:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:13 INFO - Running setup.py (path:/tmp/pip-UtShij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:13 INFO - Running setup.py (path:/tmp/pip-tZPVCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:13 INFO - Running setup.py (path:/tmp/pip-c5rrqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:13 INFO - Running setup.py (path:/tmp/pip-MrbSpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:13 INFO - Running setup.py (path:/tmp/pip-zvemIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:13 INFO - Running setup.py (path:/tmp/pip-u5SsXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:14 INFO - Running setup.py (path:/tmp/pip-thUTWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:14 INFO - Running setup.py (path:/tmp/pip-Y6tkMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:14 INFO - Running setup.py (path:/tmp/pip-rIXBoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:14 INFO - Running setup.py (path:/tmp/pip-ankPNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:14 INFO - Running setup.py (path:/tmp/pip-eYQMxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:14 INFO - Running setup.py (path:/tmp/pip-6F0vqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:14 INFO - Running setup.py (path:/tmp/pip-t2fWGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:14 INFO - Running setup.py (path:/tmp/pip-RgtP9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:14 INFO - Running setup.py (path:/tmp/pip-pe8Zd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:14 INFO - Running setup.py (path:/tmp/pip-oP7RgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:14 INFO - Running setup.py (path:/tmp/pip-8SdKhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:14 INFO - Running setup.py install for manifestparser 02:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:14 INFO - Running setup.py install for mozcrash 02:21:15 INFO - Running setup.py install for mozdebug 02:21:15 INFO - Running setup.py install for mozdevice 02:21:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozfile 02:21:15 INFO - Running setup.py install for mozhttpd 02:21:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozinfo 02:21:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozInstall 02:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozleak 02:21:15 INFO - Running setup.py install for mozlog 02:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for moznetwork 02:21:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:16 INFO - Running setup.py install for mozprocess 02:21:16 INFO - Running setup.py install for mozprofile 02:21:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:16 INFO - Running setup.py install for mozrunner 02:21:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:16 INFO - Running setup.py install for mozscreenshot 02:21:16 INFO - Running setup.py install for moztest 02:21:16 INFO - Running setup.py install for mozversion 02:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:16 INFO - Cleaning up... 02:21:16 INFO - Return code: 0 02:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:16 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 02:21:16 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 02:21:16 INFO - Using env: {'DISPLAY': ':0', 02:21:16 INFO - 'HOME': '/home/cltbld', 02:21:16 INFO - 'LANG': 'en_US.UTF-8', 02:21:16 INFO - 'LANGUAGE': 'en_US:en', 02:21:16 INFO - 'LOGNAME': 'cltbld', 02:21:16 INFO - 'MAIL': '/var/mail/cltbld', 02:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:16 INFO - 'MOZ_NO_REMOTE': '1', 02:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:16 INFO - 'NO_EM_RESTART': '1', 02:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:16 INFO - 'PWD': '/builds/slave/test', 02:21:16 INFO - 'SHELL': '/bin/bash', 02:21:16 INFO - 'SHLVL': '1', 02:21:16 INFO - 'TERM': 'linux', 02:21:16 INFO - 'TMOUT': '86400', 02:21:16 INFO - 'USER': 'cltbld', 02:21:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:16 INFO - '_': '/tools/buildbot/bin/python'} 02:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:16 INFO - Running setup.py (path:/tmp/pip-N4HtmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:16 INFO - Running setup.py (path:/tmp/pip-YsAwWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:17 INFO - Running setup.py (path:/tmp/pip-sAQ0v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:17 INFO - Running setup.py (path:/tmp/pip-ZhDUq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:17 INFO - Running setup.py (path:/tmp/pip-JRZaKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:17 INFO - Running setup.py (path:/tmp/pip-KI9NL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:17 INFO - Running setup.py (path:/tmp/pip-XX84NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:17 INFO - Running setup.py (path:/tmp/pip-WnDEyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:17 INFO - Running setup.py (path:/tmp/pip-rLh2mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:17 INFO - Running setup.py (path:/tmp/pip-obM4CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:17 INFO - Running setup.py (path:/tmp/pip-n1PvuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:17 INFO - Running setup.py (path:/tmp/pip-bqu6xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:17 INFO - Running setup.py (path:/tmp/pip-iEPtp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:17 INFO - Running setup.py (path:/tmp/pip-3fVYoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:17 INFO - Running setup.py (path:/tmp/pip-0VlwCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:18 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)) 02:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:18 INFO - Running setup.py (path:/tmp/pip-qYiRAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:18 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)) 02:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:18 INFO - Running setup.py (path:/tmp/pip-fvKtVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:18 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)) 02:21:18 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)) 02:21:18 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)) 02:21:18 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)) 02:21:18 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)) 02:21:18 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)) 02:21:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:18 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 02:21:18 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 02:21:18 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 02:21:18 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 02:21:18 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 02:21:18 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 02:21:20 INFO - Downloading blessings-1.6.tar.gz 02:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:20 INFO - Installing collected packages: blessings 02:21:20 INFO - Running setup.py install for blessings 02:21:20 INFO - Successfully installed blessings 02:21:20 INFO - Cleaning up... 02:21:20 INFO - Return code: 0 02:21:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:20 INFO - Reading from file tmpfile_stdout 02:21:20 INFO - Current package versions: 02:21:20 INFO - argparse == 1.2.1 02:21:20 INFO - blessings == 1.6 02:21:20 INFO - blobuploader == 1.2.4 02:21:20 INFO - docopt == 0.6.1 02:21:20 INFO - functools32 == 3.2.3-2 02:21:20 INFO - jsonschema == 2.5.1 02:21:20 INFO - manifestparser == 1.1 02:21:20 INFO - mozInstall == 1.12 02:21:20 INFO - mozcrash == 0.17 02:21:20 INFO - mozdebug == 0.1 02:21:20 INFO - mozdevice == 0.48 02:21:20 INFO - mozfile == 1.2 02:21:20 INFO - mozhttpd == 0.7 02:21:20 INFO - mozinfo == 0.9 02:21:20 INFO - mozleak == 0.1 02:21:20 INFO - mozlog == 3.3 02:21:20 INFO - moznetwork == 0.27 02:21:20 INFO - mozprocess == 0.23 02:21:20 INFO - mozprofile == 0.28 02:21:20 INFO - mozrunner == 6.12 02:21:20 INFO - mozscreenshot == 0.1 02:21:20 INFO - mozsystemmonitor == 0.3 02:21:20 INFO - moztest == 0.7 02:21:20 INFO - mozversion == 1.4 02:21:20 INFO - psutil == 3.1.1 02:21:20 INFO - requests == 1.2.3 02:21:20 INFO - wsgiref == 0.1.2 02:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:20 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')]} 02:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 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')]} 02:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:20 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 02:21:20 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 02:21:20 INFO - Using env: {'DISPLAY': ':0', 02:21:20 INFO - 'HOME': '/home/cltbld', 02:21:20 INFO - 'LANG': 'en_US.UTF-8', 02:21:20 INFO - 'LANGUAGE': 'en_US:en', 02:21:20 INFO - 'LOGNAME': 'cltbld', 02:21:20 INFO - 'MAIL': '/var/mail/cltbld', 02:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:20 INFO - 'MOZ_NO_REMOTE': '1', 02:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:20 INFO - 'NO_EM_RESTART': '1', 02:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:20 INFO - 'PWD': '/builds/slave/test', 02:21:20 INFO - 'SHELL': '/bin/bash', 02:21:20 INFO - 'SHLVL': '1', 02:21:20 INFO - 'TERM': 'linux', 02:21:20 INFO - 'TMOUT': '86400', 02:21:20 INFO - 'USER': 'cltbld', 02:21:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:20 INFO - '_': '/tools/buildbot/bin/python'} 02:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 INFO - Cleaning up... 02:21:20 INFO - Return code: 0 02:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:21:20 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')]} 02:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 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')]} 02:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 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 0x20b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2372180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, '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': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', '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 02:21:20 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 02:21:20 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 02:21:20 INFO - Using env: {'DISPLAY': ':0', 02:21:20 INFO - 'HOME': '/home/cltbld', 02:21:20 INFO - 'LANG': 'en_US.UTF-8', 02:21:20 INFO - 'LANGUAGE': 'en_US:en', 02:21:20 INFO - 'LOGNAME': 'cltbld', 02:21:20 INFO - 'MAIL': '/var/mail/cltbld', 02:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:20 INFO - 'MOZ_NO_REMOTE': '1', 02:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:20 INFO - 'NO_EM_RESTART': '1', 02:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:20 INFO - 'PWD': '/builds/slave/test', 02:21:20 INFO - 'SHELL': '/bin/bash', 02:21:20 INFO - 'SHLVL': '1', 02:21:20 INFO - 'TERM': 'linux', 02:21:20 INFO - 'TMOUT': '86400', 02:21:20 INFO - 'USER': 'cltbld', 02:21:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:20 INFO - '_': '/tools/buildbot/bin/python'} 02:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:21:20 INFO - Cleaning up... 02:21:20 INFO - Return code: 0 02:21:20 INFO - Running post-action listener: _resource_record_post_action 02:21:20 INFO - Running post-action listener: _start_resource_monitoring 02:21:20 INFO - Starting resource monitoring. 02:21:21 INFO - [mozharness: 2016-08-08 09:21:21.000922Z] Finished create-virtualenv step (success) 02:21:21 INFO - [mozharness: 2016-08-08 09:21:21.001511Z] Running install step. 02:21:21 INFO - Running pre-action listener: _resource_record_pre_action 02:21:21 INFO - Running main action method: install 02:21:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:21 INFO - Reading from file tmpfile_stdout 02:21:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:21 INFO - Reading from file tmpfile_stdout 02:21:21 INFO - Output received: 02:21:21 INFO - Usage: mozinstall [options] installer 02:21:21 INFO - Options: 02:21:21 INFO - -h, --help show this help message and exit 02:21:21 INFO - -d DEST, --destination=DEST 02:21:21 INFO - Directory to install application into. [default: 02:21:21 INFO - "/builds/slave/test"] 02:21:21 INFO - --app=APP Application being installed. [default: firefox] 02:21:21 INFO - mkdir: /builds/slave/test/build/application 02:21:21 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'] 02:21:21 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 02:21:38 INFO - Reading from file tmpfile_stdout 02:21:38 INFO - Output received: 02:21:38 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:38 INFO - Running post-action listener: _resource_record_post_action 02:21:38 INFO - [mozharness: 2016-08-08 09:21:38.368155Z] Finished install step (success) 02:21:38 INFO - [mozharness: 2016-08-08 09:21:38.368409Z] Running run-tests step. 02:21:38 INFO - Running pre-action listener: _resource_record_pre_action 02:21:38 INFO - Running main action method: run_tests 02:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:38 INFO - Python 2.7.3 02:21:38 INFO - Return code: 0 02:21:38 INFO - grabbing minidump binary from tooltool 02:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:38 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 0x23703b0>, '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 0x23712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2371740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:38 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 02:21:38 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 02:21:38 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 02:21:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:38 INFO - Return code: 0 02:21:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:38 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/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 02:21:38 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/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 02:21:38 INFO - Using env: {'DISPLAY': ':0', 02:21:38 INFO - 'HOME': '/home/cltbld', 02:21:38 INFO - 'LANG': 'en_US.UTF-8', 02:21:38 INFO - 'LANGUAGE': 'en_US:en', 02:21:38 INFO - 'LOGNAME': 'cltbld', 02:21:38 INFO - 'MAIL': '/var/mail/cltbld', 02:21:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:38 INFO - 'MOZ_NO_REMOTE': '1', 02:21:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:38 INFO - 'NO_EM_RESTART': '1', 02:21:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:38 INFO - 'PWD': '/builds/slave/test', 02:21:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:38 INFO - 'SHELL': '/bin/bash', 02:21:38 INFO - 'SHLVL': '1', 02:21:38 INFO - 'TERM': 'linux', 02:21:38 INFO - 'TMOUT': '86400', 02:21:38 INFO - 'USER': 'cltbld', 02:21:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733', 02:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:38 INFO - '_': '/tools/buildbot/bin/python'} 02:21:38 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/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 02:21:38 INFO - mozversion application_buildid: 20160807233010 02:21:38 INFO - mozversion application_changeset: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 02:21:38 INFO - mozversion application_display_name: Nightly 02:21:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:38 INFO - mozversion application_name: Firefox 02:21:38 INFO - mozversion application_remotingname: firefox 02:21:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:21:38 INFO - mozversion application_vendor: Mozilla 02:21:38 INFO - mozversion application_version: 51.0a1 02:21:38 INFO - mozversion platform_buildid: 20160807233010 02:21:38 INFO - mozversion platform_changeset: c0e4639e98b00f4fdb47fdbdbb6434557e7d9db7 02:21:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:21:38 INFO - mozversion platform_version: 51.0a1 02:21:38 INFO - using testdate: 1470648098 02:21:38 INFO - actual date: 1470648098 02:21:38 INFO - starting webserver on 'localhost:37477' 02:21:38 INFO - SUITE-START | Running 2 tests 02:21:38 INFO - TEST-START | dromaeo_css 02:21:38 INFO - operating with platform_type : linux_ 02:21:38 INFO - Initialising browser for dromaeo_css test... 02:21:38 INFO - TEST-INFO | started process 20197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppp6v4v/profile http://localhost:37477/getInfo.html) 02:21:43 INFO - PROCESS | 20197 | __metrics Screen width/height:1600/1200 02:21:43 INFO - PROCESS | 20197 | colorDepth:24 02:21:43 INFO - PROCESS | 20197 | Browser inner width/height: 1024/697 02:21:43 INFO - PROCESS | 20197 | __metrics 02:21:44 ERROR - PROCESS | 20197 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:21:44 INFO - TEST-INFO | 20197: exit 0 02:21:44 INFO - Browser initialized. 02:21:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:44 INFO - TEST-INFO | started process 20319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppp6v4v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:56 INFO - PROCESS | 20319 | RSS: Main: 164057088 02:21:56 INFO - PROCESS | 20319 | 02:22:46 INFO - PROCESS | 20319 | 1470648166370 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] 02:24:56 INFO - PROCESS | 20319 | Cycle 1(1): loaded http://localhost:37477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37477/tests/dromaeo/cssquery-ext.html) 02:24:57 INFO - PROCESS | 20319 | RSS: Main: 167034880 02:24:57 INFO - PROCESS | 20319 | 02:27:59 INFO - PROCESS | 20319 | Cycle 1(1): loaded http://localhost:37477/tests/dromaeo/cssquery-ext.html (next: http://localhost:37477/tests/dromaeo/cssquery-jquery.html) 02:28:00 INFO - PROCESS | 20319 | RSS: Main: 166518784 02:28:00 INFO - PROCESS | 20319 | 02:31:02 INFO - PROCESS | 20319 | Cycle 1(1): loaded http://localhost:37477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37477/tests/dromaeo/cssquery-mootools.html) 02:31:03 INFO - PROCESS | 20319 | RSS: Main: 169807872 02:31:03 INFO - PROCESS | 20319 | 02:34:04 INFO - PROCESS | 20319 | Cycle 1(1): loaded http://localhost:37477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37477/tests/dromaeo/cssquery-prototype.html) 02:34:05 INFO - PROCESS | 20319 | RSS: Main: 164343808 02:34:05 INFO - PROCESS | 20319 | 02:37:08 INFO - PROCESS | 20319 | Cycle 1(1): loaded http://localhost:37477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37477/tests/dromaeo/cssquery-yui.html) 02:37:08 INFO - PROCESS | 20319 | RSS: Main: 166617088 02:37:08 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | Cycle 1(1): loaded http://localhost:37477/tests/dromaeo/cssquery-yui.html (next: http://localhost:37477/tests/dromaeo/cssquery-dojo.html) 02:40:11 INFO - PROCESS | 20319 | RSS: Main: 169824256 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | __start_tp_report 02:40:11 INFO - PROCESS | 20319 | _x_x_mozilla_page_load 02:40:11 INFO - PROCESS | 20319 | _x_x_mozilla_page_load_details 02:40:11 INFO - PROCESS | 20319 | |i|pagename|runs| 02:40:11 INFO - PROCESS | 20319 | |0;dojo.html;3107.7669174811867;3111.704388083132;3153.795003324784;3159.225989632539;3180.411623849588;5322.361316641999;5390.434004429532;5427.402985671578;5439.4288599697;5486.753096110675;5363;5366.275552800371;5392.541633961108;5418.458154184579;5433.755481003354;4892.877678058041;4925.088858561177;4991.001799640068;5012.423571289294;5024.145895197825;4898.485659005789;4979.925301120486;4991.700497970115;5103.719295438749;5127.666701664399;4785.066911952171;4980.900381992376;4997.350344455234;5038.143515602356;5057.443681195084;4823.493533179036;4830.903381932341;4849.806007759686;4854.320395144682;4866.46468888422;4759.904801903943;4778.713277203379;4813.4945830687975;4881.974785295092;4887.364642596475;5172.974135129338;5341.572674186094;5344.305240318734;5398.13629819227;5404.270423492818;5667.716614169275;5805;5807.651540907559;5812.099124635688;5876.853078673067;5830.4461076197695;5841.890040892259;5883.382244864313;5884;5891.410858914117;5295.205719142121;5370.194470829407;5394.649347792381;5449.209864569615;5451.400345961941;5906.40935906406;5915.112733090071;5966.075258334965;6005.279366475964;6011.338752737195;5701.885962280731;5738.8278351649515;5741.339745929188;5744.396838331999;5758.280214973129;5568.443155684399;5715.8571035724435;5726.513246374022;5821.446962538552;5831.679257640871;5587.525060369833;5657.20799088128;5797.826065218051;5801.042827933344;5836.153757705109;5650.85872853182;5704.543636509069;5710.200571919934;5735.168400581976;5739.282589676291;4383.123375324948;4386.0569977455;4388.034632380871;4469.41897553316;4480.977595112069;3985.960140398559;3989.082511022481;4013.257547353749;4014.8394064237687;4060.7766572838777;5402.135658294654;5446.2375267462585;5546.168074788814;5549.556035517149;5570.470805273492;5904.704764761831;5919.082542205965;5926.762929482772;5939.2575928009;5946.345901950782;5620.5503559715125;5622.409646987089;5624.718764061862;5628.746706398222;5630.465105814941;4860.927086093711;5006.274090256892;5051.898962020739;5054.671446355975;5060.898782024413;6139.584134579375;6145.016797312587;6146.661933593696;6147.2623285206955;6148.508119350441;5918.171455996078;5941.940580594139;5942.970285148546;5949.077892926603;5949.434803693643;5827.096799996008;5981.0729336952845;6101.664408457577;6119.694015299128;6127.417895299939;5827.417258274309;5836.912446313394;5838.211841401527;5847.94152058474;5878.588498805043;5879.853003674943;5930.34766175729;5946.256717910262;5948;5973.970130149321;5635.802746903839;5711.771529138788;5721.828345149652;5743.10981797822;5755.942440575541;5687.0616348302065;5710.086386178192;5729.054705973635;5740.052891272893;5794.536437084938;5634.014047541746;5645.830625081254;5672.744726487235;5684.488396044376;5700.743466543932;5555.805546805843;5662.943370566241;5715.514181294637;5777.277840269966;5812.82561523155;5685.886282274414;5710.314762228559;5714.685692286964;5722.284714410699;5737.713114344349 02:40:11 INFO - PROCESS | 20319 | |1;ext.html;567.7161419290355;581.6887964938759;581.883623275345;584.2959234122883;589.0163427076782;34326.2836858157;37227;37418;37450.62549374506;37605.81197094014;43143.35284970728;44173;44175.11649767011;44385.77807110968;44407;8499.277561407287;8559.786005349853;8576.142385761405;8630.136986301382;8635.654573817039;8786.121387861227;8823.95588022059;8831.072737362581;8833.33749968755;8840.823183536326;8783.912160878404;8817.603207855662;8825.205731484166;8831.77920551985;8868.911310886906;8784.121587841197;8816.074312197223;8838.5580720964;8841.557922103933;8852.247558957497;8571.528565928871;8657.82684346316;8660.523671198082;8680.956595216983;8686.044535101197;41897.37153942693;42196;42290;42589.36115958263;42642.14715705699;3462.9480557791653;3513.5959364673135;4071.2061148076136;4226.197022565702;4229.661627069827;33102.834485827414;33176.50235246473;33761.15597110067;33779;34893.12767180816;4150.169966006811;4181.937270940938;4283.079137985348;4299.484061912559;4324.351347297899;321645;322017;322018.9999999977;322982;323390;57483.42516574781;57945.13082303769;58078.128828067616;58198.41801582015;58263.70868145632;36679.08302292464;37592.43611345832;37594;39075.21849562993;60607;14282.285885705673;14373.137611743328;14377.928110359591;14398.784018239734;14403.85596144046;12010.699732506582;12088.879111208775;12091.697707557381;12097.939510302569;12163.2702037878;18946.24215031411;19034.33379831699;19120.61758764845;19222;19323.806761932483;7022.859542809115;7083.112652269917;7118.893216601755;7279.162896266997;7291.781246562611;926.9490178040272;937.554661535765;955.4888134847823;1027.992567284066;1074.5594306334365;32510.67489325124;32942.67057329444;33209.66790332114;33386.833065834515;33723.49414758781;1121.198343184627;1138.9715257118473;1164.6738913104343;1168.5734706831945;1241.6709571963436;17125.828741712674;17264;17320.91339543294;17487.38794142199;17490;530940;532635;535015;538012;538041;59180;59701;59943;60048;60126;1299.2074834351038;1353.519500577281;1365.4060483689627;1365.5015919189623;1381.5648070857649;30565.694343057174;32793.18017049593;32813.50779738258;32869;33121.66878331282;56541;57758.7112064437;57910.13134802897;62155.378446214956;62345.37654623396;485317;494085;494130;495083;495616;44001.55998439975;44659.77670111629;44902.3264651037;45114.77442612766;45355;48593.75703121603;49482.505174947786;50078.74960625319;50123;50139;41941.37087943744;42755.57244427516;43445.565544345416;44524.55475445204;44856.775716121214;42340.576594233666;42421.575784242996;42589.5741042598;43006.569934300256;43923.56076439195;34662.13344666403;35129;35232.29535409226;37789.81105094457;42795.57204427916;35123.297534049685;37468.62531374651;38254.808725956194;38683.613163868;39189;27016;27560.724392755816;27578.310542236606;29860.701392985793;30611.54082688806 02:40:11 INFO - PROCESS | 20319 | |2;jquery.html;398.8603988603989;399.18566125104786;402.1976157565657;402.2598418909207;421.66753060329364;13993.580192594212;17353.30586776529;18797.214264644856;18858.434246972596;19631.607367852634;14884.702305953875;15021.774673379909;15141.09153450791;17949.910250448764;18089.90955045223;5752.568557358204;5811.418858114176;5853.385394533555;5932.288125424955;5960.374160713128;5807.245058142456;5852.180694702745;5854.268216472941;5856.297244330686;5857.941420585782;5611.7474713637785;5828.766849326022;5832.212651292085;5911.793087241947;5968.910466343008;5811.099279611667;5861.970690146543;5876.794312199074;5898.469137777621;5898.734556944926;5087.720175390352;5816.243888294494;5918.733656985446;5964.433378829004;5982.371850955674;12577.371131443482;13240.73518529624;13284.335783210898;13341.599752007456;16370.83629163705;2308.2959697292317;2341;2349.9072931087126;2815.0991682661556;2891.898783542566;10449.477526123663;10495.895041049567;10656.254062215648;12207.877921220763;14045.297735113203;1744.9476515704548;1811.8912865228128;1821.3079029968528;1885.6611805618027;1962.8625996180274;78544;79198.60400698017;82238.58880705558;82553.58723206406;83396;10714.303570267908;11103.001459737325;11250.606228781953;11272.66182014541;11439.885601143882;15680.843191568167;15805.52583422499;15897.205139742966;15957.840421595867;15981.520554383387;7773.63961306769;7986.800329991681;8039.115697273295;8112.472689275178;8217.301529369952;7335.669894854745;7407.481476296607;7485.5508669480005;7625.733099341496;7720.613969301512;4420.557944205554;4592.724436533818;4625;4868.659193856467;4896.534829191292;2014.6776515757408;2071.4717746974425;2088.791120887899;2090.5400811821373;2097.7101826764306;917.2845180759018;953.6662168241198;957.8228027814737;958.3291695812959;981.65642025292;18815.435536933914;20301.695474567892;20473.590528189354;20491.59016819655;20537.691934620994;916.0793402630314;954.2461455450256;988.357567581078;994.6274141684429;1017.6082208349691;10329.328593641389;11164.944175279072;11225.101991840633;11393.601223957288;11435.771284574428;501946;505760;507304;509400;513875;58167.709161453924;60261.39738602558;94664;94915.52542237245;99288.5035574832;968.9176420004237;991.8859331177007;1019.607451131305;1030.2891005206384;1037.5331101004426;16900.746488802924;17649.146839582172;18026.729599056285;18081.36715214961;18138.365157219436;29367.265818354714;33420.66579334175;35066.298674025864;38961.025974350865;41890.79054604707;57466;61799;62335;62695.37304626896;63850.3614963863;7870;7881.487703299267;8036.276735093869;8076.353891688534;8454.492730436194;9155.587998540215;12524.812127817908;12926.289054102115;13213.273269970245;13588.116772409761;11581.305121692725;11951.820722688994;11991.940040300091;12024.639260822189;12111.152219344562;11245.662630121109;11399.715007124889;11461.312321260752;11671.299722016705;11711.648650540497;11725.179237453296;11787.823182652095;11935.104867134825;11975.820362694392;11983.460744266355;7633.923660763321;7930.524168549675;8109.351251899716;8304.543250121302;8674.52290124024;11554.826677600011;11575.826362604736;11691.590794322157;11845.289282643069;12016.399180041139 02:40:11 INFO - PROCESS | 20319 | |3;mootools.html;1327.5619045714916;1424.772036474164;1483.9554813355596;1777.173614269366;1795.1831916478004;7858.371330293563;8714.782130446727;8796.16436438539;9506.287028472858;9516.80966380672;8862.291016718664;9150.588223529941;9191.494467804268;9218.492982885939;9219.861702074457;2400.7239167495786;2421.491486787768;2435.3546310227803;2436.7319594844553;2446.8898899549563;2412.553677569655;2432.3675844280524;2475.789557887582;2482.2429159106464;2495.4759500504824;2409.361519197414;2424.502976889742;2429.392651837041;2430.307362401716;2453.239495756321;2387.3076807725824;2394.1979436888664;2397.7961873240797;2405.927822165338;2409.674693916334;2330.0330362899545;2353.1880452051996;2357.2574638988663;2361.197192954404;2369.822263330257;9563.09150630689;9630.085141911577;9635.98822123681;9668.081532254424;9670.903290967071;5332.600054995852;5462.617616766828;5528.364238112628;5644.689542075184;5649.604527683064;3433.073070271038;3492.9301413971834;3497.1956450016637;3504.088936876405;3522.947155792665;1120.7254222715405;1173.6561636925671;1180.9350485723282;1183.9408029598571;1187.6674531131298;13362.933185334108;13468.865311346957;13525.661858453519;13546.390412431465;13559.186448813201;4770.737609431445;4793.616510679138;4838.395200599925;4842.903141937141;5035.269885866529;11109.388983605979;11147.386893720923;11188.328700278009;11235.382053986945;11272.66182014541;5502.064649009678;5517.889642207133;5555.194496797942;5564.054110801174;5564.360098588714;4463.799129039201;4848.369711937426;4986.950130498649;5024.723640199824;5060.785411501287;4195.769232692171;4204.642605378577;4218.325067989168;4247.171801498678;4263.829446822155;1307.6861553227156;1321.3525372567374;1333.8266025416633;1333.9599812005656;1351.6891115043595;931.334096121263;1005.6379703306803;1014.5890914179769;1030.3096925060227;1033.379972016784;6206;6214;6389.616623002542;6415.935840641627;6546.672666366662;465.0745017415319;468.6461721400389;476.24277398935857;481.4631685670452;482.8430760003013;4205;4266.445362102969;4267.829286828554;4359.324304732771;4379.824807007684;11311.717207069889;11582.768344633228;11767.588134415255;11785.410729463492;11805.763884722257;10340.482975851177;10877.891221087688;11587.710307242387;11590.898864607849;11614.593489227836;8583.828323433496;8717.389782715276;8738.21356077956;8763.167499087576;8818.162274583905;6416.550841441241;6544.312847150981;6570.408663220333;6584.769533066511;6654.933450665431;10011.899881001096;10852.294600850919;10914.454277285946;10927.562897484011;10969.067629251604;10588.205884558534;10729.9463502682;10843.295185812896;10906.61826836057;10921.180911431515;7180.820479488055;7655.540667559964;7738.7678369649;7948.324392426708;8107.391945603986;8416.368772341977;8491.23578877904;8526.190011948855;8530.914690853013;8551.486910785372;7748.8450230996195;7936.523808571505;7964.123946365779;8025.197480252162;8204.876926845982;7651.655675494728;7865.921340786519;7938.04743430792;7984.161663025298;8069.83860322802;7129.144502659714;7141.892871606826;7161.856762864818;7210.603416812126;7235.095613048369;5397;5428.945710542844;5432.9185062223305;5505.091659876076;5597.972010139923;5314.62797604164;5364.088105022078;5371.892562148813;5431.864203394946;5521.3926468089285 02:40:11 INFO - PROCESS | 20319 | |4;prototype.html;341.0501752618957;347.0438940718321;348.26017896429596;350.54254198271263;353.8407716527563;5502.174673798932;5539.501444869961;5551.2505811715455;5564.165375193723;5581.8604534886545;5442.83671489855;5448;5486.259354987075;5488.423715509874;5490.945090549093;3830;4064.5122585289732;4276.2089013532595;4281.850135245267;4290.97854510727;4290.249206388885;4334.331282456245;4353.10761293934;4365.279728844736;4373.518912919576;4338.2191205582985;4341.826326946918;4350.608445239928;4351.760653164075;4354.433923589929;3999.8600048998437;4172.77049762263;4201.684873634459;4322.654187664979;4338.2191205582985;3636.072801435643;3651.1602331463914;3654.506641603376;3654.835532401048;3660.7803531788177;5279.868003299948;5303;5350.117230656976;5355.30381050461;5394.433584473613;4636.446790325245;4824.517548245182;4825.613950883921;4863.756812159378;4868.488808675073;5713.971430142864;5748.827535173951;5756.21557317233;5760.9711951440395;5799;4127.5666055064385;4136.875893723193;4145;4147.900806286337;4162.958370416318;5777.62445441045;5891.3814049525035;5946.762129514815;5982.670953097578;6058.878822423527;4127.33962565994;4136.552206727682;4154.273002224599;4177.979110104491;4200.327947528381;4227.175700738327;4257.382679511454;4266.743995360288;4269.996550810557;4298.398224248608;4721.811127554859;4848.7090774553635;4849.393825771778;4905.607551395879;4924.901501969941;5701.543876489954;5734.741936612862;5748.19525266463;5758.827235182951;5769.826905192767;1461.8391976882535;1476.2987580899203;1479.7706355514913;1482.7479328513962;1487.6280929767559;883.5663264103301;928.726025822384;929.1869614087673;934.1545900959643;942.4533770413144;4886.096072226649;4891.5353041461;4950.529699678525;4953.8018479261145;4995.400551933719;5164.63588267913;5166.43169251382;5191.299174611455;5209.921851172236;5281.389176301265;4701.341812146302;4933.950660493421;4975.5522003019905;4979.278004689299;5042.243663450512;2736.2885649731215;2758.600002999554;2767.529519981608;2773.1281385065;2792.143224755515;5376.548331950352;5378.435264297271;5386.629882851533;5390.865228369244;5399.919001214985;5314.113489711097;5315.282436870973;5645.407232240637;5914.5805006798055;6083.8174854754425;6108.5418593605655;6196.955004848389;6198.72105755233;6201.379862013762;6226.719797609027;5948.315943666361;5956.553258505716;5985.371535988658;6011.188489554029;6029.306629737461;5769.509591684754;5800.56495762811;5834.795782147605;5861.531077513874;5893.5874488785375;6214.223222097238;6221.222347206599;6231.594946328655;6267.62394256346;6289.591176573508;4030.1133750574827;4159.708820382665;4161.334186530141;4200.894977625584;4201.432806571073;5876.265466816648;5929.9110513341475;5935.465808077293;5954.523638109027;5959.046552551571;5718.885622287614;5772.393898640582;5780.508656764054;5796.565257605612;5799.594028417971;5643.887122257614;5727.052802047324;5758.712064396847;5783.19035335045;5788.189653448605;5657.43425657431;5670.659760414388;5686.374498805211;5696.629719068247;5749.367569567261;5583.664980101207;5853.736581853912;5860.326062502867;5880.235569376125;5912.940870591411;5650.63270887391;5706.657600543981;5730.598858079894;5737.540996720336;5743.46776732315 02:40:11 INFO - PROCESS | 20319 | |5;yui.html;761.535463367346;774.9077490774905;818.0837462042514;855.8758979947908;881.506356440393;15326.310316035777;16700.079490858556;16807.495775126736;16958.321667133314;17008.234629441675;14449.494267700633;14463.783043254334;14487.058341207814;14506.202158881284;14601.561953141423;654.1888058807069;782.1201148707704;784.4548039112819;811.9309858661991;814.2752949874616;811.6388207247777;818.1981657975188;820.5938060659981;820.9671613135497;823.4400607586839;866.384866744612;868.3096937934357;872.7381785464368;873.5937788928147;876.1720174435161;857.6355049104168;861.5993562993239;865.5845194306705;871.2855458523982;872.2324354567971;634.784173381048;635.1013316157631;635.580516858871;635.7234602947733;635.7933671556763;13761.31193440334;13826.723465530733;13829;13829.51596694121;13857.930710346485;15586.142762148078;15641.452549160838;15747;15924;16009.199540022952;12545.498180072786;12612.117151799377;12749.42627581761;12794.488220471263;12835.93582032084;3993.920121597581;4038.1519880824767;4079.122988557445;4104;4159.292920203573;89145;92927;93176.53411732966;93301;94065.99999999932;11715.824262636068;12233.57182498626;12312.199707019015;12536.874631253753;12671.619851404472;23761.40596485067;24154.396140096287;24174.51650966971;24190.153344632854;24223.394415139763;8865.379423440298;8942.73171804847;8956.552172391355;8968;9098;4767.68918791616;4801.279808028754;4922.4339200992345;4946.752662366939;4996.4254110777;3322.318924620447;3385.4921761735445;3392.3045775615938;3392.6607339265875;3407.8466469008954;615.7906311853901;620.5439002333281;623.0560700538688;625.4621025917708;637.7480895046524;616.4509752174789;752.5484709174451;766;793.5437123653923;802.7070119406492;9313.487758173365;10114.54484548197;10288.102791245205;10378.740531486774;10427.843582346271;720.902678138455;723.8733221686184;727.5125665803924;743.1565173528085;778.8792737125755;4925.630577706686;4978.402591688948;5041.79832806691;5042.697438153649;5064;124503;124980;126238.3688081572;129721.35139324242;130533;108699;109724;110885;111651;113490;95473.09053818884;97088.51455742677;98734.5063274679;98799;98882.5055874716;9754.85367719499;9804.55879485439;9947.303688741718;9964.302498825013;10011.649592264235;52713.20930186127;52911.73544132409;53185.20222196593;54987.175192371345;55121.44878551163;81455.59272203602;83179;83929.58035209785;84329.73505397547;86844.56577717324;11711.180217385043;11712.765744685228;11787.469563869476;11825.172237943605;12073.27560346382;14110.576682699535;14119.364628591533;14223.07550009246;14288.857111428753;14321.570352889014;12865.228086314477;13128.474861005452;13985.090969086978;14025.018248722492;14142.292885355897;13216.405261763435;13469.663258418226;13782.586522404345;13826.861731382558;13904.304784760923;12983.091183617056;13005.154664946747;13116.672083197614;13838.861611383758;14029.438822446988;10836.458177091272;10895.618653347095;11105.833412498658;11148.888511114785;11738;10279.023492768176;10293.176545876462;10548.472576370998;11200.719982000515;11545.365004924473 02:40:11 INFO - PROCESS | 20319 | __end_tp_report 02:40:11 INFO - PROCESS | 20319 | __start_cc_report 02:40:11 INFO - PROCESS | 20319 | _x_x_mozilla_cycle_collect,339 02:40:11 INFO - PROCESS | 20319 | __end_cc_report 02:40:11 INFO - PROCESS | 20319 | __startTimestamp1470649211929__endTimestamp 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | ------- Summary: start ------- 02:40:11 INFO - PROCESS | 20319 | Number of tests: 6 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | [#0] dojo.html Cycles:165 Average:5417.21 Median:5657.21 stddev:630.67 (11.1%) stddev-sans-first:606.03 02:40:11 INFO - PROCESS | 20319 | Values: 3107.8 3111.7 3153.8 3159.2 3180.4 5322.4 5390.4 5427.4 5439.4 5486.8 5363.0 5366.3 5392.5 5418.5 5433.8 4892.9 4925.1 4991.0 5012.4 5024.1 4898.5 4979.9 4991.7 5103.7 5127.7 4785.1 4980.9 4997.4 5038.1 5057.4 4823.5 4830.9 4849.8 4854.3 4866.5 4759.9 4778.7 4813.5 4882.0 4887.4 5173.0 5341.6 5344.3 5398.1 5404.3 5667.7 5805.0 5807.7 5812.1 5876.9 5830.4 5841.9 5883.4 5884.0 5891.4 5295.2 5370.2 5394.6 5449.2 5451.4 5906.4 5915.1 5966.1 6005.3 6011.3 5701.9 5738.8 5741.3 5744.4 5758.3 5568.4 5715.9 5726.5 5821.4 5831.7 5587.5 5657.2 5797.8 5801.0 5836.2 5650.9 5704.5 5710.2 5735.2 5739.3 4383.1 4386.1 4388.0 4469.4 4481.0 3986.0 3989.1 4013.3 4014.8 4060.8 5402.1 5446.2 5546.2 5549.6 5570.5 5904.7 5919.1 5926.8 5939.3 5946.3 5620.6 5622.4 5624.7 5628.7 5630.5 4860.9 5006.3 5051.9 5054.7 5060.9 6139.6 6145.0 6146.7 6147.3 6148.5 5918.2 5941.9 5943.0 5949.1 5949.4 5827.1 5981.1 6101.7 6119.7 6127.4 5827.4 5836.9 5838.2 5847.9 5878.6 5879.9 5930.3 5946.3 5948.0 5974.0 5635.8 5711.8 5721.8 5743.1 5755.9 5687.1 5710.1 5729.1 5740.1 5794.5 5634.0 5645.8 5672.7 5684.5 5700.7 5555.8 5662.9 5715.5 5777.3 5812.8 5685.9 5710.3 5714.7 5722.3 5737.7 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | [#1] ext.html Cycles:180 Average:61178.12 Median:42698.86 stddev:121940.41 (285.6%) stddev-sans-first:122197.57 02:40:11 INFO - PROCESS | 20319 | Values: 567.7 581.7 581.9 584.3 589.0 34326.3 37227.0 37418.0 37450.6 37605.8 43143.4 44173.0 44175.1 44385.8 44407.0 8499.3 8559.8 8576.1 8630.1 8635.7 8786.1 8824.0 8831.1 8833.3 8840.8 8783.9 8817.6 8825.2 8831.8 8868.9 8784.1 8816.1 8838.6 8841.6 8852.2 8571.5 8657.8 8660.5 8681.0 8686.0 41897.4 42196.0 42290.0 42589.4 42642.1 3462.9 3513.6 4071.2 4226.2 4229.7 33102.8 33176.5 33761.2 33779.0 34893.1 4150.2 4181.9 4283.1 4299.5 4324.4 321645.0 322017.0 322019.0 322982.0 323390.0 57483.4 57945.1 58078.1 58198.4 58263.7 36679.1 37592.4 37594.0 39075.2 60607.0 14282.3 14373.1 14377.9 14398.8 14403.9 12010.7 12088.9 12091.7 12097.9 12163.3 18946.2 19034.3 19120.6 19222.0 19323.8 7022.9 7083.1 7118.9 7279.2 7291.8 926.9 937.6 955.5 1028.0 1074.6 32510.7 32942.7 33209.7 33386.8 33723.5 1121.2 1139.0 1164.7 1168.6 1241.7 17125.8 17264.0 17320.9 17487.4 17490.0 530940.0 532635.0 535015.0 538012.0 538041.0 59180.0 59701.0 59943.0 60048.0 60126.0 1299.2 1353.5 1365.4 1365.5 1381.6 30565.7 32793.2 32813.5 32869.0 33121.7 56541.0 57758.7 57910.1 62155.4 62345.4 485317.0 494085.0 494130.0 495083.0 495616.0 44001.6 44659.8 44902.3 45114.8 45355.0 48593.8 49482.5 50078.7 50123.0 50139.0 41941.4 42755.6 43445.6 44524.6 44856.8 42340.6 42421.6 42589.6 43006.6 43923.6 34662.1 35129.0 35232.3 37789.8 42795.6 35123.3 37468.6 38254.8 38683.6 39189.0 27016.0 27560.7 27578.3 29860.7 30611.5 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | [#2] jquery.html Cycles:180 Average:28824.28 Median:37013.66 stddev:83529.67 (225.7%) stddev-sans-first:83736.72 02:40:11 INFO - PROCESS | 20319 | Values: 398.9 399.2 402.2 402.3 421.7 13993.6 17353.3 18797.2 18858.4 19631.6 14884.7 15021.8 15141.1 17949.9 18089.9 5752.6 5811.4 5853.4 5932.3 5960.4 5807.2 5852.2 5854.3 5856.3 5857.9 5611.7 5828.8 5832.2 5911.8 5968.9 5811.1 5862.0 5876.8 5898.5 5898.7 5087.7 5816.2 5918.7 5964.4 5982.4 12577.4 13240.7 13284.3 13341.6 16370.8 2308.3 2341.0 2349.9 2815.1 2891.9 10449.5 10495.9 10656.3 12207.9 14045.3 1744.9 1811.9 1821.3 1885.7 1962.9 78544.0 79198.6 82238.6 82553.6 83396.0 10714.3 11103.0 11250.6 11272.7 11439.9 15680.8 15805.5 15897.2 15957.8 15981.5 7773.6 7986.8 8039.1 8112.5 8217.3 7335.7 7407.5 7485.6 7625.7 7720.6 4420.6 4592.7 4625.0 4868.7 4896.5 2014.7 2071.5 2088.8 2090.5 2097.7 917.3 953.7 957.8 958.3 981.7 18815.4 20301.7 20473.6 20491.6 20537.7 916.1 954.2 988.4 994.6 1017.6 10329.3 11164.9 11225.1 11393.6 11435.8 501946.0 505760.0 507304.0 509400.0 513875.0 58167.7 60261.4 94664.0 94915.5 99288.5 968.9 991.9 1019.6 1030.3 1037.5 16900.7 17649.1 18026.7 18081.4 18138.4 29367.3 33420.7 35066.3 38961.0 41890.8 57466.0 61799.0 62335.0 62695.4 63850.4 7870.0 7881.5 8036.3 8076.4 8454.5 9155.6 12524.8 12926.3 13213.3 13588.1 11581.3 11951.8 11991.9 12024.6 12111.2 11245.7 11399.7 11461.3 11671.3 11711.6 11725.2 11787.8 11935.1 11975.8 11983.5 7633.9 7930.5 8109.4 8304.5 8674.5 11554.8 11575.8 11691.6 11845.3 12016.4 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | [#3] mootools.html Cycles:180 Average:6081.03 Median:466.86 stddev:3530.98 (756.3%) stddev-sans-first:3522.82 02:40:11 INFO - PROCESS | 20319 | Values: 1327.6 1424.8 1484.0 1777.2 1795.2 7858.4 8714.8 8796.2 9506.3 9516.8 8862.3 9150.6 9191.5 9218.5 9219.9 2400.7 2421.5 2435.4 2436.7 2446.9 2412.6 2432.4 2475.8 2482.2 2495.5 2409.4 2424.5 2429.4 2430.3 2453.2 2387.3 2394.2 2397.8 2405.9 2409.7 2330.0 2353.2 2357.3 2361.2 2369.8 9563.1 9630.1 9636.0 9668.1 9670.9 5332.6 5462.6 5528.4 5644.7 5649.6 3433.1 3492.9 3497.2 3504.1 3522.9 1120.7 1173.7 1180.9 1183.9 1187.7 13362.9 13468.9 13525.7 13546.4 13559.2 4770.7 4793.6 4838.4 4842.9 5035.3 11109.4 11147.4 11188.3 11235.4 11272.7 5502.1 5517.9 5555.2 5564.1 5564.4 4463.8 4848.4 4987.0 5024.7 5060.8 4195.8 4204.6 4218.3 4247.2 4263.8 1307.7 1321.4 1333.8 1334.0 1351.7 931.3 1005.6 1014.6 1030.3 1033.4 6206.0 6214.0 6389.6 6415.9 6546.7 465.1 468.6 476.2 481.5 482.8 4205.0 4266.4 4267.8 4359.3 4379.8 11311.7 11582.8 11767.6 11785.4 11805.8 10340.5 10877.9 11587.7 11590.9 11614.6 8583.8 8717.4 8738.2 8763.2 8818.2 6416.6 6544.3 6570.4 6584.8 6654.9 10011.9 10852.3 10914.5 10927.6 10969.1 10588.2 10729.9 10843.3 10906.6 10921.2 7180.8 7655.5 7738.8 7948.3 8107.4 8416.4 8491.2 8526.2 8530.9 8551.5 7748.8 7936.5 7964.1 8025.2 8204.9 7651.7 7865.9 7938.0 7984.2 8069.8 7129.1 7141.9 7161.9 7210.6 7235.1 5397.0 5428.9 5432.9 5505.1 5598.0 5314.6 5364.1 5371.9 5431.9 5521.4 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | [#4] prototype.html Cycles:180 Average:4760.95 Median:5365.93 stddev:1419.73 (26.5%) stddev-sans-first:1384.41 02:40:11 INFO - PROCESS | 20319 | Values: 341.1 347.0 348.3 350.5 353.8 5502.2 5539.5 5551.3 5564.2 5581.9 5442.8 5448.0 5486.3 5488.4 5490.9 3830.0 4064.5 4276.2 4281.9 4291.0 4290.2 4334.3 4353.1 4365.3 4373.5 4338.2 4341.8 4350.6 4351.8 4354.4 3999.9 4172.8 4201.7 4322.7 4338.2 3636.1 3651.2 3654.5 3654.8 3660.8 5279.9 5303.0 5350.1 5355.3 5394.4 4636.4 4824.5 4825.6 4863.8 4868.5 5714.0 5748.8 5756.2 5761.0 5799.0 4127.6 4136.9 4145.0 4147.9 4163.0 5777.6 5891.4 5946.8 5982.7 6058.9 4127.3 4136.6 4154.3 4178.0 4200.3 4227.2 4257.4 4266.7 4270.0 4298.4 4721.8 4848.7 4849.4 4905.6 4924.9 5701.5 5734.7 5748.2 5758.8 5769.8 1461.8 1476.3 1479.8 1482.7 1487.6 883.6 928.7 929.2 934.2 942.5 4886.1 4891.5 4950.5 4953.8 4995.4 5164.6 5166.4 5191.3 5209.9 5281.4 4701.3 4934.0 4975.6 4979.3 5042.2 2736.3 2758.6 2767.5 2773.1 2792.1 5376.5 5378.4 5386.6 5390.9 5399.9 5314.1 5315.3 5645.4 5914.6 6083.8 6108.5 6197.0 6198.7 6201.4 6226.7 5948.3 5956.6 5985.4 6011.2 6029.3 5769.5 5800.6 5834.8 5861.5 5893.6 6214.2 6221.2 6231.6 6267.6 6289.6 4030.1 4159.7 4161.3 4200.9 4201.4 5876.3 5929.9 5935.5 5954.5 5959.0 5718.9 5772.4 5780.5 5796.6 5799.6 5643.9 5727.1 5758.7 5783.2 5788.2 5657.4 5670.7 5686.4 5696.6 5749.4 5583.7 5853.7 5860.3 5880.2 5912.9 5650.6 5706.7 5730.6 5737.5 5743.5 02:40:11 INFO - PROCESS | 20319 | 02:40:11 INFO - PROCESS | 20319 | [#5] yui.html Cycles:180 Average:22714.63 Median:4016.04 stddev:33964.65 (845.7%) stddev-sans-first:34019.93 02:40:11 INFO - PROCESS | 20319 | Values: 761.5 774.9 818.1 855.9 881.5 15326.3 16700.1 16807.5 16958.3 17008.2 14449.5 14463.8 14487.1 14506.2 14601.6 654.2 782.1 784.5 811.9 814.3 811.6 818.2 820.6 821.0 823.4 866.4 868.3 872.7 873.6 876.2 857.6 861.6 865.6 871.3 872.2 634.8 635.1 635.6 635.7 635.8 13761.3 13826.7 13829.0 13829.5 13857.9 15586.1 15641.5 15747.0 15924.0 16009.2 12545.5 12612.1 12749.4 12794.5 12835.9 3993.9 4038.2 4079.1 4104.0 4159.3 89145.0 92927.0 93176.5 93301.0 94066.0 11715.8 12233.6 12312.2 12536.9 12671.6 23761.4 24154.4 24174.5 24190.2 24223.4 8865.4 8942.7 8956.6 8968.0 9098.0 4767.7 4801.3 4922.4 4946.8 4996.4 3322.3 3385.5 3392.3 3392.7 3407.8 615.8 620.5 623.1 625.5 637.7 616.5 752.5 766.0 793.5 802.7 9313.5 10114.5 10288.1 10378.7 10427.8 720.9 723.9 727.5 743.2 778.9 4925.6 4978.4 5041.8 5042.7 5064.0 124503.0 124980.0 126238.4 129721.4 130533.0 108699.0 109724.0 110885.0 111651.0 113490.0 95473.1 97088.5 98734.5 98799.0 98882.5 9754.9 9804.6 9947.3 9964.3 10011.6 52713.2 52911.7 53185.2 54987.2 55121.4 81455.6 83179.0 83929.6 84329.7 86844.6 11711.2 11712.8 11787.5 11825.2 12073.3 14110.6 14119.4 14223.1 14288.9 14321.6 12865.2 13128.5 13985.1 14025.0 14142.3 13216.4 13469.7 13782.6 13826.9 13904.3 12983.1 13005.2 13116.7 13838.9 14029.4 10836.5 10895.6 11105.8 11148.9 11738.0 10279.0 10293.2 10548.5 11200.7 11545.4 02:40:11 INFO - PROCESS | 20319 | -------- Summary: end -------- 02:40:11 INFO - PROCESS | 20319 | 02:40:12 INFO - TEST-INFO | 20319: exit 0 02:40:12 INFO - TEST-OK | dromaeo_css | took 1114072ms 02:40:12 INFO - TEST-START | kraken 02:40:12 INFO - operating with platform_type : linux_ 02:40:12 INFO - Initialising browser for kraken test... 02:40:12 INFO - TEST-INFO | started process 20573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9c2_d/profile http://localhost:37477/getInfo.html) 02:40:17 INFO - PROCESS | 20573 | __metrics Screen width/height:1600/1200 02:40:17 INFO - PROCESS | 20573 | colorDepth:24 02:40:17 INFO - PROCESS | 20573 | Browser inner width/height: 1024/697 02:40:17 INFO - PROCESS | 20573 | __metrics 02:40:18 ERROR - PROCESS | 20573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:40:18 INFO - TEST-INFO | 20573: exit 0 02:40:18 INFO - Browser initialized. 02:40:18 INFO - Running cycle 1/1 for kraken test... 02:40:18 INFO - TEST-INFO | started process 20693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9c2_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:30 INFO - PROCESS | 20693 | RSS: Main: 164347904 02:40:30 INFO - PROCESS | 20693 | 02:40:33 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37477/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:34 INFO - PROCESS | 20693 | RSS: Main: 168955904 02:40:34 INFO - PROCESS | 20693 | 02:40:36 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37477/tests/kraken/driver.html?testName=audio-dft) 02:40:37 INFO - PROCESS | 20693 | RSS: Main: 168534016 02:40:37 INFO - PROCESS | 20693 | 02:40:40 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37477/tests/kraken/driver.html?testName=audio-fft) 02:40:40 INFO - PROCESS | 20693 | RSS: Main: 164483072 02:40:40 INFO - PROCESS | 20693 | 02:40:42 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37477/tests/kraken/driver.html?testName=audio-oscillator) 02:40:43 INFO - PROCESS | 20693 | RSS: Main: 165593088 02:40:43 INFO - PROCESS | 20693 | 02:40:45 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:46 INFO - PROCESS | 20693 | RSS: Main: 165728256 02:40:46 INFO - PROCESS | 20693 | 02:40:49 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37477/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:50 INFO - PROCESS | 20693 | RSS: Main: 166129664 02:40:50 INFO - PROCESS | 20693 | 02:40:53 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37477/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:54 INFO - PROCESS | 20693 | RSS: Main: 163463168 02:40:54 INFO - PROCESS | 20693 | 02:40:57 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37477/tests/kraken/driver.html?testName=json-parse-financial) 02:40:57 INFO - PROCESS | 20693 | RSS: Main: 164700160 02:40:57 INFO - PROCESS | 20693 | 02:40:59 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:59 INFO - PROCESS | 20693 | RSS: Main: 164823040 02:40:59 INFO - PROCESS | 20693 | 02:41:01 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:02 INFO - PROCESS | 20693 | RSS: Main: 164913152 02:41:02 INFO - PROCESS | 20693 | 02:41:04 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:05 INFO - PROCESS | 20693 | RSS: Main: 165412864 02:41:05 INFO - PROCESS | 20693 | 02:41:07 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:08 INFO - PROCESS | 20693 | RSS: Main: 165396480 02:41:08 INFO - PROCESS | 20693 | 02:41:11 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:11 INFO - PROCESS | 20693 | RSS: Main: 165781504 02:41:11 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | Cycle 1(1): loaded http://localhost:37477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37477/tests/kraken/driver.html?testName=ai-astar) 02:41:13 INFO - PROCESS | 20693 | RSS: Main: 166273024 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | __start_tp_report 02:41:13 INFO - PROCESS | 20693 | _x_x_mozilla_page_load 02:41:13 INFO - PROCESS | 20693 | _x_x_mozilla_page_load_details 02:41:13 INFO - PROCESS | 20693 | |i|pagename|runs| 02:41:13 INFO - PROCESS | 20693 | |0;ai-astar;102;114;107;112;112;114;114;113;113;112 02:41:13 INFO - PROCESS | 20693 | |1;audio-beat-detection;150;118;149;174;119;146;147;120;180;121 02:41:13 INFO - PROCESS | 20693 | |2;audio-dft;165;164;165;163;163;167;171;165;163;165 02:41:13 INFO - PROCESS | 20693 | |3;audio-fft;76;76;76;189;77;76;75;76;173;77 02:41:13 INFO - PROCESS | 20693 | |4;audio-oscillator;85;86;162;86;85;85;142;85;85;138 02:41:13 INFO - PROCESS | 20693 | |5;imaging-gaussian-blur;118;118;118;117;117;121;118;118;117;118 02:41:13 INFO - PROCESS | 20693 | |6;imaging-darkroom;146;148;148;147;148;148;147;147;150;147 02:41:13 INFO - PROCESS | 20693 | |7;imaging-desaturate;97;97;95;95;95;96;95;96;96;98 02:41:13 INFO - PROCESS | 20693 | |8;json-parse-financial;54;52;52;51;53;63;61;51;52;54 02:41:13 INFO - PROCESS | 20693 | |9;json-stringify-tinderbox;62;62;61;62;66;62;62;62;62;63 02:41:13 INFO - PROCESS | 20693 | |10;stanford-crypto-aes;78;81;88;76;80;80;76;79;86;77 02:41:13 INFO - PROCESS | 20693 | |11;stanford-crypto-ccm;130;126;127;123;132;128;121;146;123;130 02:41:13 INFO - PROCESS | 20693 | |12;stanford-crypto-pbkdf2;160;160;164;160;162;160;161;167;160;162 02:41:13 INFO - PROCESS | 20693 | |13;stanford-crypto-sha256-iterative;64;65;65;65;69;68;69;65;65;66 02:41:13 INFO - PROCESS | 20693 | __end_tp_report 02:41:13 INFO - PROCESS | 20693 | __start_cc_report 02:41:13 INFO - PROCESS | 20693 | _x_x_mozilla_cycle_collect,885 02:41:13 INFO - PROCESS | 20693 | __end_cc_report 02:41:13 INFO - PROCESS | 20693 | __startTimestamp1470649273751__endTimestamp 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | ------- Summary: start ------- 02:41:13 INFO - PROCESS | 20693 | Number of tests: 14 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.86 (3.4%) stddev-sans-first:2.18 02:41:13 INFO - PROCESS | 20693 | Values: 102.0 114.0 107.0 112.0 112.0 114.0 114.0 113.0 113.0 112.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:148.00 stddev:22.73 (15.4%) stddev-sans-first:23.94 02:41:13 INFO - PROCESS | 20693 | Values: 150.0 118.0 149.0 174.0 119.0 146.0 147.0 120.0 180.0 121.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.42 (1.5%) stddev-sans-first:2.57 02:41:13 INFO - PROCESS | 20693 | Values: 165.0 164.0 165.0 163.0 163.0 167.0 171.0 165.0 163.0 165.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#3] audio-fft Cycles:10 Average:97.10 Median:76.00 stddev:44.38 (58.4%) stddev-sans-first:46.41 02:41:13 INFO - PROCESS | 20693 | Values: 76.0 76.0 76.0 189.0 77.0 76.0 75.0 76.0 173.0 77.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.00 stddev:30.58 (36.0%) stddev-sans-first:31.66 02:41:13 INFO - PROCESS | 20693 | Values: 85.0 86.0 162.0 86.0 85.0 85.0 142.0 85.0 85.0 138.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 02:41:13 INFO - PROCESS | 20693 | Values: 118.0 118.0 118.0 117.0 117.0 121.0 118.0 118.0 117.0 118.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 02:41:13 INFO - PROCESS | 20693 | Values: 146.0 148.0 148.0 147.0 148.0 148.0 147.0 147.0 150.0 147.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.05 (1.1%) stddev-sans-first:1.05 02:41:13 INFO - PROCESS | 20693 | Values: 97.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 98.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:4.22 (7.9%) stddev-sans-first:4.47 02:41:13 INFO - PROCESS | 20693 | Values: 54.0 52.0 52.0 51.0 53.0 63.0 61.0 51.0 52.0 54.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 02:41:13 INFO - PROCESS | 20693 | Values: 62.0 62.0 61.0 62.0 66.0 62.0 62.0 62.0 62.0 63.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:4.04 (5.1%) stddev-sans-first:4.21 02:41:13 INFO - PROCESS | 20693 | Values: 78.0 81.0 88.0 76.0 80.0 80.0 76.0 79.0 86.0 77.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:129.00 stddev:7.06 (5.5%) stddev-sans-first:7.47 02:41:13 INFO - PROCESS | 20693 | Values: 130.0 126.0 127.0 123.0 132.0 128.0 121.0 146.0 123.0 130.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:2.32 (1.4%) stddev-sans-first:2.39 02:41:13 INFO - PROCESS | 20693 | Values: 160.0 160.0 164.0 160.0 162.0 160.0 161.0 167.0 160.0 162.0 02:41:13 INFO - PROCESS | 20693 | 02:41:13 INFO - PROCESS | 20693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:65.50 stddev:1.85 (2.8%) stddev-sans-first:1.80 02:41:13 INFO - PROCESS | 20693 | Values: 64.0 65.0 65.0 65.0 69.0 68.0 69.0 65.0 65.0 66.0 02:41:13 INFO - PROCESS | 20693 | -------- Summary: end -------- 02:41:13 INFO - PROCESS | 20693 | 02:41:14 INFO - TEST-INFO | 20693: exit 0 02:41:14 INFO - TEST-OK | kraken | took 61990ms 02:41:14 INFO - SUITE-END | took 1176s 02:41:14 INFO - Completed test suite (00:19:36) 02:41:14 INFO - javascript benchmark 02:41:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7348.417774253304, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.7669174811867, 3111.704388083132, 3153.795003324784, 3159.225989632539, 3180.411623849588, 5322.361316641999, 5390.434004429532, 5427.402985671578, 5439.4288599697, 5486.753096110675, 5363.0, 5366.275552800371, 5392.541633961108, 5418.458154184579, 5433.755481003354, 4892.877678058041, 4925.088858561177, 4991.001799640068, 5012.423571289294, 5024.145895197825, 4898.485659005789, 4979.925301120486, 4991.700497970115, 5103.719295438749, 5127.666701664399, 4785.066911952171, 4980.900381992376, 4997.350344455234, 5038.143515602356, 5057.443681195084, 4823.493533179036, 4830.903381932341, 4849.806007759686, 4854.320395144682, 4866.46468888422, 4759.904801903943, 4778.713277203379, 4813.4945830687975, 4881.974785295092, 4887.364642596475, 5172.974135129338, 5341.572674186094, 5344.305240318734, 5398.13629819227, 5404.270423492818, 5667.716614169275, 5805.0, 5807.651540907559, 5812.099124635688, 5876.853078673067, 5830.4461076197695, 5841.890040892259, 5883.382244864313, 5884.0, 5891.410858914117, 5295.205719142121, 5370.194470829407, 5394.649347792381, 5449.209864569615, 5451.400345961941, 5906.40935906406, 5915.112733090071, 5966.075258334965, 6005.279366475964, 6011.338752737195, 5701.885962280731, 5738.8278351649515, 5741.339745929188, 5744.396838331999, 5758.280214973129, 5568.443155684399, 5715.8571035724435, 5726.513246374022, 5821.446962538552, 5831.679257640871, 5587.525060369833, 5657.20799088128, 5797.826065218051, 5801.042827933344, 5836.153757705109, 5650.85872853182, 5704.543636509069, 5710.200571919934, 5735.168400581976, 5739.282589676291, 4383.123375324948, 4386.0569977455, 4388.034632380871, 4469.41897553316, 4480.977595112069, 3985.960140398559, 3989.082511022481, 4013.257547353749, 4014.8394064237687, 4060.7766572838777, 5402.135658294654, 5446.2375267462585, 5546.168074788814, 5549.556035517149, 5570.470805273492, 5904.704764761831, 5919.082542205965, 5926.762929482772, 5939.2575928009, 5946.345901950782, 5620.5503559715125, 5622.409646987089, 5624.718764061862, 5628.746706398222, 5630.465105814941, 4860.927086093711, 5006.274090256892, 5051.898962020739, 5054.671446355975, 5060.898782024413, 6139.584134579375, 6145.016797312587, 6146.661933593696, 6147.2623285206955, 6148.508119350441, 5918.171455996078, 5941.940580594139, 5942.970285148546, 5949.077892926603, 5949.434803693643, 5827.096799996008, 5981.0729336952845, 6101.664408457577, 6119.694015299128, 6127.417895299939, 5827.417258274309, 5836.912446313394, 5838.211841401527, 5847.94152058474, 5878.588498805043, 5879.853003674943, 5930.34766175729, 5946.256717910262, 5948.0, 5973.970130149321, 5635.802746903839, 5711.771529138788, 5721.828345149652, 5743.10981797822, 5755.942440575541, 5687.0616348302065, 5710.086386178192, 5729.054705973635, 5740.052891272893, 5794.536437084938, 5634.014047541746, 5645.830625081254, 5672.744726487235, 5684.488396044376, 5700.743466543932, 5555.805546805843, 5662.943370566241, 5715.514181294637, 5777.277840269966, 5812.82561523155, 5685.886282274414, 5710.314762228559, 5714.685692286964, 5722.284714410699, 5737.713114344349], "value": 5373.897329042454, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.7161419290355, 581.6887964938759, 581.883623275345, 584.2959234122883, 589.0163427076782, 34326.2836858157, 37227.0, 37418.0, 37450.62549374506, 37605.81197094014, 43143.35284970728, 44173.0, 44175.11649767011, 44385.77807110968, 44407.0, 8499.277561407287, 8559.786005349853, 8576.142385761405, 8630.136986301382, 8635.654573817039, 8786.121387861227, 8823.95588022059, 8831.072737362581, 8833.33749968755, 8840.823183536326, 8783.912160878404, 8817.603207855662, 8825.205731484166, 8831.77920551985, 8868.911310886906, 8784.121587841197, 8816.074312197223, 8838.5580720964, 8841.557922103933, 8852.247558957497, 8571.528565928871, 8657.82684346316, 8660.523671198082, 8680.956595216983, 8686.044535101197, 41897.37153942693, 42196.0, 42290.0, 42589.36115958263, 42642.14715705699, 3462.9480557791653, 3513.5959364673135, 4071.2061148076136, 4226.197022565702, 4229.661627069827, 33102.834485827414, 33176.50235246473, 33761.15597110067, 33779.0, 34893.12767180816, 4150.169966006811, 4181.937270940938, 4283.079137985348, 4299.484061912559, 4324.351347297899, 321645.0, 322017.0, 322018.9999999977, 322982.0, 323390.0, 57483.42516574781, 57945.13082303769, 58078.128828067616, 58198.41801582015, 58263.70868145632, 36679.08302292464, 37592.43611345832, 37594.0, 39075.21849562993, 60607.0, 14282.285885705673, 14373.137611743328, 14377.928110359591, 14398.784018239734, 14403.85596144046, 12010.699732506582, 12088.879111208775, 12091.697707557381, 12097.939510302569, 12163.2702037878, 18946.24215031411, 19034.33379831699, 19120.61758764845, 19222.0, 19323.806761932483, 7022.859542809115, 7083.112652269917, 7118.893216601755, 7279.162896266997, 7291.781246562611, 926.9490178040272, 937.554661535765, 955.4888134847823, 1027.992567284066, 1074.5594306334365, 32510.67489325124, 32942.67057329444, 33209.66790332114, 33386.833065834515, 33723.49414758781, 1121.198343184627, 1138.9715257118473, 1164.6738913104343, 1168.5734706831945, 1241.6709571963436, 17125.828741712674, 17264.0, 17320.91339543294, 17487.38794142199, 17490.0, 530940.0, 532635.0, 535015.0, 538012.0, 538041.0, 59180.0, 59701.0, 59943.0, 60048.0, 60126.0, 1299.2074834351038, 1353.519500577281, 1365.4060483689627, 1365.5015919189623, 1381.5648070857649, 30565.694343057174, 32793.18017049593, 32813.50779738258, 32869.0, 33121.66878331282, 56541.0, 57758.7112064437, 57910.13134802897, 62155.378446214956, 62345.37654623396, 485317.0, 494085.0, 494130.0, 495083.0, 495616.0, 44001.55998439975, 44659.77670111629, 44902.3264651037, 45114.77442612766, 45355.0, 48593.75703121603, 49482.505174947786, 50078.74960625319, 50123.0, 50139.0, 41941.37087943744, 42755.57244427516, 43445.565544345416, 44524.55475445204, 44856.775716121214, 42340.576594233666, 42421.575784242996, 42589.5741042598, 43006.569934300256, 43923.56076439195, 34662.13344666403, 35129.0, 35232.29535409226, 37789.81105094457, 42795.57204427916, 35123.297534049685, 37468.62531374651, 38254.808725956194, 38683.613163868, 39189.0, 27016.0, 27560.724392755816, 27578.310542236606, 29860.701392985793, 30611.54082688806], "value": 20190.60711379449, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.8603988603989, 399.18566125104786, 402.1976157565657, 402.2598418909207, 421.66753060329364, 13993.580192594212, 17353.30586776529, 18797.214264644856, 18858.434246972596, 19631.607367852634, 14884.702305953875, 15021.774673379909, 15141.09153450791, 17949.910250448764, 18089.90955045223, 5752.568557358204, 5811.418858114176, 5853.385394533555, 5932.288125424955, 5960.374160713128, 5807.245058142456, 5852.180694702745, 5854.268216472941, 5856.297244330686, 5857.941420585782, 5611.7474713637785, 5828.766849326022, 5832.212651292085, 5911.793087241947, 5968.910466343008, 5811.099279611667, 5861.970690146543, 5876.794312199074, 5898.469137777621, 5898.734556944926, 5087.720175390352, 5816.243888294494, 5918.733656985446, 5964.433378829004, 5982.371850955674, 12577.371131443482, 13240.73518529624, 13284.335783210898, 13341.599752007456, 16370.83629163705, 2308.2959697292317, 2341.0, 2349.9072931087126, 2815.0991682661556, 2891.898783542566, 10449.477526123663, 10495.895041049567, 10656.254062215648, 12207.877921220763, 14045.297735113203, 1744.9476515704548, 1811.8912865228128, 1821.3079029968528, 1885.6611805618027, 1962.8625996180274, 78544.0, 79198.60400698017, 82238.58880705558, 82553.58723206406, 83396.0, 10714.303570267908, 11103.001459737325, 11250.606228781953, 11272.66182014541, 11439.885601143882, 15680.843191568167, 15805.52583422499, 15897.205139742966, 15957.840421595867, 15981.520554383387, 7773.63961306769, 7986.800329991681, 8039.115697273295, 8112.472689275178, 8217.301529369952, 7335.669894854745, 7407.481476296607, 7485.5508669480005, 7625.733099341496, 7720.613969301512, 4420.557944205554, 4592.724436533818, 4625.0, 4868.659193856467, 4896.534829191292, 2014.6776515757408, 2071.4717746974425, 2088.791120887899, 2090.5400811821373, 2097.7101826764306, 917.2845180759018, 953.6662168241198, 957.8228027814737, 958.3291695812959, 981.65642025292, 18815.435536933914, 20301.695474567892, 20473.590528189354, 20491.59016819655, 20537.691934620994, 916.0793402630314, 954.2461455450256, 988.357567581078, 994.6274141684429, 1017.6082208349691, 10329.328593641389, 11164.944175279072, 11225.101991840633, 11393.601223957288, 11435.771284574428, 501946.0, 505760.0, 507304.0, 509400.0, 513875.0, 58167.709161453924, 60261.39738602558, 94664.0, 94915.52542237245, 99288.5035574832, 968.9176420004237, 991.8859331177007, 1019.607451131305, 1030.2891005206384, 1037.5331101004426, 16900.746488802924, 17649.146839582172, 18026.729599056285, 18081.36715214961, 18138.365157219436, 29367.265818354714, 33420.66579334175, 35066.298674025864, 38961.025974350865, 41890.79054604707, 57466.0, 61799.0, 62335.0, 62695.37304626896, 63850.3614963863, 7870.0, 7881.487703299267, 8036.276735093869, 8076.353891688534, 8454.492730436194, 9155.587998540215, 12524.812127817908, 12926.289054102115, 13213.273269970245, 13588.116772409761, 11581.305121692725, 11951.820722688994, 11991.940040300091, 12024.639260822189, 12111.152219344562, 11245.662630121109, 11399.715007124889, 11461.312321260752, 11671.299722016705, 11711.648650540497, 11725.179237453296, 11787.823182652095, 11935.104867134825, 11975.820362694392, 11983.460744266355, 7633.923660763321, 7930.524168549675, 8109.351251899716, 8304.543250121302, 8674.52290124024, 11554.826677600011, 11575.826362604736, 11691.590794322157, 11845.289282643069, 12016.399180041139], "value": 9035.112322975328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.5619045714916, 1424.772036474164, 1483.9554813355596, 1777.173614269366, 1795.1831916478004, 7858.371330293563, 8714.782130446727, 8796.16436438539, 9506.287028472858, 9516.80966380672, 8862.291016718664, 9150.588223529941, 9191.494467804268, 9218.492982885939, 9219.861702074457, 2400.7239167495786, 2421.491486787768, 2435.3546310227803, 2436.7319594844553, 2446.8898899549563, 2412.553677569655, 2432.3675844280524, 2475.789557887582, 2482.2429159106464, 2495.4759500504824, 2409.361519197414, 2424.502976889742, 2429.392651837041, 2430.307362401716, 2453.239495756321, 2387.3076807725824, 2394.1979436888664, 2397.7961873240797, 2405.927822165338, 2409.674693916334, 2330.0330362899545, 2353.1880452051996, 2357.2574638988663, 2361.197192954404, 2369.822263330257, 9563.09150630689, 9630.085141911577, 9635.98822123681, 9668.081532254424, 9670.903290967071, 5332.600054995852, 5462.617616766828, 5528.364238112628, 5644.689542075184, 5649.604527683064, 3433.073070271038, 3492.9301413971834, 3497.1956450016637, 3504.088936876405, 3522.947155792665, 1120.7254222715405, 1173.6561636925671, 1180.9350485723282, 1183.9408029598571, 1187.6674531131298, 13362.933185334108, 13468.865311346957, 13525.661858453519, 13546.390412431465, 13559.186448813201, 4770.737609431445, 4793.616510679138, 4838.395200599925, 4842.903141937141, 5035.269885866529, 11109.388983605979, 11147.386893720923, 11188.328700278009, 11235.382053986945, 11272.66182014541, 5502.064649009678, 5517.889642207133, 5555.194496797942, 5564.054110801174, 5564.360098588714, 4463.799129039201, 4848.369711937426, 4986.950130498649, 5024.723640199824, 5060.785411501287, 4195.769232692171, 4204.642605378577, 4218.325067989168, 4247.171801498678, 4263.829446822155, 1307.6861553227156, 1321.3525372567374, 1333.8266025416633, 1333.9599812005656, 1351.6891115043595, 931.334096121263, 1005.6379703306803, 1014.5890914179769, 1030.3096925060227, 1033.379972016784, 6206.0, 6214.0, 6389.616623002542, 6415.935840641627, 6546.672666366662, 465.0745017415319, 468.6461721400389, 476.24277398935857, 481.4631685670452, 482.8430760003013, 4205.0, 4266.445362102969, 4267.829286828554, 4359.324304732771, 4379.824807007684, 11311.717207069889, 11582.768344633228, 11767.588134415255, 11785.410729463492, 11805.763884722257, 10340.482975851177, 10877.891221087688, 11587.710307242387, 11590.898864607849, 11614.593489227836, 8583.828323433496, 8717.389782715276, 8738.21356077956, 8763.167499087576, 8818.162274583905, 6416.550841441241, 6544.312847150981, 6570.408663220333, 6584.769533066511, 6654.933450665431, 10011.899881001096, 10852.294600850919, 10914.454277285946, 10927.562897484011, 10969.067629251604, 10588.205884558534, 10729.9463502682, 10843.295185812896, 10906.61826836057, 10921.180911431515, 7180.820479488055, 7655.540667559964, 7738.7678369649, 7948.324392426708, 8107.391945603986, 8416.368772341977, 8491.23578877904, 8526.190011948855, 8530.914690853013, 8551.486910785372, 7748.8450230996195, 7936.523808571505, 7964.123946365779, 8025.197480252162, 8204.876926845982, 7651.655675494728, 7865.921340786519, 7938.04743430792, 7984.161663025298, 8069.83860322802, 7129.144502659714, 7141.892871606826, 7161.856762864818, 7210.603416812126, 7235.095613048369, 5397.0, 5428.945710542844, 5432.9185062223305, 5505.091659876076, 5597.972010139923, 5314.62797604164, 5364.088105022078, 5371.892562148813, 5431.864203394946, 5521.3926468089285], "value": 4760.508226608651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.0501752618957, 347.0438940718321, 348.26017896429596, 350.54254198271263, 353.8407716527563, 5502.174673798932, 5539.501444869961, 5551.2505811715455, 5564.165375193723, 5581.8604534886545, 5442.83671489855, 5448.0, 5486.259354987075, 5488.423715509874, 5490.945090549093, 3830.0, 4064.5122585289732, 4276.2089013532595, 4281.850135245267, 4290.97854510727, 4290.249206388885, 4334.331282456245, 4353.10761293934, 4365.279728844736, 4373.518912919576, 4338.2191205582985, 4341.826326946918, 4350.608445239928, 4351.760653164075, 4354.433923589929, 3999.8600048998437, 4172.77049762263, 4201.684873634459, 4322.654187664979, 4338.2191205582985, 3636.072801435643, 3651.1602331463914, 3654.506641603376, 3654.835532401048, 3660.7803531788177, 5279.868003299948, 5303.0, 5350.117230656976, 5355.30381050461, 5394.433584473613, 4636.446790325245, 4824.517548245182, 4825.613950883921, 4863.756812159378, 4868.488808675073, 5713.971430142864, 5748.827535173951, 5756.21557317233, 5760.9711951440395, 5799.0, 4127.5666055064385, 4136.875893723193, 4145.0, 4147.900806286337, 4162.958370416318, 5777.62445441045, 5891.3814049525035, 5946.762129514815, 5982.670953097578, 6058.878822423527, 4127.33962565994, 4136.552206727682, 4154.273002224599, 4177.979110104491, 4200.327947528381, 4227.175700738327, 4257.382679511454, 4266.743995360288, 4269.996550810557, 4298.398224248608, 4721.811127554859, 4848.7090774553635, 4849.393825771778, 4905.607551395879, 4924.901501969941, 5701.543876489954, 5734.741936612862, 5748.19525266463, 5758.827235182951, 5769.826905192767, 1461.8391976882535, 1476.2987580899203, 1479.7706355514913, 1482.7479328513962, 1487.6280929767559, 883.5663264103301, 928.726025822384, 929.1869614087673, 934.1545900959643, 942.4533770413144, 4886.096072226649, 4891.5353041461, 4950.529699678525, 4953.8018479261145, 4995.400551933719, 5164.63588267913, 5166.43169251382, 5191.299174611455, 5209.921851172236, 5281.389176301265, 4701.341812146302, 4933.950660493421, 4975.5522003019905, 4979.278004689299, 5042.243663450512, 2736.2885649731215, 2758.600002999554, 2767.529519981608, 2773.1281385065, 2792.143224755515, 5376.548331950352, 5378.435264297271, 5386.629882851533, 5390.865228369244, 5399.919001214985, 5314.113489711097, 5315.282436870973, 5645.407232240637, 5914.5805006798055, 6083.8174854754425, 6108.5418593605655, 6196.955004848389, 6198.72105755233, 6201.379862013762, 6226.719797609027, 5948.315943666361, 5956.553258505716, 5985.371535988658, 6011.188489554029, 6029.306629737461, 5769.509591684754, 5800.56495762811, 5834.795782147605, 5861.531077513874, 5893.5874488785375, 6214.223222097238, 6221.222347206599, 6231.594946328655, 6267.62394256346, 6289.591176573508, 4030.1133750574827, 4159.708820382665, 4161.334186530141, 4200.894977625584, 4201.432806571073, 5876.265466816648, 5929.9110513341475, 5935.465808077293, 5954.523638109027, 5959.046552551571, 5718.885622287614, 5772.393898640582, 5780.508656764054, 5796.565257605612, 5799.594028417971, 5643.887122257614, 5727.052802047324, 5758.712064396847, 5783.19035335045, 5788.189653448605, 5657.43425657431, 5670.659760414388, 5686.374498805211, 5696.629719068247, 5749.367569567261, 5583.664980101207, 5853.736581853912, 5860.326062502867, 5880.235569376125, 5912.940870591411, 5650.63270887391, 5706.657600543981, 5730.598858079894, 5737.540996720336, 5743.46776732315], "value": 4309.693963884122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.535463367346, 774.9077490774905, 818.0837462042514, 855.8758979947908, 881.506356440393, 15326.310316035777, 16700.079490858556, 16807.495775126736, 16958.321667133314, 17008.234629441675, 14449.494267700633, 14463.783043254334, 14487.058341207814, 14506.202158881284, 14601.561953141423, 654.1888058807069, 782.1201148707704, 784.4548039112819, 811.9309858661991, 814.2752949874616, 811.6388207247777, 818.1981657975188, 820.5938060659981, 820.9671613135497, 823.4400607586839, 866.384866744612, 868.3096937934357, 872.7381785464368, 873.5937788928147, 876.1720174435161, 857.6355049104168, 861.5993562993239, 865.5845194306705, 871.2855458523982, 872.2324354567971, 634.784173381048, 635.1013316157631, 635.580516858871, 635.7234602947733, 635.7933671556763, 13761.31193440334, 13826.723465530733, 13829.0, 13829.51596694121, 13857.930710346485, 15586.142762148078, 15641.452549160838, 15747.0, 15924.0, 16009.199540022952, 12545.498180072786, 12612.117151799377, 12749.42627581761, 12794.488220471263, 12835.93582032084, 3993.920121597581, 4038.1519880824767, 4079.122988557445, 4104.0, 4159.292920203573, 89145.0, 92927.0, 93176.53411732966, 93301.0, 94065.99999999932, 11715.824262636068, 12233.57182498626, 12312.199707019015, 12536.874631253753, 12671.619851404472, 23761.40596485067, 24154.396140096287, 24174.51650966971, 24190.153344632854, 24223.394415139763, 8865.379423440298, 8942.73171804847, 8956.552172391355, 8968.0, 9098.0, 4767.68918791616, 4801.279808028754, 4922.4339200992345, 4946.752662366939, 4996.4254110777, 3322.318924620447, 3385.4921761735445, 3392.3045775615938, 3392.6607339265875, 3407.8466469008954, 615.7906311853901, 620.5439002333281, 623.0560700538688, 625.4621025917708, 637.7480895046524, 616.4509752174789, 752.5484709174451, 766.0, 793.5437123653923, 802.7070119406492, 9313.487758173365, 10114.54484548197, 10288.102791245205, 10378.740531486774, 10427.843582346271, 720.902678138455, 723.8733221686184, 727.5125665803924, 743.1565173528085, 778.8792737125755, 4925.630577706686, 4978.402591688948, 5041.79832806691, 5042.697438153649, 5064.0, 124503.0, 124980.0, 126238.3688081572, 129721.35139324242, 130533.0, 108699.0, 109724.0, 110885.0, 111651.0, 113490.0, 95473.09053818884, 97088.51455742677, 98734.5063274679, 98799.0, 98882.5055874716, 9754.85367719499, 9804.55879485439, 9947.303688741718, 9964.302498825013, 10011.649592264235, 52713.20930186127, 52911.73544132409, 53185.20222196593, 54987.175192371345, 55121.44878551163, 81455.59272203602, 83179.0, 83929.58035209785, 84329.73505397547, 86844.56577717324, 11711.180217385043, 11712.765744685228, 11787.469563869476, 11825.172237943605, 12073.27560346382, 14110.576682699535, 14119.364628591533, 14223.07550009246, 14288.857111428753, 14321.570352889014, 12865.228086314477, 13128.474861005452, 13985.090969086978, 14025.018248722492, 14142.292885355897, 13216.405261763435, 13469.663258418226, 13782.586522404345, 13826.861731382558, 13904.304784760923, 12983.091183617056, 13005.154664946747, 13116.672083197614, 13838.861611383758, 14029.438822446988, 10836.458177091272, 10895.618653347095, 11105.833412498658, 11148.888511114785, 11738.0, 10279.023492768176, 10293.176545876462, 10548.472576370998, 11200.719982000515, 11545.365004924473], "value": 7827.944259170452, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 107.0, 112.0, 112.0, 114.0, 114.0, 113.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 149.0, 174.0, 119.0, 146.0, 147.0, 120.0, 180.0, 121.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 163.0, 163.0, 167.0, 171.0, 165.0, 163.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 189.0, 77.0, 76.0, 75.0, 76.0, 173.0, 77.0], "value": 97.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 162.0, 86.0, 85.0, 85.0, 142.0, 85.0, 85.0, 138.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 121.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 150.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 98.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 51.0, 53.0, 63.0, 61.0, 51.0, 52.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 66.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 88.0, 76.0, 80.0, 80.0, 76.0, 79.0, 86.0, 77.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 127.0, 123.0, 132.0, 128.0, 121.0, 146.0, 123.0, 130.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 164.0, 160.0, 162.0, 160.0, 161.0, 167.0, 160.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 69.0, 68.0, 69.0, 65.0, 65.0, 66.0], "value": 66.1, "unit": "score"}]}]} 02:41:15 INFO - Return code: 0 02:41:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:41:15 ERROR - # TBPL SUCCESS # 02:41:15 INFO - Running post-action listener: _resource_record_post_action 02:41:15 INFO - [mozharness: 2016-08-08 09:41:15.061725Z] Finished run-tests step (success) 02:41:15 INFO - Running post-run listener: _resource_record_post_run 02:41:15 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 548900864; Read time: 0; Write time: 740460 02:41:15 INFO - TinderboxPrint: CPU usage
13.4% 02:41:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:41:15 INFO - TinderboxPrint: I/O write bytes / time
548,900,864 / 740,460 02:41:15 INFO - TinderboxPrint: CPU idle
8,238.2 (86.5%) 02:41:15 INFO - TinderboxPrint: CPU user
1,216.0 (12.8%) 02:41:15 INFO - TinderboxPrint: Swap in / out
0 / 0 02:41:15 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 255000576; Read time: 0; Write time: 374648 02:41:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 293658624; Read time: 0; Write time: 365236 02:41:15 INFO - Running post-run listener: _upload_blobber_files 02:41:15 INFO - Blob upload gear active. 02:41:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:41:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:17 INFO - (blobuploader) - INFO - Done attempting. 02:41:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:20 INFO - (blobuploader) - INFO - Done attempting. 02:41:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:41:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:21 INFO - (blobuploader) - INFO - Done attempting. 02:41:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:21 INFO - Return code: 0 02:41:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee2eea33f24b6d6b2038b765454c56120f120647808df912e004e56ee8341f1a7ed97e3e4ae4be4cc4ed049742e1a0e0cf267a6bd6b281d448b97537e2d28a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0436fff199f3863cd058adef12a2b4ff34c3e6aa1fc2bff696b39bdf11ef37f37fa7e9e39db7469c9c2146ce143fde4990dd1cec9d96b3e03e0e4168502fd624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ed99dbc09ff29cd2a19ffa93a0c982977e952be0df1c05965c178716cd0319bbd9c9322376f35a5b9d38a4f6e63642517473a6cc3250bdff2f10aeac8b3a0aa"} 02:41:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:21 INFO - Contents: 02:41:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aee2eea33f24b6d6b2038b765454c56120f120647808df912e004e56ee8341f1a7ed97e3e4ae4be4cc4ed049742e1a0e0cf267a6bd6b281d448b97537e2d28a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0436fff199f3863cd058adef12a2b4ff34c3e6aa1fc2bff696b39bdf11ef37f37fa7e9e39db7469c9c2146ce143fde4990dd1cec9d96b3e03e0e4168502fd624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ed99dbc09ff29cd2a19ffa93a0c982977e952be0df1c05965c178716cd0319bbd9c9322376f35a5b9d38a4f6e63642517473a6cc3250bdff2f10aeac8b3a0aa"} 02:41:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:21 INFO - Copying logs to upload dir... 02:41:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.264196 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-08 02:41:18.602273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 02:41:18.605744) ========= 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=52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733 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/aee2eea33f24b6d6b2038b765454c56120f120647808df912e004e56ee8341f1a7ed97e3e4ae4be4cc4ed049742e1a0e0cf267a6bd6b281d448b97537e2d28a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0436fff199f3863cd058adef12a2b4ff34c3e6aa1fc2bff696b39bdf11ef37f37fa7e9e39db7469c9c2146ce143fde4990dd1cec9d96b3e03e0e4168502fd624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ed99dbc09ff29cd2a19ffa93a0c982977e952be0df1c05965c178716cd0319bbd9c9322376f35a5b9d38a4f6e63642517473a6cc3250bdff2f10aeac8b3a0aa"} build_url:https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011529 build_url: 'https://queue.taskcluster.net/v1/task/CXL_2sqsQeqEkCJmVTz7Ww/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/aee2eea33f24b6d6b2038b765454c56120f120647808df912e004e56ee8341f1a7ed97e3e4ae4be4cc4ed049742e1a0e0cf267a6bd6b281d448b97537e2d28a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0436fff199f3863cd058adef12a2b4ff34c3e6aa1fc2bff696b39bdf11ef37f37fa7e9e39db7469c9c2146ce143fde4990dd1cec9d96b3e03e0e4168502fd624", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ed99dbc09ff29cd2a19ffa93a0c982977e952be0df1c05965c178716cd0319bbd9c9322376f35a5b9d38a4f6e63642517473a6cc3250bdff2f10aeac8b3a0aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 02:41:18.633217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:41:18.633596) ========= 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=52faae308a556c440401f8e5000001e8-1470648046.767429-1264343733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 02:41:18.717649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 02:41:18.718401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 02:41:18.719193) ========= ========= Total master_lag: 0.16 =========