builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1468243375.54 results: success (0) buildid: 20160711031958 builduid: 87c2f2de948e4c8782bb3751d36420ef revision: 89c3e4ca17f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:55.536642) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:55.537129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:55.537409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:55.560389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:55.560805) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 06:22:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.8M=0s 2016-07-11 06:22:56 (30.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.393664 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:55.967782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:55.968097) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:56.017495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 06:22:56.017858) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 89c3e4ca17f5 --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 89c3e4ca17f5 --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=e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 06:22:56,385 Setting DEBUG logging. 2016-07-11 06:22:56,385 attempt 1/10 2016-07-11 06:22:56,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/89c3e4ca17f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 06:22:57,128 unpacking tar archive at: fx-team-89c3e4ca17f5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.096471 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 06:22:57.129107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:57.129469) ========= script_repo_revision: 89c3e4ca17f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:57.129972) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:57.130421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 06:22:57.141254) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-11 06:22:57.141788) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:22:57 INFO - MultiFileLogger online at 20160711 06:22:57 in /builds/slave/test 06:22:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:22:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:22:57 INFO - {'append_to_log': False, 06:22:57 INFO - 'base_work_dir': '/builds/slave/test', 06:22:57 INFO - 'blob_upload_branch': 'Fx-Team', 06:22:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:22:57 INFO - 'branch': 'Fx-Team', 06:22:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:22:57 INFO - 'config_files': ('talos/linux_config.py',), 06:22:57 INFO - 'default_actions': ('clobber', 06:22:57 INFO - 'read-buildbot-config', 06:22:57 INFO - 'download-and-extract', 06:22:57 INFO - 'populate-webroot', 06:22:57 INFO - 'create-virtualenv', 06:22:57 INFO - 'install', 06:22:57 INFO - 'run-tests'), 06:22:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:22:57 INFO - 'download_minidump_stackwalk': True, 06:22:57 INFO - 'download_symbols': 'ondemand', 06:22:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:22:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:22:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:22:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:22:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:22:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:22:57 INFO - 'installer_path': 'installer.exe', 06:22:57 INFO - 'log_level': 'info', 06:22:57 INFO - 'log_name': 'talos', 06:22:57 INFO - 'log_to_console': True, 06:22:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:22:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:22:57 INFO - 'opt_config_files': (), 06:22:57 INFO - 'pip_index': False, 06:22:57 INFO - 'sps_profile': False, 06:22:57 INFO - 'sps_profile_interval': 0, 06:22:57 INFO - 'suite': 'dromaeojs-e10s', 06:22:57 INFO - 'system_bits': '32', 06:22:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:22:57 INFO - 'title': 'talos-linux64-ix-006', 06:22:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:22:57 INFO - 'use_talos_json': True, 06:22:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:22:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:22:57 INFO - 'work_dir': 'build'} 06:22:57 INFO - ##### 06:22:57 INFO - ##### Running clobber step. 06:22:57 INFO - ##### 06:22:57 INFO - Running pre-action listener: _resource_record_pre_action 06:22:57 INFO - Running main action method: clobber 06:22:57 INFO - rmtree: /builds/slave/test/build 06:22:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:22:58 INFO - Running post-action listener: _resource_record_post_action 06:22:58 INFO - ##### 06:22:58 INFO - ##### Finished clobber step (success) 06:22:58 INFO - ##### 06:22:58 INFO - ##### 06:22:58 INFO - ##### Running read-buildbot-config step. 06:22:58 INFO - ##### 06:22:58 INFO - Running pre-action listener: _resource_record_pre_action 06:22:58 INFO - Running main action method: read_buildbot_config 06:22:58 INFO - Using buildbot properties: 06:22:58 INFO - { 06:22:58 INFO - "project": "", 06:22:58 INFO - "product": "firefox", 06:22:58 INFO - "script_repo_revision": "production", 06:22:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:22:58 INFO - "repository": "", 06:22:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 06:22:58 INFO - "buildid": "20160711031958", 06:22:58 INFO - "pgo_build": "True", 06:22:58 INFO - "basedir": "/builds/slave/test", 06:22:58 INFO - "buildnumber": 563, 06:22:58 INFO - "slavename": "talos-linux64-ix-006", 06:22:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:22:58 INFO - "platform": "ubuntu64_hw", 06:22:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:22:58 INFO - "branch": "fx-team", 06:22:58 INFO - "repo_path": "integration/fx-team", 06:22:58 INFO - "revision": "89c3e4ca17f5", 06:22:58 INFO - "stage_platform": "linux64-pgo", 06:22:58 INFO - "builduid": "87c2f2de948e4c8782bb3751d36420ef", 06:22:58 INFO - "slavebuilddir": "test" 06:22:58 INFO - } 06:22:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:22:58 INFO - Running post-action listener: _resource_record_post_action 06:22:58 INFO - ##### 06:22:58 INFO - ##### Finished read-buildbot-config step (success) 06:22:58 INFO - ##### 06:22:58 INFO - ##### 06:22:58 INFO - ##### Running download-and-extract step. 06:22:58 INFO - ##### 06:22:58 INFO - Running pre-action listener: _resource_record_pre_action 06:22:58 INFO - Running main action method: download_and_extract 06:22:58 INFO - mkdir: /builds/slave/test/build/tests 06:22:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:58 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:22:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:22:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:22:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:23:00 INFO - Downloaded 1361 bytes. 06:23:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:23:00 INFO - Using the following test package requirements: 06:23:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:23:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:23:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'jsshell-linux-x86_64.zip'], 06:23:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:23:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:23:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:23:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:23:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:23:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:00 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:23:01 INFO - Downloaded 24304312 bytes. 06:23:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:23:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:23:02 INFO - Return code: 0 06:23:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:02 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:23:04 INFO - Downloaded 24304312 bytes. 06:23:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:23:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:23:06 INFO - Return code: 0 06:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:06 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:23:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:23:07 INFO - Downloaded 14403333 bytes. 06:23:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:23:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:23:07 INFO - Return code: 0 06:23:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:07 INFO - https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:23:08 INFO - Downloaded 60473274 bytes. 06:23:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:23:08 INFO - mkdir: /builds/slave/test/properties 06:23:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:23:08 INFO - Writing to file /builds/slave/test/properties/build_url 06:23:08 INFO - Contents: 06:23:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:23:09 INFO - Running post-action listener: _resource_record_post_action 06:23:09 INFO - Running post-action listener: set_extra_try_arguments 06:23:09 INFO - ##### 06:23:09 INFO - ##### Finished download-and-extract step (success) 06:23:09 INFO - ##### 06:23:09 INFO - ##### 06:23:09 INFO - ##### Running populate-webroot step. 06:23:09 INFO - ##### 06:23:09 INFO - Running pre-action listener: _resource_record_pre_action 06:23:09 INFO - Running main action method: populate_webroot 06:23:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:23:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:23:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:23:09 INFO - '--tppagecycles', 06:23:09 INFO - '7'], 06:23:09 INFO - 'tests': ['tsvgm']}}, 06:23:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:23:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:23:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:23:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:23:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['damp', 'tps']}, 06:23:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'tests': ['damp', 'tps']}, 06:23:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['dromaeo_dom']}, 06:23:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:23:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['basic_compositor_video']}, 06:23:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:23:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['a11yr', 06:23:09 INFO - 'ts_paint', 06:23:09 INFO - 'tpaint', 06:23:09 INFO - 'sessionrestore', 06:23:09 INFO - 'sessionrestore_no_auto_restore', 06:23:09 INFO - 'tabpaint']}, 06:23:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:23:09 INFO - 'ts_paint', 06:23:09 INFO - 'tpaint', 06:23:09 INFO - 'sessionrestore', 06:23:09 INFO - 'sessionrestore_no_auto_restore', 06:23:09 INFO - 'tabpaint']}, 06:23:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:23:09 INFO - 'ts_paint', 06:23:09 INFO - 'tpaint', 06:23:09 INFO - 'sessionrestore', 06:23:09 INFO - 'sessionrestore_no_auto_restore', 06:23:09 INFO - 'tabpaint']}, 06:23:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:23:09 INFO - 'ts_paint', 06:23:09 INFO - 'tpaint', 06:23:09 INFO - 'sessionrestore', 06:23:09 INFO - 'sessionrestore_no_auto_restore', 06:23:09 INFO - 'tabpaint']}, 06:23:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['a11yr', 06:23:09 INFO - 'ts_paint', 06:23:09 INFO - 'tpaint', 06:23:09 INFO - 'sessionrestore', 06:23:09 INFO - 'sessionrestore_no_auto_restore', 06:23:09 INFO - 'tabpaint']}, 06:23:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['a11yr', 06:23:09 INFO - 'ts_paint', 06:23:09 INFO - 'tpaint', 06:23:09 INFO - 'sessionrestore', 06:23:09 INFO - 'sessionrestore_no_auto_restore', 06:23:09 INFO - 'tabpaint']}, 06:23:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['tsvgx', 06:23:09 INFO - 'tsvgr_opacity', 06:23:09 INFO - 'tart', 06:23:09 INFO - 'tscrollx', 06:23:09 INFO - 'cart']}, 06:23:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:23:09 INFO - 'tsvgr_opacity', 06:23:09 INFO - 'tart', 06:23:09 INFO - 'tscrollx', 06:23:09 INFO - 'cart']}, 06:23:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'talos_options': ['--disable-e10s'], 06:23:09 INFO - 'tests': ['tp5o']}, 06:23:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'tests': ['tp5o']}, 06:23:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'talos_options': ['--disable-e10s', 06:23:09 INFO - '--xperf_path', 06:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:09 INFO - 'tests': ['tp5n']}, 06:23:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:09 INFO - 'talos_options': ['--xperf_path', 06:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:09 INFO - 'tests': ['tp5n']}}, 06:23:09 INFO - 'talos.zip': {'path': '', 06:23:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:23:09 INFO - Running post-action listener: _resource_record_post_action 06:23:09 INFO - ##### 06:23:09 INFO - ##### Finished populate-webroot step (success) 06:23:09 INFO - ##### 06:23:09 INFO - ##### 06:23:09 INFO - ##### Running create-virtualenv step. 06:23:09 INFO - ##### 06:23:09 INFO - Running pre-action listener: _resource_record_pre_action 06:23:09 INFO - Running main action method: create_virtualenv 06:23:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:23:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:23:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:23:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:23:09 INFO - Using real prefix '/usr' 06:23:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:23:11 INFO - Installing distribute.............................................................................................................................................................................................done. 06:23:13 INFO - Installing pip.................done. 06:23:13 INFO - Return code: 0 06:23:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:23: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:23:13 INFO - Using env: {'DISPLAY': ':0', 06:23:13 INFO - 'HOME': '/home/cltbld', 06:23:13 INFO - 'LANG': 'en_US.UTF-8', 06:23:13 INFO - 'LANGUAGE': 'en_US:en', 06:23:13 INFO - 'LOGNAME': 'cltbld', 06:23:13 INFO - 'MAIL': '/var/mail/cltbld', 06:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:13 INFO - 'MOZ_NO_REMOTE': '1', 06:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:13 INFO - 'NO_EM_RESTART': '1', 06:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:13 INFO - 'PWD': '/builds/slave/test', 06:23:13 INFO - 'SHELL': '/bin/bash', 06:23:13 INFO - 'SHLVL': '1', 06:23:13 INFO - 'TERM': 'linux', 06:23:13 INFO - 'TMOUT': '86400', 06:23:13 INFO - 'USER': 'cltbld', 06:23:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:13 INFO - '_': '/tools/buildbot/bin/python'} 06:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:23:13 INFO - Cleaning up... 06:23:13 INFO - Return code: 0 06:23:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:23: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:23:13 INFO - Using env: {'DISPLAY': ':0', 06:23:13 INFO - 'HOME': '/home/cltbld', 06:23:13 INFO - 'LANG': 'en_US.UTF-8', 06:23:13 INFO - 'LANGUAGE': 'en_US:en', 06:23:13 INFO - 'LOGNAME': 'cltbld', 06:23:13 INFO - 'MAIL': '/var/mail/cltbld', 06:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:13 INFO - 'MOZ_NO_REMOTE': '1', 06:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:13 INFO - 'NO_EM_RESTART': '1', 06:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:13 INFO - 'PWD': '/builds/slave/test', 06:23:13 INFO - 'SHELL': '/bin/bash', 06:23:13 INFO - 'SHLVL': '1', 06:23:13 INFO - 'TERM': 'linux', 06:23:13 INFO - 'TMOUT': '86400', 06:23:13 INFO - 'USER': 'cltbld', 06:23:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:13 INFO - '_': '/tools/buildbot/bin/python'} 06:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:14 INFO - Downloading/unpacking psutil>=3.1.1 06:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:16 INFO - Installing collected packages: psutil 06:23:16 INFO - Running setup.py install for psutil 06:23:16 INFO - building 'psutil._psutil_linux' extension 06:23:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:23:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:23:18 INFO - building 'psutil._psutil_posix' extension 06:23:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:23:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:23:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:18 INFO - Successfully installed psutil 06:23:18 INFO - Cleaning up... 06:23:18 INFO - Return code: 0 06:23:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:18 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 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:23:18 INFO - Using env: {'DISPLAY': ':0', 06:23:18 INFO - 'HOME': '/home/cltbld', 06:23:18 INFO - 'LANG': 'en_US.UTF-8', 06:23:18 INFO - 'LANGUAGE': 'en_US:en', 06:23:18 INFO - 'LOGNAME': 'cltbld', 06:23:18 INFO - 'MAIL': '/var/mail/cltbld', 06:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:18 INFO - 'MOZ_NO_REMOTE': '1', 06:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:18 INFO - 'NO_EM_RESTART': '1', 06:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:18 INFO - 'PWD': '/builds/slave/test', 06:23:18 INFO - 'SHELL': '/bin/bash', 06:23:18 INFO - 'SHLVL': '1', 06:23:18 INFO - 'TERM': 'linux', 06:23:18 INFO - 'TMOUT': '86400', 06:23:18 INFO - 'USER': 'cltbld', 06:23:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:18 INFO - '_': '/tools/buildbot/bin/python'} 06:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:23:20 INFO - Installing collected packages: mozsystemmonitor 06:23:20 INFO - Running setup.py install for mozsystemmonitor 06:23:20 INFO - Successfully installed mozsystemmonitor 06:23:20 INFO - Cleaning up... 06:23:20 INFO - Return code: 0 06:23:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:23:20 INFO - Using env: {'DISPLAY': ':0', 06:23:20 INFO - 'HOME': '/home/cltbld', 06:23:20 INFO - 'LANG': 'en_US.UTF-8', 06:23:20 INFO - 'LANGUAGE': 'en_US:en', 06:23:20 INFO - 'LOGNAME': 'cltbld', 06:23:20 INFO - 'MAIL': '/var/mail/cltbld', 06:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:20 INFO - 'MOZ_NO_REMOTE': '1', 06:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:20 INFO - 'NO_EM_RESTART': '1', 06:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:20 INFO - 'PWD': '/builds/slave/test', 06:23:20 INFO - 'SHELL': '/bin/bash', 06:23:20 INFO - 'SHLVL': '1', 06:23:20 INFO - 'TERM': 'linux', 06:23:20 INFO - 'TMOUT': '86400', 06:23:20 INFO - 'USER': 'cltbld', 06:23:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:20 INFO - '_': '/tools/buildbot/bin/python'} 06:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:21 INFO - Downloading/unpacking jsonschema==2.5.1 06:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:23:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:23 INFO - Downloading functools32-3.2.3-2.tar.gz 06:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:23:23 INFO - warning: no files found matching '*.txt' 06:23:23 INFO - no previously-included directories found matching 'build' 06:23:23 INFO - no previously-included directories found matching 'dist' 06:23:23 INFO - no previously-included directories found matching '.git*' 06:23:23 INFO - Installing collected packages: jsonschema, functools32 06:23:23 INFO - Running setup.py install for functools32 06:23:23 INFO - warning: no files found matching '*.txt' 06:23:23 INFO - no previously-included directories found matching 'build' 06:23:23 INFO - no previously-included directories found matching 'dist' 06:23:23 INFO - no previously-included directories found matching '.git*' 06:23:23 INFO - Successfully installed jsonschema functools32 06:23:23 INFO - Cleaning up... 06:23:23 INFO - Return code: 0 06:23:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:23:23 INFO - Using env: {'DISPLAY': ':0', 06:23:23 INFO - 'HOME': '/home/cltbld', 06:23:23 INFO - 'LANG': 'en_US.UTF-8', 06:23:23 INFO - 'LANGUAGE': 'en_US:en', 06:23:23 INFO - 'LOGNAME': 'cltbld', 06:23:23 INFO - 'MAIL': '/var/mail/cltbld', 06:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:23 INFO - 'MOZ_NO_REMOTE': '1', 06:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:23 INFO - 'NO_EM_RESTART': '1', 06:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:23 INFO - 'PWD': '/builds/slave/test', 06:23:23 INFO - 'SHELL': '/bin/bash', 06:23:23 INFO - 'SHLVL': '1', 06:23:23 INFO - 'TERM': 'linux', 06:23:23 INFO - 'TMOUT': '86400', 06:23:23 INFO - 'USER': 'cltbld', 06:23:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:23 INFO - '_': '/tools/buildbot/bin/python'} 06:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:23 INFO - Downloading/unpacking blobuploader==1.2.4 06:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:23:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:23:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:26 INFO - Downloading docopt-0.6.1.tar.gz 06:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:23:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:23:26 INFO - Running setup.py install for blobuploader 06:23:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:23:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:23:26 INFO - Running setup.py install for requests 06:23:26 INFO - Running setup.py install for docopt 06:23:26 INFO - Successfully installed blobuploader requests docopt 06:23:26 INFO - Cleaning up... 06:23:26 INFO - Return code: 0 06:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:26 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 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:23:26 INFO - Using env: {'DISPLAY': ':0', 06:23:26 INFO - 'HOME': '/home/cltbld', 06:23:26 INFO - 'LANG': 'en_US.UTF-8', 06:23:26 INFO - 'LANGUAGE': 'en_US:en', 06:23:26 INFO - 'LOGNAME': 'cltbld', 06:23:26 INFO - 'MAIL': '/var/mail/cltbld', 06:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:26 INFO - 'MOZ_NO_REMOTE': '1', 06:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:26 INFO - 'NO_EM_RESTART': '1', 06:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:26 INFO - 'PWD': '/builds/slave/test', 06:23:26 INFO - 'SHELL': '/bin/bash', 06:23:26 INFO - 'SHLVL': '1', 06:23:26 INFO - 'TERM': 'linux', 06:23:26 INFO - 'TMOUT': '86400', 06:23:26 INFO - 'USER': 'cltbld', 06:23:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:26 INFO - '_': '/tools/buildbot/bin/python'} 06:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:27 INFO - Running setup.py (path:/tmp/pip-Owt_SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:27 INFO - Running setup.py (path:/tmp/pip-aSPmz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:27 INFO - Running setup.py (path:/tmp/pip-jZGBSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:27 INFO - Running setup.py (path:/tmp/pip-x2iKpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:27 INFO - Running setup.py (path:/tmp/pip-kw9R6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:27 INFO - Running setup.py (path:/tmp/pip-UtvLuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:27 INFO - Running setup.py (path:/tmp/pip-zmGHBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:27 INFO - Running setup.py (path:/tmp/pip-ILgvfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:27 INFO - Running setup.py (path:/tmp/pip-8QXSE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:27 INFO - Running setup.py (path:/tmp/pip-3rWgBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:27 INFO - Running setup.py (path:/tmp/pip-_D6lsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:27 INFO - Running setup.py (path:/tmp/pip-xVZt8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:27 INFO - Running setup.py (path:/tmp/pip-eSyA_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:28 INFO - Running setup.py (path:/tmp/pip-WM4nvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:28 INFO - Running setup.py (path:/tmp/pip-8IWhXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:28 INFO - Running setup.py (path:/tmp/pip-w0rHW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:28 INFO - Running setup.py (path:/tmp/pip-Zc7m6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:28 INFO - Running setup.py install for manifestparser 06:23:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:28 INFO - Running setup.py install for mozcrash 06:23:28 INFO - Running setup.py install for mozdebug 06:23:28 INFO - Running setup.py install for mozdevice 06:23:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:28 INFO - Running setup.py install for mozfile 06:23:28 INFO - Running setup.py install for mozhttpd 06:23:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:23:28 INFO - Running setup.py install for mozinfo 06:23:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Running setup.py install for mozInstall 06:23:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Running setup.py install for mozleak 06:23:29 INFO - Running setup.py install for mozlog 06:23:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Running setup.py install for moznetwork 06:23:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Running setup.py install for mozprocess 06:23:29 INFO - Running setup.py install for mozprofile 06:23:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Running setup.py install for mozrunner 06:23:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:23:29 INFO - Running setup.py install for mozscreenshot 06:23:29 INFO - Running setup.py install for moztest 06:23:30 INFO - Running setup.py install for mozversion 06:23:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:23:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:23:30 INFO - Cleaning up... 06:23:30 INFO - Return code: 0 06:23:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:30 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 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:23:30 INFO - Using env: {'DISPLAY': ':0', 06:23:30 INFO - 'HOME': '/home/cltbld', 06:23:30 INFO - 'LANG': 'en_US.UTF-8', 06:23:30 INFO - 'LANGUAGE': 'en_US:en', 06:23:30 INFO - 'LOGNAME': 'cltbld', 06:23:30 INFO - 'MAIL': '/var/mail/cltbld', 06:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:30 INFO - 'MOZ_NO_REMOTE': '1', 06:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:30 INFO - 'NO_EM_RESTART': '1', 06:23:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:30 INFO - 'PWD': '/builds/slave/test', 06:23:30 INFO - 'SHELL': '/bin/bash', 06:23:30 INFO - 'SHLVL': '1', 06:23:30 INFO - 'TERM': 'linux', 06:23:30 INFO - 'TMOUT': '86400', 06:23:30 INFO - 'USER': 'cltbld', 06:23:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:30 INFO - '_': '/tools/buildbot/bin/python'} 06:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:30 INFO - Running setup.py (path:/tmp/pip-tcmhUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:30 INFO - Running setup.py (path:/tmp/pip-7yJo9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:30 INFO - Running setup.py (path:/tmp/pip-3tjWQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:30 INFO - Running setup.py (path:/tmp/pip-CBxVrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:30 INFO - Running setup.py (path:/tmp/pip-vyaTs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:30 INFO - Running setup.py (path:/tmp/pip-OHRyI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:30 INFO - Running setup.py (path:/tmp/pip-6rTt7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:30 INFO - Running setup.py (path:/tmp/pip-jez3AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:30 INFO - Running setup.py (path:/tmp/pip-UMh7F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:31 INFO - Running setup.py (path:/tmp/pip-hdlQ_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:31 INFO - Running setup.py (path:/tmp/pip-3qAQ0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:31 INFO - Running setup.py (path:/tmp/pip-Nduvjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:31 INFO - Running setup.py (path:/tmp/pip-lp7eBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:31 INFO - Running setup.py (path:/tmp/pip-WtmcIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:31 INFO - Running setup.py (path:/tmp/pip-ETA19P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:31 INFO - Running setup.py (path:/tmp/pip-_bYGiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:31 INFO - Running setup.py (path:/tmp/pip-_24TvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:23:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:33 INFO - Downloading blessings-1.6.tar.gz 06:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:23:33 INFO - Installing collected packages: blessings 06:23:33 INFO - Running setup.py install for blessings 06:23:33 INFO - Successfully installed blessings 06:23:33 INFO - Cleaning up... 06:23:33 INFO - Return code: 0 06:23:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:34 INFO - Reading from file tmpfile_stdout 06:23:34 INFO - Current package versions: 06:23:34 INFO - argparse == 1.2.1 06:23:34 INFO - blessings == 1.6 06:23:34 INFO - blobuploader == 1.2.4 06:23:34 INFO - docopt == 0.6.1 06:23:34 INFO - functools32 == 3.2.3-2 06:23:34 INFO - jsonschema == 2.5.1 06:23:34 INFO - manifestparser == 1.1 06:23:34 INFO - mozInstall == 1.12 06:23:34 INFO - mozcrash == 0.17 06:23:34 INFO - mozdebug == 0.1 06:23:34 INFO - mozdevice == 0.48 06:23:34 INFO - mozfile == 1.2 06:23:34 INFO - mozhttpd == 0.7 06:23:34 INFO - mozinfo == 0.9 06:23:34 INFO - mozleak == 0.1 06:23:34 INFO - mozlog == 3.2 06:23:34 INFO - moznetwork == 0.27 06:23:34 INFO - mozprocess == 0.23 06:23:34 INFO - mozprofile == 0.28 06:23:34 INFO - mozrunner == 6.12 06:23:34 INFO - mozscreenshot == 0.1 06:23:34 INFO - mozsystemmonitor == 0.3 06:23:34 INFO - moztest == 0.7 06:23:34 INFO - mozversion == 1.4 06:23:34 INFO - psutil == 3.1.1 06:23:34 INFO - requests == 1.2.3 06:23:34 INFO - wsgiref == 0.1.2 06:23:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:34 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 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:23:34 INFO - Using env: {'DISPLAY': ':0', 06:23:34 INFO - 'HOME': '/home/cltbld', 06:23:34 INFO - 'LANG': 'en_US.UTF-8', 06:23:34 INFO - 'LANGUAGE': 'en_US:en', 06:23:34 INFO - 'LOGNAME': 'cltbld', 06:23:34 INFO - 'MAIL': '/var/mail/cltbld', 06:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:34 INFO - 'MOZ_NO_REMOTE': '1', 06:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:34 INFO - 'NO_EM_RESTART': '1', 06:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:34 INFO - 'PWD': '/builds/slave/test', 06:23:34 INFO - 'SHELL': '/bin/bash', 06:23:34 INFO - 'SHLVL': '1', 06:23:34 INFO - 'TERM': 'linux', 06:23:34 INFO - 'TMOUT': '86400', 06:23:34 INFO - 'USER': 'cltbld', 06:23:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:34 INFO - '_': '/tools/buildbot/bin/python'} 06:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:23:34 INFO - Cleaning up... 06:23:34 INFO - Return code: 0 06:23:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:34 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 0x1db2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2073180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:23:34 INFO - Using env: {'DISPLAY': ':0', 06:23:34 INFO - 'HOME': '/home/cltbld', 06:23:34 INFO - 'LANG': 'en_US.UTF-8', 06:23:34 INFO - 'LANGUAGE': 'en_US:en', 06:23:34 INFO - 'LOGNAME': 'cltbld', 06:23:34 INFO - 'MAIL': '/var/mail/cltbld', 06:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:34 INFO - 'MOZ_NO_REMOTE': '1', 06:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:34 INFO - 'NO_EM_RESTART': '1', 06:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:34 INFO - 'PWD': '/builds/slave/test', 06:23:34 INFO - 'SHELL': '/bin/bash', 06:23:34 INFO - 'SHLVL': '1', 06:23:34 INFO - 'TERM': 'linux', 06:23:34 INFO - 'TMOUT': '86400', 06:23:34 INFO - 'USER': 'cltbld', 06:23:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:34 INFO - '_': '/tools/buildbot/bin/python'} 06:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:23:34 INFO - Cleaning up... 06:23:34 INFO - Return code: 0 06:23:34 INFO - Running post-action listener: _resource_record_post_action 06:23:34 INFO - Running post-action listener: _start_resource_monitoring 06:23:34 INFO - Starting resource monitoring. 06:23:34 INFO - ##### 06:23:34 INFO - ##### Finished create-virtualenv step (success) 06:23:34 INFO - ##### 06:23:34 INFO - ##### 06:23:34 INFO - ##### Running install step. 06:23:34 INFO - ##### 06:23:34 INFO - Running pre-action listener: _resource_record_pre_action 06:23:34 INFO - Running main action method: install 06:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:34 INFO - Reading from file tmpfile_stdout 06:23:34 INFO - Detecting whether we're running mozinstall >=1.0... 06:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:23:34 INFO - Reading from file tmpfile_stdout 06:23:34 INFO - Output received: 06:23:34 INFO - Usage: mozinstall [options] installer 06:23:34 INFO - Options: 06:23:34 INFO - -h, --help show this help message and exit 06:23:34 INFO - -d DEST, --destination=DEST 06:23:34 INFO - Directory to install application into. [default: 06:23:34 INFO - "/builds/slave/test"] 06:23:34 INFO - --app=APP Application being installed. [default: firefox] 06:23:34 INFO - mkdir: /builds/slave/test/build/application 06:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:23:51 INFO - Reading from file tmpfile_stdout 06:23:51 INFO - Output received: 06:23:51 INFO - /builds/slave/test/build/application/firefox/firefox 06:23:51 INFO - Running post-action listener: _resource_record_post_action 06:23:51 INFO - ##### 06:23:51 INFO - ##### Finished install step (success) 06:23:51 INFO - ##### 06:23:51 INFO - ##### 06:23:51 INFO - ##### Running run-tests step. 06:23:51 INFO - ##### 06:23:51 INFO - Running pre-action listener: _resource_record_pre_action 06:23:51 INFO - Running main action method: run_tests 06:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:23:51 INFO - Python 2.7.3 06:23:51 INFO - Return code: 0 06:23:51 INFO - grabbing minidump binary from tooltool 06:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:51 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 0x20713b0>, '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 0x20722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:23:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:23:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:23:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:23:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:23:52 INFO - Return code: 0 06:23:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:23:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:23:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:23:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:23:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:23:52 INFO - Using env: {'DISPLAY': ':0', 06:23:52 INFO - 'HOME': '/home/cltbld', 06:23:52 INFO - 'LANG': 'en_US.UTF-8', 06:23:52 INFO - 'LANGUAGE': 'en_US:en', 06:23:52 INFO - 'LOGNAME': 'cltbld', 06:23:52 INFO - 'MAIL': '/var/mail/cltbld', 06:23:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:23:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:52 INFO - 'MOZ_NO_REMOTE': '1', 06:23:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:52 INFO - 'NO_EM_RESTART': '1', 06:23:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:52 INFO - 'PWD': '/builds/slave/test', 06:23:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:23:52 INFO - 'SHELL': '/bin/bash', 06:23:52 INFO - 'SHLVL': '1', 06:23:52 INFO - 'TERM': 'linux', 06:23:52 INFO - 'TMOUT': '86400', 06:23:52 INFO - 'USER': 'cltbld', 06:23:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181', 06:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:52 INFO - '_': '/tools/buildbot/bin/python'} 06:23:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:23:52 INFO - mozversion application_buildid: 20160711031958 06:23:52 INFO - mozversion application_changeset: 89c3e4ca17f5c9d01638d49834a81789499e72ce 06:23:52 INFO - mozversion application_display_name: Nightly 06:23:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:23:52 INFO - mozversion application_name: Firefox 06:23:52 INFO - mozversion application_remotingname: firefox 06:23:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:23:52 INFO - mozversion application_vendor: Mozilla 06:23:52 INFO - mozversion application_version: 50.0a1 06:23:52 INFO - mozversion platform_buildid: 20160711031958 06:23:52 INFO - mozversion platform_changeset: 89c3e4ca17f5c9d01638d49834a81789499e72ce 06:23:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:23:52 INFO - mozversion platform_version: 50.0a1 06:23:52 INFO - using testdate: 1468243432 06:23:52 INFO - actual date: 1468243432 06:23:52 INFO - starting webserver on 'localhost:47458' 06:23:52 INFO - SUITE-START | Running 2 tests 06:23:52 INFO - TEST-START | dromaeo_css 06:23:52 INFO - operating with platform_type : linux_ 06:23:52 INFO - Initialising browser for dromaeo_css test... 06:23:52 INFO - TEST-INFO | started process 3304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxkOqc0/profile http://localhost:47458/getInfo.html) 06:23:59 INFO - PROCESS | 3304 | __metrics Screen width/height:1600/1200 06:23:59 INFO - PROCESS | 3304 | colorDepth:24 06:23:59 INFO - PROCESS | 3304 | Browser inner width/height: 1024/697 06:23:59 INFO - PROCESS | 3304 | __metrics 06:24:00 ERROR - PROCESS | 3304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 06:24:01 INFO - TEST-INFO | 3304: exit 0 06:24:01 INFO - Browser initialized. 06:24:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:24:01 INFO - TEST-INFO | started process 3423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxkOqc0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:12 INFO - PROCESS | 3423 | RSS: Main: 167833600 06:24:12 INFO - PROCESS | 3423 | 06:25:02 INFO - PROCESS | 3423 | 1468243502500 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:27:10 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:47458/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47458/tests/dromaeo/cssquery-ext.html) 06:27:11 INFO - PROCESS | 3423 | RSS: Main: 171642880 06:27:11 INFO - PROCESS | 3423 | 06:30:13 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:47458/tests/dromaeo/cssquery-ext.html (next: http://localhost:47458/tests/dromaeo/cssquery-jquery.html) 06:30:14 INFO - PROCESS | 3423 | RSS: Main: 168312832 06:30:14 INFO - PROCESS | 3423 | 06:33:16 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:47458/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47458/tests/dromaeo/cssquery-mootools.html) 06:33:16 INFO - PROCESS | 3423 | RSS: Main: 171356160 06:33:16 INFO - PROCESS | 3423 | 06:36:18 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:47458/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47458/tests/dromaeo/cssquery-prototype.html) 06:36:19 INFO - PROCESS | 3423 | RSS: Main: 166850560 06:36:19 INFO - PROCESS | 3423 | 06:39:21 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:47458/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47458/tests/dromaeo/cssquery-yui.html) 06:39:22 INFO - PROCESS | 3423 | RSS: Main: 168845312 06:39:22 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | Cycle 1(1): loaded http://localhost:47458/tests/dromaeo/cssquery-yui.html (next: http://localhost:47458/tests/dromaeo/cssquery-dojo.html) 06:42:25 INFO - PROCESS | 3423 | RSS: Main: 170061824 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | __start_tp_report 06:42:25 INFO - PROCESS | 3423 | _x_x_mozilla_page_load 06:42:25 INFO - PROCESS | 3423 | _x_x_mozilla_page_load_details 06:42:25 INFO - PROCESS | 3423 | |i|pagename|runs| 06:42:25 INFO - PROCESS | 3423 | |0;dojo.html;3099.2097015261106;3114.4705400081984;3134.279115803366;3162.177833763221;3166.968330316696;5430.294061771969;5506.64206826556;5529.253550770644;5543.196236545698;5591.797763480851;5411.404745477994;5482.890342193154;5490.917636235459;5552.361478429982;5571.415001424853;4998.925016124761;5027.1956486962;5044.344235249412;5102.744862756866;5132.615053870956;5005.849824505252;5072.365954255718;5126.487351264881;5130.692158470485;5193;666.0673987792541;4964.503549645025;5070.746462676888;5150.9742451287875;5151.484851514837;5012.122878496285;5027.547520723152;5034.89930201394;5069.619778516626;5090.007448547534;4984.476629953875;4997.62517811162;5000.224965130375;5023.34696489454;5023.497650234984;5276.182191760283;5378.435264297271;5392.811251606175;5513.283273174502;5528.06022976095;5828.184054232411;5832.766689332421;5850.6782126983;5851.239338885917;5911.172435858984;5897.64614123154;5905.468507834273;5913.0539113742025;5931;5931.73307201177;5388.649737767072;5468;5503;5553.583481238923;5563.13771365439;5985.6408615483215;5990.400959904062;6001.789937352171;6011.969940150271;6019.127226552126;5709.543236541067;5767.942320576824;5769.278840144982;5774.769009239583;5782.045962416239;5768.971155144198;5885.61743486672;5951.613145145551;5975.611585246945;6007.219061521974;5928;5943.732532036069;5967.373425790316;5971.761129554856;5972.313183983811;5760.6255593386295;5982.7307771149535;5983.072623743326;5985.850353741192;5999.610025348426;4345.869623911288;4384.758838263926;4437.933430998473;4474.865754027384;4485.955140448619;3927.4697915781576;3961;3965.7025723070883;3977.065389633434;4004.0390306326854;5481;5617.073182924853;5632.098864181711;5641.943580564224;5682.7442765075675;5945.078512830518;5992.580519363602;6029.939700603026;6041.758329666852;6061.878762424815;5688;5734.713264336767;5741.052726300114;5762.596618236767;5766;4872.537108974641;4932.704037757746;5011.599072074226;5015.84952451427;5027;6091.269047714214;6145.4161854623735;6177.2587289525545;6179.721912513947;6182.938170618326;5990.010029691891;6017.06735456005;6025.78909738157;6031.487323577545;6056.454919057306;5978.192943952685;6041.818745437468;6081.027035674271;6168.506519478341;6181.84545386351;5851.707414629166;5858.443447872616;5860.120981852756;5875.265591801025;5939.554533409925;5928.110783382527;5967.283925928917;5969.194158788681;6009.909851352146;6024.337322894566;5654.886902261849;5766.798162064308;5809.738561764646;5813.302403711582;5862.67755273447;5833.562482813891;5846.298444186725;5849.94150058494;5859.648421094748;5868.706564671664;5758.8848223034465;5765.798197063083;5777.537796976148;5778.422157784188;5806.158107074535;5645.774169033192;5652.180433837153;5693.715314234355;5744.971275143597;5822.359540450631;5585;5611.915821262766;5622.100463925753;5689.54483641316;5709.885802284014 06:42:25 INFO - PROCESS | 3423 | |1;ext.html;549.3709702390763;607.5534482155617;608.2640005593232;608.4706305514203;647.3785166240409;37630.62369376305;42249;42274.78862605686;42335.15329693404;42391.36412953801;42246.57753422465;42593.574064259345;42680.57319426805;42941.35587966183;42981;8808.603612837438;8966.193042626162;8973.192412682858;8973.551322433885;8979.236764874993;8841.778955526132;8860.734177974671;8895.421797583169;8905.73282801517;8951.507667078307;8949.328800339968;8959.104089591054;8989.77525561863;9020.323475739313;9038.502882341469;8930.821383572356;8944.195022447979;8956.641734330618;8973.641054357819;8993.775155621097;8718.520481373522;8778.868316975251;8836.469811811312;8841.69054083104;8845.027047024822;41404;41479.7926010368;41508.79245603783;41706.37440438396;41836.1632767346;2885.668148162967;3341.498775183742;3441.6214216436174;3620.4931309616672;4125.834966601333;27977.580336294974;29507.409851802844;31600.36799264002;32767.6723232767;32804.835975819966;4153.563875793058;4178.979105104486;4268.829246830123;4284.9143017139795;4355.629771469429;289652;290553;290885;291422;291934;34567.4814877777;34642.65357346394;34650.30699386049;34651.4802277966;34671.13322166966;35221.64778352235;35331.29337413289;35614.8219258902;37402.62597374046;37575;15805.446809361847;15899.920500397424;15992.92003539998;16000;16020;11837.585684501;11956.701082473008;11993.220440671328;12016.218945768496;12018;18806.247750089842;18835.24659013624;18982.196691314304;19035.80964190368;19133.712994305097;7132.465065120136;7244.311790379906;7265.564066156047;7279.745208917769;7506;983.6360546597662;1004.7036124343336;1108.296231892754;1157.6353448663644;1171.3499008050615;33061.83469082639;33126.834365828014;33630.159246019044;33690;33788.49317260243;1125.2517076144436;1126.7014241226082;1153.5695687752589;1190.8809119088196;1218.4456072486996;16749.58126046834;17260.395886143924;17338.479845604652;17370.652586948192;17557.297708091788;639178;639607;643272;643619;643926;57632;57878.131828021775;57959.13061304084;57973;58120.418795812344;1307.8169056332122;1329.6077657091182;1363.4069179906771;1364.5087768403366;1367.746966811143;31720.206994825316;32422.513662295558;32563.185920351232;32805.83597081999;33126.834365828014;50131;50373;50456.74771626118;50482.49517504925;50741;457559;457622;459150;459452;460411;27504.17487475379;27673.256010416182;27719.30701732473;27745.445091098467;27867.860660696566;47870.52129478661;49105.75447122742;49199.75400122976;49250;49614;41320.173596528504;41710.791446042575;42063.78968105262;42785;42987.57012429961;40924.79537602293;41334.79332603318;41394.022076150315;41502.377464338664;42567.3614895783;35476.822615886755;35851.82074089613;35880.64119358877;39782.602173979045;42353.57646423496;30739.692603073683;36549.45175822418;37027.629723703496;37177.81411092927;37350.8132459336;28418.857905710338;28430.20878013772;28610.57084143698;28617.284567885137;28837.37671154105 06:42:25 INFO - PROCESS | 3423 | |2;jquery.html;393.6181903553553;396.69454520019565;397.660000699402;403.4754818735645;420.36524847480297;14205.857941420583;18777;18884.62230755384;20785.376438706844;20876.269330573414;19102.90448547759;19109;19505;19971.900140499314;20164.294249701226;5670.262865827437;5684.801031963882;5853.122031695238;5858.414158584129;5884.852878678046;5396.703181325026;5692;5740.052891272935;5744.138379243105;5775.509081728037;5715.71421428929;5722.055860782966;5725.427457254283;5732.140178973145;5734.480362703886;5388.299521062257;5657.830265092054;5683.431656834325;5693;5728.369879313273;5523.6685798852195;5530.834074977757;5560.7219639017885;5580.051391263495;5587.8603034924045;13568;13578.253196074213;13605.455781768718;18020.36928707502;23228.767712322828;2621.0040184729683;2678.2233152385784;2707.9729202707917;2727.3045373429845;2984.492636251821;10041.19670426364;10208.234382421273;10478.21413393991;12558.560450384193;14138.646533836634;1902.9143688533911;1915.9233630654758;1927.3158028899818;1950.2101648832245;1963.4011626453926;86313;87174.56412717959;88009;89113;89487;10717.35695858251;10932.289401188897;11155.72110697239;11243.472503621397;11335.319880807177;15339;15406.768898466533;15456.536303910902;15481.5355539334;15623.531294061197;7912.4065695073095;7986.201379861967;8096.473729207701;8194.95937524648;8295.294899933453;7371.447141464411;7583.165851756303;7734.99445072137;7882.842343153219;7888.343447875895;4545.36364908913;4565.429321334833;4756.6908150970075;4763.380450646797;4883.218685010382;1860.8604354673182;1921.41396873952;1929.9807001930083;1930.5752734398409;2003.1386503803503;1018.1345856022322;1031.798799234142;1053.9156867450586;1055;1058.2010582010687;19213.903930480257;19635.509112272306;20122;20171.596568068555;20369.388918332475;977.5405559387077;995.7162208770466;1020.8366661334151;1057.7831544533353;1062.044160255776;10758.94620526908;11285.71785705364;11310.377929213808;11330.546778128783;11406;545070;555151;556633;557830;564311;84285;92123.99999999866;93169.53415232881;107685;109638.51807409758;1018.3075508654039;1020.2399212586819;1053.5417093564324;1058.571278632155;1060.612876300145;18311.72532411988;18557.35049273269;18967.620647586697;19022.904885476037;19277.325293614656;34284;45633.771831140635;46708;47469.52530474651;47586.426636929515;56697;57500;59229.40770592411;66591.66704166448;66916.66541667261;7789.298963093349;7870.29167374939;7912.5648089353335;7990.081140668897;8721.604543273299;13204.207747535178;13747.862521374658;13887.444502219798;14136.08115472491;14315.928420357832;12431.440585173508;12466.563670271496;12467.875321247035;12622.242665440102;12885.677858053623;11812.350320732443;12008.759824803281;12053.57812476559;12079.335636540074;12445.25328480294;12336.75326493483;12409.317487537912;12489.439664868498;12581.811272830731;12648.114631975674;7497.512661676974;7673.616319183907;7766.534007959541;7985.960070199611;8425.325973922194;11264.747050590078;11573;12390.5663301784;12691.238525688488;12887.80668289995 06:42:25 INFO - PROCESS | 3423 | |3;mootools.html;1473.99263003685;1500.9849901500984;1605.831387704291;1736.7394890766384;1749.1079549429787;8047.959760201191;8591.613377398016;8880.777980550489;9187.127222913829;9200.907990920097;8867.512286824238;9148.268138548916;9220.077992200793;9227.861582076273;9234.630614775419;2344.8944797484155;2360.409897525619;2372.7745864142967;2378.4648454097864;2378.7383387827326;2337.392278007722;2340.6489026646054;2395.8921848516857;2396.4488167721433;2399.4121440247163;2355.9175428859994;2362.338545207336;2365.5860224460735;2375.857448553092;2384.0940442631777;2324.2213858357472;2330.5338932213454;2342.6954495915506;2347.8473899196583;2366.077229880348;2265.3317271404812;2280.1791355112146;2292.587334279829;2296.8851557422063;2297.3911913342977;9152.908470915272;9162.404443711137;9170.312226582966;9202.30982676302;9240.26077913772;4833.830815921461;4915.827946021872;5020.723860187688;5021.271915572222;5031;3252.788568743024;3260.8043517388796;3286.4905939579403;3360.4287271163716;3378.0372593810894;1093.710679649238;1118.1390329446363;1127.1940562497853;1129.9152563557766;1144.7252659361693;12835.87164128356;12836.229826210363;12902;12928.35358232094;12944.223346599234;4375;4391.824327026947;4496.437945256843;4561.69991552406;4632.2125238709505;10734.141268698486;10766.515506802212;10819.080378167786;10842.349459032483;10867.510962006729;5049.495050494995;5055.292259083732;5093.2105523643895;5098.97450512745;5100.846974590768;4219.662427005832;4533.682642215079;4634.745089020136;4666.580007799314;4671.649626278043;3857.537095548496;3944.6647035001774;3994.6404823566018;4035.596440355941;4058.6955978301744;1290.7160424706549;1299.9025073119553;1303.7718399280088;1310.2073245686413;1332.2672530108402;924.5793164110314;930.9627614895328;945.9479728614992;947.1664934857281;956.2493442647489;5801.187833703285;5885;5901.0558310670085;5906.143609176731;6020.789272375446;983.9704808855746;1000.284796370584;1016.0804471952747;1065.041462683591;1094.4035500652165;4041.777702226347;4120.835166593362;4122;4125.566815484391;4138.089620283533;11054.944725276482;11535.826962595567;11604.88395116055;11609.76780464386;11635.069194464422;11414.029807466291;11468.197226194254;11474.713132171762;11476.081913446904;11512.539498420138;8368;8456.150265463115;8542.658293668184;8644.3948923576;8676.566171691391;5625.831225063254;5634.183043458594;5768.826935191951;5791.7683292667825;5839.854003649943;10554.2084343673;10628.36229826182;10747.89252107469;10777.838332424863;10842.349459032483;10752.731181720206;10784.946075269574;10880.075193608316;11006.504707288032;11061.391623460466;7165.211826699163;7448.441366897613;7475.588842613708;7588.051493563305;7663.463557550918;8852.159044890725;8911.108889111038;8916.375853690179;8940.910590894007;9020.233280171258;7441.367483763941;7629.580373079534;7652.617369131633;7691.077070751546;7696.653650585849;7766.378689704923;7797.376209903081;7860.646270917708;8018.679252829821;8041.356691464785;7314.838786768299;7387.7783666490095;7427.925720742724;7482.476226664081;7488.625568721433;4876.878078047936;4883.121038213156;4946.837493189169;5004.074246264453;5091.745412729423;5135.10135726239;5160.870978225575;5173.741312934413;5208.348956380452;5248.580113590827 06:42:25 INFO - PROCESS | 3423 | |4;prototype.html;306.3551224672065;310.5528039622944;322.9547863299137;323.40493491974775;324.3205484509954;5651.434856514346;5693.345265294482;5739.196512488255;5740.540756739461;5748.166515855204;5554.139363313295;5622.156676498527;5626.578006649497;5632.633878797876;5637.520810731093;4156;4174.937375939348;4299.140171965604;4315.180115778008;4318.2227199104145;4261.126469073848;4262.934266433392;4284.871453856389;4287.378330142127;4290.935635965448;4248.192843359767;4259.382389553512;4266.445362102922;4295.119500502406;4320.913581728363;4060.8375664973364;4284.207421627009;4301.773669747689;4303.569643035703;4330.307150855863;3721.237146385012;3730.570984336809;3739.383001804699;3739.887803365876;3748.775073495599;5542.196381524696;5555.194496797982;5580.63725857822;5580.939621471948;5614.326280846284;4883.1698611235815;4902.142125128088;4923.483034281385;4950.158473059589;5016.423111342206;5848.2689663792025;5890.764369425217;5892.322382925976;5916.230889984275;5932.249986254065;4116.23002109093;4120.814563344657;4123.999860067865;4155.127423241123;4156.56356082613;6080.939190608082;6155.784547540859;6223.43989040984;6236.18929539157;6253.8117757625905;4219;4220.873373798791;4236.343366778093;4244.893877653083;4248.808803603845;4248.808803603783;4269.637080848101;4273.358996150602;4287.292596721506;4305.935410968838;4753.572178503882;4941.308216849644;4950.603951683856;4982.476839931827;5001.399832020108;5867.911981320283;5938.28740551128;5942.673152976541;5980.102984552352;6016.736485338128;1446.197360464952;1473.6315921019745;1480.7487672916368;1481.6592183797786;1492.3135357735564;921.4609453469795;933.641551542504;980.5734505490135;985.4383001688968;990.9603615855285;5694.060480020833;5715.114157305624;5735.942640573624;5740.880528296942;5772.5959182856795;6014.105556749697;6122.66325352101;6152.446279834747;6159.599626024294;6184.5980011299125;5515.889682206413;5704.286964129484;5725.456081672234;5766.855828604234;5780.971095144498;3236.579244698174;3245.918852028718;3262.820544870055;3272.214668479548;3273.9508907366408;6061.212042434543;6140.78507252253;6182.443580077725;6269.965455699758;6284.70053222053;6108.358622344679;6124.724387402578;6151.7539298428455;6199.752009919553;6212.9068063979075;5980.910286345796;6211.378862113753;6228.34602366754;6237.937620623827;6243.625382477066;5990.430909063632;6031.668258245663;6078.90881636767;6080.939190608037;6094.360092190256;5929.094743575703;5959.433853783884;6000.5799594028;6005.519558435228;6007.309159446545;5973.253343332083;6220.4759833841;6223.533235007483;6255.155554000334;6284.654344011124;4171.249175148502;4200.613797446774;4209.053662436368;4218.502431636724;4223.049813791872;5846.590738648254;6002.339742628395;6072.180255665428;6085.2393450818645;6148.600340977822;5942.7817297454785;5955.570663040926;5980.222571065734;5988.520918326611;5992.490638295793;5752.07966725322;5925.762969481172;5948.672822994777;5953.761849526144;5971.134185543159;5910.527157827278;5913.763449461973;5930.703464826827;5931.822045338647;5995.670238136944;6048.7278072487725;6062.787802426894;6064.9393506066135;6097.298810636834;6113.327533971348;5638.887222255614;5886.352501224947;5897;5900.291964964232;5913.645181289136 06:42:25 INFO - PROCESS | 3423 | |5;yui.html;749.3892477630731;791.3234184772018;812.3907069697726;825.1088824070004;832.4547421438959;15312.617184570378;16144.434944776935;16590.585235369123;16600.25298861551;16847.49457516275;15490.767638485431;15612.609684757886;15613.375464981387;15627.765583516228;15678.84321156788;769.3114662377183;780.8906753054576;794.1700922535935;797.2426195114635;799.460364254129;776.5069181070033;776.5340795522669;776.5340795522698;776.763087258386;779.4465929190281;808.8382323535287;817.464560712734;818.7298191596759;819.4264015189391;819.6065888373585;804.5816175588719;804.8350088231898;805.1626308639009;807.7617102954642;809.7004108479871;584.9649021058708;586.3960121075299;586.5395664403422;589.9587028907978;591.1516973143509;14983.250837458083;15065.09609423438;15111.622209444851;15207.239638018054;15240;15163.62090947724;15170.24148792556;15186.46847360337;15206.619834504116;15355.692886142326;12538;12543.121981461301;12584.68538286541;12654.240745555297;12671.239725616493;3854.6266484584517;3894.6563435614667;3909.1790723948006;3990.980045099785;4002.0595160137345;84651.5767421159;84774;85952.14047859567;86336.13663863344;87326.12673873243;10560.260781745204;10797.514111864828;11041.779164416826;11361.772764544663;11466.369349685847;18675.71986420205;18728.812711872706;18774.624507509772;18802.059897005096;20501.692474612595;8621.137886211454;8634.956825215833;8666.6100025499;8700.12998700125;8789.472631642122;4821.807127714922;4886.975565122151;4925.064237794808;4949.628777841676;5200.323957885451;3434.914127146841;3586.8385922633543;3588.5334906461994;3590.5870824855474;3610.7833529988284;631.7536160897254;646.3988490703691;661.8709351676473;674.1371045062328;678.4538446550475;638.8115505925763;683.9589624622539;709.5707097206116;729.5622626424209;741.5773009384599;9797.510124493747;9801.607935682636;9891.851622225673;10128.696139115838;10175.236857235588;720.661289194078;723.6128671160903;724.7861880745193;732.4067505320708;739.4712780361959;4678.836240731558;4698.8355407560575;4863.95136048635;4891.282744365391;4901.215805471179;131582;135778;137028;137205;139603;116346;117601.4119929395;118107.40946295386;118578;119093;60586;62260.68869655623;76472;97197;97504;8971.685990990283;9301.976782553778;9385.81228375415;9396.260407801694;9407.623695052394;47522;57621.711891440274;57638.7118064407;58325.416745832;59388;55353.44646553644;67587.3241267581;68933.65533172301;81744;81814.18185818066;12788.685177562948;12912.935435322763;13134.40895159701;13336.866631333562;13590.32048397596;15414.84585154179;15587.220638968232;15666.608334791721;15856.44502442409;16088.195590220208;14021.5092471763;14204.857951420354;14749.336279867646;14804.703905922037;14816.111033338035;14048;14376.424943002163;14586.416543338148;15030.398784048515;15051.247437628293;13432.19406835593;13641.181529108286;13835.239061851695;13952.302384880919;14217.360218790385;10966.232363734782;11436.783033125774;11533.942330288295;11638.655044576692;11962.58130965412;11120.221584489009;12066.818997715216;12248.38758062111;12350;12357 06:42:25 INFO - PROCESS | 3423 | __end_tp_report 06:42:25 INFO - PROCESS | 3423 | __start_cc_report 06:42:25 INFO - PROCESS | 3423 | _x_x_mozilla_cycle_collect,357 06:42:25 INFO - PROCESS | 3423 | __end_cc_report 06:42:25 INFO - PROCESS | 3423 | __startTimestamp1468244545364__endTimestamp 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | ------- Summary: start ------- 06:42:25 INFO - PROCESS | 3423 | Number of tests: 6 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | [#0] dojo.html Cycles:165 Average:5468.54 Median:5744.97 stddev:747.84 (13.0%) stddev-sans-first:726.67 06:42:25 INFO - PROCESS | 3423 | Values: 3099.2 3114.5 3134.3 3162.2 3167.0 5430.3 5506.6 5529.3 5543.2 5591.8 5411.4 5482.9 5490.9 5552.4 5571.4 4998.9 5027.2 5044.3 5102.7 5132.6 5005.8 5072.4 5126.5 5130.7 5193.0 666.1 4964.5 5070.7 5151.0 5151.5 5012.1 5027.5 5034.9 5069.6 5090.0 4984.5 4997.6 5000.2 5023.3 5023.5 5276.2 5378.4 5392.8 5513.3 5528.1 5828.2 5832.8 5850.7 5851.2 5911.2 5897.6 5905.5 5913.1 5931.0 5931.7 5388.6 5468.0 5503.0 5553.6 5563.1 5985.6 5990.4 6001.8 6012.0 6019.1 5709.5 5767.9 5769.3 5774.8 5782.0 5769.0 5885.6 5951.6 5975.6 6007.2 5928.0 5943.7 5967.4 5971.8 5972.3 5760.6 5982.7 5983.1 5985.9 5999.6 4345.9 4384.8 4437.9 4474.9 4486.0 3927.5 3961.0 3965.7 3977.1 4004.0 5481.0 5617.1 5632.1 5641.9 5682.7 5945.1 5992.6 6029.9 6041.8 6061.9 5688.0 5734.7 5741.1 5762.6 5766.0 4872.5 4932.7 5011.6 5015.8 5027.0 6091.3 6145.4 6177.3 6179.7 6182.9 5990.0 6017.1 6025.8 6031.5 6056.5 5978.2 6041.8 6081.0 6168.5 6181.8 5851.7 5858.4 5860.1 5875.3 5939.6 5928.1 5967.3 5969.2 6009.9 6024.3 5654.9 5766.8 5809.7 5813.3 5862.7 5833.6 5846.3 5849.9 5859.6 5868.7 5758.9 5765.8 5777.5 5778.4 5806.2 5645.8 5652.2 5693.7 5745.0 5822.4 5585.0 5611.9 5622.1 5689.5 5709.9 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | [#1] ext.html Cycles:180 Average:60666.88 Median:41327.48 stddev:129814.76 (314.1%) stddev-sans-first:130100.45 06:42:25 INFO - PROCESS | 3423 | Values: 549.4 607.6 608.3 608.5 647.4 37630.6 42249.0 42274.8 42335.2 42391.4 42246.6 42593.6 42680.6 42941.4 42981.0 8808.6 8966.2 8973.2 8973.6 8979.2 8841.8 8860.7 8895.4 8905.7 8951.5 8949.3 8959.1 8989.8 9020.3 9038.5 8930.8 8944.2 8956.6 8973.6 8993.8 8718.5 8778.9 8836.5 8841.7 8845.0 41404.0 41479.8 41508.8 41706.4 41836.2 2885.7 3341.5 3441.6 3620.5 4125.8 27977.6 29507.4 31600.4 32767.7 32804.8 4153.6 4179.0 4268.8 4284.9 4355.6 289652.0 290553.0 290885.0 291422.0 291934.0 34567.5 34642.7 34650.3 34651.5 34671.1 35221.6 35331.3 35614.8 37402.6 37575.0 15805.4 15899.9 15992.9 16000.0 16020.0 11837.6 11956.7 11993.2 12016.2 12018.0 18806.2 18835.2 18982.2 19035.8 19133.7 7132.5 7244.3 7265.6 7279.7 7506.0 983.6 1004.7 1108.3 1157.6 1171.3 33061.8 33126.8 33630.2 33690.0 33788.5 1125.3 1126.7 1153.6 1190.9 1218.4 16749.6 17260.4 17338.5 17370.7 17557.3 639178.0 639607.0 643272.0 643619.0 643926.0 57632.0 57878.1 57959.1 57973.0 58120.4 1307.8 1329.6 1363.4 1364.5 1367.7 31720.2 32422.5 32563.2 32805.8 33126.8 50131.0 50373.0 50456.7 50482.5 50741.0 457559.0 457622.0 459150.0 459452.0 460411.0 27504.2 27673.3 27719.3 27745.4 27867.9 47870.5 49105.8 49199.8 49250.0 49614.0 41320.2 41710.8 42063.8 42785.0 42987.6 40924.8 41334.8 41394.0 41502.4 42567.4 35476.8 35851.8 35880.6 39782.6 42353.6 30739.7 36549.5 37027.6 37177.8 37350.8 28418.9 28430.2 28610.6 28617.3 28837.4 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | [#2] jquery.html Cycles:180 Average:31323.46 Median:20270.49 stddev:91600.49 (451.9%) stddev-sans-first:91828.01 06:42:25 INFO - PROCESS | 3423 | Values: 393.6 396.7 397.7 403.5 420.4 14205.9 18777.0 18884.6 20785.4 20876.3 19102.9 19109.0 19505.0 19971.9 20164.3 5670.3 5684.8 5853.1 5858.4 5884.9 5396.7 5692.0 5740.1 5744.1 5775.5 5715.7 5722.1 5725.4 5732.1 5734.5 5388.3 5657.8 5683.4 5693.0 5728.4 5523.7 5530.8 5560.7 5580.1 5587.9 13568.0 13578.3 13605.5 18020.4 23228.8 2621.0 2678.2 2708.0 2727.3 2984.5 10041.2 10208.2 10478.2 12558.6 14138.6 1902.9 1915.9 1927.3 1950.2 1963.4 86313.0 87174.6 88009.0 89113.0 89487.0 10717.4 10932.3 11155.7 11243.5 11335.3 15339.0 15406.8 15456.5 15481.5 15623.5 7912.4 7986.2 8096.5 8195.0 8295.3 7371.4 7583.2 7735.0 7882.8 7888.3 4545.4 4565.4 4756.7 4763.4 4883.2 1860.9 1921.4 1930.0 1930.6 2003.1 1018.1 1031.8 1053.9 1055.0 1058.2 19213.9 19635.5 20122.0 20171.6 20369.4 977.5 995.7 1020.8 1057.8 1062.0 10758.9 11285.7 11310.4 11330.5 11406.0 545070.0 555151.0 556633.0 557830.0 564311.0 84285.0 92124.0 93169.5 107685.0 109638.5 1018.3 1020.2 1053.5 1058.6 1060.6 18311.7 18557.4 18967.6 19022.9 19277.3 34284.0 45633.8 46708.0 47469.5 47586.4 56697.0 57500.0 59229.4 66591.7 66916.7 7789.3 7870.3 7912.6 7990.1 8721.6 13204.2 13747.9 13887.4 14136.1 14315.9 12431.4 12466.6 12467.9 12622.2 12885.7 11812.4 12008.8 12053.6 12079.3 12445.3 12336.8 12409.3 12489.4 12581.8 12648.1 7497.5 7673.6 7766.5 7986.0 8425.3 11264.7 11573.0 12390.6 12691.2 12887.8 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | [#3] mootools.html Cycles:180 Average:5923.67 Median:4383.41 stddev:3486.72 (79.5%) stddev-sans-first:3480.47 06:42:25 INFO - PROCESS | 3423 | Values: 1474.0 1501.0 1605.8 1736.7 1749.1 8048.0 8591.6 8880.8 9187.1 9200.9 8867.5 9148.3 9220.1 9227.9 9234.6 2344.9 2360.4 2372.8 2378.5 2378.7 2337.4 2340.6 2395.9 2396.4 2399.4 2355.9 2362.3 2365.6 2375.9 2384.1 2324.2 2330.5 2342.7 2347.8 2366.1 2265.3 2280.2 2292.6 2296.9 2297.4 9152.9 9162.4 9170.3 9202.3 9240.3 4833.8 4915.8 5020.7 5021.3 5031.0 3252.8 3260.8 3286.5 3360.4 3378.0 1093.7 1118.1 1127.2 1129.9 1144.7 12835.9 12836.2 12902.0 12928.4 12944.2 4375.0 4391.8 4496.4 4561.7 4632.2 10734.1 10766.5 10819.1 10842.3 10867.5 5049.5 5055.3 5093.2 5099.0 5100.8 4219.7 4533.7 4634.7 4666.6 4671.6 3857.5 3944.7 3994.6 4035.6 4058.7 1290.7 1299.9 1303.8 1310.2 1332.3 924.6 931.0 945.9 947.2 956.2 5801.2 5885.0 5901.1 5906.1 6020.8 984.0 1000.3 1016.1 1065.0 1094.4 4041.8 4120.8 4122.0 4125.6 4138.1 11054.9 11535.8 11604.9 11609.8 11635.1 11414.0 11468.2 11474.7 11476.1 11512.5 8368.0 8456.2 8542.7 8644.4 8676.6 5625.8 5634.2 5768.8 5791.8 5839.9 10554.2 10628.4 10747.9 10777.8 10842.3 10752.7 10784.9 10880.1 11006.5 11061.4 7165.2 7448.4 7475.6 7588.1 7663.5 8852.2 8911.1 8916.4 8940.9 9020.2 7441.4 7629.6 7652.6 7691.1 7696.7 7766.4 7797.4 7860.6 8018.7 8041.4 7314.8 7387.8 7427.9 7482.5 7488.6 4876.9 4883.1 4946.8 5004.1 5091.7 5135.1 5160.9 5173.7 5208.3 5248.6 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | [#4] prototype.html Cycles:180 Average:4959.71 Median:5740.71 stddev:1493.61 (26.0%) stddev-sans-first:1456.39 06:42:25 INFO - PROCESS | 3423 | Values: 306.4 310.6 323.0 323.4 324.3 5651.4 5693.3 5739.2 5740.5 5748.2 5554.1 5622.2 5626.6 5632.6 5637.5 4156.0 4174.9 4299.1 4315.2 4318.2 4261.1 4262.9 4284.9 4287.4 4290.9 4248.2 4259.4 4266.4 4295.1 4320.9 4060.8 4284.2 4301.8 4303.6 4330.3 3721.2 3730.6 3739.4 3739.9 3748.8 5542.2 5555.2 5580.6 5580.9 5614.3 4883.2 4902.1 4923.5 4950.2 5016.4 5848.3 5890.8 5892.3 5916.2 5932.2 4116.2 4120.8 4124.0 4155.1 4156.6 6080.9 6155.8 6223.4 6236.2 6253.8 4219.0 4220.9 4236.3 4244.9 4248.8 4248.8 4269.6 4273.4 4287.3 4305.9 4753.6 4941.3 4950.6 4982.5 5001.4 5867.9 5938.3 5942.7 5980.1 6016.7 1446.2 1473.6 1480.7 1481.7 1492.3 921.5 933.6 980.6 985.4 991.0 5694.1 5715.1 5735.9 5740.9 5772.6 6014.1 6122.7 6152.4 6159.6 6184.6 5515.9 5704.3 5725.5 5766.9 5781.0 3236.6 3245.9 3262.8 3272.2 3274.0 6061.2 6140.8 6182.4 6270.0 6284.7 6108.4 6124.7 6151.8 6199.8 6212.9 5980.9 6211.4 6228.3 6237.9 6243.6 5990.4 6031.7 6078.9 6080.9 6094.4 5929.1 5959.4 6000.6 6005.5 6007.3 5973.3 6220.5 6223.5 6255.2 6284.7 4171.2 4200.6 4209.1 4218.5 4223.0 5846.6 6002.3 6072.2 6085.2 6148.6 5942.8 5955.6 5980.2 5988.5 5992.5 5752.1 5925.8 5948.7 5953.8 5971.1 5910.5 5913.8 5930.7 5931.8 5995.7 6048.7 6062.8 6064.9 6097.3 6113.3 5638.9 5886.4 5897.0 5900.3 5913.6 06:42:25 INFO - PROCESS | 3423 | 06:42:25 INFO - PROCESS | 3423 | [#5] yui.html Cycles:180 Average:22171.81 Median:3996.52 stddev:33512.07 (838.5%) stddev-sans-first:33567.47 06:42:25 INFO - PROCESS | 3423 | Values: 749.4 791.3 812.4 825.1 832.5 15312.6 16144.4 16590.6 16600.3 16847.5 15490.8 15612.6 15613.4 15627.8 15678.8 769.3 780.9 794.2 797.2 799.5 776.5 776.5 776.5 776.8 779.4 808.8 817.5 818.7 819.4 819.6 804.6 804.8 805.2 807.8 809.7 585.0 586.4 586.5 590.0 591.2 14983.3 15065.1 15111.6 15207.2 15240.0 15163.6 15170.2 15186.5 15206.6 15355.7 12538.0 12543.1 12584.7 12654.2 12671.2 3854.6 3894.7 3909.2 3991.0 4002.1 84651.6 84774.0 85952.1 86336.1 87326.1 10560.3 10797.5 11041.8 11361.8 11466.4 18675.7 18728.8 18774.6 18802.1 20501.7 8621.1 8635.0 8666.6 8700.1 8789.5 4821.8 4887.0 4925.1 4949.6 5200.3 3434.9 3586.8 3588.5 3590.6 3610.8 631.8 646.4 661.9 674.1 678.5 638.8 684.0 709.6 729.6 741.6 9797.5 9801.6 9891.9 10128.7 10175.2 720.7 723.6 724.8 732.4 739.5 4678.8 4698.8 4864.0 4891.3 4901.2 131582.0 135778.0 137028.0 137205.0 139603.0 116346.0 117601.4 118107.4 118578.0 119093.0 60586.0 62260.7 76472.0 97197.0 97504.0 8971.7 9302.0 9385.8 9396.3 9407.6 47522.0 57621.7 57638.7 58325.4 59388.0 55353.4 67587.3 68933.7 81744.0 81814.2 12788.7 12912.9 13134.4 13336.9 13590.3 15414.8 15587.2 15666.6 15856.4 16088.2 14021.5 14204.9 14749.3 14804.7 14816.1 14048.0 14376.4 14586.4 15030.4 15051.2 13432.2 13641.2 13835.2 13952.3 14217.4 10966.2 11436.8 11533.9 11638.7 11962.6 11120.2 12066.8 12248.4 12350.0 12357.0 06:42:25 INFO - PROCESS | 3423 | -------- Summary: end -------- 06:42:25 INFO - PROCESS | 3423 | 06:42:26 INFO - TEST-INFO | 3423: exit 0 06:42:26 INFO - TEST-OK | dromaeo_css | took 1113810ms 06:42:26 INFO - TEST-START | kraken 06:42:26 INFO - operating with platform_type : linux_ 06:42:26 INFO - Initialising browser for kraken test... 06:42:26 INFO - TEST-INFO | started process 3711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqA4ULP/profile http://localhost:47458/getInfo.html) 06:42:30 INFO - PROCESS | 3711 | __metrics Screen width/height:1600/1200 06:42:30 INFO - PROCESS | 3711 | colorDepth:24 06:42:30 INFO - PROCESS | 3711 | Browser inner width/height: 1024/697 06:42:30 INFO - PROCESS | 3711 | __metrics 06:42:31 ERROR - PROCESS | 3711 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 06:42:32 INFO - TEST-INFO | 3711: exit 0 06:42:32 INFO - Browser initialized. 06:42:32 INFO - Running cycle 1/1 for kraken test... 06:42:32 INFO - TEST-INFO | started process 3835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqA4ULP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:44 INFO - PROCESS | 3835 | RSS: Main: 168353792 06:42:44 INFO - PROCESS | 3835 | 06:42:46 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47458/tests/kraken/driver.html?testName=audio-beat-detection) 06:42:47 INFO - PROCESS | 3835 | RSS: Main: 173916160 06:42:47 INFO - PROCESS | 3835 | 06:42:50 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47458/tests/kraken/driver.html?testName=audio-dft) 06:42:50 INFO - PROCESS | 3835 | RSS: Main: 172662784 06:42:50 INFO - PROCESS | 3835 | 06:42:53 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47458/tests/kraken/driver.html?testName=audio-fft) 06:42:54 INFO - PROCESS | 3835 | RSS: Main: 167788544 06:42:54 INFO - PROCESS | 3835 | 06:42:56 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47458/tests/kraken/driver.html?testName=audio-oscillator) 06:42:57 INFO - PROCESS | 3835 | RSS: Main: 168030208 06:42:57 INFO - PROCESS | 3835 | 06:42:59 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47458/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:42:59 INFO - PROCESS | 3835 | RSS: Main: 168550400 06:42:59 INFO - PROCESS | 3835 | 06:43:02 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47458/tests/kraken/driver.html?testName=imaging-darkroom) 06:43:03 INFO - PROCESS | 3835 | RSS: Main: 168173568 06:43:03 INFO - PROCESS | 3835 | 06:43:07 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47458/tests/kraken/driver.html?testName=imaging-desaturate) 06:43:07 INFO - PROCESS | 3835 | RSS: Main: 166707200 06:43:07 INFO - PROCESS | 3835 | 06:43:10 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47458/tests/kraken/driver.html?testName=json-parse-financial) 06:43:11 INFO - PROCESS | 3835 | RSS: Main: 168292352 06:43:11 INFO - PROCESS | 3835 | 06:43:12 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47458/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:43:13 INFO - PROCESS | 3835 | RSS: Main: 168947712 06:43:13 INFO - PROCESS | 3835 | 06:43:15 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:43:15 INFO - PROCESS | 3835 | RSS: Main: 168632320 06:43:15 INFO - PROCESS | 3835 | 06:43:17 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:43:18 INFO - PROCESS | 3835 | RSS: Main: 169238528 06:43:18 INFO - PROCESS | 3835 | 06:43:21 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:21 INFO - PROCESS | 3835 | RSS: Main: 169578496 06:43:21 INFO - PROCESS | 3835 | 06:43:24 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:25 INFO - PROCESS | 3835 | RSS: Main: 169103360 06:43:25 INFO - PROCESS | 3835 | 06:43:26 INFO - PROCESS | 3835 | Cycle 1(1): loaded http://localhost:47458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47458/tests/kraken/driver.html?testName=ai-astar) 06:43:27 INFO - PROCESS | 3835 | RSS: Main: 169492480 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | __start_tp_report 06:43:27 INFO - PROCESS | 3835 | _x_x_mozilla_page_load 06:43:27 INFO - PROCESS | 3835 | _x_x_mozilla_page_load_details 06:43:27 INFO - PROCESS | 3835 | |i|pagename|runs| 06:43:27 INFO - PROCESS | 3835 | |0;ai-astar;101;110;107;112;121;113;113;112;113;110 06:43:27 INFO - PROCESS | 3835 | |1;audio-beat-detection;153;119;141;176;124;156;154;119;194;118 06:43:27 INFO - PROCESS | 3835 | |2;audio-dft;164;162;162;161;163;165;173;164;163;162 06:43:27 INFO - PROCESS | 3835 | |3;audio-fft;75;74;75;172;76;76;75;75;168;76 06:43:27 INFO - PROCESS | 3835 | |4;audio-oscillator;83;87;150;84;84;85;141;85;85;156 06:43:27 INFO - PROCESS | 3835 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;118;118 06:43:27 INFO - PROCESS | 3835 | |6;imaging-darkroom;147;147;147;147;147;147;148;147;147;147 06:43:27 INFO - PROCESS | 3835 | |7;imaging-desaturate;96;97;95;96;95;96;96;96;95;95 06:43:27 INFO - PROCESS | 3835 | |8;json-parse-financial;53;54;57;54;56;54;54;53;54;56 06:43:27 INFO - PROCESS | 3835 | |9;json-stringify-tinderbox;61;60;60;61;61;62;61;62;62;62 06:43:27 INFO - PROCESS | 3835 | |10;stanford-crypto-aes;77;81;76;75;76;74;75;75;86;75 06:43:27 INFO - PROCESS | 3835 | |11;stanford-crypto-ccm;127;122;121;139;125;130;134;136;167;126 06:43:27 INFO - PROCESS | 3835 | |12;stanford-crypto-pbkdf2;159;164;160;157;157;159;158;161;164;165 06:43:27 INFO - PROCESS | 3835 | |13;stanford-crypto-sha256-iterative;64;63;64;64;63;64;63;65;63;69 06:43:27 INFO - PROCESS | 3835 | __end_tp_report 06:43:27 INFO - PROCESS | 3835 | __start_cc_report 06:43:27 INFO - PROCESS | 3835 | _x_x_mozilla_cycle_collect,927 06:43:27 INFO - PROCESS | 3835 | __end_cc_report 06:43:27 INFO - PROCESS | 3835 | __startTimestamp1468244607058__endTimestamp 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | ------- Summary: start ------- 06:43:27 INFO - PROCESS | 3835 | Number of tests: 14 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:5.07 (4.5%) stddev-sans-first:3.81 06:43:27 INFO - PROCESS | 3835 | Values: 101.0 110.0 107.0 112.0 121.0 113.0 113.0 112.0 113.0 110.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:153.50 stddev:26.17 (17.0%) stddev-sans-first:27.61 06:43:27 INFO - PROCESS | 3835 | Values: 153.0 119.0 141.0 176.0 124.0 156.0 154.0 119.0 194.0 118.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.41 (2.1%) stddev-sans-first:3.62 06:43:27 INFO - PROCESS | 3835 | Values: 164.0 162.0 162.0 161.0 163.0 165.0 173.0 164.0 163.0 162.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:39.97 (53.3%) stddev-sans-first:41.78 06:43:27 INFO - PROCESS | 3835 | Values: 75.0 74.0 75.0 172.0 76.0 76.0 75.0 75.0 168.0 76.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:84.50 stddev:31.27 (37.0%) stddev-sans-first:32.23 06:43:27 INFO - PROCESS | 3835 | Values: 83.0 87.0 150.0 84.0 84.0 85.0 141.0 85.0 85.0 156.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:43:27 INFO - PROCESS | 3835 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:43:27 INFO - PROCESS | 3835 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:43:27 INFO - PROCESS | 3835 | Values: 96.0 97.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:1.35 (2.5%) stddev-sans-first:1.32 06:43:27 INFO - PROCESS | 3835 | Values: 53.0 54.0 57.0 54.0 56.0 54.0 54.0 53.0 54.0 56.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 06:43:27 INFO - PROCESS | 3835 | Values: 61.0 60.0 60.0 61.0 61.0 62.0 61.0 62.0 62.0 62.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:3.71 (4.9%) stddev-sans-first:3.94 06:43:27 INFO - PROCESS | 3835 | Values: 77.0 81.0 76.0 75.0 76.0 74.0 75.0 75.0 86.0 75.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:132.00 stddev:13.43 (10.2%) stddev-sans-first:14.09 06:43:27 INFO - PROCESS | 3835 | Values: 127.0 122.0 121.0 139.0 125.0 130.0 134.0 136.0 167.0 126.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:2.99 (1.9%) stddev-sans-first:3.13 06:43:27 INFO - PROCESS | 3835 | Values: 159.0 164.0 160.0 157.0 157.0 159.0 158.0 161.0 164.0 165.0 06:43:27 INFO - PROCESS | 3835 | 06:43:27 INFO - PROCESS | 3835 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.81 (2.8%) stddev-sans-first:1.92 06:43:27 INFO - PROCESS | 3835 | Values: 64.0 63.0 64.0 64.0 63.0 64.0 63.0 65.0 63.0 69.0 06:43:27 INFO - PROCESS | 3835 | -------- Summary: end -------- 06:43:27 INFO - PROCESS | 3835 | 06:43:28 INFO - TEST-INFO | 3835: exit 0 06:43:28 INFO - TEST-OK | kraken | took 61954ms 06:43:28 INFO - SUITE-END | took 1175s 06:43:28 INFO - Completed test suite (00:19:35) 06:43:28 INFO - javascript benchmark 06:43:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7378.92641039566, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.2097015261106, 3114.4705400081984, 3134.279115803366, 3162.177833763221, 3166.968330316696, 5430.294061771969, 5506.64206826556, 5529.253550770644, 5543.196236545698, 5591.797763480851, 5411.404745477994, 5482.890342193154, 5490.917636235459, 5552.361478429982, 5571.415001424853, 4998.925016124761, 5027.1956486962, 5044.344235249412, 5102.744862756866, 5132.615053870956, 5005.849824505252, 5072.365954255718, 5126.487351264881, 5130.692158470485, 5193.0, 666.0673987792541, 4964.503549645025, 5070.746462676888, 5150.9742451287875, 5151.484851514837, 5012.122878496285, 5027.547520723152, 5034.89930201394, 5069.619778516626, 5090.007448547534, 4984.476629953875, 4997.62517811162, 5000.224965130375, 5023.34696489454, 5023.497650234984, 5276.182191760283, 5378.435264297271, 5392.811251606175, 5513.283273174502, 5528.06022976095, 5828.184054232411, 5832.766689332421, 5850.6782126983, 5851.239338885917, 5911.172435858984, 5897.64614123154, 5905.468507834273, 5913.0539113742025, 5931.0, 5931.73307201177, 5388.649737767072, 5468.0, 5503.0, 5553.583481238923, 5563.13771365439, 5985.6408615483215, 5990.400959904062, 6001.789937352171, 6011.969940150271, 6019.127226552126, 5709.543236541067, 5767.942320576824, 5769.278840144982, 5774.769009239583, 5782.045962416239, 5768.971155144198, 5885.61743486672, 5951.613145145551, 5975.611585246945, 6007.219061521974, 5928.0, 5943.732532036069, 5967.373425790316, 5971.761129554856, 5972.313183983811, 5760.6255593386295, 5982.7307771149535, 5983.072623743326, 5985.850353741192, 5999.610025348426, 4345.869623911288, 4384.758838263926, 4437.933430998473, 4474.865754027384, 4485.955140448619, 3927.4697915781576, 3961.0, 3965.7025723070883, 3977.065389633434, 4004.0390306326854, 5481.0, 5617.073182924853, 5632.098864181711, 5641.943580564224, 5682.7442765075675, 5945.078512830518, 5992.580519363602, 6029.939700603026, 6041.758329666852, 6061.878762424815, 5688.0, 5734.713264336767, 5741.052726300114, 5762.596618236767, 5766.0, 4872.537108974641, 4932.704037757746, 5011.599072074226, 5015.84952451427, 5027.0, 6091.269047714214, 6145.4161854623735, 6177.2587289525545, 6179.721912513947, 6182.938170618326, 5990.010029691891, 6017.06735456005, 6025.78909738157, 6031.487323577545, 6056.454919057306, 5978.192943952685, 6041.818745437468, 6081.027035674271, 6168.506519478341, 6181.84545386351, 5851.707414629166, 5858.443447872616, 5860.120981852756, 5875.265591801025, 5939.554533409925, 5928.110783382527, 5967.283925928917, 5969.194158788681, 6009.909851352146, 6024.337322894566, 5654.886902261849, 5766.798162064308, 5809.738561764646, 5813.302403711582, 5862.67755273447, 5833.562482813891, 5846.298444186725, 5849.94150058494, 5859.648421094748, 5868.706564671664, 5758.8848223034465, 5765.798197063083, 5777.537796976148, 5778.422157784188, 5806.158107074535, 5645.774169033192, 5652.180433837153, 5693.715314234355, 5744.971275143597, 5822.359540450631, 5585.0, 5611.915821262766, 5622.100463925753, 5689.54483641316, 5709.885802284014], "value": 5418.172938269262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.3709702390763, 607.5534482155617, 608.2640005593232, 608.4706305514203, 647.3785166240409, 37630.62369376305, 42249.0, 42274.78862605686, 42335.15329693404, 42391.36412953801, 42246.57753422465, 42593.574064259345, 42680.57319426805, 42941.35587966183, 42981.0, 8808.603612837438, 8966.193042626162, 8973.192412682858, 8973.551322433885, 8979.236764874993, 8841.778955526132, 8860.734177974671, 8895.421797583169, 8905.73282801517, 8951.507667078307, 8949.328800339968, 8959.104089591054, 8989.77525561863, 9020.323475739313, 9038.502882341469, 8930.821383572356, 8944.195022447979, 8956.641734330618, 8973.641054357819, 8993.775155621097, 8718.520481373522, 8778.868316975251, 8836.469811811312, 8841.69054083104, 8845.027047024822, 41404.0, 41479.7926010368, 41508.79245603783, 41706.37440438396, 41836.1632767346, 2885.668148162967, 3341.498775183742, 3441.6214216436174, 3620.4931309616672, 4125.834966601333, 27977.580336294974, 29507.409851802844, 31600.36799264002, 32767.6723232767, 32804.835975819966, 4153.563875793058, 4178.979105104486, 4268.829246830123, 4284.9143017139795, 4355.629771469429, 289652.0, 290553.0, 290885.0, 291422.0, 291934.0, 34567.4814877777, 34642.65357346394, 34650.30699386049, 34651.4802277966, 34671.13322166966, 35221.64778352235, 35331.29337413289, 35614.8219258902, 37402.62597374046, 37575.0, 15805.446809361847, 15899.920500397424, 15992.92003539998, 16000.0, 16020.0, 11837.585684501, 11956.701082473008, 11993.220440671328, 12016.218945768496, 12018.0, 18806.247750089842, 18835.24659013624, 18982.196691314304, 19035.80964190368, 19133.712994305097, 7132.465065120136, 7244.311790379906, 7265.564066156047, 7279.745208917769, 7506.0, 983.6360546597662, 1004.7036124343336, 1108.296231892754, 1157.6353448663644, 1171.3499008050615, 33061.83469082639, 33126.834365828014, 33630.159246019044, 33690.0, 33788.49317260243, 1125.2517076144436, 1126.7014241226082, 1153.5695687752589, 1190.8809119088196, 1218.4456072486996, 16749.58126046834, 17260.395886143924, 17338.479845604652, 17370.652586948192, 17557.297708091788, 639178.0, 639607.0, 643272.0, 643619.0, 643926.0, 57632.0, 57878.131828021775, 57959.13061304084, 57973.0, 58120.418795812344, 1307.8169056332122, 1329.6077657091182, 1363.4069179906771, 1364.5087768403366, 1367.746966811143, 31720.206994825316, 32422.513662295558, 32563.185920351232, 32805.83597081999, 33126.834365828014, 50131.0, 50373.0, 50456.74771626118, 50482.49517504925, 50741.0, 457559.0, 457622.0, 459150.0, 459452.0, 460411.0, 27504.17487475379, 27673.256010416182, 27719.30701732473, 27745.445091098467, 27867.860660696566, 47870.52129478661, 49105.75447122742, 49199.75400122976, 49250.0, 49614.0, 41320.173596528504, 41710.791446042575, 42063.78968105262, 42785.0, 42987.57012429961, 40924.79537602293, 41334.79332603318, 41394.022076150315, 41502.377464338664, 42567.3614895783, 35476.822615886755, 35851.82074089613, 35880.64119358877, 39782.602173979045, 42353.57646423496, 30739.692603073683, 36549.45175822418, 37027.629723703496, 37177.81411092927, 37350.8132459336, 28418.857905710338, 28430.20878013772, 28610.57084143698, 28617.284567885137, 28837.37671154105], "value": 19506.806492231903, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.6181903553553, 396.69454520019565, 397.660000699402, 403.4754818735645, 420.36524847480297, 14205.857941420583, 18777.0, 18884.62230755384, 20785.376438706844, 20876.269330573414, 19102.90448547759, 19109.0, 19505.0, 19971.900140499314, 20164.294249701226, 5670.262865827437, 5684.801031963882, 5853.122031695238, 5858.414158584129, 5884.852878678046, 5396.703181325026, 5692.0, 5740.052891272935, 5744.138379243105, 5775.509081728037, 5715.71421428929, 5722.055860782966, 5725.427457254283, 5732.140178973145, 5734.480362703886, 5388.299521062257, 5657.830265092054, 5683.431656834325, 5693.0, 5728.369879313273, 5523.6685798852195, 5530.834074977757, 5560.7219639017885, 5580.051391263495, 5587.8603034924045, 13568.0, 13578.253196074213, 13605.455781768718, 18020.36928707502, 23228.767712322828, 2621.0040184729683, 2678.2233152385784, 2707.9729202707917, 2727.3045373429845, 2984.492636251821, 10041.19670426364, 10208.234382421273, 10478.21413393991, 12558.560450384193, 14138.646533836634, 1902.9143688533911, 1915.9233630654758, 1927.3158028899818, 1950.2101648832245, 1963.4011626453926, 86313.0, 87174.56412717959, 88009.0, 89113.0, 89487.0, 10717.35695858251, 10932.289401188897, 11155.72110697239, 11243.472503621397, 11335.319880807177, 15339.0, 15406.768898466533, 15456.536303910902, 15481.5355539334, 15623.531294061197, 7912.4065695073095, 7986.201379861967, 8096.473729207701, 8194.95937524648, 8295.294899933453, 7371.447141464411, 7583.165851756303, 7734.99445072137, 7882.842343153219, 7888.343447875895, 4545.36364908913, 4565.429321334833, 4756.6908150970075, 4763.380450646797, 4883.218685010382, 1860.8604354673182, 1921.41396873952, 1929.9807001930083, 1930.5752734398409, 2003.1386503803503, 1018.1345856022322, 1031.798799234142, 1053.9156867450586, 1055.0, 1058.2010582010687, 19213.903930480257, 19635.509112272306, 20122.0, 20171.596568068555, 20369.388918332475, 977.5405559387077, 995.7162208770466, 1020.8366661334151, 1057.7831544533353, 1062.044160255776, 10758.94620526908, 11285.71785705364, 11310.377929213808, 11330.546778128783, 11406.0, 545070.0, 555151.0, 556633.0, 557830.0, 564311.0, 84285.0, 92123.99999999866, 93169.53415232881, 107685.0, 109638.51807409758, 1018.3075508654039, 1020.2399212586819, 1053.5417093564324, 1058.571278632155, 1060.612876300145, 18311.72532411988, 18557.35049273269, 18967.620647586697, 19022.904885476037, 19277.325293614656, 34284.0, 45633.771831140635, 46708.0, 47469.52530474651, 47586.426636929515, 56697.0, 57500.0, 59229.40770592411, 66591.66704166448, 66916.66541667261, 7789.298963093349, 7870.29167374939, 7912.5648089353335, 7990.081140668897, 8721.604543273299, 13204.207747535178, 13747.862521374658, 13887.444502219798, 14136.08115472491, 14315.928420357832, 12431.440585173508, 12466.563670271496, 12467.875321247035, 12622.242665440102, 12885.677858053623, 11812.350320732443, 12008.759824803281, 12053.57812476559, 12079.335636540074, 12445.25328480294, 12336.75326493483, 12409.317487537912, 12489.439664868498, 12581.811272830731, 12648.114631975674, 7497.512661676974, 7673.616319183907, 7766.534007959541, 7985.960070199611, 8425.325973922194, 11264.747050590078, 11573.0, 12390.5663301784, 12691.238525688488, 12887.80668289995], "value": 9389.343874156722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.99263003685, 1500.9849901500984, 1605.831387704291, 1736.7394890766384, 1749.1079549429787, 8047.959760201191, 8591.613377398016, 8880.777980550489, 9187.127222913829, 9200.907990920097, 8867.512286824238, 9148.268138548916, 9220.077992200793, 9227.861582076273, 9234.630614775419, 2344.8944797484155, 2360.409897525619, 2372.7745864142967, 2378.4648454097864, 2378.7383387827326, 2337.392278007722, 2340.6489026646054, 2395.8921848516857, 2396.4488167721433, 2399.4121440247163, 2355.9175428859994, 2362.338545207336, 2365.5860224460735, 2375.857448553092, 2384.0940442631777, 2324.2213858357472, 2330.5338932213454, 2342.6954495915506, 2347.8473899196583, 2366.077229880348, 2265.3317271404812, 2280.1791355112146, 2292.587334279829, 2296.8851557422063, 2297.3911913342977, 9152.908470915272, 9162.404443711137, 9170.312226582966, 9202.30982676302, 9240.26077913772, 4833.830815921461, 4915.827946021872, 5020.723860187688, 5021.271915572222, 5031.0, 3252.788568743024, 3260.8043517388796, 3286.4905939579403, 3360.4287271163716, 3378.0372593810894, 1093.710679649238, 1118.1390329446363, 1127.1940562497853, 1129.9152563557766, 1144.7252659361693, 12835.87164128356, 12836.229826210363, 12902.0, 12928.35358232094, 12944.223346599234, 4375.0, 4391.824327026947, 4496.437945256843, 4561.69991552406, 4632.2125238709505, 10734.141268698486, 10766.515506802212, 10819.080378167786, 10842.349459032483, 10867.510962006729, 5049.495050494995, 5055.292259083732, 5093.2105523643895, 5098.97450512745, 5100.846974590768, 4219.662427005832, 4533.682642215079, 4634.745089020136, 4666.580007799314, 4671.649626278043, 3857.537095548496, 3944.6647035001774, 3994.6404823566018, 4035.596440355941, 4058.6955978301744, 1290.7160424706549, 1299.9025073119553, 1303.7718399280088, 1310.2073245686413, 1332.2672530108402, 924.5793164110314, 930.9627614895328, 945.9479728614992, 947.1664934857281, 956.2493442647489, 5801.187833703285, 5885.0, 5901.0558310670085, 5906.143609176731, 6020.789272375446, 983.9704808855746, 1000.284796370584, 1016.0804471952747, 1065.041462683591, 1094.4035500652165, 4041.777702226347, 4120.835166593362, 4122.0, 4125.566815484391, 4138.089620283533, 11054.944725276482, 11535.826962595567, 11604.88395116055, 11609.76780464386, 11635.069194464422, 11414.029807466291, 11468.197226194254, 11474.713132171762, 11476.081913446904, 11512.539498420138, 8368.0, 8456.150265463115, 8542.658293668184, 8644.3948923576, 8676.566171691391, 5625.831225063254, 5634.183043458594, 5768.826935191951, 5791.7683292667825, 5839.854003649943, 10554.2084343673, 10628.36229826182, 10747.89252107469, 10777.838332424863, 10842.349459032483, 10752.731181720206, 10784.946075269574, 10880.075193608316, 11006.504707288032, 11061.391623460466, 7165.211826699163, 7448.441366897613, 7475.588842613708, 7588.051493563305, 7663.463557550918, 8852.159044890725, 8911.108889111038, 8916.375853690179, 8940.910590894007, 9020.233280171258, 7441.367483763941, 7629.580373079534, 7652.617369131633, 7691.077070751546, 7696.653650585849, 7766.378689704923, 7797.376209903081, 7860.646270917708, 8018.679252829821, 8041.356691464785, 7314.838786768299, 7387.7783666490095, 7427.925720742724, 7482.476226664081, 7488.625568721433, 4876.878078047936, 4883.121038213156, 4946.837493189169, 5004.074246264453, 5091.745412729423, 5135.10135726239, 5160.870978225575, 5173.741312934413, 5208.348956380452, 5248.580113590827], "value": 4702.509883679848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.3551224672065, 310.5528039622944, 322.9547863299137, 323.40493491974775, 324.3205484509954, 5651.434856514346, 5693.345265294482, 5739.196512488255, 5740.540756739461, 5748.166515855204, 5554.139363313295, 5622.156676498527, 5626.578006649497, 5632.633878797876, 5637.520810731093, 4156.0, 4174.937375939348, 4299.140171965604, 4315.180115778008, 4318.2227199104145, 4261.126469073848, 4262.934266433392, 4284.871453856389, 4287.378330142127, 4290.935635965448, 4248.192843359767, 4259.382389553512, 4266.445362102922, 4295.119500502406, 4320.913581728363, 4060.8375664973364, 4284.207421627009, 4301.773669747689, 4303.569643035703, 4330.307150855863, 3721.237146385012, 3730.570984336809, 3739.383001804699, 3739.887803365876, 3748.775073495599, 5542.196381524696, 5555.194496797982, 5580.63725857822, 5580.939621471948, 5614.326280846284, 4883.1698611235815, 4902.142125128088, 4923.483034281385, 4950.158473059589, 5016.423111342206, 5848.2689663792025, 5890.764369425217, 5892.322382925976, 5916.230889984275, 5932.249986254065, 4116.23002109093, 4120.814563344657, 4123.999860067865, 4155.127423241123, 4156.56356082613, 6080.939190608082, 6155.784547540859, 6223.43989040984, 6236.18929539157, 6253.8117757625905, 4219.0, 4220.873373798791, 4236.343366778093, 4244.893877653083, 4248.808803603845, 4248.808803603783, 4269.637080848101, 4273.358996150602, 4287.292596721506, 4305.935410968838, 4753.572178503882, 4941.308216849644, 4950.603951683856, 4982.476839931827, 5001.399832020108, 5867.911981320283, 5938.28740551128, 5942.673152976541, 5980.102984552352, 6016.736485338128, 1446.197360464952, 1473.6315921019745, 1480.7487672916368, 1481.6592183797786, 1492.3135357735564, 921.4609453469795, 933.641551542504, 980.5734505490135, 985.4383001688968, 990.9603615855285, 5694.060480020833, 5715.114157305624, 5735.942640573624, 5740.880528296942, 5772.5959182856795, 6014.105556749697, 6122.66325352101, 6152.446279834747, 6159.599626024294, 6184.5980011299125, 5515.889682206413, 5704.286964129484, 5725.456081672234, 5766.855828604234, 5780.971095144498, 3236.579244698174, 3245.918852028718, 3262.820544870055, 3272.214668479548, 3273.9508907366408, 6061.212042434543, 6140.78507252253, 6182.443580077725, 6269.965455699758, 6284.70053222053, 6108.358622344679, 6124.724387402578, 6151.7539298428455, 6199.752009919553, 6212.9068063979075, 5980.910286345796, 6211.378862113753, 6228.34602366754, 6237.937620623827, 6243.625382477066, 5990.430909063632, 6031.668258245663, 6078.90881636767, 6080.939190608037, 6094.360092190256, 5929.094743575703, 5959.433853783884, 6000.5799594028, 6005.519558435228, 6007.309159446545, 5973.253343332083, 6220.4759833841, 6223.533235007483, 6255.155554000334, 6284.654344011124, 4171.249175148502, 4200.613797446774, 4209.053662436368, 4218.502431636724, 4223.049813791872, 5846.590738648254, 6002.339742628395, 6072.180255665428, 6085.2393450818645, 6148.600340977822, 5942.7817297454785, 5955.570663040926, 5980.222571065734, 5988.520918326611, 5992.490638295793, 5752.07966725322, 5925.762969481172, 5948.672822994777, 5953.761849526144, 5971.134185543159, 5910.527157827278, 5913.763449461973, 5930.703464826827, 5931.822045338647, 5995.670238136944, 6048.7278072487725, 6062.787802426894, 6064.9393506066135, 6097.298810636834, 6113.327533971348, 5638.887222255614, 5886.352501224947, 5897.0, 5900.291964964232, 5913.645181289136], "value": 4469.741903857731, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.3892477630731, 791.3234184772018, 812.3907069697726, 825.1088824070004, 832.4547421438959, 15312.617184570378, 16144.434944776935, 16590.585235369123, 16600.25298861551, 16847.49457516275, 15490.767638485431, 15612.609684757886, 15613.375464981387, 15627.765583516228, 15678.84321156788, 769.3114662377183, 780.8906753054576, 794.1700922535935, 797.2426195114635, 799.460364254129, 776.5069181070033, 776.5340795522669, 776.5340795522698, 776.763087258386, 779.4465929190281, 808.8382323535287, 817.464560712734, 818.7298191596759, 819.4264015189391, 819.6065888373585, 804.5816175588719, 804.8350088231898, 805.1626308639009, 807.7617102954642, 809.7004108479871, 584.9649021058708, 586.3960121075299, 586.5395664403422, 589.9587028907978, 591.1516973143509, 14983.250837458083, 15065.09609423438, 15111.622209444851, 15207.239638018054, 15240.0, 15163.62090947724, 15170.24148792556, 15186.46847360337, 15206.619834504116, 15355.692886142326, 12538.0, 12543.121981461301, 12584.68538286541, 12654.240745555297, 12671.239725616493, 3854.6266484584517, 3894.6563435614667, 3909.1790723948006, 3990.980045099785, 4002.0595160137345, 84651.5767421159, 84774.0, 85952.14047859567, 86336.13663863344, 87326.12673873243, 10560.260781745204, 10797.514111864828, 11041.779164416826, 11361.772764544663, 11466.369349685847, 18675.71986420205, 18728.812711872706, 18774.624507509772, 18802.059897005096, 20501.692474612595, 8621.137886211454, 8634.956825215833, 8666.6100025499, 8700.12998700125, 8789.472631642122, 4821.807127714922, 4886.975565122151, 4925.064237794808, 4949.628777841676, 5200.323957885451, 3434.914127146841, 3586.8385922633543, 3588.5334906461994, 3590.5870824855474, 3610.7833529988284, 631.7536160897254, 646.3988490703691, 661.8709351676473, 674.1371045062328, 678.4538446550475, 638.8115505925763, 683.9589624622539, 709.5707097206116, 729.5622626424209, 741.5773009384599, 9797.510124493747, 9801.607935682636, 9891.851622225673, 10128.696139115838, 10175.236857235588, 720.661289194078, 723.6128671160903, 724.7861880745193, 732.4067505320708, 739.4712780361959, 4678.836240731558, 4698.8355407560575, 4863.95136048635, 4891.282744365391, 4901.215805471179, 131582.0, 135778.0, 137028.0, 137205.0, 139603.0, 116346.0, 117601.4119929395, 118107.40946295386, 118578.0, 119093.0, 60586.0, 62260.68869655623, 76472.0, 97197.0, 97504.0, 8971.685990990283, 9301.976782553778, 9385.81228375415, 9396.260407801694, 9407.623695052394, 47522.0, 57621.711891440274, 57638.7118064407, 58325.416745832, 59388.0, 55353.44646553644, 67587.3241267581, 68933.65533172301, 81744.0, 81814.18185818066, 12788.685177562948, 12912.935435322763, 13134.40895159701, 13336.866631333562, 13590.32048397596, 15414.84585154179, 15587.220638968232, 15666.608334791721, 15856.44502442409, 16088.195590220208, 14021.5092471763, 14204.857951420354, 14749.336279867646, 14804.703905922037, 14816.111033338035, 14048.0, 14376.424943002163, 14586.416543338148, 15030.398784048515, 15051.247437628293, 13432.19406835593, 13641.181529108286, 13835.239061851695, 13952.302384880919, 14217.360218790385, 10966.232363734782, 11436.783033125774, 11533.942330288295, 11638.655044576692, 11962.58130965412, 11120.221584489009, 12066.818997715216, 12248.38758062111, 12350.0, 12357.0], "value": 7738.048739183285, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 107.0, 112.0, 121.0, 113.0, 113.0, 112.0, 113.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 141.0, 176.0, 124.0, 156.0, 154.0, 119.0, 194.0, 118.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 161.0, 163.0, 165.0, 173.0, 164.0, 163.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 172.0, 76.0, 76.0, 75.0, 75.0, 168.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 150.0, 84.0, 84.0, 85.0, 141.0, 85.0, 85.0, 156.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 57.0, 54.0, 56.0, 54.0, 54.0, 53.0, 54.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 75.0, 76.0, 74.0, 75.0, 75.0, 86.0, 75.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 121.0, 139.0, 125.0, 130.0, 134.0, 136.0, 167.0, 126.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 164.0, 160.0, 157.0, 157.0, 159.0, 158.0, 161.0, 164.0, 165.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 65.0, 63.0, 69.0], "value": 64.2, "unit": "score"}]}]} 06:43:28 INFO - Return code: 0 06:43:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:43:28 ERROR - # TBPL SUCCESS # 06:43:28 INFO - Running post-action listener: _resource_record_post_action 06:43:28 INFO - ##### 06:43:28 INFO - ##### Finished run-tests step (success) 06:43:28 INFO - ##### 06:43:28 INFO - Running post-run listener: _resource_record_post_run 06:43:28 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 10067968; Write bytes: 308957184; Read time: 2264; Write time: 217612 06:43:28 INFO - TinderboxPrint: CPU usage
13.3% 06:43:28 INFO - TinderboxPrint: I/O read bytes / time
10,067,968 / 2,264 06:43:28 INFO - TinderboxPrint: I/O write bytes / time
308,957,184 / 217,612 06:43:28 INFO - TinderboxPrint: CPU idle
8,249.1 (86.7%) 06:43:28 INFO - TinderboxPrint: CPU user
1,210.8 (12.7%) 06:43:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:43:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 16429056; Read time: 0; Write time: 19304 06:43:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 7831552; Write bytes: 292528128; Read time: 2040; Write time: 198308 06:43:28 INFO - Running post-run listener: _upload_blobber_files 06:43:28 INFO - Blob upload gear active. 06:43:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:43:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:43:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:30 INFO - (blobuploader) - INFO - Done attempting. 06:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:34 INFO - (blobuploader) - INFO - Done attempting. 06:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:35 INFO - (blobuploader) - INFO - Done attempting. 06:43:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:43:35 INFO - Return code: 0 06:43:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:43:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:43:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af4cb4f0665fc7202c3ca5db30521ff87e9622a987ba8b7a4652c6b7ae9e2cd5b14e606c8f5625d18f9113c6036a73db4956826267be9537ae08bec94468630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfa98de09c77c1482a7852a72d09666cca3eaa1550d23cea1a57f618d4bbb5020c10b4a64469e0d0724521c46345ee1768add487bdfb2bac4d0799fa491bac9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c794ffc6721c5c200d856739af59718e67c421eab59e54288df1e5dcf218f28b35a015f26a9a8627a9bb6cc6e571336b2ed48f063ebb27054f5ad5b85413c7d"} 06:43:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:43:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:43:35 INFO - Contents: 06:43:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af4cb4f0665fc7202c3ca5db30521ff87e9622a987ba8b7a4652c6b7ae9e2cd5b14e606c8f5625d18f9113c6036a73db4956826267be9537ae08bec94468630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfa98de09c77c1482a7852a72d09666cca3eaa1550d23cea1a57f618d4bbb5020c10b4a64469e0d0724521c46345ee1768add487bdfb2bac4d0799fa491bac9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c794ffc6721c5c200d856739af59718e67c421eab59e54288df1e5dcf218f28b35a015f26a9a8627a9bb6cc6e571336b2ed48f063ebb27054f5ad5b85413c7d"} 06:43:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:43:35 INFO - Copying logs to upload dir... 06:43:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:43:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.679302 ========= master_lag: 0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-11 06:43:35.210060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:43:35.214001) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af4cb4f0665fc7202c3ca5db30521ff87e9622a987ba8b7a4652c6b7ae9e2cd5b14e606c8f5625d18f9113c6036a73db4956826267be9537ae08bec94468630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfa98de09c77c1482a7852a72d09666cca3eaa1550d23cea1a57f618d4bbb5020c10b4a64469e0d0724521c46345ee1768add487bdfb2bac4d0799fa491bac9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c794ffc6721c5c200d856739af59718e67c421eab59e54288df1e5dcf218f28b35a015f26a9a8627a9bb6cc6e571336b2ed48f063ebb27054f5ad5b85413c7d"} build_url:https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/dRwDv9bRSZausWBAzUnFzA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8af4cb4f0665fc7202c3ca5db30521ff87e9622a987ba8b7a4652c6b7ae9e2cd5b14e606c8f5625d18f9113c6036a73db4956826267be9537ae08bec94468630", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfa98de09c77c1482a7852a72d09666cca3eaa1550d23cea1a57f618d4bbb5020c10b4a64469e0d0724521c46345ee1768add487bdfb2bac4d0799fa491bac9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c794ffc6721c5c200d856739af59718e67c421eab59e54288df1e5dcf218f28b35a015f26a9a8627a9bb6cc6e571336b2ed48f063ebb27054f5ad5b85413c7d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 06:43:35.239842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:43:35.240262) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1468243368.932274-2030265181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 06:43:35.325139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:43:35.325580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 06:43:35.325942) ========= ========= Total master_lag: 0.55 =========