builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1467907332.4 results: success (0) buildid: 20160707082722 builduid: e66344b6701b424499d55f672a9873c8 revision: e2f5a7c70b47be82f2a8f85cac59482c8f77550a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.405727) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.406775) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.407544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.444863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.445229) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 09:02:12-- 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% 103M=0s 2016-07-07 09:02:12 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.615288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.615624) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019135 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:12.665514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 09:02:12.665900) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e2f5a7c70b47be82f2a8f85cac59482c8f77550a --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 e2f5a7c70b47be82f2a8f85cac59482c8f77550a --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=516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 09:02:13,041 truncating revision to first 12 chars 2016-07-07 09:02:13,041 Setting DEBUG logging. 2016-07-07 09:02:13,041 attempt 1/10 2016-07-07 09:02:13,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e2f5a7c70b47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 09:02:13,579 unpacking tar archive at: fx-team-e2f5a7c70b47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.150138 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 09:02:13.830388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:13.830735) ========= script_repo_revision: e2f5a7c70b47be82f2a8f85cac59482c8f77550a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:13.831133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:13.831438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 09:02:13.850349) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-07 09:02:13.850635) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:02:14 INFO - MultiFileLogger online at 20160707 09:02:14 in /builds/slave/test 09:02:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:02:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:02:14 INFO - {'append_to_log': False, 09:02:14 INFO - 'base_work_dir': '/builds/slave/test', 09:02:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:02:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:02:14 INFO - 'branch': 'Fx-Team-Non-PGO', 09:02:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:02:14 INFO - 'config_files': ('talos/linux_config.py',), 09:02:14 INFO - 'default_actions': ('clobber', 09:02:14 INFO - 'read-buildbot-config', 09:02:14 INFO - 'download-and-extract', 09:02:14 INFO - 'populate-webroot', 09:02:14 INFO - 'create-virtualenv', 09:02:14 INFO - 'install', 09:02:14 INFO - 'run-tests'), 09:02:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:02:14 INFO - 'download_minidump_stackwalk': True, 09:02:14 INFO - 'download_symbols': 'ondemand', 09:02:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:02:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:02:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:02:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:02:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:02:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:02:14 INFO - 'installer_path': 'installer.exe', 09:02:14 INFO - 'log_level': 'info', 09:02:14 INFO - 'log_name': 'talos', 09:02:14 INFO - 'log_to_console': True, 09:02:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:02:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:02:14 INFO - 'opt_config_files': (), 09:02:14 INFO - 'pip_index': False, 09:02:14 INFO - 'sps_profile': False, 09:02:14 INFO - 'sps_profile_interval': 0, 09:02:14 INFO - 'suite': 'dromaeojs-e10s', 09:02:14 INFO - 'system_bits': '32', 09:02:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:02:14 INFO - 'title': 'talos-linux64-ix-061', 09:02:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:02:14 INFO - 'use_talos_json': True, 09:02:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:02:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:02:14 INFO - 'work_dir': 'build'} 09:02:14 INFO - ##### 09:02:14 INFO - ##### Running clobber step. 09:02:14 INFO - ##### 09:02:14 INFO - Running pre-action listener: _resource_record_pre_action 09:02:14 INFO - Running main action method: clobber 09:02:14 INFO - rmtree: /builds/slave/test/build 09:02:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:02:14 INFO - Running post-action listener: _resource_record_post_action 09:02:14 INFO - ##### 09:02:14 INFO - ##### Finished clobber step (success) 09:02:14 INFO - ##### 09:02:14 INFO - ##### 09:02:14 INFO - ##### Running read-buildbot-config step. 09:02:14 INFO - ##### 09:02:14 INFO - Running pre-action listener: _resource_record_pre_action 09:02:14 INFO - Running main action method: read_buildbot_config 09:02:14 INFO - Using buildbot properties: 09:02:14 INFO - { 09:02:14 INFO - "project": "", 09:02:14 INFO - "product": "firefox", 09:02:14 INFO - "script_repo_revision": "production", 09:02:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:02:14 INFO - "repository": "", 09:02:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:02:14 INFO - "buildid": "20160707082722", 09:02:14 INFO - "pgo_build": "False", 09:02:14 INFO - "basedir": "/builds/slave/test", 09:02:14 INFO - "buildnumber": 1468, 09:02:14 INFO - "slavename": "talos-linux64-ix-061", 09:02:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:02:14 INFO - "platform": "ubuntu64_hw", 09:02:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:02:14 INFO - "branch": "fx-team", 09:02:14 INFO - "repo_path": "integration/fx-team", 09:02:14 INFO - "revision": "e2f5a7c70b47be82f2a8f85cac59482c8f77550a", 09:02:14 INFO - "stage_platform": "linux64", 09:02:14 INFO - "builduid": "e66344b6701b424499d55f672a9873c8", 09:02:14 INFO - "slavebuilddir": "test" 09:02:14 INFO - } 09:02:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:02:14 INFO - Running post-action listener: _resource_record_post_action 09:02:14 INFO - ##### 09:02:14 INFO - ##### Finished read-buildbot-config step (success) 09:02:14 INFO - ##### 09:02:14 INFO - ##### 09:02:14 INFO - ##### Running download-and-extract step. 09:02:14 INFO - ##### 09:02:14 INFO - Running pre-action listener: _resource_record_pre_action 09:02:14 INFO - Running main action method: download_and_extract 09:02:14 INFO - mkdir: /builds/slave/test/build/tests 09:02:14 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')]} 09:02:14 INFO - https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:02:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:02:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:02:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:17 INFO - Downloaded 1361 bytes. 09:02:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:02:17 INFO - Using the following test package requirements: 09:02:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:02:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:02:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:02:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'jsshell-linux-x86_64.zip'], 09:02:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:02:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:02:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:02:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:02:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:02:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:02:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:02:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:17 INFO - https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:02:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:02:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:02:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:26 INFO - Downloaded 22734517 bytes. 09:02:26 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'] 09:02:26 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 09:02:27 INFO - Return code: 0 09:02:27 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 09:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:27 INFO - https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:40 INFO - Downloaded 22734517 bytes. 09:02:40 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'] 09:02:40 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 09:02:41 INFO - Return code: 0 09:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:41 INFO - https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:43 INFO - Downloaded 14403333 bytes. 09:02:43 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'] 09:02:43 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 09:02:43 INFO - Return code: 0 09:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:43 INFO - https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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 09:02:44 INFO - Downloaded 56643725 bytes. 09:02:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:02:44 INFO - mkdir: /builds/slave/test/properties 09:02:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:02:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:02:44 INFO - Contents: 09:02:44 INFO - build_url:https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:02:45 INFO - Running post-action listener: _resource_record_post_action 09:02:45 INFO - Running post-action listener: set_extra_try_arguments 09:02:45 INFO - ##### 09:02:45 INFO - ##### Finished download-and-extract step (success) 09:02:45 INFO - ##### 09:02:45 INFO - ##### 09:02:45 INFO - ##### Running populate-webroot step. 09:02:45 INFO - ##### 09:02:45 INFO - Running pre-action listener: _resource_record_pre_action 09:02:45 INFO - Running main action method: populate_webroot 09:02:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:02:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:02:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:02:45 INFO - '--tppagecycles', 09:02:45 INFO - '7'], 09:02:45 INFO - 'tests': ['tsvgm']}}, 09:02:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:02:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:02:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:02:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:02:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['damp', 'tps']}, 09:02:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'tests': ['damp', 'tps']}, 09:02:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['dromaeo_dom']}, 09:02:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:02:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['basic_compositor_video']}, 09:02:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:02:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['a11yr', 09:02:45 INFO - 'ts_paint', 09:02:45 INFO - 'tpaint', 09:02:45 INFO - 'sessionrestore', 09:02:45 INFO - 'sessionrestore_no_auto_restore', 09:02:45 INFO - 'tabpaint']}, 09:02:45 INFO - 'other-e10s': {'tests': ['a11yr', 09:02:45 INFO - 'ts_paint', 09:02:45 INFO - 'tpaint', 09:02:45 INFO - 'sessionrestore', 09:02:45 INFO - 'sessionrestore_no_auto_restore', 09:02:45 INFO - 'tabpaint']}, 09:02:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:02:45 INFO - 'ts_paint', 09:02:45 INFO - 'tpaint', 09:02:45 INFO - 'sessionrestore', 09:02:45 INFO - 'sessionrestore_no_auto_restore', 09:02:45 INFO - 'tabpaint']}, 09:02:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:02:45 INFO - 'ts_paint', 09:02:45 INFO - 'tpaint', 09:02:45 INFO - 'sessionrestore', 09:02:45 INFO - 'sessionrestore_no_auto_restore', 09:02:45 INFO - 'tabpaint']}, 09:02:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['a11yr', 09:02:45 INFO - 'ts_paint', 09:02:45 INFO - 'tpaint', 09:02:45 INFO - 'sessionrestore', 09:02:45 INFO - 'sessionrestore_no_auto_restore', 09:02:45 INFO - 'tabpaint']}, 09:02:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['a11yr', 09:02:45 INFO - 'ts_paint', 09:02:45 INFO - 'tpaint', 09:02:45 INFO - 'sessionrestore', 09:02:45 INFO - 'sessionrestore_no_auto_restore', 09:02:45 INFO - 'tabpaint']}, 09:02:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['tsvgx', 09:02:45 INFO - 'tsvgr_opacity', 09:02:45 INFO - 'tart', 09:02:45 INFO - 'tscrollx', 09:02:45 INFO - 'cart']}, 09:02:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:02:45 INFO - 'tsvgr_opacity', 09:02:45 INFO - 'tart', 09:02:45 INFO - 'tscrollx', 09:02:45 INFO - 'cart']}, 09:02:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'talos_options': ['--disable-e10s'], 09:02:45 INFO - 'tests': ['tp5o']}, 09:02:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'tests': ['tp5o']}, 09:02:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'talos_options': ['--disable-e10s', 09:02:45 INFO - '--xperf_path', 09:02:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:45 INFO - 'tests': ['tp5n']}, 09:02:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:45 INFO - 'talos_options': ['--xperf_path', 09:02:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:45 INFO - 'tests': ['tp5n']}}, 09:02:45 INFO - 'talos.zip': {'path': '', 09:02:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:02:45 INFO - Running post-action listener: _resource_record_post_action 09:02:45 INFO - ##### 09:02:45 INFO - ##### Finished populate-webroot step (success) 09:02:45 INFO - ##### 09:02:45 INFO - ##### 09:02:45 INFO - ##### Running create-virtualenv step. 09:02:45 INFO - ##### 09:02:45 INFO - Running pre-action listener: _resource_record_pre_action 09:02:45 INFO - Running main action method: create_virtualenv 09:02:45 INFO - Creating virtualenv /builds/slave/test/build/venv 09:02:45 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 09:02:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:02:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:02:45 INFO - Using real prefix '/usr' 09:02:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:02:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:02:48 INFO - Installing pip.................done. 09:02:48 INFO - Return code: 0 09:02:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:48 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:02:48 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 09:02:48 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 09:02:48 INFO - Using env: {'DISPLAY': ':0', 09:02:48 INFO - 'HOME': '/home/cltbld', 09:02:48 INFO - 'LANG': 'en_US.UTF-8', 09:02:48 INFO - 'LANGUAGE': 'en_US:en', 09:02:48 INFO - 'LOGNAME': 'cltbld', 09:02:48 INFO - 'MAIL': '/var/mail/cltbld', 09:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:48 INFO - 'MOZ_NO_REMOTE': '1', 09:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:48 INFO - 'NO_EM_RESTART': '1', 09:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:48 INFO - 'PWD': '/builds/slave/test', 09:02:48 INFO - 'SHELL': '/bin/bash', 09:02:48 INFO - 'SHLVL': '1', 09:02:48 INFO - 'TERM': 'linux', 09:02:48 INFO - 'TMOUT': '86400', 09:02:48 INFO - 'USER': 'cltbld', 09:02:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:48 INFO - '_': '/tools/buildbot/bin/python'} 09:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:48 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 09:02:48 INFO - Cleaning up... 09:02:48 INFO - Return code: 0 09:02:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:48 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:02:48 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 09:02:48 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 09:02:48 INFO - Using env: {'DISPLAY': ':0', 09:02:48 INFO - 'HOME': '/home/cltbld', 09:02:48 INFO - 'LANG': 'en_US.UTF-8', 09:02:48 INFO - 'LANGUAGE': 'en_US:en', 09:02:48 INFO - 'LOGNAME': 'cltbld', 09:02:48 INFO - 'MAIL': '/var/mail/cltbld', 09:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:48 INFO - 'MOZ_NO_REMOTE': '1', 09:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:48 INFO - 'NO_EM_RESTART': '1', 09:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:48 INFO - 'PWD': '/builds/slave/test', 09:02:48 INFO - 'SHELL': '/bin/bash', 09:02:48 INFO - 'SHLVL': '1', 09:02:48 INFO - 'TERM': 'linux', 09:02:48 INFO - 'TMOUT': '86400', 09:02:48 INFO - 'USER': 'cltbld', 09:02:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:48 INFO - '_': '/tools/buildbot/bin/python'} 09:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:48 INFO - Downloading/unpacking psutil>=3.1.1 09:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:02:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:50 INFO - Installing collected packages: psutil 09:02:50 INFO - Running setup.py install for psutil 09:02:50 INFO - building 'psutil._psutil_linux' extension 09:02:50 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 09:02:50 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 09:02:50 INFO - building 'psutil._psutil_posix' extension 09:02:50 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 09:02:50 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 09:02:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:50 INFO - Successfully installed psutil 09:02:50 INFO - Cleaning up... 09:02:50 INFO - Return code: 0 09:02:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:02:50 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')]} 09:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:50 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')]} 09:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:50 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:02:50 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 09:02:50 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 09:02:50 INFO - Using env: {'DISPLAY': ':0', 09:02:50 INFO - 'HOME': '/home/cltbld', 09:02:50 INFO - 'LANG': 'en_US.UTF-8', 09:02:50 INFO - 'LANGUAGE': 'en_US:en', 09:02:50 INFO - 'LOGNAME': 'cltbld', 09:02:50 INFO - 'MAIL': '/var/mail/cltbld', 09:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:50 INFO - 'MOZ_NO_REMOTE': '1', 09:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:50 INFO - 'NO_EM_RESTART': '1', 09:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:50 INFO - 'PWD': '/builds/slave/test', 09:02:50 INFO - 'SHELL': '/bin/bash', 09:02:50 INFO - 'SHLVL': '1', 09:02:50 INFO - 'TERM': 'linux', 09:02:50 INFO - 'TMOUT': '86400', 09:02:50 INFO - 'USER': 'cltbld', 09:02:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:50 INFO - '_': '/tools/buildbot/bin/python'} 09:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:02:51 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 09:02:51 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 09:02:51 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 09:02:51 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 09:02:51 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 09:02:51 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 09:02:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:02:53 INFO - Installing collected packages: mozsystemmonitor 09:02:53 INFO - Running setup.py install for mozsystemmonitor 09:02:53 INFO - Successfully installed mozsystemmonitor 09:02:53 INFO - Cleaning up... 09:02:53 INFO - Return code: 0 09:02:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:02:53 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')]} 09:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:53 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')]} 09:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:53 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:02:53 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 09:02:53 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 09:02:53 INFO - Using env: {'DISPLAY': ':0', 09:02:53 INFO - 'HOME': '/home/cltbld', 09:02:53 INFO - 'LANG': 'en_US.UTF-8', 09:02:53 INFO - 'LANGUAGE': 'en_US:en', 09:02:53 INFO - 'LOGNAME': 'cltbld', 09:02:53 INFO - 'MAIL': '/var/mail/cltbld', 09:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:53 INFO - 'MOZ_NO_REMOTE': '1', 09:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:53 INFO - 'NO_EM_RESTART': '1', 09:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:53 INFO - 'PWD': '/builds/slave/test', 09:02:53 INFO - 'SHELL': '/bin/bash', 09:02:53 INFO - 'SHLVL': '1', 09:02:53 INFO - 'TERM': 'linux', 09:02:53 INFO - 'TMOUT': '86400', 09:02:53 INFO - 'USER': 'cltbld', 09:02:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:53 INFO - '_': '/tools/buildbot/bin/python'} 09:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:02:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:02:55 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 09:02:55 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 09:02:55 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 09:02:55 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 09:02:55 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 09:02:55 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 09:02:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:02:55 INFO - warning: no files found matching '*.txt' 09:02:55 INFO - no previously-included directories found matching 'build' 09:02:55 INFO - no previously-included directories found matching 'dist' 09:02:55 INFO - no previously-included directories found matching '.git*' 09:02:55 INFO - Installing collected packages: jsonschema, functools32 09:02:55 INFO - Running setup.py install for functools32 09:02:55 INFO - warning: no files found matching '*.txt' 09:02:55 INFO - no previously-included directories found matching 'build' 09:02:55 INFO - no previously-included directories found matching 'dist' 09:02:55 INFO - no previously-included directories found matching '.git*' 09:02:55 INFO - Successfully installed jsonschema functools32 09:02:55 INFO - Cleaning up... 09:02:55 INFO - Return code: 0 09:02:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:55 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:02:55 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 09:02:55 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 09:02:55 INFO - Using env: {'DISPLAY': ':0', 09:02:55 INFO - 'HOME': '/home/cltbld', 09:02:55 INFO - 'LANG': 'en_US.UTF-8', 09:02:55 INFO - 'LANGUAGE': 'en_US:en', 09:02:55 INFO - 'LOGNAME': 'cltbld', 09:02:55 INFO - 'MAIL': '/var/mail/cltbld', 09:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:55 INFO - 'MOZ_NO_REMOTE': '1', 09:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:55 INFO - 'NO_EM_RESTART': '1', 09:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:55 INFO - 'PWD': '/builds/slave/test', 09:02:55 INFO - 'SHELL': '/bin/bash', 09:02:55 INFO - 'SHLVL': '1', 09:02:55 INFO - 'TERM': 'linux', 09:02:55 INFO - 'TMOUT': '86400', 09:02:55 INFO - 'USER': 'cltbld', 09:02:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:55 INFO - '_': '/tools/buildbot/bin/python'} 09:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:02:56 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 09:02:56 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 09:02:56 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 09:02:56 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 09:02:56 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 09:02:56 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 09:02:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:02:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:02:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 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 09:02:58 INFO - Downloading docopt-0.6.1.tar.gz 09:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:02:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:02:58 INFO - Running setup.py install for blobuploader 09:02:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:02:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:02:58 INFO - Running setup.py install for requests 09:02:59 INFO - Running setup.py install for docopt 09:02:59 INFO - Successfully installed blobuploader requests docopt 09:02:59 INFO - Cleaning up... 09:02:59 INFO - Return code: 0 09:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:59 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:02:59 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 09:02:59 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 09:02:59 INFO - Using env: {'DISPLAY': ':0', 09:02:59 INFO - 'HOME': '/home/cltbld', 09:02:59 INFO - 'LANG': 'en_US.UTF-8', 09:02:59 INFO - 'LANGUAGE': 'en_US:en', 09:02:59 INFO - 'LOGNAME': 'cltbld', 09:02:59 INFO - 'MAIL': '/var/mail/cltbld', 09:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:59 INFO - 'MOZ_NO_REMOTE': '1', 09:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:59 INFO - 'NO_EM_RESTART': '1', 09:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:59 INFO - 'PWD': '/builds/slave/test', 09:02:59 INFO - 'SHELL': '/bin/bash', 09:02:59 INFO - 'SHLVL': '1', 09:02:59 INFO - 'TERM': 'linux', 09:02:59 INFO - 'TMOUT': '86400', 09:02:59 INFO - 'USER': 'cltbld', 09:02:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:59 INFO - '_': '/tools/buildbot/bin/python'} 09:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:02:59 INFO - Running setup.py (path:/tmp/pip-4CIZSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:02:59 INFO - Running setup.py (path:/tmp/pip-YG_A7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:02:59 INFO - Running setup.py (path:/tmp/pip-qw87Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:02:59 INFO - Running setup.py (path:/tmp/pip-TVd3fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:02:59 INFO - Running setup.py (path:/tmp/pip-0cjW5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:02:59 INFO - Running setup.py (path:/tmp/pip-H6pOuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:02:59 INFO - Running setup.py (path:/tmp/pip-OttEPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:00 INFO - Running setup.py (path:/tmp/pip-147nBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:00 INFO - Running setup.py (path:/tmp/pip-EHdMVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:00 INFO - Running setup.py (path:/tmp/pip-yeWYMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:00 INFO - Running setup.py (path:/tmp/pip-y5whwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:00 INFO - Running setup.py (path:/tmp/pip-0oxQ7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:00 INFO - Running setup.py (path:/tmp/pip-Mgudj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:00 INFO - Running setup.py (path:/tmp/pip-qVnwEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:00 INFO - Running setup.py (path:/tmp/pip-97JQSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:00 INFO - Running setup.py (path:/tmp/pip-IxtGDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:00 INFO - Running setup.py (path:/tmp/pip-GR3Wsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:00 INFO - Running setup.py install for manifestparser 09:03:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:00 INFO - Running setup.py install for mozcrash 09:03:00 INFO - Running setup.py install for mozdebug 09:03:01 INFO - Running setup.py install for mozdevice 09:03:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Running setup.py install for mozfile 09:03:01 INFO - Running setup.py install for mozhttpd 09:03:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Running setup.py install for mozinfo 09:03:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Running setup.py install for mozInstall 09:03:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Running setup.py install for mozleak 09:03:01 INFO - Running setup.py install for mozlog 09:03:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Running setup.py install for moznetwork 09:03:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:01 INFO - Running setup.py install for mozprocess 09:03:01 INFO - Running setup.py install for mozprofile 09:03:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:02 INFO - Running setup.py install for mozrunner 09:03:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:02 INFO - Running setup.py install for mozscreenshot 09:03:02 INFO - Running setup.py install for moztest 09:03:02 INFO - Running setup.py install for mozversion 09:03:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:02 INFO - Cleaning up... 09:03:02 INFO - Return code: 0 09:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:02 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:03:02 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 09:03:02 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 09:03:02 INFO - Using env: {'DISPLAY': ':0', 09:03:02 INFO - 'HOME': '/home/cltbld', 09:03:02 INFO - 'LANG': 'en_US.UTF-8', 09:03:02 INFO - 'LANGUAGE': 'en_US:en', 09:03:02 INFO - 'LOGNAME': 'cltbld', 09:03:02 INFO - 'MAIL': '/var/mail/cltbld', 09:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:02 INFO - 'MOZ_NO_REMOTE': '1', 09:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:02 INFO - 'NO_EM_RESTART': '1', 09:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:02 INFO - 'PWD': '/builds/slave/test', 09:03:02 INFO - 'SHELL': '/bin/bash', 09:03:02 INFO - 'SHLVL': '1', 09:03:02 INFO - 'TERM': 'linux', 09:03:02 INFO - 'TMOUT': '86400', 09:03:02 INFO - 'USER': 'cltbld', 09:03:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:02 INFO - '_': '/tools/buildbot/bin/python'} 09:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:02 INFO - Running setup.py (path:/tmp/pip-x40iYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:02 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)) 09:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:02 INFO - Running setup.py (path:/tmp/pip-mT9yUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:02 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)) 09:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:02 INFO - Running setup.py (path:/tmp/pip-jfTHqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:02 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)) 09:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:02 INFO - Running setup.py (path:/tmp/pip-gRbRb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:03 INFO - Running setup.py (path:/tmp/pip-EUEEGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:03 INFO - Running setup.py (path:/tmp/pip-ZrLVUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:03 INFO - Running setup.py (path:/tmp/pip-ugiPvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:03 INFO - Running setup.py (path:/tmp/pip-bLvNfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:03 INFO - Running setup.py (path:/tmp/pip-GYT9GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:03 INFO - Running setup.py (path:/tmp/pip-6GoWKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:03 INFO - Running setup.py (path:/tmp/pip-8SWhSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:03 INFO - Running setup.py (path:/tmp/pip-NtPcjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:03 INFO - Running setup.py (path:/tmp/pip-iwKQzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:03 INFO - Running setup.py (path:/tmp/pip-lgixnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:03 INFO - Running setup.py (path:/tmp/pip-I74Vgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:03 INFO - Running setup.py (path:/tmp/pip-cuLbTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:03 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)) 09:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:03 INFO - Running setup.py (path:/tmp/pip-FrOT0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:04 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)) 09:03:04 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)) 09:03:04 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)) 09:03:04 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)) 09:03:04 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)) 09:03:04 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)) 09:03:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:05 INFO - Downloading blessings-1.6.tar.gz 09:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:05 INFO - Installing collected packages: blessings 09:03:05 INFO - Running setup.py install for blessings 09:03:06 INFO - Successfully installed blessings 09:03:06 INFO - Cleaning up... 09:03:06 INFO - Return code: 0 09:03:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:06 INFO - Reading from file tmpfile_stdout 09:03:06 INFO - Current package versions: 09:03:06 INFO - argparse == 1.2.1 09:03:06 INFO - blessings == 1.6 09:03:06 INFO - blobuploader == 1.2.4 09:03:06 INFO - docopt == 0.6.1 09:03:06 INFO - functools32 == 3.2.3-2 09:03:06 INFO - jsonschema == 2.5.1 09:03:06 INFO - manifestparser == 1.1 09:03:06 INFO - mozInstall == 1.12 09:03:06 INFO - mozcrash == 0.17 09:03:06 INFO - mozdebug == 0.1 09:03:06 INFO - mozdevice == 0.48 09:03:06 INFO - mozfile == 1.2 09:03:06 INFO - mozhttpd == 0.7 09:03:06 INFO - mozinfo == 0.9 09:03:06 INFO - mozleak == 0.1 09:03:06 INFO - mozlog == 3.2 09:03:06 INFO - moznetwork == 0.27 09:03:06 INFO - mozprocess == 0.23 09:03:06 INFO - mozprofile == 0.28 09:03:06 INFO - mozrunner == 6.12 09:03:06 INFO - mozscreenshot == 0.1 09:03:06 INFO - mozsystemmonitor == 0.3 09:03:06 INFO - moztest == 0.7 09:03:06 INFO - mozversion == 1.4 09:03:06 INFO - psutil == 3.1.1 09:03:06 INFO - requests == 1.2.3 09:03:06 INFO - wsgiref == 0.1.2 09:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:06 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:03:06 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 09:03:06 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 09:03:06 INFO - Using env: {'DISPLAY': ':0', 09:03:06 INFO - 'HOME': '/home/cltbld', 09:03:06 INFO - 'LANG': 'en_US.UTF-8', 09:03:06 INFO - 'LANGUAGE': 'en_US:en', 09:03:06 INFO - 'LOGNAME': 'cltbld', 09:03:06 INFO - 'MAIL': '/var/mail/cltbld', 09:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:06 INFO - 'MOZ_NO_REMOTE': '1', 09:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:06 INFO - 'NO_EM_RESTART': '1', 09:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:06 INFO - 'PWD': '/builds/slave/test', 09:03:06 INFO - 'SHELL': '/bin/bash', 09:03:06 INFO - 'SHLVL': '1', 09:03:06 INFO - 'TERM': 'linux', 09:03:06 INFO - 'TMOUT': '86400', 09:03:06 INFO - 'USER': 'cltbld', 09:03:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:06 INFO - '_': '/tools/buildbot/bin/python'} 09:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 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)) 09:03:06 INFO - Cleaning up... 09:03:06 INFO - Return code: 0 09:03:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:06 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 0x255c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', '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 09:03:06 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 09:03:06 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 09:03:06 INFO - Using env: {'DISPLAY': ':0', 09:03:06 INFO - 'HOME': '/home/cltbld', 09:03:06 INFO - 'LANG': 'en_US.UTF-8', 09:03:06 INFO - 'LANGUAGE': 'en_US:en', 09:03:06 INFO - 'LOGNAME': 'cltbld', 09:03:06 INFO - 'MAIL': '/var/mail/cltbld', 09:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:06 INFO - 'MOZ_NO_REMOTE': '1', 09:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:06 INFO - 'NO_EM_RESTART': '1', 09:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:06 INFO - 'PWD': '/builds/slave/test', 09:03:06 INFO - 'SHELL': '/bin/bash', 09:03:06 INFO - 'SHLVL': '1', 09:03:06 INFO - 'TERM': 'linux', 09:03:06 INFO - 'TMOUT': '86400', 09:03:06 INFO - 'USER': 'cltbld', 09:03:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:06 INFO - '_': '/tools/buildbot/bin/python'} 09:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:06 INFO - Cleaning up... 09:03:06 INFO - Return code: 0 09:03:06 INFO - Running post-action listener: _resource_record_post_action 09:03:06 INFO - Running post-action listener: _start_resource_monitoring 09:03:06 INFO - Starting resource monitoring. 09:03:06 INFO - ##### 09:03:06 INFO - ##### Finished create-virtualenv step (success) 09:03:06 INFO - ##### 09:03:06 INFO - ##### 09:03:06 INFO - ##### Running install step. 09:03:06 INFO - ##### 09:03:06 INFO - Running pre-action listener: _resource_record_pre_action 09:03:06 INFO - Running main action method: install 09:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:07 INFO - Reading from file tmpfile_stdout 09:03:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:07 INFO - Reading from file tmpfile_stdout 09:03:07 INFO - Output received: 09:03:07 INFO - Usage: mozinstall [options] installer 09:03:07 INFO - Options: 09:03:07 INFO - -h, --help show this help message and exit 09:03:07 INFO - -d DEST, --destination=DEST 09:03:07 INFO - Directory to install application into. [default: 09:03:07 INFO - "/builds/slave/test"] 09:03:07 INFO - --app=APP Application being installed. [default: firefox] 09:03:07 INFO - mkdir: /builds/slave/test/build/application 09:03:07 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'] 09:03:07 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 09:03:23 INFO - Reading from file tmpfile_stdout 09:03:23 INFO - Output received: 09:03:23 INFO - /builds/slave/test/build/application/firefox/firefox 09:03:23 INFO - Running post-action listener: _resource_record_post_action 09:03:23 INFO - ##### 09:03:23 INFO - ##### Finished install step (success) 09:03:23 INFO - ##### 09:03:23 INFO - ##### 09:03:23 INFO - ##### Running run-tests step. 09:03:23 INFO - ##### 09:03:23 INFO - Running pre-action listener: _resource_record_pre_action 09:03:23 INFO - Running main action method: run_tests 09:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:03:23 INFO - Python 2.7.3 09:03:23 INFO - Return code: 0 09:03:23 INFO - grabbing minidump binary from tooltool 09:03: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')]} 09:03:23 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 0x281a570>, '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 0x281b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:03:23 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 09:03:23 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 09:03:23 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 09:03:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:03:23 INFO - Return code: 0 09:03:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:03:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:03:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:03:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:03:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 09:03:23 INFO - Using env: {'DISPLAY': ':0', 09:03:23 INFO - 'HOME': '/home/cltbld', 09:03:23 INFO - 'LANG': 'en_US.UTF-8', 09:03:23 INFO - 'LANGUAGE': 'en_US:en', 09:03:23 INFO - 'LOGNAME': 'cltbld', 09:03:23 INFO - 'MAIL': '/var/mail/cltbld', 09:03:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:03:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:23 INFO - 'MOZ_NO_REMOTE': '1', 09:03:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:23 INFO - 'NO_EM_RESTART': '1', 09:03:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:23 INFO - 'PWD': '/builds/slave/test', 09:03:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:03:23 INFO - 'SHELL': '/bin/bash', 09:03:23 INFO - 'SHLVL': '1', 09:03:23 INFO - 'TERM': 'linux', 09:03:23 INFO - 'TMOUT': '86400', 09:03:23 INFO - 'USER': 'cltbld', 09:03:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379', 09:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:23 INFO - '_': '/tools/buildbot/bin/python'} 09:03:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:03:23 INFO - mozversion application_buildid: 20160707082722 09:03:23 INFO - mozversion application_changeset: e2f5a7c70b47be82f2a8f85cac59482c8f77550a 09:03:23 INFO - mozversion application_display_name: Nightly 09:03:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:03:23 INFO - mozversion application_name: Firefox 09:03:23 INFO - mozversion application_remotingname: firefox 09:03:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:03:23 INFO - mozversion application_vendor: Mozilla 09:03:23 INFO - mozversion application_version: 50.0a1 09:03:23 INFO - mozversion platform_buildid: 20160707082722 09:03:23 INFO - mozversion platform_changeset: e2f5a7c70b47be82f2a8f85cac59482c8f77550a 09:03:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:03:23 INFO - mozversion platform_version: 50.0a1 09:03:23 INFO - using testdate: 1467907403 09:03:23 INFO - actual date: 1467907403 09:03:23 INFO - starting webserver on 'localhost:55863' 09:03:23 INFO - SUITE-START | Running 2 tests 09:03:23 INFO - TEST-START | dromaeo_css 09:03:23 INFO - operating with platform_type : linux_ 09:03:23 INFO - Initialising browser for dromaeo_css test... 09:03:23 INFO - TEST-INFO | started process 20373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYKSrDD/profile http://localhost:55863/getInfo.html) 09:03:28 INFO - PROCESS | 20373 | __metrics Screen width/height:1600/1200 09:03:28 INFO - PROCESS | 20373 | colorDepth:24 09:03:28 INFO - PROCESS | 20373 | Browser inner width/height: 1024/697 09:03:28 INFO - PROCESS | 20373 | __metrics 09:03:29 ERROR - PROCESS | 20373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 09:03:30 INFO - TEST-INFO | 20373: exit 0 09:03:30 INFO - Browser initialized. 09:03:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:03:30 INFO - TEST-INFO | started process 20495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYKSrDD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:42 INFO - PROCESS | 20495 | RSS: Main: 168738816 09:03:42 INFO - PROCESS | 20495 | 09:04:32 INFO - PROCESS | 20495 | 1467907472384 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] 09:06:44 INFO - PROCESS | 20495 | Cycle 1(1): loaded http://localhost:55863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55863/tests/dromaeo/cssquery-ext.html) 09:06:45 INFO - PROCESS | 20495 | RSS: Main: 170688512 09:06:45 INFO - PROCESS | 20495 | 09:09:48 INFO - PROCESS | 20495 | Cycle 1(1): loaded http://localhost:55863/tests/dromaeo/cssquery-ext.html (next: http://localhost:55863/tests/dromaeo/cssquery-jquery.html) 09:09:48 INFO - PROCESS | 20495 | RSS: Main: 168079360 09:09:48 INFO - PROCESS | 20495 | 09:12:50 INFO - PROCESS | 20495 | Cycle 1(1): loaded http://localhost:55863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55863/tests/dromaeo/cssquery-mootools.html) 09:12:51 INFO - PROCESS | 20495 | RSS: Main: 170676224 09:12:51 INFO - PROCESS | 20495 | 09:15:53 INFO - PROCESS | 20495 | Cycle 1(1): loaded http://localhost:55863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55863/tests/dromaeo/cssquery-prototype.html) 09:15:54 INFO - PROCESS | 20495 | RSS: Main: 166985728 09:15:54 INFO - PROCESS | 20495 | 09:18:56 INFO - PROCESS | 20495 | Cycle 1(1): loaded http://localhost:55863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55863/tests/dromaeo/cssquery-yui.html) 09:18:57 INFO - PROCESS | 20495 | RSS: Main: 168144896 09:18:57 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | Cycle 1(1): loaded http://localhost:55863/tests/dromaeo/cssquery-yui.html (next: http://localhost:55863/tests/dromaeo/cssquery-dojo.html) 09:22:00 INFO - PROCESS | 20495 | RSS: Main: 169545728 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | __start_tp_report 09:22:00 INFO - PROCESS | 20495 | _x_x_mozilla_page_load 09:22:00 INFO - PROCESS | 20495 | _x_x_mozilla_page_load_details 09:22:00 INFO - PROCESS | 20495 | |i|pagename|runs| 09:22:00 INFO - PROCESS | 20495 | |0;dojo.html;2572.9228123156304;2623.8294510856795;2640.907568235112;2641.696204936433;2648.9337766555846;4716;4716.221823399135;4740.573348398643;4838.661293709441;4855.611551075915;4663.27719203524;4679.625629949604;4703.764811759415;4800.303955926389;4814.879628009301;4268.061026574149;4347.804348804311;4383.671224658164;4395.428594282739;4409.669274804386;641.0340233311974;4303.913921721563;4309.461317335333;4378.5183629800695;4400.82396704133;4278.037441575651;4333.696641235115;4347.5869792369995;4358.956410435887;4409.985703288229;4337.566243375637;4354.934675979863;4359.84740534083;4400;4408.53710360414;4226.239276930151;4345.174416860818;4363.258246098139;4364.519902810688;4385.956140438587;4680.695754775928;4817.927731084036;4832.202686556714;4843.806247750086;4849.9757501212625;5041.924371134436;5141.203113517411;5179.119549676564;5193.350831146106;5234.869128271824;5088.287639730441;5137.101007323741;5148.459411761786;5149.201873709581;5201.193814958688;4745.928811067837;4765.73788441639;4794.856154315376;4809.917768502059;4825.252085926722;5138.58891288696;5192.221166825007;5197.688138711614;5200.6619569727845;5280.445553216934;5006.224035274538;5044.1677123274985;5069.9746501267255;5070.138076527;5101.770420331094;5147.150720131136;5148.30497882781;5157.149070403341;5164.070467315919;5198.402183748917;4831.130396528659;5021.799128034838;5075.746212689424;5107.387113546398;5127.3847138343635;5083.517065878736;5086.4659210783075;5097.592192624581;5105.566026887756;5123.769430375642;4213.367994800805;4266.445362102907;4267.871963841089;4305.763183024964;4306.763128027926;3635.5455568053994;3654.3604869147794;3691.0587800110798;3694.390425579803;3708.610595887447;4285.10012897295;4321.524632290446;4324.113556720865;4337.937205384638;4391.604755572014;5050.090983622909;5055.039542486916;5063.544281014726;5063.620228482805;5111.437741848394;4311.655067594585;4353.934690979638;4375.409319741794;4432.29083346663;4459.910801784011;4604.608608268268;4609.377734005933;4610.631149508032;4613;4663.976680116578;4762.476127625959;4821.9035619288115;4825.9758701206265;4826.855194344175;4868.95131048685;5057.31726216956;5114.386273647037;5130.025295193901;5158;5159.380874295109;4823.782929768098;4831.396075490564;4837.637177211794;4856.344393506832;4889.657723959289;4901.681390709592;5062.82280120194;5094.719790411415;5111.591072714248;5148.639595228298;5093.745312734274;5134.486551344836;5141.61437892167;5150.0472412603785;5167;5005.224190250517;5011.123053465556;5012.699238045583;5019.64862459639;5071.061853557104;4876.171050921281;4935.309056732132;4986.252062190701;5005.049040682259;5007.7746501408255;4745.976270118766;4789.473157952552;4862.732549709658;4896.6572339935865;4898.828541001048;4947.282644016669;4954.20732682769;4963.329950456787;4975;5013.974930125326;4801.807927682854;4872.317875497362;4898.4121905371585;4923.630727695366;4946.925796113133 09:22:00 INFO - PROCESS | 20495 | |1;ext.html;557.8382269141948;560.4003716023853;572.5705720709468;573.0344369736994;592.5170985646695;35777;39828.20343593127;39935.80032099839;39942;39946;40240.39639405404;40499.595004050025;40580;40706.79646601763;40760;7803.687852485894;7953.642086106111;7994.400419968497;8009;8012.19878012197;7805.60971951403;7812.257835505618;7873.173316801739;7877.094134174557;7897.131315555284;7879;7914.564698941556;7928.722494712686;7935.682572697114;7943.245391687809;7867.7639670809685;7878.487898286593;7898.526088434654;7906.762797116067;7916.841663166704;7750.728724494672;7771.650275737549;7802.804929876742;7827.0607527096545;7833.725819596287;39073.41389879126;39414.802925985474;39499.60500394988;39531.209375812614;39735.40396894049;2404.579198640231;3045.1473587395567;3086.120455670123;3129.405412971551;3142.4343618148723;26965;28626.570601440995;28743.42513149746;29274.268143296376;29547;2979.8510074496407;3012.2469382654335;3015.894443694482;3033.302340461706;3073.4160509503345;223511;226802;226927;227930;228372;32833;32904.67095329016;33298.16754581155;33344.66655333464;33493.83253083719;34743.82628086843;34929.825350873085;34960;35081.64918350835;35097.47353789695;13687.452501899812;13798.65503362404;13868.445262189602;13901.567225735456;13934.512292069729;11161.72095697614;11321.71695707614;11426.143039272089;11432.599859004895;11460.025897798614;8063.919360806317;8084.585197590398;8095.757127286191;8165.591720413956;8182.836343273101;3149.921251968719;3176.9682303177133;3194.073718621574;3223.6453990061073;3244.8053116813066;877.0746862060587;898.4205187654057;911.6763548940163;950.1401231885155;951.4861974533675;28162.577561336595;28611.427771444873;29010;29465.55801662934;29663.25841853971;902.0483390023458;989.9356541824758;1012.5392946209457;1050.7425680708122;1057.434272664121;15260.46588369424;15499.690006199813;15633.218339083;15843.524694259191;15905.204739762965;365001;429075;432029;436258;644960;50725;50896.491035089915;51329.48670513322;51482;51570.74214628903;1179.504608064615;1222.0284873525568;1230.949881333237;1243.3534562027694;1243.434237421971;29001.85499072491;30052.24869378283;30080.849595751883;30281.848590756905;30644.540331894594;44356.33465497955;48622;50780.746096269286;50855;54042.459575403744;288025;289763;291367;291601;292222;37131;37417.2516549662;37486.62513374831;37996.430053549775;38039.80980095082;40800.59199407968;41146.38280425736;41903.58096418997;42039.15921681488;42443.15113697771;36405;36505;36641.45037824488;37263.06842328963;37493.625063749016;35661.1084722884;36328.81835590805;36810.8159459201;37095.25809483741;37135;35687.64312356843;35915.64084359123;35951.820240898625;36129.458058129676;36604.63395366012;32396.028119156465;32917.835410822794;32979.67020329862;32991.83504082464;33371.16572085717;25253;25483.235502934942;25762.227133186036;25832.612510812727;26148.86925565436 09:22:00 INFO - PROCESS | 20495 | |2;jquery.html;366.33144511266937;366.543653151826;367.86389036056664;380.5015429786977;386.5091334005813;16438.589035274123;16815.327386904526;17951.3717019904;18032.18855151518;18179.091045447723;15970;17474.126293685327;17579.121043947816;17638.206280717368;17657.117144142805;5139.25480805283;5288.814891478799;5316.813911513098;5319.122344813101;5324.787008519655;5075.137226671474;5234.162533994561;5258.737063146847;5271.841844744664;5296.311479507659;5187.584993200554;5207.0366982108435;5231.921521177185;5239.240310155025;5251.632385732981;5159.896802063975;5181.896362072737;5198.974005129969;5211.791528338862;5226.503482169188;4511.458624964992;4620.422447194101;4623.352730617717;4634.83778067766;4647.674662773574;21086.578268434547;21486.24798132058;21510;21924.89037554818;22088.33734987953;1881.294514557041;1992.4122383896786;2004.7995200479982;2019.1822311963679;2497.3881399057345;13745.587632370945;13879.930600346934;13888.722225555432;14148.434062637481;14251.287435628177;1841.1346667066457;1854.9536261593432;2000.9699854502048;2001.9399418017483;2026.523766914774;69498.30501694969;69601.30398695999;70154.64922675405;71082.99999999948;72778.63610681913;9306.395084319498;9331.90668093324;10041.849372259421;10063.647772327933;10267.281290309607;13742.587722368346;13786.793198102036;13890.305484725723;13942;13948.232847193502;7222.711091556384;7287.599182044933;7404.777856664308;7430.851382972419;7494.775156745306;7168.068151140423;7235.131784185932;7235.92764072363;7330.266973302627;7339.816504587428;4283.571642835692;4307.289297265978;4321.719088259253;4396.956030439718;4456.844010459618;1621.100289339428;1621.4000819696553;1632.126812155491;1650.438850790737;1721.234050847386;807.8142027333746;809.668036105194;812.1229072601576;854.5129276312442;893.5041052215953;17250.568735781704;17525.7371139433;17878;18133.90933045326;18346.174422151034;796.9123396426388;849.3799526345803;852.5268475995758;864.9264812490883;901.3330135699666;9300.209482193954;9654.179394751385;9683.32216744821;9776.560054797552;9782.853257201148;343795;346521;347669;349503;365666;79725.60137199392;80378;82973;83663;84106.15893840983;890.4746199742053;901.6393442623134;921.7833809054866;922.3313098004028;922.4142669404843;15311.693766124838;15590.9220453897;15763.211839408214;15996;16196.514104576881;32674.116942725625;35735.64264357427;36760.08099797527;36925;36966.815165923996;48581.75709121432;52616;52699;52723;53093.469065308855;7237.819054523679;7341.4126869849215;7423.294786995227;7493.550386976799;7652.311291983749;11048.502817373077;11269.830952535882;11382.601608943647;11469.31184128955;11519.136064795006;6474.482041436768;8893.866592001255;9114.27085833145;9826.901730982885;9833.016698330395;9952.850707239542;9978.800423991333;10005.74985625336;10019.248556358449;10170.745731356776;10024.398536087858;10052.748681283027;10076.949615251877;10251.28241023151;10335.689929302132;7200.207977122617;7290.343869051599;7307.378872795872;7317.780466586011;7517.43619228571;9338.439693618404;9518.619255229713;10064.194864410976;10107.090361867467;10281.023302786223 09:22:00 INFO - PROCESS | 20495 | |3;mootools.html;1393.7351903138406;1414.0949792133033;1524.3369134426518;1701.3109690575307;1724.948251552454;6864.862702745942;7530.698772049118;7575.84848303035;8004.959975200116;8017.79955501112;7635.847283054336;7901.565413902233;7905.209479052092;7938.0077490313715;7941;2140.250912180736;2197.5824593327297;2199.923002694906;2201.218567408571;2202.9889850550803;2171.695962565242;2219.323106452531;2258.4015235962484;2263.4341414646337;2270.137347807831;2172.4568857785553;2180.80372766451;2184.421128400975;2199.3841724317135;2233.2406981626245;2143.6355819510723;2144.742630884296;2153.956920861574;2165.9566808663817;2171.1098449635733;2162.643163877974;2192.506685995654;2196.6924630551734;2205.757366689663;2213.1479380438486;7945.64244608994;7998.560079195642;8000;8015.799605009863;8052;4572.977135114304;4605.30920361945;4670.929936050962;4704.576588107053;4708.74101924394;2829.7170282971742;2832.4051949090717;2858.4997625415467;2893.537034074559;2907.7964542482036;881.8853549038583;900.806536084636;911.7036962987056;918.779492921694;931.7018554062703;10621.25651204416;10658.73353166177;10693.893061069368;10697.251192416456;10747.140228781756;4086.4074709167003;4147.52303485097;4299.161663475592;4302.053548219386;4306;9036.32227582934;9071.682491112912;9140.588673509708;9142.771430714285;9143.222826059859;4623.42207224097;4644.767761611974;4658.836940707059;4661;4684.929726054112;3612.674859262679;4165.062860856283;4215.114825886537;4215.810288537024;4294.227039132986;3654.0682126057686;3686.668199862025;3702.22253326799;3780.2628487444686;3882.9029274267805;1207.897328727068;1222.3093951917137;1225.9816102758466;1239.4856134703996;1241.3172754984723;583.527342852291;817.6811043692965;832.4921797703396;836.623519416253;839.4207996482407;5168.664036837594;5192.61055420845;5284.630075894727;5344.625876188629;5353.866153346197;410.37417937644733;414.4943169333408;415.45990212723336;415.60725114766257;417.9143275628489;3583.9820800895827;3662.340778659867;3950.2297052075146;3958.8812335629977;3996.7202295839593;9144.634214631473;9559.713208603753;9566.330356874952;9719;9843.950780246052;9674.371165874196;9699.418034917928;9713.757156071155;9756.658516951873;9789.580510826032;7013.859722805515;7328.9267107329315;7370.115586129698;7371.631418429057;7383.483156179016;5160;5293.391260005149;5376.7580458878665;5400.783968641211;5569.749361278671;8574.056853745959;8914.197722205032;8919.73240802777;9193.908060919573;9215;8724.258438032584;9113.635454581743;9124.589393477178;9131.589078491617;9135.086491350812;6051.909221361771;6506.60960342381;6657.900131497934;6930.27232140618;7128.251533588898;7552.169261381354;7606.277403646644;7610.733624323122;7677.424193185422;7687.730929417444;6741.52809303344;6917.757878474229;6924.099867017256;6946.5137440378685;7059.682314295766;6842.281560436281;6919.37725604698;6921.550099243533;6945.930540694529;6980.616066116209;5635.788305514334;5647.576431767552;5664.5751568631695;5729.2265544151005;5926.525877929669;4415.712978656377;4480.081583275486;4487.887802804956;4510.706804057726;4516.09678064395;4624.260118381043;4635.212013957568;4638.930416043694;4649.186392381387;4681.321208424827 09:22:00 INFO - PROCESS | 20495 | |4;prototype.html;286.3714147446356;286.8150043222123;296.5566478115218;296.5788580216093;304.41704136578454;5120;5137.178051511759;5163.63854530183;5171.198464238045;5175.974120129399;5025.849224523261;5071.858831762852;5089.099213448336;5089.2620570017325;5117.820876269322;3788.1476667749744;3878.3212937735925;3966.801659916993;3984.728704638357;4026.8590599329027;3961.8217180226816;3980.9601903981024;3990.1820126874068;3990.261801566705;4004.199160167978;3982.5420076691116;3983.5618082010956;4003.5996400360023;4012.959870401288;4019.7588144711262;3769.2838360711376;3961.108750531136;3979.1643754811525;4003.619656132663;4012.117334186474;3469.60099588548;3494.178867966026;3507.94738078929;3509.017475106974;3521.542199514047;4948.703077815343;4963.751812409365;4984.601231901439;4999.450060493343;5014.219951917054;4261.552536983603;4571.291449825282;4580.770961451914;4592.793324300381;4607.14767767964;5286.312779338661;5300.787968481256;5306.257124002643;5307.761150748225;5309.36287645485;3777.6411240932066;3802.790846503441;3808.4668146459517;3812.4281357796276;3834.65488106069;5325.254464374952;5566.777328906839;5568.415316391802;5576.888462230773;5609.49514543693;3893.863714770026;3905.1213476967455;3906.1055388136733;3919.2161567686576;3927.6434139516064;3981.7411868228473;3993.4409182714444;3994.2410941920944;4001.6194412927493;4002.2595819773437;4506.639468842484;4540.432445944257;4542.523679804077;4542.977285113553;4552.658550608718;5128.025780020514;5262.578993680497;5294.326365185557;5333.466653334635;5383.407825139231;1372.876441120304;1384.2179168769612;1388.2503448137893;1393.770027945398;1396.9790453143212;867.2065060469725;893.629143905272;905.8097799462055;921.1939552891221;927.4759760735163;4507.2788353863225;4540.298522379179;4558.954410455919;4572.885677858014;4595.333676616872;5312.9734351328;5362;5395.325584301962;5402.945970540244;5404.891902161935;4417.757023363682;4605.585497305258;4606.88482787933;4618.630509559227;4632.2819962905805;2903.8548072596286;2920.853957302169;2931.4430258250864;2931.83874886879;2943.337749006499;5111.182210846247;5112.284280200774;5121.4622464641425;5138.743062846843;5149.150390185578;5400.972995134999;5609.158626206102;5612.97193514038;5656.632318899258;5657.717114144276;5028.058585727391;5121.055393148954;5133.768980395891;5149.407818100966;5151.7681704323395;5389.326334208224;5466.671999680032;5468.945310546844;5487.533559647315;5506.614536982373;5106.617003724661;5371.086915224343;5385.59974406665;5396.9730151348995;5402.5677945763455;5140.820071297487;5154.639175257696;5195;5218.4605541366145;5229.686218826882;3863.8261278241985;3870.5161854768153;3879.243547508209;3880.5149356330458;3882.6699730523223;5202.167653175474;5492.697901615449;5511.751971161388;5529.170624406211;5604.355499117653;5349.812756553502;5365.248865158803;5386.919196212139;5404.918926216032;5418.45815418455;5214.478552144755;5339.412664606968;5345.75944082525;5365.651232669864;5423.674579525241;5261.184516399964;5266.920996185137;5280.260763493037;5307.57539396855;5336.14621660548;5101.821436249714;5265.4997775211295;5409.729513524229;5419.187121931742;5442.482964118402;5249.947500525099;5287.673423693563;5289.920651190158;5307.57539396855;5308.840734777963 09:22:00 INFO - PROCESS | 20495 | |5;yui.html;594.726425844112;642.4924309795261;661.1635686996461;667.5727534377996;723.3056265984654;13303.733925321489;13722.725545489084;13796.586102416919;13811;13820.170789752621;12773.425195866184;12987.740245195091;12992.350382480861;12997.285149316784;13017.869821301783;616.4328817487899;760.0765070439415;761.942854285928;779.9376049915993;786.7010535996313;781.9960900195491;786.2766255045343;789.5539020453455;790.699534177012;793.9007624046994;832.81261716114;836.3560058754755;845.002896582036;845.7420486751538;846.2552953400999;837.656560810071;838.3335248477475;839.3704721458906;840.9915900840974;842.3850589069982;611.7308384310934;615.3969110271959;615.8429600451901;616.9876602467971;617.2438762515927;12415.503379864795;12449.439775210138;12471.438785254686;12485.625431237077;12496.187747796364;14163.929180354135;14214.360353784105;14244.501442449464;14264.215468149248;14313.141211527342;10078.848817267746;10188.235882308856;10305.845412318746;10306.053767272377;10384.844227336596;3320.369129865342;3340.682635149657;3395.7283417326553;3417.2140407706365;3419.384510788057;61538.384616153715;62665;63142.36857631411;64644.3535564643;64682;10732.356058636507;10750.623728169476;10792.730181745519;10882.72793180161;10958.342499450058;20725.170993160104;20727.792722072587;20757;20917.895410523153;21110.788892111188;6969.47728920333;7110.075690160246;7136.785896423115;7159.319864612853;7187.31720486553;3745.9812700936322;3763.6989040876665;3820.2741479118877;3831.5210598675167;3890.90272743178;2861.413410250894;2989.805662631922;2989.9850500747357;2993.1768763589753;2993.2965753048015;489.22213680247864;496.74417674897455;507.4468828976433;507.6573313013775;516.968981861082;551.3907132618478;572.8281515545319;586.1559354529464;592.2301008688687;617.9104029915637;7496.212897645669;7550.622468876534;7676.501027433199;7762.883556746653;7765.72819951299;455.34657766105744;505.4212926199481;560.9454226054991;596.6658671144173;634.2769243062912;3672.7245456590863;3905.3946638271113;3976.165005348851;3990.6607938324987;4071.776052317092;93365;95322.52338738262;95418.52290738502;96208;96441;87179;87371;87402.56298718593;87405.56297218474;88046.55976720076;47064.2940355895;48570;56169;74579;76929.61535192288;7377.778666639795;7670.117936437158;7689.92310076892;7742.264484873928;7927.643256053376;39493.80253098716;42161.789191053846;42226.36660450157;43093;43209;45426.772866135456;54088.729556351966;54849.725751370985;64430.35569644431;65660.67169664313;12338.198017128858;12340.074494413135;12376.876231237573;12545.686357841127;12670.619881403572;12579.93710031444;12663;13047.217166969633;13774.65563360924;13803.378847952066;10996.340219586851;11527.884721153017;11593.768124637292;11647.88352116468;11659.125565582446;10921.399323037309;11191.496382662637;11665.533378665097;11881.5841445549;12306.876931230574;10501.159907207253;10745.838812417976;11075.833862491907;11146.275492092987;11192.664220073411;10170.89829101729;10358.896411036094;10421.53103110377;10677.14582833387;10729.302595331279;9388.155066044088;9551.0926461986;9631.614735410505;9642.382517810851;9727.610895564098 09:22:00 INFO - PROCESS | 20495 | __end_tp_report 09:22:00 INFO - PROCESS | 20495 | __start_cc_report 09:22:00 INFO - PROCESS | 20495 | _x_x_mozilla_cycle_collect,394 09:22:00 INFO - PROCESS | 20495 | __end_cc_report 09:22:00 INFO - PROCESS | 20495 | __startTimestamp1467908520495__endTimestamp 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | ------- Summary: start ------- 09:22:00 INFO - PROCESS | 20495 | Number of tests: 6 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | [#0] dojo.html Cycles:165 Average:4686.08 Median:4843.81 stddev:604.54 (12.5%) stddev-sans-first:583.23 09:22:00 INFO - PROCESS | 20495 | Values: 2572.9 2623.8 2640.9 2641.7 2648.9 4716.0 4716.2 4740.6 4838.7 4855.6 4663.3 4679.6 4703.8 4800.3 4814.9 4268.1 4347.8 4383.7 4395.4 4409.7 641.0 4303.9 4309.5 4378.5 4400.8 4278.0 4333.7 4347.6 4359.0 4410.0 4337.6 4354.9 4359.8 4400.0 4408.5 4226.2 4345.2 4363.3 4364.5 4386.0 4680.7 4817.9 4832.2 4843.8 4850.0 5041.9 5141.2 5179.1 5193.4 5234.9 5088.3 5137.1 5148.5 5149.2 5201.2 4745.9 4765.7 4794.9 4809.9 4825.3 5138.6 5192.2 5197.7 5200.7 5280.4 5006.2 5044.2 5070.0 5070.1 5101.8 5147.2 5148.3 5157.1 5164.1 5198.4 4831.1 5021.8 5075.7 5107.4 5127.4 5083.5 5086.5 5097.6 5105.6 5123.8 4213.4 4266.4 4267.9 4305.8 4306.8 3635.5 3654.4 3691.1 3694.4 3708.6 4285.1 4321.5 4324.1 4337.9 4391.6 5050.1 5055.0 5063.5 5063.6 5111.4 4311.7 4353.9 4375.4 4432.3 4459.9 4604.6 4609.4 4610.6 4613.0 4664.0 4762.5 4821.9 4826.0 4826.9 4869.0 5057.3 5114.4 5130.0 5158.0 5159.4 4823.8 4831.4 4837.6 4856.3 4889.7 4901.7 5062.8 5094.7 5111.6 5148.6 5093.7 5134.5 5141.6 5150.0 5167.0 5005.2 5011.1 5012.7 5019.6 5071.1 4876.2 4935.3 4986.3 5005.0 5007.8 4746.0 4789.5 4862.7 4896.7 4898.8 4947.3 4954.2 4963.3 4975.0 5014.0 4801.8 4872.3 4898.4 4923.6 4946.9 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | [#1] ext.html Cycles:180 Average:47312.61 Median:200703.00 stddev:91832.43 (45.8%) stddev-sans-first:92022.95 09:22:00 INFO - PROCESS | 20495 | Values: 557.8 560.4 572.6 573.0 592.5 35777.0 39828.2 39935.8 39942.0 39946.0 40240.4 40499.6 40580.0 40706.8 40760.0 7803.7 7953.6 7994.4 8009.0 8012.2 7805.6 7812.3 7873.2 7877.1 7897.1 7879.0 7914.6 7928.7 7935.7 7943.2 7867.8 7878.5 7898.5 7906.8 7916.8 7750.7 7771.7 7802.8 7827.1 7833.7 39073.4 39414.8 39499.6 39531.2 39735.4 2404.6 3045.1 3086.1 3129.4 3142.4 26965.0 28626.6 28743.4 29274.3 29547.0 2979.9 3012.2 3015.9 3033.3 3073.4 223511.0 226802.0 226927.0 227930.0 228372.0 32833.0 32904.7 33298.2 33344.7 33493.8 34743.8 34929.8 34960.0 35081.6 35097.5 13687.5 13798.7 13868.4 13901.6 13934.5 11161.7 11321.7 11426.1 11432.6 11460.0 8063.9 8084.6 8095.8 8165.6 8182.8 3149.9 3177.0 3194.1 3223.6 3244.8 877.1 898.4 911.7 950.1 951.5 28162.6 28611.4 29010.0 29465.6 29663.3 902.0 989.9 1012.5 1050.7 1057.4 15260.5 15499.7 15633.2 15843.5 15905.2 365001.0 429075.0 432029.0 436258.0 644960.0 50725.0 50896.5 51329.5 51482.0 51570.7 1179.5 1222.0 1230.9 1243.4 1243.4 29001.9 30052.2 30080.8 30281.8 30644.5 44356.3 48622.0 50780.7 50855.0 54042.5 288025.0 289763.0 291367.0 291601.0 292222.0 37131.0 37417.3 37486.6 37996.4 38039.8 40800.6 41146.4 41903.6 42039.2 42443.2 36405.0 36505.0 36641.5 37263.1 37493.6 35661.1 36328.8 36810.8 37095.3 37135.0 35687.6 35915.6 35951.8 36129.5 36604.6 32396.0 32917.8 32979.7 32991.8 33371.2 25253.0 25483.2 25762.2 25832.6 26148.9 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | [#2] jquery.html Cycles:180 Average:23515.27 Median:4621.89 stddev:58359.52 (1262.7%) stddev-sans-first:58497.36 09:22:00 INFO - PROCESS | 20495 | Values: 366.3 366.5 367.9 380.5 386.5 16438.6 16815.3 17951.4 18032.2 18179.1 15970.0 17474.1 17579.1 17638.2 17657.1 5139.3 5288.8 5316.8 5319.1 5324.8 5075.1 5234.2 5258.7 5271.8 5296.3 5187.6 5207.0 5231.9 5239.2 5251.6 5159.9 5181.9 5199.0 5211.8 5226.5 4511.5 4620.4 4623.4 4634.8 4647.7 21086.6 21486.2 21510.0 21924.9 22088.3 1881.3 1992.4 2004.8 2019.2 2497.4 13745.6 13879.9 13888.7 14148.4 14251.3 1841.1 1855.0 2001.0 2001.9 2026.5 69498.3 69601.3 70154.6 71083.0 72778.6 9306.4 9331.9 10041.8 10063.6 10267.3 13742.6 13786.8 13890.3 13942.0 13948.2 7222.7 7287.6 7404.8 7430.9 7494.8 7168.1 7235.1 7235.9 7330.3 7339.8 4283.6 4307.3 4321.7 4397.0 4456.8 1621.1 1621.4 1632.1 1650.4 1721.2 807.8 809.7 812.1 854.5 893.5 17250.6 17525.7 17878.0 18133.9 18346.2 796.9 849.4 852.5 864.9 901.3 9300.2 9654.2 9683.3 9776.6 9782.9 343795.0 346521.0 347669.0 349503.0 365666.0 79725.6 80378.0 82973.0 83663.0 84106.2 890.5 901.6 921.8 922.3 922.4 15311.7 15590.9 15763.2 15996.0 16196.5 32674.1 35735.6 36760.1 36925.0 36966.8 48581.8 52616.0 52699.0 52723.0 53093.5 7237.8 7341.4 7423.3 7493.6 7652.3 11048.5 11269.8 11382.6 11469.3 11519.1 6474.5 8893.9 9114.3 9826.9 9833.0 9952.9 9978.8 10005.7 10019.2 10170.7 10024.4 10052.7 10076.9 10251.3 10335.7 7200.2 7290.3 7307.4 7317.8 7517.4 9338.4 9518.6 10064.2 10107.1 10281.0 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | [#3] mootools.html Cycles:180 Average:5149.38 Median:5164.33 stddev:2903.94 (56.2%) stddev-sans-first:2898.38 09:22:00 INFO - PROCESS | 20495 | Values: 1393.7 1414.1 1524.3 1701.3 1724.9 6864.9 7530.7 7575.8 8005.0 8017.8 7635.8 7901.6 7905.2 7938.0 7941.0 2140.3 2197.6 2199.9 2201.2 2203.0 2171.7 2219.3 2258.4 2263.4 2270.1 2172.5 2180.8 2184.4 2199.4 2233.2 2143.6 2144.7 2154.0 2166.0 2171.1 2162.6 2192.5 2196.7 2205.8 2213.1 7945.6 7998.6 8000.0 8015.8 8052.0 4573.0 4605.3 4670.9 4704.6 4708.7 2829.7 2832.4 2858.5 2893.5 2907.8 881.9 900.8 911.7 918.8 931.7 10621.3 10658.7 10693.9 10697.3 10747.1 4086.4 4147.5 4299.2 4302.1 4306.0 9036.3 9071.7 9140.6 9142.8 9143.2 4623.4 4644.8 4658.8 4661.0 4684.9 3612.7 4165.1 4215.1 4215.8 4294.2 3654.1 3686.7 3702.2 3780.3 3882.9 1207.9 1222.3 1226.0 1239.5 1241.3 583.5 817.7 832.5 836.6 839.4 5168.7 5192.6 5284.6 5344.6 5353.9 410.4 414.5 415.5 415.6 417.9 3584.0 3662.3 3950.2 3958.9 3996.7 9144.6 9559.7 9566.3 9719.0 9844.0 9674.4 9699.4 9713.8 9756.7 9789.6 7013.9 7328.9 7370.1 7371.6 7383.5 5160.0 5293.4 5376.8 5400.8 5569.7 8574.1 8914.2 8919.7 9193.9 9215.0 8724.3 9113.6 9124.6 9131.6 9135.1 6051.9 6506.6 6657.9 6930.3 7128.3 7552.2 7606.3 7610.7 7677.4 7687.7 6741.5 6917.8 6924.1 6946.5 7059.7 6842.3 6919.4 6921.6 6945.9 6980.6 5635.8 5647.6 5664.6 5729.2 5926.5 4415.7 4480.1 4487.9 4510.7 4516.1 4624.3 4635.2 4638.9 4649.2 4681.3 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | [#4] prototype.html Cycles:180 Average:4424.01 Median:5104.22 stddev:1281.89 (25.1%) stddev-sans-first:1247.30 09:22:00 INFO - PROCESS | 20495 | Values: 286.4 286.8 296.6 296.6 304.4 5120.0 5137.2 5163.6 5171.2 5176.0 5025.8 5071.9 5089.1 5089.3 5117.8 3788.1 3878.3 3966.8 3984.7 4026.9 3961.8 3981.0 3990.2 3990.3 4004.2 3982.5 3983.6 4003.6 4013.0 4019.8 3769.3 3961.1 3979.2 4003.6 4012.1 3469.6 3494.2 3507.9 3509.0 3521.5 4948.7 4963.8 4984.6 4999.5 5014.2 4261.6 4571.3 4580.8 4592.8 4607.1 5286.3 5300.8 5306.3 5307.8 5309.4 3777.6 3802.8 3808.5 3812.4 3834.7 5325.3 5566.8 5568.4 5576.9 5609.5 3893.9 3905.1 3906.1 3919.2 3927.6 3981.7 3993.4 3994.2 4001.6 4002.3 4506.6 4540.4 4542.5 4543.0 4552.7 5128.0 5262.6 5294.3 5333.5 5383.4 1372.9 1384.2 1388.3 1393.8 1397.0 867.2 893.6 905.8 921.2 927.5 4507.3 4540.3 4559.0 4572.9 4595.3 5313.0 5362.0 5395.3 5402.9 5404.9 4417.8 4605.6 4606.9 4618.6 4632.3 2903.9 2920.9 2931.4 2931.8 2943.3 5111.2 5112.3 5121.5 5138.7 5149.2 5401.0 5609.2 5613.0 5656.6 5657.7 5028.1 5121.1 5133.8 5149.4 5151.8 5389.3 5466.7 5468.9 5487.5 5506.6 5106.6 5371.1 5385.6 5397.0 5402.6 5140.8 5154.6 5195.0 5218.5 5229.7 3863.8 3870.5 3879.2 3880.5 3882.7 5202.2 5492.7 5511.8 5529.2 5604.4 5349.8 5365.2 5386.9 5404.9 5418.5 5214.5 5339.4 5345.8 5365.7 5423.7 5261.2 5266.9 5280.3 5307.6 5336.1 5101.8 5265.5 5409.7 5419.2 5442.5 5249.9 5287.7 5289.9 5307.6 5308.8 09:22:00 INFO - PROCESS | 20495 | 09:22:00 INFO - PROCESS | 20495 | [#5] yui.html Cycles:180 Average:17315.88 Median:22941.06 stddev:24436.10 (106.5%) stddev-sans-first:24472.40 09:22:00 INFO - PROCESS | 20495 | Values: 594.7 642.5 661.2 667.6 723.3 13303.7 13722.7 13796.6 13811.0 13820.2 12773.4 12987.7 12992.4 12997.3 13017.9 616.4 760.1 761.9 779.9 786.7 782.0 786.3 789.6 790.7 793.9 832.8 836.4 845.0 845.7 846.3 837.7 838.3 839.4 841.0 842.4 611.7 615.4 615.8 617.0 617.2 12415.5 12449.4 12471.4 12485.6 12496.2 14163.9 14214.4 14244.5 14264.2 14313.1 10078.8 10188.2 10305.8 10306.1 10384.8 3320.4 3340.7 3395.7 3417.2 3419.4 61538.4 62665.0 63142.4 64644.4 64682.0 10732.4 10750.6 10792.7 10882.7 10958.3 20725.2 20727.8 20757.0 20917.9 21110.8 6969.5 7110.1 7136.8 7159.3 7187.3 3746.0 3763.7 3820.3 3831.5 3890.9 2861.4 2989.8 2990.0 2993.2 2993.3 489.2 496.7 507.4 507.7 517.0 551.4 572.8 586.2 592.2 617.9 7496.2 7550.6 7676.5 7762.9 7765.7 455.3 505.4 560.9 596.7 634.3 3672.7 3905.4 3976.2 3990.7 4071.8 93365.0 95322.5 95418.5 96208.0 96441.0 87179.0 87371.0 87402.6 87405.6 88046.6 47064.3 48570.0 56169.0 74579.0 76929.6 7377.8 7670.1 7689.9 7742.3 7927.6 39493.8 42161.8 42226.4 43093.0 43209.0 45426.8 54088.7 54849.7 64430.4 65660.7 12338.2 12340.1 12376.9 12545.7 12670.6 12579.9 12663.0 13047.2 13774.7 13803.4 10996.3 11527.9 11593.8 11647.9 11659.1 10921.4 11191.5 11665.5 11881.6 12306.9 10501.2 10745.8 11075.8 11146.3 11192.7 10170.9 10358.9 10421.5 10677.1 10729.3 9388.2 9551.1 9631.6 9642.4 9727.6 09:22:00 INFO - PROCESS | 20495 | -------- Summary: end -------- 09:22:00 INFO - PROCESS | 20495 | 09:22:01 INFO - TEST-INFO | 20495: exit 0 09:22:01 INFO - TEST-OK | dromaeo_css | took 1117653ms 09:22:01 INFO - TEST-START | kraken 09:22:01 INFO - operating with platform_type : linux_ 09:22:01 INFO - Initialising browser for kraken test... 09:22:01 INFO - TEST-INFO | started process 20743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ_rxzo/profile http://localhost:55863/getInfo.html) 09:22:06 INFO - PROCESS | 20743 | __metrics Screen width/height:1600/1200 09:22:06 INFO - PROCESS | 20743 | colorDepth:24 09:22:06 INFO - PROCESS | 20743 | Browser inner width/height: 1024/697 09:22:06 INFO - PROCESS | 20743 | __metrics 09:22:07 ERROR - PROCESS | 20743 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 09:22:08 INFO - TEST-INFO | 20743: exit 0 09:22:08 INFO - Browser initialized. 09:22:08 INFO - Running cycle 1/1 for kraken test... 09:22:08 INFO - TEST-INFO | started process 20863 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ_rxzo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:20 INFO - PROCESS | 20863 | RSS: Main: 169160704 09:22:20 INFO - PROCESS | 20863 | 09:22:22 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55863/tests/kraken/driver.html?testName=audio-beat-detection) 09:22:23 INFO - PROCESS | 20863 | RSS: Main: 173273088 09:22:23 INFO - PROCESS | 20863 | 09:22:26 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55863/tests/kraken/driver.html?testName=audio-dft) 09:22:27 INFO - PROCESS | 20863 | RSS: Main: 172986368 09:22:27 INFO - PROCESS | 20863 | 09:22:30 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55863/tests/kraken/driver.html?testName=audio-fft) 09:22:30 INFO - PROCESS | 20863 | RSS: Main: 168013824 09:22:30 INFO - PROCESS | 20863 | 09:22:32 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55863/tests/kraken/driver.html?testName=audio-oscillator) 09:22:33 INFO - PROCESS | 20863 | RSS: Main: 168800256 09:22:33 INFO - PROCESS | 20863 | 09:22:35 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:22:36 INFO - PROCESS | 20863 | RSS: Main: 169058304 09:22:36 INFO - PROCESS | 20863 | 09:22:39 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55863/tests/kraken/driver.html?testName=imaging-darkroom) 09:22:40 INFO - PROCESS | 20863 | RSS: Main: 169803776 09:22:40 INFO - PROCESS | 20863 | 09:22:43 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55863/tests/kraken/driver.html?testName=imaging-desaturate) 09:22:44 INFO - PROCESS | 20863 | RSS: Main: 166940672 09:22:44 INFO - PROCESS | 20863 | 09:22:47 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55863/tests/kraken/driver.html?testName=json-parse-financial) 09:22:48 INFO - PROCESS | 20863 | RSS: Main: 167952384 09:22:48 INFO - PROCESS | 20863 | 09:22:49 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:22:50 INFO - PROCESS | 20863 | RSS: Main: 169103360 09:22:50 INFO - PROCESS | 20863 | 09:22:52 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:22:53 INFO - PROCESS | 20863 | RSS: Main: 169041920 09:22:53 INFO - PROCESS | 20863 | 09:22:55 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:22:55 INFO - PROCESS | 20863 | RSS: Main: 169127936 09:22:55 INFO - PROCESS | 20863 | 09:22:58 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:22:59 INFO - PROCESS | 20863 | RSS: Main: 169533440 09:22:59 INFO - PROCESS | 20863 | 09:23:02 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:02 INFO - PROCESS | 20863 | RSS: Main: 169295872 09:23:02 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | Cycle 1(1): loaded http://localhost:55863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55863/tests/kraken/driver.html?testName=ai-astar) 09:23:04 INFO - PROCESS | 20863 | RSS: Main: 170209280 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | __start_tp_report 09:23:04 INFO - PROCESS | 20863 | _x_x_mozilla_page_load 09:23:04 INFO - PROCESS | 20863 | _x_x_mozilla_page_load_details 09:23:04 INFO - PROCESS | 20863 | |i|pagename|runs| 09:23:04 INFO - PROCESS | 20863 | |0;ai-astar;106;113;107;114;114;115;118;114;114;118 09:23:04 INFO - PROCESS | 20863 | |1;audio-beat-detection;158;129;147;187;124;146;147;125;177;124 09:23:04 INFO - PROCESS | 20863 | |2;audio-dft;163;165;164;171;165;163;163;163;163;162 09:23:04 INFO - PROCESS | 20863 | |3;audio-fft;77;76;77;156;77;77;76;76;162;77 09:23:04 INFO - PROCESS | 20863 | |4;audio-oscillator;86;93;147;86;86;86;134;87;85;152 09:23:04 INFO - PROCESS | 20863 | |5;imaging-gaussian-blur;118;118;119;119;117;118;118;117;118;117 09:23:04 INFO - PROCESS | 20863 | |6;imaging-darkroom;147;148;150;150;148;148;149;149;147;147 09:23:04 INFO - PROCESS | 20863 | |7;imaging-desaturate;96;96;97;95;95;95;96;97;95;96 09:23:04 INFO - PROCESS | 20863 | |8;json-parse-financial;66;67;65;67;65;67;65;66;65;64 09:23:04 INFO - PROCESS | 20863 | |9;json-stringify-tinderbox;65;68;68;69;67;66;66;70;65;66 09:23:04 INFO - PROCESS | 20863 | |10;stanford-crypto-aes;79;81;81;83;81;79;85;79;84;79 09:23:04 INFO - PROCESS | 20863 | |11;stanford-crypto-ccm;144;133;130;131;131;133;144;133;186;131 09:23:04 INFO - PROCESS | 20863 | |12;stanford-crypto-pbkdf2;167;169;165;166;165;168;170;167;166;165 09:23:04 INFO - PROCESS | 20863 | |13;stanford-crypto-sha256-iterative;69;70;69;69;69;67;70;67;68;68 09:23:04 INFO - PROCESS | 20863 | __end_tp_report 09:23:04 INFO - PROCESS | 20863 | __start_cc_report 09:23:04 INFO - PROCESS | 20863 | _x_x_mozilla_cycle_collect,1003 09:23:04 INFO - PROCESS | 20863 | __end_cc_report 09:23:04 INFO - PROCESS | 20863 | __startTimestamp1467908584811__endTimestamp 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | ------- Summary: start ------- 09:23:04 INFO - PROCESS | 20863 | Number of tests: 14 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.97 (3.5%) stddev-sans-first:3.22 09:23:04 INFO - PROCESS | 20863 | Values: 106.0 113.0 107.0 114.0 114.0 115.0 118.0 114.0 114.0 118.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:147.00 stddev:22.32 (15.2%) stddev-sans-first:23.28 09:23:04 INFO - PROCESS | 20863 | Values: 158.0 129.0 147.0 187.0 124.0 146.0 147.0 125.0 177.0 124.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.57 (1.6%) stddev-sans-first:2.69 09:23:04 INFO - PROCESS | 20863 | Values: 163.0 165.0 164.0 171.0 165.0 163.0 163.0 163.0 163.0 162.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#3] audio-fft Cycles:10 Average:93.10 Median:77.00 stddev:34.76 (45.1%) stddev-sans-first:36.38 09:23:04 INFO - PROCESS | 20863 | Values: 77.0 76.0 77.0 156.0 77.0 77.0 76.0 76.0 162.0 77.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:86.00 stddev:28.13 (32.7%) stddev-sans-first:29.05 09:23:04 INFO - PROCESS | 20863 | Values: 86.0 93.0 147.0 86.0 86.0 86.0 134.0 87.0 85.0 152.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 09:23:04 INFO - PROCESS | 20863 | Values: 118.0 118.0 119.0 119.0 117.0 118.0 118.0 117.0 118.0 117.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.16 (0.8%) stddev-sans-first:1.13 09:23:04 INFO - PROCESS | 20863 | Values: 147.0 148.0 150.0 150.0 148.0 148.0 149.0 149.0 147.0 147.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 09:23:04 INFO - PROCESS | 20863 | Values: 96.0 96.0 97.0 95.0 95.0 95.0 96.0 97.0 95.0 96.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 09:23:04 INFO - PROCESS | 20863 | Values: 66.0 67.0 65.0 67.0 65.0 67.0 65.0 66.0 65.0 64.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.50 stddev:1.70 (2.5%) stddev-sans-first:1.64 09:23:04 INFO - PROCESS | 20863 | Values: 65.0 68.0 68.0 69.0 67.0 66.0 66.0 70.0 65.0 66.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.23 (2.8%) stddev-sans-first:2.24 09:23:04 INFO - PROCESS | 20863 | Values: 79.0 81.0 81.0 83.0 81.0 79.0 85.0 79.0 84.0 79.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:133.00 stddev:17.12 (12.9%) stddev-sans-first:18.08 09:23:04 INFO - PROCESS | 20863 | Values: 144.0 133.0 130.0 131.0 131.0 133.0 144.0 133.0 186.0 131.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:1.75 (1.0%) stddev-sans-first:1.86 09:23:04 INFO - PROCESS | 20863 | Values: 167.0 169.0 165.0 166.0 165.0 168.0 170.0 167.0 166.0 165.0 09:23:04 INFO - PROCESS | 20863 | 09:23:04 INFO - PROCESS | 20863 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 09:23:04 INFO - PROCESS | 20863 | Values: 69.0 70.0 69.0 69.0 69.0 67.0 70.0 67.0 68.0 68.0 09:23:04 INFO - PROCESS | 20863 | -------- Summary: end -------- 09:23:04 INFO - PROCESS | 20863 | 09:23:05 INFO - TEST-INFO | 20863: exit 0 09:23:05 INFO - TEST-OK | kraken | took 64499ms 09:23:05 INFO - SUITE-END | took 1182s 09:23:05 INFO - Completed test suite (00:19:42) 09:23:05 INFO - javascript benchmark 09:23:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6392.822954274152, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2572.9228123156304, 2623.8294510856795, 2640.907568235112, 2641.696204936433, 2648.9337766555846, 4716.0, 4716.221823399135, 4740.573348398643, 4838.661293709441, 4855.611551075915, 4663.27719203524, 4679.625629949604, 4703.764811759415, 4800.303955926389, 4814.879628009301, 4268.061026574149, 4347.804348804311, 4383.671224658164, 4395.428594282739, 4409.669274804386, 641.0340233311974, 4303.913921721563, 4309.461317335333, 4378.5183629800695, 4400.82396704133, 4278.037441575651, 4333.696641235115, 4347.5869792369995, 4358.956410435887, 4409.985703288229, 4337.566243375637, 4354.934675979863, 4359.84740534083, 4400.0, 4408.53710360414, 4226.239276930151, 4345.174416860818, 4363.258246098139, 4364.519902810688, 4385.956140438587, 4680.695754775928, 4817.927731084036, 4832.202686556714, 4843.806247750086, 4849.9757501212625, 5041.924371134436, 5141.203113517411, 5179.119549676564, 5193.350831146106, 5234.869128271824, 5088.287639730441, 5137.101007323741, 5148.459411761786, 5149.201873709581, 5201.193814958688, 4745.928811067837, 4765.73788441639, 4794.856154315376, 4809.917768502059, 4825.252085926722, 5138.58891288696, 5192.221166825007, 5197.688138711614, 5200.6619569727845, 5280.445553216934, 5006.224035274538, 5044.1677123274985, 5069.9746501267255, 5070.138076527, 5101.770420331094, 5147.150720131136, 5148.30497882781, 5157.149070403341, 5164.070467315919, 5198.402183748917, 4831.130396528659, 5021.799128034838, 5075.746212689424, 5107.387113546398, 5127.3847138343635, 5083.517065878736, 5086.4659210783075, 5097.592192624581, 5105.566026887756, 5123.769430375642, 4213.367994800805, 4266.445362102907, 4267.871963841089, 4305.763183024964, 4306.763128027926, 3635.5455568053994, 3654.3604869147794, 3691.0587800110798, 3694.390425579803, 3708.610595887447, 4285.10012897295, 4321.524632290446, 4324.113556720865, 4337.937205384638, 4391.604755572014, 5050.090983622909, 5055.039542486916, 5063.544281014726, 5063.620228482805, 5111.437741848394, 4311.655067594585, 4353.934690979638, 4375.409319741794, 4432.29083346663, 4459.910801784011, 4604.608608268268, 4609.377734005933, 4610.631149508032, 4613.0, 4663.976680116578, 4762.476127625959, 4821.9035619288115, 4825.9758701206265, 4826.855194344175, 4868.95131048685, 5057.31726216956, 5114.386273647037, 5130.025295193901, 5158.0, 5159.380874295109, 4823.782929768098, 4831.396075490564, 4837.637177211794, 4856.344393506832, 4889.657723959289, 4901.681390709592, 5062.82280120194, 5094.719790411415, 5111.591072714248, 5148.639595228298, 5093.745312734274, 5134.486551344836, 5141.61437892167, 5150.0472412603785, 5167.0, 5005.224190250517, 5011.123053465556, 5012.699238045583, 5019.64862459639, 5071.061853557104, 4876.171050921281, 4935.309056732132, 4986.252062190701, 5005.049040682259, 5007.7746501408255, 4745.976270118766, 4789.473157952552, 4862.732549709658, 4896.6572339935865, 4898.828541001048, 4947.282644016669, 4954.20732682769, 4963.329950456787, 4975.0, 5013.974930125326, 4801.807927682854, 4872.317875497362, 4898.4121905371585, 4923.630727695366, 4946.925796113133], "value": 4647.755805564673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.8382269141948, 560.4003716023853, 572.5705720709468, 573.0344369736994, 592.5170985646695, 35777.0, 39828.20343593127, 39935.80032099839, 39942.0, 39946.0, 40240.39639405404, 40499.595004050025, 40580.0, 40706.79646601763, 40760.0, 7803.687852485894, 7953.642086106111, 7994.400419968497, 8009.0, 8012.19878012197, 7805.60971951403, 7812.257835505618, 7873.173316801739, 7877.094134174557, 7897.131315555284, 7879.0, 7914.564698941556, 7928.722494712686, 7935.682572697114, 7943.245391687809, 7867.7639670809685, 7878.487898286593, 7898.526088434654, 7906.762797116067, 7916.841663166704, 7750.728724494672, 7771.650275737549, 7802.804929876742, 7827.0607527096545, 7833.725819596287, 39073.41389879126, 39414.802925985474, 39499.60500394988, 39531.209375812614, 39735.40396894049, 2404.579198640231, 3045.1473587395567, 3086.120455670123, 3129.405412971551, 3142.4343618148723, 26965.0, 28626.570601440995, 28743.42513149746, 29274.268143296376, 29547.0, 2979.8510074496407, 3012.2469382654335, 3015.894443694482, 3033.302340461706, 3073.4160509503345, 223511.0, 226802.0, 226927.0, 227930.0, 228372.0, 32833.0, 32904.67095329016, 33298.16754581155, 33344.66655333464, 33493.83253083719, 34743.82628086843, 34929.825350873085, 34960.0, 35081.64918350835, 35097.47353789695, 13687.452501899812, 13798.65503362404, 13868.445262189602, 13901.567225735456, 13934.512292069729, 11161.72095697614, 11321.71695707614, 11426.143039272089, 11432.599859004895, 11460.025897798614, 8063.919360806317, 8084.585197590398, 8095.757127286191, 8165.591720413956, 8182.836343273101, 3149.921251968719, 3176.9682303177133, 3194.073718621574, 3223.6453990061073, 3244.8053116813066, 877.0746862060587, 898.4205187654057, 911.6763548940163, 950.1401231885155, 951.4861974533675, 28162.577561336595, 28611.427771444873, 29010.0, 29465.55801662934, 29663.25841853971, 902.0483390023458, 989.9356541824758, 1012.5392946209457, 1050.7425680708122, 1057.434272664121, 15260.46588369424, 15499.690006199813, 15633.218339083, 15843.524694259191, 15905.204739762965, 365001.0, 429075.0, 432029.0, 436258.0, 644960.0, 50725.0, 50896.491035089915, 51329.48670513322, 51482.0, 51570.74214628903, 1179.504608064615, 1222.0284873525568, 1230.949881333237, 1243.3534562027694, 1243.434237421971, 29001.85499072491, 30052.24869378283, 30080.849595751883, 30281.848590756905, 30644.540331894594, 44356.33465497955, 48622.0, 50780.746096269286, 50855.0, 54042.459575403744, 288025.0, 289763.0, 291367.0, 291601.0, 292222.0, 37131.0, 37417.2516549662, 37486.62513374831, 37996.430053549775, 38039.80980095082, 40800.59199407968, 41146.38280425736, 41903.58096418997, 42039.15921681488, 42443.15113697771, 36405.0, 36505.0, 36641.45037824488, 37263.06842328963, 37493.625063749016, 35661.1084722884, 36328.81835590805, 36810.8159459201, 37095.25809483741, 37135.0, 35687.64312356843, 35915.64084359123, 35951.820240898625, 36129.458058129676, 36604.63395366012, 32396.028119156465, 32917.835410822794, 32979.67020329862, 32991.83504082464, 33371.16572085717, 25253.0, 25483.235502934942, 25762.227133186036, 25832.612510812727, 26148.86925565436], "value": 16687.63942191528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.33144511266937, 366.543653151826, 367.86389036056664, 380.5015429786977, 386.5091334005813, 16438.589035274123, 16815.327386904526, 17951.3717019904, 18032.18855151518, 18179.091045447723, 15970.0, 17474.126293685327, 17579.121043947816, 17638.206280717368, 17657.117144142805, 5139.25480805283, 5288.814891478799, 5316.813911513098, 5319.122344813101, 5324.787008519655, 5075.137226671474, 5234.162533994561, 5258.737063146847, 5271.841844744664, 5296.311479507659, 5187.584993200554, 5207.0366982108435, 5231.921521177185, 5239.240310155025, 5251.632385732981, 5159.896802063975, 5181.896362072737, 5198.974005129969, 5211.791528338862, 5226.503482169188, 4511.458624964992, 4620.422447194101, 4623.352730617717, 4634.83778067766, 4647.674662773574, 21086.578268434547, 21486.24798132058, 21510.0, 21924.89037554818, 22088.33734987953, 1881.294514557041, 1992.4122383896786, 2004.7995200479982, 2019.1822311963679, 2497.3881399057345, 13745.587632370945, 13879.930600346934, 13888.722225555432, 14148.434062637481, 14251.287435628177, 1841.1346667066457, 1854.9536261593432, 2000.9699854502048, 2001.9399418017483, 2026.523766914774, 69498.30501694969, 69601.30398695999, 70154.64922675405, 71082.99999999948, 72778.63610681913, 9306.395084319498, 9331.90668093324, 10041.849372259421, 10063.647772327933, 10267.281290309607, 13742.587722368346, 13786.793198102036, 13890.305484725723, 13942.0, 13948.232847193502, 7222.711091556384, 7287.599182044933, 7404.777856664308, 7430.851382972419, 7494.775156745306, 7168.068151140423, 7235.131784185932, 7235.92764072363, 7330.266973302627, 7339.816504587428, 4283.571642835692, 4307.289297265978, 4321.719088259253, 4396.956030439718, 4456.844010459618, 1621.100289339428, 1621.4000819696553, 1632.126812155491, 1650.438850790737, 1721.234050847386, 807.8142027333746, 809.668036105194, 812.1229072601576, 854.5129276312442, 893.5041052215953, 17250.568735781704, 17525.7371139433, 17878.0, 18133.90933045326, 18346.174422151034, 796.9123396426388, 849.3799526345803, 852.5268475995758, 864.9264812490883, 901.3330135699666, 9300.209482193954, 9654.179394751385, 9683.32216744821, 9776.560054797552, 9782.853257201148, 343795.0, 346521.0, 347669.0, 349503.0, 365666.0, 79725.60137199392, 80378.0, 82973.0, 83663.0, 84106.15893840983, 890.4746199742053, 901.6393442623134, 921.7833809054866, 922.3313098004028, 922.4142669404843, 15311.693766124838, 15590.9220453897, 15763.211839408214, 15996.0, 16196.514104576881, 32674.116942725625, 35735.64264357427, 36760.08099797527, 36925.0, 36966.815165923996, 48581.75709121432, 52616.0, 52699.0, 52723.0, 53093.469065308855, 7237.819054523679, 7341.4126869849215, 7423.294786995227, 7493.550386976799, 7652.311291983749, 11048.502817373077, 11269.830952535882, 11382.601608943647, 11469.31184128955, 11519.136064795006, 6474.482041436768, 8893.866592001255, 9114.27085833145, 9826.901730982885, 9833.016698330395, 9952.850707239542, 9978.800423991333, 10005.74985625336, 10019.248556358449, 10170.745731356776, 10024.398536087858, 10052.748681283027, 10076.949615251877, 10251.28241023151, 10335.689929302132, 7200.207977122617, 7290.343869051599, 7307.378872795872, 7317.780466586011, 7517.43619228571, 9338.439693618404, 9518.619255229713, 10064.194864410976, 10107.090361867467, 10281.023302786223], "value": 8232.504452264997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.7351903138406, 1414.0949792133033, 1524.3369134426518, 1701.3109690575307, 1724.948251552454, 6864.862702745942, 7530.698772049118, 7575.84848303035, 8004.959975200116, 8017.79955501112, 7635.847283054336, 7901.565413902233, 7905.209479052092, 7938.0077490313715, 7941.0, 2140.250912180736, 2197.5824593327297, 2199.923002694906, 2201.218567408571, 2202.9889850550803, 2171.695962565242, 2219.323106452531, 2258.4015235962484, 2263.4341414646337, 2270.137347807831, 2172.4568857785553, 2180.80372766451, 2184.421128400975, 2199.3841724317135, 2233.2406981626245, 2143.6355819510723, 2144.742630884296, 2153.956920861574, 2165.9566808663817, 2171.1098449635733, 2162.643163877974, 2192.506685995654, 2196.6924630551734, 2205.757366689663, 2213.1479380438486, 7945.64244608994, 7998.560079195642, 8000.0, 8015.799605009863, 8052.0, 4572.977135114304, 4605.30920361945, 4670.929936050962, 4704.576588107053, 4708.74101924394, 2829.7170282971742, 2832.4051949090717, 2858.4997625415467, 2893.537034074559, 2907.7964542482036, 881.8853549038583, 900.806536084636, 911.7036962987056, 918.779492921694, 931.7018554062703, 10621.25651204416, 10658.73353166177, 10693.893061069368, 10697.251192416456, 10747.140228781756, 4086.4074709167003, 4147.52303485097, 4299.161663475592, 4302.053548219386, 4306.0, 9036.32227582934, 9071.682491112912, 9140.588673509708, 9142.771430714285, 9143.222826059859, 4623.42207224097, 4644.767761611974, 4658.836940707059, 4661.0, 4684.929726054112, 3612.674859262679, 4165.062860856283, 4215.114825886537, 4215.810288537024, 4294.227039132986, 3654.0682126057686, 3686.668199862025, 3702.22253326799, 3780.2628487444686, 3882.9029274267805, 1207.897328727068, 1222.3093951917137, 1225.9816102758466, 1239.4856134703996, 1241.3172754984723, 583.527342852291, 817.6811043692965, 832.4921797703396, 836.623519416253, 839.4207996482407, 5168.664036837594, 5192.61055420845, 5284.630075894727, 5344.625876188629, 5353.866153346197, 410.37417937644733, 414.4943169333408, 415.45990212723336, 415.60725114766257, 417.9143275628489, 3583.9820800895827, 3662.340778659867, 3950.2297052075146, 3958.8812335629977, 3996.7202295839593, 9144.634214631473, 9559.713208603753, 9566.330356874952, 9719.0, 9843.950780246052, 9674.371165874196, 9699.418034917928, 9713.757156071155, 9756.658516951873, 9789.580510826032, 7013.859722805515, 7328.9267107329315, 7370.115586129698, 7371.631418429057, 7383.483156179016, 5160.0, 5293.391260005149, 5376.7580458878665, 5400.783968641211, 5569.749361278671, 8574.056853745959, 8914.197722205032, 8919.73240802777, 9193.908060919573, 9215.0, 8724.258438032584, 9113.635454581743, 9124.589393477178, 9131.589078491617, 9135.086491350812, 6051.909221361771, 6506.60960342381, 6657.900131497934, 6930.27232140618, 7128.251533588898, 7552.169261381354, 7606.277403646644, 7610.733624323122, 7677.424193185422, 7687.730929417444, 6741.52809303344, 6917.757878474229, 6924.099867017256, 6946.5137440378685, 7059.682314295766, 6842.281560436281, 6919.37725604698, 6921.550099243533, 6945.930540694529, 6980.616066116209, 5635.788305514334, 5647.576431767552, 5664.5751568631695, 5729.2265544151005, 5926.525877929669, 4415.712978656377, 4480.081583275486, 4487.887802804956, 4510.706804057726, 4516.09678064395, 4624.260118381043, 4635.212013957568, 4638.930416043694, 4649.186392381387, 4681.321208424827], "value": 4075.3048276991935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.3714147446356, 286.8150043222123, 296.5566478115218, 296.5788580216093, 304.41704136578454, 5120.0, 5137.178051511759, 5163.63854530183, 5171.198464238045, 5175.974120129399, 5025.849224523261, 5071.858831762852, 5089.099213448336, 5089.2620570017325, 5117.820876269322, 3788.1476667749744, 3878.3212937735925, 3966.801659916993, 3984.728704638357, 4026.8590599329027, 3961.8217180226816, 3980.9601903981024, 3990.1820126874068, 3990.261801566705, 4004.199160167978, 3982.5420076691116, 3983.5618082010956, 4003.5996400360023, 4012.959870401288, 4019.7588144711262, 3769.2838360711376, 3961.108750531136, 3979.1643754811525, 4003.619656132663, 4012.117334186474, 3469.60099588548, 3494.178867966026, 3507.94738078929, 3509.017475106974, 3521.542199514047, 4948.703077815343, 4963.751812409365, 4984.601231901439, 4999.450060493343, 5014.219951917054, 4261.552536983603, 4571.291449825282, 4580.770961451914, 4592.793324300381, 4607.14767767964, 5286.312779338661, 5300.787968481256, 5306.257124002643, 5307.761150748225, 5309.36287645485, 3777.6411240932066, 3802.790846503441, 3808.4668146459517, 3812.4281357796276, 3834.65488106069, 5325.254464374952, 5566.777328906839, 5568.415316391802, 5576.888462230773, 5609.49514543693, 3893.863714770026, 3905.1213476967455, 3906.1055388136733, 3919.2161567686576, 3927.6434139516064, 3981.7411868228473, 3993.4409182714444, 3994.2410941920944, 4001.6194412927493, 4002.2595819773437, 4506.639468842484, 4540.432445944257, 4542.523679804077, 4542.977285113553, 4552.658550608718, 5128.025780020514, 5262.578993680497, 5294.326365185557, 5333.466653334635, 5383.407825139231, 1372.876441120304, 1384.2179168769612, 1388.2503448137893, 1393.770027945398, 1396.9790453143212, 867.2065060469725, 893.629143905272, 905.8097799462055, 921.1939552891221, 927.4759760735163, 4507.2788353863225, 4540.298522379179, 4558.954410455919, 4572.885677858014, 4595.333676616872, 5312.9734351328, 5362.0, 5395.325584301962, 5402.945970540244, 5404.891902161935, 4417.757023363682, 4605.585497305258, 4606.88482787933, 4618.630509559227, 4632.2819962905805, 2903.8548072596286, 2920.853957302169, 2931.4430258250864, 2931.83874886879, 2943.337749006499, 5111.182210846247, 5112.284280200774, 5121.4622464641425, 5138.743062846843, 5149.150390185578, 5400.972995134999, 5609.158626206102, 5612.97193514038, 5656.632318899258, 5657.717114144276, 5028.058585727391, 5121.055393148954, 5133.768980395891, 5149.407818100966, 5151.7681704323395, 5389.326334208224, 5466.671999680032, 5468.945310546844, 5487.533559647315, 5506.614536982373, 5106.617003724661, 5371.086915224343, 5385.59974406665, 5396.9730151348995, 5402.5677945763455, 5140.820071297487, 5154.639175257696, 5195.0, 5218.4605541366145, 5229.686218826882, 3863.8261278241985, 3870.5161854768153, 3879.243547508209, 3880.5149356330458, 3882.6699730523223, 5202.167653175474, 5492.697901615449, 5511.751971161388, 5529.170624406211, 5604.355499117653, 5349.812756553502, 5365.248865158803, 5386.919196212139, 5404.918926216032, 5418.45815418455, 5214.478552144755, 5339.412664606968, 5345.75944082525, 5365.651232669864, 5423.674579525241, 5261.184516399964, 5266.920996185137, 5280.260763493037, 5307.57539396855, 5336.14621660548, 5101.821436249714, 5265.4997775211295, 5409.729513524229, 5419.187121931742, 5442.482964118402, 5249.947500525099, 5287.673423693563, 5289.920651190158, 5307.57539396855, 5308.840734777963], "value": 4010.6595381726174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.726425844112, 642.4924309795261, 661.1635686996461, 667.5727534377996, 723.3056265984654, 13303.733925321489, 13722.725545489084, 13796.586102416919, 13811.0, 13820.170789752621, 12773.425195866184, 12987.740245195091, 12992.350382480861, 12997.285149316784, 13017.869821301783, 616.4328817487899, 760.0765070439415, 761.942854285928, 779.9376049915993, 786.7010535996313, 781.9960900195491, 786.2766255045343, 789.5539020453455, 790.699534177012, 793.9007624046994, 832.81261716114, 836.3560058754755, 845.002896582036, 845.7420486751538, 846.2552953400999, 837.656560810071, 838.3335248477475, 839.3704721458906, 840.9915900840974, 842.3850589069982, 611.7308384310934, 615.3969110271959, 615.8429600451901, 616.9876602467971, 617.2438762515927, 12415.503379864795, 12449.439775210138, 12471.438785254686, 12485.625431237077, 12496.187747796364, 14163.929180354135, 14214.360353784105, 14244.501442449464, 14264.215468149248, 14313.141211527342, 10078.848817267746, 10188.235882308856, 10305.845412318746, 10306.053767272377, 10384.844227336596, 3320.369129865342, 3340.682635149657, 3395.7283417326553, 3417.2140407706365, 3419.384510788057, 61538.384616153715, 62665.0, 63142.36857631411, 64644.3535564643, 64682.0, 10732.356058636507, 10750.623728169476, 10792.730181745519, 10882.72793180161, 10958.342499450058, 20725.170993160104, 20727.792722072587, 20757.0, 20917.895410523153, 21110.788892111188, 6969.47728920333, 7110.075690160246, 7136.785896423115, 7159.319864612853, 7187.31720486553, 3745.9812700936322, 3763.6989040876665, 3820.2741479118877, 3831.5210598675167, 3890.90272743178, 2861.413410250894, 2989.805662631922, 2989.9850500747357, 2993.1768763589753, 2993.2965753048015, 489.22213680247864, 496.74417674897455, 507.4468828976433, 507.6573313013775, 516.968981861082, 551.3907132618478, 572.8281515545319, 586.1559354529464, 592.2301008688687, 617.9104029915637, 7496.212897645669, 7550.622468876534, 7676.501027433199, 7762.883556746653, 7765.72819951299, 455.34657766105744, 505.4212926199481, 560.9454226054991, 596.6658671144173, 634.2769243062912, 3672.7245456590863, 3905.3946638271113, 3976.165005348851, 3990.6607938324987, 4071.776052317092, 93365.0, 95322.52338738262, 95418.52290738502, 96208.0, 96441.0, 87179.0, 87371.0, 87402.56298718593, 87405.56297218474, 88046.55976720076, 47064.2940355895, 48570.0, 56169.0, 74579.0, 76929.61535192288, 7377.778666639795, 7670.117936437158, 7689.92310076892, 7742.264484873928, 7927.643256053376, 39493.80253098716, 42161.789191053846, 42226.36660450157, 43093.0, 43209.0, 45426.772866135456, 54088.729556351966, 54849.725751370985, 64430.35569644431, 65660.67169664313, 12338.198017128858, 12340.074494413135, 12376.876231237573, 12545.686357841127, 12670.619881403572, 12579.93710031444, 12663.0, 13047.217166969633, 13774.65563360924, 13803.378847952066, 10996.340219586851, 11527.884721153017, 11593.768124637292, 11647.88352116468, 11659.125565582446, 10921.399323037309, 11191.496382662637, 11665.533378665097, 11881.5841445549, 12306.876931230574, 10501.159907207253, 10745.838812417976, 11075.833862491907, 11146.275492092987, 11192.664220073411, 10170.89829101729, 10358.896411036094, 10421.53103110377, 10677.14582833387, 10729.302595331279, 9388.155066044088, 9551.0926461986, 9631.614735410505, 9642.382517810851, 9727.610895564098], "value": 6539.794844265551, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 107.0, 114.0, 114.0, 115.0, 118.0, 114.0, 114.0, 118.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 147.0, 187.0, 124.0, 146.0, 147.0, 125.0, 177.0, 124.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 171.0, 165.0, 163.0, 163.0, 163.0, 163.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 156.0, 77.0, 77.0, 76.0, 76.0, 162.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 93.0, 147.0, 86.0, 86.0, 86.0, 134.0, 87.0, 85.0, 152.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 119.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 150.0, 150.0, 148.0, 148.0, 149.0, 149.0, 147.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 67.0, 65.0, 67.0, 65.0, 66.0, 65.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 68.0, 69.0, 67.0, 66.0, 66.0, 70.0, 65.0, 66.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 81.0, 83.0, 81.0, 79.0, 85.0, 79.0, 84.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 130.0, 131.0, 131.0, 133.0, 144.0, 133.0, 186.0, 131.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 165.0, 166.0, 165.0, 168.0, 170.0, 167.0, 166.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 67.0, 70.0, 67.0, 68.0, 68.0], "value": 68.6, "unit": "score"}]}]} 09:23:06 INFO - Return code: 0 09:23:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:23:06 ERROR - # TBPL SUCCESS # 09:23:06 INFO - Running post-action listener: _resource_record_post_action 09:23:06 INFO - ##### 09:23:06 INFO - ##### Finished run-tests step (success) 09:23:06 INFO - ##### 09:23:06 INFO - Running post-run listener: _resource_record_post_run 09:23:06 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 16384; Write bytes: 546627584; Read time: 528; Write time: 515888 09:23:06 INFO - TinderboxPrint: CPU usage
13.3% 09:23:06 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 528 09:23:06 INFO - TinderboxPrint: I/O write bytes / time
546,627,584 / 515,888 09:23:06 INFO - TinderboxPrint: CPU idle
8,293.0 (86.7%) 09:23:06 INFO - TinderboxPrint: CPU user
1,219.5 (12.7%) 09:23:06 INFO - TinderboxPrint: Swap in / out
0 / 0 09:23:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 246120448; Read time: 124; Write time: 236448 09:23:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 300507136; Read time: 396; Write time: 279440 09:23:06 INFO - Running post-run listener: _upload_blobber_files 09:23:06 INFO - Blob upload gear active. 09:23:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:23:06 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 09:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:23:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:23:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:23:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:07 INFO - (blobuploader) - INFO - Done attempting. 09:23:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:23:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:11 INFO - (blobuploader) - INFO - Done attempting. 09:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:12 INFO - (blobuploader) - INFO - Done attempting. 09:23:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:23:12 INFO - Return code: 0 09:23:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:23:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:23:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06f1d0eddf7ca12f7603eb5fa69f73b558215c50464df222e9b16ca06a8a6cf2dffd1c47f7d64d8a4730ad13b5e5a314aab41611e02d97de66ccc5b1cb29226f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97eb91ecd517b4eaa5a0371e7e2b8d9194fbcc515eb836d8c06dd95817816761a99d061d957661a3a8738e71caaf46672d2f16140496cf775d046e9e31d0de15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51bcb9b2d404d8bbc0d468d16eaa30d56ed5c3d2caa5b7257a7f255eb3e5afeebec42450009ecbe17230b45dabab924552daaa8b1eb3f808754f4bfddef00015"} 09:23:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:23:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:23:12 INFO - Contents: 09:23:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06f1d0eddf7ca12f7603eb5fa69f73b558215c50464df222e9b16ca06a8a6cf2dffd1c47f7d64d8a4730ad13b5e5a314aab41611e02d97de66ccc5b1cb29226f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97eb91ecd517b4eaa5a0371e7e2b8d9194fbcc515eb836d8c06dd95817816761a99d061d957661a3a8738e71caaf46672d2f16140496cf775d046e9e31d0de15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51bcb9b2d404d8bbc0d468d16eaa30d56ed5c3d2caa5b7257a7f255eb3e5afeebec42450009ecbe17230b45dabab924552daaa8b1eb3f808754f4bfddef00015"} 09:23:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:23:12 INFO - Copying logs to upload dir... 09:23:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:23:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.325818 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-07 09:23:12.184164) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 09:23:12.187732) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379 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-Non-PGO/sha512/06f1d0eddf7ca12f7603eb5fa69f73b558215c50464df222e9b16ca06a8a6cf2dffd1c47f7d64d8a4730ad13b5e5a314aab41611e02d97de66ccc5b1cb29226f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97eb91ecd517b4eaa5a0371e7e2b8d9194fbcc515eb836d8c06dd95817816761a99d061d957661a3a8738e71caaf46672d2f16140496cf775d046e9e31d0de15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51bcb9b2d404d8bbc0d468d16eaa30d56ed5c3d2caa5b7257a7f255eb3e5afeebec42450009ecbe17230b45dabab924552daaa8b1eb3f808754f4bfddef00015"} build_url:https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/D74TtTLcQIuVs_G8Zh0RKQ/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-Non-PGO/sha512/06f1d0eddf7ca12f7603eb5fa69f73b558215c50464df222e9b16ca06a8a6cf2dffd1c47f7d64d8a4730ad13b5e5a314aab41611e02d97de66ccc5b1cb29226f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97eb91ecd517b4eaa5a0371e7e2b8d9194fbcc515eb836d8c06dd95817816761a99d061d957661a3a8738e71caaf46672d2f16140496cf775d046e9e31d0de15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/51bcb9b2d404d8bbc0d468d16eaa30d56ed5c3d2caa5b7257a7f255eb3e5afeebec42450009ecbe17230b45dabab924552daaa8b1eb3f808754f4bfddef00015"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 09:23:12.213714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 09:23:12.214085) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467906845.507710-1713262379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 09:23:12.299209) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 09:23:12.299543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 09:23:12.299858) ========= ========= Total master_lag: 0.16 =========