builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1470490241.06 results: success (0) buildid: 20160806023103 builduid: ac55196d6b4a407281d8aba8ab10c2c9 revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.062751) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.063246) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.063582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.078420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.078760) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-06 06:30:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.3M=0s 2016-08-06 06:30:41 (90.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129138 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.222585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.222950) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:41.272517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 06:30:41.272927) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --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 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --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=31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-06 06:30:41,552 truncating revision to first 12 chars 2016-08-06 06:30:41,552 Setting DEBUG logging. 2016-08-06 06:30:41,552 attempt 1/10 2016-08-06 06:30:41,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/115ec609a6bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 06:30:42,611 unpacking tar archive at: fx-team-115ec609a6bf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.384691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 06:30:42.672027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:42.672419) ========= script_repo_revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:42.672861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:42.673169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 06:30:42.683258) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-06 06:30:42.683604) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:30:43 INFO - MultiFileLogger online at 20160806 06:30:43 in /builds/slave/test 06:30:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:30:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:30:43 INFO - {'append_to_log': False, 06:30:43 INFO - 'base_work_dir': '/builds/slave/test', 06:30:43 INFO - 'blob_upload_branch': 'Fx-Team', 06:30:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:30:43 INFO - 'branch': 'Fx-Team', 06:30:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:30:43 INFO - 'config_files': ('talos/linux_config.py',), 06:30:43 INFO - 'default_actions': ('clobber', 06:30:43 INFO - 'read-buildbot-config', 06:30:43 INFO - 'download-and-extract', 06:30:43 INFO - 'populate-webroot', 06:30:43 INFO - 'create-virtualenv', 06:30:43 INFO - 'install', 06:30:43 INFO - 'run-tests'), 06:30:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:30:43 INFO - 'download_minidump_stackwalk': True, 06:30:43 INFO - 'download_symbols': 'ondemand', 06:30:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:30:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:30:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:30:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:30:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:30:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:30:43 INFO - 'installer_path': 'installer.exe', 06:30:43 INFO - 'log_level': 'info', 06:30:43 INFO - 'log_name': 'talos', 06:30:43 INFO - 'log_to_console': True, 06:30:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:30:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:30:43 INFO - 'opt_config_files': (), 06:30:43 INFO - 'pip_index': False, 06:30:43 INFO - 'sps_profile': False, 06:30:43 INFO - 'sps_profile_interval': 0, 06:30:43 INFO - 'suite': 'dromaeojs', 06:30:43 INFO - 'system_bits': '32', 06:30:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:30:43 INFO - 'title': 'talos-linux64-ix-014', 06:30:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:30:43 INFO - 'use_talos_json': True, 06:30:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:30:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:30:43 INFO - 'work_dir': 'build'} 06:30:43 INFO - [mozharness: 2016-08-06 13:30:43.062355Z] Running clobber step. 06:30:43 INFO - Running pre-action listener: _resource_record_pre_action 06:30:43 INFO - Running main action method: clobber 06:30:43 INFO - rmtree: /builds/slave/test/build 06:30:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:30:43 INFO - Running post-action listener: _resource_record_post_action 06:30:43 INFO - [mozharness: 2016-08-06 13:30:43.549937Z] Finished clobber step (success) 06:30:43 INFO - [mozharness: 2016-08-06 13:30:43.550038Z] Running read-buildbot-config step. 06:30:43 INFO - Running pre-action listener: _resource_record_pre_action 06:30:43 INFO - Running main action method: read_buildbot_config 06:30:43 INFO - Using buildbot properties: 06:30:43 INFO - { 06:30:43 INFO - "project": "", 06:30:43 INFO - "product": "firefox", 06:30:43 INFO - "script_repo_revision": "production", 06:30:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:30:43 INFO - "repository": "", 06:30:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:30:43 INFO - "buildid": "20160806023103", 06:30:43 INFO - "pgo_build": "True", 06:30:43 INFO - "basedir": "/builds/slave/test", 06:30:43 INFO - "buildnumber": 1434, 06:30:43 INFO - "slavename": "talos-linux64-ix-014", 06:30:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:30:43 INFO - "platform": "ubuntu64_hw", 06:30:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:30:43 INFO - "branch": "fx-team", 06:30:43 INFO - "repo_path": "integration/fx-team", 06:30:43 INFO - "revision": "115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1", 06:30:43 INFO - "stage_platform": "linux64-pgo", 06:30:43 INFO - "builduid": "ac55196d6b4a407281d8aba8ab10c2c9", 06:30:43 INFO - "slavebuilddir": "test" 06:30:43 INFO - } 06:30:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:30:43 INFO - Running post-action listener: _resource_record_post_action 06:30:43 INFO - [mozharness: 2016-08-06 13:30:43.552480Z] Finished read-buildbot-config step (success) 06:30:43 INFO - [mozharness: 2016-08-06 13:30:43.552608Z] Running download-and-extract step. 06:30:43 INFO - Running pre-action listener: _resource_record_pre_action 06:30:43 INFO - Running main action method: download_and_extract 06:30:43 INFO - mkdir: /builds/slave/test/build/tests 06:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:43 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:30:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:44 INFO - Downloaded 1361 bytes. 06:30:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:30:44 INFO - Using the following test package requirements: 06:30:44 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:30:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:30:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:30:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'jsshell-linux-x86_64.zip'], 06:30:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:30:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:30:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:30:44 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:30:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:30:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:30:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:30:44 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')]} 06:30:44 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:30:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:45 INFO - Downloaded 21824821 bytes. 06:30:45 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'] 06:30:45 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 06:30:46 INFO - Return code: 0 06:30:46 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 06:30:46 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')]} 06:30:46 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:30:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:47 INFO - Downloaded 21824821 bytes. 06:30:47 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'] 06:30:47 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 06:30:48 INFO - Return code: 0 06:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:48 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:30:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:49 INFO - Downloaded 14413723 bytes. 06:30:49 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'] 06:30:49 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 06:30:49 INFO - Return code: 0 06:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:49 INFO - trying https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:30:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/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 06:30:50 INFO - Downloaded 59971237 bytes. 06:30:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:30:50 INFO - mkdir: /builds/slave/test/properties 06:30:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:30:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:30:50 INFO - Contents: 06:30:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:30:51 INFO - Running post-action listener: _resource_record_post_action 06:30:51 INFO - Running post-action listener: set_extra_try_arguments 06:30:51 INFO - [mozharness: 2016-08-06 13:30:51.629071Z] Finished download-and-extract step (success) 06:30:51 INFO - [mozharness: 2016-08-06 13:30:51.629306Z] Running populate-webroot step. 06:30:51 INFO - Running pre-action listener: _resource_record_pre_action 06:30:51 INFO - Running main action method: populate_webroot 06:30:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:30:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:30:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:30:51 INFO - '--tppagecycles', 06:30:51 INFO - '7'], 06:30:51 INFO - 'tests': ['tsvgm']}}, 06:30:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:30:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:30:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:30:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:30:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['damp', 'tps']}, 06:30:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'tests': ['damp', 'tps']}, 06:30:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['dromaeo_dom']}, 06:30:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:30:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['basic_compositor_video']}, 06:30:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:30:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other-e10s': {'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tsvgx', 06:30:51 INFO - 'tsvgr_opacity', 06:30:51 INFO - 'tart', 06:30:51 INFO - 'tscrollx', 06:30:51 INFO - 'cart']}, 06:30:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:30:51 INFO - 'tsvgr_opacity', 06:30:51 INFO - 'tart', 06:30:51 INFO - 'tscrollx', 06:30:51 INFO - 'cart']}, 06:30:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tp5o']}, 06:30:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'tests': ['tp5o']}, 06:30:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s', 06:30:51 INFO - '--xperf_path', 06:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:51 INFO - 'tests': ['tp5n']}, 06:30:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--xperf_path', 06:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:51 INFO - 'tests': ['tp5n']}}, 06:30:51 INFO - 'talos.zip': {'path': '', 06:30:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:30:51 INFO - Running post-action listener: _resource_record_post_action 06:30:51 INFO - [mozharness: 2016-08-06 13:30:51.644807Z] Finished populate-webroot step (success) 06:30:51 INFO - [mozharness: 2016-08-06 13:30:51.644897Z] Running create-virtualenv step. 06:30:51 INFO - Running pre-action listener: _resource_record_pre_action 06:30:51 INFO - Running main action method: create_virtualenv 06:30:51 INFO - Creating virtualenv /builds/slave/test/build/venv 06:30:51 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 06:30:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:30:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:30:51 INFO - Using real prefix '/usr' 06:30:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:30:52 INFO - Installing distribute.............................................................................................................................................................................................done. 06:30:54 INFO - Installing pip.................done. 06:30:54 INFO - Return code: 0 06:30:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:54 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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:30:54 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 06:30:54 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 06:30:54 INFO - Using env: {'DISPLAY': ':0', 06:30:54 INFO - 'HOME': '/home/cltbld', 06:30:54 INFO - 'LANG': 'en_US.UTF-8', 06:30:54 INFO - 'LANGUAGE': 'en_US:en', 06:30:54 INFO - 'LOGNAME': 'cltbld', 06:30:54 INFO - 'MAIL': '/var/mail/cltbld', 06:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:54 INFO - 'MOZ_NO_REMOTE': '1', 06:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:54 INFO - 'NO_EM_RESTART': '1', 06:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:54 INFO - 'PWD': '/builds/slave/test', 06:30:54 INFO - 'SHELL': '/bin/bash', 06:30:54 INFO - 'SHLVL': '1', 06:30:54 INFO - 'TERM': 'linux', 06:30:54 INFO - 'TMOUT': '86400', 06:30:54 INFO - 'USER': 'cltbld', 06:30:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:54 INFO - '_': '/tools/buildbot/bin/python'} 06:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:54 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 06:30:54 INFO - Cleaning up... 06:30:54 INFO - Return code: 0 06:30:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:54 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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:30:54 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 06:30:54 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 06:30:54 INFO - Using env: {'DISPLAY': ':0', 06:30:54 INFO - 'HOME': '/home/cltbld', 06:30:54 INFO - 'LANG': 'en_US.UTF-8', 06:30:54 INFO - 'LANGUAGE': 'en_US:en', 06:30:54 INFO - 'LOGNAME': 'cltbld', 06:30:54 INFO - 'MAIL': '/var/mail/cltbld', 06:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:54 INFO - 'MOZ_NO_REMOTE': '1', 06:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:54 INFO - 'NO_EM_RESTART': '1', 06:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:54 INFO - 'PWD': '/builds/slave/test', 06:30:54 INFO - 'SHELL': '/bin/bash', 06:30:54 INFO - 'SHLVL': '1', 06:30:54 INFO - 'TERM': 'linux', 06:30:54 INFO - 'TMOUT': '86400', 06:30:54 INFO - 'USER': 'cltbld', 06:30:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:54 INFO - '_': '/tools/buildbot/bin/python'} 06:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:54 INFO - Downloading/unpacking psutil>=3.1.1 06:30:54 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 06:30:54 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 06:30:54 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 06:30:54 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 06:30:54 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 06:30:54 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 06:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:30:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:56 INFO - Installing collected packages: psutil 06:30:56 INFO - Running setup.py install for psutil 06:30:56 INFO - building 'psutil._psutil_linux' extension 06:30:56 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 06:30:56 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 06:30:56 INFO - building 'psutil._psutil_posix' extension 06:30:56 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 06:30:57 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 06:30:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:57 INFO - Successfully installed psutil 06:30:57 INFO - Cleaning up... 06:30:57 INFO - Return code: 0 06:30:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:30:57 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')]} 06:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:57 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')]} 06:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:57 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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:30:57 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 06:30:57 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 06:30:57 INFO - Using env: {'DISPLAY': ':0', 06:30:57 INFO - 'HOME': '/home/cltbld', 06:30:57 INFO - 'LANG': 'en_US.UTF-8', 06:30:57 INFO - 'LANGUAGE': 'en_US:en', 06:30:57 INFO - 'LOGNAME': 'cltbld', 06:30:57 INFO - 'MAIL': '/var/mail/cltbld', 06:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:57 INFO - 'MOZ_NO_REMOTE': '1', 06:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:57 INFO - 'NO_EM_RESTART': '1', 06:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:57 INFO - 'PWD': '/builds/slave/test', 06:30:57 INFO - 'SHELL': '/bin/bash', 06:30:57 INFO - 'SHLVL': '1', 06:30:57 INFO - 'TERM': 'linux', 06:30:57 INFO - 'TMOUT': '86400', 06:30:57 INFO - 'USER': 'cltbld', 06:30:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:57 INFO - '_': '/tools/buildbot/bin/python'} 06:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:30:57 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 06:30:57 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 06:30:57 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 06:30:57 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 06:30:57 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 06:30:57 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 06:30:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:30:59 INFO - Installing collected packages: mozsystemmonitor 06:30:59 INFO - Running setup.py install for mozsystemmonitor 06:30:59 INFO - Successfully installed mozsystemmonitor 06:30:59 INFO - Cleaning up... 06:30:59 INFO - Return code: 0 06:30:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:30: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')]} 06:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30: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')]} 06:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:30:59 INFO - Using env: {'DISPLAY': ':0', 06:30:59 INFO - 'HOME': '/home/cltbld', 06:30:59 INFO - 'LANG': 'en_US.UTF-8', 06:30:59 INFO - 'LANGUAGE': 'en_US:en', 06:30:59 INFO - 'LOGNAME': 'cltbld', 06:30:59 INFO - 'MAIL': '/var/mail/cltbld', 06:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:59 INFO - 'MOZ_NO_REMOTE': '1', 06:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:59 INFO - 'NO_EM_RESTART': '1', 06:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:59 INFO - 'PWD': '/builds/slave/test', 06:30:59 INFO - 'SHELL': '/bin/bash', 06:30:59 INFO - 'SHLVL': '1', 06:30:59 INFO - 'TERM': 'linux', 06:30:59 INFO - 'TMOUT': '86400', 06:30:59 INFO - 'USER': 'cltbld', 06:30:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:59 INFO - '_': '/tools/buildbot/bin/python'} 06:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:59 INFO - Downloading/unpacking jsonschema==2.5.1 06:30:59 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 06:30:59 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 06:30:59 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 06:30:59 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 06:30:59 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 06:30:59 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 06:31:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:31:01 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 06:31:01 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 06:31:01 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 06:31:01 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 06:31:01 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 06:31:01 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 06:31:01 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:01 INFO - warning: no files found matching '*.txt' 06:31:01 INFO - no previously-included directories found matching 'build' 06:31:01 INFO - no previously-included directories found matching 'dist' 06:31:01 INFO - no previously-included directories found matching '.git*' 06:31:01 INFO - Installing collected packages: jsonschema, functools32 06:31:01 INFO - Running setup.py install for functools32 06:31:01 INFO - warning: no files found matching '*.txt' 06:31:01 INFO - no previously-included directories found matching 'build' 06:31:01 INFO - no previously-included directories found matching 'dist' 06:31:01 INFO - no previously-included directories found matching '.git*' 06:31:01 INFO - Successfully installed jsonschema functools32 06:31:01 INFO - Cleaning up... 06:31:02 INFO - Return code: 0 06:31:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:31:02 INFO - Using env: {'DISPLAY': ':0', 06:31:02 INFO - 'HOME': '/home/cltbld', 06:31:02 INFO - 'LANG': 'en_US.UTF-8', 06:31:02 INFO - 'LANGUAGE': 'en_US:en', 06:31:02 INFO - 'LOGNAME': 'cltbld', 06:31:02 INFO - 'MAIL': '/var/mail/cltbld', 06:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:02 INFO - 'MOZ_NO_REMOTE': '1', 06:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:02 INFO - 'NO_EM_RESTART': '1', 06:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:02 INFO - 'PWD': '/builds/slave/test', 06:31:02 INFO - 'SHELL': '/bin/bash', 06:31:02 INFO - 'SHLVL': '1', 06:31:02 INFO - 'TERM': 'linux', 06:31:02 INFO - 'TMOUT': '86400', 06:31:02 INFO - 'USER': 'cltbld', 06:31:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:02 INFO - '_': '/tools/buildbot/bin/python'} 06:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:31:02 INFO - Cleaning up... 06:31:02 INFO - Return code: 0 06:31:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:31:02 INFO - Using env: {'DISPLAY': ':0', 06:31:02 INFO - 'HOME': '/home/cltbld', 06:31:02 INFO - 'LANG': 'en_US.UTF-8', 06:31:02 INFO - 'LANGUAGE': 'en_US:en', 06:31:02 INFO - 'LOGNAME': 'cltbld', 06:31:02 INFO - 'MAIL': '/var/mail/cltbld', 06:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:02 INFO - 'MOZ_NO_REMOTE': '1', 06:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:02 INFO - 'NO_EM_RESTART': '1', 06:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:02 INFO - 'PWD': '/builds/slave/test', 06:31:02 INFO - 'SHELL': '/bin/bash', 06:31:02 INFO - 'SHLVL': '1', 06:31:02 INFO - 'TERM': 'linux', 06:31:02 INFO - 'TMOUT': '86400', 06:31:02 INFO - 'USER': 'cltbld', 06:31:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:02 INFO - '_': '/tools/buildbot/bin/python'} 06:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:02 INFO - Downloading/unpacking blobuploader==1.2.4 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:31:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:31:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:05 INFO - Downloading docopt-0.6.1.tar.gz 06:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:31:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:31:05 INFO - Running setup.py install for blobuploader 06:31:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:31:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:31:05 INFO - Running setup.py install for requests 06:31:05 INFO - Running setup.py install for docopt 06:31:05 INFO - Successfully installed blobuploader requests docopt 06:31:05 INFO - Cleaning up... 06:31:05 INFO - Return code: 0 06:31:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:05 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')]} 06:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:05 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')]} 06:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:05 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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:31:05 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 06:31:05 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 06:31:05 INFO - Using env: {'DISPLAY': ':0', 06:31:05 INFO - 'HOME': '/home/cltbld', 06:31:05 INFO - 'LANG': 'en_US.UTF-8', 06:31:05 INFO - 'LANGUAGE': 'en_US:en', 06:31:05 INFO - 'LOGNAME': 'cltbld', 06:31:05 INFO - 'MAIL': '/var/mail/cltbld', 06:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:05 INFO - 'MOZ_NO_REMOTE': '1', 06:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:05 INFO - 'NO_EM_RESTART': '1', 06:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:05 INFO - 'PWD': '/builds/slave/test', 06:31:05 INFO - 'SHELL': '/bin/bash', 06:31:05 INFO - 'SHLVL': '1', 06:31:05 INFO - 'TERM': 'linux', 06:31:05 INFO - 'TMOUT': '86400', 06:31:05 INFO - 'USER': 'cltbld', 06:31:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:05 INFO - '_': '/tools/buildbot/bin/python'} 06:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:05 INFO - Running setup.py (path:/tmp/pip-MQtaFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:05 INFO - Running setup.py (path:/tmp/pip-nfoRn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:06 INFO - Running setup.py (path:/tmp/pip-ecZdXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:06 INFO - Running setup.py (path:/tmp/pip-cdt7On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:06 INFO - Running setup.py (path:/tmp/pip-hB62_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:06 INFO - Running setup.py (path:/tmp/pip-y3cMw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:06 INFO - Running setup.py (path:/tmp/pip-UCjGVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:06 INFO - Running setup.py (path:/tmp/pip-H8Yynp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:06 INFO - Running setup.py (path:/tmp/pip-xTQ4Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:06 INFO - Running setup.py (path:/tmp/pip-wGksY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:06 INFO - Running setup.py (path:/tmp/pip-kfIpEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:06 INFO - Running setup.py (path:/tmp/pip-xSKlJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:06 INFO - Running setup.py (path:/tmp/pip-T_53f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:06 INFO - Running setup.py (path:/tmp/pip-NAYPHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:06 INFO - Running setup.py (path:/tmp/pip-2j8kLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:06 INFO - Running setup.py (path:/tmp/pip-B6_OWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:07 INFO - Running setup.py (path:/tmp/pip-PXHqdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:31:07 INFO - Running setup.py install for manifestparser 06:31:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Running setup.py install for mozcrash 06:31:07 INFO - Running setup.py install for mozdebug 06:31:07 INFO - Running setup.py install for mozdevice 06:31:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Running setup.py install for mozfile 06:31:07 INFO - Running setup.py install for mozhttpd 06:31:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Running setup.py install for mozinfo 06:31:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Running setup.py install for mozInstall 06:31:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:31:07 INFO - Running setup.py install for mozleak 06:31:08 INFO - Running setup.py install for mozlog 06:31:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Running setup.py install for moznetwork 06:31:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Running setup.py install for mozprocess 06:31:08 INFO - Running setup.py install for mozprofile 06:31:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Running setup.py install for mozrunner 06:31:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Running setup.py install for mozscreenshot 06:31:08 INFO - Running setup.py install for moztest 06:31:08 INFO - Running setup.py install for mozversion 06:31:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:31:08 INFO - Cleaning up... 06:31:08 INFO - Return code: 0 06:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:08 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')]} 06:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:08 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')]} 06:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:08 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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:31:08 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 06:31:08 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 06:31:08 INFO - Using env: {'DISPLAY': ':0', 06:31:08 INFO - 'HOME': '/home/cltbld', 06:31:08 INFO - 'LANG': 'en_US.UTF-8', 06:31:08 INFO - 'LANGUAGE': 'en_US:en', 06:31:08 INFO - 'LOGNAME': 'cltbld', 06:31:08 INFO - 'MAIL': '/var/mail/cltbld', 06:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:08 INFO - 'MOZ_NO_REMOTE': '1', 06:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:08 INFO - 'NO_EM_RESTART': '1', 06:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:08 INFO - 'PWD': '/builds/slave/test', 06:31:08 INFO - 'SHELL': '/bin/bash', 06:31:08 INFO - 'SHLVL': '1', 06:31:08 INFO - 'TERM': 'linux', 06:31:08 INFO - 'TMOUT': '86400', 06:31:08 INFO - 'USER': 'cltbld', 06:31:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:08 INFO - '_': '/tools/buildbot/bin/python'} 06:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:09 INFO - Running setup.py (path:/tmp/pip-fEkTem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:09 INFO - Running setup.py (path:/tmp/pip-A7O2mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:09 INFO - Running setup.py (path:/tmp/pip-C7C_Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:09 INFO - Running setup.py (path:/tmp/pip-3Nc2jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:09 INFO - Running setup.py (path:/tmp/pip-uIThwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:09 INFO - Running setup.py (path:/tmp/pip-LXbjI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:09 INFO - Running setup.py (path:/tmp/pip-1r_Xeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:09 INFO - Running setup.py (path:/tmp/pip-eE6BkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:09 INFO - Running setup.py (path:/tmp/pip-QOqxYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:09 INFO - Running setup.py (path:/tmp/pip-XAwJOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:09 INFO - Running setup.py (path:/tmp/pip-jHcS4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:09 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)) 06:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:09 INFO - Running setup.py (path:/tmp/pip-i_L4uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:10 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)) 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:10 INFO - Running setup.py (path:/tmp/pip-7y10Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:10 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)) 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:10 INFO - Running setup.py (path:/tmp/pip-HenIaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:10 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)) 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:10 INFO - Running setup.py (path:/tmp/pip-qFSCUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:10 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)) 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:10 INFO - Running setup.py (path:/tmp/pip-XQnJw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:10 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)) 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:10 INFO - Running setup.py (path:/tmp/pip-UlHZfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:10 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)) 06:31:10 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)) 06:31:10 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)) 06:31:10 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)) 06:31:10 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)) 06:31:10 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)) 06:31:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:12 INFO - Downloading blessings-1.6.tar.gz 06:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:31:12 INFO - Installing collected packages: blessings 06:31:12 INFO - Running setup.py install for blessings 06:31:12 INFO - Successfully installed blessings 06:31:12 INFO - Cleaning up... 06:31:12 INFO - Return code: 0 06:31:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:12 INFO - Reading from file tmpfile_stdout 06:31:12 INFO - Current package versions: 06:31:12 INFO - argparse == 1.2.1 06:31:12 INFO - blessings == 1.6 06:31:12 INFO - blobuploader == 1.2.4 06:31:12 INFO - docopt == 0.6.1 06:31:12 INFO - functools32 == 3.2.3-2 06:31:12 INFO - jsonschema == 2.5.1 06:31:12 INFO - manifestparser == 1.1 06:31:12 INFO - mozInstall == 1.12 06:31:12 INFO - mozcrash == 0.17 06:31:12 INFO - mozdebug == 0.1 06:31:12 INFO - mozdevice == 0.48 06:31:12 INFO - mozfile == 1.2 06:31:12 INFO - mozhttpd == 0.7 06:31:12 INFO - mozinfo == 0.9 06:31:12 INFO - mozleak == 0.1 06:31:12 INFO - mozlog == 3.3 06:31:12 INFO - moznetwork == 0.27 06:31:12 INFO - mozprocess == 0.23 06:31:12 INFO - mozprofile == 0.28 06:31:12 INFO - mozrunner == 6.12 06:31:12 INFO - mozscreenshot == 0.1 06:31:12 INFO - mozsystemmonitor == 0.3 06:31:12 INFO - moztest == 0.7 06:31:12 INFO - mozversion == 1.4 06:31:12 INFO - psutil == 3.1.1 06:31:12 INFO - requests == 1.2.3 06:31:12 INFO - wsgiref == 0.1.2 06:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:12 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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:31:12 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 06:31:12 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 06:31:12 INFO - Using env: {'DISPLAY': ':0', 06:31:12 INFO - 'HOME': '/home/cltbld', 06:31:12 INFO - 'LANG': 'en_US.UTF-8', 06:31:12 INFO - 'LANGUAGE': 'en_US:en', 06:31:12 INFO - 'LOGNAME': 'cltbld', 06:31:12 INFO - 'MAIL': '/var/mail/cltbld', 06:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:12 INFO - 'MOZ_NO_REMOTE': '1', 06:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:12 INFO - 'NO_EM_RESTART': '1', 06:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:12 INFO - 'PWD': '/builds/slave/test', 06:31:12 INFO - 'SHELL': '/bin/bash', 06:31:12 INFO - 'SHLVL': '1', 06:31:12 INFO - 'TERM': 'linux', 06:31:12 INFO - 'TMOUT': '86400', 06:31:12 INFO - 'USER': 'cltbld', 06:31:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:12 INFO - '_': '/tools/buildbot/bin/python'} 06:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 INFO - Cleaning up... 06:31:13 INFO - Return code: 0 06:31:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:13 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 0xdeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', '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 06:31:13 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 06:31:13 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 06:31:13 INFO - Using env: {'DISPLAY': ':0', 06:31:13 INFO - 'HOME': '/home/cltbld', 06:31:13 INFO - 'LANG': 'en_US.UTF-8', 06:31:13 INFO - 'LANGUAGE': 'en_US:en', 06:31:13 INFO - 'LOGNAME': 'cltbld', 06:31:13 INFO - 'MAIL': '/var/mail/cltbld', 06:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:13 INFO - 'MOZ_NO_REMOTE': '1', 06:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:13 INFO - 'NO_EM_RESTART': '1', 06:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:13 INFO - 'PWD': '/builds/slave/test', 06:31:13 INFO - 'SHELL': '/bin/bash', 06:31:13 INFO - 'SHLVL': '1', 06:31:13 INFO - 'TERM': 'linux', 06:31:13 INFO - 'TMOUT': '86400', 06:31:13 INFO - 'USER': 'cltbld', 06:31:13 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:13 INFO - '_': '/tools/buildbot/bin/python'} 06:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:31:13 INFO - Cleaning up... 06:31:13 INFO - Return code: 0 06:31:13 INFO - Running post-action listener: _resource_record_post_action 06:31:13 INFO - Running post-action listener: _start_resource_monitoring 06:31:13 INFO - Starting resource monitoring. 06:31:13 INFO - [mozharness: 2016-08-06 13:31:13.259831Z] Finished create-virtualenv step (success) 06:31:13 INFO - [mozharness: 2016-08-06 13:31:13.260268Z] Running install step. 06:31:13 INFO - Running pre-action listener: _resource_record_pre_action 06:31:13 INFO - Running main action method: install 06:31:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:13 INFO - Reading from file tmpfile_stdout 06:31:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:31:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:31:13 INFO - Reading from file tmpfile_stdout 06:31:13 INFO - Output received: 06:31:13 INFO - Usage: mozinstall [options] installer 06:31:13 INFO - Options: 06:31:13 INFO - -h, --help show this help message and exit 06:31:13 INFO - -d DEST, --destination=DEST 06:31:13 INFO - Directory to install application into. [default: 06:31:13 INFO - "/builds/slave/test"] 06:31:13 INFO - --app=APP Application being installed. [default: firefox] 06:31:13 INFO - mkdir: /builds/slave/test/build/application 06:31:13 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'] 06:31:13 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 06:31:30 INFO - Reading from file tmpfile_stdout 06:31:30 INFO - Output received: 06:31:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:31:30 INFO - Running post-action listener: _resource_record_post_action 06:31:31 INFO - [mozharness: 2016-08-06 13:31:31.000066Z] Finished install step (success) 06:31:31 INFO - [mozharness: 2016-08-06 13:31:31.000314Z] Running run-tests step. 06:31:31 INFO - Running pre-action listener: _resource_record_pre_action 06:31:31 INFO - Running main action method: run_tests 06:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:31:31 INFO - Python 2.7.3 06:31:31 INFO - Return code: 0 06:31:31 INFO - grabbing minidump binary from tooltool 06:31: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')]} 06:31:31 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 0x10aa3b0>, '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 0x10ab2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:31:31 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 06:31:31 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 06:31:31 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 06:31:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:31:31 INFO - Return code: 0 06:31:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:31:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:31:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:31:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:31:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:31:31 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:31:31 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:31:31 INFO - Using env: {'DISPLAY': ':0', 06:31:31 INFO - 'HOME': '/home/cltbld', 06:31:31 INFO - 'LANG': 'en_US.UTF-8', 06:31:31 INFO - 'LANGUAGE': 'en_US:en', 06:31:31 INFO - 'LOGNAME': 'cltbld', 06:31:31 INFO - 'MAIL': '/var/mail/cltbld', 06:31:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:31:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:31 INFO - 'MOZ_NO_REMOTE': '1', 06:31:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:31 INFO - 'NO_EM_RESTART': '1', 06:31:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:31 INFO - 'PWD': '/builds/slave/test', 06:31:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:31:31 INFO - 'SHELL': '/bin/bash', 06:31:31 INFO - 'SHLVL': '1', 06:31:31 INFO - 'TERM': 'linux', 06:31:31 INFO - 'TMOUT': '86400', 06:31:31 INFO - 'USER': 'cltbld', 06:31:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232', 06:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:31 INFO - '_': '/tools/buildbot/bin/python'} 06:31:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:31:31 INFO - mozversion application_buildid: 20160806023103 06:31:31 INFO - mozversion application_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 06:31:31 INFO - mozversion application_display_name: Nightly 06:31:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:31:31 INFO - mozversion application_name: Firefox 06:31:31 INFO - mozversion application_remotingname: firefox 06:31:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:31:31 INFO - mozversion application_vendor: Mozilla 06:31:31 INFO - mozversion application_version: 51.0a1 06:31:31 INFO - mozversion platform_buildid: 20160806023103 06:31:31 INFO - mozversion platform_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 06:31:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:31:31 INFO - mozversion platform_version: 51.0a1 06:31:31 INFO - using testdate: 1470490291 06:31:31 INFO - actual date: 1470490291 06:31:31 INFO - starting webserver on 'localhost:37139' 06:31:31 INFO - SUITE-START | Running 2 tests 06:31:31 INFO - TEST-START | dromaeo_css 06:31:31 INFO - operating with platform_type : linux_ 06:31:31 INFO - Initialising browser for dromaeo_css test... 06:31:31 INFO - TEST-INFO | started process 11184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2lvsQ/profile http://localhost:37139/getInfo.html) 06:31:35 INFO - PROCESS | 11184 | __metrics Screen width/height:1600/1200 06:31:35 INFO - PROCESS | 11184 | colorDepth:24 06:31:35 INFO - PROCESS | 11184 | Browser inner width/height: 1024/697 06:31:35 INFO - PROCESS | 11184 | __metrics 06:31:35 INFO - PROCESS | 11184 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:31:35 INFO - PROCESS | 11184 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:31:36 INFO - TEST-INFO | 11184: exit 0 06:31:36 INFO - Browser initialized. 06:31:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:31:36 INFO - TEST-INFO | started process 11266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2lvsQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:48 INFO - PROCESS | 11266 | RSS: Main: 157106176 06:31:48 INFO - PROCESS | 11266 | 06:32:40 INFO - PROCESS | 11266 | 1470490360271 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] 06:34:49 INFO - PROCESS | 11266 | Cycle 1(1): loaded http://localhost:37139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37139/tests/dromaeo/cssquery-ext.html) 06:34:50 INFO - PROCESS | 11266 | RSS: Main: 252710912 06:34:50 INFO - PROCESS | 11266 | 06:37:52 INFO - PROCESS | 11266 | Cycle 1(1): loaded http://localhost:37139/tests/dromaeo/cssquery-ext.html (next: http://localhost:37139/tests/dromaeo/cssquery-jquery.html) 06:37:53 INFO - PROCESS | 11266 | RSS: Main: 244727808 06:37:53 INFO - PROCESS | 11266 | 06:40:55 INFO - PROCESS | 11266 | Cycle 1(1): loaded http://localhost:37139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37139/tests/dromaeo/cssquery-mootools.html) 06:40:56 INFO - PROCESS | 11266 | RSS: Main: 186204160 06:40:56 INFO - PROCESS | 11266 | 06:43:58 INFO - PROCESS | 11266 | Cycle 1(1): loaded http://localhost:37139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37139/tests/dromaeo/cssquery-prototype.html) 06:43:58 INFO - PROCESS | 11266 | RSS: Main: 225357824 06:43:58 INFO - PROCESS | 11266 | 06:47:01 INFO - PROCESS | 11266 | Cycle 1(1): loaded http://localhost:37139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37139/tests/dromaeo/cssquery-yui.html) 06:47:02 INFO - PROCESS | 11266 | RSS: Main: 186515456 06:47:02 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | Cycle 1(1): loaded http://localhost:37139/tests/dromaeo/cssquery-yui.html (next: http://localhost:37139/tests/dromaeo/cssquery-dojo.html) 06:50:05 INFO - PROCESS | 11266 | RSS: Main: 278405120 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | __start_tp_report 06:50:05 INFO - PROCESS | 11266 | _x_x_mozilla_page_load 06:50:05 INFO - PROCESS | 11266 | _x_x_mozilla_page_load_details 06:50:05 INFO - PROCESS | 11266 | |i|pagename|runs| 06:50:05 INFO - PROCESS | 11266 | |0;dojo.html;3055.373648402077;3071.8771249150027;3075.8615862286197;3115.8909438169667;3135.357251763389;5213.32226810515;5266.81566145185;5289.550388216997;5341.412444631087;5363.168708850125;5262.578993680506;5295.258663787064;5341.359036915565;5365.463453654633;5391.56867450604;4769.833055843046;4791.209450440673;4855.878603034917;4861.124997500448;5044.142495775709;4943.382077240345;4968.527989840977;4995.5753760930365;5014.323066386046;5017.37282839645;4782.617390608743;4828.227483602606;4833.951660483385;4890.119778439879;4955.984023275238;4777.713337199779;4783.7129772213775;4794.137055330039;4798.160321943681;4872.853814385574;4778.5699287064335;4795.184818580815;4801.231802911552;4822.228443449067;4856.562909338177;5167.147420675584;5207.375114986188;5272.947270527284;5273.314469119028;5274.894502109936;5662.235598194274;5711.942880571182;5735.799247026334;5737;5739.971300143514;5717.085266357363;5733.770649174028;5740.799072032459;5743.253377060997;5744.569157313218;5159.277701121846;5203.895922081537;5248.737563121828;5250.501202385767;5321.787128514816;5742.454466825645;5803.7968671096305;5805.332386775491;5806.390329015477;5811.418858114239;5577.9163312550345;5583.0787919992745;5614.157876318585;5627.380988091307;5632.831015069554;5474.507294343528;5569.220309156722;5579.358373787067;5582.385937546866;5683.658980461186;5618.213450116905;5629.831105066854;5635.154726791015;5650.830475085754;5668.404817494104;5609.579281553818;5651.321841379061;5654.37801841797;5657.066584013592;5666.263385759825;4264.658827293809;4270.722403043792;4311.50417701962;4365.825366985348;4367.432233809648;3908.5309762828642;3910.550286717064;3918.216356728609;3920.4315374270573;3954.189391174802;5479.5342395896;5484.095124304445;5512.80705175317;5526.309211348582;5532.640378375393;5757.740901659436;5762.88474230513;5765.94234057654;5768.250127483484;5769.076947688433;5251.081060814342;5355.0896347621;5449.972750136224;5460.808871689472;5461.098918678374;4959.776810043484;4962.354893863775;4962.478939711351;4963.305137280783;4981.2030075187795;5944.673042982591;5946.286445626466;5946.910796338058;5950.107483877367;5995.250593675791;5507.146392309199;5618.831435056954;5659.518940890071;5670.42997598211;5721.199032135588;5982.790602328898;5990.820275391745;5995.0407934731975;6019.819405417845;6044.576879618385;5622.746976385991;5624.971875140598;5626.127950167731;5631;5631.2960879890015;5542.61201715876;5632.098864181711;5668.744906479301;5673.120666296731;5737.110747834093;5581.330240371181;5582.302212223472;5590.748416321194;5614.24207731951;5635.746391412478;5522.723863806874;5564.387917329172;5567.137093750475;5578.30271216098;5579.13523403873;5398.676079435089;5500.477454641963;5510.118381059011;5548.167774833646;5554.277943867433;5679.914801278067;5709.400512946247;5729.169270455844;5731.226284451713;5736.397678243724;5554.055810512142;5566.471185237396;5567.526760225264;5567.777288908398;5570.777168913198 06:50:05 INFO - PROCESS | 11266 | |1;ext.html;570.40677695197;589.6904125334199;594.1859652276382;615.1449485215549;617.7992152550422;32995.505067424005;35786;45270;46306.30540541895;46333.76833115838;46817.765911170485;47144.292835607404;47205.29192062122;47304;47344.28983565249;9007.774805629862;9156.313276504256;9156.633734650606;9167.174954254117;9172.2203612693;9015.278777697802;9106.408083474553;9113.772155696095;9115.27077833775;9121.407108537956;9147.313951453634;9202.4478531288;9206.953965230165;9207.769805754877;9211.677591284306;9129.360944733871;9156.404833685789;9166.816663666756;9177;9184;8946;9018.59416326267;9030.413023153475;9033.593488293043;9037.141471560191;44681.77659111716;45034.32448513275;45046.774766126284;45051.77474112641;45102.32346514805;3386.255023894739;3586.8385922633283;3945.1320709443876;4029.5366032906004;4194.496660400741;33374;34235.31529369399;34287;34381;34436;4101.85643502476;4217.325227963542;4250.213710463574;4335.5014173370155;4359.6076353128055;352463;352515;354056;354184;354234;59969.700151499834;60336.69831650814;60414.07308524932;60420.69789651024;60463.39536604666;62211.688941555905;62541;62568;62851;62973.68513157405;16859.578510537336;17150.828491715172;17156.742648860276;17162.39931602388;17173.484795456156;13068.934655326853;13146.934265328613;13157.210567365988;13163.802542961863;13166.934165329112;15984.36062557508;17231.138443077794;17237.482875513753;17298.827011729973;17425.215865286093;6663.833404164838;6689.397954184049;6755.1556055493065;6760.256371799098;6808.114945057111;971.2958105373689;1041.3699711674478;1136.914731395132;1174.3247632611112;1199.2384835629439;33258.8337058318;33406.331873362884;33802.49296260509;33826.49260261098;34040.319193615986;1098.6484325015917;1101.2896681640457;1110.21729680575;1149.2357582207906;1223.5350566784564;17349.82650173482;17659.911700441673;17681.823181768017;17738.29046838138;17827.96924522834;561305;565747;567180;567258;567274;60999.39000609937;61052.694736526035;61069;61105;61212.387876120665;1243.5088140184757;1355.2478374502246;1374.793780932868;1407.1275808998487;1410.5989313342436;32289.35421291514;34860.65139348574;34886.65113348936;35197.02023127114;35318.47022294719;52900.47099528956;53372.73313633407;53481.4651853492;53530.19704704355;53579.46420535745;418733;420770;423009;423771;424040;42381.97371249726;43324;43748;44208;44269.778651106535;50194.49805501898;51019.744901275255;51056.67603391988;51369.486305136474;51709;42518.5748142527;45748;46358.30462543132;46995;47301.763491182326;43339.34990975201;43713;44409.55590444183;46543.301850471595;47431.288530672755;45049;45261.32108018317;45340.54659453363;45751.313730294736;46648.30027549657;44208.33687494626;45540.31689524594;45541.11087304205;47377.76311118422;47677.76161119172;29645.467999069017;30336.54495182618;30446.84776576103;30935.69064309328;31125.377492450476 06:50:05 INFO - PROCESS | 11266 | |2;jquery.html;369.5676059010957;375.8139720838184;393.9803009849507;399.3430806323598;409.9446574712415;14429.63925901853;16880.577985550368;19850.70223946642;20138.6979195312;20145;19652.9017354913;19688.11403486843;19831.702524462144;19896.40310790675;19931.60136797263;5540.889182216363;5569.053260945649;5580.441955804427;5735.397783232763;5739.053056245714;5444.700541470217;5614.578906582003;5621.297337832771;5624.521915637176;5625.493705566499;5408.702521361323;5584.664920104787;5590.049691552445;5591.916121258185;5598.636088654245;5568.1091025435935;5593.496585307301;5601.103823388259;5603.159526071081;5622.269105016342;4863.343448634424;4991.176455884774;5025.070361983045;5039.697618142924;5085.110105731519;23354.299371018897;23413.41466463335;23718;23809.404764880845;24054.39864003414;2154.806067453921;2230.2863083813186;2341.7541158178487;2460.3849037740565;2873.7700983921236;14309.212993285366;14468.348924298432;14600.70798584033;14729.631759205999;15141.621459463491;1904.6381187574316;1949.9512512187166;1958.1188465190578;1980.019890154383;2004.2684420186526;80701;81861.59069204616;84164;84314.15685843125;85022.14977850205;11006.889931100746;11040.227184097197;11184.44077796107;11187.552497899993;11503.194776365573;15874;15886.76169857453;15894.284757185955;15902.76145857813;15910.204489775464;7885.645145968445;8221.630026648696;8268.131846156188;8333.749987500263;8356.415050946376;7754.92245077542;7811.804704882424;7861.521817526113;7989.201079892081;8214.316065206618;4729.858104256878;4847;4856.805727770849;4945.579625731782;4996.7001979881325;1927.6144771045847;1960.6961370688332;1984.1369004483097;1985.5830275641988;2002.8383537548186;942.561135425169;947.199616324205;958.7171784323641;1003.2042643667899;1006.4263369879245;20290.391288261377;20504;20647.58704825895;20675.379738607866;20821;960.2941837749248;961.4135377419768;971.6987733802544;1002.9247806414548;1018.5823812236947;10986.285891417192;11371.829422558669;11442.713932151597;11447.141464390204;11498.655040348804;518359;526785;527510;528999;552510;88559;92614;100319;102310;103250;988.1995583577182;1017.2980643356209;1043.7181960870673;1044.8798388185455;1048.0619845238468;17381.190095846545;17580.296788128842;18010;18406.447806565826;18572.721409179143;44353;44455.55544444514;44649;44748.986295617426;45893.31160032669;60652.69673651604;63570;63783.3621663796;65260;66081;8118.512889226666;8223.588820558829;8269.793255168428;8478.279346255636;8622.870656940026;11716.824247636463;12489.812652810397;13339.933300333436;13581.981351398486;13870.930645346709;12026.639200823989;12050.75898482043;12325.568605098779;12372.505099795908;12820.205171275842;11631.243969141979;12024.579139730067;12064.75870482568;12229.266244025386;12453.813192802296;12187.695307617381;12229.69425764363;12372.81440778371;12375.195612285534;12441.875581244072;8731.738047858575;8753.47479151253;8791.340649451444;8876.245519130945;8970.506622135585;11425.14311426663;11887.881121188677;11912.940435297767;11924.105692072955;12255.877441225473 06:50:05 INFO - PROCESS | 11266 | |3;mootools.html;1319.5909268126875;1458.1105525629368;1505.5709122899973;1602.8557429831312;1738.5914310137116;8097;8437.578121093944;8478.19457151571;8717.91282087179;8724.73825785226;8438.662453501867;8532.658693652262;8546.786330341745;8552.401331906753;8555;2384.4396566806786;2411.710594728635;2417.443987882788;2419.721732000825;2419.9274021779374;2326.848754830939;2389.6415537669313;2397.5444665513496;2397.5444665513496;2399.0763556030965;2353.1881500882255;2354.882255887199;2356.929292121239;2400.927972160838;2407.67496387988;2294.4149241943364;2309.284121922201;2313.9305820825402;2315.293835380217;2344.2498400511845;2300.9884950575306;2329.8485598436046;2335.7781010803947;2336.299110266913;2336.8481048731946;8572.357073219533;8584.957075214646;8599.61301741423;8639.65441382344;8694.17405346491;5143.177091665316;5353;5353.0899747043095;5353.678779273256;5354.625176237665;3137.3568418474156;3152.8265945372996;3162.5256211568217;3204.7115759581748;3210.2616398228306;1066.7599790047254;1073.3345325897992;1081.3349789879246;1084.159776173464;1097.7200813792513;12307.26156430608;12338.753224935452;12367.196132251374;12448.439820208112;12491.999999999909;4558.247889098262;4608.470025946992;4689.366935463737;4697.084068606658;4849.2726091085915;9886.406815591088;9904;9910.950445247727;9911.504424778732;9936.503174841373;5329;5340.626156169109;5353.705546194997;5362.436944120889;5366.141417373202;4011.5988401159652;4307.289297265978;4422.646188304928;4921.483244259372;4943.480934501826;3771.9245615087543;3860.884173474744;3919.980400097981;3950.822213000364;3952.8616498422416;1151.0891919413732;1176.3765204441659;1177.7938860699344;1183.0594677231622;1188.423614546944;828.6519661742083;832.309183377795;956.0773853231665;965.5799727118725;982.2878413150552;5945.40545945402;6192.225971753531;6198.81403557894;6200.844978875474;6412.3267056959285;1026.6047571684956;1052.394872948058;1080.3355936099242;1089.8801131875487;1105.8451816745662;4355.412019377407;4369.75966321849;4446.221911165533;4499.88750281239;4645.674802763841;11360.602378916697;11368.090552755759;11479.25384849982;11489.368084755251;11570.652880413601;11392.658220253406;11398.544058237578;11409.600663976888;11416.942915285537;11430.885691143149;8155.469894456842;8461.576921153917;8469.280111190494;8585.8712119317;8590.91409085901;6357.841053973688;6362.395572420613;6383.39357761012;6420.133282006869;6452.451541618827;10071.19430445548;10344.534495947852;10349.844752328872;10367.533460994424;10419.374837509773;8916.910830891607;10085.596576137166;10181.541830617492;10537.315074520438;10537.578496860346;7701.92298077012;7961.800954976172;7992.240737130196;8007.35941124697;8221.21898419673;8410.327173825957;8793.296536276954;8798.252148567444;8822.07368226327;8881.245094167069;7999.880001799861;8032.879506807286;8060.717874874351;8123.959380203298;8223.259906608433;7722.459427839997;7787.649555769891;7829.334506566778;7837.49056311338;7916.4062695299235;7354.77935661931;7362.042934418491;7368.889466657897;7424.925750742424;7428.1086269647985;5388.919166212431;5528.7235638218735;5540.085885828793;5569.916451253153;5806.042003069446;5399.190121481809;5461.5357694596405;5517.227588137584;5540.36285827135;5613.242212301287 06:50:05 INFO - PROCESS | 11266 | |4;prototype.html;325.14649046253584;332.5161889450849;333.2884292036503;336.9460886258199;337.15206256265515;5098.736808442595;5132.615053870961;5142.820001299955;5146.456063181045;5162.22566615008;4801.463531669867;4848.448496481127;5036;5037.672551284173;5094.668846524974;4070.308047631895;4071.409645601386;4074.348104303312;4075;4090.4886889138857;4074.470318858544;4077.755334679914;4084.5098588169462;4085.448464457305;4086.816093275795;3746.9812650936706;3849.2301539692035;3972.2254160438724;3984.1434091670285;4058.614431629005;3939.5075615548058;3944.9211015779524;3946.980265098656;3948.368261078228;3976.8409263629565;3500.877469288588;3501.8074005929666;3506.947395789065;3509.631488693676;3510;4730.243161094243;4920.360353154067;4946.604271658259;4956.207006878918;4957.7769000395065;4571.794269257892;4579.107074120515;4587;4587.472440669332;4610.109854959451;5262.315898933152;5271.525562699376;5272.181097521349;5279.234510995922;5283.709395983219;3596.5684117905757;3932.2528719543197;3943.4479172915817;3946.861859834921;3954.8220330085214;5405.162199859028;5439.830436456181;5454.91817622736;5476.26070480484;5504.559635229172;3859.807009649506;3866.0141663875534;3877.836649005287;3882;3883.76697398157;3910.2179564087296;3910.2375036868107;3910.7066969977363;3921.098147426051;3926.450296958428;4368.497622773358;4430.313301438282;4452.30989196675;4483.3723278741;4487.349334346502;5333.320004198743;5342.973285133549;5343.145096784574;5344.706041167696;5348.689571055116;1359.9796003059962;1371.4719832864419;1376.5526203983745;1377.3044612470637;1378.9862101379058;883.3286702106445;907.4147175072042;922.3220932614523;927.5037854747677;943.2124176312718;5113.057038325413;5117.897642047138;5122.795088196431;5160.690358578422;5161.458046905096;5393.487618676219;5414.3502779665905;5430.484104010113;5455.809046683347;5464.480874316933;5002.624803139779;5180.559652429586;5223.824639456168;5265.236540701577;5275.920861187085;2912.1554749122943;2918.664353599363;2920.445115428062;2932.6627437844495;2936.8237905725723;5468.4531546845;5726.341470730836;5754.280714910637;5757.136429535603;5775.0942189077505;5536.612437129443;5574.470425309671;5585.525230355384;5607.775688972477;5608.10270356741;5747.9882041286055;5752.194692743019;5764.308283005982;5793.478586927113;5800.4489573490455;5242.68543887368;5502.697351645698;5523.8066667666435;5549.7790486093;5563;5471.480209380103;5479.4520547944885;5480.972595136999;5482.39693633708;5484.61607687458;5586.664800112007;5757.683327417032;5759.7984070559005;5763.884722305615;5770.740316685843;3908.7459315144424;3935.3309937310155;3975.284448799244;4000.9199816002933;4004.1991601680365;5526.696031718294;5528.087865502147;5536.501714845522;5539.371711528955;5540.252065971043;5232.607554433509;5401.783928642811;5410.675359478444;5424.2406063151975;5437.646552974044;5329.094054010905;5378.337722827226;5380.461953804588;5388.218708287355;5401.837944861661;5078.7206703631655;5173.896522069613;5325.068113080118;5333.359996800409;5335.226392173191;5390.703511306916;5394.163904594794;5404.621676482766;5410.512109170009;5413.810516631899;5306.734663266899;5308.672831792052;5312.920306195333;5317.415084340642;5326.547243484347 06:50:05 INFO - PROCESS | 11266 | |5;yui.html;764.7361660227222;773.8684423647979;780.6760194519275;808.7088648086687;868.5309932636377;15435.768463473043;16163.030218186917;16196.352145914148;16200.837991620081;16207.594810129753;15224.847751522482;15367.69264614707;15373.846261537381;15389.692206155898;15398.30707618157;647.7797548833396;792.5403266105645;807.4347956430493;818.0428898189133;821.3839620284787;787.6180052674448;787.6219414680957;787.8148635070783;788.1369899959535;788.8501184774904;831.6631764135535;832.3549249331755;832.4547421438967;833.2251006563893;835.6657337065192;685.1367277230676;832.4173078844802;835.8913341265596;857.3012994409598;859.5487369131193;630.0454810961397;632.3676323676324;632.3739497897049;632.3771085480797;632.7374139732005;15371.077735335915;15374.769378459332;15397.461088861948;15413.229338533141;15416.845831541654;14695.338709758087;15007.249637518189;15030.624234394118;15058.54824355271;15104.924475377553;13515.459381624723;13572.211123284194;13740.381682824196;13810.516631917835;13857.722845543134;4459.866204013885;4487;4544.545545445429;4595;4717.740524271164;82085.58957205235;83424.58287708584;84210;84508.73236901512;84681.57659211665;10592.894071059345;10814.945925270324;10933.070688991365;11185.832212516818;11547.480363383667;20955.8952205238;20977.265795697076;20994.21549168338;21033.05351259197;21179;8265.090840007595;8330.791730206673;8341.082480927093;8368.665253389796;8474.788130296793;4776.689515181502;4776.95223047772;4845.854624361275;4864.975675121673;5034.572061374751;3403.6256011838677;3512.631173726773;3544.858205671744;3555.8933232003083;3560.127768696686;599.1372423709844;605.4157737782972;606.4087514673158;612.4763327355137;618.7463140112533;584.3396961433552;619.6932518403419;678.5657179405184;726.1612837173074;740.7814694665087;9621.374610650286;9709.6601618943;9769.218462523124;9921.751956201153;9995.400275983464;588.9381614930456;649.4609474136455;658.4107224034462;659.7756762700609;660.8513084556032;4660.438753017777;4822.67671473773;4915.11527924977;4928.7289199093675;4967.453580106186;125863.370683146;126792.36603816922;127024.36487817502;128042;131631.34184329017;105048.47475762572;106430.46784766181;107256;109084;109201.45399272953;93673;96008;98455.52316715255;99079.50460247653;100220;9206.907930920604;10146.239032072477;10321.174306055647;10357.896421035693;10523;53783;53802;54151.72924135354;55470.72264638651;56464;71315;76877;79916;80920.59539702264;82837.17162828294;12105.515779368727;12289.262644241375;12484.563040293546;12533.310667913353;12662.810057849323;15018.774718379014;15281.46514871974;15319.310631021408;15853.920730396274;16229.431969880998;13777.862221377658;14126.43494260218;14144.504942326968;14309;14655.92672036633;14526.927365363106;14637.121772693672;14727.190004549853;15518.301676424813;15541.300641470934;13138.474461021453;13177.604671859859;13272.933635331761;13387.263700496176;13769.931150344184;11679.299242045505;11682.357470339213;11702.239354441934;11716.589919352782;11915.582954596548;10362.792744144925;11278.379689117177;12007.339596322287;12383.442745076312;12442.813357799821 06:50:05 INFO - PROCESS | 11266 | __end_tp_report 06:50:05 INFO - PROCESS | 11266 | __start_cc_report 06:50:05 INFO - PROCESS | 11266 | _x_x_mozilla_cycle_collect,960 06:50:05 INFO - PROCESS | 11266 | __end_cc_report 06:50:05 INFO - PROCESS | 11266 | __startTimestamp1470491405332__endTimestamp 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | ------- Summary: start ------- 06:50:05 INFO - PROCESS | 11266 | Number of tests: 6 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | [#0] dojo.html Cycles:165 Average:5301.10 Median:5548.17 stddev:602.16 (10.9%) stddev-sans-first:577.66 06:50:05 INFO - PROCESS | 11266 | Values: 3055.4 3071.9 3075.9 3115.9 3135.4 5213.3 5266.8 5289.6 5341.4 5363.2 5262.6 5295.3 5341.4 5365.5 5391.6 4769.8 4791.2 4855.9 4861.1 5044.1 4943.4 4968.5 4995.6 5014.3 5017.4 4782.6 4828.2 4834.0 4890.1 4956.0 4777.7 4783.7 4794.1 4798.2 4872.9 4778.6 4795.2 4801.2 4822.2 4856.6 5167.1 5207.4 5272.9 5273.3 5274.9 5662.2 5711.9 5735.8 5737.0 5740.0 5717.1 5733.8 5740.8 5743.3 5744.6 5159.3 5203.9 5248.7 5250.5 5321.8 5742.5 5803.8 5805.3 5806.4 5811.4 5577.9 5583.1 5614.2 5627.4 5632.8 5474.5 5569.2 5579.4 5582.4 5683.7 5618.2 5629.8 5635.2 5650.8 5668.4 5609.6 5651.3 5654.4 5657.1 5666.3 4264.7 4270.7 4311.5 4365.8 4367.4 3908.5 3910.6 3918.2 3920.4 3954.2 5479.5 5484.1 5512.8 5526.3 5532.6 5757.7 5762.9 5765.9 5768.3 5769.1 5251.1 5355.1 5450.0 5460.8 5461.1 4959.8 4962.4 4962.5 4963.3 4981.2 5944.7 5946.3 5946.9 5950.1 5995.3 5507.1 5618.8 5659.5 5670.4 5721.2 5982.8 5990.8 5995.0 6019.8 6044.6 5622.7 5625.0 5626.1 5631.0 5631.3 5542.6 5632.1 5668.7 5673.1 5737.1 5581.3 5582.3 5590.7 5614.2 5635.7 5522.7 5564.4 5567.1 5578.3 5579.1 5398.7 5500.5 5510.1 5548.2 5554.3 5679.9 5709.4 5729.2 5731.2 5736.4 5554.1 5566.5 5567.5 5567.8 5570.8 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | [#1] ext.html Cycles:180 Average:62549.10 Median:45077.05 stddev:120671.03 (267.7%) stddev-sans-first:120919.82 06:50:05 INFO - PROCESS | 11266 | Values: 570.4 589.7 594.2 615.1 617.8 32995.5 35786.0 45270.0 46306.3 46333.8 46817.8 47144.3 47205.3 47304.0 47344.3 9007.8 9156.3 9156.6 9167.2 9172.2 9015.3 9106.4 9113.8 9115.3 9121.4 9147.3 9202.4 9207.0 9207.8 9211.7 9129.4 9156.4 9166.8 9177.0 9184.0 8946.0 9018.6 9030.4 9033.6 9037.1 44681.8 45034.3 45046.8 45051.8 45102.3 3386.3 3586.8 3945.1 4029.5 4194.5 33374.0 34235.3 34287.0 34381.0 34436.0 4101.9 4217.3 4250.2 4335.5 4359.6 352463.0 352515.0 354056.0 354184.0 354234.0 59969.7 60336.7 60414.1 60420.7 60463.4 62211.7 62541.0 62568.0 62851.0 62973.7 16859.6 17150.8 17156.7 17162.4 17173.5 13068.9 13146.9 13157.2 13163.8 13166.9 15984.4 17231.1 17237.5 17298.8 17425.2 6663.8 6689.4 6755.2 6760.3 6808.1 971.3 1041.4 1136.9 1174.3 1199.2 33258.8 33406.3 33802.5 33826.5 34040.3 1098.6 1101.3 1110.2 1149.2 1223.5 17349.8 17659.9 17681.8 17738.3 17828.0 561305.0 565747.0 567180.0 567258.0 567274.0 60999.4 61052.7 61069.0 61105.0 61212.4 1243.5 1355.2 1374.8 1407.1 1410.6 32289.4 34860.7 34886.7 35197.0 35318.5 52900.5 53372.7 53481.5 53530.2 53579.5 418733.0 420770.0 423009.0 423771.0 424040.0 42382.0 43324.0 43748.0 44208.0 44269.8 50194.5 51019.7 51056.7 51369.5 51709.0 42518.6 45748.0 46358.3 46995.0 47301.8 43339.3 43713.0 44409.6 46543.3 47431.3 45049.0 45261.3 45340.5 45751.3 46648.3 44208.3 45540.3 45541.1 47377.8 47677.8 29645.5 30336.5 30446.8 30935.7 31125.4 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | [#2] jquery.html Cycles:180 Average:30845.34 Median:23565.71 stddev:87516.05 (371.4%) stddev-sans-first:87731.64 06:50:05 INFO - PROCESS | 11266 | Values: 369.6 375.8 394.0 399.3 409.9 14429.6 16880.6 19850.7 20138.7 20145.0 19652.9 19688.1 19831.7 19896.4 19931.6 5540.9 5569.1 5580.4 5735.4 5739.1 5444.7 5614.6 5621.3 5624.5 5625.5 5408.7 5584.7 5590.0 5591.9 5598.6 5568.1 5593.5 5601.1 5603.2 5622.3 4863.3 4991.2 5025.1 5039.7 5085.1 23354.3 23413.4 23718.0 23809.4 24054.4 2154.8 2230.3 2341.8 2460.4 2873.8 14309.2 14468.3 14600.7 14729.6 15141.6 1904.6 1950.0 1958.1 1980.0 2004.3 80701.0 81861.6 84164.0 84314.2 85022.1 11006.9 11040.2 11184.4 11187.6 11503.2 15874.0 15886.8 15894.3 15902.8 15910.2 7885.6 8221.6 8268.1 8333.7 8356.4 7754.9 7811.8 7861.5 7989.2 8214.3 4729.9 4847.0 4856.8 4945.6 4996.7 1927.6 1960.7 1984.1 1985.6 2002.8 942.6 947.2 958.7 1003.2 1006.4 20290.4 20504.0 20647.6 20675.4 20821.0 960.3 961.4 971.7 1002.9 1018.6 10986.3 11371.8 11442.7 11447.1 11498.7 518359.0 526785.0 527510.0 528999.0 552510.0 88559.0 92614.0 100319.0 102310.0 103250.0 988.2 1017.3 1043.7 1044.9 1048.1 17381.2 17580.3 18010.0 18406.4 18572.7 44353.0 44455.6 44649.0 44749.0 45893.3 60652.7 63570.0 63783.4 65260.0 66081.0 8118.5 8223.6 8269.8 8478.3 8622.9 11716.8 12489.8 13339.9 13582.0 13870.9 12026.6 12050.8 12325.6 12372.5 12820.2 11631.2 12024.6 12064.8 12229.3 12453.8 12187.7 12229.7 12372.8 12375.2 12441.9 8731.7 8753.5 8791.3 8876.2 8970.5 11425.1 11887.9 11912.9 11924.1 12255.9 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | [#3] mootools.html Cycles:180 Average:5895.88 Median:4773.18 stddev:3347.11 (70.1%) stddev-sans-first:3338.83 06:50:05 INFO - PROCESS | 11266 | Values: 1319.6 1458.1 1505.6 1602.9 1738.6 8097.0 8437.6 8478.2 8717.9 8724.7 8438.7 8532.7 8546.8 8552.4 8555.0 2384.4 2411.7 2417.4 2419.7 2419.9 2326.8 2389.6 2397.5 2397.5 2399.1 2353.2 2354.9 2356.9 2400.9 2407.7 2294.4 2309.3 2313.9 2315.3 2344.2 2301.0 2329.8 2335.8 2336.3 2336.8 8572.4 8585.0 8599.6 8639.7 8694.2 5143.2 5353.0 5353.1 5353.7 5354.6 3137.4 3152.8 3162.5 3204.7 3210.3 1066.8 1073.3 1081.3 1084.2 1097.7 12307.3 12338.8 12367.2 12448.4 12492.0 4558.2 4608.5 4689.4 4697.1 4849.3 9886.4 9904.0 9911.0 9911.5 9936.5 5329.0 5340.6 5353.7 5362.4 5366.1 4011.6 4307.3 4422.6 4921.5 4943.5 3771.9 3860.9 3920.0 3950.8 3952.9 1151.1 1176.4 1177.8 1183.1 1188.4 828.7 832.3 956.1 965.6 982.3 5945.4 6192.2 6198.8 6200.8 6412.3 1026.6 1052.4 1080.3 1089.9 1105.8 4355.4 4369.8 4446.2 4499.9 4645.7 11360.6 11368.1 11479.3 11489.4 11570.7 11392.7 11398.5 11409.6 11416.9 11430.9 8155.5 8461.6 8469.3 8585.9 8590.9 6357.8 6362.4 6383.4 6420.1 6452.5 10071.2 10344.5 10349.8 10367.5 10419.4 8916.9 10085.6 10181.5 10537.3 10537.6 7701.9 7961.8 7992.2 8007.4 8221.2 8410.3 8793.3 8798.3 8822.1 8881.2 7999.9 8032.9 8060.7 8124.0 8223.3 7722.5 7787.6 7829.3 7837.5 7916.4 7354.8 7362.0 7368.9 7424.9 7428.1 5388.9 5528.7 5540.1 5569.9 5806.0 5399.2 5461.5 5517.2 5540.4 5613.2 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | [#4] prototype.html Cycles:180 Average:4515.79 Median:5161.84 stddev:1326.80 (25.7%) stddev-sans-first:1292.70 06:50:05 INFO - PROCESS | 11266 | Values: 325.1 332.5 333.3 336.9 337.2 5098.7 5132.6 5142.8 5146.5 5162.2 4801.5 4848.4 5036.0 5037.7 5094.7 4070.3 4071.4 4074.3 4075.0 4090.5 4074.5 4077.8 4084.5 4085.4 4086.8 3747.0 3849.2 3972.2 3984.1 4058.6 3939.5 3944.9 3947.0 3948.4 3976.8 3500.9 3501.8 3506.9 3509.6 3510.0 4730.2 4920.4 4946.6 4956.2 4957.8 4571.8 4579.1 4587.0 4587.5 4610.1 5262.3 5271.5 5272.2 5279.2 5283.7 3596.6 3932.3 3943.4 3946.9 3954.8 5405.2 5439.8 5454.9 5476.3 5504.6 3859.8 3866.0 3877.8 3882.0 3883.8 3910.2 3910.2 3910.7 3921.1 3926.5 4368.5 4430.3 4452.3 4483.4 4487.3 5333.3 5343.0 5343.1 5344.7 5348.7 1360.0 1371.5 1376.6 1377.3 1379.0 883.3 907.4 922.3 927.5 943.2 5113.1 5117.9 5122.8 5160.7 5161.5 5393.5 5414.4 5430.5 5455.8 5464.5 5002.6 5180.6 5223.8 5265.2 5275.9 2912.2 2918.7 2920.4 2932.7 2936.8 5468.5 5726.3 5754.3 5757.1 5775.1 5536.6 5574.5 5585.5 5607.8 5608.1 5748.0 5752.2 5764.3 5793.5 5800.4 5242.7 5502.7 5523.8 5549.8 5563.0 5471.5 5479.5 5481.0 5482.4 5484.6 5586.7 5757.7 5759.8 5763.9 5770.7 3908.7 3935.3 3975.3 4000.9 4004.2 5526.7 5528.1 5536.5 5539.4 5540.3 5232.6 5401.8 5410.7 5424.2 5437.6 5329.1 5378.3 5380.5 5388.2 5401.8 5078.7 5173.9 5325.1 5333.4 5335.2 5390.7 5394.2 5404.6 5410.5 5413.8 5306.7 5308.7 5312.9 5317.4 5326.5 06:50:05 INFO - PROCESS | 11266 | 06:50:05 INFO - PROCESS | 11266 | [#5] yui.html Cycles:180 Average:22325.62 Median:4473.43 stddev:32993.18 (737.5%) stddev-sans-first:33046.02 06:50:05 INFO - PROCESS | 11266 | Values: 764.7 773.9 780.7 808.7 868.5 15435.8 16163.0 16196.4 16200.8 16207.6 15224.8 15367.7 15373.8 15389.7 15398.3 647.8 792.5 807.4 818.0 821.4 787.6 787.6 787.8 788.1 788.9 831.7 832.4 832.5 833.2 835.7 685.1 832.4 835.9 857.3 859.5 630.0 632.4 632.4 632.4 632.7 15371.1 15374.8 15397.5 15413.2 15416.8 14695.3 15007.2 15030.6 15058.5 15104.9 13515.5 13572.2 13740.4 13810.5 13857.7 4459.9 4487.0 4544.5 4595.0 4717.7 82085.6 83424.6 84210.0 84508.7 84681.6 10592.9 10814.9 10933.1 11185.8 11547.5 20955.9 20977.3 20994.2 21033.1 21179.0 8265.1 8330.8 8341.1 8368.7 8474.8 4776.7 4777.0 4845.9 4865.0 5034.6 3403.6 3512.6 3544.9 3555.9 3560.1 599.1 605.4 606.4 612.5 618.7 584.3 619.7 678.6 726.2 740.8 9621.4 9709.7 9769.2 9921.8 9995.4 588.9 649.5 658.4 659.8 660.9 4660.4 4822.7 4915.1 4928.7 4967.5 125863.4 126792.4 127024.4 128042.0 131631.3 105048.5 106430.5 107256.0 109084.0 109201.5 93673.0 96008.0 98455.5 99079.5 100220.0 9206.9 10146.2 10321.2 10357.9 10523.0 53783.0 53802.0 54151.7 55470.7 56464.0 71315.0 76877.0 79916.0 80920.6 82837.2 12105.5 12289.3 12484.6 12533.3 12662.8 15018.8 15281.5 15319.3 15853.9 16229.4 13777.9 14126.4 14144.5 14309.0 14655.9 14526.9 14637.1 14727.2 15518.3 15541.3 13138.5 13177.6 13272.9 13387.3 13769.9 11679.3 11682.4 11702.2 11716.6 11915.6 10362.8 11278.4 12007.3 12383.4 12442.8 06:50:05 INFO - PROCESS | 11266 | -------- Summary: end -------- 06:50:05 INFO - PROCESS | 11266 | 06:50:06 INFO - TEST-INFO | 11266: exit 0 06:50:06 INFO - TEST-OK | dromaeo_css | took 1114882ms 06:50:06 INFO - TEST-START | kraken 06:50:06 INFO - operating with platform_type : linux_ 06:50:06 INFO - Initialising browser for kraken test... 06:50:06 INFO - TEST-INFO | started process 11464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkS4an4/profile http://localhost:37139/getInfo.html) 06:50:10 INFO - PROCESS | 11464 | __metrics Screen width/height:1600/1200 06:50:10 INFO - PROCESS | 11464 | colorDepth:24 06:50:10 INFO - PROCESS | 11464 | Browser inner width/height: 1024/697 06:50:10 INFO - PROCESS | 11464 | __metrics 06:50:10 INFO - PROCESS | 11464 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:50:10 INFO - PROCESS | 11464 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:11 INFO - TEST-INFO | 11464: exit 0 06:50:11 INFO - Browser initialized. 06:50:11 INFO - Running cycle 1/1 for kraken test... 06:50:11 INFO - TEST-INFO | started process 11546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkS4an4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:23 INFO - PROCESS | 11546 | RSS: Main: 156651520 06:50:23 INFO - PROCESS | 11546 | 06:50:26 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37139/tests/kraken/driver.html?testName=audio-beat-detection) 06:50:26 INFO - PROCESS | 11546 | RSS: Main: 212586496 06:50:26 INFO - PROCESS | 11546 | 06:50:29 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37139/tests/kraken/driver.html?testName=audio-dft) 06:50:30 INFO - PROCESS | 11546 | RSS: Main: 192245760 06:50:30 INFO - PROCESS | 11546 | 06:50:33 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37139/tests/kraken/driver.html?testName=audio-fft) 06:50:33 INFO - PROCESS | 11546 | RSS: Main: 270036992 06:50:33 INFO - PROCESS | 11546 | 06:50:35 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37139/tests/kraken/driver.html?testName=audio-oscillator) 06:50:36 INFO - PROCESS | 11546 | RSS: Main: 179154944 06:50:36 INFO - PROCESS | 11546 | 06:50:38 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:50:39 INFO - PROCESS | 11546 | RSS: Main: 183164928 06:50:39 INFO - PROCESS | 11546 | 06:50:42 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37139/tests/kraken/driver.html?testName=imaging-darkroom) 06:50:42 INFO - PROCESS | 11546 | RSS: Main: 219226112 06:50:42 INFO - PROCESS | 11546 | 06:50:46 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37139/tests/kraken/driver.html?testName=imaging-desaturate) 06:50:46 INFO - PROCESS | 11546 | RSS: Main: 219127808 06:50:46 INFO - PROCESS | 11546 | 06:50:49 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37139/tests/kraken/driver.html?testName=json-parse-financial) 06:50:50 INFO - PROCESS | 11546 | RSS: Main: 219455488 06:50:50 INFO - PROCESS | 11546 | 06:50:51 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:50:52 INFO - PROCESS | 11546 | RSS: Main: 183287808 06:50:52 INFO - PROCESS | 11546 | 06:50:54 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:50:54 INFO - PROCESS | 11546 | RSS: Main: 191131648 06:50:54 INFO - PROCESS | 11546 | 06:50:56 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:50:57 INFO - PROCESS | 11546 | RSS: Main: 194355200 06:50:57 INFO - PROCESS | 11546 | 06:50:59 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:51:00 INFO - PROCESS | 11546 | RSS: Main: 187813888 06:51:00 INFO - PROCESS | 11546 | 06:51:03 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:51:03 INFO - PROCESS | 11546 | RSS: Main: 192757760 06:51:03 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | Cycle 1(1): loaded http://localhost:37139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37139/tests/kraken/driver.html?testName=ai-astar) 06:51:05 INFO - PROCESS | 11546 | RSS: Main: 243302400 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | __start_tp_report 06:51:05 INFO - PROCESS | 11546 | _x_x_mozilla_page_load 06:51:05 INFO - PROCESS | 11546 | _x_x_mozilla_page_load_details 06:51:05 INFO - PROCESS | 11546 | |i|pagename|runs| 06:51:05 INFO - PROCESS | 11546 | |0;ai-astar;103;110;110;110;112;110;110;110;109;117 06:51:05 INFO - PROCESS | 11546 | |1;audio-beat-detection;144;116;120;185;121;117;145;122;169;118 06:51:05 INFO - PROCESS | 11546 | |2;audio-dft;162;160;160;161;160;162;161;160;161;161 06:51:05 INFO - PROCESS | 11546 | |3;audio-fft;73;76;77;112;76;76;73;86;99;76 06:51:05 INFO - PROCESS | 11546 | |4;audio-oscillator;83;83;132;83;85;84;114;84;84;130 06:51:05 INFO - PROCESS | 11546 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 06:51:05 INFO - PROCESS | 11546 | |6;imaging-darkroom;146;147;146;147;148;146;146;152;146;146 06:51:05 INFO - PROCESS | 11546 | |7;imaging-desaturate;95;96;95;95;95;95;96;94;95;95 06:51:05 INFO - PROCESS | 11546 | |8;json-parse-financial;51;51;50;50;61;54;51;50;49;51 06:51:05 INFO - PROCESS | 11546 | |9;json-stringify-tinderbox;60;59;60;60;60;59;60;60;60;60 06:51:05 INFO - PROCESS | 11546 | |10;stanford-crypto-aes;82;86;78;76;76;76;76;77;76;79 06:51:05 INFO - PROCESS | 11546 | |11;stanford-crypto-ccm;131;138;136;119;128;120;120;121;146;123 06:51:05 INFO - PROCESS | 11546 | |12;stanford-crypto-pbkdf2;159;156;157;157;156;158;156;160;159;158 06:51:05 INFO - PROCESS | 11546 | |13;stanford-crypto-sha256-iterative;70;63;69;62;67;65;64;63;61;62 06:51:05 INFO - PROCESS | 11546 | __end_tp_report 06:51:05 INFO - PROCESS | 11546 | __start_cc_report 06:51:05 INFO - PROCESS | 11546 | _x_x_mozilla_cycle_collect,1665 06:51:05 INFO - PROCESS | 11546 | __end_cc_report 06:51:05 INFO - PROCESS | 11546 | __startTimestamp1470491465773__endTimestamp 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | ------- Summary: start ------- 06:51:05 INFO - PROCESS | 11546 | Number of tests: 14 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:3.38 (3.1%) stddev-sans-first:2.42 06:51:05 INFO - PROCESS | 11546 | Values: 103.0 110.0 110.0 110.0 112.0 110.0 110.0 110.0 109.0 117.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:133.00 stddev:24.49 (18.4%) stddev-sans-first:25.79 06:51:05 INFO - PROCESS | 11546 | Values: 144.0 116.0 120.0 185.0 121.0 117.0 145.0 122.0 169.0 118.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 06:51:05 INFO - PROCESS | 11546 | Values: 162.0 160.0 160.0 161.0 160.0 162.0 161.0 160.0 161.0 161.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:13.06 (17.2%) stddev-sans-first:13.40 06:51:05 INFO - PROCESS | 11546 | Values: 73.0 76.0 77.0 112.0 76.0 76.0 73.0 86.0 99.0 76.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:83.50 stddev:20.64 (24.7%) stddev-sans-first:21.34 06:51:05 INFO - PROCESS | 11546 | Values: 83.0 83.0 132.0 83.0 85.0 84.0 114.0 84.0 84.0 130.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:51:05 INFO - PROCESS | 11546 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:146.50 stddev:1.89 (1.3%) stddev-sans-first:1.96 06:51:05 INFO - PROCESS | 11546 | Values: 146.0 147.0 146.0 147.0 148.0 146.0 146.0 152.0 146.0 146.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:51:05 INFO - PROCESS | 11546 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.00 stddev:3.49 (6.8%) stddev-sans-first:3.69 06:51:05 INFO - PROCESS | 11546 | Values: 51.0 51.0 50.0 50.0 61.0 54.0 51.0 50.0 49.0 51.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 06:51:05 INFO - PROCESS | 11546 | Values: 60.0 59.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 60.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.50 stddev:3.36 (4.3%) stddev-sans-first:3.27 06:51:05 INFO - PROCESS | 11546 | Values: 82.0 86.0 78.0 76.0 76.0 76.0 76.0 77.0 76.0 79.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.50 stddev:9.31 (7.2%) stddev-sans-first:9.82 06:51:05 INFO - PROCESS | 11546 | Values: 131.0 138.0 136.0 119.0 128.0 120.0 120.0 121.0 146.0 123.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:158.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 06:51:05 INFO - PROCESS | 11546 | Values: 159.0 156.0 157.0 157.0 156.0 158.0 156.0 160.0 159.0 158.0 06:51:05 INFO - PROCESS | 11546 | 06:51:05 INFO - PROCESS | 11546 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:3.10 (4.8%) stddev-sans-first:2.60 06:51:05 INFO - PROCESS | 11546 | Values: 70.0 63.0 69.0 62.0 67.0 65.0 64.0 63.0 61.0 62.0 06:51:05 INFO - PROCESS | 11546 | -------- Summary: end -------- 06:51:05 INFO - PROCESS | 11546 | 06:51:06 INFO - TEST-INFO | 11546: exit 0 06:51:06 INFO - TEST-OK | kraken | took 60650ms 06:51:06 INFO - SUITE-END | took 1175s 06:51:06 INFO - Completed test suite (00:19:35) 06:51:06 INFO - javascript benchmark 06:51:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.373648402077, 3071.8771249150027, 3075.8615862286197, 3115.8909438169667, 3135.357251763389, 5213.32226810515, 5266.81566145185, 5289.550388216997, 5341.412444631087, 5363.168708850125, 5262.578993680506, 5295.258663787064, 5341.359036915565, 5365.463453654633, 5391.56867450604, 4769.833055843046, 4791.209450440673, 4855.878603034917, 4861.124997500448, 5044.142495775709, 4943.382077240345, 4968.527989840977, 4995.5753760930365, 5014.323066386046, 5017.37282839645, 4782.617390608743, 4828.227483602606, 4833.951660483385, 4890.119778439879, 4955.984023275238, 4777.713337199779, 4783.7129772213775, 4794.137055330039, 4798.160321943681, 4872.853814385574, 4778.5699287064335, 4795.184818580815, 4801.231802911552, 4822.228443449067, 4856.562909338177, 5167.147420675584, 5207.375114986188, 5272.947270527284, 5273.314469119028, 5274.894502109936, 5662.235598194274, 5711.942880571182, 5735.799247026334, 5737.0, 5739.971300143514, 5717.085266357363, 5733.770649174028, 5740.799072032459, 5743.253377060997, 5744.569157313218, 5159.277701121846, 5203.895922081537, 5248.737563121828, 5250.501202385767, 5321.787128514816, 5742.454466825645, 5803.7968671096305, 5805.332386775491, 5806.390329015477, 5811.418858114239, 5577.9163312550345, 5583.0787919992745, 5614.157876318585, 5627.380988091307, 5632.831015069554, 5474.507294343528, 5569.220309156722, 5579.358373787067, 5582.385937546866, 5683.658980461186, 5618.213450116905, 5629.831105066854, 5635.154726791015, 5650.830475085754, 5668.404817494104, 5609.579281553818, 5651.321841379061, 5654.37801841797, 5657.066584013592, 5666.263385759825, 4264.658827293809, 4270.722403043792, 4311.50417701962, 4365.825366985348, 4367.432233809648, 3908.5309762828642, 3910.550286717064, 3918.216356728609, 3920.4315374270573, 3954.189391174802, 5479.5342395896, 5484.095124304445, 5512.80705175317, 5526.309211348582, 5532.640378375393, 5757.740901659436, 5762.88474230513, 5765.94234057654, 5768.250127483484, 5769.076947688433, 5251.081060814342, 5355.0896347621, 5449.972750136224, 5460.808871689472, 5461.098918678374, 4959.776810043484, 4962.354893863775, 4962.478939711351, 4963.305137280783, 4981.2030075187795, 5944.673042982591, 5946.286445626466, 5946.910796338058, 5950.107483877367, 5995.250593675791, 5507.146392309199, 5618.831435056954, 5659.518940890071, 5670.42997598211, 5721.199032135588, 5982.790602328898, 5990.820275391745, 5995.0407934731975, 6019.819405417845, 6044.576879618385, 5622.746976385991, 5624.971875140598, 5626.127950167731, 5631.0, 5631.2960879890015, 5542.61201715876, 5632.098864181711, 5668.744906479301, 5673.120666296731, 5737.110747834093, 5581.330240371181, 5582.302212223472, 5590.748416321194, 5614.24207731951, 5635.746391412478, 5522.723863806874, 5564.387917329172, 5567.137093750475, 5578.30271216098, 5579.13523403873, 5398.676079435089, 5500.477454641963, 5510.118381059011, 5548.167774833646, 5554.277943867433, 5679.914801278067, 5709.400512946247, 5729.169270455844, 5731.226284451713, 5736.397678243724, 5554.055810512142, 5566.471185237396, 5567.526760225264, 5567.777288908398, 5570.777168913198], "value": 5260.427949648431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.40677695197, 589.6904125334199, 594.1859652276382, 615.1449485215549, 617.7992152550422, 32995.505067424005, 35786.0, 45270.0, 46306.30540541895, 46333.76833115838, 46817.765911170485, 47144.292835607404, 47205.29192062122, 47304.0, 47344.28983565249, 9007.774805629862, 9156.313276504256, 9156.633734650606, 9167.174954254117, 9172.2203612693, 9015.278777697802, 9106.408083474553, 9113.772155696095, 9115.27077833775, 9121.407108537956, 9147.313951453634, 9202.4478531288, 9206.953965230165, 9207.769805754877, 9211.677591284306, 9129.360944733871, 9156.404833685789, 9166.816663666756, 9177.0, 9184.0, 8946.0, 9018.59416326267, 9030.413023153475, 9033.593488293043, 9037.141471560191, 44681.77659111716, 45034.32448513275, 45046.774766126284, 45051.77474112641, 45102.32346514805, 3386.255023894739, 3586.8385922633283, 3945.1320709443876, 4029.5366032906004, 4194.496660400741, 33374.0, 34235.31529369399, 34287.0, 34381.0, 34436.0, 4101.85643502476, 4217.325227963542, 4250.213710463574, 4335.5014173370155, 4359.6076353128055, 352463.0, 352515.0, 354056.0, 354184.0, 354234.0, 59969.700151499834, 60336.69831650814, 60414.07308524932, 60420.69789651024, 60463.39536604666, 62211.688941555905, 62541.0, 62568.0, 62851.0, 62973.68513157405, 16859.578510537336, 17150.828491715172, 17156.742648860276, 17162.39931602388, 17173.484795456156, 13068.934655326853, 13146.934265328613, 13157.210567365988, 13163.802542961863, 13166.934165329112, 15984.36062557508, 17231.138443077794, 17237.482875513753, 17298.827011729973, 17425.215865286093, 6663.833404164838, 6689.397954184049, 6755.1556055493065, 6760.256371799098, 6808.114945057111, 971.2958105373689, 1041.3699711674478, 1136.914731395132, 1174.3247632611112, 1199.2384835629439, 33258.8337058318, 33406.331873362884, 33802.49296260509, 33826.49260261098, 34040.319193615986, 1098.6484325015917, 1101.2896681640457, 1110.21729680575, 1149.2357582207906, 1223.5350566784564, 17349.82650173482, 17659.911700441673, 17681.823181768017, 17738.29046838138, 17827.96924522834, 561305.0, 565747.0, 567180.0, 567258.0, 567274.0, 60999.39000609937, 61052.694736526035, 61069.0, 61105.0, 61212.387876120665, 1243.5088140184757, 1355.2478374502246, 1374.793780932868, 1407.1275808998487, 1410.5989313342436, 32289.35421291514, 34860.65139348574, 34886.65113348936, 35197.02023127114, 35318.47022294719, 52900.47099528956, 53372.73313633407, 53481.4651853492, 53530.19704704355, 53579.46420535745, 418733.0, 420770.0, 423009.0, 423771.0, 424040.0, 42381.97371249726, 43324.0, 43748.0, 44208.0, 44269.778651106535, 50194.49805501898, 51019.744901275255, 51056.67603391988, 51369.486305136474, 51709.0, 42518.5748142527, 45748.0, 46358.30462543132, 46995.0, 47301.763491182326, 43339.34990975201, 43713.0, 44409.55590444183, 46543.301850471595, 47431.288530672755, 45049.0, 45261.32108018317, 45340.54659453363, 45751.313730294736, 46648.30027549657, 44208.33687494626, 45540.31689524594, 45541.11087304205, 47377.76311118422, 47677.76161119172, 29645.467999069017, 30336.54495182618, 30446.84776576103, 30935.69064309328, 31125.377492450476], "value": 21144.364629511016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5676059010957, 375.8139720838184, 393.9803009849507, 399.3430806323598, 409.9446574712415, 14429.63925901853, 16880.577985550368, 19850.70223946642, 20138.6979195312, 20145.0, 19652.9017354913, 19688.11403486843, 19831.702524462144, 19896.40310790675, 19931.60136797263, 5540.889182216363, 5569.053260945649, 5580.441955804427, 5735.397783232763, 5739.053056245714, 5444.700541470217, 5614.578906582003, 5621.297337832771, 5624.521915637176, 5625.493705566499, 5408.702521361323, 5584.664920104787, 5590.049691552445, 5591.916121258185, 5598.636088654245, 5568.1091025435935, 5593.496585307301, 5601.103823388259, 5603.159526071081, 5622.269105016342, 4863.343448634424, 4991.176455884774, 5025.070361983045, 5039.697618142924, 5085.110105731519, 23354.299371018897, 23413.41466463335, 23718.0, 23809.404764880845, 24054.39864003414, 2154.806067453921, 2230.2863083813186, 2341.7541158178487, 2460.3849037740565, 2873.7700983921236, 14309.212993285366, 14468.348924298432, 14600.70798584033, 14729.631759205999, 15141.621459463491, 1904.6381187574316, 1949.9512512187166, 1958.1188465190578, 1980.019890154383, 2004.2684420186526, 80701.0, 81861.59069204616, 84164.0, 84314.15685843125, 85022.14977850205, 11006.889931100746, 11040.227184097197, 11184.44077796107, 11187.552497899993, 11503.194776365573, 15874.0, 15886.76169857453, 15894.284757185955, 15902.76145857813, 15910.204489775464, 7885.645145968445, 8221.630026648696, 8268.131846156188, 8333.749987500263, 8356.415050946376, 7754.92245077542, 7811.804704882424, 7861.521817526113, 7989.201079892081, 8214.316065206618, 4729.858104256878, 4847.0, 4856.805727770849, 4945.579625731782, 4996.7001979881325, 1927.6144771045847, 1960.6961370688332, 1984.1369004483097, 1985.5830275641988, 2002.8383537548186, 942.561135425169, 947.199616324205, 958.7171784323641, 1003.2042643667899, 1006.4263369879245, 20290.391288261377, 20504.0, 20647.58704825895, 20675.379738607866, 20821.0, 960.2941837749248, 961.4135377419768, 971.6987733802544, 1002.9247806414548, 1018.5823812236947, 10986.285891417192, 11371.829422558669, 11442.713932151597, 11447.141464390204, 11498.655040348804, 518359.0, 526785.0, 527510.0, 528999.0, 552510.0, 88559.0, 92614.0, 100319.0, 102310.0, 103250.0, 988.1995583577182, 1017.2980643356209, 1043.7181960870673, 1044.8798388185455, 1048.0619845238468, 17381.190095846545, 17580.296788128842, 18010.0, 18406.447806565826, 18572.721409179143, 44353.0, 44455.55544444514, 44649.0, 44748.986295617426, 45893.31160032669, 60652.69673651604, 63570.0, 63783.3621663796, 65260.0, 66081.0, 8118.512889226666, 8223.588820558829, 8269.793255168428, 8478.279346255636, 8622.870656940026, 11716.824247636463, 12489.812652810397, 13339.933300333436, 13581.981351398486, 13870.930645346709, 12026.639200823989, 12050.75898482043, 12325.568605098779, 12372.505099795908, 12820.205171275842, 11631.243969141979, 12024.579139730067, 12064.75870482568, 12229.266244025386, 12453.813192802296, 12187.695307617381, 12229.69425764363, 12372.81440778371, 12375.195612285534, 12441.875581244072, 8731.738047858575, 8753.47479151253, 8791.340649451444, 8876.245519130945, 8970.506622135585, 11425.14311426663, 11887.881121188677, 11912.940435297767, 11924.105692072955, 12255.877441225473], "value": 9457.606558136984, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.5909268126875, 1458.1105525629368, 1505.5709122899973, 1602.8557429831312, 1738.5914310137116, 8097.0, 8437.578121093944, 8478.19457151571, 8717.91282087179, 8724.73825785226, 8438.662453501867, 8532.658693652262, 8546.786330341745, 8552.401331906753, 8555.0, 2384.4396566806786, 2411.710594728635, 2417.443987882788, 2419.721732000825, 2419.9274021779374, 2326.848754830939, 2389.6415537669313, 2397.5444665513496, 2397.5444665513496, 2399.0763556030965, 2353.1881500882255, 2354.882255887199, 2356.929292121239, 2400.927972160838, 2407.67496387988, 2294.4149241943364, 2309.284121922201, 2313.9305820825402, 2315.293835380217, 2344.2498400511845, 2300.9884950575306, 2329.8485598436046, 2335.7781010803947, 2336.299110266913, 2336.8481048731946, 8572.357073219533, 8584.957075214646, 8599.61301741423, 8639.65441382344, 8694.17405346491, 5143.177091665316, 5353.0, 5353.0899747043095, 5353.678779273256, 5354.625176237665, 3137.3568418474156, 3152.8265945372996, 3162.5256211568217, 3204.7115759581748, 3210.2616398228306, 1066.7599790047254, 1073.3345325897992, 1081.3349789879246, 1084.159776173464, 1097.7200813792513, 12307.26156430608, 12338.753224935452, 12367.196132251374, 12448.439820208112, 12491.999999999909, 4558.247889098262, 4608.470025946992, 4689.366935463737, 4697.084068606658, 4849.2726091085915, 9886.406815591088, 9904.0, 9910.950445247727, 9911.504424778732, 9936.503174841373, 5329.0, 5340.626156169109, 5353.705546194997, 5362.436944120889, 5366.141417373202, 4011.5988401159652, 4307.289297265978, 4422.646188304928, 4921.483244259372, 4943.480934501826, 3771.9245615087543, 3860.884173474744, 3919.980400097981, 3950.822213000364, 3952.8616498422416, 1151.0891919413732, 1176.3765204441659, 1177.7938860699344, 1183.0594677231622, 1188.423614546944, 828.6519661742083, 832.309183377795, 956.0773853231665, 965.5799727118725, 982.2878413150552, 5945.40545945402, 6192.225971753531, 6198.81403557894, 6200.844978875474, 6412.3267056959285, 1026.6047571684956, 1052.394872948058, 1080.3355936099242, 1089.8801131875487, 1105.8451816745662, 4355.412019377407, 4369.75966321849, 4446.221911165533, 4499.88750281239, 4645.674802763841, 11360.602378916697, 11368.090552755759, 11479.25384849982, 11489.368084755251, 11570.652880413601, 11392.658220253406, 11398.544058237578, 11409.600663976888, 11416.942915285537, 11430.885691143149, 8155.469894456842, 8461.576921153917, 8469.280111190494, 8585.8712119317, 8590.91409085901, 6357.841053973688, 6362.395572420613, 6383.39357761012, 6420.133282006869, 6452.451541618827, 10071.19430445548, 10344.534495947852, 10349.844752328872, 10367.533460994424, 10419.374837509773, 8916.910830891607, 10085.596576137166, 10181.541830617492, 10537.315074520438, 10537.578496860346, 7701.92298077012, 7961.800954976172, 7992.240737130196, 8007.35941124697, 8221.21898419673, 8410.327173825957, 8793.296536276954, 8798.252148567444, 8822.07368226327, 8881.245094167069, 7999.880001799861, 8032.879506807286, 8060.717874874351, 8123.959380203298, 8223.259906608433, 7722.459427839997, 7787.649555769891, 7829.334506566778, 7837.49056311338, 7916.4062695299235, 7354.77935661931, 7362.042934418491, 7368.889466657897, 7424.925750742424, 7428.1086269647985, 5388.919166212431, 5528.7235638218735, 5540.085885828793, 5569.916451253153, 5806.042003069446, 5399.190121481809, 5461.5357694596405, 5517.227588137584, 5540.36285827135, 5613.242212301287], "value": 4702.926235468468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.14649046253584, 332.5161889450849, 333.2884292036503, 336.9460886258199, 337.15206256265515, 5098.736808442595, 5132.615053870961, 5142.820001299955, 5146.456063181045, 5162.22566615008, 4801.463531669867, 4848.448496481127, 5036.0, 5037.672551284173, 5094.668846524974, 4070.308047631895, 4071.409645601386, 4074.348104303312, 4075.0, 4090.4886889138857, 4074.470318858544, 4077.755334679914, 4084.5098588169462, 4085.448464457305, 4086.816093275795, 3746.9812650936706, 3849.2301539692035, 3972.2254160438724, 3984.1434091670285, 4058.614431629005, 3939.5075615548058, 3944.9211015779524, 3946.980265098656, 3948.368261078228, 3976.8409263629565, 3500.877469288588, 3501.8074005929666, 3506.947395789065, 3509.631488693676, 3510.0, 4730.243161094243, 4920.360353154067, 4946.604271658259, 4956.207006878918, 4957.7769000395065, 4571.794269257892, 4579.107074120515, 4587.0, 4587.472440669332, 4610.109854959451, 5262.315898933152, 5271.525562699376, 5272.181097521349, 5279.234510995922, 5283.709395983219, 3596.5684117905757, 3932.2528719543197, 3943.4479172915817, 3946.861859834921, 3954.8220330085214, 5405.162199859028, 5439.830436456181, 5454.91817622736, 5476.26070480484, 5504.559635229172, 3859.807009649506, 3866.0141663875534, 3877.836649005287, 3882.0, 3883.76697398157, 3910.2179564087296, 3910.2375036868107, 3910.7066969977363, 3921.098147426051, 3926.450296958428, 4368.497622773358, 4430.313301438282, 4452.30989196675, 4483.3723278741, 4487.349334346502, 5333.320004198743, 5342.973285133549, 5343.145096784574, 5344.706041167696, 5348.689571055116, 1359.9796003059962, 1371.4719832864419, 1376.5526203983745, 1377.3044612470637, 1378.9862101379058, 883.3286702106445, 907.4147175072042, 922.3220932614523, 927.5037854747677, 943.2124176312718, 5113.057038325413, 5117.897642047138, 5122.795088196431, 5160.690358578422, 5161.458046905096, 5393.487618676219, 5414.3502779665905, 5430.484104010113, 5455.809046683347, 5464.480874316933, 5002.624803139779, 5180.559652429586, 5223.824639456168, 5265.236540701577, 5275.920861187085, 2912.1554749122943, 2918.664353599363, 2920.445115428062, 2932.6627437844495, 2936.8237905725723, 5468.4531546845, 5726.341470730836, 5754.280714910637, 5757.136429535603, 5775.0942189077505, 5536.612437129443, 5574.470425309671, 5585.525230355384, 5607.775688972477, 5608.10270356741, 5747.9882041286055, 5752.194692743019, 5764.308283005982, 5793.478586927113, 5800.4489573490455, 5242.68543887368, 5502.697351645698, 5523.8066667666435, 5549.7790486093, 5563.0, 5471.480209380103, 5479.4520547944885, 5480.972595136999, 5482.39693633708, 5484.61607687458, 5586.664800112007, 5757.683327417032, 5759.7984070559005, 5763.884722305615, 5770.740316685843, 3908.7459315144424, 3935.3309937310155, 3975.284448799244, 4000.9199816002933, 4004.1991601680365, 5526.696031718294, 5528.087865502147, 5536.501714845522, 5539.371711528955, 5540.252065971043, 5232.607554433509, 5401.783928642811, 5410.675359478444, 5424.2406063151975, 5437.646552974044, 5329.094054010905, 5378.337722827226, 5380.461953804588, 5388.218708287355, 5401.837944861661, 5078.7206703631655, 5173.896522069613, 5325.068113080118, 5333.359996800409, 5335.226392173191, 5390.703511306916, 5394.163904594794, 5404.621676482766, 5410.512109170009, 5413.810516631899, 5306.734663266899, 5308.672831792052, 5312.920306195333, 5317.415084340642, 5326.547243484347], "value": 4096.902325394796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.7361660227222, 773.8684423647979, 780.6760194519275, 808.7088648086687, 868.5309932636377, 15435.768463473043, 16163.030218186917, 16196.352145914148, 16200.837991620081, 16207.594810129753, 15224.847751522482, 15367.69264614707, 15373.846261537381, 15389.692206155898, 15398.30707618157, 647.7797548833396, 792.5403266105645, 807.4347956430493, 818.0428898189133, 821.3839620284787, 787.6180052674448, 787.6219414680957, 787.8148635070783, 788.1369899959535, 788.8501184774904, 831.6631764135535, 832.3549249331755, 832.4547421438967, 833.2251006563893, 835.6657337065192, 685.1367277230676, 832.4173078844802, 835.8913341265596, 857.3012994409598, 859.5487369131193, 630.0454810961397, 632.3676323676324, 632.3739497897049, 632.3771085480797, 632.7374139732005, 15371.077735335915, 15374.769378459332, 15397.461088861948, 15413.229338533141, 15416.845831541654, 14695.338709758087, 15007.249637518189, 15030.624234394118, 15058.54824355271, 15104.924475377553, 13515.459381624723, 13572.211123284194, 13740.381682824196, 13810.516631917835, 13857.722845543134, 4459.866204013885, 4487.0, 4544.545545445429, 4595.0, 4717.740524271164, 82085.58957205235, 83424.58287708584, 84210.0, 84508.73236901512, 84681.57659211665, 10592.894071059345, 10814.945925270324, 10933.070688991365, 11185.832212516818, 11547.480363383667, 20955.8952205238, 20977.265795697076, 20994.21549168338, 21033.05351259197, 21179.0, 8265.090840007595, 8330.791730206673, 8341.082480927093, 8368.665253389796, 8474.788130296793, 4776.689515181502, 4776.95223047772, 4845.854624361275, 4864.975675121673, 5034.572061374751, 3403.6256011838677, 3512.631173726773, 3544.858205671744, 3555.8933232003083, 3560.127768696686, 599.1372423709844, 605.4157737782972, 606.4087514673158, 612.4763327355137, 618.7463140112533, 584.3396961433552, 619.6932518403419, 678.5657179405184, 726.1612837173074, 740.7814694665087, 9621.374610650286, 9709.6601618943, 9769.218462523124, 9921.751956201153, 9995.400275983464, 588.9381614930456, 649.4609474136455, 658.4107224034462, 659.7756762700609, 660.8513084556032, 4660.438753017777, 4822.67671473773, 4915.11527924977, 4928.7289199093675, 4967.453580106186, 125863.370683146, 126792.36603816922, 127024.36487817502, 128042.0, 131631.34184329017, 105048.47475762572, 106430.46784766181, 107256.0, 109084.0, 109201.45399272953, 93673.0, 96008.0, 98455.52316715255, 99079.50460247653, 100220.0, 9206.907930920604, 10146.239032072477, 10321.174306055647, 10357.896421035693, 10523.0, 53783.0, 53802.0, 54151.72924135354, 55470.72264638651, 56464.0, 71315.0, 76877.0, 79916.0, 80920.59539702264, 82837.17162828294, 12105.515779368727, 12289.262644241375, 12484.563040293546, 12533.310667913353, 12662.810057849323, 15018.774718379014, 15281.46514871974, 15319.310631021408, 15853.920730396274, 16229.431969880998, 13777.862221377658, 14126.43494260218, 14144.504942326968, 14309.0, 14655.92672036633, 14526.927365363106, 14637.121772693672, 14727.190004549853, 15518.301676424813, 15541.300641470934, 13138.474461021453, 13177.604671859859, 13272.933635331761, 13387.263700496176, 13769.931150344184, 11679.299242045505, 11682.357470339213, 11702.239354441934, 11716.589919352782, 11915.582954596548, 10362.792744144925, 11278.379689117177, 12007.339596322287, 12383.442745076312, 12442.813357799821], "value": 7770.515308222952, "unit": "score"}], "name": "dromaeo_css", "value": 7348.858247567903, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 110.0, 109.0, 117.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 120.0, 185.0, 121.0, 117.0, 145.0, 122.0, 169.0, 118.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 160.0, 162.0, 161.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 77.0, 112.0, 76.0, 76.0, 73.0, 86.0, 99.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 132.0, 83.0, 85.0, 84.0, 114.0, 84.0, 84.0, 130.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 152.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 50.0, 61.0, 54.0, 51.0, 50.0, 49.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 78.0, 76.0, 76.0, 76.0, 76.0, 77.0, 76.0, 79.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 136.0, 119.0, 128.0, 120.0, 120.0, 121.0, 146.0, 123.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 157.0, 157.0, 156.0, 158.0, 156.0, 160.0, 159.0, 158.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 69.0, 62.0, 67.0, 65.0, 64.0, 63.0, 61.0, 62.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1484.3, "alertThreshold": 2.0}]} 06:51:07 INFO - Return code: 0 06:51:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:51:07 INFO - # TBPL SUCCESS # 06:51:07 INFO - Running post-action listener: _resource_record_post_action 06:51:07 INFO - [mozharness: 2016-08-06 13:51:07.090068Z] Finished run-tests step (success) 06:51:07 INFO - Running post-run listener: _resource_record_post_run 06:51:07 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550715392; Read time: 16; Write time: 458592 06:51:07 INFO - TinderboxPrint: CPU usage
13.0% 06:51:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:51:07 INFO - TinderboxPrint: I/O write bytes / time
550,715,392 / 458,592 06:51:07 INFO - TinderboxPrint: CPU idle
8,284.2 (87.0%) 06:51:07 INFO - TinderboxPrint: CPU user
1,191.6 (12.5%) 06:51:07 INFO - TinderboxPrint: Swap in / out
0 / 0 06:51:07 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257196032; Read time: 0; Write time: 249372 06:51:07 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293519360; Read time: 16; Write time: 209220 06:51:07 INFO - Running post-run listener: _upload_blobber_files 06:51:07 INFO - Blob upload gear active. 06:51:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:51:07 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 06:51:07 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'] 06:51:07 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 06:51:08 INFO - (blobuploader) - INFO - Open directory for files ... 06:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:51:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:08 INFO - (blobuploader) - INFO - Done attempting. 06:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:12 INFO - (blobuploader) - INFO - Done attempting. 06:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:13 INFO - (blobuploader) - INFO - Done attempting. 06:51:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:51:13 INFO - Return code: 0 06:51:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:51:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:51:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43b6d042738885f622cae0c751bbdbf13ea5a38f3f37e8b9fc7a3e57d55a6cee39947b71bdfb881a91bf5a3d65fae80d253c368d502cf16c9b11bee4523c9346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5efad4246926bfc78387b9cbf394428c6c229b9b5c7fca664f39049c2db0fdbf56d26e937610816762c8ab61fa04e9e5db3fc5a1bee2c29065aaf255740f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cd5128c0c8ccf5bf37939b3b815d421d64a883017de3b1f48c9bd69ddee0e36bd2761ef01b1c850ade953e2192cdc40eac8ed6baef9b38e4bde42dc19b61176"} 06:51:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:51:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:51:13 INFO - Contents: 06:51:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43b6d042738885f622cae0c751bbdbf13ea5a38f3f37e8b9fc7a3e57d55a6cee39947b71bdfb881a91bf5a3d65fae80d253c368d502cf16c9b11bee4523c9346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5efad4246926bfc78387b9cbf394428c6c229b9b5c7fca664f39049c2db0fdbf56d26e937610816762c8ab61fa04e9e5db3fc5a1bee2c29065aaf255740f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cd5128c0c8ccf5bf37939b3b815d421d64a883017de3b1f48c9bd69ddee0e36bd2761ef01b1c850ade953e2192cdc40eac8ed6baef9b38e4bde42dc19b61176"} 06:51:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:51:13 INFO - Copying logs to upload dir... 06:51:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:51:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.333526 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-06 06:51:13.235086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 06:51:13.242820) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43b6d042738885f622cae0c751bbdbf13ea5a38f3f37e8b9fc7a3e57d55a6cee39947b71bdfb881a91bf5a3d65fae80d253c368d502cf16c9b11bee4523c9346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5efad4246926bfc78387b9cbf394428c6c229b9b5c7fca664f39049c2db0fdbf56d26e937610816762c8ab61fa04e9e5db3fc5a1bee2c29065aaf255740f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cd5128c0c8ccf5bf37939b3b815d421d64a883017de3b1f48c9bd69ddee0e36bd2761ef01b1c850ade953e2192cdc40eac8ed6baef9b38e4bde42dc19b61176"} build_url:https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/ISNdwF93Q1ioolhAw5xRQQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43b6d042738885f622cae0c751bbdbf13ea5a38f3f37e8b9fc7a3e57d55a6cee39947b71bdfb881a91bf5a3d65fae80d253c368d502cf16c9b11bee4523c9346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5efad4246926bfc78387b9cbf394428c6c229b9b5c7fca664f39049c2db0fdbf56d26e937610816762c8ab61fa04e9e5db3fc5a1bee2c29065aaf255740f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cd5128c0c8ccf5bf37939b3b815d421d64a883017de3b1f48c9bd69ddee0e36bd2761ef01b1c850ade953e2192cdc40eac8ed6baef9b38e4bde42dc19b61176"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 06:51:13.272320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:51:13.272713) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470490240.617466-504714232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 06:51:13.328670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 06:51:13.329056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 06:51:13.329441) ========= ========= Total master_lag: 0.35 =========