builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1468277539.59 results: success (0) buildid: 20160711150926 builduid: 48f51566060e45959cb749adbec6f59e revision: f87c66fa12c635e07cd071dbfb9646258b7896d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.592602) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.593086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.593370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.608458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.608747) ========= 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=923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 15:52:20-- 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% 221M=0s 2016-07-11 15:52:20 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.731779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.732439) ========= 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=923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.782271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:19.782636) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f87c66fa12c635e07cd071dbfb9646258b7896d2 --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 f87c66fa12c635e07cd071dbfb9646258b7896d2 --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=923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 15:52:20,304 truncating revision to first 12 chars 2016-07-11 15:52:20,304 Setting DEBUG logging. 2016-07-11 15:52:20,304 attempt 1/10 2016-07-11 15:52:20,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f87c66fa12c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 15:52:20,622 unpacking tar archive at: fx-team-f87c66fa12c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:20.460304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:20.460677) ========= script_repo_revision: f87c66fa12c635e07cd071dbfb9646258b7896d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:20.461104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:20.461371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:52:20.472302) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-11 15:52:20.472586) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:52:21 INFO - MultiFileLogger online at 20160711 15:52:21 in /builds/slave/test 15:52:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:52:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:21 INFO - {'append_to_log': False, 15:52:21 INFO - 'base_work_dir': '/builds/slave/test', 15:52:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:52:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:21 INFO - 'branch': 'Fx-Team-Non-PGO', 15:52:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:21 INFO - 'config_files': ('talos/linux_config.py',), 15:52:21 INFO - 'default_actions': ('clobber', 15:52:21 INFO - 'read-buildbot-config', 15:52:21 INFO - 'download-and-extract', 15:52:21 INFO - 'populate-webroot', 15:52:21 INFO - 'create-virtualenv', 15:52:21 INFO - 'install', 15:52:21 INFO - 'run-tests'), 15:52:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:21 INFO - 'download_minidump_stackwalk': True, 15:52:21 INFO - 'download_symbols': 'ondemand', 15:52:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:21 INFO - 'installer_path': 'installer.exe', 15:52:21 INFO - 'log_level': 'info', 15:52:21 INFO - 'log_name': 'talos', 15:52:21 INFO - 'log_to_console': True, 15:52:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:52:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:52:21 INFO - 'opt_config_files': (), 15:52:21 INFO - 'pip_index': False, 15:52:21 INFO - 'sps_profile': False, 15:52:21 INFO - 'sps_profile_interval': 0, 15:52:21 INFO - 'suite': 'dromaeojs', 15:52:21 INFO - 'system_bits': '32', 15:52:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:21 INFO - 'title': 'talos-linux64-ix-007', 15:52:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:21 INFO - 'use_talos_json': True, 15:52:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:21 INFO - 'work_dir': 'build'} 15:52:21 INFO - ##### 15:52:21 INFO - ##### Running clobber step. 15:52:21 INFO - ##### 15:52:21 INFO - Running pre-action listener: _resource_record_pre_action 15:52:21 INFO - Running main action method: clobber 15:52:21 INFO - rmtree: /builds/slave/test/build 15:52:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:21 INFO - Running post-action listener: _resource_record_post_action 15:52:21 INFO - ##### 15:52:21 INFO - ##### Finished clobber step (success) 15:52:21 INFO - ##### 15:52:21 INFO - ##### 15:52:21 INFO - ##### Running read-buildbot-config step. 15:52:21 INFO - ##### 15:52:21 INFO - Running pre-action listener: _resource_record_pre_action 15:52:21 INFO - Running main action method: read_buildbot_config 15:52:21 INFO - Using buildbot properties: 15:52:21 INFO - { 15:52:21 INFO - "project": "", 15:52:21 INFO - "product": "firefox", 15:52:21 INFO - "script_repo_revision": "production", 15:52:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:52:21 INFO - "repository": "", 15:52:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:52:21 INFO - "buildid": "20160711150926", 15:52:21 INFO - "pgo_build": "False", 15:52:21 INFO - "basedir": "/builds/slave/test", 15:52:21 INFO - "buildnumber": 1971, 15:52:21 INFO - "slavename": "talos-linux64-ix-007", 15:52:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:52:21 INFO - "platform": "ubuntu64_hw", 15:52:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:52:21 INFO - "branch": "fx-team", 15:52:21 INFO - "repo_path": "integration/fx-team", 15:52:21 INFO - "revision": "f87c66fa12c635e07cd071dbfb9646258b7896d2", 15:52:21 INFO - "stage_platform": "linux64", 15:52:21 INFO - "builduid": "48f51566060e45959cb749adbec6f59e", 15:52:21 INFO - "slavebuilddir": "test" 15:52:21 INFO - } 15:52:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:52:21 INFO - Running post-action listener: _resource_record_post_action 15:52:21 INFO - ##### 15:52:21 INFO - ##### Finished read-buildbot-config step (success) 15:52:21 INFO - ##### 15:52:21 INFO - ##### 15:52:21 INFO - ##### Running download-and-extract step. 15:52:21 INFO - ##### 15:52:21 INFO - Running pre-action listener: _resource_record_pre_action 15:52:21 INFO - Running main action method: download_and_extract 15:52:21 INFO - mkdir: /builds/slave/test/build/tests 15:52:21 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')]} 15:52:21 INFO - https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:52:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:52:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:52:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:22 INFO - Downloaded 1361 bytes. 15:52:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:52:22 INFO - Using the following test package requirements: 15:52:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:52:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:52:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'jsshell-linux-x86_64.zip'], 15:52:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:52:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:52:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:52:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:52:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:52:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:52:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:52:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:52:22 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')]} 15:52:22 INFO - https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:52:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:52:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:23 INFO - Downloaded 22700380 bytes. 15:52:23 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'] 15:52:23 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 15:52:24 INFO - Return code: 0 15:52:24 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 15:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:24 INFO - https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:25 INFO - Downloaded 22700380 bytes. 15:52:25 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'] 15:52:25 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 15:52:26 INFO - Return code: 0 15:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:26 INFO - https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:52:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:52:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:27 INFO - Downloaded 14403333 bytes. 15:52:27 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'] 15:52:27 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 15:52:28 INFO - Return code: 0 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:28 INFO - https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/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 15:52:29 INFO - Downloaded 56652367 bytes. 15:52:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:29 INFO - mkdir: /builds/slave/test/properties 15:52:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:29 INFO - Contents: 15:52:29 INFO - build_url:https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:52:30 INFO - Running post-action listener: _resource_record_post_action 15:52:30 INFO - Running post-action listener: set_extra_try_arguments 15:52:30 INFO - ##### 15:52:30 INFO - ##### Finished download-and-extract step (success) 15:52:30 INFO - ##### 15:52:30 INFO - ##### 15:52:30 INFO - ##### Running populate-webroot step. 15:52:30 INFO - ##### 15:52:30 INFO - Running pre-action listener: _resource_record_pre_action 15:52:30 INFO - Running main action method: populate_webroot 15:52:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:30 INFO - '--tppagecycles', 15:52:30 INFO - '7'], 15:52:30 INFO - 'tests': ['tsvgm']}}, 15:52:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['damp', 'tps']}, 15:52:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'tests': ['damp', 'tps']}, 15:52:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['dromaeo_dom']}, 15:52:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['basic_compositor_video']}, 15:52:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:52:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['a11yr', 15:52:30 INFO - 'ts_paint', 15:52:30 INFO - 'tpaint', 15:52:30 INFO - 'sessionrestore', 15:52:30 INFO - 'sessionrestore_no_auto_restore', 15:52:30 INFO - 'tabpaint']}, 15:52:30 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:30 INFO - 'ts_paint', 15:52:30 INFO - 'tpaint', 15:52:30 INFO - 'sessionrestore', 15:52:30 INFO - 'sessionrestore_no_auto_restore', 15:52:30 INFO - 'tabpaint']}, 15:52:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:30 INFO - 'ts_paint', 15:52:30 INFO - 'tpaint', 15:52:30 INFO - 'sessionrestore', 15:52:30 INFO - 'sessionrestore_no_auto_restore', 15:52:30 INFO - 'tabpaint']}, 15:52:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:30 INFO - 'ts_paint', 15:52:30 INFO - 'tpaint', 15:52:30 INFO - 'sessionrestore', 15:52:30 INFO - 'sessionrestore_no_auto_restore', 15:52:30 INFO - 'tabpaint']}, 15:52:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['a11yr', 15:52:30 INFO - 'ts_paint', 15:52:30 INFO - 'tpaint', 15:52:30 INFO - 'sessionrestore', 15:52:30 INFO - 'sessionrestore_no_auto_restore', 15:52:30 INFO - 'tabpaint']}, 15:52:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['a11yr', 15:52:30 INFO - 'ts_paint', 15:52:30 INFO - 'tpaint', 15:52:30 INFO - 'sessionrestore', 15:52:30 INFO - 'sessionrestore_no_auto_restore', 15:52:30 INFO - 'tabpaint']}, 15:52:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['tsvgx', 15:52:30 INFO - 'tsvgr_opacity', 15:52:30 INFO - 'tart', 15:52:30 INFO - 'tscrollx', 15:52:30 INFO - 'cart']}, 15:52:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:30 INFO - 'tsvgr_opacity', 15:52:30 INFO - 'tart', 15:52:30 INFO - 'tscrollx', 15:52:30 INFO - 'cart']}, 15:52:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'talos_options': ['--disable-e10s'], 15:52:30 INFO - 'tests': ['tp5o']}, 15:52:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'tests': ['tp5o']}, 15:52:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'talos_options': ['--disable-e10s', 15:52:30 INFO - '--xperf_path', 15:52:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:30 INFO - 'tests': ['tp5n']}, 15:52:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:30 INFO - 'talos_options': ['--xperf_path', 15:52:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:30 INFO - 'tests': ['tp5n']}}, 15:52:30 INFO - 'talos.zip': {'path': '', 15:52:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:30 INFO - Running post-action listener: _resource_record_post_action 15:52:30 INFO - ##### 15:52:30 INFO - ##### Finished populate-webroot step (success) 15:52:30 INFO - ##### 15:52:30 INFO - ##### 15:52:30 INFO - ##### Running create-virtualenv step. 15:52:30 INFO - ##### 15:52:30 INFO - Running pre-action listener: _resource_record_pre_action 15:52:30 INFO - Running main action method: create_virtualenv 15:52:30 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:30 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 15:52:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:30 INFO - Using real prefix '/usr' 15:52:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:32 INFO - Installing pip.................done. 15:52:32 INFO - Return code: 0 15:52:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:32 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:32 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 15:52:32 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 15:52:32 INFO - Using env: {'DISPLAY': ':0', 15:52:32 INFO - 'HOME': '/home/cltbld', 15:52:32 INFO - 'LANG': 'en_US.UTF-8', 15:52:32 INFO - 'LANGUAGE': 'en_US:en', 15:52:32 INFO - 'LOGNAME': 'cltbld', 15:52:32 INFO - 'MAIL': '/var/mail/cltbld', 15:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:32 INFO - 'MOZ_NO_REMOTE': '1', 15:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:32 INFO - 'NO_EM_RESTART': '1', 15:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:32 INFO - 'PWD': '/builds/slave/test', 15:52:32 INFO - 'SHELL': '/bin/bash', 15:52:32 INFO - 'SHLVL': '1', 15:52:32 INFO - 'TERM': 'linux', 15:52:32 INFO - 'TMOUT': '86400', 15:52:32 INFO - 'USER': 'cltbld', 15:52:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:32 INFO - '_': '/tools/buildbot/bin/python'} 15:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:33 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 15:52:33 INFO - Cleaning up... 15:52:33 INFO - Return code: 0 15:52:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:52:33 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')]} 15:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:33 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')]} 15:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:33 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:33 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 15:52:33 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 15:52:33 INFO - Using env: {'DISPLAY': ':0', 15:52:33 INFO - 'HOME': '/home/cltbld', 15:52:33 INFO - 'LANG': 'en_US.UTF-8', 15:52:33 INFO - 'LANGUAGE': 'en_US:en', 15:52:33 INFO - 'LOGNAME': 'cltbld', 15:52:33 INFO - 'MAIL': '/var/mail/cltbld', 15:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:33 INFO - 'MOZ_NO_REMOTE': '1', 15:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:33 INFO - 'NO_EM_RESTART': '1', 15:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:33 INFO - 'PWD': '/builds/slave/test', 15:52:33 INFO - 'SHELL': '/bin/bash', 15:52:33 INFO - 'SHLVL': '1', 15:52:33 INFO - 'TERM': 'linux', 15:52:33 INFO - 'TMOUT': '86400', 15:52:33 INFO - 'USER': 'cltbld', 15:52:33 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:33 INFO - '_': '/tools/buildbot/bin/python'} 15:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:33 INFO - Downloading/unpacking psutil>=3.1.1 15:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:35 INFO - Installing collected packages: psutil 15:52:35 INFO - Running setup.py install for psutil 15:52:35 INFO - building 'psutil._psutil_linux' extension 15:52:35 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 15:52:35 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 15:52:35 INFO - building 'psutil._psutil_posix' extension 15:52:35 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 15:52:35 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 15:52:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:35 INFO - Successfully installed psutil 15:52:35 INFO - Cleaning up... 15:52:35 INFO - Return code: 0 15:52:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:52:35 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')]} 15:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:35 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')]} 15:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:35 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:35 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 15:52:35 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 15:52:35 INFO - Using env: {'DISPLAY': ':0', 15:52:35 INFO - 'HOME': '/home/cltbld', 15:52:35 INFO - 'LANG': 'en_US.UTF-8', 15:52:35 INFO - 'LANGUAGE': 'en_US:en', 15:52:35 INFO - 'LOGNAME': 'cltbld', 15:52:35 INFO - 'MAIL': '/var/mail/cltbld', 15:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:35 INFO - 'MOZ_NO_REMOTE': '1', 15:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:35 INFO - 'NO_EM_RESTART': '1', 15:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:35 INFO - 'PWD': '/builds/slave/test', 15:52:35 INFO - 'SHELL': '/bin/bash', 15:52:35 INFO - 'SHLVL': '1', 15:52:35 INFO - 'TERM': 'linux', 15:52:35 INFO - 'TMOUT': '86400', 15:52:35 INFO - 'USER': 'cltbld', 15:52:35 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:35 INFO - '_': '/tools/buildbot/bin/python'} 15:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:52:36 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 15:52:36 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 15:52:36 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 15:52:36 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 15:52:36 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 15:52:36 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 15:52:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:52:38 INFO - Installing collected packages: mozsystemmonitor 15:52:38 INFO - Running setup.py install for mozsystemmonitor 15:52:38 INFO - Successfully installed mozsystemmonitor 15:52:38 INFO - Cleaning up... 15:52:38 INFO - Return code: 0 15:52:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:52:38 INFO - Using env: {'DISPLAY': ':0', 15:52:38 INFO - 'HOME': '/home/cltbld', 15:52:38 INFO - 'LANG': 'en_US.UTF-8', 15:52:38 INFO - 'LANGUAGE': 'en_US:en', 15:52:38 INFO - 'LOGNAME': 'cltbld', 15:52:38 INFO - 'MAIL': '/var/mail/cltbld', 15:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:38 INFO - 'MOZ_NO_REMOTE': '1', 15:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:38 INFO - 'NO_EM_RESTART': '1', 15:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:38 INFO - 'PWD': '/builds/slave/test', 15:52:38 INFO - 'SHELL': '/bin/bash', 15:52:38 INFO - 'SHLVL': '1', 15:52:38 INFO - 'TERM': 'linux', 15:52:38 INFO - 'TMOUT': '86400', 15:52:38 INFO - 'USER': 'cltbld', 15:52:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:38 INFO - '_': '/tools/buildbot/bin/python'} 15:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:38 INFO - Downloading/unpacking jsonschema==2.5.1 15:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:52:40 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 15:52:40 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 15:52:40 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 15:52:40 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 15:52:40 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 15:52:40 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 15:52:40 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:40 INFO - warning: no files found matching '*.txt' 15:52:40 INFO - no previously-included directories found matching 'build' 15:52:40 INFO - no previously-included directories found matching 'dist' 15:52:40 INFO - no previously-included directories found matching '.git*' 15:52:40 INFO - Installing collected packages: jsonschema, functools32 15:52:40 INFO - Running setup.py install for functools32 15:52:40 INFO - warning: no files found matching '*.txt' 15:52:40 INFO - no previously-included directories found matching 'build' 15:52:40 INFO - no previously-included directories found matching 'dist' 15:52:40 INFO - no previously-included directories found matching '.git*' 15:52:40 INFO - Successfully installed jsonschema functools32 15:52:40 INFO - Cleaning up... 15:52:40 INFO - Return code: 0 15:52:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:52:40 INFO - Using env: {'DISPLAY': ':0', 15:52:40 INFO - 'HOME': '/home/cltbld', 15:52:40 INFO - 'LANG': 'en_US.UTF-8', 15:52:40 INFO - 'LANGUAGE': 'en_US:en', 15:52:40 INFO - 'LOGNAME': 'cltbld', 15:52:40 INFO - 'MAIL': '/var/mail/cltbld', 15:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:40 INFO - 'MOZ_NO_REMOTE': '1', 15:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:40 INFO - 'NO_EM_RESTART': '1', 15:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:40 INFO - 'PWD': '/builds/slave/test', 15:52:40 INFO - 'SHELL': '/bin/bash', 15:52:40 INFO - 'SHLVL': '1', 15:52:40 INFO - 'TERM': 'linux', 15:52:40 INFO - 'TMOUT': '86400', 15:52:40 INFO - 'USER': 'cltbld', 15:52:40 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:40 INFO - '_': '/tools/buildbot/bin/python'} 15:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:41 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:42 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:43 INFO - Downloading docopt-0.6.1.tar.gz 15:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:43 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:43 INFO - Running setup.py install for blobuploader 15:52:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:43 INFO - Running setup.py install for requests 15:52:44 INFO - Running setup.py install for docopt 15:52:44 INFO - Successfully installed blobuploader requests docopt 15:52:44 INFO - Cleaning up... 15:52:44 INFO - Return code: 0 15:52:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:44 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:44 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 15:52:44 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 15:52:44 INFO - Using env: {'DISPLAY': ':0', 15:52:44 INFO - 'HOME': '/home/cltbld', 15:52:44 INFO - 'LANG': 'en_US.UTF-8', 15:52:44 INFO - 'LANGUAGE': 'en_US:en', 15:52:44 INFO - 'LOGNAME': 'cltbld', 15:52:44 INFO - 'MAIL': '/var/mail/cltbld', 15:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:44 INFO - 'MOZ_NO_REMOTE': '1', 15:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:44 INFO - 'NO_EM_RESTART': '1', 15:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:44 INFO - 'PWD': '/builds/slave/test', 15:52:44 INFO - 'SHELL': '/bin/bash', 15:52:44 INFO - 'SHLVL': '1', 15:52:44 INFO - 'TERM': 'linux', 15:52:44 INFO - 'TMOUT': '86400', 15:52:44 INFO - 'USER': 'cltbld', 15:52:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:44 INFO - '_': '/tools/buildbot/bin/python'} 15:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:44 INFO - Running setup.py (path:/tmp/pip-R9IiZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:44 INFO - Running setup.py (path:/tmp/pip-h9b0vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:44 INFO - Running setup.py (path:/tmp/pip-2wOngA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:44 INFO - Running setup.py (path:/tmp/pip-lvWcCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:44 INFO - Running setup.py (path:/tmp/pip-_JA6F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:44 INFO - Running setup.py (path:/tmp/pip-LSvihw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:45 INFO - Running setup.py (path:/tmp/pip-GstjHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:45 INFO - Running setup.py (path:/tmp/pip-drgtLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:45 INFO - Running setup.py (path:/tmp/pip-qEgWLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:45 INFO - Running setup.py (path:/tmp/pip-crj9XE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:45 INFO - Running setup.py (path:/tmp/pip-NE5bra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:45 INFO - Running setup.py (path:/tmp/pip-L_3JPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:45 INFO - Running setup.py (path:/tmp/pip-vz4sbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:45 INFO - Running setup.py (path:/tmp/pip-UqpI_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:45 INFO - Running setup.py (path:/tmp/pip-QjEpfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:45 INFO - Running setup.py (path:/tmp/pip-WaBHcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:45 INFO - Running setup.py (path:/tmp/pip-T0Rj3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:45 INFO - Running setup.py install for manifestparser 15:52:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:45 INFO - Running setup.py install for mozcrash 15:52:46 INFO - Running setup.py install for mozdebug 15:52:46 INFO - Running setup.py install for mozdevice 15:52:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Running setup.py install for mozfile 15:52:46 INFO - Running setup.py install for mozhttpd 15:52:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Running setup.py install for mozinfo 15:52:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Running setup.py install for mozInstall 15:52:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Running setup.py install for mozleak 15:52:46 INFO - Running setup.py install for mozlog 15:52:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Running setup.py install for moznetwork 15:52:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:46 INFO - Running setup.py install for mozprocess 15:52:47 INFO - Running setup.py install for mozprofile 15:52:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:47 INFO - Running setup.py install for mozrunner 15:52:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:47 INFO - Running setup.py install for mozscreenshot 15:52:47 INFO - Running setup.py install for moztest 15:52:47 INFO - Running setup.py install for mozversion 15:52:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:47 INFO - Cleaning up... 15:52:47 INFO - Return code: 0 15:52:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:47 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')]} 15:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:47 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')]} 15:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:47 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:47 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 15:52:47 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 15:52:47 INFO - Using env: {'DISPLAY': ':0', 15:52:47 INFO - 'HOME': '/home/cltbld', 15:52:47 INFO - 'LANG': 'en_US.UTF-8', 15:52:47 INFO - 'LANGUAGE': 'en_US:en', 15:52:47 INFO - 'LOGNAME': 'cltbld', 15:52:47 INFO - 'MAIL': '/var/mail/cltbld', 15:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:47 INFO - 'MOZ_NO_REMOTE': '1', 15:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:47 INFO - 'NO_EM_RESTART': '1', 15:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:47 INFO - 'PWD': '/builds/slave/test', 15:52:47 INFO - 'SHELL': '/bin/bash', 15:52:47 INFO - 'SHLVL': '1', 15:52:47 INFO - 'TERM': 'linux', 15:52:47 INFO - 'TMOUT': '86400', 15:52:47 INFO - 'USER': 'cltbld', 15:52:47 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:47 INFO - '_': '/tools/buildbot/bin/python'} 15:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:47 INFO - Running setup.py (path:/tmp/pip-efk5H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:47 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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:47 INFO - Running setup.py (path:/tmp/pip-7VgOtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:47 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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:47 INFO - Running setup.py (path:/tmp/pip-khdcQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:48 INFO - Running setup.py (path:/tmp/pip-ocyrPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:48 INFO - Running setup.py (path:/tmp/pip-J1Q3S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:48 INFO - Running setup.py (path:/tmp/pip-MVMD4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:48 INFO - Running setup.py (path:/tmp/pip-Atqo1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:48 INFO - Running setup.py (path:/tmp/pip-NzaxWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:48 INFO - Running setup.py (path:/tmp/pip-1hVLXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:48 INFO - Running setup.py (path:/tmp/pip-b90Sp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:48 INFO - Running setup.py (path:/tmp/pip-TWOtV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:48 INFO - Running setup.py (path:/tmp/pip-oF7Pdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:48 INFO - Running setup.py (path:/tmp/pip-it6t3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:48 INFO - Running setup.py (path:/tmp/pip-tFy4Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:48 INFO - Running setup.py (path:/tmp/pip-4X4PUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:48 INFO - Running setup.py (path:/tmp/pip-JrxLy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:48 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)) 15:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:48 INFO - Running setup.py (path:/tmp/pip-Xt7orG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:49 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)) 15:52:49 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)) 15:52:49 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)) 15:52:49 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)) 15:52:49 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)) 15:52:49 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)) 15:52:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:49 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 15:52:49 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 15:52:49 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 15:52:49 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 15:52:49 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 15:52:49 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 15:52:50 INFO - Downloading blessings-1.6.tar.gz 15:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:51 INFO - Installing collected packages: blessings 15:52:51 INFO - Running setup.py install for blessings 15:52:51 INFO - Successfully installed blessings 15:52:51 INFO - Cleaning up... 15:52:51 INFO - Return code: 0 15:52:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:51 INFO - Reading from file tmpfile_stdout 15:52:51 INFO - Current package versions: 15:52:51 INFO - argparse == 1.2.1 15:52:51 INFO - blessings == 1.6 15:52:51 INFO - blobuploader == 1.2.4 15:52:51 INFO - docopt == 0.6.1 15:52:51 INFO - functools32 == 3.2.3-2 15:52:51 INFO - jsonschema == 2.5.1 15:52:51 INFO - manifestparser == 1.1 15:52:51 INFO - mozInstall == 1.12 15:52:51 INFO - mozcrash == 0.17 15:52:51 INFO - mozdebug == 0.1 15:52:51 INFO - mozdevice == 0.48 15:52:51 INFO - mozfile == 1.2 15:52:51 INFO - mozhttpd == 0.7 15:52:51 INFO - mozinfo == 0.9 15:52:51 INFO - mozleak == 0.1 15:52:51 INFO - mozlog == 3.2 15:52:51 INFO - moznetwork == 0.27 15:52:51 INFO - mozprocess == 0.23 15:52:51 INFO - mozprofile == 0.28 15:52:51 INFO - mozrunner == 6.12 15:52:51 INFO - mozscreenshot == 0.1 15:52:51 INFO - mozsystemmonitor == 0.3 15:52:51 INFO - moztest == 0.7 15:52:51 INFO - mozversion == 1.4 15:52:51 INFO - psutil == 3.1.1 15:52:51 INFO - requests == 1.2.3 15:52:51 INFO - wsgiref == 0.1.2 15:52:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:51 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:51 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 15:52:51 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 15:52:51 INFO - Using env: {'DISPLAY': ':0', 15:52:51 INFO - 'HOME': '/home/cltbld', 15:52:51 INFO - 'LANG': 'en_US.UTF-8', 15:52:51 INFO - 'LANGUAGE': 'en_US:en', 15:52:51 INFO - 'LOGNAME': 'cltbld', 15:52:51 INFO - 'MAIL': '/var/mail/cltbld', 15:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:51 INFO - 'MOZ_NO_REMOTE': '1', 15:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:51 INFO - 'NO_EM_RESTART': '1', 15:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:51 INFO - 'PWD': '/builds/slave/test', 15:52:51 INFO - 'SHELL': '/bin/bash', 15:52:51 INFO - 'SHLVL': '1', 15:52:51 INFO - 'TERM': 'linux', 15:52:51 INFO - 'TMOUT': '86400', 15:52:51 INFO - 'USER': 'cltbld', 15:52:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:51 INFO - '_': '/tools/buildbot/bin/python'} 15:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 INFO - Cleaning up... 15:52:51 INFO - Return code: 0 15:52:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:51 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 0xc95030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, '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': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', '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 15:52:51 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 15:52:51 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 15:52:51 INFO - Using env: {'DISPLAY': ':0', 15:52:51 INFO - 'HOME': '/home/cltbld', 15:52:51 INFO - 'LANG': 'en_US.UTF-8', 15:52:51 INFO - 'LANGUAGE': 'en_US:en', 15:52:51 INFO - 'LOGNAME': 'cltbld', 15:52:51 INFO - 'MAIL': '/var/mail/cltbld', 15:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:51 INFO - 'MOZ_NO_REMOTE': '1', 15:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:51 INFO - 'NO_EM_RESTART': '1', 15:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:51 INFO - 'PWD': '/builds/slave/test', 15:52:51 INFO - 'SHELL': '/bin/bash', 15:52:51 INFO - 'SHLVL': '1', 15:52:51 INFO - 'TERM': 'linux', 15:52:51 INFO - 'TMOUT': '86400', 15:52:51 INFO - 'USER': 'cltbld', 15:52:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:51 INFO - '_': '/tools/buildbot/bin/python'} 15:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:52:51 INFO - Cleaning up... 15:52:51 INFO - Return code: 0 15:52:51 INFO - Running post-action listener: _resource_record_post_action 15:52:51 INFO - Running post-action listener: _start_resource_monitoring 15:52:51 INFO - Starting resource monitoring. 15:52:51 INFO - ##### 15:52:51 INFO - ##### Finished create-virtualenv step (success) 15:52:51 INFO - ##### 15:52:51 INFO - ##### 15:52:51 INFO - ##### Running install step. 15:52:51 INFO - ##### 15:52:51 INFO - Running pre-action listener: _resource_record_pre_action 15:52:51 INFO - Running main action method: install 15:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:52 INFO - Reading from file tmpfile_stdout 15:52:52 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:52 INFO - Reading from file tmpfile_stdout 15:52:52 INFO - Output received: 15:52:52 INFO - Usage: mozinstall [options] installer 15:52:52 INFO - Options: 15:52:52 INFO - -h, --help show this help message and exit 15:52:52 INFO - -d DEST, --destination=DEST 15:52:52 INFO - Directory to install application into. [default: 15:52:52 INFO - "/builds/slave/test"] 15:52:52 INFO - --app=APP Application being installed. [default: firefox] 15:52:52 INFO - mkdir: /builds/slave/test/build/application 15:52:52 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'] 15:52:52 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 15:53:08 INFO - Reading from file tmpfile_stdout 15:53:08 INFO - Output received: 15:53:08 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:08 INFO - Running post-action listener: _resource_record_post_action 15:53:08 INFO - ##### 15:53:08 INFO - ##### Finished install step (success) 15:53:08 INFO - ##### 15:53:08 INFO - ##### 15:53:08 INFO - ##### Running run-tests step. 15:53:08 INFO - ##### 15:53:08 INFO - Running pre-action listener: _resource_record_pre_action 15:53:08 INFO - Running main action method: run_tests 15:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:08 INFO - Python 2.7.3 15:53:08 INFO - Return code: 0 15:53:08 INFO - grabbing minidump binary from tooltool 15:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:53:08 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 0xf543b0>, '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 0xf552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:08 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 15:53:08 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 15:53:08 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 15:53:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:08 INFO - Return code: 0 15:53:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:53:08 INFO - Using env: {'DISPLAY': ':0', 15:53:08 INFO - 'HOME': '/home/cltbld', 15:53:08 INFO - 'LANG': 'en_US.UTF-8', 15:53:08 INFO - 'LANGUAGE': 'en_US:en', 15:53:08 INFO - 'LOGNAME': 'cltbld', 15:53:08 INFO - 'MAIL': '/var/mail/cltbld', 15:53:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:08 INFO - 'MOZ_NO_REMOTE': '1', 15:53:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:08 INFO - 'NO_EM_RESTART': '1', 15:53:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:08 INFO - 'PWD': '/builds/slave/test', 15:53:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:08 INFO - 'SHELL': '/bin/bash', 15:53:08 INFO - 'SHLVL': '1', 15:53:08 INFO - 'TERM': 'linux', 15:53:08 INFO - 'TMOUT': '86400', 15:53:08 INFO - 'USER': 'cltbld', 15:53:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725', 15:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:08 INFO - '_': '/tools/buildbot/bin/python'} 15:53:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:53:09 INFO - mozversion application_buildid: 20160711150926 15:53:09 INFO - mozversion application_changeset: f87c66fa12c635e07cd071dbfb9646258b7896d2 15:53:09 INFO - mozversion application_display_name: Nightly 15:53:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:09 INFO - mozversion application_name: Firefox 15:53:09 INFO - mozversion application_remotingname: firefox 15:53:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:53:09 INFO - mozversion application_vendor: Mozilla 15:53:09 INFO - mozversion application_version: 50.0a1 15:53:09 INFO - mozversion platform_buildid: 20160711150926 15:53:09 INFO - mozversion platform_changeset: f87c66fa12c635e07cd071dbfb9646258b7896d2 15:53:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:53:09 INFO - mozversion platform_version: 50.0a1 15:53:09 INFO - using testdate: 1468277589 15:53:09 INFO - actual date: 1468277589 15:53:09 INFO - starting webserver on 'localhost:46248' 15:53:09 INFO - SUITE-START | Running 2 tests 15:53:09 INFO - TEST-START | dromaeo_css 15:53:09 INFO - operating with platform_type : linux_ 15:53:09 INFO - Initialising browser for dromaeo_css test... 15:53:09 INFO - TEST-INFO | started process 14083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6W4yyd/profile http://localhost:46248/getInfo.html) 15:53:12 INFO - PROCESS | 14083 | __metrics Screen width/height:1600/1200 15:53:12 INFO - PROCESS | 14083 | colorDepth:24 15:53:12 INFO - PROCESS | 14083 | Browser inner width/height: 1024/697 15:53:12 INFO - PROCESS | 14083 | __metrics 15:53:13 INFO - PROCESS | 14083 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:53:13 INFO - PROCESS | 14083 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:14 INFO - TEST-INFO | 14083: exit 0 15:53:14 INFO - Browser initialized. 15:53:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:14 INFO - TEST-INFO | started process 14163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6W4yyd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:26 INFO - PROCESS | 14163 | RSS: Main: 158855168 15:53:26 INFO - PROCESS | 14163 | 15:54:18 INFO - PROCESS | 14163 | 1468277658297 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] 15:56:30 INFO - PROCESS | 14163 | Cycle 1(1): loaded http://localhost:46248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46248/tests/dromaeo/cssquery-ext.html) 15:56:31 INFO - PROCESS | 14163 | RSS: Main: 261836800 15:56:31 INFO - PROCESS | 14163 | 15:59:34 INFO - PROCESS | 14163 | Cycle 1(1): loaded http://localhost:46248/tests/dromaeo/cssquery-ext.html (next: http://localhost:46248/tests/dromaeo/cssquery-jquery.html) 15:59:34 INFO - PROCESS | 14163 | RSS: Main: 245604352 15:59:34 INFO - PROCESS | 14163 | 16:02:37 INFO - PROCESS | 14163 | Cycle 1(1): loaded http://localhost:46248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46248/tests/dromaeo/cssquery-mootools.html) 16:02:37 INFO - PROCESS | 14163 | RSS: Main: 238018560 16:02:37 INFO - PROCESS | 14163 | 16:05:40 INFO - PROCESS | 14163 | Cycle 1(1): loaded http://localhost:46248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46248/tests/dromaeo/cssquery-prototype.html) 16:05:40 INFO - PROCESS | 14163 | RSS: Main: 238772224 16:05:40 INFO - PROCESS | 14163 | 16:08:43 INFO - PROCESS | 14163 | Cycle 1(1): loaded http://localhost:46248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46248/tests/dromaeo/cssquery-yui.html) 16:08:44 INFO - PROCESS | 14163 | RSS: Main: 216510464 16:08:44 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | Cycle 1(1): loaded http://localhost:46248/tests/dromaeo/cssquery-yui.html (next: http://localhost:46248/tests/dromaeo/cssquery-dojo.html) 16:11:47 INFO - PROCESS | 14163 | RSS: Main: 285356032 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | __start_tp_report 16:11:47 INFO - PROCESS | 14163 | _x_x_mozilla_page_load 16:11:47 INFO - PROCESS | 14163 | _x_x_mozilla_page_load_details 16:11:47 INFO - PROCESS | 14163 | |i|pagename|runs| 16:11:47 INFO - PROCESS | 14163 | |0;dojo.html;2621.8426894386334;2643.854587997662;2656.5616673248915;2684.1947415775276;2687.3147347426416;4599.862004139873;4652.813887444507;4776.020915712279;4864.075825593135;4917.164082106042;4722.268048452487;4733.8816529586775;4751.548602882721;4803.111424386491;4849.321095046696;4360.65114790816;4407.80164892579;4459.264221403472;4471.552844715518;4472.552744725534;4403.713758605681;4459.754713490756;4467.553244675539;4496.415465989433;4530.139273538017;4504.941338785383;4569.428821397325;4585.541445855421;4592.7933243004145;4600.539946005406;4239.91520169598;4257.467816522934;4278.080212754273;4313.654907607384;4454;4360.934585981181;4372.956270437318;4374.934375984363;4424.159409712144;4431.158079964796;4911.852644420673;4922.606191504671;4924.975375123137;4927.359443272351;4934.4572097069295;5034.14419548674;5084.618653600958;5199.402068762103;5252.842414727565;5255.76349064293;5138.2806407103035;5190.6107041972;5229.1633338666015;5239.659422137587;5244.685318880841;4823.638227132979;4828.855134345975;4873.463918968911;4875.975620121877;4877.6829506081995;5169.68981861082;5262.3158989331905;5283.181106928432;5334.546563542065;5337.626366154332;5148.253503242084;5150.4592017837585;5186.196139598368;5191.454897235812;5208.218767184952;5241.13521268994;5243.842684719388;5248.370195576479;5286.15421532553;5289.444608316071;4983.9782844516785;5089.05852417304;5184.326037615161;5193.870153246199;5197.610179236573;5131.846044618667;5158.071547121554;5178.482151784791;5179;5188.169892817206;4478;4478.104379124188;4478.619317358061;4518.661100417482;4534.841280555231;3753.774773513598;3789.1853251551047;3874.651281384689;3935.7244992850797;3947.151362457028;4454.532274111237;4463.375127482155;4496.662750293675;4505.07645932583;4510.909781804346;5264.078786212397;5272.973635131876;5273.446288139767;5277.920831187535;5316.548093412103;4334;4410.580994805488;4428.114377124588;4456.309272062836;4470.5976462117915;4686.179918514246;4690.554397332248;4691.882702932386;4697.694649847749;4730.385049943554;4710.599599034121;4876.536729010738;4889.437714662859;4899.04468628614;4940.333055037596;5005.77474013663;5109.335786347751;5166.6125040621355;5176.145935920531;5224.686518808883;4878.243872199815;4901.681390709592;4905.288733133747;4905.656604037826;4961.7271050092595;4917.360743103373;5115.306494193408;5138.254953031864;5151.639385242997;5156;5119.385673719177;5171.120909445328;5173.611979101658;5185.792568297225;5190.662606930538;5087.3132127163835;5097.439281678938;5097.745112744422;5099.745012749422;5144.356955380577;4786.928196076992;5028.069807085701;5084.2881996521255;5095.108356037753;5099.5410413063;4977.751112444291;5001.949980500294;5072.67027643202;5082.517160869711;5082.771275292695;5124.436312005601;5131.179011358165;5132.358455193101;5132.43543210254;5141.048905952411;4896.902061958812;4899.853004409873;4943.209086546135;5012.398512178562;5060.49395060491 16:11:47 INFO - PROCESS | 14163 | |1;ext.html;575.976960921563;578.6961845031358;582.4263100845669;585.5520526797004;586.809286981731;27509.312267193305;29712.405751884977;39902.401463978065;41480;41488.58511414885;42610;43139.56860431395;43140.13719725604;43169.7841510792;43183.784081079626;7923.9207607924045;8048.235417635316;8064.354851611857;8076.515409075474;8078.394120440961;7906;7992.760217193493;7999.200079992012;8004.51972881629;8005.279524842763;7952.443328966946;7969.481983671043;8027.397945154137;8046;8053.838923221532;7912.327452166573;7949.72175973844;7952.562609056499;7955.124936257007;8038.678452861937;7924.80187995299;7978.441509094366;7978.441509094366;7980.680772769082;7987;39477.60522394768;39936.80031599823;39968.400473992915;39985.80007099946;40004;3072.9231769205726;3295.423300922353;3392.4402473591826;3396.9660303397145;3648.872289469882;29781.255468613457;30534.54198187029;30892.691073089205;31153.688463115304;31774.841125794454;3270.2151483643993;3277.4264503711993;3386.779859309137;3387.4749413840896;3452.7410444216534;273943;274744;275717;276507;276633;29829.701702982693;30704;30708.846455768024;32159.839200803846;54879.90240195174;33313.167170820925;33561.83219083889;33577.328453431284;33583.49624755631;33625.14186294143;12874.935625321814;12980.740385192243;12985.805212921814;12992.415341309665;13017;11327.32036077838;11341;11428.142889283337;11474.94262528682;11480.311181329147;8046.919530804734;8086.1913808618665;8092.71675491355;8110.878336824952;8179.877301840477;3137.897608602242;3140.120766185472;3163.7063129231583;3177.4916013437737;3190.6330771961057;911.2026976395654;919.2370332623906;949.6343907595625;954.5418199264392;1004.1213937804421;28615.85692071526;29188.06273743439;29210.269743256587;29296.121116366543;29489.557656635166;951.4386511957978;981.7496538382667;1001.9048190421898;1005.080351478389;1005.7485628592851;14483;15264.694706106038;15355.309011094527;15632.40969473296;15770.448034318973;380181;381345;382370;382780;384009;50793.49206507961;51944.480555193964;52223.73888130535;52239;52245;1204.5242129358853;1217.8477690288714;1219.5969768296445;1227.6010296653624;1232.4946771823509;27741.72258277472;28295.43409131847;28561.571576426784;28877.855610721814;28992.565111522923;44473;44703.776481117384;45042.3243651352;45080.323795143755;45127;323616;327081;327293;328910;328916;25607;26220.08229711951;26408.415495070356;26591.60112598274;26598.7340126604;41011.17977640371;43348.56651433445;44703.776481118686;44842.77578612217;45007.77496112498;37333.81333093426;37461.62538374581;37654;38034;38831.6116838828;37466.43800342942;37631.81184094062;37714.622853772205;37836.81081594574;37914.43128353022;34363.312733744686;34797;37451.81274093612;37819.81090094532;37878.8106059468;31275.53086703747;33143;33826.49260261147;34075.65924340725;34213.82893085518;25763.355916102246;25815.332591857277;25985.740142598333;26112.086076987212;26463.735362646126 16:11:47 INFO - PROCESS | 14163 | |2;jquery.html;339.15888596281235;367.36262584416033;374.7133442916168;380.0934770572185;396.306463688545;12891.226526408422;16273.918630406846;16362.590935226624;17377.826221737778;18136.637267254646;16142.112183829884;16151;16174.433894813685;16505.422310219146;17407.82592174078;4571.679982401233;4966.153358932731;5022.84931452057;5161.17421212606;5163.767630456619;5105.157648987913;5105.923411148836;5110.080185566597;5113.2074528447965;5116.513931176532;5085.694858308495;5094.159463688506;5221.347331583552;5537.8061767838135;5543.695096769676;5527;5541.99999999998;5546.528545073674;5546.91679624806;5564.693941833198;5247.337513685655;5412.756425960802;5425.9728701356635;5445.945540544623;5448.618596698233;12623.368831558386;12873.485060597564;12884.098113132084;12890.41993110303;13219.603411897659;1768.3722278591044;1839.7332386803973;2005.0876851032745;2124.3839286606867;2292.885355732207;9239.953800231024;9583.9936806635;9852.16256618181;10037.949810250975;10088.092071713581;1720.6300645361182;1743.7122874725655;1780.4658602419352;1812.3747307179003;1821.253286152671;63226;65420.34579654238;70016;71602.28397716008;72081.59388045917;9485.620575177054;9690.37012594179;9697.175740062032;9876.555555000043;10227.744306392251;12916.677083072811;13837.100588461717;13867.71182754834;14323.14061156334;14375.712485750226;7160.498765086498;7325.2308507607;7339.853202935911;7348.742794002184;7420.480566360411;6860.5197636165985;6864.279250678706;6967.094277743962;6972.825679358057;7117.679704413314;4379.189849877719;4402.163588918095;4467.508574056851;4469.9776501117285;4501.7974191161475;1753.140960929161;1783;1817.6546456173285;1820.1627251464474;1892.101251905334;817.1093508076107;849.6856163219525;891.9108089191159;955.4649396337934;959.8800149981253;16806.663866722596;16921.576960576083;18281.451556453063;18732.438026859218;18736.53158671044;860.6987554355925;871.3595507302127;881.5460038080394;926.6108234541508;956.3926906414476;9630.518474076269;9916;9935.850962235572;9941.80116397668;10064.748381290527;390638;394015;396241;397045;399979;82191.5890420544;82754.58622706968;84672.15327846643;85032.14967850366;85252.57373713216;959.7648576098901;961.5240455974338;962.4946902876046;966.79213968997;972.3485264872552;15912.283947222635;15985;16054.357825686842;16090.195490225677;16098.356065757238;26164;30520.389592208474;38385.42421863618;39923.80038099791;40112;45853.31220031635;51506.96986060333;51636.48363516317;51912.48087519076;52198.47801521936;7372.96313518429;7484.925150748641;7498.62506874665;7518.962405188158;7728.729494467667;9682.27382946296;10679.252452328574;11096.223264371416;11155.72110697239;11301.491432885376;9493;9652.710418687451;9671.564779584794;9863.309568330147;10062.798744025225;9524.809503809747;9692.321537492307;9714.80570388574;9826.557804898654;9828.4102953823;8774.07872173438;8882.378233523592;9283.907160928304;9831.9016809831;10306.433146176732;7404.148522919933;7404.518706284074;7472.551646901204;7488.8876666848955;7664.31021208094;8069.31410830086;9394.624215031323;9563.474008929576;9583.904160958302;9790.461524616214 16:11:47 INFO - PROCESS | 14163 | |3;mootools.html;1333.3533236380356;1398.2449477282266;1474.638713515189;1670.089801058423;1712.9743053854186;7179.1026121734785;7603.809904752384;7658.846823063543;7667.884981725271;7675.347595454379;6473.611583305005;7197.424206063515;7438.851222975551;7448.441366897491;7543.69825206991;2198.6152423325934;2225.944351391212;2227.4431392151964;2228.108756497406;2233.7542870284256;1866.1042699504246;2173.8369622278315;2183.3995651195887;2194.36363454598;2194.5281764420647;2129.8935053247274;2214.7895949884737;2231.252530402317;2232.799048085672;2239.876806775627;2167.219800871685;2205.878676672782;2208.966865497011;2211.1818627107914;2242.3273018094505;2190.266260802633;2195.110980053081;2196.7803219677903;2197.4067001909557;2198.40643026382;7690.346320562759;7721.845563088763;7730.420218483636;7743.728969486097;7748.457607967444;4521.683482156251;4531.478879928784;4552.271636538138;4559.840405585822;4647.419072615923;2825.773938084969;2834.2772592988863;2912.4903141950076;2964.3774807290497;2972.3758010817755;879.6393478673713;884.7566919097235;886.4636894678691;894.7539426657656;901.33301356996;10071.295009349422;10072.54673539685;10075.848862267072;10076.445795481246;10100.949495252476;3959.40608908666;4076.286649836267;4149.585041495826;4216.262154123016;4222.408862759216;8642.740717778477;8646.092160323202;8669.176428239307;8676.826463470696;8699.739007829776;4638.1187574360765;4647.233206520887;4656.208444564432;4659.836905708284;4670.859874203779;4148.875533733993;4185.937210941838;4204.894877628022;4219.767912764766;4226.344916537942;3501.1772233525103;3505.9824700876334;3531.770434921722;3567.8929632111076;3581.659742324475;1031.664708969588;1136.471540733563;1151.654503648902;1164.0920082335792;1181.9763604727857;623.3984205241873;738.7155944961229;739.7965559471081;790.8299715561182;847.8050048488882;4925.532074452921;5139.254808052811;5146.356705411824;5198.558122559549;5224.05966925957;759.1687102622619;796.6415113199083;807.894973653433;827.0612854410167;856.1866227084295;3578.3737845876867;3686.7787932724123;3690.0590349460717;3707.545758316283;3748.475213470116;8901.421407608614;9283.442993420416;9431.292653051049;9433.716988490356;9454.385464944757;7977.641006154737;8640.827183456297;8934.151255630704;9268.443893366419;9327.533623318806;6942;7092.858142837114;7106;7151.642417879085;7152.105986751656;4920.5817505511;5118.97440512795;5160.432352441153;5201.115810312332;5314.388845282842;8318.958405207935;8551.230389264996;8587.22714955657;8717.476951382938;8740.694075707319;8759.255463285692;8795.25240354577;8864.379493435397;8968.192862642394;8985.730428087169;6739.393454588914;6834.965825171042;6883.3116688330765;6885.173779146334;6888.380045795902;7299.489035767445;7330.5968171751065;7376.815579610553;7391.704331826667;7395.075615548057;5742.856428589152;5815.854603634943;6601.801945941629;6662.267150613526;6870.965645171742;6420;6503.479721622164;6558.081868538313;6575.473962083118;6590.538662293785;5948.672822994777;5967.045272756338;5974.850628734316;6024.246969128859;6030.3668114847305;4432.889177770581;4564.42944631921;4564.7032942858605;4677.321788340603;4693.296005599051;4613.700109492872;4718.150732867979;4723.881902952454;4730.432348118248;4740.525947405232 16:11:47 INFO - PROCESS | 14163 | |4;prototype.html;294.4523186872417;295.20589613938506;298.20082179758236;300.8601000534751;301.37314386076963;4924.113659541281;4936;4938.456769755324;4944.975275123628;4958.578520825729;4812.15787237233;4823.589994850442;4826.251930950708;4878.195097808857;4889.413270407547;3643.7995910224927;3760.9623903760885;3771.4342848572796;3849.538055433352;3850.4994350734364;3802.4296355546753;3825.407061905409;3846.0961674006585;3853.5761066282685;3868.845246190149;3805.0106972187154;3827.617238276178;3835.1946091320856;3837.846486140565;3842.558105817825;3615.6745892869635;3694.963050369502;3778.9433158502643;3794.829232684536;3833.4824798652385;3350.731941444703;3378.983105084483;3387.1193489692855;3389.1527118220447;3397.9830100849586;4717.127331443694;4736.59738922192;4741.028089241697;4742.928856067162;4748.976255118702;4206.326987681987;4352.825886964518;4363.47638283408;4383.693141480097;4410.977945110286;5062.31658726071;5067.366579177603;5087.465816089331;5092.210707340369;5095.337606111182;3711.0165806061414;3728.384816505273;3728.9440658390145;3731.3656678364473;3731.4962480065115;5179.792808287664;5373.946260537384;5392.811251606175;5395.757190926457;5399.487048730364;3813.6758375537834;3826.559945606291;3836.712246581462;3839.3665045267217;3842.50047493824;3874.767513949172;3876.496055512822;3883.7863917484246;3886.417037444406;3895.9220815584094;4373.409589705349;4380.525003373084;4383.956160438354;4395.120975804788;4408.140412619508;4860.684055536379;5143.331366922276;5150.690958542499;5158.793648254103;5188.247704082887;1275.9489620415266;1290.148501988683;1295.4429595274123;1296.5202874936333;1296.546208826903;811.5536454949872;817.6606708216024;847.6100993543039;855.8202777416687;860.0281681699639;4369.80335884886;4487.6185524230805;4513.729176249435;4540.250858608359;4547.8180872764715;5274.815381461707;5284.365876094893;5284.894302113936;5287.709175995357;5304.549113325334;4517.554382597603;4521;4521.751303678329;4528.592426681548;4531.45622525299;2657.255968328871;2789.428167225714;2799.314168028846;2809.3819359740824;2835.957460638092;4924.630652701062;4938.38270216223;4970.254461830682;4980.211081794207;4981.2030075187795;5243.318368612056;5394.083005889008;5403.7838486460105;5415.783368665209;5424.294841670637;4930.359053323188;4967.254911763264;4987.650864439454;4990.600751939836;5008.57427118699;5282.641820498027;5283.524482796413;5294.947050529446;5300.3639563252655;5305.840824775263;5086.160783470834;5177.197534382177;5184.559312458483;5219.8434046978655;5243.134882744457;4957.355543779286;4975.726335051607;4976.30331753562;4988.152014157675;4990.675606085593;3395.541601883714;3429.5713035870517;3478.1652403423504;3497.5453191085;3499.055255081165;4532.90934181308;4707.599854012447;4784.6889952153;4803.303520989367;4851.199552073868;4515.5484451554585;4525.456945166601;4548.317752337176;4587.541245875385;4617.445906491243;4550.431196100488;4583.816647334203;4597.471290801601;4597.60920321763;4603.976980115078;4413.382126502356;4487.685861989629;4513.1650644630845;4526.751028693322;4551.795169217327;4643.953560464352;4928.704277743347;4981.975090124526;5206.869828254324;5207.505286997729;5076.923846142385;5078.289039534394;5085.186370180753;5092.185250359925;5111.849833787368 16:11:47 INFO - PROCESS | 14163 | |5;yui.html;701.8561194955032;722.1478655186879;734.5115498193702;745.5899255409523;757.8446418484209;11629.767404651902;12235.938820305886;12270.0797440192;12290.139690221687;12291.078169137305;11553.65339039828;11556.191066625339;11558.47986840592;11562.53749850007;11615.419229038536;621.9378062193779;770.7572114783853;796.1839114907209;797.9680812767511;800.771780042688;782.9921700782976;789.4513313247295;792.5086446403209;793.0562630469751;793.2424534569501;653.5196630476596;843.7004863273542;846.0904527632789;846.2637505370305;846.5851732650988;662.0268205737558;664.4717449627534;664.7374287156595;808.8341889912554;833.5332213960202;610.4048552661164;611.5963464113709;612.3600837125215;615.0221148374062;615.2401783797008;11889.643310700692;11916.106292028046;11929.105317101164;11934.522619095225;11935.16453848231;12058.577949771803;12551.748965020739;12563.497460101586;12732.745345093139;12949.093563450562;11564.76870462586;11625;11776;11900.523979040829;12319.63041108768;4085.387191921206;4150.439690641755;4154.231467178552;4155.646770024551;4162.542120366757;58230.41769582292;58232.708836455546;58760.41239587592;59072.70463647654;59478;9752.609895604097;9908.752281192883;9968.380512805177;10065.949670251603;10409.115225205942;18223.544411389823;18300;18318.175682094337;18330.175142118638;18340.449786506426;6172.69136543171;6555.967220163869;6672.332766723289;6896.448284137257;7057.468525358511;3700.870469533553;3772.2832661794173;3791.677707394847;3836.9808150959066;3932.036651020518;2709.322669332667;2801.7058208887775;2804.2568719289407;2808.5225511663066;2810.2412348665744;475.583864118896;487.05511308062245;496.54318027414865;497.3757933793139;502.73103889418985;540.1843216742668;543.3914016301688;582.408855012163;587.4184557288254;633.3128555517316;7802.960985195038;7884.329831964347;7890.9605451972375;8217.79455513617;8328.33373330132;576.3026737647493;579.3192998227066;598.9011813050885;603.8279090459198;636.5734957578434;3885.261800257942;4041.1513582148077;4048.574899635496;4079.1433798902563;4147.170565886835;89996.5500172495;90676;90735;92673;94359.52820235855;79501.60249198717;80440;82207.588962056;82551;83453;72354.27645723475;72697.63651181711;74015.62992185005;75286.62356688292;75400.62299688466;7317.67070481819;7402.1857595665515;7531.435142364235;7539.886901696588;7575.545467271982;42546.36180457358;44313.33529996988;44462.11075778531;44758.32862507;45803.3129503051;58591;64274;64831.67584162049;65551.34448655452;65641;9726.513674316397;10354.430506322225;10553.997370249814;10651.30766500175;10806.891931080903;11323.886761132613;11488.597899073493;11519.366434845828;12155.87844121583;12202.08484363694;10453.581856725647;10546.894531054591;10555.52500137511;10832.350058996486;12494.68763280889;11874;11898.881011189776;11923.940380298043;12346.382680865741;12402.13185077036;11911.702207444883;12054.15620906528;12494.562690305796;12561.497540098293;12620.242785432903;9876.753081173028;10128;10238.027387398186;10321.63874264397;10418.166546676399;9758.951205243928;10111.3427627204;10116.797664046531;10122.342047766871;10129.240306977154 16:11:47 INFO - PROCESS | 14163 | __end_tp_report 16:11:47 INFO - PROCESS | 14163 | __start_cc_report 16:11:47 INFO - PROCESS | 14163 | _x_x_mozilla_cycle_collect,978 16:11:47 INFO - PROCESS | 14163 | __end_cc_report 16:11:47 INFO - PROCESS | 14163 | __startTimestamp1468278707483__endTimestamp 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | ------- Summary: start ------- 16:11:47 INFO - PROCESS | 14163 | Number of tests: 6 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | [#0] dojo.html Cycles:165 Average:4794.50 Median:4917.36 stddev:514.60 (10.5%) stddev-sans-first:487.14 16:11:47 INFO - PROCESS | 14163 | Values: 2621.8 2643.9 2656.6 2684.2 2687.3 4599.9 4652.8 4776.0 4864.1 4917.2 4722.3 4733.9 4751.5 4803.1 4849.3 4360.7 4407.8 4459.3 4471.6 4472.6 4403.7 4459.8 4467.6 4496.4 4530.1 4504.9 4569.4 4585.5 4592.8 4600.5 4239.9 4257.5 4278.1 4313.7 4454.0 4360.9 4373.0 4374.9 4424.2 4431.2 4911.9 4922.6 4925.0 4927.4 4934.5 5034.1 5084.6 5199.4 5252.8 5255.8 5138.3 5190.6 5229.2 5239.7 5244.7 4823.6 4828.9 4873.5 4876.0 4877.7 5169.7 5262.3 5283.2 5334.5 5337.6 5148.3 5150.5 5186.2 5191.5 5208.2 5241.1 5243.8 5248.4 5286.2 5289.4 4984.0 5089.1 5184.3 5193.9 5197.6 5131.8 5158.1 5178.5 5179.0 5188.2 4478.0 4478.1 4478.6 4518.7 4534.8 3753.8 3789.2 3874.7 3935.7 3947.2 4454.5 4463.4 4496.7 4505.1 4510.9 5264.1 5273.0 5273.4 5277.9 5316.5 4334.0 4410.6 4428.1 4456.3 4470.6 4686.2 4690.6 4691.9 4697.7 4730.4 4710.6 4876.5 4889.4 4899.0 4940.3 5005.8 5109.3 5166.6 5176.1 5224.7 4878.2 4901.7 4905.3 4905.7 4961.7 4917.4 5115.3 5138.3 5151.6 5156.0 5119.4 5171.1 5173.6 5185.8 5190.7 5087.3 5097.4 5097.7 5099.7 5144.4 4786.9 5028.1 5084.3 5095.1 5099.5 4977.8 5001.9 5072.7 5082.5 5082.8 5124.4 5131.2 5132.4 5132.4 5141.0 4896.9 4899.9 4943.2 5012.4 5060.5 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | [#1] ext.html Cycles:180 Average:47249.99 Median:19222.94 stddev:87282.35 (454.1%) stddev-sans-first:87456.85 16:11:47 INFO - PROCESS | 14163 | Values: 576.0 578.7 582.4 585.6 586.8 27509.3 29712.4 39902.4 41480.0 41488.6 42610.0 43139.6 43140.1 43169.8 43183.8 7923.9 8048.2 8064.4 8076.5 8078.4 7906.0 7992.8 7999.2 8004.5 8005.3 7952.4 7969.5 8027.4 8046.0 8053.8 7912.3 7949.7 7952.6 7955.1 8038.7 7924.8 7978.4 7978.4 7980.7 7987.0 39477.6 39936.8 39968.4 39985.8 40004.0 3072.9 3295.4 3392.4 3397.0 3648.9 29781.3 30534.5 30892.7 31153.7 31774.8 3270.2 3277.4 3386.8 3387.5 3452.7 273943.0 274744.0 275717.0 276507.0 276633.0 29829.7 30704.0 30708.8 32159.8 54879.9 33313.2 33561.8 33577.3 33583.5 33625.1 12874.9 12980.7 12985.8 12992.4 13017.0 11327.3 11341.0 11428.1 11474.9 11480.3 8046.9 8086.2 8092.7 8110.9 8179.9 3137.9 3140.1 3163.7 3177.5 3190.6 911.2 919.2 949.6 954.5 1004.1 28615.9 29188.1 29210.3 29296.1 29489.6 951.4 981.7 1001.9 1005.1 1005.7 14483.0 15264.7 15355.3 15632.4 15770.4 380181.0 381345.0 382370.0 382780.0 384009.0 50793.5 51944.5 52223.7 52239.0 52245.0 1204.5 1217.8 1219.6 1227.6 1232.5 27741.7 28295.4 28561.6 28877.9 28992.6 44473.0 44703.8 45042.3 45080.3 45127.0 323616.0 327081.0 327293.0 328910.0 328916.0 25607.0 26220.1 26408.4 26591.6 26598.7 41011.2 43348.6 44703.8 44842.8 45007.8 37333.8 37461.6 37654.0 38034.0 38831.6 37466.4 37631.8 37714.6 37836.8 37914.4 34363.3 34797.0 37451.8 37819.8 37878.8 31275.5 33143.0 33826.5 34075.7 34213.8 25763.4 25815.3 25985.7 26112.1 26463.7 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | [#2] jquery.html Cycles:180 Average:24283.99 Median:52055.48 stddev:65476.32 (125.8%) stddev-sans-first:65635.31 16:11:47 INFO - PROCESS | 14163 | Values: 339.2 367.4 374.7 380.1 396.3 12891.2 16273.9 16362.6 17377.8 18136.6 16142.1 16151.0 16174.4 16505.4 17407.8 4571.7 4966.2 5022.8 5161.2 5163.8 5105.2 5105.9 5110.1 5113.2 5116.5 5085.7 5094.2 5221.3 5537.8 5543.7 5527.0 5542.0 5546.5 5546.9 5564.7 5247.3 5412.8 5426.0 5445.9 5448.6 12623.4 12873.5 12884.1 12890.4 13219.6 1768.4 1839.7 2005.1 2124.4 2292.9 9240.0 9584.0 9852.2 10037.9 10088.1 1720.6 1743.7 1780.5 1812.4 1821.3 63226.0 65420.3 70016.0 71602.3 72081.6 9485.6 9690.4 9697.2 9876.6 10227.7 12916.7 13837.1 13867.7 14323.1 14375.7 7160.5 7325.2 7339.9 7348.7 7420.5 6860.5 6864.3 6967.1 6972.8 7117.7 4379.2 4402.2 4467.5 4470.0 4501.8 1753.1 1783.0 1817.7 1820.2 1892.1 817.1 849.7 891.9 955.5 959.9 16806.7 16921.6 18281.5 18732.4 18736.5 860.7 871.4 881.5 926.6 956.4 9630.5 9916.0 9935.9 9941.8 10064.7 390638.0 394015.0 396241.0 397045.0 399979.0 82191.6 82754.6 84672.2 85032.1 85252.6 959.8 961.5 962.5 966.8 972.3 15912.3 15985.0 16054.4 16090.2 16098.4 26164.0 30520.4 38385.4 39923.8 40112.0 45853.3 51507.0 51636.5 51912.5 52198.5 7373.0 7484.9 7498.6 7519.0 7728.7 9682.3 10679.3 11096.2 11155.7 11301.5 9493.0 9652.7 9671.6 9863.3 10062.8 9524.8 9692.3 9714.8 9826.6 9828.4 8774.1 8882.4 9283.9 9831.9 10306.4 7404.1 7404.5 7472.6 7488.9 7664.3 8069.3 9394.6 9563.5 9583.9 9790.5 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | [#3] mootools.html Cycles:180 Average:5007.45 Median:5179.50 stddev:2735.10 (52.8%) stddev-sans-first:2728.83 16:11:47 INFO - PROCESS | 14163 | Values: 1333.4 1398.2 1474.6 1670.1 1713.0 7179.1 7603.8 7658.8 7667.9 7675.3 6473.6 7197.4 7438.9 7448.4 7543.7 2198.6 2225.9 2227.4 2228.1 2233.8 1866.1 2173.8 2183.4 2194.4 2194.5 2129.9 2214.8 2231.3 2232.8 2239.9 2167.2 2205.9 2209.0 2211.2 2242.3 2190.3 2195.1 2196.8 2197.4 2198.4 7690.3 7721.8 7730.4 7743.7 7748.5 4521.7 4531.5 4552.3 4559.8 4647.4 2825.8 2834.3 2912.5 2964.4 2972.4 879.6 884.8 886.5 894.8 901.3 10071.3 10072.5 10075.8 10076.4 10100.9 3959.4 4076.3 4149.6 4216.3 4222.4 8642.7 8646.1 8669.2 8676.8 8699.7 4638.1 4647.2 4656.2 4659.8 4670.9 4148.9 4185.9 4204.9 4219.8 4226.3 3501.2 3506.0 3531.8 3567.9 3581.7 1031.7 1136.5 1151.7 1164.1 1182.0 623.4 738.7 739.8 790.8 847.8 4925.5 5139.3 5146.4 5198.6 5224.1 759.2 796.6 807.9 827.1 856.2 3578.4 3686.8 3690.1 3707.5 3748.5 8901.4 9283.4 9431.3 9433.7 9454.4 7977.6 8640.8 8934.2 9268.4 9327.5 6942.0 7092.9 7106.0 7151.6 7152.1 4920.6 5119.0 5160.4 5201.1 5314.4 8319.0 8551.2 8587.2 8717.5 8740.7 8759.3 8795.3 8864.4 8968.2 8985.7 6739.4 6835.0 6883.3 6885.2 6888.4 7299.5 7330.6 7376.8 7391.7 7395.1 5742.9 5815.9 6601.8 6662.3 6871.0 6420.0 6503.5 6558.1 6575.5 6590.5 5948.7 5967.0 5974.9 6024.2 6030.4 4432.9 4564.4 4564.7 4677.3 4693.3 4613.7 4718.2 4723.9 4730.4 4740.5 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | [#4] prototype.html Cycles:180 Average:4194.22 Median:4585.68 stddev:1210.46 (26.4%) stddev-sans-first:1177.94 16:11:47 INFO - PROCESS | 14163 | Values: 294.5 295.2 298.2 300.9 301.4 4924.1 4936.0 4938.5 4945.0 4958.6 4812.2 4823.6 4826.3 4878.2 4889.4 3643.8 3761.0 3771.4 3849.5 3850.5 3802.4 3825.4 3846.1 3853.6 3868.8 3805.0 3827.6 3835.2 3837.8 3842.6 3615.7 3695.0 3778.9 3794.8 3833.5 3350.7 3379.0 3387.1 3389.2 3398.0 4717.1 4736.6 4741.0 4742.9 4749.0 4206.3 4352.8 4363.5 4383.7 4411.0 5062.3 5067.4 5087.5 5092.2 5095.3 3711.0 3728.4 3728.9 3731.4 3731.5 5179.8 5373.9 5392.8 5395.8 5399.5 3813.7 3826.6 3836.7 3839.4 3842.5 3874.8 3876.5 3883.8 3886.4 3895.9 4373.4 4380.5 4384.0 4395.1 4408.1 4860.7 5143.3 5150.7 5158.8 5188.2 1275.9 1290.1 1295.4 1296.5 1296.5 811.6 817.7 847.6 855.8 860.0 4369.8 4487.6 4513.7 4540.3 4547.8 5274.8 5284.4 5284.9 5287.7 5304.5 4517.6 4521.0 4521.8 4528.6 4531.5 2657.3 2789.4 2799.3 2809.4 2836.0 4924.6 4938.4 4970.3 4980.2 4981.2 5243.3 5394.1 5403.8 5415.8 5424.3 4930.4 4967.3 4987.7 4990.6 5008.6 5282.6 5283.5 5294.9 5300.4 5305.8 5086.2 5177.2 5184.6 5219.8 5243.1 4957.4 4975.7 4976.3 4988.2 4990.7 3395.5 3429.6 3478.2 3497.5 3499.1 4532.9 4707.6 4784.7 4803.3 4851.2 4515.5 4525.5 4548.3 4587.5 4617.4 4550.4 4583.8 4597.5 4597.6 4604.0 4413.4 4487.7 4513.2 4526.8 4551.8 4644.0 4928.7 4982.0 5206.9 5207.5 5076.9 5078.3 5085.2 5092.2 5111.8 16:11:47 INFO - PROCESS | 14163 | 16:11:47 INFO - PROCESS | 14163 | [#5] yui.html Cycles:180 Average:17316.09 Median:491.80 stddev:24506.98 (4983.1%) stddev-sans-first:24543.98 16:11:47 INFO - PROCESS | 14163 | Values: 701.9 722.1 734.5 745.6 757.8 11629.8 12235.9 12270.1 12290.1 12291.1 11553.7 11556.2 11558.5 11562.5 11615.4 621.9 770.8 796.2 798.0 800.8 783.0 789.5 792.5 793.1 793.2 653.5 843.7 846.1 846.3 846.6 662.0 664.5 664.7 808.8 833.5 610.4 611.6 612.4 615.0 615.2 11889.6 11916.1 11929.1 11934.5 11935.2 12058.6 12551.7 12563.5 12732.7 12949.1 11564.8 11625.0 11776.0 11900.5 12319.6 4085.4 4150.4 4154.2 4155.6 4162.5 58230.4 58232.7 58760.4 59072.7 59478.0 9752.6 9908.8 9968.4 10065.9 10409.1 18223.5 18300.0 18318.2 18330.2 18340.4 6172.7 6556.0 6672.3 6896.4 7057.5 3700.9 3772.3 3791.7 3837.0 3932.0 2709.3 2801.7 2804.3 2808.5 2810.2 475.6 487.1 496.5 497.4 502.7 540.2 543.4 582.4 587.4 633.3 7803.0 7884.3 7891.0 8217.8 8328.3 576.3 579.3 598.9 603.8 636.6 3885.3 4041.2 4048.6 4079.1 4147.2 89996.6 90676.0 90735.0 92673.0 94359.5 79501.6 80440.0 82207.6 82551.0 83453.0 72354.3 72697.6 74015.6 75286.6 75400.6 7317.7 7402.2 7531.4 7539.9 7575.5 42546.4 44313.3 44462.1 44758.3 45803.3 58591.0 64274.0 64831.7 65551.3 65641.0 9726.5 10354.4 10554.0 10651.3 10806.9 11323.9 11488.6 11519.4 12155.9 12202.1 10453.6 10546.9 10555.5 10832.4 12494.7 11874.0 11898.9 11923.9 12346.4 12402.1 11911.7 12054.2 12494.6 12561.5 12620.2 9876.8 10128.0 10238.0 10321.6 10418.2 9759.0 10111.3 10116.8 10122.3 10129.2 16:11:47 INFO - PROCESS | 14163 | -------- Summary: end -------- 16:11:47 INFO - PROCESS | 14163 | 16:11:48 INFO - TEST-INFO | 14163: exit 0 16:11:48 INFO - TEST-OK | dromaeo_css | took 1119303ms 16:11:48 INFO - TEST-START | kraken 16:11:48 INFO - operating with platform_type : linux_ 16:11:48 INFO - Initialising browser for kraken test... 16:11:48 INFO - TEST-INFO | started process 14357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4EmzIU/profile http://localhost:46248/getInfo.html) 16:11:52 INFO - PROCESS | 14357 | __metrics Screen width/height:1600/1200 16:11:52 INFO - PROCESS | 14357 | colorDepth:24 16:11:52 INFO - PROCESS | 14357 | Browser inner width/height: 1024/697 16:11:52 INFO - PROCESS | 14357 | __metrics 16:11:53 INFO - PROCESS | 14357 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:11:53 INFO - PROCESS | 14357 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:11:53 INFO - TEST-INFO | 14357: exit 0 16:11:53 INFO - Browser initialized. 16:11:53 INFO - Running cycle 1/1 for kraken test... 16:11:53 INFO - TEST-INFO | started process 14443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4EmzIU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:05 INFO - PROCESS | 14443 | RSS: Main: 158826496 16:12:05 INFO - PROCESS | 14443 | 16:12:08 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46248/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:09 INFO - PROCESS | 14443 | RSS: Main: 217362432 16:12:09 INFO - PROCESS | 14443 | 16:12:12 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46248/tests/kraken/driver.html?testName=audio-dft) 16:12:12 INFO - PROCESS | 14443 | RSS: Main: 203763712 16:12:12 INFO - PROCESS | 14443 | 16:12:16 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46248/tests/kraken/driver.html?testName=audio-fft) 16:12:16 INFO - PROCESS | 14443 | RSS: Main: 270921728 16:12:16 INFO - PROCESS | 14443 | 16:12:18 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46248/tests/kraken/driver.html?testName=audio-oscillator) 16:12:19 INFO - PROCESS | 14443 | RSS: Main: 181276672 16:12:19 INFO - PROCESS | 14443 | 16:12:21 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:22 INFO - PROCESS | 14443 | RSS: Main: 185520128 16:12:22 INFO - PROCESS | 14443 | 16:12:25 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46248/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:26 INFO - PROCESS | 14443 | RSS: Main: 221728768 16:12:26 INFO - PROCESS | 14443 | 16:12:29 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46248/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:30 INFO - PROCESS | 14443 | RSS: Main: 217530368 16:12:30 INFO - PROCESS | 14443 | 16:12:33 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46248/tests/kraken/driver.html?testName=json-parse-financial) 16:12:33 INFO - PROCESS | 14443 | RSS: Main: 220172288 16:12:33 INFO - PROCESS | 14443 | 16:12:35 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:36 INFO - PROCESS | 14443 | RSS: Main: 205377536 16:12:36 INFO - PROCESS | 14443 | 16:12:37 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:38 INFO - PROCESS | 14443 | RSS: Main: 210608128 16:12:38 INFO - PROCESS | 14443 | 16:12:40 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:41 INFO - PROCESS | 14443 | RSS: Main: 211320832 16:12:41 INFO - PROCESS | 14443 | 16:12:44 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:44 INFO - PROCESS | 14443 | RSS: Main: 224149504 16:12:44 INFO - PROCESS | 14443 | 16:12:47 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:48 INFO - PROCESS | 14443 | RSS: Main: 223621120 16:12:48 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | Cycle 1(1): loaded http://localhost:46248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46248/tests/kraken/driver.html?testName=ai-astar) 16:12:50 INFO - PROCESS | 14443 | RSS: Main: 267333632 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | __start_tp_report 16:12:50 INFO - PROCESS | 14443 | _x_x_mozilla_page_load 16:12:50 INFO - PROCESS | 14443 | _x_x_mozilla_page_load_details 16:12:50 INFO - PROCESS | 14443 | |i|pagename|runs| 16:12:50 INFO - PROCESS | 14443 | |0;ai-astar;104;116;115;114;113;114;114;114;115;114 16:12:50 INFO - PROCESS | 14443 | |1;audio-beat-detection;152;122;125;172;124;123;142;132;194;125 16:12:50 INFO - PROCESS | 14443 | |2;audio-dft;161;162;161;160;161;161;161;164;161;162 16:12:50 INFO - PROCESS | 14443 | |3;audio-fft;75;77;78;118;76;78;76;77;99;78 16:12:50 INFO - PROCESS | 14443 | |4;audio-oscillator;85;86;115;86;86;86;130;85;85;132 16:12:50 INFO - PROCESS | 14443 | |5;imaging-gaussian-blur;117;116;117;117;116;117;116;118;116;116 16:12:50 INFO - PROCESS | 14443 | |6;imaging-darkroom;147;147;145;146;146;147;145;146;146;146 16:12:50 INFO - PROCESS | 14443 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;96 16:12:50 INFO - PROCESS | 14443 | |8;json-parse-financial;64;65;64;63;65;65;65;65;63;64 16:12:50 INFO - PROCESS | 14443 | |9;json-stringify-tinderbox;64;65;65;65;65;64;65;65;65;64 16:12:50 INFO - PROCESS | 14443 | |10;stanford-crypto-aes;79;79;79;78;80;79;81;78;78;89 16:12:50 INFO - PROCESS | 14443 | |11;stanford-crypto-ccm;129;135;133;130;139;132;143;137;173;131 16:12:50 INFO - PROCESS | 14443 | |12;stanford-crypto-pbkdf2;170;165;165;166;167;169;166;169;170;167 16:12:50 INFO - PROCESS | 14443 | |13;stanford-crypto-sha256-iterative;76;67;67;66;70;65;67;66;66;66 16:12:50 INFO - PROCESS | 14443 | __end_tp_report 16:12:50 INFO - PROCESS | 14443 | __start_cc_report 16:12:50 INFO - PROCESS | 14443 | _x_x_mozilla_cycle_collect,1875 16:12:50 INFO - PROCESS | 14443 | __end_cc_report 16:12:50 INFO - PROCESS | 14443 | __startTimestamp1468278770298__endTimestamp 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | ------- Summary: start ------- 16:12:50 INFO - PROCESS | 14443 | Number of tests: 14 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.37 (3.0%) stddev-sans-first:0.87 16:12:50 INFO - PROCESS | 14443 | Values: 104.0 116.0 115.0 114.0 113.0 114.0 114.0 114.0 115.0 114.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:137.00 stddev:24.63 (18.0%) stddev-sans-first:25.80 16:12:50 INFO - PROCESS | 14443 | Values: 152.0 122.0 125.0 172.0 124.0 123.0 142.0 132.0 194.0 125.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 16:12:50 INFO - PROCESS | 14443 | Values: 161.0 162.0 161.0 160.0 161.0 161.0 161.0 164.0 161.0 162.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.50 stddev:14.10 (18.2%) stddev-sans-first:14.64 16:12:50 INFO - PROCESS | 14443 | Values: 75.0 77.0 78.0 118.0 76.0 78.0 76.0 77.0 99.0 78.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:85.50 stddev:19.86 (23.2%) stddev-sans-first:20.54 16:12:50 INFO - PROCESS | 14443 | Values: 85.0 86.0 115.0 86.0 86.0 86.0 130.0 85.0 85.0 132.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 16:12:50 INFO - PROCESS | 14443 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 116.0 118.0 116.0 116.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 16:12:50 INFO - PROCESS | 14443 | Values: 147.0 147.0 145.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 16:12:50 INFO - PROCESS | 14443 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 16:12:50 INFO - PROCESS | 14443 | Values: 64.0 65.0 64.0 63.0 65.0 65.0 65.0 65.0 63.0 64.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 16:12:50 INFO - PROCESS | 14443 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:3.30 (4.2%) stddev-sans-first:3.48 16:12:50 INFO - PROCESS | 14443 | Values: 79.0 79.0 79.0 78.0 80.0 79.0 81.0 78.0 78.0 89.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:136.00 stddev:12.98 (9.5%) stddev-sans-first:13.33 16:12:50 INFO - PROCESS | 14443 | Values: 129.0 135.0 133.0 130.0 139.0 132.0 143.0 137.0 173.0 131.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.00 stddev:1.96 (1.2%) stddev-sans-first:1.83 16:12:50 INFO - PROCESS | 14443 | Values: 170.0 165.0 165.0 166.0 167.0 169.0 166.0 169.0 170.0 167.0 16:12:50 INFO - PROCESS | 14443 | 16:12:50 INFO - PROCESS | 14443 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:3.24 (4.8%) stddev-sans-first:1.41 16:12:50 INFO - PROCESS | 14443 | Values: 76.0 67.0 67.0 66.0 70.0 65.0 67.0 66.0 66.0 66.0 16:12:50 INFO - PROCESS | 14443 | -------- Summary: end -------- 16:12:50 INFO - PROCESS | 14443 | 16:12:51 INFO - TEST-INFO | 14443: exit 0 16:12:51 INFO - TEST-OK | kraken | took 63049ms 16:12:51 INFO - SUITE-END | took 1182s 16:12:51 INFO - Completed test suite (00:19:42) 16:12:51 INFO - javascript benchmark 16:12:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.8426894386334, 2643.854587997662, 2656.5616673248915, 2684.1947415775276, 2687.3147347426416, 4599.862004139873, 4652.813887444507, 4776.020915712279, 4864.075825593135, 4917.164082106042, 4722.268048452487, 4733.8816529586775, 4751.548602882721, 4803.111424386491, 4849.321095046696, 4360.65114790816, 4407.80164892579, 4459.264221403472, 4471.552844715518, 4472.552744725534, 4403.713758605681, 4459.754713490756, 4467.553244675539, 4496.415465989433, 4530.139273538017, 4504.941338785383, 4569.428821397325, 4585.541445855421, 4592.7933243004145, 4600.539946005406, 4239.91520169598, 4257.467816522934, 4278.080212754273, 4313.654907607384, 4454.0, 4360.934585981181, 4372.956270437318, 4374.934375984363, 4424.159409712144, 4431.158079964796, 4911.852644420673, 4922.606191504671, 4924.975375123137, 4927.359443272351, 4934.4572097069295, 5034.14419548674, 5084.618653600958, 5199.402068762103, 5252.842414727565, 5255.76349064293, 5138.2806407103035, 5190.6107041972, 5229.1633338666015, 5239.659422137587, 5244.685318880841, 4823.638227132979, 4828.855134345975, 4873.463918968911, 4875.975620121877, 4877.6829506081995, 5169.68981861082, 5262.3158989331905, 5283.181106928432, 5334.546563542065, 5337.626366154332, 5148.253503242084, 5150.4592017837585, 5186.196139598368, 5191.454897235812, 5208.218767184952, 5241.13521268994, 5243.842684719388, 5248.370195576479, 5286.15421532553, 5289.444608316071, 4983.9782844516785, 5089.05852417304, 5184.326037615161, 5193.870153246199, 5197.610179236573, 5131.846044618667, 5158.071547121554, 5178.482151784791, 5179.0, 5188.169892817206, 4478.0, 4478.104379124188, 4478.619317358061, 4518.661100417482, 4534.841280555231, 3753.774773513598, 3789.1853251551047, 3874.651281384689, 3935.7244992850797, 3947.151362457028, 4454.532274111237, 4463.375127482155, 4496.662750293675, 4505.07645932583, 4510.909781804346, 5264.078786212397, 5272.973635131876, 5273.446288139767, 5277.920831187535, 5316.548093412103, 4334.0, 4410.580994805488, 4428.114377124588, 4456.309272062836, 4470.5976462117915, 4686.179918514246, 4690.554397332248, 4691.882702932386, 4697.694649847749, 4730.385049943554, 4710.599599034121, 4876.536729010738, 4889.437714662859, 4899.04468628614, 4940.333055037596, 5005.77474013663, 5109.335786347751, 5166.6125040621355, 5176.145935920531, 5224.686518808883, 4878.243872199815, 4901.681390709592, 4905.288733133747, 4905.656604037826, 4961.7271050092595, 4917.360743103373, 5115.306494193408, 5138.254953031864, 5151.639385242997, 5156.0, 5119.385673719177, 5171.120909445328, 5173.611979101658, 5185.792568297225, 5190.662606930538, 5087.3132127163835, 5097.439281678938, 5097.745112744422, 5099.745012749422, 5144.356955380577, 4786.928196076992, 5028.069807085701, 5084.2881996521255, 5095.108356037753, 5099.5410413063, 4977.751112444291, 5001.949980500294, 5072.67027643202, 5082.517160869711, 5082.771275292695, 5124.436312005601, 5131.179011358165, 5132.358455193101, 5132.43543210254, 5141.048905952411, 4896.902061958812, 4899.853004409873, 4943.209086546135, 5012.398512178562, 5060.49395060491], "value": 4760.718275646062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.976960921563, 578.6961845031358, 582.4263100845669, 585.5520526797004, 586.809286981731, 27509.312267193305, 29712.405751884977, 39902.401463978065, 41480.0, 41488.58511414885, 42610.0, 43139.56860431395, 43140.13719725604, 43169.7841510792, 43183.784081079626, 7923.9207607924045, 8048.235417635316, 8064.354851611857, 8076.515409075474, 8078.394120440961, 7906.0, 7992.760217193493, 7999.200079992012, 8004.51972881629, 8005.279524842763, 7952.443328966946, 7969.481983671043, 8027.397945154137, 8046.0, 8053.838923221532, 7912.327452166573, 7949.72175973844, 7952.562609056499, 7955.124936257007, 8038.678452861937, 7924.80187995299, 7978.441509094366, 7978.441509094366, 7980.680772769082, 7987.0, 39477.60522394768, 39936.80031599823, 39968.400473992915, 39985.80007099946, 40004.0, 3072.9231769205726, 3295.423300922353, 3392.4402473591826, 3396.9660303397145, 3648.872289469882, 29781.255468613457, 30534.54198187029, 30892.691073089205, 31153.688463115304, 31774.841125794454, 3270.2151483643993, 3277.4264503711993, 3386.779859309137, 3387.4749413840896, 3452.7410444216534, 273943.0, 274744.0, 275717.0, 276507.0, 276633.0, 29829.701702982693, 30704.0, 30708.846455768024, 32159.839200803846, 54879.90240195174, 33313.167170820925, 33561.83219083889, 33577.328453431284, 33583.49624755631, 33625.14186294143, 12874.935625321814, 12980.740385192243, 12985.805212921814, 12992.415341309665, 13017.0, 11327.32036077838, 11341.0, 11428.142889283337, 11474.94262528682, 11480.311181329147, 8046.919530804734, 8086.1913808618665, 8092.71675491355, 8110.878336824952, 8179.877301840477, 3137.897608602242, 3140.120766185472, 3163.7063129231583, 3177.4916013437737, 3190.6330771961057, 911.2026976395654, 919.2370332623906, 949.6343907595625, 954.5418199264392, 1004.1213937804421, 28615.85692071526, 29188.06273743439, 29210.269743256587, 29296.121116366543, 29489.557656635166, 951.4386511957978, 981.7496538382667, 1001.9048190421898, 1005.080351478389, 1005.7485628592851, 14483.0, 15264.694706106038, 15355.309011094527, 15632.40969473296, 15770.448034318973, 380181.0, 381345.0, 382370.0, 382780.0, 384009.0, 50793.49206507961, 51944.480555193964, 52223.73888130535, 52239.0, 52245.0, 1204.5242129358853, 1217.8477690288714, 1219.5969768296445, 1227.6010296653624, 1232.4946771823509, 27741.72258277472, 28295.43409131847, 28561.571576426784, 28877.855610721814, 28992.565111522923, 44473.0, 44703.776481117384, 45042.3243651352, 45080.323795143755, 45127.0, 323616.0, 327081.0, 327293.0, 328910.0, 328916.0, 25607.0, 26220.08229711951, 26408.415495070356, 26591.60112598274, 26598.7340126604, 41011.17977640371, 43348.56651433445, 44703.776481118686, 44842.77578612217, 45007.77496112498, 37333.81333093426, 37461.62538374581, 37654.0, 38034.0, 38831.6116838828, 37466.43800342942, 37631.81184094062, 37714.622853772205, 37836.81081594574, 37914.43128353022, 34363.312733744686, 34797.0, 37451.81274093612, 37819.81090094532, 37878.8106059468, 31275.53086703747, 33143.0, 33826.49260261147, 34075.65924340725, 34213.82893085518, 25763.355916102246, 25815.332591857277, 25985.740142598333, 26112.086076987212, 26463.735362646126], "value": 16736.178142858604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.15888596281235, 367.36262584416033, 374.7133442916168, 380.0934770572185, 396.306463688545, 12891.226526408422, 16273.918630406846, 16362.590935226624, 17377.826221737778, 18136.637267254646, 16142.112183829884, 16151.0, 16174.433894813685, 16505.422310219146, 17407.82592174078, 4571.679982401233, 4966.153358932731, 5022.84931452057, 5161.17421212606, 5163.767630456619, 5105.157648987913, 5105.923411148836, 5110.080185566597, 5113.2074528447965, 5116.513931176532, 5085.694858308495, 5094.159463688506, 5221.347331583552, 5537.8061767838135, 5543.695096769676, 5527.0, 5541.99999999998, 5546.528545073674, 5546.91679624806, 5564.693941833198, 5247.337513685655, 5412.756425960802, 5425.9728701356635, 5445.945540544623, 5448.618596698233, 12623.368831558386, 12873.485060597564, 12884.098113132084, 12890.41993110303, 13219.603411897659, 1768.3722278591044, 1839.7332386803973, 2005.0876851032745, 2124.3839286606867, 2292.885355732207, 9239.953800231024, 9583.9936806635, 9852.16256618181, 10037.949810250975, 10088.092071713581, 1720.6300645361182, 1743.7122874725655, 1780.4658602419352, 1812.3747307179003, 1821.253286152671, 63226.0, 65420.34579654238, 70016.0, 71602.28397716008, 72081.59388045917, 9485.620575177054, 9690.37012594179, 9697.175740062032, 9876.555555000043, 10227.744306392251, 12916.677083072811, 13837.100588461717, 13867.71182754834, 14323.14061156334, 14375.712485750226, 7160.498765086498, 7325.2308507607, 7339.853202935911, 7348.742794002184, 7420.480566360411, 6860.5197636165985, 6864.279250678706, 6967.094277743962, 6972.825679358057, 7117.679704413314, 4379.189849877719, 4402.163588918095, 4467.508574056851, 4469.9776501117285, 4501.7974191161475, 1753.140960929161, 1783.0, 1817.6546456173285, 1820.1627251464474, 1892.101251905334, 817.1093508076107, 849.6856163219525, 891.9108089191159, 955.4649396337934, 959.8800149981253, 16806.663866722596, 16921.576960576083, 18281.451556453063, 18732.438026859218, 18736.53158671044, 860.6987554355925, 871.3595507302127, 881.5460038080394, 926.6108234541508, 956.3926906414476, 9630.518474076269, 9916.0, 9935.850962235572, 9941.80116397668, 10064.748381290527, 390638.0, 394015.0, 396241.0, 397045.0, 399979.0, 82191.5890420544, 82754.58622706968, 84672.15327846643, 85032.14967850366, 85252.57373713216, 959.7648576098901, 961.5240455974338, 962.4946902876046, 966.79213968997, 972.3485264872552, 15912.283947222635, 15985.0, 16054.357825686842, 16090.195490225677, 16098.356065757238, 26164.0, 30520.389592208474, 38385.42421863618, 39923.80038099791, 40112.0, 45853.31220031635, 51506.96986060333, 51636.48363516317, 51912.48087519076, 52198.47801521936, 7372.96313518429, 7484.925150748641, 7498.62506874665, 7518.962405188158, 7728.729494467667, 9682.27382946296, 10679.252452328574, 11096.223264371416, 11155.72110697239, 11301.491432885376, 9493.0, 9652.710418687451, 9671.564779584794, 9863.309568330147, 10062.798744025225, 9524.809503809747, 9692.321537492307, 9714.80570388574, 9826.557804898654, 9828.4102953823, 8774.07872173438, 8882.378233523592, 9283.907160928304, 9831.9016809831, 10306.433146176732, 7404.148522919933, 7404.518706284074, 7472.551646901204, 7488.8876666848955, 7664.31021208094, 8069.31410830086, 9394.624215031323, 9563.474008929576, 9583.904160958302, 9790.461524616214], "value": 8072.5187814901055, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3533236380356, 1398.2449477282266, 1474.638713515189, 1670.089801058423, 1712.9743053854186, 7179.1026121734785, 7603.809904752384, 7658.846823063543, 7667.884981725271, 7675.347595454379, 6473.611583305005, 7197.424206063515, 7438.851222975551, 7448.441366897491, 7543.69825206991, 2198.6152423325934, 2225.944351391212, 2227.4431392151964, 2228.108756497406, 2233.7542870284256, 1866.1042699504246, 2173.8369622278315, 2183.3995651195887, 2194.36363454598, 2194.5281764420647, 2129.8935053247274, 2214.7895949884737, 2231.252530402317, 2232.799048085672, 2239.876806775627, 2167.219800871685, 2205.878676672782, 2208.966865497011, 2211.1818627107914, 2242.3273018094505, 2190.266260802633, 2195.110980053081, 2196.7803219677903, 2197.4067001909557, 2198.40643026382, 7690.346320562759, 7721.845563088763, 7730.420218483636, 7743.728969486097, 7748.457607967444, 4521.683482156251, 4531.478879928784, 4552.271636538138, 4559.840405585822, 4647.419072615923, 2825.773938084969, 2834.2772592988863, 2912.4903141950076, 2964.3774807290497, 2972.3758010817755, 879.6393478673713, 884.7566919097235, 886.4636894678691, 894.7539426657656, 901.33301356996, 10071.295009349422, 10072.54673539685, 10075.848862267072, 10076.445795481246, 10100.949495252476, 3959.40608908666, 4076.286649836267, 4149.585041495826, 4216.262154123016, 4222.408862759216, 8642.740717778477, 8646.092160323202, 8669.176428239307, 8676.826463470696, 8699.739007829776, 4638.1187574360765, 4647.233206520887, 4656.208444564432, 4659.836905708284, 4670.859874203779, 4148.875533733993, 4185.937210941838, 4204.894877628022, 4219.767912764766, 4226.344916537942, 3501.1772233525103, 3505.9824700876334, 3531.770434921722, 3567.8929632111076, 3581.659742324475, 1031.664708969588, 1136.471540733563, 1151.654503648902, 1164.0920082335792, 1181.9763604727857, 623.3984205241873, 738.7155944961229, 739.7965559471081, 790.8299715561182, 847.8050048488882, 4925.532074452921, 5139.254808052811, 5146.356705411824, 5198.558122559549, 5224.05966925957, 759.1687102622619, 796.6415113199083, 807.894973653433, 827.0612854410167, 856.1866227084295, 3578.3737845876867, 3686.7787932724123, 3690.0590349460717, 3707.545758316283, 3748.475213470116, 8901.421407608614, 9283.442993420416, 9431.292653051049, 9433.716988490356, 9454.385464944757, 7977.641006154737, 8640.827183456297, 8934.151255630704, 9268.443893366419, 9327.533623318806, 6942.0, 7092.858142837114, 7106.0, 7151.642417879085, 7152.105986751656, 4920.5817505511, 5118.97440512795, 5160.432352441153, 5201.115810312332, 5314.388845282842, 8318.958405207935, 8551.230389264996, 8587.22714955657, 8717.476951382938, 8740.694075707319, 8759.255463285692, 8795.25240354577, 8864.379493435397, 8968.192862642394, 8985.730428087169, 6739.393454588914, 6834.965825171042, 6883.3116688330765, 6885.173779146334, 6888.380045795902, 7299.489035767445, 7330.5968171751065, 7376.815579610553, 7391.704331826667, 7395.075615548057, 5742.856428589152, 5815.854603634943, 6601.801945941629, 6662.267150613526, 6870.965645171742, 6420.0, 6503.479721622164, 6558.081868538313, 6575.473962083118, 6590.538662293785, 5948.672822994777, 5967.045272756338, 5974.850628734316, 6024.246969128859, 6030.3668114847305, 4432.889177770581, 4564.42944631921, 4564.7032942858605, 4677.321788340603, 4693.296005599051, 4613.700109492872, 4718.150732867979, 4723.881902952454, 4730.432348118248, 4740.525947405232], "value": 4052.813075053194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.4523186872417, 295.20589613938506, 298.20082179758236, 300.8601000534751, 301.37314386076963, 4924.113659541281, 4936.0, 4938.456769755324, 4944.975275123628, 4958.578520825729, 4812.15787237233, 4823.589994850442, 4826.251930950708, 4878.195097808857, 4889.413270407547, 3643.7995910224927, 3760.9623903760885, 3771.4342848572796, 3849.538055433352, 3850.4994350734364, 3802.4296355546753, 3825.407061905409, 3846.0961674006585, 3853.5761066282685, 3868.845246190149, 3805.0106972187154, 3827.617238276178, 3835.1946091320856, 3837.846486140565, 3842.558105817825, 3615.6745892869635, 3694.963050369502, 3778.9433158502643, 3794.829232684536, 3833.4824798652385, 3350.731941444703, 3378.983105084483, 3387.1193489692855, 3389.1527118220447, 3397.9830100849586, 4717.127331443694, 4736.59738922192, 4741.028089241697, 4742.928856067162, 4748.976255118702, 4206.326987681987, 4352.825886964518, 4363.47638283408, 4383.693141480097, 4410.977945110286, 5062.31658726071, 5067.366579177603, 5087.465816089331, 5092.210707340369, 5095.337606111182, 3711.0165806061414, 3728.384816505273, 3728.9440658390145, 3731.3656678364473, 3731.4962480065115, 5179.792808287664, 5373.946260537384, 5392.811251606175, 5395.757190926457, 5399.487048730364, 3813.6758375537834, 3826.559945606291, 3836.712246581462, 3839.3665045267217, 3842.50047493824, 3874.767513949172, 3876.496055512822, 3883.7863917484246, 3886.417037444406, 3895.9220815584094, 4373.409589705349, 4380.525003373084, 4383.956160438354, 4395.120975804788, 4408.140412619508, 4860.684055536379, 5143.331366922276, 5150.690958542499, 5158.793648254103, 5188.247704082887, 1275.9489620415266, 1290.148501988683, 1295.4429595274123, 1296.5202874936333, 1296.546208826903, 811.5536454949872, 817.6606708216024, 847.6100993543039, 855.8202777416687, 860.0281681699639, 4369.80335884886, 4487.6185524230805, 4513.729176249435, 4540.250858608359, 4547.8180872764715, 5274.815381461707, 5284.365876094893, 5284.894302113936, 5287.709175995357, 5304.549113325334, 4517.554382597603, 4521.0, 4521.751303678329, 4528.592426681548, 4531.45622525299, 2657.255968328871, 2789.428167225714, 2799.314168028846, 2809.3819359740824, 2835.957460638092, 4924.630652701062, 4938.38270216223, 4970.254461830682, 4980.211081794207, 4981.2030075187795, 5243.318368612056, 5394.083005889008, 5403.7838486460105, 5415.783368665209, 5424.294841670637, 4930.359053323188, 4967.254911763264, 4987.650864439454, 4990.600751939836, 5008.57427118699, 5282.641820498027, 5283.524482796413, 5294.947050529446, 5300.3639563252655, 5305.840824775263, 5086.160783470834, 5177.197534382177, 5184.559312458483, 5219.8434046978655, 5243.134882744457, 4957.355543779286, 4975.726335051607, 4976.30331753562, 4988.152014157675, 4990.675606085593, 3395.541601883714, 3429.5713035870517, 3478.1652403423504, 3497.5453191085, 3499.055255081165, 4532.90934181308, 4707.599854012447, 4784.6889952153, 4803.303520989367, 4851.199552073868, 4515.5484451554585, 4525.456945166601, 4548.317752337176, 4587.541245875385, 4617.445906491243, 4550.431196100488, 4583.816647334203, 4597.471290801601, 4597.60920321763, 4603.976980115078, 4413.382126502356, 4487.685861989629, 4513.1650644630845, 4526.751028693322, 4551.795169217327, 4643.953560464352, 4928.704277743347, 4981.975090124526, 5206.869828254324, 5207.505286997729, 5076.923846142385, 5078.289039534394, 5085.186370180753, 5092.185250359925, 5111.849833787368], "value": 3807.555397773809, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.8561194955032, 722.1478655186879, 734.5115498193702, 745.5899255409523, 757.8446418484209, 11629.767404651902, 12235.938820305886, 12270.0797440192, 12290.139690221687, 12291.078169137305, 11553.65339039828, 11556.191066625339, 11558.47986840592, 11562.53749850007, 11615.419229038536, 621.9378062193779, 770.7572114783853, 796.1839114907209, 797.9680812767511, 800.771780042688, 782.9921700782976, 789.4513313247295, 792.5086446403209, 793.0562630469751, 793.2424534569501, 653.5196630476596, 843.7004863273542, 846.0904527632789, 846.2637505370305, 846.5851732650988, 662.0268205737558, 664.4717449627534, 664.7374287156595, 808.8341889912554, 833.5332213960202, 610.4048552661164, 611.5963464113709, 612.3600837125215, 615.0221148374062, 615.2401783797008, 11889.643310700692, 11916.106292028046, 11929.105317101164, 11934.522619095225, 11935.16453848231, 12058.577949771803, 12551.748965020739, 12563.497460101586, 12732.745345093139, 12949.093563450562, 11564.76870462586, 11625.0, 11776.0, 11900.523979040829, 12319.63041108768, 4085.387191921206, 4150.439690641755, 4154.231467178552, 4155.646770024551, 4162.542120366757, 58230.41769582292, 58232.708836455546, 58760.41239587592, 59072.70463647654, 59478.0, 9752.609895604097, 9908.752281192883, 9968.380512805177, 10065.949670251603, 10409.115225205942, 18223.544411389823, 18300.0, 18318.175682094337, 18330.175142118638, 18340.449786506426, 6172.69136543171, 6555.967220163869, 6672.332766723289, 6896.448284137257, 7057.468525358511, 3700.870469533553, 3772.2832661794173, 3791.677707394847, 3836.9808150959066, 3932.036651020518, 2709.322669332667, 2801.7058208887775, 2804.2568719289407, 2808.5225511663066, 2810.2412348665744, 475.583864118896, 487.05511308062245, 496.54318027414865, 497.3757933793139, 502.73103889418985, 540.1843216742668, 543.3914016301688, 582.408855012163, 587.4184557288254, 633.3128555517316, 7802.960985195038, 7884.329831964347, 7890.9605451972375, 8217.79455513617, 8328.33373330132, 576.3026737647493, 579.3192998227066, 598.9011813050885, 603.8279090459198, 636.5734957578434, 3885.261800257942, 4041.1513582148077, 4048.574899635496, 4079.1433798902563, 4147.170565886835, 89996.5500172495, 90676.0, 90735.0, 92673.0, 94359.52820235855, 79501.60249198717, 80440.0, 82207.588962056, 82551.0, 83453.0, 72354.27645723475, 72697.63651181711, 74015.62992185005, 75286.62356688292, 75400.62299688466, 7317.67070481819, 7402.1857595665515, 7531.435142364235, 7539.886901696588, 7575.545467271982, 42546.36180457358, 44313.33529996988, 44462.11075778531, 44758.32862507, 45803.3129503051, 58591.0, 64274.0, 64831.67584162049, 65551.34448655452, 65641.0, 9726.513674316397, 10354.430506322225, 10553.997370249814, 10651.30766500175, 10806.891931080903, 11323.886761132613, 11488.597899073493, 11519.366434845828, 12155.87844121583, 12202.08484363694, 10453.581856725647, 10546.894531054591, 10555.52500137511, 10832.350058996486, 12494.68763280889, 11874.0, 11898.881011189776, 11923.940380298043, 12346.382680865741, 12402.13185077036, 11911.702207444883, 12054.15620906528, 12494.562690305796, 12561.497540098293, 12620.242785432903, 9876.753081173028, 10128.0, 10238.027387398186, 10321.63874264397, 10418.166546676399, 9758.951205243928, 10111.3427627204, 10116.797664046531, 10122.342047766871, 10129.240306977154], "value": 6481.429411696468, "unit": "score"}], "name": "dromaeo_css", "value": 6330.089184217695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 125.0, 172.0, 124.0, 123.0, 142.0, 132.0, 194.0, 125.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 164.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 118.0, 76.0, 78.0, 76.0, 77.0, 99.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 115.0, 86.0, 86.0, 86.0, 130.0, 85.0, 85.0, 132.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 65.0, 65.0, 65.0, 65.0, 63.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 80.0, 79.0, 81.0, 78.0, 78.0, 89.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 135.0, 133.0, 130.0, 139.0, 132.0, 143.0, 137.0, 173.0, 131.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 165.0, 166.0, 167.0, 169.0, 166.0, 169.0, 170.0, 167.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 67.0, 67.0, 66.0, 70.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1536.5, "alertThreshold": 2.0}]} 16:12:51 INFO - Return code: 0 16:12:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:12:51 INFO - # TBPL SUCCESS # 16:12:51 INFO - Running post-action listener: _resource_record_post_action 16:12:51 INFO - ##### 16:12:51 INFO - ##### Finished run-tests step (success) 16:12:51 INFO - ##### 16:12:51 INFO - Running post-run listener: _resource_record_post_run 16:12:51 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 544935936; Read time: 0; Write time: 469068 16:12:51 INFO - TinderboxPrint: CPU usage
13.0% 16:12:51 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:12:51 INFO - TinderboxPrint: I/O write bytes / time
544,935,936 / 469,068 16:12:51 INFO - TinderboxPrint: CPU idle
8,323.6 (87.0%) 16:12:51 INFO - TinderboxPrint: CPU user
1,205.9 (12.6%) 16:12:51 INFO - TinderboxPrint: Swap in / out
0 / 0 16:12:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257363968; Read time: 0; Write time: 271936 16:12:51 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 287571968; Read time: 0; Write time: 197132 16:12:52 INFO - Running post-run listener: _upload_blobber_files 16:12:52 INFO - Blob upload gear active. 16:12:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:52 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 16:12:52 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'] 16:12:52 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 16:12:52 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:53 INFO - (blobuploader) - INFO - Done attempting. 16:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:56 INFO - (blobuploader) - INFO - Done attempting. 16:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:57 INFO - (blobuploader) - INFO - Done attempting. 16:12:57 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:57 INFO - Return code: 0 16:12:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20995e314067e9fa8d7f73246e6a3a88d13f6d6f84ee43c1825784ad031ecd09b2894b7bcdcd68331d1fb67ac205968e71960d0ed9fe8cc0c05e1c7360d63ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a01372ba4e34b30c8cffc8406ba15dfe2743897a597c8270accafa32787f504eaff5bb373f7ddadfd2ebfbb3e0456988089396eaa9ad65598ee4d4d772b8adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcfa14e6187edbd72d33f276ccef0046bfef68a809a444c2746be4f38cbe5e9415c11cb429c621676b111de827fee3bb29e190c1d422de48b302192c1aaa8ae1"} 16:12:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:57 INFO - Contents: 16:12:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20995e314067e9fa8d7f73246e6a3a88d13f6d6f84ee43c1825784ad031ecd09b2894b7bcdcd68331d1fb67ac205968e71960d0ed9fe8cc0c05e1c7360d63ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a01372ba4e34b30c8cffc8406ba15dfe2743897a597c8270accafa32787f504eaff5bb373f7ddadfd2ebfbb3e0456988089396eaa9ad65598ee4d4d772b8adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcfa14e6187edbd72d33f276ccef0046bfef68a809a444c2746be4f38cbe5e9415c11cb429c621676b111de827fee3bb29e190c1d422de48b302192c1aaa8ae1"} 16:12:57 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:57 INFO - Copying logs to upload dir... 16:12:57 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.685208 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-11 16:12:57.186167) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:12:57.193997) ========= 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=923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20995e314067e9fa8d7f73246e6a3a88d13f6d6f84ee43c1825784ad031ecd09b2894b7bcdcd68331d1fb67ac205968e71960d0ed9fe8cc0c05e1c7360d63ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a01372ba4e34b30c8cffc8406ba15dfe2743897a597c8270accafa32787f504eaff5bb373f7ddadfd2ebfbb3e0456988089396eaa9ad65598ee4d4d772b8adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcfa14e6187edbd72d33f276ccef0046bfef68a809a444c2746be4f38cbe5e9415c11cb429c621676b111de827fee3bb29e190c1d422de48b302192c1aaa8ae1"} build_url:https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/P6M9xmp4R_ulGn_DJ_ZZLg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20995e314067e9fa8d7f73246e6a3a88d13f6d6f84ee43c1825784ad031ecd09b2894b7bcdcd68331d1fb67ac205968e71960d0ed9fe8cc0c05e1c7360d63ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a01372ba4e34b30c8cffc8406ba15dfe2743897a597c8270accafa32787f504eaff5bb373f7ddadfd2ebfbb3e0456988089396eaa9ad65598ee4d4d772b8adb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcfa14e6187edbd72d33f276ccef0046bfef68a809a444c2746be4f38cbe5e9415c11cb429c621676b111de827fee3bb29e190c1d422de48b302192c1aaa8ae1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:12:57.225874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:12:57.226234) ========= 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=923d835db2ba3686ebe126b700000192-1468277538.885697-1646071725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:12:57.308491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:12:57.308813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:12:57.309110) ========= ========= Total master_lag: 0.19 =========