builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1470819924.73 results: success (0) buildid: 20160809233002 builduid: 64a68fd7ce8141209c4f9a6ff74e83ac revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.732632) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.733001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.733284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.762739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.762991) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 02:05:25-- 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% 223M=0s 2016-08-10 02:05:25 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.935047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.935352) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018967 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.985699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:24.986007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3269dd1a824d1b42cb021d1fb6858885179940b0 --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 3269dd1a824d1b42cb021d1fb6858885179940b0 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 02:05:25,266 truncating revision to first 12 chars 2016-08-10 02:05:25,266 Setting DEBUG logging. 2016-08-10 02:05:25,267 attempt 1/10 2016-08-10 02:05:25,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3269dd1a824d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 02:05:25,683 unpacking tar archive at: fx-team-3269dd1a824d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:25.745366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:25.745637) ========= script_repo_revision: 3269dd1a824d1b42cb021d1fb6858885179940b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:25.745990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:25.746477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 02:05:25.763419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-10 02:05:25.763753) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:26 INFO - MultiFileLogger online at 20160810 02:05:26 in /builds/slave/test 02:05:26 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:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:26 INFO - {'append_to_log': False, 02:05:26 INFO - 'base_work_dir': '/builds/slave/test', 02:05:26 INFO - 'blob_upload_branch': 'Fx-Team', 02:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:26 INFO - 'branch': 'Fx-Team', 02:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:26 INFO - 'config_files': ('talos/linux_config.py',), 02:05:26 INFO - 'default_actions': ('clobber', 02:05:26 INFO - 'read-buildbot-config', 02:05:26 INFO - 'download-and-extract', 02:05:26 INFO - 'populate-webroot', 02:05:26 INFO - 'create-virtualenv', 02:05:26 INFO - 'install', 02:05:26 INFO - 'run-tests'), 02:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:26 INFO - 'download_minidump_stackwalk': True, 02:05:26 INFO - 'download_symbols': 'ondemand', 02:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:26 INFO - 'installer_path': 'installer.exe', 02:05:26 INFO - 'log_level': 'info', 02:05:26 INFO - 'log_name': 'talos', 02:05:26 INFO - 'log_to_console': True, 02:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:26 INFO - 'opt_config_files': (), 02:05:26 INFO - 'pip_index': False, 02:05:26 INFO - 'sps_profile': False, 02:05:26 INFO - 'sps_profile_interval': 0, 02:05:26 INFO - 'suite': 'dromaeojs-e10s', 02:05:26 INFO - 'system_bits': '32', 02:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:26 INFO - 'title': 'talos-linux64-ix-041', 02:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:26 INFO - 'use_talos_json': True, 02:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:26 INFO - 'work_dir': 'build'} 02:05:26 INFO - [mozharness: 2016-08-10 09:05:26.142644Z] Running clobber step. 02:05:26 INFO - Running pre-action listener: _resource_record_pre_action 02:05:26 INFO - Running main action method: clobber 02:05:26 INFO - rmtree: /builds/slave/test/build 02:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:26 INFO - Running post-action listener: _resource_record_post_action 02:05:26 INFO - [mozharness: 2016-08-10 09:05:26.598291Z] Finished clobber step (success) 02:05:26 INFO - [mozharness: 2016-08-10 09:05:26.598392Z] Running read-buildbot-config step. 02:05:26 INFO - Running pre-action listener: _resource_record_pre_action 02:05:26 INFO - Running main action method: read_buildbot_config 02:05:26 INFO - Using buildbot properties: 02:05:26 INFO - { 02:05:26 INFO - "project": "", 02:05:26 INFO - "product": "firefox", 02:05:26 INFO - "script_repo_revision": "production", 02:05:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:05:26 INFO - "repository": "", 02:05:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:05:26 INFO - "buildid": "20160809233002", 02:05:26 INFO - "pgo_build": "True", 02:05:26 INFO - "basedir": "/builds/slave/test", 02:05:26 INFO - "buildnumber": 662, 02:05:26 INFO - "slavename": "talos-linux64-ix-041", 02:05:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:05:26 INFO - "platform": "ubuntu64_hw", 02:05:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:05:26 INFO - "branch": "fx-team", 02:05:26 INFO - "repo_path": "integration/fx-team", 02:05:26 INFO - "revision": "3269dd1a824d1b42cb021d1fb6858885179940b0", 02:05:26 INFO - "stage_platform": "linux64-pgo", 02:05:26 INFO - "builduid": "64a68fd7ce8141209c4f9a6ff74e83ac", 02:05:26 INFO - "slavebuilddir": "test" 02:05:26 INFO - } 02:05:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:05:26 INFO - Running post-action listener: _resource_record_post_action 02:05:26 INFO - [mozharness: 2016-08-10 09:05:26.600830Z] Finished read-buildbot-config step (success) 02:05:26 INFO - [mozharness: 2016-08-10 09:05:26.600917Z] Running download-and-extract step. 02:05:26 INFO - Running pre-action listener: _resource_record_pre_action 02:05:26 INFO - Running main action method: download_and_extract 02:05:26 INFO - mkdir: /builds/slave/test/build/tests 02:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:26 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:05:26 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:27 INFO - Downloaded 1361 bytes. 02:05:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:05:27 INFO - Using the following test package requirements: 02:05:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:05:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:05:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'jsshell-linux-x86_64.zip'], 02:05:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:05:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:05:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:05:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:05:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:05:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:05:27 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:05:27 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:05:27 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:28 INFO - Downloaded 21831225 bytes. 02:05:28 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:05:28 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:05:29 INFO - Return code: 0 02:05:29 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:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:29 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:30 INFO - Downloaded 21831225 bytes. 02:05:30 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:05:30 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:05:31 INFO - Return code: 0 02:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:31 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:05:31 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:32 INFO - Downloaded 14413723 bytes. 02:05:32 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:05:32 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:05:32 INFO - Return code: 0 02:05:32 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:05:32 INFO - trying https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:05:32 INFO - Downloading https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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:05:34 INFO - Downloaded 59300254 bytes. 02:05:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:05:34 INFO - mkdir: /builds/slave/test/properties 02:05:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:05:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:05:34 INFO - Contents: 02:05:34 INFO - build_url:https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:05:34 INFO - Running post-action listener: _resource_record_post_action 02:05:34 INFO - Running post-action listener: set_extra_try_arguments 02:05:34 INFO - [mozharness: 2016-08-10 09:05:34.664974Z] Finished download-and-extract step (success) 02:05:34 INFO - [mozharness: 2016-08-10 09:05:34.665207Z] Running populate-webroot step. 02:05:34 INFO - Running pre-action listener: _resource_record_pre_action 02:05:34 INFO - Running main action method: populate_webroot 02:05:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:05:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:05:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:05:34 INFO - '--tppagecycles', 02:05:34 INFO - '7'], 02:05:34 INFO - 'tests': ['tsvgm']}}, 02:05:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:05:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:05:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:05:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:05:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['damp', 'tps']}, 02:05:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'tests': ['damp', 'tps']}, 02:05:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['dromaeo_dom']}, 02:05:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:05:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['basic_compositor_video']}, 02:05:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:05:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['a11yr', 02:05:34 INFO - 'ts_paint', 02:05:34 INFO - 'tpaint', 02:05:34 INFO - 'sessionrestore', 02:05:34 INFO - 'sessionrestore_no_auto_restore', 02:05:34 INFO - 'tabpaint']}, 02:05:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:05:34 INFO - 'ts_paint', 02:05:34 INFO - 'tpaint', 02:05:34 INFO - 'sessionrestore', 02:05:34 INFO - 'sessionrestore_no_auto_restore', 02:05:34 INFO - 'tabpaint']}, 02:05:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:05:34 INFO - 'ts_paint', 02:05:34 INFO - 'tpaint', 02:05:34 INFO - 'sessionrestore', 02:05:34 INFO - 'sessionrestore_no_auto_restore', 02:05:34 INFO - 'tabpaint']}, 02:05:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:05:34 INFO - 'ts_paint', 02:05:34 INFO - 'tpaint', 02:05:34 INFO - 'sessionrestore', 02:05:34 INFO - 'sessionrestore_no_auto_restore', 02:05:34 INFO - 'tabpaint']}, 02:05:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['a11yr', 02:05:34 INFO - 'ts_paint', 02:05:34 INFO - 'tpaint', 02:05:34 INFO - 'sessionrestore', 02:05:34 INFO - 'sessionrestore_no_auto_restore', 02:05:34 INFO - 'tabpaint']}, 02:05:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['a11yr', 02:05:34 INFO - 'ts_paint', 02:05:34 INFO - 'tpaint', 02:05:34 INFO - 'sessionrestore', 02:05:34 INFO - 'sessionrestore_no_auto_restore', 02:05:34 INFO - 'tabpaint']}, 02:05:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['tsvgx', 02:05:34 INFO - 'tsvgr_opacity', 02:05:34 INFO - 'tart', 02:05:34 INFO - 'tscrollx', 02:05:34 INFO - 'cart']}, 02:05:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:05:34 INFO - 'tsvgr_opacity', 02:05:34 INFO - 'tart', 02:05:34 INFO - 'tscrollx', 02:05:34 INFO - 'cart']}, 02:05:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'talos_options': ['--disable-e10s'], 02:05:34 INFO - 'tests': ['tp5o']}, 02:05:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'tests': ['tp5o']}, 02:05:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'talos_options': ['--disable-e10s', 02:05:34 INFO - '--xperf_path', 02:05:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:34 INFO - 'tests': ['tp5n']}, 02:05:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:34 INFO - 'talos_options': ['--xperf_path', 02:05:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:34 INFO - 'tests': ['tp5n']}}, 02:05:34 INFO - 'talos.zip': {'path': '', 02:05:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:05:34 INFO - Running post-action listener: _resource_record_post_action 02:05:34 INFO - [mozharness: 2016-08-10 09:05:34.684598Z] Finished populate-webroot step (success) 02:05:34 INFO - [mozharness: 2016-08-10 09:05:34.684686Z] Running create-virtualenv step. 02:05:34 INFO - Running pre-action listener: _resource_record_pre_action 02:05:34 INFO - Running main action method: create_virtualenv 02:05:34 INFO - Creating virtualenv /builds/slave/test/build/venv 02:05:34 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:05:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:05:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:05:34 INFO - Using real prefix '/usr' 02:05:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:05:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:05:37 INFO - Installing pip.................done. 02:05:37 INFO - Return code: 0 02:05:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:05:37 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:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:37 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:05:37 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:05:37 INFO - Using env: {'DISPLAY': ':0', 02:05:37 INFO - 'HOME': '/home/cltbld', 02:05:37 INFO - 'LANG': 'en_US.UTF-8', 02:05:37 INFO - 'LANGUAGE': 'en_US:en', 02:05:37 INFO - 'LOGNAME': 'cltbld', 02:05:37 INFO - 'MAIL': '/var/mail/cltbld', 02:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:37 INFO - 'MOZ_NO_REMOTE': '1', 02:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:37 INFO - 'NO_EM_RESTART': '1', 02:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:37 INFO - 'PWD': '/builds/slave/test', 02:05:37 INFO - 'SHELL': '/bin/bash', 02:05:37 INFO - 'SHLVL': '1', 02:05:37 INFO - 'TERM': 'linux', 02:05:37 INFO - 'TMOUT': '86400', 02:05:37 INFO - 'USER': 'cltbld', 02:05:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:37 INFO - '_': '/tools/buildbot/bin/python'} 02:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:37 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:05:37 INFO - Cleaning up... 02:05:37 INFO - Return code: 0 02:05:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:05:37 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:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:37 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:37 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:05:37 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:05:37 INFO - Using env: {'DISPLAY': ':0', 02:05:37 INFO - 'HOME': '/home/cltbld', 02:05:37 INFO - 'LANG': 'en_US.UTF-8', 02:05:37 INFO - 'LANGUAGE': 'en_US:en', 02:05:37 INFO - 'LOGNAME': 'cltbld', 02:05:37 INFO - 'MAIL': '/var/mail/cltbld', 02:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:37 INFO - 'MOZ_NO_REMOTE': '1', 02:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:37 INFO - 'NO_EM_RESTART': '1', 02:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:37 INFO - 'PWD': '/builds/slave/test', 02:05:37 INFO - 'SHELL': '/bin/bash', 02:05:37 INFO - 'SHLVL': '1', 02:05:37 INFO - 'TERM': 'linux', 02:05:37 INFO - 'TMOUT': '86400', 02:05:37 INFO - 'USER': 'cltbld', 02:05:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:37 INFO - '_': '/tools/buildbot/bin/python'} 02:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:37 INFO - Downloading/unpacking psutil>=3.1.1 02:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:05:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:39 INFO - Installing collected packages: psutil 02:05:39 INFO - Running setup.py install for psutil 02:05:39 INFO - building 'psutil._psutil_linux' extension 02:05:39 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:05:39 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:05:40 INFO - building 'psutil._psutil_posix' extension 02:05:40 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:05:40 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:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:40 INFO - Successfully installed psutil 02:05:40 INFO - Cleaning up... 02:05:40 INFO - Return code: 0 02:05:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:40 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:40 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:05:40 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:05:40 INFO - Using env: {'DISPLAY': ':0', 02:05:40 INFO - 'HOME': '/home/cltbld', 02:05:40 INFO - 'LANG': 'en_US.UTF-8', 02:05:40 INFO - 'LANGUAGE': 'en_US:en', 02:05:40 INFO - 'LOGNAME': 'cltbld', 02:05:40 INFO - 'MAIL': '/var/mail/cltbld', 02:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:40 INFO - 'MOZ_NO_REMOTE': '1', 02:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:40 INFO - 'NO_EM_RESTART': '1', 02:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:40 INFO - 'PWD': '/builds/slave/test', 02:05:40 INFO - 'SHELL': '/bin/bash', 02:05:40 INFO - 'SHLVL': '1', 02:05:40 INFO - 'TERM': 'linux', 02:05:40 INFO - 'TMOUT': '86400', 02:05:40 INFO - 'USER': 'cltbld', 02:05:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:40 INFO - '_': '/tools/buildbot/bin/python'} 02:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:05:40 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:05:40 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:05:40 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:05:40 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:05:40 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:05:40 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:05:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:05:42 INFO - Installing collected packages: mozsystemmonitor 02:05:42 INFO - Running setup.py install for mozsystemmonitor 02:05:42 INFO - Successfully installed mozsystemmonitor 02:05:42 INFO - Cleaning up... 02:05:42 INFO - Return code: 0 02:05:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:05:42 INFO - Using env: {'DISPLAY': ':0', 02:05:42 INFO - 'HOME': '/home/cltbld', 02:05:42 INFO - 'LANG': 'en_US.UTF-8', 02:05:42 INFO - 'LANGUAGE': 'en_US:en', 02:05:42 INFO - 'LOGNAME': 'cltbld', 02:05:42 INFO - 'MAIL': '/var/mail/cltbld', 02:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:42 INFO - 'MOZ_NO_REMOTE': '1', 02:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:42 INFO - 'NO_EM_RESTART': '1', 02:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:42 INFO - 'PWD': '/builds/slave/test', 02:05:42 INFO - 'SHELL': '/bin/bash', 02:05:42 INFO - 'SHLVL': '1', 02:05:42 INFO - 'TERM': 'linux', 02:05:42 INFO - 'TMOUT': '86400', 02:05:42 INFO - 'USER': 'cltbld', 02:05:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:42 INFO - '_': '/tools/buildbot/bin/python'} 02:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:42 INFO - Downloading/unpacking jsonschema==2.5.1 02:05:42 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:05:42 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:05:42 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:05:42 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:05:42 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:05:42 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:05:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:05:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:05:44 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:05:44 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:05:44 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:05:44 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:05:44 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:05:44 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:05:44 INFO - Downloading functools32-3.2.3-2.tar.gz 02:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:05:44 INFO - warning: no files found matching '*.txt' 02:05:44 INFO - no previously-included directories found matching 'build' 02:05:44 INFO - no previously-included directories found matching 'dist' 02:05:44 INFO - no previously-included directories found matching '.git*' 02:05:44 INFO - Installing collected packages: jsonschema, functools32 02:05:44 INFO - Running setup.py install for functools32 02:05:45 INFO - warning: no files found matching '*.txt' 02:05:45 INFO - no previously-included directories found matching 'build' 02:05:45 INFO - no previously-included directories found matching 'dist' 02:05:45 INFO - no previously-included directories found matching '.git*' 02:05:45 INFO - Successfully installed jsonschema functools32 02:05:45 INFO - Cleaning up... 02:05:45 INFO - Return code: 0 02:05:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:05:45 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:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:45 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:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:45 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:45 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:05:45 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:05:45 INFO - Using env: {'DISPLAY': ':0', 02:05:45 INFO - 'HOME': '/home/cltbld', 02:05:45 INFO - 'LANG': 'en_US.UTF-8', 02:05:45 INFO - 'LANGUAGE': 'en_US:en', 02:05:45 INFO - 'LOGNAME': 'cltbld', 02:05:45 INFO - 'MAIL': '/var/mail/cltbld', 02:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:45 INFO - 'MOZ_NO_REMOTE': '1', 02:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:45 INFO - 'NO_EM_RESTART': '1', 02:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:45 INFO - 'PWD': '/builds/slave/test', 02:05:45 INFO - 'SHELL': '/bin/bash', 02:05:45 INFO - 'SHLVL': '1', 02:05:45 INFO - 'TERM': 'linux', 02:05:45 INFO - 'TMOUT': '86400', 02:05:45 INFO - 'USER': 'cltbld', 02:05:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:45 INFO - '_': '/tools/buildbot/bin/python'} 02:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:05:45 INFO - Cleaning up... 02:05:45 INFO - Return code: 0 02:05:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:05:45 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:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:45 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:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:45 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:45 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:05:45 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:05:45 INFO - Using env: {'DISPLAY': ':0', 02:05:45 INFO - 'HOME': '/home/cltbld', 02:05:45 INFO - 'LANG': 'en_US.UTF-8', 02:05:45 INFO - 'LANGUAGE': 'en_US:en', 02:05:45 INFO - 'LOGNAME': 'cltbld', 02:05:45 INFO - 'MAIL': '/var/mail/cltbld', 02:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:45 INFO - 'MOZ_NO_REMOTE': '1', 02:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:45 INFO - 'NO_EM_RESTART': '1', 02:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:45 INFO - 'PWD': '/builds/slave/test', 02:05:45 INFO - 'SHELL': '/bin/bash', 02:05:45 INFO - 'SHLVL': '1', 02:05:45 INFO - 'TERM': 'linux', 02:05:45 INFO - 'TMOUT': '86400', 02:05:45 INFO - 'USER': 'cltbld', 02:05:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:45 INFO - '_': '/tools/buildbot/bin/python'} 02:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:47 INFO - Downloading blobuploader-1.2.4.tar.gz 02:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:05:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:05:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:48 INFO - Downloading docopt-0.6.1.tar.gz 02:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:05:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:05:48 INFO - Running setup.py install for blobuploader 02:05:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:05:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:05:48 INFO - Running setup.py install for requests 02:05:48 INFO - Running setup.py install for docopt 02:05:48 INFO - Successfully installed blobuploader requests docopt 02:05:48 INFO - Cleaning up... 02:05:48 INFO - Return code: 0 02:05:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:48 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:48 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:05:48 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:05:48 INFO - Using env: {'DISPLAY': ':0', 02:05:48 INFO - 'HOME': '/home/cltbld', 02:05:48 INFO - 'LANG': 'en_US.UTF-8', 02:05:48 INFO - 'LANGUAGE': 'en_US:en', 02:05:48 INFO - 'LOGNAME': 'cltbld', 02:05:48 INFO - 'MAIL': '/var/mail/cltbld', 02:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:48 INFO - 'MOZ_NO_REMOTE': '1', 02:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:48 INFO - 'NO_EM_RESTART': '1', 02:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:48 INFO - 'PWD': '/builds/slave/test', 02:05:48 INFO - 'SHELL': '/bin/bash', 02:05:48 INFO - 'SHLVL': '1', 02:05:48 INFO - 'TERM': 'linux', 02:05:48 INFO - 'TMOUT': '86400', 02:05:48 INFO - 'USER': 'cltbld', 02:05:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:48 INFO - '_': '/tools/buildbot/bin/python'} 02:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:05:49 INFO - Running setup.py (path:/tmp/pip-GEZk4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:05:49 INFO - Running setup.py (path:/tmp/pip-8TQoY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:05:49 INFO - Running setup.py (path:/tmp/pip-BEDYgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:05:49 INFO - Running setup.py (path:/tmp/pip-WEaMH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:05:49 INFO - Running setup.py (path:/tmp/pip-prmaW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:05:49 INFO - Running setup.py (path:/tmp/pip-0kpDnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:05:49 INFO - Running setup.py (path:/tmp/pip-zQqZE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:05:49 INFO - Running setup.py (path:/tmp/pip-x_Nd28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:05:49 INFO - Running setup.py (path:/tmp/pip-ToQTna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:05:49 INFO - Running setup.py (path:/tmp/pip-qgU61t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:05:49 INFO - Running setup.py (path:/tmp/pip-a4x_LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:05:49 INFO - Running setup.py (path:/tmp/pip-oMuFwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:05:49 INFO - Running setup.py (path:/tmp/pip-L0DUp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:05:49 INFO - Running setup.py (path:/tmp/pip-9UZKlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:50 INFO - Running setup.py (path:/tmp/pip-zsqWS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:05:50 INFO - Running setup.py (path:/tmp/pip-vPNk0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:05:50 INFO - Running setup.py (path:/tmp/pip-86NNiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:05:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:05:50 INFO - Running setup.py install for manifestparser 02:05:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:05:50 INFO - Running setup.py install for mozcrash 02:05:50 INFO - Running setup.py install for mozdebug 02:05:50 INFO - Running setup.py install for mozdevice 02:05:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:05:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:05:50 INFO - Running setup.py install for mozfile 02:05:50 INFO - Running setup.py install for mozhttpd 02:05:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:05:50 INFO - Running setup.py install for mozinfo 02:05:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:05:50 INFO - Running setup.py install for mozInstall 02:05:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Running setup.py install for mozleak 02:05:51 INFO - Running setup.py install for mozlog 02:05:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Running setup.py install for moznetwork 02:05:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Running setup.py install for mozprocess 02:05:51 INFO - Running setup.py install for mozprofile 02:05:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Running setup.py install for mozrunner 02:05:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:05:51 INFO - Running setup.py install for mozscreenshot 02:05:51 INFO - Running setup.py install for moztest 02:05:51 INFO - Running setup.py install for mozversion 02:05:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:05:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:05:52 INFO - Cleaning up... 02:05:52 INFO - Return code: 0 02:05:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:52 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:52 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:05:52 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:05:52 INFO - Using env: {'DISPLAY': ':0', 02:05:52 INFO - 'HOME': '/home/cltbld', 02:05:52 INFO - 'LANG': 'en_US.UTF-8', 02:05:52 INFO - 'LANGUAGE': 'en_US:en', 02:05:52 INFO - 'LOGNAME': 'cltbld', 02:05:52 INFO - 'MAIL': '/var/mail/cltbld', 02:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:52 INFO - 'MOZ_NO_REMOTE': '1', 02:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:52 INFO - 'NO_EM_RESTART': '1', 02:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:52 INFO - 'PWD': '/builds/slave/test', 02:05:52 INFO - 'SHELL': '/bin/bash', 02:05:52 INFO - 'SHLVL': '1', 02:05:52 INFO - 'TERM': 'linux', 02:05:52 INFO - 'TMOUT': '86400', 02:05:52 INFO - 'USER': 'cltbld', 02:05:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:52 INFO - '_': '/tools/buildbot/bin/python'} 02:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:05:52 INFO - Running setup.py (path:/tmp/pip-bK9dJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:05:52 INFO - Running setup.py (path:/tmp/pip-hIbOy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:05:52 INFO - Running setup.py (path:/tmp/pip-FbxegO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:05:52 INFO - Running setup.py (path:/tmp/pip-ATaHxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:05:52 INFO - Running setup.py (path:/tmp/pip-hX4UId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:05:52 INFO - Running setup.py (path:/tmp/pip-HqppJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:05:52 INFO - Running setup.py (path:/tmp/pip-yeF04i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:05:52 INFO - Running setup.py (path:/tmp/pip-y2Rp8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:05:52 INFO - Running setup.py (path:/tmp/pip-lt89pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:05:52 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:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:05:52 INFO - Running setup.py (path:/tmp/pip-nwuiVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:05:53 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:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:05:53 INFO - Running setup.py (path:/tmp/pip-6QMvvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:05:53 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:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:05:53 INFO - Running setup.py (path:/tmp/pip-b0Cc8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:05:53 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:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:05:53 INFO - Running setup.py (path:/tmp/pip-l4MErA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:05:53 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:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:05:53 INFO - Running setup.py (path:/tmp/pip-oqPz7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:05:53 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:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:53 INFO - Running setup.py (path:/tmp/pip-UYqWY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:53 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:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:05:53 INFO - Running setup.py (path:/tmp/pip-IxByOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:05:53 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:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:05:53 INFO - Running setup.py (path:/tmp/pip-B4zC4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:05:53 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:05:53 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:05:53 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:05:53 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:05:53 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:05:53 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:05:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:05:53 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:05:53 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:05:53 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:05:53 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:05:53 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:05:53 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:05:55 INFO - Downloading blessings-1.6.tar.gz 02:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:05:55 INFO - Installing collected packages: blessings 02:05:55 INFO - Running setup.py install for blessings 02:05:55 INFO - Successfully installed blessings 02:05:55 INFO - Cleaning up... 02:05:55 INFO - Return code: 0 02:05:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:05:55 INFO - Reading from file tmpfile_stdout 02:05:55 INFO - Current package versions: 02:05:55 INFO - argparse == 1.2.1 02:05:55 INFO - blessings == 1.6 02:05:55 INFO - blobuploader == 1.2.4 02:05:55 INFO - docopt == 0.6.1 02:05:55 INFO - functools32 == 3.2.3-2 02:05:55 INFO - jsonschema == 2.5.1 02:05:55 INFO - manifestparser == 1.1 02:05:55 INFO - mozInstall == 1.12 02:05:55 INFO - mozcrash == 0.17 02:05:55 INFO - mozdebug == 0.1 02:05:55 INFO - mozdevice == 0.48 02:05:55 INFO - mozfile == 1.2 02:05:55 INFO - mozhttpd == 0.7 02:05:55 INFO - mozinfo == 0.9 02:05:55 INFO - mozleak == 0.1 02:05:55 INFO - mozlog == 3.3 02:05:55 INFO - moznetwork == 0.27 02:05:55 INFO - mozprocess == 0.23 02:05:55 INFO - mozprofile == 0.28 02:05:55 INFO - mozrunner == 6.12 02:05:55 INFO - mozscreenshot == 0.1 02:05:55 INFO - mozsystemmonitor == 0.3 02:05:55 INFO - moztest == 0.7 02:05:55 INFO - mozversion == 1.4 02:05:55 INFO - psutil == 3.1.1 02:05:55 INFO - requests == 1.2.3 02:05:55 INFO - wsgiref == 0.1.2 02:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:55 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:55 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:05:55 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:05:55 INFO - Using env: {'DISPLAY': ':0', 02:05:55 INFO - 'HOME': '/home/cltbld', 02:05:55 INFO - 'LANG': 'en_US.UTF-8', 02:05:55 INFO - 'LANGUAGE': 'en_US:en', 02:05:55 INFO - 'LOGNAME': 'cltbld', 02:05:55 INFO - 'MAIL': '/var/mail/cltbld', 02:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:55 INFO - 'MOZ_NO_REMOTE': '1', 02:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:55 INFO - 'NO_EM_RESTART': '1', 02:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:55 INFO - 'PWD': '/builds/slave/test', 02:05:55 INFO - 'SHELL': '/bin/bash', 02:05:55 INFO - 'SHLVL': '1', 02:05:55 INFO - 'TERM': 'linux', 02:05:55 INFO - 'TMOUT': '86400', 02:05:55 INFO - 'USER': 'cltbld', 02:05:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:55 INFO - '_': '/tools/buildbot/bin/python'} 02:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:56 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:05:56 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:05:56 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:05:56 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:05:56 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:05:56 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:05:56 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:05:56 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:05:56 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:05:56 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:05:56 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:05:56 INFO - Cleaning up... 02:05:56 INFO - Return code: 0 02:05:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:56 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 0x1d07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', '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:05:56 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:05:56 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:05:56 INFO - Using env: {'DISPLAY': ':0', 02:05:56 INFO - 'HOME': '/home/cltbld', 02:05:56 INFO - 'LANG': 'en_US.UTF-8', 02:05:56 INFO - 'LANGUAGE': 'en_US:en', 02:05:56 INFO - 'LOGNAME': 'cltbld', 02:05:56 INFO - 'MAIL': '/var/mail/cltbld', 02:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:56 INFO - 'MOZ_NO_REMOTE': '1', 02:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:56 INFO - 'NO_EM_RESTART': '1', 02:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:56 INFO - 'PWD': '/builds/slave/test', 02:05:56 INFO - 'SHELL': '/bin/bash', 02:05:56 INFO - 'SHLVL': '1', 02:05:56 INFO - 'TERM': 'linux', 02:05:56 INFO - 'TMOUT': '86400', 02:05:56 INFO - 'USER': 'cltbld', 02:05:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:56 INFO - '_': '/tools/buildbot/bin/python'} 02:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:05:56 INFO - Cleaning up... 02:05:56 INFO - Return code: 0 02:05:56 INFO - Running post-action listener: _resource_record_post_action 02:05:56 INFO - Running post-action listener: _start_resource_monitoring 02:05:56 INFO - Starting resource monitoring. 02:05:56 INFO - [mozharness: 2016-08-10 09:05:56.339699Z] Finished create-virtualenv step (success) 02:05:56 INFO - [mozharness: 2016-08-10 09:05:56.340142Z] Running install step. 02:05:56 INFO - Running pre-action listener: _resource_record_pre_action 02:05:56 INFO - Running main action method: install 02:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:05:56 INFO - Reading from file tmpfile_stdout 02:05:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:05:56 INFO - Reading from file tmpfile_stdout 02:05:56 INFO - Output received: 02:05:56 INFO - Usage: mozinstall [options] installer 02:05:56 INFO - Options: 02:05:56 INFO - -h, --help show this help message and exit 02:05:56 INFO - -d DEST, --destination=DEST 02:05:56 INFO - Directory to install application into. [default: 02:05:56 INFO - "/builds/slave/test"] 02:05:56 INFO - --app=APP Application being installed. [default: firefox] 02:05:56 INFO - mkdir: /builds/slave/test/build/application 02:05:56 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:05:56 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:06:13 INFO - Reading from file tmpfile_stdout 02:06:13 INFO - Output received: 02:06:13 INFO - /builds/slave/test/build/application/firefox/firefox 02:06:13 INFO - Running post-action listener: _resource_record_post_action 02:06:13 INFO - [mozharness: 2016-08-10 09:06:13.670308Z] Finished install step (success) 02:06:13 INFO - [mozharness: 2016-08-10 09:06:13.670556Z] Running run-tests step. 02:06:13 INFO - Running pre-action listener: _resource_record_pre_action 02:06:13 INFO - Running main action method: run_tests 02:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:13 INFO - Python 2.7.3 02:06:13 INFO - Return code: 0 02:06:13 INFO - grabbing minidump binary from tooltool 02:06: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:06:13 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 0x1fc63b0>, '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 0x1fc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:13 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:06:13 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:06:13 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:06:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:13 INFO - Return code: 0 02:06:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:06:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:06:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:13 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/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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:06:13 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/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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:06:13 INFO - Using env: {'DISPLAY': ':0', 02:06:13 INFO - 'HOME': '/home/cltbld', 02:06:13 INFO - 'LANG': 'en_US.UTF-8', 02:06:13 INFO - 'LANGUAGE': 'en_US:en', 02:06:13 INFO - 'LOGNAME': 'cltbld', 02:06:13 INFO - 'MAIL': '/var/mail/cltbld', 02:06:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:13 INFO - 'MOZ_NO_REMOTE': '1', 02:06:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:13 INFO - 'NO_EM_RESTART': '1', 02:06:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:13 INFO - 'PWD': '/builds/slave/test', 02:06:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:13 INFO - 'SHELL': '/bin/bash', 02:06:13 INFO - 'SHLVL': '1', 02:06:13 INFO - 'TERM': 'linux', 02:06:13 INFO - 'TMOUT': '86400', 02:06:13 INFO - 'USER': 'cltbld', 02:06:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275', 02:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:13 INFO - '_': '/tools/buildbot/bin/python'} 02:06:13 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/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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:06:13 INFO - mozversion application_buildid: 20160809233002 02:06:13 INFO - mozversion application_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 02:06:13 INFO - mozversion application_display_name: Nightly 02:06:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:13 INFO - mozversion application_name: Firefox 02:06:13 INFO - mozversion application_remotingname: firefox 02:06:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:06:13 INFO - mozversion application_vendor: Mozilla 02:06:13 INFO - mozversion application_version: 51.0a1 02:06:13 INFO - mozversion platform_buildid: 20160809233002 02:06:13 INFO - mozversion platform_changeset: 3269dd1a824d1b42cb021d1fb6858885179940b0 02:06:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:06:13 INFO - mozversion platform_version: 51.0a1 02:06:13 INFO - using testdate: 1470819973 02:06:13 INFO - actual date: 1470819973 02:06:13 INFO - starting webserver on 'localhost:37239' 02:06:13 INFO - SUITE-START | Running 2 tests 02:06:13 INFO - TEST-START | dromaeo_css 02:06:13 INFO - operating with platform_type : linux_ 02:06:13 INFO - Initialising browser for dromaeo_css test... 02:06:13 INFO - TEST-INFO | started process 29190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8nTUy/profile http://localhost:37239/getInfo.html) 02:06:18 INFO - PROCESS | 29190 | __metrics Screen width/height:1600/1200 02:06:18 INFO - PROCESS | 29190 | colorDepth:24 02:06:18 INFO - PROCESS | 29190 | Browser inner width/height: 1024/697 02:06:18 INFO - PROCESS | 29190 | __metrics 02:06:19 ERROR - PROCESS | 29190 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:06:19 INFO - TEST-INFO | 29190: exit 0 02:06:19 INFO - Browser initialized. 02:06:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:19 INFO - TEST-INFO | started process 29310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8nTUy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:31 INFO - PROCESS | 29310 | RSS: Main: 162811904 02:06:31 INFO - PROCESS | 29310 | 02:07:21 INFO - PROCESS | 29310 | 1470820041249 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:09:31 INFO - PROCESS | 29310 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37239/tests/dromaeo/cssquery-ext.html) 02:09:32 INFO - PROCESS | 29310 | RSS: Main: 165076992 02:09:32 INFO - PROCESS | 29310 | 02:12:34 INFO - PROCESS | 29310 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-ext.html (next: http://localhost:37239/tests/dromaeo/cssquery-jquery.html) 02:12:35 INFO - PROCESS | 29310 | RSS: Main: 164802560 02:12:35 INFO - PROCESS | 29310 | 02:15:37 INFO - PROCESS | 29310 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37239/tests/dromaeo/cssquery-mootools.html) 02:15:37 INFO - PROCESS | 29310 | RSS: Main: 168570880 02:15:37 INFO - PROCESS | 29310 | 02:18:39 INFO - PROCESS | 29310 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37239/tests/dromaeo/cssquery-prototype.html) 02:18:40 INFO - PROCESS | 29310 | RSS: Main: 162951168 02:18:40 INFO - PROCESS | 29310 | 02:21:42 INFO - PROCESS | 29310 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37239/tests/dromaeo/cssquery-yui.html) 02:21:43 INFO - PROCESS | 29310 | RSS: Main: 165437440 02:21:43 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-yui.html (next: http://localhost:37239/tests/dromaeo/cssquery-dojo.html) 02:24:46 INFO - PROCESS | 29310 | RSS: Main: 168857600 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | __start_tp_report 02:24:46 INFO - PROCESS | 29310 | _x_x_mozilla_page_load 02:24:46 INFO - PROCESS | 29310 | _x_x_mozilla_page_load_details 02:24:46 INFO - PROCESS | 29310 | |i|pagename|runs| 02:24:46 INFO - PROCESS | 29310 | |0;dojo.html;3093.783435159539;3106.440840648685;3134.0754477429164;3145.056483055083;3145.1979745164995;5259.894802103956;5387.649802762822;5459.12653975364;5467.398586155525;5470.972645136773;5439.456054394558;5439.564834813215;5472.370677372103;5493.807716729915;5500.367457742351;4899.804007839691;4985.102681517325;5014.448410674823;5016.27264046713;5046.646734728571;4960.528749768784;4972.726500042496;5040.42035165957;5046.798128074873;5070.467600901889;4830.420349558058;4908.828191013297;4917.532834380728;4988.401391832967;5027.220780778966;4916.360873086512;4926.088673595396;4934.4572097069295;4945.060438516706;4972.975135124338;4935.2350385689915;4946.826861059882;4957.7769000395065;4966.106100901836;5012.624053196025;5239.449857764918;5252.947470525284;5271.841844744664;5341.919871201935;5410.675359478444;5733.799317023926;5744.368119506851;5751.913721294184;5753.050746626802;5753.827385178452;5751.568632352591;5756.481916627524;5762.625429347079;5769.701817091163;5771.307443106854;5274.947250527484;5339.652922560022;5395.190721391744;5395.4604539545735;5461.9453805462235;5871.3541510433815;5877.794277200277;5879.265091863517;5913.438223368773;5922.970385148046;5633.239512665819;5638.295213098363;5640.210370548127;5695.145728140812;5705.771769129271;5567.582431317667;5664.348599911063;5677.914831277534;5696.658200507983;5802;5685.829425117253;5702;5733.77064917407;5741.540676745851;5743.396943320975;5666.688332141772;5718.971405142947;5721.5708821838525;5751.309842818889;5754.338251101177;4345.521992580813;4372.519022907478;4380.9780951095045;4399.824007039682;4430.091831174666;3920.196359746245;3921.8235179416993;3923.2103343101694;3944.9211015779524;3955.3869150281753;5422.701751403711;5429.4027656957705;5463.754131064112;5477.260569823103;5480.6437581557075;5542.307211598551;5622.437756224344;5673.631213971161;5764.135379692996;5820.447057529528;5437.918431223535;5473.0969390051;5483.479069488472;5484.396716361197;5517.586181036358;4934.037862616755;4976.154053810861;4978.327925730053;4984.7258400788305;4998.375203099613;5837.678927658934;5839.532837373;5888.9705551472825;5909.0840919658385;5979.940200598112;5722.885542289214;5741.684207368635;5743.770249190153;5757.91363129545;5768.077107662753;5915.171875937458;5949.25634295713;5949.315828679757;5956.583039187215;5963.642181469126;5604.8318550443555;5712.485876271156;5723.599348045597;5750.913736293875;5809.2738407699035;5808.390119037609;5819.098039803837;5839.912401313899;5851.385604511465;5856.209411729533;5547.445255474582;5702.030654788613;5705.4009329019855;5712.228849105484;5731.484166425042;5644.463775941279;5659.320881494247;5751.482366587027;5776.393478684678;5799.217105690846;5735.168400581809;5743.971280143573;5746.770129194785;5750.7987220447085;5773.566982476415;5493.450654934474;5751.827445176651;5764.193012978102;5822.70886455684;5823.4467725566;5505;5517.337919449692;5579.804706835242;5590.273264475755;5664.178694089416 02:24:46 INFO - PROCESS | 29310 | |1;ext.html;558.9608727389082;573.9569532285079;578.5602941764259;578.6296770067155;596.731470838123;41492;42472.36291455631;42480.57519424805;42548.57451425485;42582.36126458106;42490.78754606222;42673.359899601455;43017.35473967893;43066.7846660767;43080.3537946931;8835.646574137027;8927;8938.597763100675;8964.641414343418;8989.685361012365;8811.911880881205;8817.338699597556;8842.469451832878;8859.5570221489;8865.335099867503;8864.379493435463;8929.642814287421;8951.73144805657;8961.507117108556;8976.910230897673;8843.292536597057;8859.512726800023;8922.598483068212;8926.2412694921;8926.955365223164;8795.78010549735;8896.955515222382;8916.687915922912;8932;8955.104489551059;40005.19989600192;40323;40461.79769101136;40517.79741101305;40557.18885622301;3587.982060089683;3717.665410113103;3753.305638456894;3754.924901501982;4118.75287482752;31331;32419.837900810344;32615.347693046006;32748.345033099442;32809;3997.960020399788;4168.124693814302;4180.143070670505;4199.202151591188;4295.4415925929425;362254;366012;366173;367005;367150;62198;62448.375516244254;62955.37044629495;63041;63141;36685.63314366822;37376.62623373731;37411.625883741355;39549.406758898636;58146.70926645424;17465.825341746673;17547.385841495485;17672.734908976374;17684.29262829498;17696.29214831418;13331.333433328295;13488.258145802076;13489.662758431117;13497.460101596023;13509.86490135086;19064.237430502624;19081.522961925784;19191.232350705814;19260.518487037934;19497;7250.673719682627;7302.531297633582;7315.817104572322;7321.267873212636;7363.521371110861;948.2698322291934;1024.2011231239644;1031.097789434245;1040.9739756506149;1078.6710053433778;33155.336893262;33193.83403083018;33249.16877078044;33558.66441335604;33865.83067084649;1125.386664267976;1134.1720544002924;1161.6108603617713;1183.360985068071;1218.2994778002683;17397.130143492774;17551.210195541233;17559.824401756076;17606.471805845846;17682.646347072987;542436;544592;547837;549581;554432;58428.4157158423;58905.70547147237;58969.115463268085;58970.11544826831;59014.40985590175;1334.5996201139812;1350.3518311210673;1379.4482207117032;1390.2562129260998;1404.7120340330207;31021.224469388446;32584.67415325911;32703.672963270063;33109.337813244085;33196.50205246875;51815.48184518257;52077;52181.7390913043;52214;52253.47746522638;434105;436399;436402;437037;438742;28953.13140605785;29043.564346534396;29098.7090129096;29350.41299174047;29514;48201.75899120482;48263.75868120637;48818.51181488282;48846.755766220944;50068.99310068964;41425.585744142176;41863.37204941867;42218.155636887706;43184.568154318054;43452.34821477617;41351.172976539696;41832;42321.788391057846;42620.14759704727;43036;36118.638813612575;41248.38127428031;41360;41926.37110443407;42088.78955605203;35741.46387804133;37940;38104.61895381011;38270.80864595659;38471.615283847925;28834.567481488215;28969.7103028967;28986.27534311659;29431;29621.851890740407 02:24:46 INFO - PROCESS | 29310 | |2;jquery.html;378.6289436352375;381.5326225373917;390.99413508797375;391.43083840253917;408.5505943462192;18549.814501854977;19962.201511939504;20474.89762551185;20481.385558433252;20583.897080514576;18534.165962531686;19040.90479547604;19172.904135479337;19211.519712007208;19400.611987760236;5334.466553344673;5401.837944861661;5466.562674985991;5469.398366179717;5516;5442.591805614575;5453.3728621208475;5458.6724796512335;5460.726963651801;5472.20653005314;5462.562994960394;5767.653940763546;5973.790917317895;5987.0121429964;5997.430244126801;5747.425257474261;5854.6194497357965;5893.7053147342895;5902.645841249518;5909.8227053188475;5217.973910130463;5355.464453554613;5365.463453654643;5378.731063446851;5383;14301.856981430157;14462.638434039232;14513.346899389553;17510.036947967856;24021.357650658414;2431.7081950165916;2435.4879695464465;2450.754924507535;2498.7876030537427;2568.4991426671804;10379.169666426667;10639.787204255872;10705.839412408743;10834.945825270903;10953.068989135932;1928.4889504281377;1978.7130866024345;2023.5851650411778;2044.3849359006367;2051.128270485038;80203.5989820053;83059.58470207671;83513.58243208806;83582.16417835804;84395;10943.890561094446;11036.558537658564;11241.2693174945;11308.09535237179;11312;15929.442469513744;15934.123623200603;15954.20228988546;15978.121203333696;16003.59991000211;7891.921080789119;8201.917980820235;8219.095899451055;8434.915650843535;8437.156284371515;8126.796830079295;8197.4671646344;8202.302804261586;8457.534835584102;8508.404411691246;4758.78585463655;4768.712447639118;4921.26181072842;4934.251472557886;4961.330220420197;1932.4685711429188;2071.2025870040143;2103.4110449074283;2113;2138.1768019312367;1005.5324274212526;1036.8392899100652;1047.9214058945608;1051.6266725312557;1075.1560025380038;19834.404967850987;20214.696779548318;20231.393058208276;20273.594528109355;20399;999.7400675824192;1015.6445244164483;1030.1501261459325;1052.1267348101057;1079.422508957704;10879.075278601407;11177.105831533458;12286.447109880077;12310.384480776105;12395.690107747198;464679;472085;477940;479187;486868;60869.04351217245;63383.68308158522;93100;94902.0509794907;95285;971.2472833554052;980.7253968888723;1039.0440794469107;1039.9740006499746;1043.2540733375522;17226.655466890843;18038;18595.72106418432;18749.531261718566;18752.343667971556;42123;42668.786656067765;43149.78425107854;43743.78128109339;44464.33303500385;59838.70080649569;61927.6903615479;62196;62501.68749156407;62709;5855.970720146372;6585.703643336157;8485.98000903701;8518.574071296534;8851.247643950337;12716.364181790688;13695.315234238049;13716.245606491739;13730.588082357146;13771.173729576258;11756.23584467007;11802.94098529502;12138.33239171854;12255.816162757388;12257.816132758195;11452.484638191134;11513.942430287794;11646.708832278922;11660.416979151178;11674.416279185836;11863.228890122115;12030.338331391857;12182.086343524094;12279.386030698608;12397.380130993595;8574.614142363484;8668.869966950375;8697.347698922733;8713.390062695551;9069.727908162766;10979.1216702662;11822.172447928562;11881.465334060162;11899;12050.819237711617 02:24:46 INFO - PROCESS | 29310 | |3;mootools.html;1483.9554813355596;1521.634807646165;1659.9336026558938;1773.4768243368205;1810.565464288571;8064.31453326468;8720.651173953042;8841.115888411156;9461.716148515547;9487.098725621072;8870.600822962966;9127;9205.677801276957;9214.677486287981;9216.400933939289;2339.976600233997;2367;2379.762023797624;2383.189715496731;2384.141708984764;2284.8971796269125;2343.1798870395396;2353.564590550745;2359.8820058997067;2377.3699969508007;2330.8951097200584;2346.8709220992837;2352.647102934556;2376.5009348036933;2380.75002124777;2306.6540018997284;2308.6998690170253;2317.44381348476;2318.9768102319013;2339.0409931927998;2263.343630347197;2290.874001929893;2291.6104262275453;2293.587154312223;2295.5753185660706;9153.679621213225;9201.585928633227;9258.861117083181;9317.627294908263;9337.953310233406;5191.870203244949;5291.153415453509;5425.430329815352;5426.593005524602;5428.022955867942;3481.547398838135;3583.140046388874;3650.470681751158;3662.7252956028137;3690.225052738928;1148.4315263944402;1200.2678366196612;1213.4204097911197;1226.693326668333;1228.2875931959531;12833.935830320788;12861;12862.099653024292;12884.613461596167;12902.225866447949;4494.505604383515;4638.768061596907;4811.133995880705;4860.4896485869185;4862.17343051682;10828.133749300194;10842.783144337069;10843.295185812896;10847.891521084846;10855.023047925566;5436.945630543723;5453.3455985281225;5472.835814925558;5476.397596264408;5486.615936884459;4215.451991241119;4812.1578723723205;4950.9009819803405;4966.205407134841;5055.266986286968;3925.509311336083;4022.6926248969203;4059.3910913363234;4073.837046518106;4188.5811418857875;1255.6923553729212;1277.310252463678;1278.6931136527353;1301.7006088599676;1315.8684131586956;934.5794392523392;968.5931908598405;1034.1519953637944;1072.8873468285874;1076.5532304093713;6342.270638876496;6442.9355706443275;6466.8682980478225;6644.435223006099;6678;941.5762906692016;975.3660120921317;977.7213494154132;1002.4887307473241;1002.7716047841482;4110.588941105865;4647.256438969748;4671.112488627218;4703.717776933395;4771.642126840501;10648.307859989076;10895.182861285435;11063.778724425467;11330.320180789178;11339.489722962486;11120.221584489009;11200;11256.943715281372;11262.887371126348;11350;8190.5904704764525;8482.491050536988;8486.448380855225;8541.48751074925;8620.181082797124;6177.6911154441195;6252.406021427957;6359.936400636119;6391.424771770563;6416.807495775134;9908.950455247677;10148.492575371054;10233.590656373959;10393.636222732168;10515.57937682484;10492.842607360742;10508.737281568023;10634.149268058381;10644.733881653021;10682.359058456517;7051.753188638373;7443.330100290783;7727.806804829925;7734.071911370672;7948;8571.271441927505;8627.611757471055;8638.740837774876;8667;8700.912990870263;7737.5744334062165;7847.9215207849475;7894.486858354188;8025.638846252049;8102.270795628422;7676.117246516722;7744.419168562267;7814.921850781419;7817.335526480313;7906.7627971160955;7263.0921134858145;7337.229590893093;7353.926460735324;7375.704971801282;7377.151627562899;5499.50504454601;5598.076317407582;5620.578456615688;5640.85897852557;5732.828015159552;5452.6183167177915;5498.3127109111365;5623.437656234344;5636.605437619327;5686.2607860977805 02:24:46 INFO - PROCESS | 29310 | |4;prototype.html;326.55099238546995;332.7304883044734;339.2417945890934;340.3108704872633;341.96922276995065;5464.497263252602;5471.5896307776975;5529.834104976847;5554.833354999347;5564.387917329091;5363.632273770183;5403.432639572838;5405.162199859018;5407.297051383314;5408.91886621701;4059.16787058653;4181.623653871151;4246;4297.570242975693;4301.311790113583;4213.052063285767;4246.171996460692;4256.787160641971;4260.744355338689;4282.657387409;4229.513605935311;4235.686937049509;4239.427677263576;4249.80875860587;4251.3622956556455;4084.2239974404915;4219;4286.87139385819;4312.504062032875;4342.522322544518;3825.3114439400897;3828.942565861514;3832.5784163741964;3839.596842331543;3856.132370216707;5308.203769434615;5310.7610157543;5311.601629877736;5312.73436328182;5325.334333208349;4846.927296090562;4848.927266091011;4895.604752645515;4930.827421040282;4960.503949605047;5656.773729050874;5667.773289068432;5673.546116310686;5682.431756824326;5701.116326969326;4172.895677608054;4178.415021896937;4186.874393768192;4199.286121359346;4200.789960501963;5793.638494953682;5919.1713160157615;5932.932072226998;5975.701214939236;5992.221011268507;4237.978810105929;4240.703150779415;4274.551172126944;4280.400743895857;4292.325992862786;4307.6769242306955;4344.848615116996;4347.695661303742;4355.695101342875;4364.148990946798;4684.718916864931;4901.803927842846;4909.165441874889;4921.237208232658;4964.90070198594;5731.713414329267;5732.398098199629;5745.396733343023;5748.683822389725;5760.946698249851;1463.7657974723993;1476.468471350313;1476.6529865481602;1481.2223582618997;1481.429649584896;944.2540393089382;995.2137811129271;999.9850002249972;1003.8293490106553;1014.3314248061897;5472.069748142825;5490.4469421719095;5536.280283563111;5562.415946325658;5573.216570697338;5820.708964551755;5851.502622277069;5864.853378665567;5875.41245875409;5897.941020589825;5339.199120131933;5514.448555144534;5537.612367134262;5540.750666219949;5577.637453565505;3092.9845350773103;3102.348506813594;3120.719135277836;3130.4208721386617;3139.4192074466296;5840.269966254218;6054.8183554493435;6069.2716873975405;6104.542159338067;6109.7861574844665;5927.229460170151;5938.317093534299;5982.461578457873;5988.3113441953865;5992.310884248367;6082.905077086167;6096.146539484475;6104.633721976696;6112.480439162632;6119.694015299128;5665.745041473226;5710.2576665033275;5796.449337312949;5849.707514624337;5859.56053296013;5768.53851691872;5794.594378393472;5796.188533605215;5797.913031304618;5799.072148456226;5795.449432303924;6029;6083.939160608337;6087.36082711309;6147.770445910746;4178.456800615901;4200.91598168041;4214.199302132585;4243.130158317475;4243.448351714257;5728.684922329146;5967.373425790403;6014.849628759316;6016.548758843017;6053.636781793107;5589.720513974366;5715.8856822864145;5724.141378793214;5732.3121225453215;5742.483176514133;5733.684647344436;5740.741666624928;5761.695321871285;5767.826965191051;5778.959787238337;5650.3219613646625;5658.991058174453;5703.458171473703;5749.942500574941;5758.971205144115;5734.254546908875;5757.165211044459;5765.423457654201;5773.758641892014;5797.304323481209;5470.671759694431;5680.147977803197;5686.289213848269;5700.885982280248;5708.514776244066 02:24:46 INFO - PROCESS | 29310 | |5;yui.html;771.7954741993369;796.7251298302084;826.1779529368278;835.9791005224865;858.974230773077;16560.58598535037;16650.250738716757;17323.13384330785;17367.913160434196;17410.738838917412;15689.764653530206;15763.921180394082;15873.126978016204;15927.52217433476;15965.281562329694;667.4093427316811;795.3478147918709;801.310872649521;821.6302663801283;823.6005537314397;811.5130921447144;815.6207363575936;819.4100247821559;819.573821612761;821.0557858462786;854.2909385210261;860.7503823891064;862.1766213266347;863.201538576817;864.3992425264444;837.4598384042258;847.7965288330787;853.0190281176634;854.598338780772;856.1096459681924;614.5360253008994;617.5461036138435;618.2858798088215;618.5608218165063;619.5105866365566;14258.857411425857;14281.78577321341;14299.213543255117;14545.563633091024;14605.12369257848;15960.600984975352;16132.274047667766;16148.192590370552;16214.189290535543;16609.750853737205;12764.425600847891;12781.16922400041;13016.674583135497;13237.536686216032;13322.067455278135;3952.347862602667;4095.5699651536456;4142.834286628531;4172.269852775752;4177.728447650893;66740;70052.2994770056;83889.58055209745;84056.57971710163;84877.57561212154;12051.638450846489;12281.877181228252;12371.381430928417;12705.491780328868;12730.23618582888;20691.06890189945;20805.375838724864;20876.686849697267;20958.895205523873;20992.370228893156;8849.20357167858;8883.955580222058;8906;9034.774130646787;9058;4937.7777999990085;5083.669561478492;5098.515641014098;5145.382554093533;5235.816746413933;3492.6158122606494;3554.3779838528153;3609.9278014439565;3615.331163734665;3618.7466877318334;601.5758889982552;605.636618029179;605.9454649081604;609.2567068176817;622.7228883147046;754.0954327614763;769.7451519429355;770.9614519274014;792.3542313014874;809.8785182222714;9878.851817222747;10634.46827658614;10779.67660970172;10984.286021408743;11128.554857805759;746.119578896896;751.2825251884437;769.4421544380391;773.9922600774033;777.7744454108246;4833.854984350475;5119.180931051014;5153.768080436389;5194.92207616886;5244.895102097937;90162.54918725364;124840;131130;132651;133387;109751;110511.44744276228;111040;111795;112491;81029.59485202536;94830.52584737031;94971.52514237385;100488.49755751321;100622;9812.252569280612;11059.50232239535;11161.944190278997;11257.268277561932;11325.830112548483;45807.54192458166;46042.53957460383;54958.17562736482;55889.44110558843;57069.42930570641;48518.51481485281;72573.637131814;73087.26912730804;77140;77870;14513.564593062225;14802.77795833085;14850.777238341218;15014.92492537574;15172.924135379253;15312.770308445604;15613.297401617181;16027.198640068184;16222.35110595563;16466;14074.437022518985;14228.857711422754;14287.71424571482;15171.468998584996;15690.215489225266;14221.217833018869;14403.567892963229;14867;14898.106113633217;15364.692706145592;14422.495212667507;14658.63353416173;15053.849461505682;15095.4716584919;15250.694986100438;11531.654050378502;11680.591179308683;11707.131752720297;12086.335251561248;12113.091518136;10782.460876956278;11852.348120853436;12456.505219373734;12504.499820007099;12968 02:24:46 INFO - PROCESS | 29310 | __end_tp_report 02:24:46 INFO - PROCESS | 29310 | __start_cc_report 02:24:46 INFO - PROCESS | 29310 | _x_x_mozilla_cycle_collect,322 02:24:46 INFO - PROCESS | 29310 | __end_cc_report 02:24:46 INFO - PROCESS | 29310 | __startTimestamp1470821086361__endTimestamp 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | ------- Summary: start ------- 02:24:46 INFO - PROCESS | 29310 | Number of tests: 6 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | [#0] dojo.html Cycles:165 Average:5370.57 Median:5590.27 stddev:601.74 (10.8%) stddev-sans-first:576.47 02:24:46 INFO - PROCESS | 29310 | Values: 3093.8 3106.4 3134.1 3145.1 3145.2 5259.9 5387.6 5459.1 5467.4 5471.0 5439.5 5439.6 5472.4 5493.8 5500.4 4899.8 4985.1 5014.4 5016.3 5046.6 4960.5 4972.7 5040.4 5046.8 5070.5 4830.4 4908.8 4917.5 4988.4 5027.2 4916.4 4926.1 4934.5 4945.1 4973.0 4935.2 4946.8 4957.8 4966.1 5012.6 5239.4 5252.9 5271.8 5341.9 5410.7 5733.8 5744.4 5751.9 5753.1 5753.8 5751.6 5756.5 5762.6 5769.7 5771.3 5274.9 5339.7 5395.2 5395.5 5461.9 5871.4 5877.8 5879.3 5913.4 5923.0 5633.2 5638.3 5640.2 5695.1 5705.8 5567.6 5664.3 5677.9 5696.7 5802.0 5685.8 5702.0 5733.8 5741.5 5743.4 5666.7 5719.0 5721.6 5751.3 5754.3 4345.5 4372.5 4381.0 4399.8 4430.1 3920.2 3921.8 3923.2 3944.9 3955.4 5422.7 5429.4 5463.8 5477.3 5480.6 5542.3 5622.4 5673.6 5764.1 5820.4 5437.9 5473.1 5483.5 5484.4 5517.6 4934.0 4976.2 4978.3 4984.7 4998.4 5837.7 5839.5 5889.0 5909.1 5979.9 5722.9 5741.7 5743.8 5757.9 5768.1 5915.2 5949.3 5949.3 5956.6 5963.6 5604.8 5712.5 5723.6 5750.9 5809.3 5808.4 5819.1 5839.9 5851.4 5856.2 5547.4 5702.0 5705.4 5712.2 5731.5 5644.5 5659.3 5751.5 5776.4 5799.2 5735.2 5744.0 5746.8 5750.8 5773.6 5493.5 5751.8 5764.2 5822.7 5823.4 5505.0 5517.3 5579.8 5590.3 5664.2 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | [#1] ext.html Cycles:180 Average:60870.31 Median:4174.13 stddev:120962.91 (2897.9%) stddev-sans-first:121217.49 02:24:46 INFO - PROCESS | 29310 | Values: 559.0 574.0 578.6 578.6 596.7 41492.0 42472.4 42480.6 42548.6 42582.4 42490.8 42673.4 43017.4 43066.8 43080.4 8835.6 8927.0 8938.6 8964.6 8989.7 8811.9 8817.3 8842.5 8859.6 8865.3 8864.4 8929.6 8951.7 8961.5 8976.9 8843.3 8859.5 8922.6 8926.2 8927.0 8795.8 8897.0 8916.7 8932.0 8955.1 40005.2 40323.0 40461.8 40517.8 40557.2 3588.0 3717.7 3753.3 3754.9 4118.8 31331.0 32419.8 32615.3 32748.3 32809.0 3998.0 4168.1 4180.1 4199.2 4295.4 362254.0 366012.0 366173.0 367005.0 367150.0 62198.0 62448.4 62955.4 63041.0 63141.0 36685.6 37376.6 37411.6 39549.4 58146.7 17465.8 17547.4 17672.7 17684.3 17696.3 13331.3 13488.3 13489.7 13497.5 13509.9 19064.2 19081.5 19191.2 19260.5 19497.0 7250.7 7302.5 7315.8 7321.3 7363.5 948.3 1024.2 1031.1 1041.0 1078.7 33155.3 33193.8 33249.2 33558.7 33865.8 1125.4 1134.2 1161.6 1183.4 1218.3 17397.1 17551.2 17559.8 17606.5 17682.6 542436.0 544592.0 547837.0 549581.0 554432.0 58428.4 58905.7 58969.1 58970.1 59014.4 1334.6 1350.4 1379.4 1390.3 1404.7 31021.2 32584.7 32703.7 33109.3 33196.5 51815.5 52077.0 52181.7 52214.0 52253.5 434105.0 436399.0 436402.0 437037.0 438742.0 28953.1 29043.6 29098.7 29350.4 29514.0 48201.8 48263.8 48818.5 48846.8 50069.0 41425.6 41863.4 42218.2 43184.6 43452.3 41351.2 41832.0 42321.8 42620.1 43036.0 36118.6 41248.4 41360.0 41926.4 42088.8 35741.5 37940.0 38104.6 38270.8 38471.6 28834.6 28969.7 28986.3 29431.0 29621.9 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | [#2] jquery.html Cycles:180 Average:28517.75 Median:13079.77 stddev:78504.12 (600.2%) stddev-sans-first:78695.91 02:24:46 INFO - PROCESS | 29310 | Values: 378.6 381.5 391.0 391.4 408.6 18549.8 19962.2 20474.9 20481.4 20583.9 18534.2 19040.9 19172.9 19211.5 19400.6 5334.5 5401.8 5466.6 5469.4 5516.0 5442.6 5453.4 5458.7 5460.7 5472.2 5462.6 5767.7 5973.8 5987.0 5997.4 5747.4 5854.6 5893.7 5902.6 5909.8 5218.0 5355.5 5365.5 5378.7 5383.0 14301.9 14462.6 14513.3 17510.0 24021.4 2431.7 2435.5 2450.8 2498.8 2568.5 10379.2 10639.8 10705.8 10834.9 10953.1 1928.5 1978.7 2023.6 2044.4 2051.1 80203.6 83059.6 83513.6 83582.2 84395.0 10943.9 11036.6 11241.3 11308.1 11312.0 15929.4 15934.1 15954.2 15978.1 16003.6 7891.9 8201.9 8219.1 8434.9 8437.2 8126.8 8197.5 8202.3 8457.5 8508.4 4758.8 4768.7 4921.3 4934.3 4961.3 1932.5 2071.2 2103.4 2113.0 2138.2 1005.5 1036.8 1047.9 1051.6 1075.2 19834.4 20214.7 20231.4 20273.6 20399.0 999.7 1015.6 1030.2 1052.1 1079.4 10879.1 11177.1 12286.4 12310.4 12395.7 464679.0 472085.0 477940.0 479187.0 486868.0 60869.0 63383.7 93100.0 94902.1 95285.0 971.2 980.7 1039.0 1040.0 1043.3 17226.7 18038.0 18595.7 18749.5 18752.3 42123.0 42668.8 43149.8 43743.8 44464.3 59838.7 61927.7 62196.0 62501.7 62709.0 5856.0 6585.7 8486.0 8518.6 8851.2 12716.4 13695.3 13716.2 13730.6 13771.2 11756.2 11802.9 12138.3 12255.8 12257.8 11452.5 11513.9 11646.7 11660.4 11674.4 11863.2 12030.3 12182.1 12279.4 12397.4 8574.6 8668.9 8697.3 8713.4 9069.7 10979.1 11822.2 11881.5 11899.0 12050.8 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | [#3] mootools.html Cycles:180 Average:6008.92 Median:4737.68 stddev:3400.21 (71.8%) stddev-sans-first:3392.75 02:24:46 INFO - PROCESS | 29310 | Values: 1484.0 1521.6 1659.9 1773.5 1810.6 8064.3 8720.7 8841.1 9461.7 9487.1 8870.6 9127.0 9205.7 9214.7 9216.4 2340.0 2367.0 2379.8 2383.2 2384.1 2284.9 2343.2 2353.6 2359.9 2377.4 2330.9 2346.9 2352.6 2376.5 2380.8 2306.7 2308.7 2317.4 2319.0 2339.0 2263.3 2290.9 2291.6 2293.6 2295.6 9153.7 9201.6 9258.9 9317.6 9338.0 5191.9 5291.2 5425.4 5426.6 5428.0 3481.5 3583.1 3650.5 3662.7 3690.2 1148.4 1200.3 1213.4 1226.7 1228.3 12833.9 12861.0 12862.1 12884.6 12902.2 4494.5 4638.8 4811.1 4860.5 4862.2 10828.1 10842.8 10843.3 10847.9 10855.0 5436.9 5453.3 5472.8 5476.4 5486.6 4215.5 4812.2 4950.9 4966.2 5055.3 3925.5 4022.7 4059.4 4073.8 4188.6 1255.7 1277.3 1278.7 1301.7 1315.9 934.6 968.6 1034.2 1072.9 1076.6 6342.3 6442.9 6466.9 6644.4 6678.0 941.6 975.4 977.7 1002.5 1002.8 4110.6 4647.3 4671.1 4703.7 4771.6 10648.3 10895.2 11063.8 11330.3 11339.5 11120.2 11200.0 11256.9 11262.9 11350.0 8190.6 8482.5 8486.4 8541.5 8620.2 6177.7 6252.4 6359.9 6391.4 6416.8 9909.0 10148.5 10233.6 10393.6 10515.6 10492.8 10508.7 10634.1 10644.7 10682.4 7051.8 7443.3 7727.8 7734.1 7948.0 8571.3 8627.6 8638.7 8667.0 8700.9 7737.6 7847.9 7894.5 8025.6 8102.3 7676.1 7744.4 7814.9 7817.3 7906.8 7263.1 7337.2 7353.9 7375.7 7377.2 5499.5 5598.1 5620.6 5640.9 5732.8 5452.6 5498.3 5623.4 5636.6 5686.3 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | [#4] prototype.html Cycles:180 Average:4838.84 Median:5536.95 stddev:1413.65 (25.5%) stddev-sans-first:1376.45 02:24:46 INFO - PROCESS | 29310 | Values: 326.6 332.7 339.2 340.3 342.0 5464.5 5471.6 5529.8 5554.8 5564.4 5363.6 5403.4 5405.2 5407.3 5408.9 4059.2 4181.6 4246.0 4297.6 4301.3 4213.1 4246.2 4256.8 4260.7 4282.7 4229.5 4235.7 4239.4 4249.8 4251.4 4084.2 4219.0 4286.9 4312.5 4342.5 3825.3 3828.9 3832.6 3839.6 3856.1 5308.2 5310.8 5311.6 5312.7 5325.3 4846.9 4848.9 4895.6 4930.8 4960.5 5656.8 5667.8 5673.5 5682.4 5701.1 4172.9 4178.4 4186.9 4199.3 4200.8 5793.6 5919.2 5932.9 5975.7 5992.2 4238.0 4240.7 4274.6 4280.4 4292.3 4307.7 4344.8 4347.7 4355.7 4364.1 4684.7 4901.8 4909.2 4921.2 4964.9 5731.7 5732.4 5745.4 5748.7 5760.9 1463.8 1476.5 1476.7 1481.2 1481.4 944.3 995.2 1000.0 1003.8 1014.3 5472.1 5490.4 5536.3 5562.4 5573.2 5820.7 5851.5 5864.9 5875.4 5897.9 5339.2 5514.4 5537.6 5540.8 5577.6 3093.0 3102.3 3120.7 3130.4 3139.4 5840.3 6054.8 6069.3 6104.5 6109.8 5927.2 5938.3 5982.5 5988.3 5992.3 6082.9 6096.1 6104.6 6112.5 6119.7 5665.7 5710.3 5796.4 5849.7 5859.6 5768.5 5794.6 5796.2 5797.9 5799.1 5795.4 6029.0 6083.9 6087.4 6147.8 4178.5 4200.9 4214.2 4243.1 4243.4 5728.7 5967.4 6014.8 6016.5 6053.6 5589.7 5715.9 5724.1 5732.3 5742.5 5733.7 5740.7 5761.7 5767.8 5779.0 5650.3 5659.0 5703.5 5749.9 5759.0 5734.3 5757.2 5765.4 5773.8 5797.3 5470.7 5680.1 5686.3 5700.9 5708.5 02:24:46 INFO - PROCESS | 29310 | 02:24:46 INFO - PROCESS | 29310 | [#5] yui.html Cycles:180 Average:21997.44 Median:3582.15 stddev:31970.78 (892.5%) stddev-sans-first:32020.75 02:24:46 INFO - PROCESS | 29310 | Values: 771.8 796.7 826.2 836.0 859.0 16560.6 16650.3 17323.1 17367.9 17410.7 15689.8 15763.9 15873.1 15927.5 15965.3 667.4 795.3 801.3 821.6 823.6 811.5 815.6 819.4 819.6 821.1 854.3 860.8 862.2 863.2 864.4 837.5 847.8 853.0 854.6 856.1 614.5 617.5 618.3 618.6 619.5 14258.9 14281.8 14299.2 14545.6 14605.1 15960.6 16132.3 16148.2 16214.2 16609.8 12764.4 12781.2 13016.7 13237.5 13322.1 3952.3 4095.6 4142.8 4172.3 4177.7 66740.0 70052.3 83889.6 84056.6 84877.6 12051.6 12281.9 12371.4 12705.5 12730.2 20691.1 20805.4 20876.7 20958.9 20992.4 8849.2 8884.0 8906.0 9034.8 9058.0 4937.8 5083.7 5098.5 5145.4 5235.8 3492.6 3554.4 3609.9 3615.3 3618.7 601.6 605.6 605.9 609.3 622.7 754.1 769.7 771.0 792.4 809.9 9878.9 10634.5 10779.7 10984.3 11128.6 746.1 751.3 769.4 774.0 777.8 4833.9 5119.2 5153.8 5194.9 5244.9 90162.5 124840.0 131130.0 132651.0 133387.0 109751.0 110511.4 111040.0 111795.0 112491.0 81029.6 94830.5 94971.5 100488.5 100622.0 9812.3 11059.5 11161.9 11257.3 11325.8 45807.5 46042.5 54958.2 55889.4 57069.4 48518.5 72573.6 73087.3 77140.0 77870.0 14513.6 14802.8 14850.8 15014.9 15172.9 15312.8 15613.3 16027.2 16222.4 16466.0 14074.4 14228.9 14287.7 15171.5 15690.2 14221.2 14403.6 14867.0 14898.1 15364.7 14422.5 14658.6 15053.8 15095.5 15250.7 11531.7 11680.6 11707.1 12086.3 12113.1 10782.5 11852.3 12456.5 12504.5 12968.0 02:24:46 INFO - PROCESS | 29310 | -------- Summary: end -------- 02:24:46 INFO - PROCESS | 29310 | 02:24:47 INFO - TEST-INFO | 29310: exit 0 02:24:47 INFO - TEST-OK | dromaeo_css | took 1113124ms 02:24:47 INFO - TEST-START | kraken 02:24:47 INFO - operating with platform_type : linux_ 02:24:47 INFO - Initialising browser for kraken test... 02:24:47 INFO - TEST-INFO | started process 29558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvqgfg/profile http://localhost:37239/getInfo.html) 02:24:51 INFO - PROCESS | 29558 | __metrics Screen width/height:1600/1200 02:24:51 INFO - PROCESS | 29558 | colorDepth:24 02:24:51 INFO - PROCESS | 29558 | Browser inner width/height: 1024/697 02:24:51 INFO - PROCESS | 29558 | __metrics 02:24:52 ERROR - PROCESS | 29558 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:24:53 INFO - TEST-INFO | 29558: exit 0 02:24:53 INFO - Browser initialized. 02:24:53 INFO - Running cycle 1/1 for kraken test... 02:24:53 INFO - TEST-INFO | started process 29678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQvqgfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:04 INFO - PROCESS | 29678 | RSS: Main: 162840576 02:25:04 INFO - PROCESS | 29678 | 02:25:07 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:08 INFO - PROCESS | 29678 | RSS: Main: 168525824 02:25:08 INFO - PROCESS | 29678 | 02:25:10 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-dft) 02:25:11 INFO - PROCESS | 29678 | RSS: Main: 167280640 02:25:11 INFO - PROCESS | 29678 | 02:25:14 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-fft) 02:25:15 INFO - PROCESS | 29678 | RSS: Main: 163098624 02:25:15 INFO - PROCESS | 29678 | 02:25:17 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-oscillator) 02:25:17 INFO - PROCESS | 29678 | RSS: Main: 164536320 02:25:17 INFO - PROCESS | 29678 | 02:25:20 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:20 INFO - PROCESS | 29678 | RSS: Main: 164532224 02:25:20 INFO - PROCESS | 29678 | 02:25:23 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37239/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:24 INFO - PROCESS | 29678 | RSS: Main: 164872192 02:25:24 INFO - PROCESS | 29678 | 02:25:27 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37239/tests/kraken/driver.html?testName=imaging-desaturate) 02:25:28 INFO - PROCESS | 29678 | RSS: Main: 162734080 02:25:28 INFO - PROCESS | 29678 | 02:25:31 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37239/tests/kraken/driver.html?testName=json-parse-financial) 02:25:32 INFO - PROCESS | 29678 | RSS: Main: 163704832 02:25:32 INFO - PROCESS | 29678 | 02:25:33 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:25:34 INFO - PROCESS | 29678 | RSS: Main: 163819520 02:25:34 INFO - PROCESS | 29678 | 02:25:36 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:25:36 INFO - PROCESS | 29678 | RSS: Main: 164192256 02:25:36 INFO - PROCESS | 29678 | 02:25:38 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:25:39 INFO - PROCESS | 29678 | RSS: Main: 165154816 02:25:39 INFO - PROCESS | 29678 | 02:25:42 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:25:42 INFO - PROCESS | 29678 | RSS: Main: 165335040 02:25:42 INFO - PROCESS | 29678 | 02:25:45 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:25:46 INFO - PROCESS | 29678 | RSS: Main: 165318656 02:25:46 INFO - PROCESS | 29678 | 02:25:47 INFO - PROCESS | 29678 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37239/tests/kraken/driver.html?testName=ai-astar) 02:25:48 INFO - PROCESS | 29678 | RSS: Main: 165961728 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | __start_tp_report 02:25:48 INFO - PROCESS | 29678 | _x_x_mozilla_page_load 02:25:48 INFO - PROCESS | 29678 | _x_x_mozilla_page_load_details 02:25:48 INFO - PROCESS | 29678 | |i|pagename|runs| 02:25:48 INFO - PROCESS | 29678 | |0;ai-astar;102;112;106;111;111;115;112;111;112;111 02:25:48 INFO - PROCESS | 29678 | |1;audio-beat-detection;151;119;149;183;123;150;146;119;183;118 02:25:48 INFO - PROCESS | 29678 | |2;audio-dft;161;161;164;165;162;166;170;165;162;164 02:25:48 INFO - PROCESS | 29678 | |3;audio-fft;74;75;75;173;77;76;75;76;170;76 02:25:48 INFO - PROCESS | 29678 | |4;audio-oscillator;83;84;155;85;85;84;141;84;84;158 02:25:48 INFO - PROCESS | 29678 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;117;118;118 02:25:48 INFO - PROCESS | 29678 | |6;imaging-darkroom;147;150;149;151;150;147;147;147;147;148 02:25:48 INFO - PROCESS | 29678 | |7;imaging-desaturate;97;96;95;95;94;96;95;96;94;95 02:25:48 INFO - PROCESS | 29678 | |8;json-parse-financial;53;51;52;50;51;51;51;52;50;50 02:25:48 INFO - PROCESS | 29678 | |9;json-stringify-tinderbox;61;63;62;61;63;62;63;62;62;62 02:25:48 INFO - PROCESS | 29678 | |10;stanford-crypto-aes;76;88;79;78;77;76;86;77;81;81 02:25:48 INFO - PROCESS | 29678 | |11;stanford-crypto-ccm;125;131;123;130;126;136;123;130;152;142 02:25:48 INFO - PROCESS | 29678 | |12;stanford-crypto-pbkdf2;157;167;158;159;160;161;166;162;162;162 02:25:48 INFO - PROCESS | 29678 | |13;stanford-crypto-sha256-iterative;66;64;64;67;64;72;65;62;62;63 02:25:48 INFO - PROCESS | 29678 | __end_tp_report 02:25:48 INFO - PROCESS | 29678 | __start_cc_report 02:25:48 INFO - PROCESS | 29678 | _x_x_mozilla_cycle_collect,876 02:25:48 INFO - PROCESS | 29678 | __end_cc_report 02:25:48 INFO - PROCESS | 29678 | __startTimestamp1470821147999__endTimestamp 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | ------- Summary: start ------- 02:25:48 INFO - PROCESS | 29678 | Number of tests: 14 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.65 (3.3%) stddev-sans-first:2.33 02:25:48 INFO - PROCESS | 29678 | Values: 102.0 112.0 106.0 111.0 111.0 115.0 112.0 111.0 112.0 111.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:149.50 stddev:24.77 (16.6%) stddev-sans-first:26.15 02:25:48 INFO - PROCESS | 29678 | Values: 151.0 119.0 149.0 183.0 123.0 150.0 146.0 119.0 183.0 118.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:2.75 (1.7%) stddev-sans-first:2.69 02:25:48 INFO - PROCESS | 29678 | Values: 161.0 161.0 164.0 165.0 162.0 166.0 170.0 165.0 162.0 164.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:40.49 (53.6%) stddev-sans-first:42.25 02:25:48 INFO - PROCESS | 29678 | Values: 74.0 75.0 75.0 173.0 77.0 76.0 75.0 76.0 170.0 76.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:84.00 stddev:32.74 (39.0%) stddev-sans-first:33.81 02:25:48 INFO - PROCESS | 29678 | Values: 83.0 84.0 155.0 85.0 85.0 84.0 141.0 84.0 84.0 158.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:25:48 INFO - PROCESS | 29678 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.57 (1.1%) stddev-sans-first:1.59 02:25:48 INFO - PROCESS | 29678 | Values: 147.0 150.0 149.0 151.0 150.0 147.0 147.0 147.0 147.0 148.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.95 (1.0%) stddev-sans-first:0.78 02:25:48 INFO - PROCESS | 29678 | Values: 97.0 96.0 95.0 95.0 94.0 96.0 95.0 96.0 94.0 95.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.99 (1.9%) stddev-sans-first:0.78 02:25:48 INFO - PROCESS | 29678 | Values: 53.0 51.0 52.0 50.0 51.0 51.0 51.0 52.0 50.0 50.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 02:25:48 INFO - PROCESS | 29678 | Values: 61.0 63.0 62.0 61.0 63.0 62.0 63.0 62.0 62.0 62.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:4.18 (5.2%) stddev-sans-first:4.18 02:25:48 INFO - PROCESS | 29678 | Values: 76.0 88.0 79.0 78.0 77.0 76.0 86.0 77.0 81.0 81.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:130.50 stddev:9.26 (7.1%) stddev-sans-first:9.49 02:25:48 INFO - PROCESS | 29678 | Values: 125.0 131.0 123.0 130.0 126.0 136.0 123.0 130.0 152.0 142.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:3.20 (2.0%) stddev-sans-first:2.98 02:25:48 INFO - PROCESS | 29678 | Values: 157.0 167.0 158.0 159.0 160.0 161.0 166.0 162.0 162.0 162.0 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - PROCESS | 29678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:2.96 (4.6%) stddev-sans-first:3.11 02:25:48 INFO - PROCESS | 29678 | Values: 66.0 64.0 64.0 67.0 64.0 72.0 65.0 62.0 62.0 63.0 02:25:48 INFO - PROCESS | 29678 | -------- Summary: end -------- 02:25:48 INFO - PROCESS | 29678 | 02:25:48 INFO - TEST-INFO | 29678: exit 0 02:25:49 INFO - TEST-OK | kraken | took 61940ms 02:25:49 INFO - SUITE-END | took 1175s 02:25:49 INFO - Completed test suite (00:19:35) 02:25:49 INFO - javascript benchmark 02:25:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7430.172850381037, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.783435159539, 3106.440840648685, 3134.0754477429164, 3145.056483055083, 3145.1979745164995, 5259.894802103956, 5387.649802762822, 5459.12653975364, 5467.398586155525, 5470.972645136773, 5439.456054394558, 5439.564834813215, 5472.370677372103, 5493.807716729915, 5500.367457742351, 4899.804007839691, 4985.102681517325, 5014.448410674823, 5016.27264046713, 5046.646734728571, 4960.528749768784, 4972.726500042496, 5040.42035165957, 5046.798128074873, 5070.467600901889, 4830.420349558058, 4908.828191013297, 4917.532834380728, 4988.401391832967, 5027.220780778966, 4916.360873086512, 4926.088673595396, 4934.4572097069295, 4945.060438516706, 4972.975135124338, 4935.2350385689915, 4946.826861059882, 4957.7769000395065, 4966.106100901836, 5012.624053196025, 5239.449857764918, 5252.947470525284, 5271.841844744664, 5341.919871201935, 5410.675359478444, 5733.799317023926, 5744.368119506851, 5751.913721294184, 5753.050746626802, 5753.827385178452, 5751.568632352591, 5756.481916627524, 5762.625429347079, 5769.701817091163, 5771.307443106854, 5274.947250527484, 5339.652922560022, 5395.190721391744, 5395.4604539545735, 5461.9453805462235, 5871.3541510433815, 5877.794277200277, 5879.265091863517, 5913.438223368773, 5922.970385148046, 5633.239512665819, 5638.295213098363, 5640.210370548127, 5695.145728140812, 5705.771769129271, 5567.582431317667, 5664.348599911063, 5677.914831277534, 5696.658200507983, 5802.0, 5685.829425117253, 5702.0, 5733.77064917407, 5741.540676745851, 5743.396943320975, 5666.688332141772, 5718.971405142947, 5721.5708821838525, 5751.309842818889, 5754.338251101177, 4345.521992580813, 4372.519022907478, 4380.9780951095045, 4399.824007039682, 4430.091831174666, 3920.196359746245, 3921.8235179416993, 3923.2103343101694, 3944.9211015779524, 3955.3869150281753, 5422.701751403711, 5429.4027656957705, 5463.754131064112, 5477.260569823103, 5480.6437581557075, 5542.307211598551, 5622.437756224344, 5673.631213971161, 5764.135379692996, 5820.447057529528, 5437.918431223535, 5473.0969390051, 5483.479069488472, 5484.396716361197, 5517.586181036358, 4934.037862616755, 4976.154053810861, 4978.327925730053, 4984.7258400788305, 4998.375203099613, 5837.678927658934, 5839.532837373, 5888.9705551472825, 5909.0840919658385, 5979.940200598112, 5722.885542289214, 5741.684207368635, 5743.770249190153, 5757.91363129545, 5768.077107662753, 5915.171875937458, 5949.25634295713, 5949.315828679757, 5956.583039187215, 5963.642181469126, 5604.8318550443555, 5712.485876271156, 5723.599348045597, 5750.913736293875, 5809.2738407699035, 5808.390119037609, 5819.098039803837, 5839.912401313899, 5851.385604511465, 5856.209411729533, 5547.445255474582, 5702.030654788613, 5705.4009329019855, 5712.228849105484, 5731.484166425042, 5644.463775941279, 5659.320881494247, 5751.482366587027, 5776.393478684678, 5799.217105690846, 5735.168400581809, 5743.971280143573, 5746.770129194785, 5750.7987220447085, 5773.566982476415, 5493.450654934474, 5751.827445176651, 5764.193012978102, 5822.70886455684, 5823.4467725566, 5505.0, 5517.337919449692, 5579.804706835242, 5590.273264475755, 5664.178694089416], "value": 5330.136755425825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9608727389082, 573.9569532285079, 578.5602941764259, 578.6296770067155, 596.731470838123, 41492.0, 42472.36291455631, 42480.57519424805, 42548.57451425485, 42582.36126458106, 42490.78754606222, 42673.359899601455, 43017.35473967893, 43066.7846660767, 43080.3537946931, 8835.646574137027, 8927.0, 8938.597763100675, 8964.641414343418, 8989.685361012365, 8811.911880881205, 8817.338699597556, 8842.469451832878, 8859.5570221489, 8865.335099867503, 8864.379493435463, 8929.642814287421, 8951.73144805657, 8961.507117108556, 8976.910230897673, 8843.292536597057, 8859.512726800023, 8922.598483068212, 8926.2412694921, 8926.955365223164, 8795.78010549735, 8896.955515222382, 8916.687915922912, 8932.0, 8955.104489551059, 40005.19989600192, 40323.0, 40461.79769101136, 40517.79741101305, 40557.18885622301, 3587.982060089683, 3717.665410113103, 3753.305638456894, 3754.924901501982, 4118.75287482752, 31331.0, 32419.837900810344, 32615.347693046006, 32748.345033099442, 32809.0, 3997.960020399788, 4168.124693814302, 4180.143070670505, 4199.202151591188, 4295.4415925929425, 362254.0, 366012.0, 366173.0, 367005.0, 367150.0, 62198.0, 62448.375516244254, 62955.37044629495, 63041.0, 63141.0, 36685.63314366822, 37376.62623373731, 37411.625883741355, 39549.406758898636, 58146.70926645424, 17465.825341746673, 17547.385841495485, 17672.734908976374, 17684.29262829498, 17696.29214831418, 13331.333433328295, 13488.258145802076, 13489.662758431117, 13497.460101596023, 13509.86490135086, 19064.237430502624, 19081.522961925784, 19191.232350705814, 19260.518487037934, 19497.0, 7250.673719682627, 7302.531297633582, 7315.817104572322, 7321.267873212636, 7363.521371110861, 948.2698322291934, 1024.2011231239644, 1031.097789434245, 1040.9739756506149, 1078.6710053433778, 33155.336893262, 33193.83403083018, 33249.16877078044, 33558.66441335604, 33865.83067084649, 1125.386664267976, 1134.1720544002924, 1161.6108603617713, 1183.360985068071, 1218.2994778002683, 17397.130143492774, 17551.210195541233, 17559.824401756076, 17606.471805845846, 17682.646347072987, 542436.0, 544592.0, 547837.0, 549581.0, 554432.0, 58428.4157158423, 58905.70547147237, 58969.115463268085, 58970.11544826831, 59014.40985590175, 1334.5996201139812, 1350.3518311210673, 1379.4482207117032, 1390.2562129260998, 1404.7120340330207, 31021.224469388446, 32584.67415325911, 32703.672963270063, 33109.337813244085, 33196.50205246875, 51815.48184518257, 52077.0, 52181.7390913043, 52214.0, 52253.47746522638, 434105.0, 436399.0, 436402.0, 437037.0, 438742.0, 28953.13140605785, 29043.564346534396, 29098.7090129096, 29350.41299174047, 29514.0, 48201.75899120482, 48263.75868120637, 48818.51181488282, 48846.755766220944, 50068.99310068964, 41425.585744142176, 41863.37204941867, 42218.155636887706, 43184.568154318054, 43452.34821477617, 41351.172976539696, 41832.0, 42321.788391057846, 42620.14759704727, 43036.0, 36118.638813612575, 41248.38127428031, 41360.0, 41926.37110443407, 42088.78955605203, 35741.46387804133, 37940.0, 38104.61895381011, 38270.80864595659, 38471.615283847925, 28834.567481488215, 28969.7103028967, 28986.27534311659, 29431.0, 29621.851890740407], "value": 20216.200222646068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6289436352375, 381.5326225373917, 390.99413508797375, 391.43083840253917, 408.5505943462192, 18549.814501854977, 19962.201511939504, 20474.89762551185, 20481.385558433252, 20583.897080514576, 18534.165962531686, 19040.90479547604, 19172.904135479337, 19211.519712007208, 19400.611987760236, 5334.466553344673, 5401.837944861661, 5466.562674985991, 5469.398366179717, 5516.0, 5442.591805614575, 5453.3728621208475, 5458.6724796512335, 5460.726963651801, 5472.20653005314, 5462.562994960394, 5767.653940763546, 5973.790917317895, 5987.0121429964, 5997.430244126801, 5747.425257474261, 5854.6194497357965, 5893.7053147342895, 5902.645841249518, 5909.8227053188475, 5217.973910130463, 5355.464453554613, 5365.463453654643, 5378.731063446851, 5383.0, 14301.856981430157, 14462.638434039232, 14513.346899389553, 17510.036947967856, 24021.357650658414, 2431.7081950165916, 2435.4879695464465, 2450.754924507535, 2498.7876030537427, 2568.4991426671804, 10379.169666426667, 10639.787204255872, 10705.839412408743, 10834.945825270903, 10953.068989135932, 1928.4889504281377, 1978.7130866024345, 2023.5851650411778, 2044.3849359006367, 2051.128270485038, 80203.5989820053, 83059.58470207671, 83513.58243208806, 83582.16417835804, 84395.0, 10943.890561094446, 11036.558537658564, 11241.2693174945, 11308.09535237179, 11312.0, 15929.442469513744, 15934.123623200603, 15954.20228988546, 15978.121203333696, 16003.59991000211, 7891.921080789119, 8201.917980820235, 8219.095899451055, 8434.915650843535, 8437.156284371515, 8126.796830079295, 8197.4671646344, 8202.302804261586, 8457.534835584102, 8508.404411691246, 4758.78585463655, 4768.712447639118, 4921.26181072842, 4934.251472557886, 4961.330220420197, 1932.4685711429188, 2071.2025870040143, 2103.4110449074283, 2113.0, 2138.1768019312367, 1005.5324274212526, 1036.8392899100652, 1047.9214058945608, 1051.6266725312557, 1075.1560025380038, 19834.404967850987, 20214.696779548318, 20231.393058208276, 20273.594528109355, 20399.0, 999.7400675824192, 1015.6445244164483, 1030.1501261459325, 1052.1267348101057, 1079.422508957704, 10879.075278601407, 11177.105831533458, 12286.447109880077, 12310.384480776105, 12395.690107747198, 464679.0, 472085.0, 477940.0, 479187.0, 486868.0, 60869.04351217245, 63383.68308158522, 93100.0, 94902.0509794907, 95285.0, 971.2472833554052, 980.7253968888723, 1039.0440794469107, 1039.9740006499746, 1043.2540733375522, 17226.655466890843, 18038.0, 18595.72106418432, 18749.531261718566, 18752.343667971556, 42123.0, 42668.786656067765, 43149.78425107854, 43743.78128109339, 44464.33303500385, 59838.70080649569, 61927.6903615479, 62196.0, 62501.68749156407, 62709.0, 5855.970720146372, 6585.703643336157, 8485.98000903701, 8518.574071296534, 8851.247643950337, 12716.364181790688, 13695.315234238049, 13716.245606491739, 13730.588082357146, 13771.173729576258, 11756.23584467007, 11802.94098529502, 12138.33239171854, 12255.816162757388, 12257.816132758195, 11452.484638191134, 11513.942430287794, 11646.708832278922, 11660.416979151178, 11674.416279185836, 11863.228890122115, 12030.338331391857, 12182.086343524094, 12279.386030698608, 12397.380130993595, 8574.614142363484, 8668.869966950375, 8697.347698922733, 8713.390062695551, 9069.727908162766, 10979.1216702662, 11822.172447928562, 11881.465334060162, 11899.0, 12050.819237711617], "value": 9275.31492183489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.9554813355596, 1521.634807646165, 1659.9336026558938, 1773.4768243368205, 1810.565464288571, 8064.31453326468, 8720.651173953042, 8841.115888411156, 9461.716148515547, 9487.098725621072, 8870.600822962966, 9127.0, 9205.677801276957, 9214.677486287981, 9216.400933939289, 2339.976600233997, 2367.0, 2379.762023797624, 2383.189715496731, 2384.141708984764, 2284.8971796269125, 2343.1798870395396, 2353.564590550745, 2359.8820058997067, 2377.3699969508007, 2330.8951097200584, 2346.8709220992837, 2352.647102934556, 2376.5009348036933, 2380.75002124777, 2306.6540018997284, 2308.6998690170253, 2317.44381348476, 2318.9768102319013, 2339.0409931927998, 2263.343630347197, 2290.874001929893, 2291.6104262275453, 2293.587154312223, 2295.5753185660706, 9153.679621213225, 9201.585928633227, 9258.861117083181, 9317.627294908263, 9337.953310233406, 5191.870203244949, 5291.153415453509, 5425.430329815352, 5426.593005524602, 5428.022955867942, 3481.547398838135, 3583.140046388874, 3650.470681751158, 3662.7252956028137, 3690.225052738928, 1148.4315263944402, 1200.2678366196612, 1213.4204097911197, 1226.693326668333, 1228.2875931959531, 12833.935830320788, 12861.0, 12862.099653024292, 12884.613461596167, 12902.225866447949, 4494.505604383515, 4638.768061596907, 4811.133995880705, 4860.4896485869185, 4862.17343051682, 10828.133749300194, 10842.783144337069, 10843.295185812896, 10847.891521084846, 10855.023047925566, 5436.945630543723, 5453.3455985281225, 5472.835814925558, 5476.397596264408, 5486.615936884459, 4215.451991241119, 4812.1578723723205, 4950.9009819803405, 4966.205407134841, 5055.266986286968, 3925.509311336083, 4022.6926248969203, 4059.3910913363234, 4073.837046518106, 4188.5811418857875, 1255.6923553729212, 1277.310252463678, 1278.6931136527353, 1301.7006088599676, 1315.8684131586956, 934.5794392523392, 968.5931908598405, 1034.1519953637944, 1072.8873468285874, 1076.5532304093713, 6342.270638876496, 6442.9355706443275, 6466.8682980478225, 6644.435223006099, 6678.0, 941.5762906692016, 975.3660120921317, 977.7213494154132, 1002.4887307473241, 1002.7716047841482, 4110.588941105865, 4647.256438969748, 4671.112488627218, 4703.717776933395, 4771.642126840501, 10648.307859989076, 10895.182861285435, 11063.778724425467, 11330.320180789178, 11339.489722962486, 11120.221584489009, 11200.0, 11256.943715281372, 11262.887371126348, 11350.0, 8190.5904704764525, 8482.491050536988, 8486.448380855225, 8541.48751074925, 8620.181082797124, 6177.6911154441195, 6252.406021427957, 6359.936400636119, 6391.424771770563, 6416.807495775134, 9908.950455247677, 10148.492575371054, 10233.590656373959, 10393.636222732168, 10515.57937682484, 10492.842607360742, 10508.737281568023, 10634.149268058381, 10644.733881653021, 10682.359058456517, 7051.753188638373, 7443.330100290783, 7727.806804829925, 7734.071911370672, 7948.0, 8571.271441927505, 8627.611757471055, 8638.740837774876, 8667.0, 8700.912990870263, 7737.5744334062165, 7847.9215207849475, 7894.486858354188, 8025.638846252049, 8102.270795628422, 7676.117246516722, 7744.419168562267, 7814.921850781419, 7817.335526480313, 7906.7627971160955, 7263.0921134858145, 7337.229590893093, 7353.926460735324, 7375.704971801282, 7377.151627562899, 5499.50504454601, 5598.076317407582, 5620.578456615688, 5640.85897852557, 5732.828015159552, 5452.6183167177915, 5498.3127109111365, 5623.437656234344, 5636.605437619327, 5686.2607860977805], "value": 4810.836616367622, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.55099238546995, 332.7304883044734, 339.2417945890934, 340.3108704872633, 341.96922276995065, 5464.497263252602, 5471.5896307776975, 5529.834104976847, 5554.833354999347, 5564.387917329091, 5363.632273770183, 5403.432639572838, 5405.162199859018, 5407.297051383314, 5408.91886621701, 4059.16787058653, 4181.623653871151, 4246.0, 4297.570242975693, 4301.311790113583, 4213.052063285767, 4246.171996460692, 4256.787160641971, 4260.744355338689, 4282.657387409, 4229.513605935311, 4235.686937049509, 4239.427677263576, 4249.80875860587, 4251.3622956556455, 4084.2239974404915, 4219.0, 4286.87139385819, 4312.504062032875, 4342.522322544518, 3825.3114439400897, 3828.942565861514, 3832.5784163741964, 3839.596842331543, 3856.132370216707, 5308.203769434615, 5310.7610157543, 5311.601629877736, 5312.73436328182, 5325.334333208349, 4846.927296090562, 4848.927266091011, 4895.604752645515, 4930.827421040282, 4960.503949605047, 5656.773729050874, 5667.773289068432, 5673.546116310686, 5682.431756824326, 5701.116326969326, 4172.895677608054, 4178.415021896937, 4186.874393768192, 4199.286121359346, 4200.789960501963, 5793.638494953682, 5919.1713160157615, 5932.932072226998, 5975.701214939236, 5992.221011268507, 4237.978810105929, 4240.703150779415, 4274.551172126944, 4280.400743895857, 4292.325992862786, 4307.6769242306955, 4344.848615116996, 4347.695661303742, 4355.695101342875, 4364.148990946798, 4684.718916864931, 4901.803927842846, 4909.165441874889, 4921.237208232658, 4964.90070198594, 5731.713414329267, 5732.398098199629, 5745.396733343023, 5748.683822389725, 5760.946698249851, 1463.7657974723993, 1476.468471350313, 1476.6529865481602, 1481.2223582618997, 1481.429649584896, 944.2540393089382, 995.2137811129271, 999.9850002249972, 1003.8293490106553, 1014.3314248061897, 5472.069748142825, 5490.4469421719095, 5536.280283563111, 5562.415946325658, 5573.216570697338, 5820.708964551755, 5851.502622277069, 5864.853378665567, 5875.41245875409, 5897.941020589825, 5339.199120131933, 5514.448555144534, 5537.612367134262, 5540.750666219949, 5577.637453565505, 3092.9845350773103, 3102.348506813594, 3120.719135277836, 3130.4208721386617, 3139.4192074466296, 5840.269966254218, 6054.8183554493435, 6069.2716873975405, 6104.542159338067, 6109.7861574844665, 5927.229460170151, 5938.317093534299, 5982.461578457873, 5988.3113441953865, 5992.310884248367, 6082.905077086167, 6096.146539484475, 6104.633721976696, 6112.480439162632, 6119.694015299128, 5665.745041473226, 5710.2576665033275, 5796.449337312949, 5849.707514624337, 5859.56053296013, 5768.53851691872, 5794.594378393472, 5796.188533605215, 5797.913031304618, 5799.072148456226, 5795.449432303924, 6029.0, 6083.939160608337, 6087.36082711309, 6147.770445910746, 4178.456800615901, 4200.91598168041, 4214.199302132585, 4243.130158317475, 4243.448351714257, 5728.684922329146, 5967.373425790403, 6014.849628759316, 6016.548758843017, 6053.636781793107, 5589.720513974366, 5715.8856822864145, 5724.141378793214, 5732.3121225453215, 5742.483176514133, 5733.684647344436, 5740.741666624928, 5761.695321871285, 5767.826965191051, 5778.959787238337, 5650.3219613646625, 5658.991058174453, 5703.458171473703, 5749.942500574941, 5758.971205144115, 5734.254546908875, 5757.165211044459, 5765.423457654201, 5773.758641892014, 5797.304323481209, 5470.671759694431, 5680.147977803197, 5686.289213848269, 5700.885982280248, 5708.514776244066], "value": 4386.383847766249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.7954741993369, 796.7251298302084, 826.1779529368278, 835.9791005224865, 858.974230773077, 16560.58598535037, 16650.250738716757, 17323.13384330785, 17367.913160434196, 17410.738838917412, 15689.764653530206, 15763.921180394082, 15873.126978016204, 15927.52217433476, 15965.281562329694, 667.4093427316811, 795.3478147918709, 801.310872649521, 821.6302663801283, 823.6005537314397, 811.5130921447144, 815.6207363575936, 819.4100247821559, 819.573821612761, 821.0557858462786, 854.2909385210261, 860.7503823891064, 862.1766213266347, 863.201538576817, 864.3992425264444, 837.4598384042258, 847.7965288330787, 853.0190281176634, 854.598338780772, 856.1096459681924, 614.5360253008994, 617.5461036138435, 618.2858798088215, 618.5608218165063, 619.5105866365566, 14258.857411425857, 14281.78577321341, 14299.213543255117, 14545.563633091024, 14605.12369257848, 15960.600984975352, 16132.274047667766, 16148.192590370552, 16214.189290535543, 16609.750853737205, 12764.425600847891, 12781.16922400041, 13016.674583135497, 13237.536686216032, 13322.067455278135, 3952.347862602667, 4095.5699651536456, 4142.834286628531, 4172.269852775752, 4177.728447650893, 66740.0, 70052.2994770056, 83889.58055209745, 84056.57971710163, 84877.57561212154, 12051.638450846489, 12281.877181228252, 12371.381430928417, 12705.491780328868, 12730.23618582888, 20691.06890189945, 20805.375838724864, 20876.686849697267, 20958.895205523873, 20992.370228893156, 8849.20357167858, 8883.955580222058, 8906.0, 9034.774130646787, 9058.0, 4937.7777999990085, 5083.669561478492, 5098.515641014098, 5145.382554093533, 5235.816746413933, 3492.6158122606494, 3554.3779838528153, 3609.9278014439565, 3615.331163734665, 3618.7466877318334, 601.5758889982552, 605.636618029179, 605.9454649081604, 609.2567068176817, 622.7228883147046, 754.0954327614763, 769.7451519429355, 770.9614519274014, 792.3542313014874, 809.8785182222714, 9878.851817222747, 10634.46827658614, 10779.67660970172, 10984.286021408743, 11128.554857805759, 746.119578896896, 751.2825251884437, 769.4421544380391, 773.9922600774033, 777.7744454108246, 4833.854984350475, 5119.180931051014, 5153.768080436389, 5194.92207616886, 5244.895102097937, 90162.54918725364, 124840.0, 131130.0, 132651.0, 133387.0, 109751.0, 110511.44744276228, 111040.0, 111795.0, 112491.0, 81029.59485202536, 94830.52584737031, 94971.52514237385, 100488.49755751321, 100622.0, 9812.252569280612, 11059.50232239535, 11161.944190278997, 11257.268277561932, 11325.830112548483, 45807.54192458166, 46042.53957460383, 54958.17562736482, 55889.44110558843, 57069.42930570641, 48518.51481485281, 72573.637131814, 73087.26912730804, 77140.0, 77870.0, 14513.564593062225, 14802.77795833085, 14850.777238341218, 15014.92492537574, 15172.924135379253, 15312.770308445604, 15613.297401617181, 16027.198640068184, 16222.35110595563, 16466.0, 14074.437022518985, 14228.857711422754, 14287.71424571482, 15171.468998584996, 15690.215489225266, 14221.217833018869, 14403.567892963229, 14867.0, 14898.106113633217, 15364.692706145592, 14422.495212667507, 14658.63353416173, 15053.849461505682, 15095.4716584919, 15250.694986100438, 11531.654050378502, 11680.591179308683, 11707.131752720297, 12086.335251561248, 12113.091518136, 10782.460876956278, 11852.348120853436, 12456.505219373734, 12504.499820007099, 12968.0], "value": 7977.318228426394, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 111.0, 111.0, 115.0, 112.0, 111.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 149.0, 183.0, 123.0, 150.0, 146.0, 119.0, 183.0, 118.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 164.0, 165.0, 162.0, 166.0, 170.0, 165.0, 162.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 173.0, 77.0, 76.0, 75.0, 76.0, 170.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 155.0, 85.0, 85.0, 84.0, 141.0, 84.0, 84.0, 158.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 149.0, 151.0, 150.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 50.0, 51.0, 51.0, 51.0, 52.0, 50.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 88.0, 79.0, 78.0, 77.0, 76.0, 86.0, 77.0, 81.0, 81.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 131.0, 123.0, 130.0, 126.0, 136.0, 123.0, 130.0, 152.0, 142.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 167.0, 158.0, 159.0, 160.0, 161.0, 166.0, 162.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 67.0, 64.0, 72.0, 65.0, 62.0, 62.0, 63.0], "value": 64.9, "unit": "score"}]}]} 02:25:49 INFO - Return code: 0 02:25:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:25:49 ERROR - # TBPL SUCCESS # 02:25:49 INFO - Running post-action listener: _resource_record_post_action 02:25:49 INFO - [mozharness: 2016-08-10 09:25:49.300647Z] Finished run-tests step (success) 02:25:49 INFO - Running post-run listener: _resource_record_post_run 02:25:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552845312; Read time: 16; Write time: 548304 02:25:49 INFO - TinderboxPrint: CPU usage
13.4% 02:25:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:25:49 INFO - TinderboxPrint: I/O write bytes / time
552,845,312 / 548,304 02:25:49 INFO - TinderboxPrint: CPU idle
8,240.3 (86.6%) 02:25:49 INFO - TinderboxPrint: CPU user
1,212.7 (12.7%) 02:25:49 INFO - TinderboxPrint: Swap in / out
0 / 0 02:25:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260534272; Read time: 0; Write time: 303568 02:25:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 292311040; Read time: 0; Write time: 244736 02:25:49 INFO - Running post-run listener: _upload_blobber_files 02:25:49 INFO - Blob upload gear active. 02:25:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:25:49 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:25:49 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:25:49 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:25:50 INFO - (blobuploader) - INFO - Open directory for files ... 02:25:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:25:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:25:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:25:53 INFO - (blobuploader) - INFO - Done attempting. 02:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:25:54 INFO - (blobuploader) - INFO - Done attempting. 02:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:25:55 INFO - (blobuploader) - INFO - Done attempting. 02:25:55 INFO - (blobuploader) - INFO - Iteration through files over. 02:25:55 INFO - Return code: 0 02:25:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:25:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:25:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe6ce10bc64698bdbf8fdb263cb8623d34f7d5c6a9ab54e93c6239db0d00988a7b000c1151f5013082ecda847f915f6c458b939cfa825b8bba710206ba01467c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f50c974ce99da53e16e11fec53c7736c0cae8df09e713a80651a3e2bfdbd867b2a8b8e17f03c6585a20de987e067d92499f05e41d356eefb98dd3ca766e9b1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/564a6ad1208535d8b14785b5e3ee5cfae3a993145b0218f5ae51ec929f3784cdf68495f703f3ac0fdbf1cf8c29be57b249a7e9cd0c6d935e00d3203fde3ef6a5"} 02:25:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:25:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:25:55 INFO - Contents: 02:25:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe6ce10bc64698bdbf8fdb263cb8623d34f7d5c6a9ab54e93c6239db0d00988a7b000c1151f5013082ecda847f915f6c458b939cfa825b8bba710206ba01467c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f50c974ce99da53e16e11fec53c7736c0cae8df09e713a80651a3e2bfdbd867b2a8b8e17f03c6585a20de987e067d92499f05e41d356eefb98dd3ca766e9b1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/564a6ad1208535d8b14785b5e3ee5cfae3a993145b0218f5ae51ec929f3784cdf68495f703f3ac0fdbf1cf8c29be57b249a7e9cd0c6d935e00d3203fde3ef6a5"} 02:25:55 INFO - Running post-run listener: copy_logs_to_upload_dir 02:25:55 INFO - Copying logs to upload dir... 02:25:55 INFO - mkdir: /builds/slave/test/build/upload/logs 02:25:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.659033 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-10 02:25:55.438309) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 02:25:55.441679) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275 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/fe6ce10bc64698bdbf8fdb263cb8623d34f7d5c6a9ab54e93c6239db0d00988a7b000c1151f5013082ecda847f915f6c458b939cfa825b8bba710206ba01467c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f50c974ce99da53e16e11fec53c7736c0cae8df09e713a80651a3e2bfdbd867b2a8b8e17f03c6585a20de987e067d92499f05e41d356eefb98dd3ca766e9b1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/564a6ad1208535d8b14785b5e3ee5cfae3a993145b0218f5ae51ec929f3784cdf68495f703f3ac0fdbf1cf8c29be57b249a7e9cd0c6d935e00d3203fde3ef6a5"} build_url:https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/IPilepXvTNGfidb-KqKjKQ/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/fe6ce10bc64698bdbf8fdb263cb8623d34f7d5c6a9ab54e93c6239db0d00988a7b000c1151f5013082ecda847f915f6c458b939cfa825b8bba710206ba01467c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f50c974ce99da53e16e11fec53c7736c0cae8df09e713a80651a3e2bfdbd867b2a8b8e17f03c6585a20de987e067d92499f05e41d356eefb98dd3ca766e9b1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/564a6ad1208535d8b14785b5e3ee5cfae3a993145b0218f5ae51ec929f3784cdf68495f703f3ac0fdbf1cf8c29be57b249a7e9cd0c6d935e00d3203fde3ef6a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 02:25:55.466970) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:25:55.467348) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470817417.515292-647990275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 02:25:55.551261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 02:25:55.551577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 02:25:55.551864) ========= ========= Total master_lag: 0.17 =========