builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1470810250.98 results: success (0) buildid: 20160809203014 builduid: 2d030529ccfd4ee8871c9efb91c2ba63 revision: d8d09f4544be39ec9c880c7e006b281251c8a60e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:10.979625) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:10.980087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:10.980379) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.065868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.066197) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 23:24:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-08-09 23:24:11 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.196113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.199603) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019732 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.254624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.255258) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8d09f4544be39ec9c880c7e006b281251c8a60e --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 d8d09f4544be39ec9c880c7e006b281251c8a60e --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=652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 23:24:11,507 truncating revision to first 12 chars 2016-08-09 23:24:11,507 Setting DEBUG logging. 2016-08-09 23:24:11,507 attempt 1/10 2016-08-09 23:24:11,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8d09f4544be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 23:24:11,824 unpacking tar archive at: fx-team-d8d09f4544be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660531 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.934033) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.934372) ========= script_repo_revision: d8d09f4544be39ec9c880c7e006b281251c8a60e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.934759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.935024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 23:24:11.945160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-09 23:24:11.945565) ========= /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=652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:24:12 INFO - MultiFileLogger online at 20160809 23:24:12 in /builds/slave/test 23:24:12 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 23:24:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:12 INFO - {'append_to_log': False, 23:24:12 INFO - 'base_work_dir': '/builds/slave/test', 23:24:12 INFO - 'blob_upload_branch': 'Fx-Team', 23:24:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:12 INFO - 'branch': 'Fx-Team', 23:24:12 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:12 INFO - 'config_files': ('talos/linux_config.py',), 23:24:12 INFO - 'default_actions': ('clobber', 23:24:12 INFO - 'read-buildbot-config', 23:24:12 INFO - 'download-and-extract', 23:24:12 INFO - 'populate-webroot', 23:24:12 INFO - 'create-virtualenv', 23:24:12 INFO - 'install', 23:24:12 INFO - 'run-tests'), 23:24:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:12 INFO - 'download_minidump_stackwalk': True, 23:24:12 INFO - 'download_symbols': 'ondemand', 23:24:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:12 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:12 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:12 INFO - 'installer_path': 'installer.exe', 23:24:12 INFO - 'log_level': 'info', 23:24:12 INFO - 'log_name': 'talos', 23:24:12 INFO - 'log_to_console': True, 23:24:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:24:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:24:12 INFO - 'opt_config_files': (), 23:24:12 INFO - 'pip_index': False, 23:24:12 INFO - 'sps_profile': False, 23:24:12 INFO - 'sps_profile_interval': 0, 23:24:12 INFO - 'suite': 'dromaeojs-e10s', 23:24:12 INFO - 'system_bits': '32', 23:24:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:12 INFO - 'title': 'talos-linux64-ix-046', 23:24:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:12 INFO - 'use_talos_json': True, 23:24:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:12 INFO - 'work_dir': 'build'} 23:24:12 INFO - [mozharness: 2016-08-10 06:24:12.288745Z] Running clobber step. 23:24:12 INFO - Running pre-action listener: _resource_record_pre_action 23:24:12 INFO - Running main action method: clobber 23:24:12 INFO - rmtree: /builds/slave/test/build 23:24:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:12 INFO - Running post-action listener: _resource_record_post_action 23:24:12 INFO - [mozharness: 2016-08-10 06:24:12.750976Z] Finished clobber step (success) 23:24:12 INFO - [mozharness: 2016-08-10 06:24:12.751075Z] Running read-buildbot-config step. 23:24:12 INFO - Running pre-action listener: _resource_record_pre_action 23:24:12 INFO - Running main action method: read_buildbot_config 23:24:12 INFO - Using buildbot properties: 23:24:12 INFO - { 23:24:12 INFO - "project": "", 23:24:12 INFO - "product": "firefox", 23:24:12 INFO - "script_repo_revision": "production", 23:24:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:24:12 INFO - "repository": "", 23:24:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:24:12 INFO - "buildid": "20160809203014", 23:24:12 INFO - "pgo_build": "True", 23:24:12 INFO - "basedir": "/builds/slave/test", 23:24:12 INFO - "buildnumber": 661, 23:24:12 INFO - "slavename": "talos-linux64-ix-046", 23:24:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:24:12 INFO - "platform": "ubuntu64_hw", 23:24:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:24:12 INFO - "branch": "fx-team", 23:24:12 INFO - "repo_path": "integration/fx-team", 23:24:12 INFO - "revision": "d8d09f4544be39ec9c880c7e006b281251c8a60e", 23:24:12 INFO - "stage_platform": "linux64-pgo", 23:24:12 INFO - "builduid": "2d030529ccfd4ee8871c9efb91c2ba63", 23:24:12 INFO - "slavebuilddir": "test" 23:24:12 INFO - } 23:24:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:24:12 INFO - Running post-action listener: _resource_record_post_action 23:24:12 INFO - [mozharness: 2016-08-10 06:24:12.753528Z] Finished read-buildbot-config step (success) 23:24:12 INFO - [mozharness: 2016-08-10 06:24:12.753616Z] Running download-and-extract step. 23:24:12 INFO - Running pre-action listener: _resource_record_pre_action 23:24:12 INFO - Running main action method: download_and_extract 23:24:12 INFO - mkdir: /builds/slave/test/build/tests 23:24:12 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')]} 23:24:12 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:24:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:13 INFO - Downloaded 1361 bytes. 23:24:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:24:13 INFO - Using the following test package requirements: 23:24:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:24:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:24:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'jsshell-linux-x86_64.zip'], 23:24:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:24:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:24:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:24:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:24:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:24:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:24: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')]} 23:24:13 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:14 INFO - Downloaded 21831161 bytes. 23:24:14 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'] 23:24:14 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 23:24:15 INFO - Return code: 0 23:24:15 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 23:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:15 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:16 INFO - Downloaded 21831161 bytes. 23:24:16 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'] 23:24:16 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 23:24:17 INFO - Return code: 0 23:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:17 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:18 INFO - Downloaded 14413723 bytes. 23:24:18 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'] 23:24:18 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 23:24:18 INFO - Return code: 0 23:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:18 INFO - trying https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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 23:24:19 INFO - Downloaded 59325157 bytes. 23:24:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:19 INFO - mkdir: /builds/slave/test/properties 23:24:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:19 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:19 INFO - Contents: 23:24:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:20 INFO - Running post-action listener: _resource_record_post_action 23:24:20 INFO - Running post-action listener: set_extra_try_arguments 23:24:20 INFO - [mozharness: 2016-08-10 06:24:20.471494Z] Finished download-and-extract step (success) 23:24:20 INFO - [mozharness: 2016-08-10 06:24:20.471724Z] Running populate-webroot step. 23:24:20 INFO - Running pre-action listener: _resource_record_pre_action 23:24:20 INFO - Running main action method: populate_webroot 23:24:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:20 INFO - '--tppagecycles', 23:24:20 INFO - '7'], 23:24:20 INFO - 'tests': ['tsvgm']}}, 23:24:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['damp', 'tps']}, 23:24:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'tests': ['damp', 'tps']}, 23:24:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['dromaeo_dom']}, 23:24:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['basic_compositor_video']}, 23:24:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:24:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['a11yr', 23:24:20 INFO - 'ts_paint', 23:24:20 INFO - 'tpaint', 23:24:20 INFO - 'sessionrestore', 23:24:20 INFO - 'sessionrestore_no_auto_restore', 23:24:20 INFO - 'tabpaint']}, 23:24:20 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:20 INFO - 'ts_paint', 23:24:20 INFO - 'tpaint', 23:24:20 INFO - 'sessionrestore', 23:24:20 INFO - 'sessionrestore_no_auto_restore', 23:24:20 INFO - 'tabpaint']}, 23:24:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:20 INFO - 'ts_paint', 23:24:20 INFO - 'tpaint', 23:24:20 INFO - 'sessionrestore', 23:24:20 INFO - 'sessionrestore_no_auto_restore', 23:24:20 INFO - 'tabpaint']}, 23:24:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:20 INFO - 'ts_paint', 23:24:20 INFO - 'tpaint', 23:24:20 INFO - 'sessionrestore', 23:24:20 INFO - 'sessionrestore_no_auto_restore', 23:24:20 INFO - 'tabpaint']}, 23:24:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['a11yr', 23:24:20 INFO - 'ts_paint', 23:24:20 INFO - 'tpaint', 23:24:20 INFO - 'sessionrestore', 23:24:20 INFO - 'sessionrestore_no_auto_restore', 23:24:20 INFO - 'tabpaint']}, 23:24:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['a11yr', 23:24:20 INFO - 'ts_paint', 23:24:20 INFO - 'tpaint', 23:24:20 INFO - 'sessionrestore', 23:24:20 INFO - 'sessionrestore_no_auto_restore', 23:24:20 INFO - 'tabpaint']}, 23:24:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['tsvgx', 23:24:20 INFO - 'tsvgr_opacity', 23:24:20 INFO - 'tart', 23:24:20 INFO - 'tscrollx', 23:24:20 INFO - 'cart']}, 23:24:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:20 INFO - 'tsvgr_opacity', 23:24:20 INFO - 'tart', 23:24:20 INFO - 'tscrollx', 23:24:20 INFO - 'cart']}, 23:24:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'talos_options': ['--disable-e10s'], 23:24:20 INFO - 'tests': ['tp5o']}, 23:24:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'tests': ['tp5o']}, 23:24:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'talos_options': ['--disable-e10s', 23:24:20 INFO - '--xperf_path', 23:24:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:20 INFO - 'tests': ['tp5n']}, 23:24:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:20 INFO - 'talos_options': ['--xperf_path', 23:24:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:20 INFO - 'tests': ['tp5n']}}, 23:24:20 INFO - 'talos.zip': {'path': '', 23:24:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:20 INFO - Running post-action listener: _resource_record_post_action 23:24:20 INFO - [mozharness: 2016-08-10 06:24:20.493528Z] Finished populate-webroot step (success) 23:24:20 INFO - [mozharness: 2016-08-10 06:24:20.493616Z] Running create-virtualenv step. 23:24:20 INFO - Running pre-action listener: _resource_record_pre_action 23:24:20 INFO - Running main action method: create_virtualenv 23:24:20 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:20 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 23:24:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:20 INFO - Using real prefix '/usr' 23:24:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:21 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:23 INFO - Installing pip.................done. 23:24:23 INFO - Return code: 0 23:24:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:23 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:23 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 23:24:23 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 23:24:23 INFO - Using env: {'DISPLAY': ':0', 23:24:23 INFO - 'HOME': '/home/cltbld', 23:24:23 INFO - 'LANG': 'en_US.UTF-8', 23:24:23 INFO - 'LANGUAGE': 'en_US:en', 23:24:23 INFO - 'LOGNAME': 'cltbld', 23:24:23 INFO - 'MAIL': '/var/mail/cltbld', 23:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:23 INFO - 'MOZ_NO_REMOTE': '1', 23:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:23 INFO - 'NO_EM_RESTART': '1', 23:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:23 INFO - 'PWD': '/builds/slave/test', 23:24:23 INFO - 'SHELL': '/bin/bash', 23:24:23 INFO - 'SHLVL': '1', 23:24:23 INFO - 'TERM': 'linux', 23:24:23 INFO - 'TMOUT': '86400', 23:24:23 INFO - 'USER': 'cltbld', 23:24:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:23 INFO - '_': '/tools/buildbot/bin/python'} 23:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:23 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 23:24:23 INFO - Cleaning up... 23:24:23 INFO - Return code: 0 23:24:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:23 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:23 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 23:24:23 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 23:24:23 INFO - Using env: {'DISPLAY': ':0', 23:24:23 INFO - 'HOME': '/home/cltbld', 23:24:23 INFO - 'LANG': 'en_US.UTF-8', 23:24:23 INFO - 'LANGUAGE': 'en_US:en', 23:24:23 INFO - 'LOGNAME': 'cltbld', 23:24:23 INFO - 'MAIL': '/var/mail/cltbld', 23:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:23 INFO - 'MOZ_NO_REMOTE': '1', 23:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:23 INFO - 'NO_EM_RESTART': '1', 23:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:23 INFO - 'PWD': '/builds/slave/test', 23:24:23 INFO - 'SHELL': '/bin/bash', 23:24:23 INFO - 'SHLVL': '1', 23:24:23 INFO - 'TERM': 'linux', 23:24:23 INFO - 'TMOUT': '86400', 23:24:23 INFO - 'USER': 'cltbld', 23:24:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:23 INFO - '_': '/tools/buildbot/bin/python'} 23:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:23 INFO - Downloading/unpacking psutil>=3.1.1 23:24:23 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 23:24:23 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 23:24:23 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 23:24:23 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 23:24:23 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 23:24:23 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 23:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:25 INFO - Installing collected packages: psutil 23:24:25 INFO - Running setup.py install for psutil 23:24:25 INFO - building 'psutil._psutil_linux' extension 23:24:25 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 23:24:25 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 23:24:25 INFO - building 'psutil._psutil_posix' extension 23:24:25 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 23:24:25 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 23:24:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:26 INFO - Successfully installed psutil 23:24:26 INFO - Cleaning up... 23:24:26 INFO - Return code: 0 23:24:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:26 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:26 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 23:24:26 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 23:24:26 INFO - Using env: {'DISPLAY': ':0', 23:24:26 INFO - 'HOME': '/home/cltbld', 23:24:26 INFO - 'LANG': 'en_US.UTF-8', 23:24:26 INFO - 'LANGUAGE': 'en_US:en', 23:24:26 INFO - 'LOGNAME': 'cltbld', 23:24:26 INFO - 'MAIL': '/var/mail/cltbld', 23:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:26 INFO - 'MOZ_NO_REMOTE': '1', 23:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:26 INFO - 'NO_EM_RESTART': '1', 23:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:26 INFO - 'PWD': '/builds/slave/test', 23:24:26 INFO - 'SHELL': '/bin/bash', 23:24:26 INFO - 'SHLVL': '1', 23:24:26 INFO - 'TERM': 'linux', 23:24:26 INFO - 'TMOUT': '86400', 23:24:26 INFO - 'USER': 'cltbld', 23:24:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:26 INFO - '_': '/tools/buildbot/bin/python'} 23:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:24:26 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 23:24:26 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 23:24:26 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 23:24:26 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 23:24:26 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 23:24:26 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 23:24:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:24:28 INFO - Installing collected packages: mozsystemmonitor 23:24:28 INFO - Running setup.py install for mozsystemmonitor 23:24:28 INFO - Successfully installed mozsystemmonitor 23:24:28 INFO - Cleaning up... 23:24:28 INFO - Return code: 0 23:24:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:24:28 INFO - Using env: {'DISPLAY': ':0', 23:24:28 INFO - 'HOME': '/home/cltbld', 23:24:28 INFO - 'LANG': 'en_US.UTF-8', 23:24:28 INFO - 'LANGUAGE': 'en_US:en', 23:24:28 INFO - 'LOGNAME': 'cltbld', 23:24:28 INFO - 'MAIL': '/var/mail/cltbld', 23:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:28 INFO - 'MOZ_NO_REMOTE': '1', 23:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:28 INFO - 'NO_EM_RESTART': '1', 23:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:28 INFO - 'PWD': '/builds/slave/test', 23:24:28 INFO - 'SHELL': '/bin/bash', 23:24:28 INFO - 'SHLVL': '1', 23:24:28 INFO - 'TERM': 'linux', 23:24:28 INFO - 'TMOUT': '86400', 23:24:28 INFO - 'USER': 'cltbld', 23:24:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:28 INFO - '_': '/tools/buildbot/bin/python'} 23:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:28 INFO - Downloading/unpacking jsonschema==2.5.1 23:24:28 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 23:24:28 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 23:24:28 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 23:24:28 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 23:24:28 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 23:24:28 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 23:24:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:24:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:24:30 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 23:24:30 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 23:24:30 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 23:24:30 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 23:24:30 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 23:24:30 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 23:24:30 INFO - Downloading functools32-3.2.3-2.tar.gz 23:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:24:30 INFO - warning: no files found matching '*.txt' 23:24:30 INFO - no previously-included directories found matching 'build' 23:24:30 INFO - no previously-included directories found matching 'dist' 23:24:30 INFO - no previously-included directories found matching '.git*' 23:24:30 INFO - Installing collected packages: jsonschema, functools32 23:24:30 INFO - Running setup.py install for functools32 23:24:30 INFO - warning: no files found matching '*.txt' 23:24:30 INFO - no previously-included directories found matching 'build' 23:24:30 INFO - no previously-included directories found matching 'dist' 23:24:30 INFO - no previously-included directories found matching '.git*' 23:24:30 INFO - Successfully installed jsonschema functools32 23:24:30 INFO - Cleaning up... 23:24:30 INFO - Return code: 0 23:24:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:24:30 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')]} 23:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 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')]} 23:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:30 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 23:24:30 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 23:24:30 INFO - Using env: {'DISPLAY': ':0', 23:24:30 INFO - 'HOME': '/home/cltbld', 23:24:30 INFO - 'LANG': 'en_US.UTF-8', 23:24:30 INFO - 'LANGUAGE': 'en_US:en', 23:24:30 INFO - 'LOGNAME': 'cltbld', 23:24:30 INFO - 'MAIL': '/var/mail/cltbld', 23:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:30 INFO - 'MOZ_NO_REMOTE': '1', 23:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:30 INFO - 'NO_EM_RESTART': '1', 23:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:30 INFO - 'PWD': '/builds/slave/test', 23:24:30 INFO - 'SHELL': '/bin/bash', 23:24:30 INFO - 'SHLVL': '1', 23:24:30 INFO - 'TERM': 'linux', 23:24:30 INFO - 'TMOUT': '86400', 23:24:30 INFO - 'USER': 'cltbld', 23:24:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:30 INFO - '_': '/tools/buildbot/bin/python'} 23:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:24:31 INFO - Cleaning up... 23:24:31 INFO - Return code: 0 23:24:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:24:31 INFO - Using env: {'DISPLAY': ':0', 23:24:31 INFO - 'HOME': '/home/cltbld', 23:24:31 INFO - 'LANG': 'en_US.UTF-8', 23:24:31 INFO - 'LANGUAGE': 'en_US:en', 23:24:31 INFO - 'LOGNAME': 'cltbld', 23:24:31 INFO - 'MAIL': '/var/mail/cltbld', 23:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:31 INFO - 'MOZ_NO_REMOTE': '1', 23:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:31 INFO - 'NO_EM_RESTART': '1', 23:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:31 INFO - 'PWD': '/builds/slave/test', 23:24:31 INFO - 'SHELL': '/bin/bash', 23:24:31 INFO - 'SHLVL': '1', 23:24:31 INFO - 'TERM': 'linux', 23:24:31 INFO - 'TMOUT': '86400', 23:24:31 INFO - 'USER': 'cltbld', 23:24:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:31 INFO - '_': '/tools/buildbot/bin/python'} 23:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:31 INFO - Downloading/unpacking blobuploader==1.2.4 23:24:31 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 23:24:31 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 23:24:31 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 23:24:31 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 23:24:31 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 23:24:31 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 23:24:33 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 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 23:24:33 INFO - Downloading docopt-0.6.1.tar.gz 23:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:34 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:34 INFO - Running setup.py install for blobuploader 23:24:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:34 INFO - Running setup.py install for requests 23:24:34 INFO - Running setup.py install for docopt 23:24:34 INFO - Successfully installed blobuploader requests docopt 23:24:34 INFO - Cleaning up... 23:24:34 INFO - Return code: 0 23:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:34 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:34 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 23:24:34 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 23:24:34 INFO - Using env: {'DISPLAY': ':0', 23:24:34 INFO - 'HOME': '/home/cltbld', 23:24:34 INFO - 'LANG': 'en_US.UTF-8', 23:24:34 INFO - 'LANGUAGE': 'en_US:en', 23:24:34 INFO - 'LOGNAME': 'cltbld', 23:24:34 INFO - 'MAIL': '/var/mail/cltbld', 23:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:34 INFO - 'MOZ_NO_REMOTE': '1', 23:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:34 INFO - 'NO_EM_RESTART': '1', 23:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:34 INFO - 'PWD': '/builds/slave/test', 23:24:34 INFO - 'SHELL': '/bin/bash', 23:24:34 INFO - 'SHLVL': '1', 23:24:34 INFO - 'TERM': 'linux', 23:24:34 INFO - 'TMOUT': '86400', 23:24:34 INFO - 'USER': 'cltbld', 23:24:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:34 INFO - '_': '/tools/buildbot/bin/python'} 23:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:34 INFO - Running setup.py (path:/tmp/pip-_nurNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:34 INFO - Running setup.py (path:/tmp/pip-Eypbc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:35 INFO - Running setup.py (path:/tmp/pip-XWXgj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:35 INFO - Running setup.py (path:/tmp/pip-yQBGVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:35 INFO - Running setup.py (path:/tmp/pip-NmCmQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:35 INFO - Running setup.py (path:/tmp/pip-Qu0UJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:35 INFO - Running setup.py (path:/tmp/pip-v0sdNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:35 INFO - Running setup.py (path:/tmp/pip-N2RRFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:35 INFO - Running setup.py (path:/tmp/pip-rkCHlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:35 INFO - Running setup.py (path:/tmp/pip-lpwlIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:35 INFO - Running setup.py (path:/tmp/pip-MIJWdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:35 INFO - Running setup.py (path:/tmp/pip-ifdj6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:35 INFO - Running setup.py (path:/tmp/pip-CMZwq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:35 INFO - Running setup.py (path:/tmp/pip-J74vdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:35 INFO - Running setup.py (path:/tmp/pip-yIwvca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:35 INFO - Running setup.py (path:/tmp/pip-Mj6fjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:36 INFO - Running setup.py (path:/tmp/pip-CLvWJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:24:36 INFO - Running setup.py install for manifestparser 23:24:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Running setup.py install for mozcrash 23:24:36 INFO - Running setup.py install for mozdebug 23:24:36 INFO - Running setup.py install for mozdevice 23:24:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Running setup.py install for mozfile 23:24:36 INFO - Running setup.py install for mozhttpd 23:24:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Running setup.py install for mozinfo 23:24:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Running setup.py install for mozInstall 23:24:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:24:36 INFO - Running setup.py install for mozleak 23:24:36 INFO - Running setup.py install for mozlog 23:24:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:24:37 INFO - Running setup.py install for moznetwork 23:24:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:24:37 INFO - Running setup.py install for mozprocess 23:24:37 INFO - Running setup.py install for mozprofile 23:24:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:24:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:24:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:24:37 INFO - Running setup.py install for mozrunner 23:24:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:24:37 INFO - Running setup.py install for mozscreenshot 23:24:37 INFO - Running setup.py install for moztest 23:24:37 INFO - Running setup.py install for mozversion 23:24:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:24:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:24:37 INFO - Cleaning up... 23:24:37 INFO - Return code: 0 23:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:37 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:37 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 23:24:37 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 23:24:37 INFO - Using env: {'DISPLAY': ':0', 23:24:37 INFO - 'HOME': '/home/cltbld', 23:24:37 INFO - 'LANG': 'en_US.UTF-8', 23:24:37 INFO - 'LANGUAGE': 'en_US:en', 23:24:37 INFO - 'LOGNAME': 'cltbld', 23:24:37 INFO - 'MAIL': '/var/mail/cltbld', 23:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:37 INFO - 'MOZ_NO_REMOTE': '1', 23:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:37 INFO - 'NO_EM_RESTART': '1', 23:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:37 INFO - 'PWD': '/builds/slave/test', 23:24:37 INFO - 'SHELL': '/bin/bash', 23:24:37 INFO - 'SHLVL': '1', 23:24:37 INFO - 'TERM': 'linux', 23:24:37 INFO - 'TMOUT': '86400', 23:24:37 INFO - 'USER': 'cltbld', 23:24:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:37 INFO - '_': '/tools/buildbot/bin/python'} 23:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:38 INFO - Running setup.py (path:/tmp/pip-HKEYXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:38 INFO - Running setup.py (path:/tmp/pip-6F4KBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:38 INFO - Running setup.py (path:/tmp/pip-XlOQoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:38 INFO - Running setup.py (path:/tmp/pip-1dsZ1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:38 INFO - Running setup.py (path:/tmp/pip-oly7Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:38 INFO - Running setup.py (path:/tmp/pip-jjL71b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:38 INFO - Running setup.py (path:/tmp/pip-DJi_lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:38 INFO - Running setup.py (path:/tmp/pip-I8Cmfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:38 INFO - Running setup.py (path:/tmp/pip-7ALnBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:38 INFO - Running setup.py (path:/tmp/pip-6KxWaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:38 INFO - Running setup.py (path:/tmp/pip-ZVE71e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:38 INFO - Running setup.py (path:/tmp/pip-tpXdI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:38 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)) 23:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:38 INFO - Running setup.py (path:/tmp/pip-em68kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:39 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)) 23:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:39 INFO - Running setup.py (path:/tmp/pip-ecCIL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:39 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)) 23:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:39 INFO - Running setup.py (path:/tmp/pip-RgY1Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:39 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)) 23:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:39 INFO - Running setup.py (path:/tmp/pip-3wp9_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:39 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)) 23:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:39 INFO - Running setup.py (path:/tmp/pip-H_ihCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:39 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)) 23:24:39 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)) 23:24:39 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)) 23:24:39 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)) 23:24:39 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)) 23:24:39 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)) 23:24:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:41 INFO - Downloading blessings-1.6.tar.gz 23:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:24:41 INFO - Installing collected packages: blessings 23:24:41 INFO - Running setup.py install for blessings 23:24:41 INFO - Successfully installed blessings 23:24:41 INFO - Cleaning up... 23:24:41 INFO - Return code: 0 23:24:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:41 INFO - Reading from file tmpfile_stdout 23:24:41 INFO - Current package versions: 23:24:41 INFO - argparse == 1.2.1 23:24:41 INFO - blessings == 1.6 23:24:41 INFO - blobuploader == 1.2.4 23:24:41 INFO - docopt == 0.6.1 23:24:41 INFO - functools32 == 3.2.3-2 23:24:41 INFO - jsonschema == 2.5.1 23:24:41 INFO - manifestparser == 1.1 23:24:41 INFO - mozInstall == 1.12 23:24:41 INFO - mozcrash == 0.17 23:24:41 INFO - mozdebug == 0.1 23:24:41 INFO - mozdevice == 0.48 23:24:41 INFO - mozfile == 1.2 23:24:41 INFO - mozhttpd == 0.7 23:24:41 INFO - mozinfo == 0.9 23:24:41 INFO - mozleak == 0.1 23:24:41 INFO - mozlog == 3.3 23:24:41 INFO - moznetwork == 0.27 23:24:41 INFO - mozprocess == 0.23 23:24:41 INFO - mozprofile == 0.28 23:24:41 INFO - mozrunner == 6.12 23:24:41 INFO - mozscreenshot == 0.1 23:24:41 INFO - mozsystemmonitor == 0.3 23:24:41 INFO - moztest == 0.7 23:24:41 INFO - mozversion == 1.4 23:24:41 INFO - psutil == 3.1.1 23:24:41 INFO - requests == 1.2.3 23:24:41 INFO - wsgiref == 0.1.2 23:24:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:41 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')]} 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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')]} 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:41 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 23:24:41 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 23:24:41 INFO - Using env: {'DISPLAY': ':0', 23:24:41 INFO - 'HOME': '/home/cltbld', 23:24:41 INFO - 'LANG': 'en_US.UTF-8', 23:24:41 INFO - 'LANGUAGE': 'en_US:en', 23:24:41 INFO - 'LOGNAME': 'cltbld', 23:24:41 INFO - 'MAIL': '/var/mail/cltbld', 23:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:41 INFO - 'MOZ_NO_REMOTE': '1', 23:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:41 INFO - 'NO_EM_RESTART': '1', 23:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:41 INFO - 'PWD': '/builds/slave/test', 23:24:41 INFO - 'SHELL': '/bin/bash', 23:24:41 INFO - 'SHLVL': '1', 23:24:41 INFO - 'TERM': 'linux', 23:24:41 INFO - 'TMOUT': '86400', 23:24:41 INFO - 'USER': 'cltbld', 23:24:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:41 INFO - '_': '/tools/buildbot/bin/python'} 23:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 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)) 23:24:41 INFO - Cleaning up... 23:24:41 INFO - Return code: 0 23:24:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:41 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')]} 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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')]} 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 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 0x1b16030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', '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 23:24:41 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 23:24:41 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 23:24:41 INFO - Using env: {'DISPLAY': ':0', 23:24:41 INFO - 'HOME': '/home/cltbld', 23:24:41 INFO - 'LANG': 'en_US.UTF-8', 23:24:41 INFO - 'LANGUAGE': 'en_US:en', 23:24:41 INFO - 'LOGNAME': 'cltbld', 23:24:41 INFO - 'MAIL': '/var/mail/cltbld', 23:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:41 INFO - 'MOZ_NO_REMOTE': '1', 23:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:41 INFO - 'NO_EM_RESTART': '1', 23:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:41 INFO - 'PWD': '/builds/slave/test', 23:24:41 INFO - 'SHELL': '/bin/bash', 23:24:41 INFO - 'SHLVL': '1', 23:24:41 INFO - 'TERM': 'linux', 23:24:41 INFO - 'TMOUT': '86400', 23:24:41 INFO - 'USER': 'cltbld', 23:24:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:41 INFO - '_': '/tools/buildbot/bin/python'} 23:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:24:42 INFO - Cleaning up... 23:24:42 INFO - Return code: 0 23:24:42 INFO - Running post-action listener: _resource_record_post_action 23:24:42 INFO - Running post-action listener: _start_resource_monitoring 23:24:42 INFO - Starting resource monitoring. 23:24:42 INFO - [mozharness: 2016-08-10 06:24:42.135163Z] Finished create-virtualenv step (success) 23:24:42 INFO - [mozharness: 2016-08-10 06:24:42.135639Z] Running install step. 23:24:42 INFO - Running pre-action listener: _resource_record_pre_action 23:24:42 INFO - Running main action method: install 23:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:42 INFO - Reading from file tmpfile_stdout 23:24:42 INFO - Detecting whether we're running mozinstall >=1.0... 23:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:24:42 INFO - Reading from file tmpfile_stdout 23:24:42 INFO - Output received: 23:24:42 INFO - Usage: mozinstall [options] installer 23:24:42 INFO - Options: 23:24:42 INFO - -h, --help show this help message and exit 23:24:42 INFO - -d DEST, --destination=DEST 23:24:42 INFO - Directory to install application into. [default: 23:24:42 INFO - "/builds/slave/test"] 23:24:42 INFO - --app=APP Application being installed. [default: firefox] 23:24:42 INFO - mkdir: /builds/slave/test/build/application 23:24:42 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'] 23:24:42 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 23:24:59 INFO - Reading from file tmpfile_stdout 23:24:59 INFO - Output received: 23:24:59 INFO - /builds/slave/test/build/application/firefox/firefox 23:24:59 INFO - Running post-action listener: _resource_record_post_action 23:24:59 INFO - [mozharness: 2016-08-10 06:24:59.338632Z] Finished install step (success) 23:24:59 INFO - [mozharness: 2016-08-10 06:24:59.338878Z] Running run-tests step. 23:24:59 INFO - Running pre-action listener: _resource_record_pre_action 23:24:59 INFO - Running main action method: run_tests 23:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:24:59 INFO - Python 2.7.3 23:24:59 INFO - Return code: 0 23:24:59 INFO - grabbing minidump binary from tooltool 23:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:59 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 0x1dd53b0>, '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 0x1dd62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:24:59 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 23:24:59 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 23:24:59 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 23:24:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:24:59 INFO - Return code: 0 23:24:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:24:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:24:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:24:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:24:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:24:59 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/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:24:59 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/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 23:24:59 INFO - Using env: {'DISPLAY': ':0', 23:24:59 INFO - 'HOME': '/home/cltbld', 23:24:59 INFO - 'LANG': 'en_US.UTF-8', 23:24:59 INFO - 'LANGUAGE': 'en_US:en', 23:24:59 INFO - 'LOGNAME': 'cltbld', 23:24:59 INFO - 'MAIL': '/var/mail/cltbld', 23:24:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:24:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:59 INFO - 'MOZ_NO_REMOTE': '1', 23:24:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:59 INFO - 'NO_EM_RESTART': '1', 23:24:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:59 INFO - 'PWD': '/builds/slave/test', 23:24:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:24:59 INFO - 'SHELL': '/bin/bash', 23:24:59 INFO - 'SHLVL': '1', 23:24:59 INFO - 'TERM': 'linux', 23:24:59 INFO - 'TMOUT': '86400', 23:24:59 INFO - 'USER': 'cltbld', 23:24:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919', 23:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:59 INFO - '_': '/tools/buildbot/bin/python'} 23:24:59 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/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 23:24:59 INFO - mozversion application_buildid: 20160809203014 23:24:59 INFO - mozversion application_changeset: d8d09f4544be39ec9c880c7e006b281251c8a60e 23:24:59 INFO - mozversion application_display_name: Nightly 23:24:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:24:59 INFO - mozversion application_name: Firefox 23:24:59 INFO - mozversion application_remotingname: firefox 23:24:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:24:59 INFO - mozversion application_vendor: Mozilla 23:24:59 INFO - mozversion application_version: 51.0a1 23:24:59 INFO - mozversion platform_buildid: 20160809203014 23:24:59 INFO - mozversion platform_changeset: d8d09f4544be39ec9c880c7e006b281251c8a60e 23:24:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:24:59 INFO - mozversion platform_version: 51.0a1 23:24:59 INFO - using testdate: 1470810299 23:24:59 INFO - actual date: 1470810299 23:24:59 INFO - starting webserver on 'localhost:45825' 23:24:59 INFO - SUITE-START | Running 2 tests 23:24:59 INFO - TEST-START | dromaeo_css 23:24:59 INFO - operating with platform_type : linux_ 23:24:59 INFO - Initialising browser for dromaeo_css test... 23:24:59 INFO - TEST-INFO | started process 11483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4srJD2/profile http://localhost:45825/getInfo.html) 23:25:04 INFO - PROCESS | 11483 | __metrics Screen width/height:1600/1200 23:25:04 INFO - PROCESS | 11483 | colorDepth:24 23:25:04 INFO - PROCESS | 11483 | Browser inner width/height: 1024/697 23:25:04 INFO - PROCESS | 11483 | __metrics 23:25:04 ERROR - PROCESS | 11483 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 23:25:05 INFO - TEST-INFO | 11483: exit 0 23:25:05 INFO - Browser initialized. 23:25:05 INFO - Running cycle 1/1 for dromaeo_css test... 23:25:05 INFO - TEST-INFO | started process 11602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4srJD2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:17 INFO - PROCESS | 11602 | RSS: Main: 163192832 23:25:17 INFO - PROCESS | 11602 | 23:26:06 INFO - PROCESS | 11602 | 1470810366893 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] 23:28:16 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:45825/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45825/tests/dromaeo/cssquery-ext.html) 23:28:17 INFO - PROCESS | 11602 | RSS: Main: 165150720 23:28:17 INFO - PROCESS | 11602 | 23:31:20 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:45825/tests/dromaeo/cssquery-ext.html (next: http://localhost:45825/tests/dromaeo/cssquery-jquery.html) 23:31:20 INFO - PROCESS | 11602 | RSS: Main: 164167680 23:31:20 INFO - PROCESS | 11602 | 23:34:22 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:45825/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45825/tests/dromaeo/cssquery-mootools.html) 23:34:23 INFO - PROCESS | 11602 | RSS: Main: 168079360 23:34:23 INFO - PROCESS | 11602 | 23:37:25 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:45825/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45825/tests/dromaeo/cssquery-prototype.html) 23:37:25 INFO - PROCESS | 11602 | RSS: Main: 162623488 23:37:25 INFO - PROCESS | 11602 | 23:40:28 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:45825/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45825/tests/dromaeo/cssquery-yui.html) 23:40:28 INFO - PROCESS | 11602 | RSS: Main: 165216256 23:40:28 INFO - PROCESS | 11602 | 23:43:31 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:45825/tests/dromaeo/cssquery-yui.html (next: http://localhost:45825/tests/dromaeo/cssquery-dojo.html) 23:43:32 INFO - PROCESS | 11602 | RSS: Main: 169066496 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | __start_tp_report 23:43:32 INFO - PROCESS | 11602 | _x_x_mozilla_page_load 23:43:32 INFO - PROCESS | 11602 | _x_x_mozilla_page_load_details 23:43:32 INFO - PROCESS | 11602 | |i|pagename|runs| 23:43:32 INFO - PROCESS | 11602 | |0;dojo.html;3133.7806353555247;3133.905982820513;3161.0674850918977;3163.335699503104;3170.080676603785;5408.21580870774;5420.105682562383;5451.890962180759;5475.09660905951;5482.451754824516;5437.782488700447;5445.646033007852;5457.072297709389;5463.098588732854;5534.197541356501;4944.406671199461;4962.08201482726;4992.176290912013;5029.06962211992;5107.336046313974;4856.17445034345;4956.3804524434445;4981.178105612587;5032.144535428967;5087.10975579274;4870.43989941156;4942.406911170682;4966.056449274626;4983.626228032894;5022.221555658879;4950.87622809429;4971.676841005323;4973.875653108665;4980.277859710358;5015.598752099823;4776.928346074812;4844.85465436034;4844.975775121137;4871.269309603553;4878.048780487807;5361.973190134025;5422.945770542284;5475.863103422406;5483.150111732688;5503.972480137613;5773.740181691834;5780.335261444946;5790.971045144747;5793.044147715622;5806.506446952014;5701.600887937846;5760.7695692172265;5823.359430462646;5842.444967728059;5852.853678658025;5426.810061647863;5463.945360546423;5485.204645326406;5512.310961129859;5519.503244707996;5983.491403230687;5993.0710739835395;5993.430624090704;5997.400259973968;6009.188759517409;5513.972430137904;5639.802606908821;5686.147077938343;5709.3719690834805;5709.7716091356715;5581.720913954286;5724.542036637059;5752.36723960364;5777.162311464814;5823.650580965155;5828.125781132864;5838;5841.240638717025;5844.094165404369;5848.152017957373;5778.508826749689;5853.64878107315;5855.824325270249;5857.355690874;5859.355470898197;4348.304271316574;4406.449193850769;4426.203283409017;4439.445069366329;4482;3945.546262179829;3975.2248311578965;3988.6210809973004;4008.0781420272915;4015.357542793139;5558.249636299048;5602.803901863415;5611.242482264924;5613.298337707786;5615.691136987423;5677.14842773579;5786.623869448473;5817.912731309034;5848.298204215522;5907.497862681635;5518.172274158828;5598.384177740527;5615.971920140455;5622.184783206412;5625.6905870176715;4999.975000124976;5009.724465154379;5015.974920125376;5022.347094877642;5049.368828896388;5889;5924.052151655715;5930.140129681172;5977.342492325841;5991.951408503407;5809.62237454581;5847.619904706181;5849.53203743708;5849.883002339844;5891.410858914246;5989.2812862456785;6037.09443583466;6053.757849685963;6056.3035250946705;6076.483498902466;5612.607117501736;5703.20155178267;5738.569607279387;5742.397048310035;5757.539396848326;5887.322957859729;5896.852578685567;5902.1441890926435;5902.468777810018;5919.644821310735;5680.346760122638;5727.369989301257;5730.08318669011;5730.283714535683;5738.885222295614;5546.916796247979;5630.23991761107;5638.85902852432;5664.716764161858;5727.5417966561745;5601.579881508985;5623.100303951348;5633.267675202197;5637.8590535236945;5681.687507187145;5676.176954341515;5720.685362305113;5738.655680659173;5774.566907481872;5775.566832487664;5454.209139674805;5551.500364967173;5577.609567330248;5614.85962850932;5618.887622247614 23:43:32 INFO - PROCESS | 11602 | |1;ext.html;541.2103431310021;575.7927146227358;589.1898639370866;599.8290487211144;617.0959544267647;40151.59848401519;43977;44060;44109.77945110278;44316.3352549712;44204;44348;44664.3300350495;44670;44750.32874506877;8812.427192232517;8903.688370907019;8958.37291389603;8963.820723585524;8976.551172441352;8781.736547903573;8912.108789121101;8918.152775486318;8919.598618062202;8943.284537237005;8977.910220897773;9013.188813006827;9042.095790420972;9042.23141033013;9066.18404343609;8908.376413651047;8958.328125390623;8963.327750418679;8968;8984.460932344015;8685.826283474358;8686.913130868674;8714.520701361422;8775.64897404103;8797.252233560155;42224.57775422268;42490.57509424897;42502.149957000685;42504.3624345635;42562.148757024996;3506.3738745431183;3830.157365379612;4018.7789671568053;4057.58968094209;4363.040131171138;32859;33194.50208246878;33286.6671333286;33348.49977250343;34948.5051494851;4102.589741025903;4157.833686652531;4186.497620285555;4189.937150942738;4354.259775838115;345189;352861.17847054027;354047;354914;355272.99999999744;58406.415935840945;59005;59075;59105.11342329869;59134;61630.69184654138;61869.07196392058;62008.379916201164;62134.689326553074;62357.68821155956;16377;16663.83336166647;16676;16685.416010439818;16821.158942052847;13353.399097040656;13362.599122026355;13438.596842094752;13445.924326053891;13451.663708407368;15878;17405.47783566495;17415.56461088483;17496.21267042986;17732.734008989875;5734.426557344315;5752.827415177468;5752.9712351437975;5833.620814647034;5920.467157955804;887.6848718704766;983.5967253426061;1051.5793682526898;1067.4769363012067;1076.1982323169289;29855;30080.398392032475;30390.54414183789;30532.38935221283;31019.379612407625;1090.334895713614;1091.2361347057092;1145.6563031090639;1160.9941950290195;1232.9876701232872;16263.18684065792;16334.918325408296;16548.83451165497;16621.83378166227;17078.57303567396;470068;473163;473278;473750;478681;59329;59511.70244148751;59652.403475965555;59655.403445964985;59968;1282.51264519482;1343.879050885425;1345.8855997240148;1367.4325155060737;1368.726254749054;28374.57438138388;29727.256818578844;29823.552646709883;30001.849990749906;30567.08298751041;51625.22562161646;51804;51911.22133168081;51938.74030629823;52117.21824172565;428453;430059;430606;430663;431393;43161.56838431701;43242.13515729605;43737.90655233645;44296.778516108505;44383.33424998563;48761;49164;49336;50068.749656251486;50069;41598.58401416068;42261.57738422576;43085.78457107695;43634.12731745284;44671;41508.169836602494;41555.792221038704;42600.147997040505;42918;43778.78110609554;35211.64788352084;36390;36411.27177456489;36476.63523364732;36481;32544.34911301808;37317.81341093277;37948.24103517859;38473;38522.61477385303;25755.742442575334;26219.344516387242;26467.470650587267;28050.719492804812;28483 23:43:32 INFO - PROCESS | 11602 | |2;jquery.html;374.51126280204323;385.30452533177623;400.7775684495105;401.27369461275083;422.1915032712356;13565.389557469913;18365.265389384407;19066.142023608936;19733.901330493347;19735.703964440545;19114.139863706132;19231.230750769988;19526.804731952678;20219;20349.898250508726;5761.279840019987;5907.320658124328;5922.2005029321135;5956.434138756833;6002.189704389917;5734.168545560912;5893.941060589382;5928.258967629046;5935.050391937291;5946.316173640043;5748.856278593027;5823.2138661280605;5884.735186916578;5900.203472531196;5909.231799866011;5813.186153938452;5867.970660146715;5881.2354393928945;5888.911666324987;5898.705064746746;5034.748262586892;5178.818741344073;5240.135377662681;5251.973740131275;5265.394479634852;23780.286591402284;23980.28059158228;24207.757922420726;24257;24515.754842451526;2428.659987601737;2439.438929046329;2521.1932181701864;2640.379510814957;2858.828470291789;15004.774928376082;15035.54893353201;15063;15197.772033419507;15382.692346153126;1945.737325461073;2001.319551352547;2056.5167185711493;2062.742157230346;2118.756343020557;93187;93724;96676.51661741716;99754.5012274934;102668.48665756699;17757.556061098578;17811.910940445214;18078.45764627063;18242.179101940445;18639.720404193948;32336.191595210308;32418.189545261557;32668.18329541733;32753.344933101205;32824.50763238553;9945.104940555384;10018.448985305879;10151.695449136538;10271.589136434459;10606.204534659932;8189.099199088096;8240.62917168729;8383;8445.113263107409;8945.865812012826;8593.52735599548;8908.821823563492;8979.685711000084;9191.494467804336;9220.53897305132;3547.746842495347;3595.5865075516126;3597.7481576289933;3696.131409118855;3706.981465092711;827.3009307135461;964.3972517176765;1004.7002064111869;1017.9236557258236;1025.763834840041;18347;18840.15219315134;18983.33558325452;19315.80684193168;19949.700754488695;952.5237381309346;972.6060945317158;1000.0849222961054;1041.1982773264544;1088.983665245022;9529.761755956019;10841.945790270998;11013.339199648046;11029.227954043301;11151.721206969729;385776;387944;391714;490496;503281;89360.5531972336;91782;95827;100230.4988475053;101504;985.7831277119022;1010.777628921636;1035.6478797208986;1044.3055368180228;1045.3518818332682;16437.58906027359;17847.46457606274;17951.73072403941;17993.910030449762;18135.546611334295;36913.63086369102;40306.59693403028;41974.58025419829;44023.339649904636;46184.30723539217;64875.67562162159;65445.345546543926;66011;66081;66833.66583167248;7994.760157195294;8201.630926608197;8274.379421543288;8384.203500667427;8388.161183881562;11919.52321907114;13088.80366794518;13220.801687974496;13430.529931452353;13513.39189736484;10592.947035264775;10750.784984300426;11090.279131856727;11307.660770176908;11596.536138554364;11346;11510.654680359603;11750.58872939443;11798;12062.698432539257;10942.45287735626;10971.396573188551;11017.283876548;11131.109511239243;11350.318980861175;7760.3403710685225;8117.1071182168735;8170.754877353689;8241;8557.015943166367;10244.64143754965;11162.944185279346;11333.150013748836;11336.546538138382;11655 23:43:32 INFO - PROCESS | 11602 | |3;mootools.html;1498.5654160293511;1503.1957902522151;1672.4062957650035;1758.1824451629989;1783.0638914569856;8054.154313797055;8526.44578102423;8621.568921553928;9257.213136883365;9290.21033212177;8573.614187361569;8767.167119123673;8841.292696584274;8855.557222138883;8876.112388761121;2396.1972739132366;2437.792787613055;2440.3655049687122;2444.608862581987;2448.7673671001317;2387.1883559589737;2410.0841680161516;2413.4328432818274;2424.7575242475787;2429.0526694589034;2364.84628499147;2391.246757271454;2401.6757737705448;2413.80689544836;2415.420299128214;2289.7252329720372;2303.2053941390195;2306.423394151462;2337.9766202338014;2340.239422187787;2184.7050648162453;2185.9781402185936;2190.3319487556287;2202.0201010550313;2206.4594174427207;8930.062343453908;8944;9008.729738107868;9011.45931244121;9015.639374425014;5345.946540534584;5363.980843639735;5490.478404551562;5548.639338442988;5571.4428557144365;3372.8650853966055;3373.6120346160014;3402.2004828865197;3425;3453.1539772755837;1043.002649925392;1078.1267173589417;2040.5918816236813;2173.7065496157975;2191.079746506455;12734;12875.291858947849;12880.935595321964;12909.096363254575;12960.287184204864;4680.92124410641;4747.169245382113;4769.379980602499;4859.222524396079;4888.633352498577;9939.105480506789;9946.303758736964;9971;9977.900220997843;10026.64906728261;5498.670079795145;5504.174373843955;5507.228987941691;5514.448555144453;5525.171224316385;4555.681102322872;4904.60763138948;5001.349824522861;5057;5158.974205129025;3628.8004159771467;3734.887953361349;3843.404272337792;3889.0471834400187;3899.7855117968215;1174.0666170394557;1181.4447209811374;1196.2403873540366;1202.7053371923935;1210.3706072842074;867.5011868175698;956.93779904306;963.8939716631165;970.7864269860619;993.8459538771502;5600.551955843523;5831.79588714393;5918.940810591925;6093.177421048102;6108.144859719643;931.6599441203912;969.8593703912893;983.9606415743433;984.4437892590663;1029.3772267778036;4039.6768258539246;4225.133847561243;4267.317229243306;4286.5284818669925;4309.978450107729;11487.655370338904;11848.045072563104;11867.228630139014;11876.940615296868;11882.108841836896;11673.299602023906;11698.35659038761;11779.941100294443;11813.350265735467;11854.466549005316;8165.265126138676;8328.583570821434;8472.449290795956;8485;8521.233089022018;5722.370539240597;5845.41545845412;5906.0845568935165;5964;6049.274087109575;9742.220622350336;10053.597856085675;10139.695809125738;10210.693679189637;10243.180545556188;10113.190944724258;10319.690409287734;10367.27429079957;10404.502919299464;10542.631007914686;7912;8475.194856488624;8728.170823771732;8772.868406973774;8839.867401988846;8951.32865035138;9008.054154313964;9071.59177837012;9083.18251357381;9120.543972801466;8078.515289082674;8087.272145506698;8089.069756978023;8278.130796266547;8369.455985360932;7837.7648670539975;7962.761117166494;8065.395095367989;8185.058718247477;8292.83414331722;7246.130464344313;7306.926930730838;7325.6337183141695;7343.302386273295;7415.1101867776215;5011.348524691767;5051.545360917535;5065.924011139762;5087.109755792795;5179.81870634526;5329.866753331043;5356.946430535645;5373.758180881791;5416.593755468434;5515.641483303572 23:43:32 INFO - PROCESS | 11602 | |4;prototype.html;328.6889551835982;335.7565764820505;346.4629823773152;349.76390936118116;352.35870715298165;5377.8117765878205;5452.809151679692;5532.170174473831;5555.944440555599;5623.240862483563;5516.475934786199;5524.812165384442;5528.44715528447;5536.4186760390185;5539.612227144102;4334.1765064637775;4344.848615116996;4348.760603228081;4352.564743525654;4352.673549483793;4104.6716262699065;4276;4306.5262821089655;4357.455318085239;4360.498542667602;4262.126264115865;4269.6157345838865;4279.786010699452;4282.421873047146;4294.398784170218;4265.168292183041;4268.509121451042;4275.657947364203;4279.87160385189;4292.720973136736;3596.514470546469;3746.756460830037;3754.1740817020213;3766.7928263945473;3779.9244015119543;5385.569154467633;5392.892142157135;5393.595480338951;5394.217838413448;5402.6758394496455;4861.8784530386665;4867.4889136640495;4880.7554073711335;4905.901881962341;4910.435299940516;5557.972210138963;5650.5479561634975;5737.594289399082;5740.339860916007;5745.770169193227;4095.795210239506;4112.115895082542;4117.773522456264;4118.979405102956;4120.896977575585;5789.478946894757;5907.970460147715;5921.674307913063;5960;5979.312379076418;4129.731567448106;4139.19285739284;4156.501219853637;4168.6665066794585;4172.061286210578;4212.3681447782465;4220.493540775126;4226.915461690811;4230.873073807791;4231.61915427613;4837.7097374157665;4839.661223714306;4848.17581011229;4856.902861942742;4862.197737373364;5617.915731264035;5631.690257035821;5648.548116150698;5722.628029178173;5732.480892563474;1460.8831293496708;1468.4199741102418;1474.6064968604567;1476.1364601708121;1476.8670819626286;910.2035718746097;930.3348106104032;943.8489841625444;947.3090533397989;957.3968399908014;4882.5605695487575;4892.877678058077;4901;4975.328330675385;5017.982017982018;5172.586193104543;5201.739913004335;5202.193659982633;5203.765830537635;5232.738363081907;4664.813407463664;4901.632377571696;4947.678400903929;4962.454130045692;4965.453800081988;2754.2701184186208;2759.2412086676322;2760.544510155842;2778.70823563527;2779.291280723443;5306.575473962073;5381.546982314753;5387.875032481152;5395.541378982752;5399.244105825188;5262.973720124539;5309.424928909476;5630.042892708249;6026.487748541423;6145.87967151332;6112.327643959161;6181.567290289727;6225.132460261903;6238.251409830849;6256.343083976208;5905.320888097924;5910.449847023043;6015.608985415934;6027.8848413043725;6044.455998960115;5863.824085277449;5870.354261031369;5906.645601263938;5908.911366329423;5910.408959104056;6158.04550294705;6173.074038894202;6179.16581261524;6180.938190618036;6192.504599631929;4054.8378064878257;4245;4275.209086318917;4289.635380992526;4290.871273861789;5823.213866128188;5912.379200183918;5912.46787789101;5925.259342582177;5990.7004649768205;5753.338366087786;5803.622764520462;5815.447532484407;5824.592278540462;5827.3007239131575;5785.190073389645;5811.476967072984;5826.388229235869;5840.474357307863;5889.852753681193;5581.218629391808;5744.597878148489;5783.826485205451;5785.508231800176;5806.44838740319;5838.883222335615;5873.588848780544;5886.38192989747;5907.91138132937;5916.911246331395;5473.343198816008;5748.655080695172;5766.509846663081;5780.364159942487;5782.595218334676 23:43:32 INFO - PROCESS | 11602 | |5;yui.html;683.7948615415376;730.0509337860783;736.4771012581067;752.7177308509309;759.9164091949888;13974.93012534936;14026.649333766649;14738.336774845131;14830.925845370784;14858.479953201626;15077.6984460311;15148.469803556878;15195.088294702326;15229.543113706579;15243.92378038111;807.8747794091911;811.995940020299;821.765796747927;823.7487566292278;828.883956246123;823.4647479138548;836.5315423362936;838.9077201507829;839.2782207301716;839.7564706235185;867.9218870301671;875.5403413208053;879.9384043116985;880.1770344727701;880.2649787427474;870.9433886797337;872.0363997782454;872.7905302727299;873.1617647058831;874.5976850648709;630.4483576870239;637.1207733328024;638.4413638066692;639.5491178718992;640.1326202994968;14733.852661473355;14842.183679897602;14907.701845963129;14991.475298364614;15000;14127.223002734845;14959.551213463614;15228.238588070551;15337.156456394894;15424.691506169815;12412.62762117138;12460.563880264148;12727.809082863765;12731.299778512179;13033.348332583333;3900.941485877714;4057.0871553900433;4105.856295029689;4126.834926602963;4139.482564679415;86059;86577;88568;89288.55355723244;90219.54890225508;11385.487653055467;11686.47410866513;11954.880451195551;12092.334921579397;12140.392980350947;21793.891030545063;22179.445513862283;22185.556288874133;22200.11199552032;22252;7952.403569732178;7967.521948682982;7999.400044996649;8287;8320.251177394064;4617.722936623813;4671.416072990876;4717.43390793107;4747.406574178228;4786.569208771228;3507.964920350764;3608.9278214435562;3627.5284213052664;3640.0717816957035;3657.6708096271464;588.6115163991831;601.6841158391792;607.6657838188978;611.6758118197363;629.8330942300294;701.1971292869636;725.7060890339421;734.6326836581709;740.9740659076906;743.9590822504706;9734.561944712505;9856.162226210708;10027.997200279913;10091.798164036825;10201.438920859275;682.2938258902012;683.4327508168209;716.4089626058418;721.6412866287669;744.7132853851306;4854.393200849894;4917.166723151447;4919.581835543947;4980.8792074468565;5073.7716802743225;125993;126703;128635.35682321529;131544;134671;106894.46552767187;109013;109228;113409.43295283636;115219;76191;76593.99999999888;91713.95573243535;100383.49808250912;100758.49620751996;10013.449260290463;10717.142628589538;10857.402842843403;10876.238663293494;11004.504797284302;43282.56717432912;44286;50103;51948.480515194366;52880.206796897306;52691.473085268655;64852.675736621015;65626;66480;69117.65441172762;11011.394373309546;11301.43492825339;11319.603813866475;13514.86485135136;13713.314334283046;13015.479380824661;15021.624459388602;15773.65550734405;15838.9208053959;16039;13451.260180690157;13598.388072536562;14559.781603276171;14706.63233419173;15323.693526129638;13994.930025349808;14319.28403579796;14351.856481435052;14474.348654310792;14972.401103955719;13923.190941944422;14015.649608759863;14184.858151418353;14400.42398304056;14668.339924703201;11791.941040295087;12005.339706316236;12116.939415302868;12362.567310144103;12498.37508124572;11519.25124866881;11567.768644626893;11864.347460889734;11922.344271065174;12401.751964960831 23:43:32 INFO - PROCESS | 11602 | __end_tp_report 23:43:32 INFO - PROCESS | 11602 | __start_cc_report 23:43:32 INFO - PROCESS | 11602 | _x_x_mozilla_cycle_collect,329 23:43:32 INFO - PROCESS | 11602 | __end_cc_report 23:43:32 INFO - PROCESS | 11602 | __startTimestamp1470811412175__endTimestamp 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | ------- Summary: start ------- 23:43:32 INFO - PROCESS | 11602 | Number of tests: 6 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | [#0] dojo.html Cycles:165 Average:5411.78 Median:5618.89 stddev:612.97 (10.9%) stddev-sans-first:588.22 23:43:32 INFO - PROCESS | 11602 | Values: 3133.8 3133.9 3161.1 3163.3 3170.1 5408.2 5420.1 5451.9 5475.1 5482.5 5437.8 5445.6 5457.1 5463.1 5534.2 4944.4 4962.1 4992.2 5029.1 5107.3 4856.2 4956.4 4981.2 5032.1 5087.1 4870.4 4942.4 4966.1 4983.6 5022.2 4950.9 4971.7 4973.9 4980.3 5015.6 4776.9 4844.9 4845.0 4871.3 4878.0 5362.0 5422.9 5475.9 5483.2 5504.0 5773.7 5780.3 5791.0 5793.0 5806.5 5701.6 5760.8 5823.4 5842.4 5852.9 5426.8 5463.9 5485.2 5512.3 5519.5 5983.5 5993.1 5993.4 5997.4 6009.2 5514.0 5639.8 5686.1 5709.4 5709.8 5581.7 5724.5 5752.4 5777.2 5823.7 5828.1 5838.0 5841.2 5844.1 5848.2 5778.5 5853.6 5855.8 5857.4 5859.4 4348.3 4406.4 4426.2 4439.4 4482.0 3945.5 3975.2 3988.6 4008.1 4015.4 5558.2 5602.8 5611.2 5613.3 5615.7 5677.1 5786.6 5817.9 5848.3 5907.5 5518.2 5598.4 5616.0 5622.2 5625.7 5000.0 5009.7 5016.0 5022.3 5049.4 5889.0 5924.1 5930.1 5977.3 5992.0 5809.6 5847.6 5849.5 5849.9 5891.4 5989.3 6037.1 6053.8 6056.3 6076.5 5612.6 5703.2 5738.6 5742.4 5757.5 5887.3 5896.9 5902.1 5902.5 5919.6 5680.3 5727.4 5730.1 5730.3 5738.9 5546.9 5630.2 5638.9 5664.7 5727.5 5601.6 5623.1 5633.3 5637.9 5681.7 5676.2 5720.7 5738.7 5774.6 5775.6 5454.2 5551.5 5577.6 5614.9 5618.9 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | [#1] ext.html Cycles:180 Average:58837.07 Median:430634.50 stddev:111401.75 (25.9%) stddev-sans-first:111628.28 23:43:32 INFO - PROCESS | 11602 | Values: 541.2 575.8 589.2 599.8 617.1 40151.6 43977.0 44060.0 44109.8 44316.3 44204.0 44348.0 44664.3 44670.0 44750.3 8812.4 8903.7 8958.4 8963.8 8976.6 8781.7 8912.1 8918.2 8919.6 8943.3 8977.9 9013.2 9042.1 9042.2 9066.2 8908.4 8958.3 8963.3 8968.0 8984.5 8685.8 8686.9 8714.5 8775.6 8797.3 42224.6 42490.6 42502.1 42504.4 42562.1 3506.4 3830.2 4018.8 4057.6 4363.0 32859.0 33194.5 33286.7 33348.5 34948.5 4102.6 4157.8 4186.5 4189.9 4354.3 345189.0 352861.2 354047.0 354914.0 355273.0 58406.4 59005.0 59075.0 59105.1 59134.0 61630.7 61869.1 62008.4 62134.7 62357.7 16377.0 16663.8 16676.0 16685.4 16821.2 13353.4 13362.6 13438.6 13445.9 13451.7 15878.0 17405.5 17415.6 17496.2 17732.7 5734.4 5752.8 5753.0 5833.6 5920.5 887.7 983.6 1051.6 1067.5 1076.2 29855.0 30080.4 30390.5 30532.4 31019.4 1090.3 1091.2 1145.7 1161.0 1233.0 16263.2 16334.9 16548.8 16621.8 17078.6 470068.0 473163.0 473278.0 473750.0 478681.0 59329.0 59511.7 59652.4 59655.4 59968.0 1282.5 1343.9 1345.9 1367.4 1368.7 28374.6 29727.3 29823.6 30001.8 30567.1 51625.2 51804.0 51911.2 51938.7 52117.2 428453.0 430059.0 430606.0 430663.0 431393.0 43161.6 43242.1 43737.9 44296.8 44383.3 48761.0 49164.0 49336.0 50068.7 50069.0 41598.6 42261.6 43085.8 43634.1 44671.0 41508.2 41555.8 42600.1 42918.0 43778.8 35211.6 36390.0 36411.3 36476.6 36481.0 32544.3 37317.8 37948.2 38473.0 38522.6 25755.7 26219.3 26467.5 28050.7 28483.0 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | [#2] jquery.html Cycles:180 Average:29171.69 Median:17597.51 stddev:72547.31 (412.3%) stddev-sans-first:72718.60 23:43:32 INFO - PROCESS | 11602 | Values: 374.5 385.3 400.8 401.3 422.2 13565.4 18365.3 19066.1 19733.9 19735.7 19114.1 19231.2 19526.8 20219.0 20349.9 5761.3 5907.3 5922.2 5956.4 6002.2 5734.2 5893.9 5928.3 5935.1 5946.3 5748.9 5823.2 5884.7 5900.2 5909.2 5813.2 5868.0 5881.2 5888.9 5898.7 5034.7 5178.8 5240.1 5252.0 5265.4 23780.3 23980.3 24207.8 24257.0 24515.8 2428.7 2439.4 2521.2 2640.4 2858.8 15004.8 15035.5 15063.0 15197.8 15382.7 1945.7 2001.3 2056.5 2062.7 2118.8 93187.0 93724.0 96676.5 99754.5 102668.5 17757.6 17811.9 18078.5 18242.2 18639.7 32336.2 32418.2 32668.2 32753.3 32824.5 9945.1 10018.4 10151.7 10271.6 10606.2 8189.1 8240.6 8383.0 8445.1 8945.9 8593.5 8908.8 8979.7 9191.5 9220.5 3547.7 3595.6 3597.7 3696.1 3707.0 827.3 964.4 1004.7 1017.9 1025.8 18347.0 18840.2 18983.3 19315.8 19949.7 952.5 972.6 1000.1 1041.2 1089.0 9529.8 10841.9 11013.3 11029.2 11151.7 385776.0 387944.0 391714.0 490496.0 503281.0 89360.6 91782.0 95827.0 100230.5 101504.0 985.8 1010.8 1035.6 1044.3 1045.4 16437.6 17847.5 17951.7 17993.9 18135.5 36913.6 40306.6 41974.6 44023.3 46184.3 64875.7 65445.3 66011.0 66081.0 66833.7 7994.8 8201.6 8274.4 8384.2 8388.2 11919.5 13088.8 13220.8 13430.5 13513.4 10592.9 10750.8 11090.3 11307.7 11596.5 11346.0 11510.7 11750.6 11798.0 12062.7 10942.5 10971.4 11017.3 11131.1 11350.3 7760.3 8117.1 8170.8 8241.0 8557.0 10244.6 11162.9 11333.2 11336.5 11655.0 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | [#3] mootools.html Cycles:180 Average:5987.38 Median:5054.27 stddev:3423.87 (67.7%) stddev-sans-first:3416.86 23:43:32 INFO - PROCESS | 11602 | Values: 1498.6 1503.2 1672.4 1758.2 1783.1 8054.2 8526.4 8621.6 9257.2 9290.2 8573.6 8767.2 8841.3 8855.6 8876.1 2396.2 2437.8 2440.4 2444.6 2448.8 2387.2 2410.1 2413.4 2424.8 2429.1 2364.8 2391.2 2401.7 2413.8 2415.4 2289.7 2303.2 2306.4 2338.0 2340.2 2184.7 2186.0 2190.3 2202.0 2206.5 8930.1 8944.0 9008.7 9011.5 9015.6 5345.9 5364.0 5490.5 5548.6 5571.4 3372.9 3373.6 3402.2 3425.0 3453.2 1043.0 1078.1 2040.6 2173.7 2191.1 12734.0 12875.3 12880.9 12909.1 12960.3 4680.9 4747.2 4769.4 4859.2 4888.6 9939.1 9946.3 9971.0 9977.9 10026.6 5498.7 5504.2 5507.2 5514.4 5525.2 4555.7 4904.6 5001.3 5057.0 5159.0 3628.8 3734.9 3843.4 3889.0 3899.8 1174.1 1181.4 1196.2 1202.7 1210.4 867.5 956.9 963.9 970.8 993.8 5600.6 5831.8 5918.9 6093.2 6108.1 931.7 969.9 984.0 984.4 1029.4 4039.7 4225.1 4267.3 4286.5 4310.0 11487.7 11848.0 11867.2 11876.9 11882.1 11673.3 11698.4 11779.9 11813.4 11854.5 8165.3 8328.6 8472.4 8485.0 8521.2 5722.4 5845.4 5906.1 5964.0 6049.3 9742.2 10053.6 10139.7 10210.7 10243.2 10113.2 10319.7 10367.3 10404.5 10542.6 7912.0 8475.2 8728.2 8772.9 8839.9 8951.3 9008.1 9071.6 9083.2 9120.5 8078.5 8087.3 8089.1 8278.1 8369.5 7837.8 7962.8 8065.4 8185.1 8292.8 7246.1 7306.9 7325.6 7343.3 7415.1 5011.3 5051.5 5065.9 5087.1 5179.8 5329.9 5356.9 5373.8 5416.6 5515.6 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | [#4] prototype.html Cycles:180 Average:4772.08 Median:5386.72 stddev:1418.33 (26.3%) stddev-sans-first:1382.54 23:43:32 INFO - PROCESS | 11602 | Values: 328.7 335.8 346.5 349.8 352.4 5377.8 5452.8 5532.2 5555.9 5623.2 5516.5 5524.8 5528.4 5536.4 5539.6 4334.2 4344.8 4348.8 4352.6 4352.7 4104.7 4276.0 4306.5 4357.5 4360.5 4262.1 4269.6 4279.8 4282.4 4294.4 4265.2 4268.5 4275.7 4279.9 4292.7 3596.5 3746.8 3754.2 3766.8 3779.9 5385.6 5392.9 5393.6 5394.2 5402.7 4861.9 4867.5 4880.8 4905.9 4910.4 5558.0 5650.5 5737.6 5740.3 5745.8 4095.8 4112.1 4117.8 4119.0 4120.9 5789.5 5908.0 5921.7 5960.0 5979.3 4129.7 4139.2 4156.5 4168.7 4172.1 4212.4 4220.5 4226.9 4230.9 4231.6 4837.7 4839.7 4848.2 4856.9 4862.2 5617.9 5631.7 5648.5 5722.6 5732.5 1460.9 1468.4 1474.6 1476.1 1476.9 910.2 930.3 943.8 947.3 957.4 4882.6 4892.9 4901.0 4975.3 5018.0 5172.6 5201.7 5202.2 5203.8 5232.7 4664.8 4901.6 4947.7 4962.5 4965.5 2754.3 2759.2 2760.5 2778.7 2779.3 5306.6 5381.5 5387.9 5395.5 5399.2 5263.0 5309.4 5630.0 6026.5 6145.9 6112.3 6181.6 6225.1 6238.3 6256.3 5905.3 5910.4 6015.6 6027.9 6044.5 5863.8 5870.4 5906.6 5908.9 5910.4 6158.0 6173.1 6179.2 6180.9 6192.5 4054.8 4245.0 4275.2 4289.6 4290.9 5823.2 5912.4 5912.5 5925.3 5990.7 5753.3 5803.6 5815.4 5824.6 5827.3 5785.2 5811.5 5826.4 5840.5 5889.9 5581.2 5744.6 5783.8 5785.5 5806.4 5838.9 5873.6 5886.4 5907.9 5916.9 5473.3 5748.7 5766.5 5780.4 5782.6 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - PROCESS | 11602 | [#5] yui.html Cycles:180 Average:21756.99 Median:3558.45 stddev:32425.99 (911.2%) stddev-sans-first:32478.35 23:43:32 INFO - PROCESS | 11602 | Values: 683.8 730.1 736.5 752.7 759.9 13974.9 14026.6 14738.3 14830.9 14858.5 15077.7 15148.5 15195.1 15229.5 15243.9 807.9 812.0 821.8 823.7 828.9 823.5 836.5 838.9 839.3 839.8 867.9 875.5 879.9 880.2 880.3 870.9 872.0 872.8 873.2 874.6 630.4 637.1 638.4 639.5 640.1 14733.9 14842.2 14907.7 14991.5 15000.0 14127.2 14959.6 15228.2 15337.2 15424.7 12412.6 12460.6 12727.8 12731.3 13033.3 3900.9 4057.1 4105.9 4126.8 4139.5 86059.0 86577.0 88568.0 89288.6 90219.5 11385.5 11686.5 11954.9 12092.3 12140.4 21793.9 22179.4 22185.6 22200.1 22252.0 7952.4 7967.5 7999.4 8287.0 8320.3 4617.7 4671.4 4717.4 4747.4 4786.6 3508.0 3608.9 3627.5 3640.1 3657.7 588.6 601.7 607.7 611.7 629.8 701.2 725.7 734.6 741.0 744.0 9734.6 9856.2 10028.0 10091.8 10201.4 682.3 683.4 716.4 721.6 744.7 4854.4 4917.2 4919.6 4980.9 5073.8 125993.0 126703.0 128635.4 131544.0 134671.0 106894.5 109013.0 109228.0 113409.4 115219.0 76191.0 76594.0 91714.0 100383.5 100758.5 10013.4 10717.1 10857.4 10876.2 11004.5 43282.6 44286.0 50103.0 51948.5 52880.2 52691.5 64852.7 65626.0 66480.0 69117.7 11011.4 11301.4 11319.6 13514.9 13713.3 13015.5 15021.6 15773.7 15838.9 16039.0 13451.3 13598.4 14559.8 14706.6 15323.7 13994.9 14319.3 14351.9 14474.3 14972.4 13923.2 14015.6 14184.9 14400.4 14668.3 11791.9 12005.3 12116.9 12362.6 12498.4 11519.3 11567.8 11864.3 11922.3 12401.8 23:43:32 INFO - PROCESS | 11602 | -------- Summary: end -------- 23:43:32 INFO - PROCESS | 11602 | 23:43:32 INFO - TEST-INFO | 11602: exit 0 23:43:32 INFO - TEST-OK | dromaeo_css | took 1113283ms 23:43:32 INFO - TEST-START | kraken 23:43:32 INFO - operating with platform_type : linux_ 23:43:32 INFO - Initialising browser for kraken test... 23:43:32 INFO - TEST-INFO | started process 11865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIqNlj/profile http://localhost:45825/getInfo.html) 23:43:37 INFO - PROCESS | 11865 | __metrics Screen width/height:1600/1200 23:43:37 INFO - PROCESS | 11865 | colorDepth:24 23:43:37 INFO - PROCESS | 11865 | Browser inner width/height: 1024/697 23:43:37 INFO - PROCESS | 11865 | __metrics 23:43:37 ERROR - PROCESS | 11865 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 23:43:38 INFO - TEST-INFO | 11865: exit 0 23:43:38 INFO - Browser initialized. 23:43:38 INFO - Running cycle 1/1 for kraken test... 23:43:38 INFO - TEST-INFO | started process 11985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIqNlj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:50 INFO - PROCESS | 11985 | RSS: Main: 163049472 23:43:50 INFO - PROCESS | 11985 | 23:43:53 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45825/tests/kraken/driver.html?testName=audio-beat-detection) 23:43:54 INFO - PROCESS | 11985 | RSS: Main: 168501248 23:43:54 INFO - PROCESS | 11985 | 23:43:56 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45825/tests/kraken/driver.html?testName=audio-dft) 23:43:57 INFO - PROCESS | 11985 | RSS: Main: 167452672 23:43:57 INFO - PROCESS | 11985 | 23:44:00 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45825/tests/kraken/driver.html?testName=audio-fft) 23:44:00 INFO - PROCESS | 11985 | RSS: Main: 163418112 23:44:00 INFO - PROCESS | 11985 | 23:44:02 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45825/tests/kraken/driver.html?testName=audio-oscillator) 23:44:03 INFO - PROCESS | 11985 | RSS: Main: 164454400 23:44:03 INFO - PROCESS | 11985 | 23:44:05 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45825/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:44:06 INFO - PROCESS | 11985 | RSS: Main: 164286464 23:44:06 INFO - PROCESS | 11985 | 23:44:09 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45825/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:10 INFO - PROCESS | 11985 | RSS: Main: 164384768 23:44:10 INFO - PROCESS | 11985 | 23:44:13 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45825/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:14 INFO - PROCESS | 11985 | RSS: Main: 162115584 23:44:14 INFO - PROCESS | 11985 | 23:44:17 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45825/tests/kraken/driver.html?testName=json-parse-financial) 23:44:17 INFO - PROCESS | 11985 | RSS: Main: 164057088 23:44:17 INFO - PROCESS | 11985 | 23:44:19 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45825/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:19 INFO - PROCESS | 11985 | RSS: Main: 164462592 23:44:19 INFO - PROCESS | 11985 | 23:44:21 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:22 INFO - PROCESS | 11985 | RSS: Main: 164384768 23:44:22 INFO - PROCESS | 11985 | 23:44:24 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:24 INFO - PROCESS | 11985 | RSS: Main: 164810752 23:44:24 INFO - PROCESS | 11985 | 23:44:27 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:28 INFO - PROCESS | 11985 | RSS: Main: 164999168 23:44:28 INFO - PROCESS | 11985 | 23:44:30 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:31 INFO - PROCESS | 11985 | RSS: Main: 165085184 23:44:31 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | Cycle 1(1): loaded http://localhost:45825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45825/tests/kraken/driver.html?testName=ai-astar) 23:44:33 INFO - PROCESS | 11985 | RSS: Main: 165900288 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | __start_tp_report 23:44:33 INFO - PROCESS | 11985 | _x_x_mozilla_page_load 23:44:33 INFO - PROCESS | 11985 | _x_x_mozilla_page_load_details 23:44:33 INFO - PROCESS | 11985 | |i|pagename|runs| 23:44:33 INFO - PROCESS | 11985 | |0;ai-astar;104;114;106;110;112;112;112;115;115;114 23:44:33 INFO - PROCESS | 11985 | |1;audio-beat-detection;150;121;148;190;119;144;149;121;184;120 23:44:33 INFO - PROCESS | 11985 | |2;audio-dft;162;161;163;163;164;164;170;163;163;162 23:44:33 INFO - PROCESS | 11985 | |3;audio-fft;75;76;76;175;76;75;76;76;170;75 23:44:33 INFO - PROCESS | 11985 | |4;audio-oscillator;85;84;142;84;85;83;146;84;84;135 23:44:33 INFO - PROCESS | 11985 | |5;imaging-gaussian-blur;119;119;117;117;117;117;117;118;118;118 23:44:33 INFO - PROCESS | 11985 | |6;imaging-darkroom;148;147;148;148;147;147;148;147;147;147 23:44:33 INFO - PROCESS | 11985 | |7;imaging-desaturate;96;98;97;96;97;97;96;97;97;97 23:44:33 INFO - PROCESS | 11985 | |8;json-parse-financial;55;50;51;52;56;53;51;52;51;53 23:44:33 INFO - PROCESS | 11985 | |9;json-stringify-tinderbox;59;61;60;61;64;60;60;60;61;61 23:44:33 INFO - PROCESS | 11985 | |10;stanford-crypto-aes;76;76;80;82;77;77;76;77;84;79 23:44:33 INFO - PROCESS | 11985 | |11;stanford-crypto-ccm;124;131;145;134;134;124;124;137;189;128 23:44:33 INFO - PROCESS | 11985 | |12;stanford-crypto-pbkdf2;159;158;163;162;160;160;159;159;157;158 23:44:33 INFO - PROCESS | 11985 | |13;stanford-crypto-sha256-iterative;69;71;65;65;64;65;67;66;63;66 23:44:33 INFO - PROCESS | 11985 | __end_tp_report 23:44:33 INFO - PROCESS | 11985 | __start_cc_report 23:44:33 INFO - PROCESS | 11985 | _x_x_mozilla_cycle_collect,840 23:44:33 INFO - PROCESS | 11985 | __end_cc_report 23:44:33 INFO - PROCESS | 11985 | __startTimestamp1470811473519__endTimestamp 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | ------- Summary: start ------- 23:44:33 INFO - PROCESS | 11985 | Number of tests: 14 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:2.86 23:44:33 INFO - PROCESS | 11985 | Values: 104.0 114.0 106.0 110.0 112.0 112.0 112.0 115.0 115.0 114.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:148.50 stddev:25.92 (17.5%) stddev-sans-first:27.42 23:44:33 INFO - PROCESS | 11985 | Values: 150.0 121.0 148.0 190.0 119.0 144.0 149.0 121.0 184.0 120.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.46 (1.5%) stddev-sans-first:2.55 23:44:33 INFO - PROCESS | 11985 | Values: 162.0 161.0 163.0 163.0 164.0 164.0 170.0 163.0 163.0 162.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.87 (53.8%) stddev-sans-first:42.70 23:44:33 INFO - PROCESS | 11985 | Values: 75.0 76.0 76.0 175.0 76.0 75.0 76.0 76.0 170.0 75.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:84.00 stddev:27.60 (32.9%) stddev-sans-first:28.64 23:44:33 INFO - PROCESS | 11985 | Values: 85.0 84.0 142.0 84.0 85.0 83.0 146.0 84.0 84.0 135.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 23:44:33 INFO - PROCESS | 11985 | Values: 119.0 119.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:44:33 INFO - PROCESS | 11985 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 23:44:33 INFO - PROCESS | 11985 | Values: 96.0 98.0 97.0 96.0 97.0 97.0 96.0 97.0 97.0 97.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.90 (3.6%) stddev-sans-first:1.76 23:44:33 INFO - PROCESS | 11985 | Values: 55.0 50.0 51.0 52.0 56.0 53.0 51.0 52.0 51.0 53.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:1.34 (2.2%) stddev-sans-first:1.27 23:44:33 INFO - PROCESS | 11985 | Values: 59.0 61.0 60.0 61.0 64.0 60.0 60.0 60.0 61.0 61.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.80 (3.6%) stddev-sans-first:2.83 23:44:33 INFO - PROCESS | 11985 | Values: 76.0 76.0 80.0 82.0 77.0 77.0 76.0 77.0 84.0 79.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:134.00 stddev:19.47 (14.5%) stddev-sans-first:20.07 23:44:33 INFO - PROCESS | 11985 | Values: 124.0 131.0 145.0 134.0 134.0 124.0 124.0 137.0 189.0 128.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.50 stddev:1.84 (1.2%) stddev-sans-first:1.94 23:44:33 INFO - PROCESS | 11985 | Values: 159.0 158.0 163.0 162.0 160.0 160.0 159.0 159.0 157.0 158.0 23:44:33 INFO - PROCESS | 11985 | 23:44:33 INFO - PROCESS | 11985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:2.38 (3.6%) stddev-sans-first:2.28 23:44:33 INFO - PROCESS | 11985 | Values: 69.0 71.0 65.0 65.0 64.0 65.0 67.0 66.0 63.0 66.0 23:44:33 INFO - PROCESS | 11985 | -------- Summary: end -------- 23:44:33 INFO - PROCESS | 11985 | 23:44:34 INFO - TEST-INFO | 11985: exit 0 23:44:34 INFO - TEST-OK | kraken | took 61659ms 23:44:34 INFO - SUITE-END | took 1174s 23:44:34 INFO - Completed test suite (00:19:35) 23:44:34 INFO - javascript benchmark 23:44:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7486.5580227517075, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.7806353555247, 3133.905982820513, 3161.0674850918977, 3163.335699503104, 3170.080676603785, 5408.21580870774, 5420.105682562383, 5451.890962180759, 5475.09660905951, 5482.451754824516, 5437.782488700447, 5445.646033007852, 5457.072297709389, 5463.098588732854, 5534.197541356501, 4944.406671199461, 4962.08201482726, 4992.176290912013, 5029.06962211992, 5107.336046313974, 4856.17445034345, 4956.3804524434445, 4981.178105612587, 5032.144535428967, 5087.10975579274, 4870.43989941156, 4942.406911170682, 4966.056449274626, 4983.626228032894, 5022.221555658879, 4950.87622809429, 4971.676841005323, 4973.875653108665, 4980.277859710358, 5015.598752099823, 4776.928346074812, 4844.85465436034, 4844.975775121137, 4871.269309603553, 4878.048780487807, 5361.973190134025, 5422.945770542284, 5475.863103422406, 5483.150111732688, 5503.972480137613, 5773.740181691834, 5780.335261444946, 5790.971045144747, 5793.044147715622, 5806.506446952014, 5701.600887937846, 5760.7695692172265, 5823.359430462646, 5842.444967728059, 5852.853678658025, 5426.810061647863, 5463.945360546423, 5485.204645326406, 5512.310961129859, 5519.503244707996, 5983.491403230687, 5993.0710739835395, 5993.430624090704, 5997.400259973968, 6009.188759517409, 5513.972430137904, 5639.802606908821, 5686.147077938343, 5709.3719690834805, 5709.7716091356715, 5581.720913954286, 5724.542036637059, 5752.36723960364, 5777.162311464814, 5823.650580965155, 5828.125781132864, 5838.0, 5841.240638717025, 5844.094165404369, 5848.152017957373, 5778.508826749689, 5853.64878107315, 5855.824325270249, 5857.355690874, 5859.355470898197, 4348.304271316574, 4406.449193850769, 4426.203283409017, 4439.445069366329, 4482.0, 3945.546262179829, 3975.2248311578965, 3988.6210809973004, 4008.0781420272915, 4015.357542793139, 5558.249636299048, 5602.803901863415, 5611.242482264924, 5613.298337707786, 5615.691136987423, 5677.14842773579, 5786.623869448473, 5817.912731309034, 5848.298204215522, 5907.497862681635, 5518.172274158828, 5598.384177740527, 5615.971920140455, 5622.184783206412, 5625.6905870176715, 4999.975000124976, 5009.724465154379, 5015.974920125376, 5022.347094877642, 5049.368828896388, 5889.0, 5924.052151655715, 5930.140129681172, 5977.342492325841, 5991.951408503407, 5809.62237454581, 5847.619904706181, 5849.53203743708, 5849.883002339844, 5891.410858914246, 5989.2812862456785, 6037.09443583466, 6053.757849685963, 6056.3035250946705, 6076.483498902466, 5612.607117501736, 5703.20155178267, 5738.569607279387, 5742.397048310035, 5757.539396848326, 5887.322957859729, 5896.852578685567, 5902.1441890926435, 5902.468777810018, 5919.644821310735, 5680.346760122638, 5727.369989301257, 5730.08318669011, 5730.283714535683, 5738.885222295614, 5546.916796247979, 5630.23991761107, 5638.85902852432, 5664.716764161858, 5727.5417966561745, 5601.579881508985, 5623.100303951348, 5633.267675202197, 5637.8590535236945, 5681.687507187145, 5676.176954341515, 5720.685362305113, 5738.655680659173, 5774.566907481872, 5775.566832487664, 5454.209139674805, 5551.500364967173, 5577.609567330248, 5614.85962850932, 5618.887622247614], "value": 5370.325959338298, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.2103431310021, 575.7927146227358, 589.1898639370866, 599.8290487211144, 617.0959544267647, 40151.59848401519, 43977.0, 44060.0, 44109.77945110278, 44316.3352549712, 44204.0, 44348.0, 44664.3300350495, 44670.0, 44750.32874506877, 8812.427192232517, 8903.688370907019, 8958.37291389603, 8963.820723585524, 8976.551172441352, 8781.736547903573, 8912.108789121101, 8918.152775486318, 8919.598618062202, 8943.284537237005, 8977.910220897773, 9013.188813006827, 9042.095790420972, 9042.23141033013, 9066.18404343609, 8908.376413651047, 8958.328125390623, 8963.327750418679, 8968.0, 8984.460932344015, 8685.826283474358, 8686.913130868674, 8714.520701361422, 8775.64897404103, 8797.252233560155, 42224.57775422268, 42490.57509424897, 42502.149957000685, 42504.3624345635, 42562.148757024996, 3506.3738745431183, 3830.157365379612, 4018.7789671568053, 4057.58968094209, 4363.040131171138, 32859.0, 33194.50208246878, 33286.6671333286, 33348.49977250343, 34948.5051494851, 4102.589741025903, 4157.833686652531, 4186.497620285555, 4189.937150942738, 4354.259775838115, 345189.0, 352861.17847054027, 354047.0, 354914.0, 355272.99999999744, 58406.415935840945, 59005.0, 59075.0, 59105.11342329869, 59134.0, 61630.69184654138, 61869.07196392058, 62008.379916201164, 62134.689326553074, 62357.68821155956, 16377.0, 16663.83336166647, 16676.0, 16685.416010439818, 16821.158942052847, 13353.399097040656, 13362.599122026355, 13438.596842094752, 13445.924326053891, 13451.663708407368, 15878.0, 17405.47783566495, 17415.56461088483, 17496.21267042986, 17732.734008989875, 5734.426557344315, 5752.827415177468, 5752.9712351437975, 5833.620814647034, 5920.467157955804, 887.6848718704766, 983.5967253426061, 1051.5793682526898, 1067.4769363012067, 1076.1982323169289, 29855.0, 30080.398392032475, 30390.54414183789, 30532.38935221283, 31019.379612407625, 1090.334895713614, 1091.2361347057092, 1145.6563031090639, 1160.9941950290195, 1232.9876701232872, 16263.18684065792, 16334.918325408296, 16548.83451165497, 16621.83378166227, 17078.57303567396, 470068.0, 473163.0, 473278.0, 473750.0, 478681.0, 59329.0, 59511.70244148751, 59652.403475965555, 59655.403445964985, 59968.0, 1282.51264519482, 1343.879050885425, 1345.8855997240148, 1367.4325155060737, 1368.726254749054, 28374.57438138388, 29727.256818578844, 29823.552646709883, 30001.849990749906, 30567.08298751041, 51625.22562161646, 51804.0, 51911.22133168081, 51938.74030629823, 52117.21824172565, 428453.0, 430059.0, 430606.0, 430663.0, 431393.0, 43161.56838431701, 43242.13515729605, 43737.90655233645, 44296.778516108505, 44383.33424998563, 48761.0, 49164.0, 49336.0, 50068.749656251486, 50069.0, 41598.58401416068, 42261.57738422576, 43085.78457107695, 43634.12731745284, 44671.0, 41508.169836602494, 41555.792221038704, 42600.147997040505, 42918.0, 43778.78110609554, 35211.64788352084, 36390.0, 36411.27177456489, 36476.63523364732, 36481.0, 32544.34911301808, 37317.81341093277, 37948.24103517859, 38473.0, 38522.61477385303, 25755.742442575334, 26219.344516387242, 26467.470650587267, 28050.719492804812, 28483.0], "value": 20151.27727254776, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.51126280204323, 385.30452533177623, 400.7775684495105, 401.27369461275083, 422.1915032712356, 13565.389557469913, 18365.265389384407, 19066.142023608936, 19733.901330493347, 19735.703964440545, 19114.139863706132, 19231.230750769988, 19526.804731952678, 20219.0, 20349.898250508726, 5761.279840019987, 5907.320658124328, 5922.2005029321135, 5956.434138756833, 6002.189704389917, 5734.168545560912, 5893.941060589382, 5928.258967629046, 5935.050391937291, 5946.316173640043, 5748.856278593027, 5823.2138661280605, 5884.735186916578, 5900.203472531196, 5909.231799866011, 5813.186153938452, 5867.970660146715, 5881.2354393928945, 5888.911666324987, 5898.705064746746, 5034.748262586892, 5178.818741344073, 5240.135377662681, 5251.973740131275, 5265.394479634852, 23780.286591402284, 23980.28059158228, 24207.757922420726, 24257.0, 24515.754842451526, 2428.659987601737, 2439.438929046329, 2521.1932181701864, 2640.379510814957, 2858.828470291789, 15004.774928376082, 15035.54893353201, 15063.0, 15197.772033419507, 15382.692346153126, 1945.737325461073, 2001.319551352547, 2056.5167185711493, 2062.742157230346, 2118.756343020557, 93187.0, 93724.0, 96676.51661741716, 99754.5012274934, 102668.48665756699, 17757.556061098578, 17811.910940445214, 18078.45764627063, 18242.179101940445, 18639.720404193948, 32336.191595210308, 32418.189545261557, 32668.18329541733, 32753.344933101205, 32824.50763238553, 9945.104940555384, 10018.448985305879, 10151.695449136538, 10271.589136434459, 10606.204534659932, 8189.099199088096, 8240.62917168729, 8383.0, 8445.113263107409, 8945.865812012826, 8593.52735599548, 8908.821823563492, 8979.685711000084, 9191.494467804336, 9220.53897305132, 3547.746842495347, 3595.5865075516126, 3597.7481576289933, 3696.131409118855, 3706.981465092711, 827.3009307135461, 964.3972517176765, 1004.7002064111869, 1017.9236557258236, 1025.763834840041, 18347.0, 18840.15219315134, 18983.33558325452, 19315.80684193168, 19949.700754488695, 952.5237381309346, 972.6060945317158, 1000.0849222961054, 1041.1982773264544, 1088.983665245022, 9529.761755956019, 10841.945790270998, 11013.339199648046, 11029.227954043301, 11151.721206969729, 385776.0, 387944.0, 391714.0, 490496.0, 503281.0, 89360.5531972336, 91782.0, 95827.0, 100230.4988475053, 101504.0, 985.7831277119022, 1010.777628921636, 1035.6478797208986, 1044.3055368180228, 1045.3518818332682, 16437.58906027359, 17847.46457606274, 17951.73072403941, 17993.910030449762, 18135.546611334295, 36913.63086369102, 40306.59693403028, 41974.58025419829, 44023.339649904636, 46184.30723539217, 64875.67562162159, 65445.345546543926, 66011.0, 66081.0, 66833.66583167248, 7994.760157195294, 8201.630926608197, 8274.379421543288, 8384.203500667427, 8388.161183881562, 11919.52321907114, 13088.80366794518, 13220.801687974496, 13430.529931452353, 13513.39189736484, 10592.947035264775, 10750.784984300426, 11090.279131856727, 11307.660770176908, 11596.536138554364, 11346.0, 11510.654680359603, 11750.58872939443, 11798.0, 12062.698432539257, 10942.45287735626, 10971.396573188551, 11017.283876548, 11131.109511239243, 11350.318980861175, 7760.3403710685225, 8117.1071182168735, 8170.754877353689, 8241.0, 8557.015943166367, 10244.64143754965, 11162.944185279346, 11333.150013748836, 11336.546538138382, 11655.0], "value": 10128.151267299541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.5654160293511, 1503.1957902522151, 1672.4062957650035, 1758.1824451629989, 1783.0638914569856, 8054.154313797055, 8526.44578102423, 8621.568921553928, 9257.213136883365, 9290.21033212177, 8573.614187361569, 8767.167119123673, 8841.292696584274, 8855.557222138883, 8876.112388761121, 2396.1972739132366, 2437.792787613055, 2440.3655049687122, 2444.608862581987, 2448.7673671001317, 2387.1883559589737, 2410.0841680161516, 2413.4328432818274, 2424.7575242475787, 2429.0526694589034, 2364.84628499147, 2391.246757271454, 2401.6757737705448, 2413.80689544836, 2415.420299128214, 2289.7252329720372, 2303.2053941390195, 2306.423394151462, 2337.9766202338014, 2340.239422187787, 2184.7050648162453, 2185.9781402185936, 2190.3319487556287, 2202.0201010550313, 2206.4594174427207, 8930.062343453908, 8944.0, 9008.729738107868, 9011.45931244121, 9015.639374425014, 5345.946540534584, 5363.980843639735, 5490.478404551562, 5548.639338442988, 5571.4428557144365, 3372.8650853966055, 3373.6120346160014, 3402.2004828865197, 3425.0, 3453.1539772755837, 1043.002649925392, 1078.1267173589417, 2040.5918816236813, 2173.7065496157975, 2191.079746506455, 12734.0, 12875.291858947849, 12880.935595321964, 12909.096363254575, 12960.287184204864, 4680.92124410641, 4747.169245382113, 4769.379980602499, 4859.222524396079, 4888.633352498577, 9939.105480506789, 9946.303758736964, 9971.0, 9977.900220997843, 10026.64906728261, 5498.670079795145, 5504.174373843955, 5507.228987941691, 5514.448555144453, 5525.171224316385, 4555.681102322872, 4904.60763138948, 5001.349824522861, 5057.0, 5158.974205129025, 3628.8004159771467, 3734.887953361349, 3843.404272337792, 3889.0471834400187, 3899.7855117968215, 1174.0666170394557, 1181.4447209811374, 1196.2403873540366, 1202.7053371923935, 1210.3706072842074, 867.5011868175698, 956.93779904306, 963.8939716631165, 970.7864269860619, 993.8459538771502, 5600.551955843523, 5831.79588714393, 5918.940810591925, 6093.177421048102, 6108.144859719643, 931.6599441203912, 969.8593703912893, 983.9606415743433, 984.4437892590663, 1029.3772267778036, 4039.6768258539246, 4225.133847561243, 4267.317229243306, 4286.5284818669925, 4309.978450107729, 11487.655370338904, 11848.045072563104, 11867.228630139014, 11876.940615296868, 11882.108841836896, 11673.299602023906, 11698.35659038761, 11779.941100294443, 11813.350265735467, 11854.466549005316, 8165.265126138676, 8328.583570821434, 8472.449290795956, 8485.0, 8521.233089022018, 5722.370539240597, 5845.41545845412, 5906.0845568935165, 5964.0, 6049.274087109575, 9742.220622350336, 10053.597856085675, 10139.695809125738, 10210.693679189637, 10243.180545556188, 10113.190944724258, 10319.690409287734, 10367.27429079957, 10404.502919299464, 10542.631007914686, 7912.0, 8475.194856488624, 8728.170823771732, 8772.868406973774, 8839.867401988846, 8951.32865035138, 9008.054154313964, 9071.59177837012, 9083.18251357381, 9120.543972801466, 8078.515289082674, 8087.272145506698, 8089.069756978023, 8278.130796266547, 8369.455985360932, 7837.7648670539975, 7962.761117166494, 8065.395095367989, 8185.058718247477, 8292.83414331722, 7246.130464344313, 7306.926930730838, 7325.6337183141695, 7343.302386273295, 7415.1101867776215, 5011.348524691767, 5051.545360917535, 5065.924011139762, 5087.109755792795, 5179.81870634526, 5329.866753331043, 5356.946430535645, 5373.758180881791, 5416.593755468434, 5515.641483303572], "value": 4799.727303339463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.6889551835982, 335.7565764820505, 346.4629823773152, 349.76390936118116, 352.35870715298165, 5377.8117765878205, 5452.809151679692, 5532.170174473831, 5555.944440555599, 5623.240862483563, 5516.475934786199, 5524.812165384442, 5528.44715528447, 5536.4186760390185, 5539.612227144102, 4334.1765064637775, 4344.848615116996, 4348.760603228081, 4352.564743525654, 4352.673549483793, 4104.6716262699065, 4276.0, 4306.5262821089655, 4357.455318085239, 4360.498542667602, 4262.126264115865, 4269.6157345838865, 4279.786010699452, 4282.421873047146, 4294.398784170218, 4265.168292183041, 4268.509121451042, 4275.657947364203, 4279.87160385189, 4292.720973136736, 3596.514470546469, 3746.756460830037, 3754.1740817020213, 3766.7928263945473, 3779.9244015119543, 5385.569154467633, 5392.892142157135, 5393.595480338951, 5394.217838413448, 5402.6758394496455, 4861.8784530386665, 4867.4889136640495, 4880.7554073711335, 4905.901881962341, 4910.435299940516, 5557.972210138963, 5650.5479561634975, 5737.594289399082, 5740.339860916007, 5745.770169193227, 4095.795210239506, 4112.115895082542, 4117.773522456264, 4118.979405102956, 4120.896977575585, 5789.478946894757, 5907.970460147715, 5921.674307913063, 5960.0, 5979.312379076418, 4129.731567448106, 4139.19285739284, 4156.501219853637, 4168.6665066794585, 4172.061286210578, 4212.3681447782465, 4220.493540775126, 4226.915461690811, 4230.873073807791, 4231.61915427613, 4837.7097374157665, 4839.661223714306, 4848.17581011229, 4856.902861942742, 4862.197737373364, 5617.915731264035, 5631.690257035821, 5648.548116150698, 5722.628029178173, 5732.480892563474, 1460.8831293496708, 1468.4199741102418, 1474.6064968604567, 1476.1364601708121, 1476.8670819626286, 910.2035718746097, 930.3348106104032, 943.8489841625444, 947.3090533397989, 957.3968399908014, 4882.5605695487575, 4892.877678058077, 4901.0, 4975.328330675385, 5017.982017982018, 5172.586193104543, 5201.739913004335, 5202.193659982633, 5203.765830537635, 5232.738363081907, 4664.813407463664, 4901.632377571696, 4947.678400903929, 4962.454130045692, 4965.453800081988, 2754.2701184186208, 2759.2412086676322, 2760.544510155842, 2778.70823563527, 2779.291280723443, 5306.575473962073, 5381.546982314753, 5387.875032481152, 5395.541378982752, 5399.244105825188, 5262.973720124539, 5309.424928909476, 5630.042892708249, 6026.487748541423, 6145.87967151332, 6112.327643959161, 6181.567290289727, 6225.132460261903, 6238.251409830849, 6256.343083976208, 5905.320888097924, 5910.449847023043, 6015.608985415934, 6027.8848413043725, 6044.455998960115, 5863.824085277449, 5870.354261031369, 5906.645601263938, 5908.911366329423, 5910.408959104056, 6158.04550294705, 6173.074038894202, 6179.16581261524, 6180.938190618036, 6192.504599631929, 4054.8378064878257, 4245.0, 4275.209086318917, 4289.635380992526, 4290.871273861789, 5823.213866128188, 5912.379200183918, 5912.46787789101, 5925.259342582177, 5990.7004649768205, 5753.338366087786, 5803.622764520462, 5815.447532484407, 5824.592278540462, 5827.3007239131575, 5785.190073389645, 5811.476967072984, 5826.388229235869, 5840.474357307863, 5889.852753681193, 5581.218629391808, 5744.597878148489, 5783.826485205451, 5785.508231800176, 5806.44838740319, 5838.883222335615, 5873.588848780544, 5886.38192989747, 5907.91138132937, 5916.911246331395, 5473.343198816008, 5748.655080695172, 5766.509846663081, 5780.364159942487, 5782.595218334676], "value": 4319.700342170174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.7948615415376, 730.0509337860783, 736.4771012581067, 752.7177308509309, 759.9164091949888, 13974.93012534936, 14026.649333766649, 14738.336774845131, 14830.925845370784, 14858.479953201626, 15077.6984460311, 15148.469803556878, 15195.088294702326, 15229.543113706579, 15243.92378038111, 807.8747794091911, 811.995940020299, 821.765796747927, 823.7487566292278, 828.883956246123, 823.4647479138548, 836.5315423362936, 838.9077201507829, 839.2782207301716, 839.7564706235185, 867.9218870301671, 875.5403413208053, 879.9384043116985, 880.1770344727701, 880.2649787427474, 870.9433886797337, 872.0363997782454, 872.7905302727299, 873.1617647058831, 874.5976850648709, 630.4483576870239, 637.1207733328024, 638.4413638066692, 639.5491178718992, 640.1326202994968, 14733.852661473355, 14842.183679897602, 14907.701845963129, 14991.475298364614, 15000.0, 14127.223002734845, 14959.551213463614, 15228.238588070551, 15337.156456394894, 15424.691506169815, 12412.62762117138, 12460.563880264148, 12727.809082863765, 12731.299778512179, 13033.348332583333, 3900.941485877714, 4057.0871553900433, 4105.856295029689, 4126.834926602963, 4139.482564679415, 86059.0, 86577.0, 88568.0, 89288.55355723244, 90219.54890225508, 11385.487653055467, 11686.47410866513, 11954.880451195551, 12092.334921579397, 12140.392980350947, 21793.891030545063, 22179.445513862283, 22185.556288874133, 22200.11199552032, 22252.0, 7952.403569732178, 7967.521948682982, 7999.400044996649, 8287.0, 8320.251177394064, 4617.722936623813, 4671.416072990876, 4717.43390793107, 4747.406574178228, 4786.569208771228, 3507.964920350764, 3608.9278214435562, 3627.5284213052664, 3640.0717816957035, 3657.6708096271464, 588.6115163991831, 601.6841158391792, 607.6657838188978, 611.6758118197363, 629.8330942300294, 701.1971292869636, 725.7060890339421, 734.6326836581709, 740.9740659076906, 743.9590822504706, 9734.561944712505, 9856.162226210708, 10027.997200279913, 10091.798164036825, 10201.438920859275, 682.2938258902012, 683.4327508168209, 716.4089626058418, 721.6412866287669, 744.7132853851306, 4854.393200849894, 4917.166723151447, 4919.581835543947, 4980.8792074468565, 5073.7716802743225, 125993.0, 126703.0, 128635.35682321529, 131544.0, 134671.0, 106894.46552767187, 109013.0, 109228.0, 113409.43295283636, 115219.0, 76191.0, 76593.99999999888, 91713.95573243535, 100383.49808250912, 100758.49620751996, 10013.449260290463, 10717.142628589538, 10857.402842843403, 10876.238663293494, 11004.504797284302, 43282.56717432912, 44286.0, 50103.0, 51948.480515194366, 52880.206796897306, 52691.473085268655, 64852.675736621015, 65626.0, 66480.0, 69117.65441172762, 11011.394373309546, 11301.43492825339, 11319.603813866475, 13514.86485135136, 13713.314334283046, 13015.479380824661, 15021.624459388602, 15773.65550734405, 15838.9208053959, 16039.0, 13451.260180690157, 13598.388072536562, 14559.781603276171, 14706.63233419173, 15323.693526129638, 13994.930025349808, 14319.28403579796, 14351.856481435052, 14474.348654310792, 14972.401103955719, 13923.190941944422, 14015.649608759863, 14184.858151418353, 14400.42398304056, 14668.339924703201, 11791.941040295087, 12005.339706316236, 12116.939415302868, 12362.567310144103, 12498.37508124572, 11519.25124866881, 11567.768644626893, 11864.347460889734, 11922.344271065174, 12401.751964960831], "value": 7747.208972291913, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 106.0, 110.0, 112.0, 112.0, 112.0, 115.0, 115.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 148.0, 190.0, 119.0, 144.0, 149.0, 121.0, 184.0, 120.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 164.0, 164.0, 170.0, 163.0, 163.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 175.0, 76.0, 75.0, 76.0, 76.0, 170.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 142.0, 84.0, 85.0, 83.0, 146.0, 84.0, 84.0, 135.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 50.0, 51.0, 52.0, 56.0, 53.0, 51.0, 52.0, 51.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 61.0, 64.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 80.0, 82.0, 77.0, 77.0, 76.0, 77.0, 84.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 145.0, 134.0, 134.0, 124.0, 124.0, 137.0, 189.0, 128.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 163.0, 162.0, 160.0, 160.0, 159.0, 159.0, 157.0, 158.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 65.0, 65.0, 64.0, 65.0, 67.0, 66.0, 63.0, 66.0], "value": 66.1, "unit": "score"}]}]} 23:44:34 INFO - Return code: 0 23:44:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:44:34 ERROR - # TBPL SUCCESS # 23:44:34 INFO - Running post-action listener: _resource_record_post_action 23:44:34 INFO - [mozharness: 2016-08-10 06:44:34.828668Z] Finished run-tests step (success) 23:44:34 INFO - Running post-run listener: _resource_record_post_run 23:44:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551079936; Read time: 8; Write time: 578900 23:44:34 INFO - TinderboxPrint: CPU usage
13.4% 23:44:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:44:34 INFO - TinderboxPrint: I/O write bytes / time
551,079,936 / 578,900 23:44:34 INFO - TinderboxPrint: CPU idle
8,237.1 (86.6%) 23:44:34 INFO - TinderboxPrint: CPU user
1,213.9 (12.8%) 23:44:34 INFO - TinderboxPrint: Swap in / out
0 / 0 23:44:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258555904; Read time: 0; Write time: 323636 23:44:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 292155392; Read time: 0; Write time: 255212 23:44:35 INFO - Running post-run listener: _upload_blobber_files 23:44:35 INFO - Blob upload gear active. 23:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:35 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 23:44:35 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'] 23:44:35 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 23:44:35 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:36 INFO - (blobuploader) - INFO - Done attempting. 23:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:37 INFO - (blobuploader) - INFO - Done attempting. 23:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:44:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:41 INFO - (blobuploader) - INFO - Done attempting. 23:44:41 INFO - (blobuploader) - INFO - Iteration through files over. 23:44:41 INFO - Return code: 0 23:44:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:44:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:44:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d10cd964e8c511499eb30560a531558f830cc0de2401efd60b52b6efccf48bf175f8a64aa35925d0b9b74976f83aca6f242e99149bfa16c8f069cca4f15c9e88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4507a2a79bee060ca1220ec711ace90901b89206b2419e029f1e88fdc70e2ae5d4544a0dd76617bf99bfde0bf7784d997875d8a8edfd5e174896c45c431b2ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2569116c17fca02687d46f399ca9bb0d82735c225504dcd0ea2b7f68d7f4f1dec1a4d13a122d2c48dac0064585355a35e929aee879cec021d5e6f774d7ad4614"} 23:44:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:44:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:44:41 INFO - Contents: 23:44:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d10cd964e8c511499eb30560a531558f830cc0de2401efd60b52b6efccf48bf175f8a64aa35925d0b9b74976f83aca6f242e99149bfa16c8f069cca4f15c9e88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4507a2a79bee060ca1220ec711ace90901b89206b2419e029f1e88fdc70e2ae5d4544a0dd76617bf99bfde0bf7784d997875d8a8edfd5e174896c45c431b2ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2569116c17fca02687d46f399ca9bb0d82735c225504dcd0ea2b7f68d7f4f1dec1a4d13a122d2c48dac0064585355a35e929aee879cec021d5e6f774d7ad4614"} 23:44:41 INFO - Running post-run listener: copy_logs_to_upload_dir 23:44:41 INFO - Copying logs to upload dir... 23:44:41 INFO - mkdir: /builds/slave/test/build/upload/logs 23:44:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.777682 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-09 23:44:41.742741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 23:44:41.746680) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919 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/d10cd964e8c511499eb30560a531558f830cc0de2401efd60b52b6efccf48bf175f8a64aa35925d0b9b74976f83aca6f242e99149bfa16c8f069cca4f15c9e88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4507a2a79bee060ca1220ec711ace90901b89206b2419e029f1e88fdc70e2ae5d4544a0dd76617bf99bfde0bf7784d997875d8a8edfd5e174896c45c431b2ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2569116c17fca02687d46f399ca9bb0d82735c225504dcd0ea2b7f68d7f4f1dec1a4d13a122d2c48dac0064585355a35e929aee879cec021d5e6f774d7ad4614"} build_url:https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/Bx1HG7suR9S32CFMhYJS4w/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/d10cd964e8c511499eb30560a531558f830cc0de2401efd60b52b6efccf48bf175f8a64aa35925d0b9b74976f83aca6f242e99149bfa16c8f069cca4f15c9e88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4507a2a79bee060ca1220ec711ace90901b89206b2419e029f1e88fdc70e2ae5d4544a0dd76617bf99bfde0bf7784d997875d8a8edfd5e174896c45c431b2ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2569116c17fca02687d46f399ca9bb0d82735c225504dcd0ea2b7f68d7f4f1dec1a4d13a122d2c48dac0064585355a35e929aee879cec021d5e6f774d7ad4614"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 23:44:41.772300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:44:41.772621) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470808849.886049-600508919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004710 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 23:44:41.854464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 23:44:41.854832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 23:44:41.855125) ========= ========= Total master_lag: 0.18 =========