builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1472755757.05 results: success (0) buildid: 20160901111321 builduid: f0df6025abeb4b85b733ba7b66f4dc2d revision: d667c9cd84f16752ae92c2b683afcc35e0483ec3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.049858) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.050419) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.050781) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.066275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.066572) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 11:49:17-- 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% 220M=0s 2016-09-01 11:49:17 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.398334 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.481168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.481787) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014638 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.532689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:17.533086) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d667c9cd84f16752ae92c2b683afcc35e0483ec3 --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 d667c9cd84f16752ae92c2b683afcc35e0483ec3 --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=78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 11:49:17,672 truncating revision to first 12 chars 2016-09-01 11:49:17,672 Setting DEBUG logging. 2016-09-01 11:49:17,672 attempt 1/10 2016-09-01 11:49:17,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d667c9cd84f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 11:49:18,147 unpacking tar archive at: fx-team-d667c9cd84f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.819419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:18.366663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:18.367013) ========= script_repo_revision: d667c9cd84f16752ae92c2b683afcc35e0483ec3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:18.367498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:18.367819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 11:49:18.378332) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-09-01 11:49:18.378708) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:18 INFO - MultiFileLogger online at 20160901 11:49:18 in /builds/slave/test 11:49:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:49:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:18 INFO - {'append_to_log': False, 11:49:18 INFO - 'base_work_dir': '/builds/slave/test', 11:49:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:49:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:18 INFO - 'branch': 'Fx-Team-Non-PGO', 11:49:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:18 INFO - 'config_files': ('talos/linux_config.py',), 11:49:18 INFO - 'default_actions': ('clobber', 11:49:18 INFO - 'read-buildbot-config', 11:49:18 INFO - 'download-and-extract', 11:49:18 INFO - 'populate-webroot', 11:49:18 INFO - 'create-virtualenv', 11:49:18 INFO - 'install', 11:49:18 INFO - 'run-tests'), 11:49:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:18 INFO - 'download_minidump_stackwalk': True, 11:49:18 INFO - 'download_symbols': 'ondemand', 11:49:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:18 INFO - 'installer_path': 'installer.exe', 11:49:18 INFO - 'log_level': 'info', 11:49:18 INFO - 'log_name': 'talos', 11:49:18 INFO - 'log_to_console': True, 11:49:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:18 INFO - 'opt_config_files': (), 11:49:18 INFO - 'pip_index': False, 11:49:18 INFO - 'sps_profile': False, 11:49:18 INFO - 'sps_profile_interval': 0, 11:49:18 INFO - 'suite': 'dromaeojs', 11:49:18 INFO - 'system_bits': '32', 11:49:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:18 INFO - 'title': 'talos-linux64-ix-019', 11:49:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:18 INFO - 'use_talos_json': True, 11:49:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:18 INFO - 'work_dir': 'build'} 11:49:18 INFO - [mozharness: 2016-09-01 18:49:18.611283Z] Running clobber step. 11:49:18 INFO - Running pre-action listener: _resource_record_pre_action 11:49:18 INFO - Running main action method: clobber 11:49:18 INFO - rmtree: /builds/slave/test/build 11:49:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:19 INFO - Running post-action listener: _resource_record_post_action 11:49:19 INFO - [mozharness: 2016-09-01 18:49:19.070263Z] Finished clobber step (success) 11:49:19 INFO - [mozharness: 2016-09-01 18:49:19.070365Z] Running read-buildbot-config step. 11:49:19 INFO - Running pre-action listener: _resource_record_pre_action 11:49:19 INFO - Running main action method: read_buildbot_config 11:49:19 INFO - Using buildbot properties: 11:49:19 INFO - { 11:49:19 INFO - "project": "", 11:49:19 INFO - "product": "firefox", 11:49:19 INFO - "script_repo_revision": "production", 11:49:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:49:19 INFO - "repository": "", 11:49:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:49:19 INFO - "buildid": "20160901111321", 11:49:19 INFO - "pgo_build": "False", 11:49:19 INFO - "basedir": "/builds/slave/test", 11:49:19 INFO - "buildnumber": 3266, 11:49:19 INFO - "slavename": "talos-linux64-ix-019", 11:49:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:49:19 INFO - "platform": "ubuntu64_hw", 11:49:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:49:19 INFO - "branch": "fx-team", 11:49:19 INFO - "repo_path": "integration/fx-team", 11:49:19 INFO - "revision": "d667c9cd84f16752ae92c2b683afcc35e0483ec3", 11:49:19 INFO - "stage_platform": "linux64", 11:49:19 INFO - "builduid": "f0df6025abeb4b85b733ba7b66f4dc2d", 11:49:19 INFO - "slavebuilddir": "test" 11:49:19 INFO - } 11:49:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:49:19 INFO - Running post-action listener: _resource_record_post_action 11:49:19 INFO - [mozharness: 2016-09-01 18:49:19.072830Z] Finished read-buildbot-config step (success) 11:49:19 INFO - [mozharness: 2016-09-01 18:49:19.072921Z] Running download-and-extract step. 11:49:19 INFO - Running pre-action listener: _resource_record_pre_action 11:49:19 INFO - Running main action method: download_and_extract 11:49:19 INFO - mkdir: /builds/slave/test/build/tests 11:49:19 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')]} 11:49:19 INFO - trying https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:49:19 INFO - Downloading https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:19 INFO - Downloaded 1361 bytes. 11:49:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:49:19 INFO - Using the following test package requirements: 11:49:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:49:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:49:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'jsshell-linux-x86_64.zip'], 11:49:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:49:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:49:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:49:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:49:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:49:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:49:19 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')]} 11:49:19 INFO - trying https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:49:19 INFO - Downloading https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:20 INFO - Downloaded 20334629 bytes. 11:49:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:49:24 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 11:49:24 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')]} 11:49:24 INFO - trying https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:49:24 INFO - Downloading https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:26 INFO - Downloaded 20334629 bytes. 11:49:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:49: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')]} 11:49:31 INFO - trying https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:31 INFO - Downloading https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:32 INFO - Downloaded 14413998 bytes. 11:49:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:32 INFO - trying https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:49:32 INFO - Downloading https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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 11:49:34 INFO - Downloaded 55868627 bytes. 11:49:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:49:34 INFO - mkdir: /builds/slave/test/properties 11:49:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:34 INFO - Contents: 11:49:34 INFO - build_url:https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:49:35 INFO - Running post-action listener: _resource_record_post_action 11:49:35 INFO - Running post-action listener: set_extra_try_arguments 11:49:35 INFO - [mozharness: 2016-09-01 18:49:35.325421Z] Finished download-and-extract step (success) 11:49:35 INFO - [mozharness: 2016-09-01 18:49:35.325650Z] Running populate-webroot step. 11:49:35 INFO - Running pre-action listener: _resource_record_pre_action 11:49:35 INFO - Running main action method: populate_webroot 11:49:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:35 INFO - '--tppagecycles', 11:49:35 INFO - '7'], 11:49:35 INFO - 'tests': ['tsvgm']}}, 11:49:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['damp', 'tps']}, 11:49:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'tests': ['damp', 'tps']}, 11:49:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['dromaeo_dom']}, 11:49:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['basic_compositor_video']}, 11:49:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:49:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['a11yr', 11:49:35 INFO - 'ts_paint', 11:49:35 INFO - 'tpaint', 11:49:35 INFO - 'sessionrestore', 11:49:35 INFO - 'sessionrestore_no_auto_restore', 11:49:35 INFO - 'tabpaint']}, 11:49:35 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:35 INFO - 'ts_paint', 11:49:35 INFO - 'tpaint', 11:49:35 INFO - 'sessionrestore', 11:49:35 INFO - 'sessionrestore_no_auto_restore', 11:49:35 INFO - 'tabpaint']}, 11:49:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:35 INFO - 'ts_paint', 11:49:35 INFO - 'tpaint', 11:49:35 INFO - 'sessionrestore', 11:49:35 INFO - 'sessionrestore_no_auto_restore', 11:49:35 INFO - 'tabpaint']}, 11:49:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:35 INFO - 'ts_paint', 11:49:35 INFO - 'tpaint', 11:49:35 INFO - 'sessionrestore', 11:49:35 INFO - 'sessionrestore_no_auto_restore', 11:49:35 INFO - 'tabpaint']}, 11:49:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['a11yr', 11:49:35 INFO - 'ts_paint', 11:49:35 INFO - 'tpaint', 11:49:35 INFO - 'sessionrestore', 11:49:35 INFO - 'sessionrestore_no_auto_restore', 11:49:35 INFO - 'tabpaint']}, 11:49:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['a11yr', 11:49:35 INFO - 'ts_paint', 11:49:35 INFO - 'tpaint', 11:49:35 INFO - 'sessionrestore', 11:49:35 INFO - 'sessionrestore_no_auto_restore', 11:49:35 INFO - 'tabpaint']}, 11:49:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['tsvgx', 11:49:35 INFO - 'tsvgr_opacity', 11:49:35 INFO - 'tart', 11:49:35 INFO - 'tscrollx', 11:49:35 INFO - 'cart']}, 11:49:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:35 INFO - 'tsvgr_opacity', 11:49:35 INFO - 'tart', 11:49:35 INFO - 'tscrollx', 11:49:35 INFO - 'cart']}, 11:49:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'talos_options': ['--disable-e10s'], 11:49:35 INFO - 'tests': ['tp5o']}, 11:49:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'tests': ['tp5o']}, 11:49:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'talos_options': ['--disable-e10s', 11:49:35 INFO - '--xperf_path', 11:49:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:35 INFO - 'tests': ['tp5n']}, 11:49:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:35 INFO - 'talos_options': ['--xperf_path', 11:49:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:35 INFO - 'tests': ['tp5n']}}, 11:49:35 INFO - 'talos.zip': {'path': '', 11:49:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:35 INFO - Running post-action listener: _resource_record_post_action 11:49:35 INFO - [mozharness: 2016-09-01 18:49:35.346772Z] Finished populate-webroot step (success) 11:49:35 INFO - [mozharness: 2016-09-01 18:49:35.346863Z] Running create-virtualenv step. 11:49:35 INFO - Running pre-action listener: _resource_record_pre_action 11:49:35 INFO - Running main action method: create_virtualenv 11:49:35 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:35 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 11:49:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:35 INFO - Using real prefix '/usr' 11:49:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:37 INFO - Installing pip.................done. 11:49:37 INFO - Return code: 0 11:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:49:37 INFO - Using env: {'DISPLAY': ':0', 11:49:37 INFO - 'HOME': '/home/cltbld', 11:49:37 INFO - 'LANG': 'en_US.UTF-8', 11:49:37 INFO - 'LANGUAGE': 'en_US:en', 11:49:37 INFO - 'LOGNAME': 'cltbld', 11:49:37 INFO - 'MAIL': '/var/mail/cltbld', 11:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:37 INFO - 'MOZ_NO_REMOTE': '1', 11:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:37 INFO - 'NO_EM_RESTART': '1', 11:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:37 INFO - 'PWD': '/builds/slave/test', 11:49:37 INFO - 'SHELL': '/bin/bash', 11:49:37 INFO - 'SHLVL': '1', 11:49:37 INFO - 'TERM': 'linux', 11:49:37 INFO - 'TMOUT': '86400', 11:49:37 INFO - 'USER': 'cltbld', 11:49:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:37 INFO - '_': '/tools/buildbot/bin/python'} 11:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:38 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 11:49:38 INFO - Cleaning up... 11:49:38 INFO - Return code: 0 11:49:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:38 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 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:38 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 11:49:38 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 11:49:38 INFO - Using env: {'DISPLAY': ':0', 11:49:38 INFO - 'HOME': '/home/cltbld', 11:49:38 INFO - 'LANG': 'en_US.UTF-8', 11:49:38 INFO - 'LANGUAGE': 'en_US:en', 11:49:38 INFO - 'LOGNAME': 'cltbld', 11:49:38 INFO - 'MAIL': '/var/mail/cltbld', 11:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:38 INFO - 'MOZ_NO_REMOTE': '1', 11:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:38 INFO - 'NO_EM_RESTART': '1', 11:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:38 INFO - 'PWD': '/builds/slave/test', 11:49:38 INFO - 'SHELL': '/bin/bash', 11:49:38 INFO - 'SHLVL': '1', 11:49:38 INFO - 'TERM': 'linux', 11:49:38 INFO - 'TMOUT': '86400', 11:49:38 INFO - 'USER': 'cltbld', 11:49:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:38 INFO - '_': '/tools/buildbot/bin/python'} 11:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:38 INFO - Downloading/unpacking psutil>=3.1.1 11:49:38 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 11:49:38 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 11:49:38 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 11:49:38 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 11:49:38 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 11:49:38 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 11:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:40 INFO - Installing collected packages: psutil 11:49:40 INFO - Running setup.py install for psutil 11:49:40 INFO - building 'psutil._psutil_linux' extension 11:49:40 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 11:49:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:49:40 INFO - building 'psutil._psutil_posix' extension 11:49:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:49:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:40 INFO - Successfully installed psutil 11:49:40 INFO - Cleaning up... 11:49:40 INFO - Return code: 0 11:49:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:49:40 INFO - Using env: {'DISPLAY': ':0', 11:49:40 INFO - 'HOME': '/home/cltbld', 11:49:40 INFO - 'LANG': 'en_US.UTF-8', 11:49:40 INFO - 'LANGUAGE': 'en_US:en', 11:49:40 INFO - 'LOGNAME': 'cltbld', 11:49:40 INFO - 'MAIL': '/var/mail/cltbld', 11:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:40 INFO - 'MOZ_NO_REMOTE': '1', 11:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:40 INFO - 'NO_EM_RESTART': '1', 11:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:40 INFO - 'PWD': '/builds/slave/test', 11:49:40 INFO - 'SHELL': '/bin/bash', 11:49:40 INFO - 'SHLVL': '1', 11:49:40 INFO - 'TERM': 'linux', 11:49:40 INFO - 'TMOUT': '86400', 11:49:40 INFO - 'USER': 'cltbld', 11:49:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:40 INFO - '_': '/tools/buildbot/bin/python'} 11:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 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 11:49:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:49:43 INFO - Installing collected packages: mozsystemmonitor 11:49:43 INFO - Running setup.py install for mozsystemmonitor 11:49:43 INFO - Successfully installed mozsystemmonitor 11:49:43 INFO - Cleaning up... 11:49:43 INFO - Return code: 0 11:49:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:43 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 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:43 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 11:49:43 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 11:49:43 INFO - Using env: {'DISPLAY': ':0', 11:49:43 INFO - 'HOME': '/home/cltbld', 11:49:43 INFO - 'LANG': 'en_US.UTF-8', 11:49:43 INFO - 'LANGUAGE': 'en_US:en', 11:49:43 INFO - 'LOGNAME': 'cltbld', 11:49:43 INFO - 'MAIL': '/var/mail/cltbld', 11:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:43 INFO - 'MOZ_NO_REMOTE': '1', 11:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:43 INFO - 'NO_EM_RESTART': '1', 11:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:43 INFO - 'PWD': '/builds/slave/test', 11:49:43 INFO - 'SHELL': '/bin/bash', 11:49:43 INFO - 'SHLVL': '1', 11:49:43 INFO - 'TERM': 'linux', 11:49:43 INFO - 'TMOUT': '86400', 11:49:43 INFO - 'USER': 'cltbld', 11:49:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:43 INFO - '_': '/tools/buildbot/bin/python'} 11:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:43 INFO - Downloading/unpacking jsonschema==2.5.1 11:49:43 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 11:49:43 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 11:49:43 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 11:49:43 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 11:49:43 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 11:49:43 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 11:49:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:49:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:49:45 INFO - warning: no files found matching '*.txt' 11:49:45 INFO - no previously-included directories found matching 'build' 11:49:45 INFO - no previously-included directories found matching 'dist' 11:49:45 INFO - no previously-included directories found matching '.git*' 11:49:45 INFO - Installing collected packages: jsonschema, functools32 11:49:45 INFO - Running setup.py install for functools32 11:49:45 INFO - warning: no files found matching '*.txt' 11:49:45 INFO - no previously-included directories found matching 'build' 11:49:45 INFO - no previously-included directories found matching 'dist' 11:49:45 INFO - no previously-included directories found matching '.git*' 11:49:45 INFO - Successfully installed jsonschema functools32 11:49:45 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:49:45 INFO - Using env: {'DISPLAY': ':0', 11:49:45 INFO - 'HOME': '/home/cltbld', 11:49:45 INFO - 'LANG': 'en_US.UTF-8', 11:49:45 INFO - 'LANGUAGE': 'en_US:en', 11:49:45 INFO - 'LOGNAME': 'cltbld', 11:49:45 INFO - 'MAIL': '/var/mail/cltbld', 11:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:45 INFO - 'MOZ_NO_REMOTE': '1', 11:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:45 INFO - 'NO_EM_RESTART': '1', 11:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:45 INFO - 'PWD': '/builds/slave/test', 11:49:45 INFO - 'SHELL': '/bin/bash', 11:49:45 INFO - 'SHLVL': '1', 11:49:45 INFO - 'TERM': 'linux', 11:49:45 INFO - 'TMOUT': '86400', 11:49:45 INFO - 'USER': 'cltbld', 11:49:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:45 INFO - '_': '/tools/buildbot/bin/python'} 11:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:49:45 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:46 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 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:46 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 11:49:46 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 11:49:46 INFO - Using env: {'DISPLAY': ':0', 11:49:46 INFO - 'HOME': '/home/cltbld', 11:49:46 INFO - 'LANG': 'en_US.UTF-8', 11:49:46 INFO - 'LANGUAGE': 'en_US:en', 11:49:46 INFO - 'LOGNAME': 'cltbld', 11:49:46 INFO - 'MAIL': '/var/mail/cltbld', 11:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:46 INFO - 'MOZ_NO_REMOTE': '1', 11:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:46 INFO - 'NO_EM_RESTART': '1', 11:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:46 INFO - 'PWD': '/builds/slave/test', 11:49:46 INFO - 'SHELL': '/bin/bash', 11:49:46 INFO - 'SHLVL': '1', 11:49:46 INFO - 'TERM': 'linux', 11:49:46 INFO - 'TMOUT': '86400', 11:49:46 INFO - 'USER': 'cltbld', 11:49:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:46 INFO - '_': '/tools/buildbot/bin/python'} 11:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:46 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:46 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 11:49:46 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 11:49:46 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 11:49:46 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 11:49:46 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 11:49:46 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 11:49:48 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 INFO - Downloading docopt-0.6.1.tar.gz 11:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:48 INFO - Running setup.py install for blobuploader 11:49:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:48 INFO - Running setup.py install for requests 11:49:49 INFO - Running setup.py install for docopt 11:49:49 INFO - Successfully installed blobuploader requests docopt 11:49:49 INFO - Cleaning up... 11:49:49 INFO - Return code: 0 11:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:49 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 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:49 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 11:49:49 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 11:49:49 INFO - Using env: {'DISPLAY': ':0', 11:49:49 INFO - 'HOME': '/home/cltbld', 11:49:49 INFO - 'LANG': 'en_US.UTF-8', 11:49:49 INFO - 'LANGUAGE': 'en_US:en', 11:49:49 INFO - 'LOGNAME': 'cltbld', 11:49:49 INFO - 'MAIL': '/var/mail/cltbld', 11:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:49 INFO - 'MOZ_NO_REMOTE': '1', 11:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:49 INFO - 'NO_EM_RESTART': '1', 11:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:49 INFO - 'PWD': '/builds/slave/test', 11:49:49 INFO - 'SHELL': '/bin/bash', 11:49:49 INFO - 'SHLVL': '1', 11:49:49 INFO - 'TERM': 'linux', 11:49:49 INFO - 'TMOUT': '86400', 11:49:49 INFO - 'USER': 'cltbld', 11:49:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:49 INFO - '_': '/tools/buildbot/bin/python'} 11:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:49 INFO - Running setup.py (path:/tmp/pip-rDdOLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:49 INFO - Running setup.py (path:/tmp/pip-JNC4j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:49 INFO - Running setup.py (path:/tmp/pip-LwCyQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:49 INFO - Running setup.py (path:/tmp/pip-cIvnmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:49 INFO - Running setup.py (path:/tmp/pip-AprmyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 INFO - Running setup.py (path:/tmp/pip-ja7wic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:50 INFO - Running setup.py (path:/tmp/pip-vzxqzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:50 INFO - Running setup.py (path:/tmp/pip-QiooXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:50 INFO - Running setup.py (path:/tmp/pip-a208DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:50 INFO - Running setup.py (path:/tmp/pip-tA2RXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:50 INFO - Running setup.py (path:/tmp/pip-oZtkHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:50 INFO - Running setup.py (path:/tmp/pip-zj3G9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:50 INFO - Running setup.py (path:/tmp/pip-MQWcjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:50 INFO - Running setup.py (path:/tmp/pip-JkBnlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:50 INFO - Running setup.py (path:/tmp/pip-9ZklNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:50 INFO - Running setup.py (path:/tmp/pip-2Nse5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:50 INFO - Running setup.py (path:/tmp/pip-UDrOkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:50 INFO - Running setup.py install for manifestparser 11:49:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Running setup.py install for mozcrash 11:49:51 INFO - Running setup.py install for mozdebug 11:49:51 INFO - Running setup.py install for mozdevice 11:49:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Running setup.py install for mozfile 11:49:51 INFO - Running setup.py install for mozhttpd 11:49:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Running setup.py install for mozinfo 11:49:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Running setup.py install for mozInstall 11:49:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Running setup.py install for mozleak 11:49:51 INFO - Running setup.py install for mozlog 11:49:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:51 INFO - Running setup.py install for moznetwork 11:49:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Running setup.py install for mozprocess 11:49:52 INFO - Running setup.py install for mozprofile 11:49:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Running setup.py install for mozrunner 11:49:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Running setup.py install for mozscreenshot 11:49:52 INFO - Running setup.py install for moztest 11:49:52 INFO - Running setup.py install for mozversion 11:49:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:52 INFO - Cleaning up... 11:49:52 INFO - Return code: 0 11:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:49:52 INFO - Using env: {'DISPLAY': ':0', 11:49:52 INFO - 'HOME': '/home/cltbld', 11:49:52 INFO - 'LANG': 'en_US.UTF-8', 11:49:52 INFO - 'LANGUAGE': 'en_US:en', 11:49:52 INFO - 'LOGNAME': 'cltbld', 11:49:52 INFO - 'MAIL': '/var/mail/cltbld', 11:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:52 INFO - 'MOZ_NO_REMOTE': '1', 11:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:52 INFO - 'NO_EM_RESTART': '1', 11:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:52 INFO - 'PWD': '/builds/slave/test', 11:49:52 INFO - 'SHELL': '/bin/bash', 11:49:52 INFO - 'SHLVL': '1', 11:49:52 INFO - 'TERM': 'linux', 11:49:52 INFO - 'TMOUT': '86400', 11:49:52 INFO - 'USER': 'cltbld', 11:49:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:52 INFO - '_': '/tools/buildbot/bin/python'} 11:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:52 INFO - Running setup.py (path:/tmp/pip-YlJaQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:52 INFO - Running setup.py (path:/tmp/pip-WlBwjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:53 INFO - Running setup.py (path:/tmp/pip-QRwyrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:53 INFO - Running setup.py (path:/tmp/pip-LIvOvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:53 INFO - Running setup.py (path:/tmp/pip-362QKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:53 INFO - Running setup.py (path:/tmp/pip-3AbVG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:53 INFO - Running setup.py (path:/tmp/pip-yENGwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:53 INFO - Running setup.py (path:/tmp/pip-ss2S0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:53 INFO - Running setup.py (path:/tmp/pip-iPdU2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:53 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)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:53 INFO - Running setup.py (path:/tmp/pip-xwLOkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:53 INFO - Running setup.py (path:/tmp/pip-q1eJVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:53 INFO - Running setup.py (path:/tmp/pip-ihW4L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:53 INFO - Running setup.py (path:/tmp/pip-zcoT3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:53 INFO - Running setup.py (path:/tmp/pip-sqRjYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:53 INFO - Running setup.py (path:/tmp/pip-XNPWId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:54 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)) 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:54 INFO - Running setup.py (path:/tmp/pip-PMXmxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:54 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)) 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:54 INFO - Running setup.py (path:/tmp/pip-CtRPWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:54 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)) 11:49:54 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)) 11:49:54 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)) 11:49:54 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)) 11:49:54 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)) 11:49:54 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)) 11:49:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:56 INFO - Downloading blessings-1.6.tar.gz 11:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:56 INFO - Installing collected packages: blessings 11:49:56 INFO - Running setup.py install for blessings 11:49:56 INFO - Successfully installed blessings 11:49:56 INFO - Cleaning up... 11:49:56 INFO - Return code: 0 11:49:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:56 INFO - Reading from file tmpfile_stdout 11:49:56 INFO - Current package versions: 11:49:56 INFO - argparse == 1.2.1 11:49:56 INFO - blessings == 1.6 11:49:56 INFO - blobuploader == 1.2.4 11:49:56 INFO - docopt == 0.6.1 11:49:56 INFO - functools32 == 3.2.3-2 11:49:56 INFO - jsonschema == 2.5.1 11:49:56 INFO - manifestparser == 1.1 11:49:56 INFO - mozInstall == 1.12 11:49:56 INFO - mozcrash == 0.17 11:49:56 INFO - mozdebug == 0.1 11:49:56 INFO - mozdevice == 0.48 11:49:56 INFO - mozfile == 1.2 11:49:56 INFO - mozhttpd == 0.7 11:49:56 INFO - mozinfo == 0.9 11:49:56 INFO - mozleak == 0.1 11:49:56 INFO - mozlog == 3.3 11:49:56 INFO - moznetwork == 0.27 11:49:56 INFO - mozprocess == 0.23 11:49:56 INFO - mozprofile == 0.28 11:49:56 INFO - mozrunner == 6.12 11:49:56 INFO - mozscreenshot == 0.1 11:49:56 INFO - mozsystemmonitor == 0.3 11:49:56 INFO - moztest == 0.7 11:49:56 INFO - mozversion == 1.4 11:49:56 INFO - psutil == 3.1.1 11:49:56 INFO - requests == 1.2.3 11:49:56 INFO - wsgiref == 0.1.2 11:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 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 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:56 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 11:49:56 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 11:49:56 INFO - Using env: {'DISPLAY': ':0', 11:49:56 INFO - 'HOME': '/home/cltbld', 11:49:56 INFO - 'LANG': 'en_US.UTF-8', 11:49:56 INFO - 'LANGUAGE': 'en_US:en', 11:49:56 INFO - 'LOGNAME': 'cltbld', 11:49:56 INFO - 'MAIL': '/var/mail/cltbld', 11:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:56 INFO - 'MOZ_NO_REMOTE': '1', 11:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:56 INFO - 'NO_EM_RESTART': '1', 11:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:56 INFO - 'PWD': '/builds/slave/test', 11:49:56 INFO - 'SHELL': '/bin/bash', 11:49:56 INFO - 'SHLVL': '1', 11:49:56 INFO - 'TERM': 'linux', 11:49:56 INFO - 'TMOUT': '86400', 11:49:56 INFO - 'USER': 'cltbld', 11:49:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:56 INFO - '_': '/tools/buildbot/bin/python'} 11:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:49:56 INFO - Cleaning up... 11:49:56 INFO - Return code: 0 11:49:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb572d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', '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 11:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:49:56 INFO - Using env: {'DISPLAY': ':0', 11:49:56 INFO - 'HOME': '/home/cltbld', 11:49:56 INFO - 'LANG': 'en_US.UTF-8', 11:49:56 INFO - 'LANGUAGE': 'en_US:en', 11:49:56 INFO - 'LOGNAME': 'cltbld', 11:49:56 INFO - 'MAIL': '/var/mail/cltbld', 11:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:56 INFO - 'MOZ_NO_REMOTE': '1', 11:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:56 INFO - 'NO_EM_RESTART': '1', 11:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:56 INFO - 'PWD': '/builds/slave/test', 11:49:56 INFO - 'SHELL': '/bin/bash', 11:49:56 INFO - 'SHLVL': '1', 11:49:56 INFO - 'TERM': 'linux', 11:49:56 INFO - 'TMOUT': '86400', 11:49:56 INFO - 'USER': 'cltbld', 11:49:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:56 INFO - '_': '/tools/buildbot/bin/python'} 11:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:49:56 INFO - Cleaning up... 11:49:56 INFO - Return code: 0 11:49:56 INFO - Running post-action listener: _resource_record_post_action 11:49:56 INFO - Running post-action listener: _start_resource_monitoring 11:49:56 INFO - Starting resource monitoring. 11:49:56 INFO - [mozharness: 2016-09-01 18:49:56.960509Z] Finished create-virtualenv step (success) 11:49:56 INFO - [mozharness: 2016-09-01 18:49:56.960972Z] Running install step. 11:49:56 INFO - Running pre-action listener: _resource_record_pre_action 11:49:56 INFO - Running main action method: install 11:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:57 INFO - Reading from file tmpfile_stdout 11:49:57 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:57 INFO - Reading from file tmpfile_stdout 11:49:57 INFO - Output received: 11:49:57 INFO - Usage: mozinstall [options] installer 11:49:57 INFO - Options: 11:49:57 INFO - -h, --help show this help message and exit 11:49:57 INFO - -d DEST, --destination=DEST 11:49:57 INFO - Directory to install application into. [default: 11:49:57 INFO - "/builds/slave/test"] 11:49:57 INFO - --app=APP Application being installed. [default: firefox] 11:49:57 INFO - mkdir: /builds/slave/test/build/application 11:49:57 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'] 11:49:57 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 11:50:13 INFO - Reading from file tmpfile_stdout 11:50:13 INFO - Output received: 11:50:13 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:13 INFO - Running post-action listener: _resource_record_post_action 11:50:13 INFO - [mozharness: 2016-09-01 18:50:13.392778Z] Finished install step (success) 11:50:13 INFO - [mozharness: 2016-09-01 18:50:13.393062Z] Running run-tests step. 11:50:13 INFO - Running pre-action listener: _resource_record_pre_action 11:50:13 INFO - Running main action method: run_tests 11:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:13 INFO - Python 2.7.3 11:50:13 INFO - Return code: 0 11:50:13 INFO - grabbing minidump binary from tooltool 11:50: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')]} 11:50:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b090>, '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 0x186e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:50:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:50:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:50:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:13 INFO - Return code: 0 11:50:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 11:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 11:50:13 INFO - Using env: {'DISPLAY': ':0', 11:50:13 INFO - 'HOME': '/home/cltbld', 11:50:13 INFO - 'LANG': 'en_US.UTF-8', 11:50:13 INFO - 'LANGUAGE': 'en_US:en', 11:50:13 INFO - 'LOGNAME': 'cltbld', 11:50:13 INFO - 'MAIL': '/var/mail/cltbld', 11:50:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:13 INFO - 'MOZ_NO_REMOTE': '1', 11:50:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:13 INFO - 'NO_EM_RESTART': '1', 11:50:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:13 INFO - 'PWD': '/builds/slave/test', 11:50:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:13 INFO - 'SHELL': '/bin/bash', 11:50:13 INFO - 'SHLVL': '1', 11:50:13 INFO - 'TERM': 'linux', 11:50:13 INFO - 'TMOUT': '86400', 11:50:13 INFO - 'USER': 'cltbld', 11:50:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544', 11:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:13 INFO - '_': '/tools/buildbot/bin/python'} 11:50:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 11:50:13 INFO - mozversion application_buildid: 20160901111321 11:50:13 INFO - mozversion application_changeset: d667c9cd84f16752ae92c2b683afcc35e0483ec3 11:50:13 INFO - mozversion application_display_name: Nightly 11:50:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:13 INFO - mozversion application_name: Firefox 11:50:13 INFO - mozversion application_remotingname: firefox 11:50:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:50:13 INFO - mozversion application_vendor: Mozilla 11:50:13 INFO - mozversion application_version: 51.0a1 11:50:13 INFO - mozversion platform_buildid: 20160901111321 11:50:13 INFO - mozversion platform_changeset: d667c9cd84f16752ae92c2b683afcc35e0483ec3 11:50:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:13 INFO - mozversion platform_version: 51.0a1 11:50:13 INFO - using testdate: 1472755813 11:50:13 INFO - actual date: 1472755813 11:50:13 INFO - starting webserver on 'localhost:41800' 11:50:13 INFO - SUITE-START | Running 2 tests 11:50:13 INFO - TEST-START | dromaeo_css 11:50:13 INFO - operating with platform_type : linux_ 11:50:13 INFO - Initialising browser for dromaeo_css test... 11:50:13 INFO - TEST-INFO | started process 4745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN84uTt/profile http://localhost:41800/getInfo.html) 11:50:18 INFO - PROCESS | 4745 | __metrics Screen width/height:1600/1200 11:50:18 INFO - PROCESS | 4745 | colorDepth:24 11:50:18 INFO - PROCESS | 4745 | Browser inner width/height: 1024/697 11:50:18 INFO - PROCESS | 4745 | __metrics 11:50:19 INFO - PROCESS | 4745 | 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" 11:50:19 INFO - PROCESS | 4745 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:19 INFO - PROCESS | 4745 | console.error: PushService: 11:50:19 INFO - PROCESS | 4745 | stateChangeProcessEnqueue: Error transitioning state 11:50:19 INFO - PROCESS | 4745 | UnknownError 11:50:20 INFO - TEST-INFO | 4745: exit 0 11:50:20 INFO - Browser initialized. 11:50:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:20 INFO - TEST-INFO | started process 4828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN84uTt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:32 INFO - PROCESS | 4828 | RSS: Main: 181096448 11:50:32 INFO - PROCESS | 4828 | 11:51:24 INFO - PROCESS | 4828 | 1472755884313 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] 11:53:37 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:41800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41800/tests/dromaeo/cssquery-ext.html) 11:53:38 INFO - PROCESS | 4828 | RSS: Main: 281821184 11:53:38 INFO - PROCESS | 4828 | 11:56:41 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:41800/tests/dromaeo/cssquery-ext.html (next: http://localhost:41800/tests/dromaeo/cssquery-jquery.html) 11:56:42 INFO - PROCESS | 4828 | RSS: Main: 269352960 11:56:42 INFO - PROCESS | 4828 | 11:59:44 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:41800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41800/tests/dromaeo/cssquery-mootools.html) 11:59:45 INFO - PROCESS | 4828 | RSS: Main: 251256832 11:59:45 INFO - PROCESS | 4828 | 12:02:47 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:41800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41800/tests/dromaeo/cssquery-prototype.html) 12:02:47 INFO - PROCESS | 4828 | RSS: Main: 218501120 12:02:47 INFO - PROCESS | 4828 | 12:05:51 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:41800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41800/tests/dromaeo/cssquery-yui.html) 12:05:51 INFO - PROCESS | 4828 | RSS: Main: 219246592 12:05:51 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:41800/tests/dromaeo/cssquery-yui.html (next: http://localhost:41800/tests/dromaeo/cssquery-dojo.html) 12:08:54 INFO - PROCESS | 4828 | RSS: Main: 309858304 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | __start_tp_report 12:08:54 INFO - PROCESS | 4828 | _x_x_mozilla_page_load 12:08:54 INFO - PROCESS | 4828 | _x_x_mozilla_page_load_details 12:08:54 INFO - PROCESS | 4828 | |i|pagename|runs| 12:08:54 INFO - PROCESS | 4828 | |0;dojo.html;2625.776808971237;2629.500394924964;2648.801339899508;2680.798940079493;2690.408110215752;4706.082313948781;4793.304970779235;4793.400824896888;4856.295837103622;4910.7299098549565;4775.14047471455;4790.97604511977;4811.3264143019915;4839.516048395159;4880.560749532541;4321.58944900234;4347.7173983690955;4422.71252368595;4481.7983190756495;4583.495815460314;4499.167653984007;4516.187086324477;4535.115652447774;4558.72647641141;4568.406107206059;4352.825886964518;4378.824847006116;4395.3846461495095;4402.911941761179;4413.602775750198;4393.033532622818;4397.824087036514;4399.73601583906;4430.136123455927;4485.753283569403;4421.07157496926;4424.380586717862;4427.778611069466;4464.8883777905485;4480.93278600818;4671.369365135731;4741.217699079648;4778.904421911542;4825.083234185528;4831.855044348676;5115.18157094863;5123.820666276662;5124.948750512522;5126.359205099363;5193.272941788153;5149.098907691139;5157.948420515784;5171.2501687255135;5174.61190410717;5177.352830896138;4675.883102922386;4702.882427939329;4717.386739723814;4816.109019831342;4816.61467082629;5124.692518448905;5145.614078944094;5153.484651534816;5199.428062913152;5210.062188806051;4932.950670493321;4937.629677774109;4943.975280123576;4944.332515110486;5001.149804533238;5023.397192336943;5026.346574945233;5048.545630893163;5084.8220312288895;5110.8466745997675;5083.415407228142;5089.51649593288;5096.184610462308;5139.563137133386;5144.511271429208;5069.264956581275;5089.262057001714;5091.032703786343;5098.898022039539;5143.12566863634;4342.32693932441;4380.78096095194;4381.539938306496;4390.100029493946;4438.822447102079;3831.9042023949623;3839.404892241707;3888.7861167635488;3914;3930.469386632768;4389.934150987738;4399.560043995575;4403.383526306319;4407.42703448556;4456.598906098467;4985.626078044161;5051.520105589963;5190.6107041972;5201.2198170274005;5206.7917283309;4350;4361.847335343247;4370.2352088384405;4419.756913369732;4425.955740442619;4647.9767601161775;4649.395578574764;4655.906881862344;4698.036902434993;4705.411823522059;4661.137689527312;4803.519648035169;4806.206975848946;4815.518448155157;4818.518148185153;5136.383633963948;5223.033738758342;5252.5535329497425;5253.868653283698;5264.368275806928;4840.394950631171;4846.951530484791;4856.611471082376;4856.975715121402;4916.410030796184;5103.617228707788;5106.66806657566;5106.719130447861;5112.923306150485;5156.535911767809;5057.8735531612;5114.820981265638;5134.614903882149;5169.147090730138;5210.47895210476;5022.723750193774;5025.045241404122;5027;5028.547430731252;5087.771050302671;4982.327385802871;5029.1953287473825;5039.244113383022;5043.445221025758;5045.4450010498085;4851.442084160226;4963.379577552806;4991.750412479434;5019.146745053423;5082.1106306395495;5055.849500293939;5116.488351164854;5136.229565565195;5137.563307118937;5137.845864624067;4823.5658790709;4872.731999739906;5029.64792464524;5034.647574669738;5044.495550444926 12:08:54 INFO - PROCESS | 4828 | |1;ext.html;565.1409857017331;570.0252568108534;577.7313549199619;580.5065694159962;581.7847396463309;27293.181204563843;37597.81201093994;38422.615773842255;38849.22301553974;42838.785806070926;40125;40342;40535;40614;40705.59294407055;7016.158061032683;7670.96164519178;7819.569923654197;7822.295993360596;7822.452428330019;7027.578345299273;7206.8558628827395;7210.567365958033;9694.079062489052;9961.203103751719;10059.949700251489;10124.848127278097;10127.6961691149;10130.392176469435;10136.645217417392;10002.149817265505;10003.39979601219;10010.54952527138;10014.79970400588;10020.749481262954;9755.463449510275;9817.705468835946;9818.214542836557;9821.754456138653;9836.606535738561;36963.63036369629;37277.627223727686;37412.43881341782;37422.43866342007;37432.43851342232;2891.2193707698802;2940.7059294070423;3020.5318175682805;3132.5144602586633;3513.2095278562374;28305.292367690767;28487.57268640972;28536.714632853822;28721.56917646237;30066.098017059525;3490.3019396120876;3500.8949731508096;3505.2814173094453;3597.3524765542193;3632.4369722693023;243973;245804;246159;246816;247046;50443.24335134976;51175.48824511782;51212;51242.74378628158;51252.48747512477;31765.841170794;32438.513422298685;32643.347133057207;34158.82920585381;52762.20856687153;14759.92620036893;14886.478973235884;14912.179830109448;14919.328630211667;14920.253987300592;10747.40889251083;10866.511007004703;10876.564937402574;10890.61882834097;10892.945535272273;15037.548873533811;15200.163990980602;15225.238738063052;16007.679846403007;17099.829001709822;6504.1869766279215;6564.835879102965;6857.451403887677;6886.8622627547165;6947.756828510978;735.3418690272176;842.5660784695887;855.6320782063648;943.5942544705842;954.0936110694868;24977.62533561998;27807.443851122865;28310.43379132406;28312.71687283142;28336.574951375747;827.4662842466576;914.0311270053764;927.1053433436766;943.1417410156724;956.2875657635107;14427.3507692152;14677.706445871236;14825.110493370217;15114.168720720467;15191;384230.10389273043;497826;505067;506529;506743;50453.74773126111;50983.235251471255;51027.48972510302;51067.23399149016;51069.91440684736;1154.2497376705041;1158.9594364197212;1184;1188.6671731915078;1193.3734789235548;27210.591841122794;28265.293367665974;29035.41929161447;29367.706322936498;29535.55696664595;41980.58019419767;42676.573234267256;42704.14591708086;42705.359419609355;42723.3591496134;286362;287204;287206;287759;287883;22121.55756884821;23936.40158996039;24835.379115521533;25196.748032520172;25673.229803105936;39878;39967.80016099901;40689.79655101824;41216.175676485705;41265.1746965065;33600.831995839864;33686;34153.316933661685;34169.829150854086;34449;33606.32787344191;33948.66051339455;34158.487622686174;34184;34274.82862585671;33114.5032824503;33262.66737332596;33548.161295967795;33644.49533257052;34443;29185.708142918298;30946;31335.529967050057;31376.843115784275;31553;24081;24362.390940225927;24542.386440339134;24851.13021044255;24958.0016799326 12:08:54 INFO - PROCESS | 4828 | |2;jquery.html;361.1260748987452;364.9087728067982;365.4408754605453;378.3228021840905;381.429762505055;15317.540473785777;16144.596385090379;16918.238679259433;16994.83005169948;17002.40491582795;16038.59903502413;16558.66882662346;17138.400155994543;17253.30986760528;17286.827131728678;4850.757462126889;5089.84730458085;5091.414487333948;5105.055564720538;5107.336046313974;3611.693006094485;3754.7796965986026;5058.949410505885;5599.1041433370665;5868.295804503466;5932.940670593303;5934.31755348134;5937.435943585374;5942.6137301075505;5944.97027514864;5711.143328500737;5846.736896839631;5869.295684517842;5870.882582348372;5881.323647780496;5009.448960614366;5144.125498665198;5146.871328216825;5151.356080489939;5158.845234642967;19280.22879084835;19758.506037349038;20457.18171273147;20788;20802.16791328345;1910.579672472054;1922.9134688939032;1924.9711254331196;1935.6709359408935;1957.2268953763185;12760.36198190096;13428.462861485528;13727.862721372758;14094.718105637932;14115.505957291445;1680.3446655804246;1735.6788994036144;1737.409280844519;1751.1106673988022;1757.2092558348795;68698.3130168697;71664.6416767918;71745.9238111434;72027;72834;9319.673811416567;9464.2553659438;9698.46658433793;9699.951500242594;10059.446730429896;13325.333733313295;13363.665908352368;13373.264470454023;13375.933120334335;13389.66525836862;6979.092717946634;7178.318059784312;7207.675654595451;7590.316871481593;7634.312911837961;6782.321767823179;6846.931530684629;6899.413549848218;7146.499745017799;7382.114146302478;6086;6086.756529738849;6091.360407157274;6125.356837531995;6172.9074063889075;1611.5084899105884;1658.6019355354629;1687.6287216812282;1730.6279149982813;1763.3563749231694;834.1866679986964;867.0505796153202;878.4070752242211;888.6623083228332;897.2328658996595;16485.91757041207;16956.541301511214;17670.91164544195;17677;18090.819091808913;846.2398211719609;865.4893612768496;868.0538213347355;876.0232340939933;893.6790617364983;9843.60625574969;10033.698989030196;10163.441010744333;10225.539850706737;10234.846477302846;386825;392204;392789;395203;396828;68741.65629171922;68862.31137688558;70482.64758676276;70578;70799.64600177068;913.7350168451075;914.6615752171739;924.4360939826701;940.0693313619468;943.3867985809279;15172.468963586221;15277.465288715286;15548.84451155474;16248.187590620659;16265.186740663155;33815.154621134665;34021.91736991577;34264.65735342615;34422;35367;43324;46685.766571168286;46869.06261874675;49208.2618760726;55015.17477237764;6613.66931653425;6859.211190713132;6860.5540639858245;6916.619585922823;7070.646467676493;9065.365424420228;11231.326120432801;11790.646280611596;11953.880461195624;12634.115611907078;10023.348482348623;10257.897421025695;10432.165426765992;10735.355878647306;10785.568577256821;10321.035073304363;10354.637587684394;10421.895781042396;10440;10733.409662468326;10053.161474265642;10284.125849302893;11118.555257789598;11386.146039046938;11430.714232144262;7638.579878106758;7770.961145194238;7812.257835505618;7826.921730782619;7898.960505197667;10561;10708.946455267675;10765.138788897026;10901.34591924487;10963.725906852074 12:08:54 INFO - PROCESS | 4828 | |3;mootools.html;1330.5010621017118;1372.1835507872815;1383.1631862723052;1572.567543925421;1593.6095656564137;6786.762463313785;7382.741604043859;7407.407407407408;8009.519428834274;8010.799730006753;7469.887951680729;7799.337056350217;7801.336886364666;7805.219478052192;7806.375489960804;2184.759676435595;2214.457457922811;2220.7224096987875;2224.4327696437385;2227.20934068405;1833.4041436533114;2115.344243284579;2139.0481235849975;2152.0961196297594;2152.7309086364203;2142.603618330606;2160.12514931453;2167.815735662463;2173.0438607012943;2178.749443813958;2116.4391436269325;2151.580441813847;2164.101897712447;2174.6520556711007;2174.934751957444;2116.0795054151495;2129.4569884679463;2141.5288636499945;2143.024923659731;2146.7853214678407;7888.816677498421;7906.881396779053;8038.356931445471;8039.31665808407;8041.477303975223;4550.749708766017;4660.347551342815;4709.458412282597;4716.457607375161;4721.881952951169;2715.266877942964;2834.078924349574;2912.155474912273;2913.3444974880695;2937.7062293770664;884.3986089459165;914.6981496106268;936.8688383626297;937.2642475656577;939.8261321655448;10628.840567391419;10629.627963021258;10666.573337066586;10677.039066484054;10678.145748340192;3811.1805961718364;4091.938620920629;4299.935500967488;4301.741895486281;4308.67684923632;9202.90797092034;9206.941201761749;9221.723348299427;9222.170004699608;9224.584893679801;4752.596029337545;4752.667313288037;4756.476787553366;4757.119932812441;4760.404949381327;4250.3199488081755;4285.657147428198;4293.055527783882;4343.609075183185;4351.891202719894;3593.568771747407;3656.3601369760186;3714.7213958953184;3745.9063523411587;3750;1077.6012875236213;1152.6311580294225;1179.9469023893946;1185.733210027737;1221.2794451273614;654.4371840217409;747.2340850628041;762.9732959346396;777.2616014785863;778.7391223939931;4800.615950723934;4842.370491836039;4889.853304400874;4996.675216110941;5004.974975125101;815.9469634473859;847.631280393031;861.7113267055606;873.24028095556;882.6601758323092;3566.233259849145;3621.3843646580144;3630.582483014487;3657.5976642569294;3720.4605332227216;9300.348975571645;9405.623775049058;9634.084761947604;9674.661386851427;9689.321747477608;8089.959550202211;9614.278929080347;9620.37467564606;9623.133917947418;9627.518624068909;6925.203601585781;7194.856102877913;7243.89134162988;7379.852402952019;7396.112466504054;5294.391145018218;5322.54758345545;5374.892502150014;5393.352797664305;5595.63628364155;8895.911040889509;9067.863982040142;9069.138431848964;9148.634054638007;9156.908430915606;8669.21977022071;8879.378443508893;8909.198172164277;9066.682666106655;9124.589393477178;6411.294757576756;6616.139901812733;6619.74224897268;6623.277947733528;6623.735050598115;7036.9296307036275;7151.82120446993;7215.891761623685;7220.241874603301;7220.38626716735;6396.168498095218;6406.87186256263;6432.163818703726;6469.256035555972;6553.967230163818;6421.935780642134;6425.967870160619;6520.217573891164;6616.371444712745;6626.271110177973;6334.683265836782;6345.7144428499905;6355.428011478989;6396.200474940632;6404.4876409886165;4394.494633117232;4407.162639098561;4488.48382436011;4501.819927202875;4670.065986802721;4344.304911214191;4368.497622773421;4393.7363758174615;4429.357743127293;4590.977045114753 12:08:54 INFO - PROCESS | 4828 | |4;prototype.html;297.06720896385355;299.239930576336;300.6752707076357;303.93161538653794;306.1382209081437;4839.903201935959;4851.975740121295;4853.538913803183;4876.268559716044;4881.975590122049;4793.185158523051;4798.664093513456;4830.44449888263;4866.562009419152;4873.1471992401275;3571.607123216444;3666.6333366663252;3668.679844740514;3679.68722658573;3690.520232369788;3655.1958569114754;3787.829547670348;3790.3177428062936;3851.7496362736333;3852.306584814732;3768.2651882882847;3769.302679004379;3774.7168962327796;3788.299164654534;3807.1814559869763;3564.1802385451233;3721.7208709346905;3780.4707340972286;3788.507494025759;3810.485584446106;3277.5575297334794;3284.4252255855367;3285.4414749492403;3293.8682452701864;3296.8516416761304;4673.929891051637;4682.508336624639;4700.012997270577;4705.882352941169;4722.504137065627;4255.425517555122;4288.16380805743;4288.849890253858;4291.613754762056;4292.463442069741;4924.60603151747;5016.924746128811;5054.418741844698;5069.822556210552;5078.162103252959;3592;3595.7482976191677;3602.35157671619;3602.369585322558;3606.6393360663988;5273.525382715574;5298.682079075268;5314.441983591706;5340.465953404629;5353.384360798558;3443.345764304774;3653.6711695947492;3668.1013151777984;3675.088953744038;3704.759190652599;3714.220013797079;3732.626737326246;3733.7305316192624;3763.6048214937587;3765.5104836371643;4297.978510107429;4298.527162012176;4302.967287850894;4317.287647538121;4322.7190232634775;4936.47042364711;5166.225066240019;5166.992436474927;5172.844814655567;5186.714730689849;1276.6425400887767;1297.6107167849607;1298.3638017371609;1298.4222021200665;1299.2529295655036;800.7757827808223;814.1492140712969;824.4640983360863;826.7313123234852;826.8304997475624;4251.893702657397;4314.71954322968;4429.49060857999;4491.910161796745;4499.887502812456;5227.26818245446;5273.841784746463;5285.365756109291;5285.920711189336;5288.312519372457;4484.775761211927;4497.707649002804;4498.730076195438;4509.827444864359;4511.300748384006;2646.465050270838;2758.6275852759622;2778.6804517480346;2807.7332653397893;2811.1566530040905;4888.364512613338;4906.435759887588;4914.508549145128;4919.06537757832;4921.360223170965;5098.770555324945;5319.255304257407;5362.785488580413;5390.353157621111;5412.458754124635;4874.439439464436;4875.195592727231;4885.682430641997;4892.584130348889;4917.188663870493;5184.585233181412;5190.870228244324;5209.583233341399;5219.660722053054;5227.712475813714;4851.878703032311;5099.209622508517;5147.150720131136;5154.53609175176;5163.328767260232;4874.439439464507;4909.828156014522;4972.975135124301;4973.358791598692;4980.825671101494;3817.541894972621;3849;3849.1147036182397;3862.643787289695;3867.3425517661503;5059.316992206005;5280.603954703336;5285.392179899361;5314.335708036496;5319.606177220344;5079.136546786981;5099.974500127476;5107.642465027412;5113.488651135006;5114.207297868837;5115;5115.846524604268;5119.232115182753;5121.1550094234035;5125.282460455614;4971.4051879872195;4998.275250088789;5046.646734728533;5051.247070346743;5052.722100284373;4923.5814955729165;4951.430585482715;5128.8461346159675;5143.3570803649545;5144.9742751286;4994.326900488377;5003.474635163256;5013;5020.15554989437;5028.64799464034 12:08:54 INFO - PROCESS | 4828 | |5;yui.html;627.9560430769845;645.9031145328203;691.7993781803274;712.6971037309144;732.6226993098555;12891.871081289184;13863.376148073336;13944.651383715413;14033.578992630211;14203.289835508222;12428.813567796491;12670.80993785094;12673;12676.873231267684;12696.428660710268;585.70421936922;710.1584622222682;714.1822613107988;716.8028792082193;730.4667592657363;729.3690957321905;731.5208538407352;731.5574077683005;731.6049333359979;732.1068296678044;770.8304173081913;771.090113665874;771.1671394893501;771.3713323641242;771.699037375424;611.5535658968934;613.9570230083896;617.1051974636749;630.7161777200232;768.4083255892959;546.4508169289838;547.8958997790407;555.5111501878321;563.0990415335472;563.5125616341876;12936.870631293756;12945.611631651065;12998.155119917175;12999;12999.740005199938;12037.518499260019;12339.853337398996;12346.197497162655;12575.685607859785;12756.30294095598;8841.681930397344;9011.864822027675;9048.638054477813;9117.452952822852;11363.090952723762;3768.5477742670782;3778.6599206071587;3859;3972.503437070366;3995.800209989489;60324;60805.69597151986;61223.69388153075;62101.37898621001;63475.68262158706;9651.517424128766;9766.902330976742;9769.90230097704;9799.706008819747;10216.029477199654;17730.20214090369;17776.9111154446;17779.73330400045;17830.10849457522;17848.46454606364;6681.365270299314;6750.8649827004165;6775.288594697486;6781.830454238585;6803.081583986099;3664.706823454117;3746.4380342948775;3764.3036038333;3792.5069740934055;3820.331441997695;2702.4730177615174;2780.7636350909993;2810.3817160224717;2812.1844665046906;2812.7890408219464;469.6078774223493;478.909007288614;481.4559547711064;489.6107594462411;490.5315423770291;447.5993985383064;518.362414230491;542.2977244468423;543.7661805423705;559.1696330948538;7347.26527347261;7551.320381165721;7574.848503029909;7731.183171954586;7740.806479838049;487.22044728434224;498.185466761847;500.30207860035046;504.47534564053706;513.1091926251775;3401.693847553732;3458.239187378773;3505.737069719781;3558.1638314995957;3644.9635503645154;104780.47609761903;105115.47442262739;105346.4732676347;106905;110057.44971275092;85441;90346;91636.63265867294;91792;92700.53649731843;79065.60467197627;79821;82464;82878;83758;6610.867782644416;6693.068320506076;6757.93242067573;6785.457163427012;6909.1018167639895;46314.58966565334;47222.29166562573;47712.761436192595;48010.75994620004;49542;67155.3284467149;67234.66382668055;68417;68713.2573485315;69783.30216697768;8793;8941.195292423454;9119.407238529475;9125.680601178927;9284;10373.831309183313;10474.581016759244;10483.26251836549;10547.05076543084;10578.8413173804;8842.24840888506;9469.431834089977;9914.553845076845;9919.603215871284;10624.946875265574;11065.944670276596;11710.1217408693;11765.352905590275;12551.435185416862;12565.434555444845;9674.275200159022;10061.647842325483;10078.092971632588;10309.587616495257;10717.14262858985;9007.954960225157;9383.718488445358;9474.95262523683;9654.565544550653;9665.130138287588;9027.909720902708;9127.863082053642;9161.35870489086;9606.855897161688;9775.560099795384 12:08:54 INFO - PROCESS | 4828 | __end_tp_report 12:08:54 INFO - PROCESS | 4828 | __start_cc_report 12:08:54 INFO - PROCESS | 4828 | _x_x_mozilla_cycle_collect,916 12:08:54 INFO - PROCESS | 4828 | __end_cc_report 12:08:54 INFO - PROCESS | 4828 | __startTimestamp1472756934912__endTimestamp 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | ------- Summary: start ------- 12:08:54 INFO - PROCESS | 4828 | Number of tests: 6 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | [#0] dojo.html Cycles:165 Average:4752.29 Median:4856.61 stddev:494.88 (10.2%) stddev-sans-first:467.44 12:08:54 INFO - PROCESS | 4828 | Values: 2625.8 2629.5 2648.8 2680.8 2690.4 4706.1 4793.3 4793.4 4856.3 4910.7 4775.1 4791.0 4811.3 4839.5 4880.6 4321.6 4347.7 4422.7 4481.8 4583.5 4499.2 4516.2 4535.1 4558.7 4568.4 4352.8 4378.8 4395.4 4402.9 4413.6 4393.0 4397.8 4399.7 4430.1 4485.8 4421.1 4424.4 4427.8 4464.9 4480.9 4671.4 4741.2 4778.9 4825.1 4831.9 5115.2 5123.8 5124.9 5126.4 5193.3 5149.1 5157.9 5171.3 5174.6 5177.4 4675.9 4702.9 4717.4 4816.1 4816.6 5124.7 5145.6 5153.5 5199.4 5210.1 4933.0 4937.6 4944.0 4944.3 5001.1 5023.4 5026.3 5048.5 5084.8 5110.8 5083.4 5089.5 5096.2 5139.6 5144.5 5069.3 5089.3 5091.0 5098.9 5143.1 4342.3 4380.8 4381.5 4390.1 4438.8 3831.9 3839.4 3888.8 3914.0 3930.5 4389.9 4399.6 4403.4 4407.4 4456.6 4985.6 5051.5 5190.6 5201.2 5206.8 4350.0 4361.8 4370.2 4419.8 4426.0 4648.0 4649.4 4655.9 4698.0 4705.4 4661.1 4803.5 4806.2 4815.5 4818.5 5136.4 5223.0 5252.6 5253.9 5264.4 4840.4 4847.0 4856.6 4857.0 4916.4 5103.6 5106.7 5106.7 5112.9 5156.5 5057.9 5114.8 5134.6 5169.1 5210.5 5022.7 5025.0 5027.0 5028.5 5087.8 4982.3 5029.2 5039.2 5043.4 5045.4 4851.4 4963.4 4991.8 5019.1 5082.1 5055.8 5116.5 5136.2 5137.6 5137.8 4823.6 4872.7 5029.6 5034.6 5044.5 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | [#1] ext.html Cycles:180 Average:48208.16 Median:34050.99 stddev:93945.99 (275.9%) stddev-sans-first:94141.43 12:08:54 INFO - PROCESS | 4828 | Values: 565.1 570.0 577.7 580.5 581.8 27293.2 37597.8 38422.6 38849.2 42838.8 40125.0 40342.0 40535.0 40614.0 40705.6 7016.2 7671.0 7819.6 7822.3 7822.5 7027.6 7206.9 7210.6 9694.1 9961.2 10059.9 10124.8 10127.7 10130.4 10136.6 10002.1 10003.4 10010.5 10014.8 10020.7 9755.5 9817.7 9818.2 9821.8 9836.6 36963.6 37277.6 37412.4 37422.4 37432.4 2891.2 2940.7 3020.5 3132.5 3513.2 28305.3 28487.6 28536.7 28721.6 30066.1 3490.3 3500.9 3505.3 3597.4 3632.4 243973.0 245804.0 246159.0 246816.0 247046.0 50443.2 51175.5 51212.0 51242.7 51252.5 31765.8 32438.5 32643.3 34158.8 52762.2 14759.9 14886.5 14912.2 14919.3 14920.3 10747.4 10866.5 10876.6 10890.6 10892.9 15037.5 15200.2 15225.2 16007.7 17099.8 6504.2 6564.8 6857.5 6886.9 6947.8 735.3 842.6 855.6 943.6 954.1 24977.6 27807.4 28310.4 28312.7 28336.6 827.5 914.0 927.1 943.1 956.3 14427.4 14677.7 14825.1 15114.2 15191.0 384230.1 497826.0 505067.0 506529.0 506743.0 50453.7 50983.2 51027.5 51067.2 51069.9 1154.2 1159.0 1184.0 1188.7 1193.4 27210.6 28265.3 29035.4 29367.7 29535.6 41980.6 42676.6 42704.1 42705.4 42723.4 286362.0 287204.0 287206.0 287759.0 287883.0 22121.6 23936.4 24835.4 25196.7 25673.2 39878.0 39967.8 40689.8 41216.2 41265.2 33600.8 33686.0 34153.3 34169.8 34449.0 33606.3 33948.7 34158.5 34184.0 34274.8 33114.5 33262.7 33548.2 33644.5 34443.0 29185.7 30946.0 31335.5 31376.8 31553.0 24081.0 24362.4 24542.4 24851.1 24958.0 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | [#2] jquery.html Cycles:180 Average:24280.69 Median:193603.21 stddev:64648.82 (33.4%) stddev-sans-first:64805.23 12:08:54 INFO - PROCESS | 4828 | Values: 361.1 364.9 365.4 378.3 381.4 15317.5 16144.6 16918.2 16994.8 17002.4 16038.6 16558.7 17138.4 17253.3 17286.8 4850.8 5089.8 5091.4 5105.1 5107.3 3611.7 3754.8 5058.9 5599.1 5868.3 5932.9 5934.3 5937.4 5942.6 5945.0 5711.1 5846.7 5869.3 5870.9 5881.3 5009.4 5144.1 5146.9 5151.4 5158.8 19280.2 19758.5 20457.2 20788.0 20802.2 1910.6 1922.9 1925.0 1935.7 1957.2 12760.4 13428.5 13727.9 14094.7 14115.5 1680.3 1735.7 1737.4 1751.1 1757.2 68698.3 71664.6 71745.9 72027.0 72834.0 9319.7 9464.3 9698.5 9700.0 10059.4 13325.3 13363.7 13373.3 13375.9 13389.7 6979.1 7178.3 7207.7 7590.3 7634.3 6782.3 6846.9 6899.4 7146.5 7382.1 6086.0 6086.8 6091.4 6125.4 6172.9 1611.5 1658.6 1687.6 1730.6 1763.4 834.2 867.1 878.4 888.7 897.2 16485.9 16956.5 17670.9 17677.0 18090.8 846.2 865.5 868.1 876.0 893.7 9843.6 10033.7 10163.4 10225.5 10234.8 386825.0 392204.0 392789.0 395203.0 396828.0 68741.7 68862.3 70482.6 70578.0 70799.6 913.7 914.7 924.4 940.1 943.4 15172.5 15277.5 15548.8 16248.2 16265.2 33815.2 34021.9 34264.7 34422.0 35367.0 43324.0 46685.8 46869.1 49208.3 55015.2 6613.7 6859.2 6860.6 6916.6 7070.6 9065.4 11231.3 11790.6 11953.9 12634.1 10023.3 10257.9 10432.2 10735.4 10785.6 10321.0 10354.6 10421.9 10440.0 10733.4 10053.2 10284.1 11118.6 11386.1 11430.7 7638.6 7771.0 7812.3 7826.9 7899.0 10561.0 10708.9 10765.1 10901.3 10963.7 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | [#3] mootools.html Cycles:180 Average:5096.58 Median:5308.47 stddev:2859.76 (53.9%) stddev-sans-first:2853.78 12:08:54 INFO - PROCESS | 4828 | Values: 1330.5 1372.2 1383.2 1572.6 1593.6 6786.8 7382.7 7407.4 8009.5 8010.8 7469.9 7799.3 7801.3 7805.2 7806.4 2184.8 2214.5 2220.7 2224.4 2227.2 1833.4 2115.3 2139.0 2152.1 2152.7 2142.6 2160.1 2167.8 2173.0 2178.7 2116.4 2151.6 2164.1 2174.7 2174.9 2116.1 2129.5 2141.5 2143.0 2146.8 7888.8 7906.9 8038.4 8039.3 8041.5 4550.7 4660.3 4709.5 4716.5 4721.9 2715.3 2834.1 2912.2 2913.3 2937.7 884.4 914.7 936.9 937.3 939.8 10628.8 10629.6 10666.6 10677.0 10678.1 3811.2 4091.9 4299.9 4301.7 4308.7 9202.9 9206.9 9221.7 9222.2 9224.6 4752.6 4752.7 4756.5 4757.1 4760.4 4250.3 4285.7 4293.1 4343.6 4351.9 3593.6 3656.4 3714.7 3745.9 3750.0 1077.6 1152.6 1179.9 1185.7 1221.3 654.4 747.2 763.0 777.3 778.7 4800.6 4842.4 4889.9 4996.7 5005.0 815.9 847.6 861.7 873.2 882.7 3566.2 3621.4 3630.6 3657.6 3720.5 9300.3 9405.6 9634.1 9674.7 9689.3 8090.0 9614.3 9620.4 9623.1 9627.5 6925.2 7194.9 7243.9 7379.9 7396.1 5294.4 5322.5 5374.9 5393.4 5595.6 8895.9 9067.9 9069.1 9148.6 9156.9 8669.2 8879.4 8909.2 9066.7 9124.6 6411.3 6616.1 6619.7 6623.3 6623.7 7036.9 7151.8 7215.9 7220.2 7220.4 6396.2 6406.9 6432.2 6469.3 6554.0 6421.9 6426.0 6520.2 6616.4 6626.3 6334.7 6345.7 6355.4 6396.2 6404.5 4394.5 4407.2 4488.5 4501.8 4670.1 4344.3 4368.5 4393.7 4429.4 4591.0 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | [#4] prototype.html Cycles:180 Average:4216.06 Median:4852.76 stddev:1234.26 (25.4%) stddev-sans-first:1202.17 12:08:54 INFO - PROCESS | 4828 | Values: 297.1 299.2 300.7 303.9 306.1 4839.9 4852.0 4853.5 4876.3 4882.0 4793.2 4798.7 4830.4 4866.6 4873.1 3571.6 3666.6 3668.7 3679.7 3690.5 3655.2 3787.8 3790.3 3851.7 3852.3 3768.3 3769.3 3774.7 3788.3 3807.2 3564.2 3721.7 3780.5 3788.5 3810.5 3277.6 3284.4 3285.4 3293.9 3296.9 4673.9 4682.5 4700.0 4705.9 4722.5 4255.4 4288.2 4288.8 4291.6 4292.5 4924.6 5016.9 5054.4 5069.8 5078.2 3592.0 3595.7 3602.4 3602.4 3606.6 5273.5 5298.7 5314.4 5340.5 5353.4 3443.3 3653.7 3668.1 3675.1 3704.8 3714.2 3732.6 3733.7 3763.6 3765.5 4298.0 4298.5 4303.0 4317.3 4322.7 4936.5 5166.2 5167.0 5172.8 5186.7 1276.6 1297.6 1298.4 1298.4 1299.3 800.8 814.1 824.5 826.7 826.8 4251.9 4314.7 4429.5 4491.9 4499.9 5227.3 5273.8 5285.4 5285.9 5288.3 4484.8 4497.7 4498.7 4509.8 4511.3 2646.5 2758.6 2778.7 2807.7 2811.2 4888.4 4906.4 4914.5 4919.1 4921.4 5098.8 5319.3 5362.8 5390.4 5412.5 4874.4 4875.2 4885.7 4892.6 4917.2 5184.6 5190.9 5209.6 5219.7 5227.7 4851.9 5099.2 5147.2 5154.5 5163.3 4874.4 4909.8 4973.0 4973.4 4980.8 3817.5 3849.0 3849.1 3862.6 3867.3 5059.3 5280.6 5285.4 5314.3 5319.6 5079.1 5100.0 5107.6 5113.5 5114.2 5115.0 5115.8 5119.2 5121.2 5125.3 4971.4 4998.3 5046.6 5051.2 5052.7 4923.6 4951.4 5128.8 5143.4 5145.0 4994.3 5003.5 5013.0 5020.2 5028.6 12:08:54 INFO - PROCESS | 4828 | 12:08:54 INFO - PROCESS | 4828 | [#5] yui.html Cycles:180 Average:18214.77 Median:563.31 stddev:27488.86 (4879.9%) stddev-sans-first:27534.26 12:08:54 INFO - PROCESS | 4828 | Values: 628.0 645.9 691.8 712.7 732.6 12891.9 13863.4 13944.7 14033.6 14203.3 12428.8 12670.8 12673.0 12676.9 12696.4 585.7 710.2 714.2 716.8 730.5 729.4 731.5 731.6 731.6 732.1 770.8 771.1 771.2 771.4 771.7 611.6 614.0 617.1 630.7 768.4 546.5 547.9 555.5 563.1 563.5 12936.9 12945.6 12998.2 12999.0 12999.7 12037.5 12339.9 12346.2 12575.7 12756.3 8841.7 9011.9 9048.6 9117.5 11363.1 3768.5 3778.7 3859.0 3972.5 3995.8 60324.0 60805.7 61223.7 62101.4 63475.7 9651.5 9766.9 9769.9 9799.7 10216.0 17730.2 17776.9 17779.7 17830.1 17848.5 6681.4 6750.9 6775.3 6781.8 6803.1 3664.7 3746.4 3764.3 3792.5 3820.3 2702.5 2780.8 2810.4 2812.2 2812.8 469.6 478.9 481.5 489.6 490.5 447.6 518.4 542.3 543.8 559.2 7347.3 7551.3 7574.8 7731.2 7740.8 487.2 498.2 500.3 504.5 513.1 3401.7 3458.2 3505.7 3558.2 3645.0 104780.5 105115.5 105346.5 106905.0 110057.4 85441.0 90346.0 91636.6 91792.0 92700.5 79065.6 79821.0 82464.0 82878.0 83758.0 6610.9 6693.1 6757.9 6785.5 6909.1 46314.6 47222.3 47712.8 48010.8 49542.0 67155.3 67234.7 68417.0 68713.3 69783.3 8793.0 8941.2 9119.4 9125.7 9284.0 10373.8 10474.6 10483.3 10547.1 10578.8 8842.2 9469.4 9914.6 9919.6 10624.9 11065.9 11710.1 11765.4 12551.4 12565.4 9674.3 10061.6 10078.1 10309.6 10717.1 9008.0 9383.7 9475.0 9654.6 9665.1 9027.9 9127.9 9161.4 9606.9 9775.6 12:08:54 INFO - PROCESS | 4828 | -------- Summary: end -------- 12:08:54 INFO - PROCESS | 4828 | 12:08:55 INFO - TEST-INFO | 4828: exit 0 12:08:55 INFO - TEST-OK | dromaeo_css | took 1122287ms 12:08:55 INFO - TEST-START | kraken 12:08:55 INFO - operating with platform_type : linux_ 12:08:55 INFO - Initialising browser for kraken test... 12:08:55 INFO - TEST-INFO | started process 5131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_UAjJB/profile http://localhost:41800/getInfo.html) 12:09:00 INFO - PROCESS | 5131 | __metrics Screen width/height:1600/1200 12:09:00 INFO - PROCESS | 5131 | colorDepth:24 12:09:00 INFO - PROCESS | 5131 | Browser inner width/height: 1024/697 12:09:00 INFO - PROCESS | 5131 | __metrics 12:09:01 INFO - PROCESS | 5131 | 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" 12:09:01 INFO - PROCESS | 5131 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:01 INFO - PROCESS | 5131 | console.error: PushService: 12:09:01 INFO - PROCESS | 5131 | stateChangeProcessEnqueue: Error transitioning state 12:09:01 INFO - PROCESS | 5131 | UnknownError 12:09:02 INFO - TEST-INFO | 5131: exit 0 12:09:02 INFO - Browser initialized. 12:09:02 INFO - Running cycle 1/1 for kraken test... 12:09:02 INFO - TEST-INFO | started process 5215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_UAjJB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:14 INFO - PROCESS | 5215 | RSS: Main: 180355072 12:09:14 INFO - PROCESS | 5215 | 12:09:17 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41800/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:18 INFO - PROCESS | 5215 | RSS: Main: 235175936 12:09:18 INFO - PROCESS | 5215 | 12:09:21 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41800/tests/kraken/driver.html?testName=audio-dft) 12:09:21 INFO - PROCESS | 5215 | RSS: Main: 224378880 12:09:21 INFO - PROCESS | 5215 | 12:09:25 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41800/tests/kraken/driver.html?testName=audio-fft) 12:09:25 INFO - PROCESS | 5215 | RSS: Main: 302542848 12:09:25 INFO - PROCESS | 5215 | 12:09:28 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41800/tests/kraken/driver.html?testName=audio-oscillator) 12:09:28 INFO - PROCESS | 5215 | RSS: Main: 212455424 12:09:28 INFO - PROCESS | 5215 | 12:09:30 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:31 INFO - PROCESS | 5215 | RSS: Main: 215916544 12:09:31 INFO - PROCESS | 5215 | 12:09:34 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41800/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:35 INFO - PROCESS | 5215 | RSS: Main: 253280256 12:09:35 INFO - PROCESS | 5215 | 12:09:38 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41800/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:39 INFO - PROCESS | 5215 | RSS: Main: 247369728 12:09:39 INFO - PROCESS | 5215 | 12:09:42 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41800/tests/kraken/driver.html?testName=json-parse-financial) 12:09:42 INFO - PROCESS | 5215 | RSS: Main: 250191872 12:09:42 INFO - PROCESS | 5215 | 12:09:44 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:45 INFO - PROCESS | 5215 | RSS: Main: 214282240 12:09:45 INFO - PROCESS | 5215 | 12:09:47 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:47 INFO - PROCESS | 5215 | RSS: Main: 221974528 12:09:47 INFO - PROCESS | 5215 | 12:09:50 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:50 INFO - PROCESS | 5215 | RSS: Main: 222715904 12:09:50 INFO - PROCESS | 5215 | 12:09:53 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:54 INFO - PROCESS | 5215 | RSS: Main: 223817728 12:09:54 INFO - PROCESS | 5215 | 12:09:57 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:57 INFO - PROCESS | 5215 | RSS: Main: 221728768 12:09:57 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | Cycle 1(1): loaded http://localhost:41800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41800/tests/kraken/driver.html?testName=ai-astar) 12:09:59 INFO - PROCESS | 5215 | RSS: Main: 272588800 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | __start_tp_report 12:09:59 INFO - PROCESS | 5215 | _x_x_mozilla_page_load 12:09:59 INFO - PROCESS | 5215 | _x_x_mozilla_page_load_details 12:09:59 INFO - PROCESS | 5215 | |i|pagename|runs| 12:09:59 INFO - PROCESS | 5215 | |0;ai-astar;115;114;120;115;114;116;114;116;114;129 12:09:59 INFO - PROCESS | 5215 | |1;audio-beat-detection;163;126;153;194;123;154;152;125;191;129 12:09:59 INFO - PROCESS | 5215 | |2;audio-dft;162;162;162;161;160;161;161;160;161;160 12:09:59 INFO - PROCESS | 5215 | |3;audio-fft;75;75;76;162;76;77;76;76;158;77 12:09:59 INFO - PROCESS | 5215 | |4;audio-oscillator;84;85;164;83;84;83;152;84;84;143 12:09:59 INFO - PROCESS | 5215 | |5;imaging-gaussian-blur;117;118;116;117;116;117;117;117;117;117 12:09:59 INFO - PROCESS | 5215 | |6;imaging-darkroom;146;146;147;147;146;148;147;146;146;146 12:09:59 INFO - PROCESS | 5215 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;94 12:09:59 INFO - PROCESS | 5215 | |8;json-parse-financial;66;66;66;66;67;66;67;66;67;66 12:09:59 INFO - PROCESS | 5215 | |9;json-stringify-tinderbox;69;69;68;68;68;69;69;70;69;69 12:09:59 INFO - PROCESS | 5215 | |10;stanford-crypto-aes;84;83;83;83;82;82;85;82;82;82 12:09:59 INFO - PROCESS | 5215 | |11;stanford-crypto-ccm;151;138;130;133;132;133;136;134;188;140 12:09:59 INFO - PROCESS | 5215 | |12;stanford-crypto-pbkdf2;178;177;173;179;175;176;175;175;175;183 12:09:59 INFO - PROCESS | 5215 | |13;stanford-crypto-sha256-iterative;79;71;70;70;70;70;69;69;69;68 12:09:59 INFO - PROCESS | 5215 | __end_tp_report 12:09:59 INFO - PROCESS | 5215 | __start_cc_report 12:09:59 INFO - PROCESS | 5215 | _x_x_mozilla_cycle_collect,1964 12:09:59 INFO - PROCESS | 5215 | __end_cc_report 12:09:59 INFO - PROCESS | 5215 | __startTimestamp1472756999865__endTimestamp 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | ------- Summary: start ------- 12:09:59 INFO - PROCESS | 5215 | Number of tests: 14 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#0] ai-astar Cycles:10 Average:116.70 Median:115.50 stddev:4.69 (4.1%) stddev-sans-first:4.94 12:09:59 INFO - PROCESS | 5215 | Values: 115.0 114.0 120.0 115.0 114.0 116.0 114.0 116.0 114.0 129.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:153.50 stddev:26.20 (17.1%) stddev-sans-first:27.42 12:09:59 INFO - PROCESS | 5215 | Values: 163.0 126.0 153.0 194.0 123.0 154.0 152.0 125.0 191.0 129.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 12:09:59 INFO - PROCESS | 5215 | Values: 162.0 162.0 162.0 161.0 160.0 161.0 161.0 160.0 161.0 160.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:35.44 (46.6%) stddev-sans-first:37.00 12:09:59 INFO - PROCESS | 5215 | Values: 75.0 75.0 76.0 162.0 76.0 77.0 76.0 76.0 158.0 77.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:84.00 stddev:33.77 (40.2%) stddev-sans-first:34.99 12:09:59 INFO - PROCESS | 5215 | Values: 84.0 85.0 164.0 83.0 84.0 83.0 152.0 84.0 84.0 143.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:09:59 INFO - PROCESS | 5215 | Values: 117.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 12:09:59 INFO - PROCESS | 5215 | Values: 146.0 146.0 147.0 147.0 146.0 148.0 147.0 146.0 146.0 146.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:09:59 INFO - PROCESS | 5215 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 12:09:59 INFO - PROCESS | 5215 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 67.0 66.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 12:09:59 INFO - PROCESS | 5215 | Values: 69.0 69.0 68.0 68.0 68.0 69.0 69.0 70.0 69.0 69.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 12:09:59 INFO - PROCESS | 5215 | Values: 84.0 83.0 83.0 83.0 82.0 82.0 85.0 82.0 82.0 82.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:137.00 stddev:17.39 (12.7%) stddev-sans-first:18.10 12:09:59 INFO - PROCESS | 5215 | Values: 151.0 138.0 130.0 133.0 132.0 133.0 136.0 134.0 188.0 140.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:176.50 stddev:2.84 (1.6%) stddev-sans-first:2.96 12:09:59 INFO - PROCESS | 5215 | Values: 178.0 177.0 173.0 179.0 175.0 176.0 175.0 175.0 175.0 183.0 12:09:59 INFO - PROCESS | 5215 | 12:09:59 INFO - PROCESS | 5215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:3.10 (4.4%) stddev-sans-first:0.88 12:09:59 INFO - PROCESS | 5215 | Values: 79.0 71.0 70.0 70.0 70.0 70.0 69.0 69.0 69.0 68.0 12:09:59 INFO - PROCESS | 5215 | -------- Summary: end -------- 12:09:59 INFO - PROCESS | 5215 | 12:10:01 INFO - TEST-INFO | 5215: exit 0 12:10:01 INFO - TEST-OK | kraken | took 65206ms 12:10:01 INFO - SUITE-END | took 1187s 12:10:01 INFO - Completed test suite (00:19:47) 12:10:01 INFO - javascript benchmark 12:10:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.776808971237, 2629.500394924964, 2648.801339899508, 2680.798940079493, 2690.408110215752, 4706.082313948781, 4793.304970779235, 4793.400824896888, 4856.295837103622, 4910.7299098549565, 4775.14047471455, 4790.97604511977, 4811.3264143019915, 4839.516048395159, 4880.560749532541, 4321.58944900234, 4347.7173983690955, 4422.71252368595, 4481.7983190756495, 4583.495815460314, 4499.167653984007, 4516.187086324477, 4535.115652447774, 4558.72647641141, 4568.406107206059, 4352.825886964518, 4378.824847006116, 4395.3846461495095, 4402.911941761179, 4413.602775750198, 4393.033532622818, 4397.824087036514, 4399.73601583906, 4430.136123455927, 4485.753283569403, 4421.07157496926, 4424.380586717862, 4427.778611069466, 4464.8883777905485, 4480.93278600818, 4671.369365135731, 4741.217699079648, 4778.904421911542, 4825.083234185528, 4831.855044348676, 5115.18157094863, 5123.820666276662, 5124.948750512522, 5126.359205099363, 5193.272941788153, 5149.098907691139, 5157.948420515784, 5171.2501687255135, 5174.61190410717, 5177.352830896138, 4675.883102922386, 4702.882427939329, 4717.386739723814, 4816.109019831342, 4816.61467082629, 5124.692518448905, 5145.614078944094, 5153.484651534816, 5199.428062913152, 5210.062188806051, 4932.950670493321, 4937.629677774109, 4943.975280123576, 4944.332515110486, 5001.149804533238, 5023.397192336943, 5026.346574945233, 5048.545630893163, 5084.8220312288895, 5110.8466745997675, 5083.415407228142, 5089.51649593288, 5096.184610462308, 5139.563137133386, 5144.511271429208, 5069.264956581275, 5089.262057001714, 5091.032703786343, 5098.898022039539, 5143.12566863634, 4342.32693932441, 4380.78096095194, 4381.539938306496, 4390.100029493946, 4438.822447102079, 3831.9042023949623, 3839.404892241707, 3888.7861167635488, 3914.0, 3930.469386632768, 4389.934150987738, 4399.560043995575, 4403.383526306319, 4407.42703448556, 4456.598906098467, 4985.626078044161, 5051.520105589963, 5190.6107041972, 5201.2198170274005, 5206.7917283309, 4350.0, 4361.847335343247, 4370.2352088384405, 4419.756913369732, 4425.955740442619, 4647.9767601161775, 4649.395578574764, 4655.906881862344, 4698.036902434993, 4705.411823522059, 4661.137689527312, 4803.519648035169, 4806.206975848946, 4815.518448155157, 4818.518148185153, 5136.383633963948, 5223.033738758342, 5252.5535329497425, 5253.868653283698, 5264.368275806928, 4840.394950631171, 4846.951530484791, 4856.611471082376, 4856.975715121402, 4916.410030796184, 5103.617228707788, 5106.66806657566, 5106.719130447861, 5112.923306150485, 5156.535911767809, 5057.8735531612, 5114.820981265638, 5134.614903882149, 5169.147090730138, 5210.47895210476, 5022.723750193774, 5025.045241404122, 5027.0, 5028.547430731252, 5087.771050302671, 4982.327385802871, 5029.1953287473825, 5039.244113383022, 5043.445221025758, 5045.4450010498085, 4851.442084160226, 4963.379577552806, 4991.750412479434, 5019.146745053423, 5082.1106306395495, 5055.849500293939, 5116.488351164854, 5136.229565565195, 5137.563307118937, 5137.845864624067, 4823.5658790709, 4872.731999739906, 5029.64792464524, 5034.647574669738, 5044.495550444926], "value": 4720.575293357893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.1409857017331, 570.0252568108534, 577.7313549199619, 580.5065694159962, 581.7847396463309, 27293.181204563843, 37597.81201093994, 38422.615773842255, 38849.22301553974, 42838.785806070926, 40125.0, 40342.0, 40535.0, 40614.0, 40705.59294407055, 7016.158061032683, 7670.96164519178, 7819.569923654197, 7822.295993360596, 7822.452428330019, 7027.578345299273, 7206.8558628827395, 7210.567365958033, 9694.079062489052, 9961.203103751719, 10059.949700251489, 10124.848127278097, 10127.6961691149, 10130.392176469435, 10136.645217417392, 10002.149817265505, 10003.39979601219, 10010.54952527138, 10014.79970400588, 10020.749481262954, 9755.463449510275, 9817.705468835946, 9818.214542836557, 9821.754456138653, 9836.606535738561, 36963.63036369629, 37277.627223727686, 37412.43881341782, 37422.43866342007, 37432.43851342232, 2891.2193707698802, 2940.7059294070423, 3020.5318175682805, 3132.5144602586633, 3513.2095278562374, 28305.292367690767, 28487.57268640972, 28536.714632853822, 28721.56917646237, 30066.098017059525, 3490.3019396120876, 3500.8949731508096, 3505.2814173094453, 3597.3524765542193, 3632.4369722693023, 243973.0, 245804.0, 246159.0, 246816.0, 247046.0, 50443.24335134976, 51175.48824511782, 51212.0, 51242.74378628158, 51252.48747512477, 31765.841170794, 32438.513422298685, 32643.347133057207, 34158.82920585381, 52762.20856687153, 14759.92620036893, 14886.478973235884, 14912.179830109448, 14919.328630211667, 14920.253987300592, 10747.40889251083, 10866.511007004703, 10876.564937402574, 10890.61882834097, 10892.945535272273, 15037.548873533811, 15200.163990980602, 15225.238738063052, 16007.679846403007, 17099.829001709822, 6504.1869766279215, 6564.835879102965, 6857.451403887677, 6886.8622627547165, 6947.756828510978, 735.3418690272176, 842.5660784695887, 855.6320782063648, 943.5942544705842, 954.0936110694868, 24977.62533561998, 27807.443851122865, 28310.43379132406, 28312.71687283142, 28336.574951375747, 827.4662842466576, 914.0311270053764, 927.1053433436766, 943.1417410156724, 956.2875657635107, 14427.3507692152, 14677.706445871236, 14825.110493370217, 15114.168720720467, 15191.0, 384230.10389273043, 497826.0, 505067.0, 506529.0, 506743.0, 50453.74773126111, 50983.235251471255, 51027.48972510302, 51067.23399149016, 51069.91440684736, 1154.2497376705041, 1158.9594364197212, 1184.0, 1188.6671731915078, 1193.3734789235548, 27210.591841122794, 28265.293367665974, 29035.41929161447, 29367.706322936498, 29535.55696664595, 41980.58019419767, 42676.573234267256, 42704.14591708086, 42705.359419609355, 42723.3591496134, 286362.0, 287204.0, 287206.0, 287759.0, 287883.0, 22121.55756884821, 23936.40158996039, 24835.379115521533, 25196.748032520172, 25673.229803105936, 39878.0, 39967.80016099901, 40689.79655101824, 41216.175676485705, 41265.1746965065, 33600.831995839864, 33686.0, 34153.316933661685, 34169.829150854086, 34449.0, 33606.32787344191, 33948.66051339455, 34158.487622686174, 34184.0, 34274.82862585671, 33114.5032824503, 33262.66737332596, 33548.161295967795, 33644.49533257052, 34443.0, 29185.708142918298, 30946.0, 31335.529967050057, 31376.843115784275, 31553.0, 24081.0, 24362.390940225927, 24542.386440339134, 24851.13021044255, 24958.0016799326], "value": 17423.446302325992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1260748987452, 364.9087728067982, 365.4408754605453, 378.3228021840905, 381.429762505055, 15317.540473785777, 16144.596385090379, 16918.238679259433, 16994.83005169948, 17002.40491582795, 16038.59903502413, 16558.66882662346, 17138.400155994543, 17253.30986760528, 17286.827131728678, 4850.757462126889, 5089.84730458085, 5091.414487333948, 5105.055564720538, 5107.336046313974, 3611.693006094485, 3754.7796965986026, 5058.949410505885, 5599.1041433370665, 5868.295804503466, 5932.940670593303, 5934.31755348134, 5937.435943585374, 5942.6137301075505, 5944.97027514864, 5711.143328500737, 5846.736896839631, 5869.295684517842, 5870.882582348372, 5881.323647780496, 5009.448960614366, 5144.125498665198, 5146.871328216825, 5151.356080489939, 5158.845234642967, 19280.22879084835, 19758.506037349038, 20457.18171273147, 20788.0, 20802.16791328345, 1910.579672472054, 1922.9134688939032, 1924.9711254331196, 1935.6709359408935, 1957.2268953763185, 12760.36198190096, 13428.462861485528, 13727.862721372758, 14094.718105637932, 14115.505957291445, 1680.3446655804246, 1735.6788994036144, 1737.409280844519, 1751.1106673988022, 1757.2092558348795, 68698.3130168697, 71664.6416767918, 71745.9238111434, 72027.0, 72834.0, 9319.673811416567, 9464.2553659438, 9698.46658433793, 9699.951500242594, 10059.446730429896, 13325.333733313295, 13363.665908352368, 13373.264470454023, 13375.933120334335, 13389.66525836862, 6979.092717946634, 7178.318059784312, 7207.675654595451, 7590.316871481593, 7634.312911837961, 6782.321767823179, 6846.931530684629, 6899.413549848218, 7146.499745017799, 7382.114146302478, 6086.0, 6086.756529738849, 6091.360407157274, 6125.356837531995, 6172.9074063889075, 1611.5084899105884, 1658.6019355354629, 1687.6287216812282, 1730.6279149982813, 1763.3563749231694, 834.1866679986964, 867.0505796153202, 878.4070752242211, 888.6623083228332, 897.2328658996595, 16485.91757041207, 16956.541301511214, 17670.91164544195, 17677.0, 18090.819091808913, 846.2398211719609, 865.4893612768496, 868.0538213347355, 876.0232340939933, 893.6790617364983, 9843.60625574969, 10033.698989030196, 10163.441010744333, 10225.539850706737, 10234.846477302846, 386825.0, 392204.0, 392789.0, 395203.0, 396828.0, 68741.65629171922, 68862.31137688558, 70482.64758676276, 70578.0, 70799.64600177068, 913.7350168451075, 914.6615752171739, 924.4360939826701, 940.0693313619468, 943.3867985809279, 15172.468963586221, 15277.465288715286, 15548.84451155474, 16248.187590620659, 16265.186740663155, 33815.154621134665, 34021.91736991577, 34264.65735342615, 34422.0, 35367.0, 43324.0, 46685.766571168286, 46869.06261874675, 49208.2618760726, 55015.17477237764, 6613.66931653425, 6859.211190713132, 6860.5540639858245, 6916.619585922823, 7070.646467676493, 9065.365424420228, 11231.326120432801, 11790.646280611596, 11953.880461195624, 12634.115611907078, 10023.348482348623, 10257.897421025695, 10432.165426765992, 10735.355878647306, 10785.568577256821, 10321.035073304363, 10354.637587684394, 10421.895781042396, 10440.0, 10733.409662468326, 10053.161474265642, 10284.125849302893, 11118.555257789598, 11386.146039046938, 11430.714232144262, 7638.579878106758, 7770.961145194238, 7812.257835505618, 7826.921730782619, 7898.960505197667, 10561.0, 10708.946455267675, 10765.138788897026, 10901.34591924487, 10963.725906852074], "value": 8325.319283427685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.5010621017118, 1372.1835507872815, 1383.1631862723052, 1572.567543925421, 1593.6095656564137, 6786.762463313785, 7382.741604043859, 7407.407407407408, 8009.519428834274, 8010.799730006753, 7469.887951680729, 7799.337056350217, 7801.336886364666, 7805.219478052192, 7806.375489960804, 2184.759676435595, 2214.457457922811, 2220.7224096987875, 2224.4327696437385, 2227.20934068405, 1833.4041436533114, 2115.344243284579, 2139.0481235849975, 2152.0961196297594, 2152.7309086364203, 2142.603618330606, 2160.12514931453, 2167.815735662463, 2173.0438607012943, 2178.749443813958, 2116.4391436269325, 2151.580441813847, 2164.101897712447, 2174.6520556711007, 2174.934751957444, 2116.0795054151495, 2129.4569884679463, 2141.5288636499945, 2143.024923659731, 2146.7853214678407, 7888.816677498421, 7906.881396779053, 8038.356931445471, 8039.31665808407, 8041.477303975223, 4550.749708766017, 4660.347551342815, 4709.458412282597, 4716.457607375161, 4721.881952951169, 2715.266877942964, 2834.078924349574, 2912.155474912273, 2913.3444974880695, 2937.7062293770664, 884.3986089459165, 914.6981496106268, 936.8688383626297, 937.2642475656577, 939.8261321655448, 10628.840567391419, 10629.627963021258, 10666.573337066586, 10677.039066484054, 10678.145748340192, 3811.1805961718364, 4091.938620920629, 4299.935500967488, 4301.741895486281, 4308.67684923632, 9202.90797092034, 9206.941201761749, 9221.723348299427, 9222.170004699608, 9224.584893679801, 4752.596029337545, 4752.667313288037, 4756.476787553366, 4757.119932812441, 4760.404949381327, 4250.3199488081755, 4285.657147428198, 4293.055527783882, 4343.609075183185, 4351.891202719894, 3593.568771747407, 3656.3601369760186, 3714.7213958953184, 3745.9063523411587, 3750.0, 1077.6012875236213, 1152.6311580294225, 1179.9469023893946, 1185.733210027737, 1221.2794451273614, 654.4371840217409, 747.2340850628041, 762.9732959346396, 777.2616014785863, 778.7391223939931, 4800.615950723934, 4842.370491836039, 4889.853304400874, 4996.675216110941, 5004.974975125101, 815.9469634473859, 847.631280393031, 861.7113267055606, 873.24028095556, 882.6601758323092, 3566.233259849145, 3621.3843646580144, 3630.582483014487, 3657.5976642569294, 3720.4605332227216, 9300.348975571645, 9405.623775049058, 9634.084761947604, 9674.661386851427, 9689.321747477608, 8089.959550202211, 9614.278929080347, 9620.37467564606, 9623.133917947418, 9627.518624068909, 6925.203601585781, 7194.856102877913, 7243.89134162988, 7379.852402952019, 7396.112466504054, 5294.391145018218, 5322.54758345545, 5374.892502150014, 5393.352797664305, 5595.63628364155, 8895.911040889509, 9067.863982040142, 9069.138431848964, 9148.634054638007, 9156.908430915606, 8669.21977022071, 8879.378443508893, 8909.198172164277, 9066.682666106655, 9124.589393477178, 6411.294757576756, 6616.139901812733, 6619.74224897268, 6623.277947733528, 6623.735050598115, 7036.9296307036275, 7151.82120446993, 7215.891761623685, 7220.241874603301, 7220.38626716735, 6396.168498095218, 6406.87186256263, 6432.163818703726, 6469.256035555972, 6553.967230163818, 6421.935780642134, 6425.967870160619, 6520.217573891164, 6616.371444712745, 6626.271110177973, 6334.683265836782, 6345.7144428499905, 6355.428011478989, 6396.200474940632, 6404.4876409886165, 4394.494633117232, 4407.162639098561, 4488.48382436011, 4501.819927202875, 4670.065986802721, 4344.304911214191, 4368.497622773421, 4393.7363758174615, 4429.357743127293, 4590.977045114753], "value": 4095.384567373093, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.06720896385355, 299.239930576336, 300.6752707076357, 303.93161538653794, 306.1382209081437, 4839.903201935959, 4851.975740121295, 4853.538913803183, 4876.268559716044, 4881.975590122049, 4793.185158523051, 4798.664093513456, 4830.44449888263, 4866.562009419152, 4873.1471992401275, 3571.607123216444, 3666.6333366663252, 3668.679844740514, 3679.68722658573, 3690.520232369788, 3655.1958569114754, 3787.829547670348, 3790.3177428062936, 3851.7496362736333, 3852.306584814732, 3768.2651882882847, 3769.302679004379, 3774.7168962327796, 3788.299164654534, 3807.1814559869763, 3564.1802385451233, 3721.7208709346905, 3780.4707340972286, 3788.507494025759, 3810.485584446106, 3277.5575297334794, 3284.4252255855367, 3285.4414749492403, 3293.8682452701864, 3296.8516416761304, 4673.929891051637, 4682.508336624639, 4700.012997270577, 4705.882352941169, 4722.504137065627, 4255.425517555122, 4288.16380805743, 4288.849890253858, 4291.613754762056, 4292.463442069741, 4924.60603151747, 5016.924746128811, 5054.418741844698, 5069.822556210552, 5078.162103252959, 3592.0, 3595.7482976191677, 3602.35157671619, 3602.369585322558, 3606.6393360663988, 5273.525382715574, 5298.682079075268, 5314.441983591706, 5340.465953404629, 5353.384360798558, 3443.345764304774, 3653.6711695947492, 3668.1013151777984, 3675.088953744038, 3704.759190652599, 3714.220013797079, 3732.626737326246, 3733.7305316192624, 3763.6048214937587, 3765.5104836371643, 4297.978510107429, 4298.527162012176, 4302.967287850894, 4317.287647538121, 4322.7190232634775, 4936.47042364711, 5166.225066240019, 5166.992436474927, 5172.844814655567, 5186.714730689849, 1276.6425400887767, 1297.6107167849607, 1298.3638017371609, 1298.4222021200665, 1299.2529295655036, 800.7757827808223, 814.1492140712969, 824.4640983360863, 826.7313123234852, 826.8304997475624, 4251.893702657397, 4314.71954322968, 4429.49060857999, 4491.910161796745, 4499.887502812456, 5227.26818245446, 5273.841784746463, 5285.365756109291, 5285.920711189336, 5288.312519372457, 4484.775761211927, 4497.707649002804, 4498.730076195438, 4509.827444864359, 4511.300748384006, 2646.465050270838, 2758.6275852759622, 2778.6804517480346, 2807.7332653397893, 2811.1566530040905, 4888.364512613338, 4906.435759887588, 4914.508549145128, 4919.06537757832, 4921.360223170965, 5098.770555324945, 5319.255304257407, 5362.785488580413, 5390.353157621111, 5412.458754124635, 4874.439439464436, 4875.195592727231, 4885.682430641997, 4892.584130348889, 4917.188663870493, 5184.585233181412, 5190.870228244324, 5209.583233341399, 5219.660722053054, 5227.712475813714, 4851.878703032311, 5099.209622508517, 5147.150720131136, 5154.53609175176, 5163.328767260232, 4874.439439464507, 4909.828156014522, 4972.975135124301, 4973.358791598692, 4980.825671101494, 3817.541894972621, 3849.0, 3849.1147036182397, 3862.643787289695, 3867.3425517661503, 5059.316992206005, 5280.603954703336, 5285.392179899361, 5314.335708036496, 5319.606177220344, 5079.136546786981, 5099.974500127476, 5107.642465027412, 5113.488651135006, 5114.207297868837, 5115.0, 5115.846524604268, 5119.232115182753, 5121.1550094234035, 5125.282460455614, 4971.4051879872195, 4998.275250088789, 5046.646734728533, 5051.247070346743, 5052.722100284373, 4923.5814955729165, 4951.430585482715, 5128.8461346159675, 5143.3570803649545, 5144.9742751286, 4994.326900488377, 5003.474635163256, 5013.0, 5020.15554989437, 5028.64799464034], "value": 3820.9206312827478, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.9560430769845, 645.9031145328203, 691.7993781803274, 712.6971037309144, 732.6226993098555, 12891.871081289184, 13863.376148073336, 13944.651383715413, 14033.578992630211, 14203.289835508222, 12428.813567796491, 12670.80993785094, 12673.0, 12676.873231267684, 12696.428660710268, 585.70421936922, 710.1584622222682, 714.1822613107988, 716.8028792082193, 730.4667592657363, 729.3690957321905, 731.5208538407352, 731.5574077683005, 731.6049333359979, 732.1068296678044, 770.8304173081913, 771.090113665874, 771.1671394893501, 771.3713323641242, 771.699037375424, 611.5535658968934, 613.9570230083896, 617.1051974636749, 630.7161777200232, 768.4083255892959, 546.4508169289838, 547.8958997790407, 555.5111501878321, 563.0990415335472, 563.5125616341876, 12936.870631293756, 12945.611631651065, 12998.155119917175, 12999.0, 12999.740005199938, 12037.518499260019, 12339.853337398996, 12346.197497162655, 12575.685607859785, 12756.30294095598, 8841.681930397344, 9011.864822027675, 9048.638054477813, 9117.452952822852, 11363.090952723762, 3768.5477742670782, 3778.6599206071587, 3859.0, 3972.503437070366, 3995.800209989489, 60324.0, 60805.69597151986, 61223.69388153075, 62101.37898621001, 63475.68262158706, 9651.517424128766, 9766.902330976742, 9769.90230097704, 9799.706008819747, 10216.029477199654, 17730.20214090369, 17776.9111154446, 17779.73330400045, 17830.10849457522, 17848.46454606364, 6681.365270299314, 6750.8649827004165, 6775.288594697486, 6781.830454238585, 6803.081583986099, 3664.706823454117, 3746.4380342948775, 3764.3036038333, 3792.5069740934055, 3820.331441997695, 2702.4730177615174, 2780.7636350909993, 2810.3817160224717, 2812.1844665046906, 2812.7890408219464, 469.6078774223493, 478.909007288614, 481.4559547711064, 489.6107594462411, 490.5315423770291, 447.5993985383064, 518.362414230491, 542.2977244468423, 543.7661805423705, 559.1696330948538, 7347.26527347261, 7551.320381165721, 7574.848503029909, 7731.183171954586, 7740.806479838049, 487.22044728434224, 498.185466761847, 500.30207860035046, 504.47534564053706, 513.1091926251775, 3401.693847553732, 3458.239187378773, 3505.737069719781, 3558.1638314995957, 3644.9635503645154, 104780.47609761903, 105115.47442262739, 105346.4732676347, 106905.0, 110057.44971275092, 85441.0, 90346.0, 91636.63265867294, 91792.0, 92700.53649731843, 79065.60467197627, 79821.0, 82464.0, 82878.0, 83758.0, 6610.867782644416, 6693.068320506076, 6757.93242067573, 6785.457163427012, 6909.1018167639895, 46314.58966565334, 47222.29166562573, 47712.761436192595, 48010.75994620004, 49542.0, 67155.3284467149, 67234.66382668055, 68417.0, 68713.2573485315, 69783.30216697768, 8793.0, 8941.195292423454, 9119.407238529475, 9125.680601178927, 9284.0, 10373.831309183313, 10474.581016759244, 10483.26251836549, 10547.05076543084, 10578.8413173804, 8842.24840888506, 9469.431834089977, 9914.553845076845, 9919.603215871284, 10624.946875265574, 11065.944670276596, 11710.1217408693, 11765.352905590275, 12551.435185416862, 12565.434555444845, 9674.275200159022, 10061.647842325483, 10078.092971632588, 10309.587616495257, 10717.14262858985, 9007.954960225157, 9383.718488445358, 9474.95262523683, 9654.565544550653, 9665.130138287588, 9027.909720902708, 9127.863082053642, 9161.35870489086, 9606.855897161688, 9775.560099795384], "value": 6245.829004284849, "unit": "score"}], "name": "dromaeo_css", "value": 6371.944870876186, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 120.0, 115.0, 114.0, 116.0, 114.0, 116.0, 114.0, 129.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 153.0, 194.0, 123.0, 154.0, 152.0, 125.0, 191.0, 129.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 162.0, 76.0, 77.0, 76.0, 76.0, 158.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 164.0, 83.0, 84.0, 83.0, 152.0, 84.0, 84.0, 143.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 70.0, 69.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 82.0, 82.0, 85.0, 82.0, 82.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 130.0, 133.0, 132.0, 133.0, 136.0, 134.0, 188.0, 140.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 173.0, 179.0, 175.0, 176.0, 175.0, 175.0, 175.0, 183.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 71.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 69.0, 68.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1590.7999999999997, "alertThreshold": 2.0}]} 12:10:01 INFO - Return code: 0 12:10:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:10:01 INFO - # TBPL SUCCESS # 12:10:01 INFO - Running post-action listener: _resource_record_post_action 12:10:01 INFO - [mozharness: 2016-09-01 19:10:01.684217Z] Finished run-tests step (success) 12:10:01 INFO - Running post-run listener: _resource_record_post_run 12:10:01 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409137152; Read time: 16; Write time: 296392 12:10:01 INFO - TinderboxPrint: CPU usage
13.0% 12:10:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:10:01 INFO - TinderboxPrint: I/O write bytes / time
409,137,152 / 296,392 12:10:01 INFO - TinderboxPrint: CPU idle
8,354.3 (87.0%) 12:10:01 INFO - TinderboxPrint: CPU user
1,202.1 (12.5%) 12:10:01 INFO - TinderboxPrint: Swap in / out
0 / 0 12:10:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118198272; Read time: 0; Write time: 91408 12:10:01 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290398208; Read time: 0; Write time: 204960 12:10:02 INFO - Running post-run listener: _upload_blobber_files 12:10:02 INFO - Blob upload gear active. 12:10:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:02 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 12:10:02 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:10:02 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:10:02 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:10:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:03 INFO - (blobuploader) - INFO - Done attempting. 12:10:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:10:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:10:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:05 INFO - (blobuploader) - INFO - Done attempting. 12:10:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:10:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:12 INFO - (blobuploader) - INFO - Done attempting. 12:10:12 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:12 INFO - Return code: 0 12:10:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ec7c6b150404372fc2c2a622ae860f08c3712b95e36f5300b0b10b4fe41b59fe48bc3b6df2e7dca620fc34de864c13795a0a0543c0f934720eab037d8d6f96d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/391d47e8515dccfb95350f9944a8f43eb031a6a59723b5aa5ce52106466d7a14e12cdebf992296cd114bcccf08f7a49bccbdd356cb8db552b2fa09cfeddde260", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116b41e4a444adf41dae4e4dcbb5e78bdc1083eba41e49a8b04fc3438c893ecf46d4042a9d8baaadf0982daa3921eb4323688ba518fc3f448bb24ff7f67fb0c8"} 12:10:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:12 INFO - Contents: 12:10:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ec7c6b150404372fc2c2a622ae860f08c3712b95e36f5300b0b10b4fe41b59fe48bc3b6df2e7dca620fc34de864c13795a0a0543c0f934720eab037d8d6f96d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/391d47e8515dccfb95350f9944a8f43eb031a6a59723b5aa5ce52106466d7a14e12cdebf992296cd114bcccf08f7a49bccbdd356cb8db552b2fa09cfeddde260", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116b41e4a444adf41dae4e4dcbb5e78bdc1083eba41e49a8b04fc3438c893ecf46d4042a9d8baaadf0982daa3921eb4323688ba518fc3f448bb24ff7f67fb0c8"} 12:10:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:12 INFO - Copying logs to upload dir... 12:10:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.679535 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-09-01 12:10:12.078935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 12:10:12.082043) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544 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-Non-PGO/sha512/0ec7c6b150404372fc2c2a622ae860f08c3712b95e36f5300b0b10b4fe41b59fe48bc3b6df2e7dca620fc34de864c13795a0a0543c0f934720eab037d8d6f96d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/391d47e8515dccfb95350f9944a8f43eb031a6a59723b5aa5ce52106466d7a14e12cdebf992296cd114bcccf08f7a49bccbdd356cb8db552b2fa09cfeddde260", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116b41e4a444adf41dae4e4dcbb5e78bdc1083eba41e49a8b04fc3438c893ecf46d4042a9d8baaadf0982daa3921eb4323688ba518fc3f448bb24ff7f67fb0c8"} build_url:https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/DMsUQ7C4QfSHr7kWZWGLWA/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-Non-PGO/sha512/0ec7c6b150404372fc2c2a622ae860f08c3712b95e36f5300b0b10b4fe41b59fe48bc3b6df2e7dca620fc34de864c13795a0a0543c0f934720eab037d8d6f96d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/391d47e8515dccfb95350f9944a8f43eb031a6a59723b5aa5ce52106466d7a14e12cdebf992296cd114bcccf08f7a49bccbdd356cb8db552b2fa09cfeddde260", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/116b41e4a444adf41dae4e4dcbb5e78bdc1083eba41e49a8b04fc3438c893ecf46d4042a9d8baaadf0982daa3921eb4323688ba518fc3f448bb24ff7f67fb0c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 12:10:12.106850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 12:10:12.107148) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472755756.353034-1965647544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 12:10:12.192832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 12:10:12.193136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 12:10:12.193415) ========= ========= Total master_lag: 0.18 =========