builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1467693798.06 results: success (0) buildid: 20160704205822 builduid: e662c191b8b44a5f80766d601c4cd09f revision: 652fa69526ff82afbe7b7e6a360709c457fddf19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.063006) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.063757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.064156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.106051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.106372) ========= 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=8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 21:43:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.2K=0.1s 2016-07-04 21:43:18 (85.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.280811 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.408467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.408825) ========= 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=8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.459130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:18.459530) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 652fa69526ff82afbe7b7e6a360709c457fddf19 --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 652fa69526ff82afbe7b7e6a360709c457fddf19 --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=8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 21:43:18,923 truncating revision to first 12 chars 2016-07-04 21:43:18,923 Setting DEBUG logging. 2016-07-04 21:43:18,923 attempt 1/10 2016-07-04 21:43:18,923 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/652fa69526ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 21:43:19,205 unpacking tar archive at: fx-team-652fa69526ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:19.143108) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:19.143475) ========= script_repo_revision: 652fa69526ff82afbe7b7e6a360709c457fddf19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:19.143999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:19.144330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 21:43:19.154009) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-04 21:43:19.154333) ========= /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=8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:43:19 INFO - MultiFileLogger online at 20160704 21:43:19 in /builds/slave/test 21:43:19 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 21:43:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:43:19 INFO - {'append_to_log': False, 21:43:19 INFO - 'base_work_dir': '/builds/slave/test', 21:43:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:43:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:43:19 INFO - 'branch': 'Fx-Team-Non-PGO', 21:43:19 INFO - 'buildbot_json_path': 'buildprops.json', 21:43:19 INFO - 'config_files': ('talos/linux_config.py',), 21:43:19 INFO - 'default_actions': ('clobber', 21:43:19 INFO - 'read-buildbot-config', 21:43:19 INFO - 'download-and-extract', 21:43:19 INFO - 'populate-webroot', 21:43:19 INFO - 'create-virtualenv', 21:43:19 INFO - 'install', 21:43:19 INFO - 'run-tests'), 21:43:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:43:19 INFO - 'download_minidump_stackwalk': True, 21:43:19 INFO - 'download_symbols': 'ondemand', 21:43:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:43:19 INFO - 'tooltool.py': '/tools/tooltool.py', 21:43:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:43:19 INFO - '/tools/misc-python/virtualenv.py')}, 21:43:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:43:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:43:19 INFO - 'installer_path': 'installer.exe', 21:43:19 INFO - 'log_level': 'info', 21:43:19 INFO - 'log_name': 'talos', 21:43:19 INFO - 'log_to_console': True, 21:43:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:43:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:43:19 INFO - 'opt_config_files': (), 21:43:19 INFO - 'pip_index': False, 21:43:19 INFO - 'sps_profile': False, 21:43:19 INFO - 'sps_profile_interval': 0, 21:43:19 INFO - 'suite': 'dromaeojs', 21:43:19 INFO - 'system_bits': '32', 21:43:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:43:19 INFO - 'title': 'talos-linux64-ix-038', 21:43:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:43:19 INFO - 'use_talos_json': True, 21:43:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:43:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:43:19 INFO - 'work_dir': 'build'} 21:43:19 INFO - ##### 21:43:19 INFO - ##### Running clobber step. 21:43:19 INFO - ##### 21:43:19 INFO - Running pre-action listener: _resource_record_pre_action 21:43:19 INFO - Running main action method: clobber 21:43:19 INFO - rmtree: /builds/slave/test/build 21:43:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:43:20 INFO - Running post-action listener: _resource_record_post_action 21:43:20 INFO - ##### 21:43:20 INFO - ##### Finished clobber step (success) 21:43:20 INFO - ##### 21:43:20 INFO - ##### 21:43:20 INFO - ##### Running read-buildbot-config step. 21:43:20 INFO - ##### 21:43:20 INFO - Running pre-action listener: _resource_record_pre_action 21:43:20 INFO - Running main action method: read_buildbot_config 21:43:20 INFO - Using buildbot properties: 21:43:20 INFO - { 21:43:20 INFO - "project": "", 21:43:20 INFO - "product": "firefox", 21:43:20 INFO - "script_repo_revision": "production", 21:43:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:43:20 INFO - "repository": "", 21:43:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:43:20 INFO - "buildid": "20160704205822", 21:43:20 INFO - "pgo_build": "False", 21:43:20 INFO - "basedir": "/builds/slave/test", 21:43:20 INFO - "buildnumber": 1793, 21:43:20 INFO - "slavename": "talos-linux64-ix-038", 21:43:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:43:20 INFO - "platform": "ubuntu64_hw", 21:43:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:43:20 INFO - "branch": "fx-team", 21:43:20 INFO - "repo_path": "integration/fx-team", 21:43:20 INFO - "revision": "652fa69526ff82afbe7b7e6a360709c457fddf19", 21:43:20 INFO - "stage_platform": "linux64", 21:43:20 INFO - "builduid": "e662c191b8b44a5f80766d601c4cd09f", 21:43:20 INFO - "slavebuilddir": "test" 21:43:20 INFO - } 21:43:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:43:20 INFO - Running post-action listener: _resource_record_post_action 21:43:20 INFO - ##### 21:43:20 INFO - ##### Finished read-buildbot-config step (success) 21:43:20 INFO - ##### 21:43:20 INFO - ##### 21:43:20 INFO - ##### Running download-and-extract step. 21:43:20 INFO - ##### 21:43:20 INFO - Running pre-action listener: _resource_record_pre_action 21:43:20 INFO - Running main action method: download_and_extract 21:43:20 INFO - mkdir: /builds/slave/test/build/tests 21:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:20 INFO - https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:24 INFO - Downloaded 1361 bytes. 21:43:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:43:24 INFO - Using the following test package requirements: 21:43:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:43:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:43:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:43:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'jsshell-linux-x86_64.zip'], 21:43:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:43:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:43:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:43:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:43:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:43:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:43:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:43:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:43: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')]} 21:43:24 INFO - https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:43:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:43:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:43:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:29 INFO - Downloaded 22728514 bytes. 21:43:29 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'] 21:43:29 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 21:43:31 INFO - Return code: 0 21:43:31 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 21:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:43:31 INFO - https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:43:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:43:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:43:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:36 INFO - Downloaded 22728514 bytes. 21:43:36 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'] 21:43:36 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 21:43:37 INFO - Return code: 0 21:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:43:37 INFO - https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:39 INFO - Downloaded 14403333 bytes. 21:43:39 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'] 21:43:39 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 21:43:39 INFO - Return code: 0 21:43:39 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')]} 21:43:39 INFO - https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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 21:43:41 INFO - Downloaded 56489852 bytes. 21:43:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:43:41 INFO - mkdir: /builds/slave/test/properties 21:43:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:43:41 INFO - Writing to file /builds/slave/test/properties/build_url 21:43:41 INFO - Contents: 21:43:41 INFO - build_url:https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:43:41 INFO - Running post-action listener: _resource_record_post_action 21:43:41 INFO - Running post-action listener: set_extra_try_arguments 21:43:41 INFO - ##### 21:43:41 INFO - ##### Finished download-and-extract step (success) 21:43:41 INFO - ##### 21:43:41 INFO - ##### 21:43:41 INFO - ##### Running populate-webroot step. 21:43:41 INFO - ##### 21:43:41 INFO - Running pre-action listener: _resource_record_pre_action 21:43:41 INFO - Running main action method: populate_webroot 21:43:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:43:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:43:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:43:41 INFO - '--tppagecycles', 21:43:41 INFO - '7'], 21:43:41 INFO - 'tests': ['tsvgm']}}, 21:43:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:43:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:43:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:43:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:43:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:43:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:43:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['damp', 'tps']}, 21:43:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'tests': ['damp', 'tps']}, 21:43:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['dromaeo_dom']}, 21:43:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:43:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['basic_compositor_video']}, 21:43:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:43:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['a11yr', 21:43:41 INFO - 'ts_paint', 21:43:41 INFO - 'tpaint', 21:43:41 INFO - 'sessionrestore', 21:43:41 INFO - 'sessionrestore_no_auto_restore', 21:43:41 INFO - 'tabpaint']}, 21:43:41 INFO - 'other-e10s': {'tests': ['a11yr', 21:43:41 INFO - 'ts_paint', 21:43:41 INFO - 'tpaint', 21:43:41 INFO - 'sessionrestore', 21:43:41 INFO - 'sessionrestore_no_auto_restore', 21:43:41 INFO - 'tabpaint']}, 21:43:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:43:41 INFO - 'ts_paint', 21:43:41 INFO - 'tpaint', 21:43:41 INFO - 'sessionrestore', 21:43:41 INFO - 'sessionrestore_no_auto_restore', 21:43:41 INFO - 'tabpaint']}, 21:43:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:43:41 INFO - 'ts_paint', 21:43:41 INFO - 'tpaint', 21:43:41 INFO - 'sessionrestore', 21:43:41 INFO - 'sessionrestore_no_auto_restore', 21:43:41 INFO - 'tabpaint']}, 21:43:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['a11yr', 21:43:41 INFO - 'ts_paint', 21:43:41 INFO - 'tpaint', 21:43:41 INFO - 'sessionrestore', 21:43:41 INFO - 'sessionrestore_no_auto_restore', 21:43:41 INFO - 'tabpaint']}, 21:43:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['a11yr', 21:43:41 INFO - 'ts_paint', 21:43:41 INFO - 'tpaint', 21:43:41 INFO - 'sessionrestore', 21:43:41 INFO - 'sessionrestore_no_auto_restore', 21:43:41 INFO - 'tabpaint']}, 21:43:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['tsvgx', 21:43:41 INFO - 'tsvgr_opacity', 21:43:41 INFO - 'tart', 21:43:41 INFO - 'tscrollx', 21:43:41 INFO - 'cart']}, 21:43:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:43:41 INFO - 'tsvgr_opacity', 21:43:41 INFO - 'tart', 21:43:41 INFO - 'tscrollx', 21:43:41 INFO - 'cart']}, 21:43:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'talos_options': ['--disable-e10s'], 21:43:41 INFO - 'tests': ['tp5o']}, 21:43:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'tests': ['tp5o']}, 21:43:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'talos_options': ['--disable-e10s', 21:43:41 INFO - '--xperf_path', 21:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:43:41 INFO - 'tests': ['tp5n']}, 21:43:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:43:41 INFO - 'talos_options': ['--xperf_path', 21:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:43:41 INFO - 'tests': ['tp5n']}}, 21:43:41 INFO - 'talos.zip': {'path': '', 21:43:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:43:41 INFO - Running post-action listener: _resource_record_post_action 21:43:41 INFO - ##### 21:43:41 INFO - ##### Finished populate-webroot step (success) 21:43:41 INFO - ##### 21:43:41 INFO - ##### 21:43:41 INFO - ##### Running create-virtualenv step. 21:43:41 INFO - ##### 21:43:41 INFO - Running pre-action listener: _resource_record_pre_action 21:43:41 INFO - Running main action method: create_virtualenv 21:43:41 INFO - Creating virtualenv /builds/slave/test/build/venv 21:43:41 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 21:43:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:43:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:43:41 INFO - Using real prefix '/usr' 21:43:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:43:42 INFO - Installing distribute.............................................................................................................................................................................................done. 21:43:44 INFO - Installing pip.................done. 21:43:44 INFO - Return code: 0 21:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:43: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')]} 21:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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')]} 21:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:44 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:43:44 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 21:43:44 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 21:43:44 INFO - Using env: {'DISPLAY': ':0', 21:43:44 INFO - 'HOME': '/home/cltbld', 21:43:44 INFO - 'LANG': 'en_US.UTF-8', 21:43:44 INFO - 'LANGUAGE': 'en_US:en', 21:43:44 INFO - 'LOGNAME': 'cltbld', 21:43:44 INFO - 'MAIL': '/var/mail/cltbld', 21:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:44 INFO - 'MOZ_NO_REMOTE': '1', 21:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:44 INFO - 'NO_EM_RESTART': '1', 21:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:44 INFO - 'PWD': '/builds/slave/test', 21:43:44 INFO - 'SHELL': '/bin/bash', 21:43:44 INFO - 'SHLVL': '1', 21:43:44 INFO - 'TERM': 'linux', 21:43:44 INFO - 'TMOUT': '86400', 21:43:44 INFO - 'USER': 'cltbld', 21:43:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:44 INFO - '_': '/tools/buildbot/bin/python'} 21:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:44 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 21:43:44 INFO - Cleaning up... 21:43:44 INFO - Return code: 0 21:43:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:43: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')]} 21:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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')]} 21:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:44 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:43:44 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 21:43:44 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 21:43:44 INFO - Using env: {'DISPLAY': ':0', 21:43:44 INFO - 'HOME': '/home/cltbld', 21:43:44 INFO - 'LANG': 'en_US.UTF-8', 21:43:44 INFO - 'LANGUAGE': 'en_US:en', 21:43:44 INFO - 'LOGNAME': 'cltbld', 21:43:44 INFO - 'MAIL': '/var/mail/cltbld', 21:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:44 INFO - 'MOZ_NO_REMOTE': '1', 21:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:44 INFO - 'NO_EM_RESTART': '1', 21:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:44 INFO - 'PWD': '/builds/slave/test', 21:43:44 INFO - 'SHELL': '/bin/bash', 21:43:44 INFO - 'SHLVL': '1', 21:43:44 INFO - 'TERM': 'linux', 21:43:44 INFO - 'TMOUT': '86400', 21:43:44 INFO - 'USER': 'cltbld', 21:43:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:44 INFO - '_': '/tools/buildbot/bin/python'} 21:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:44 INFO - Downloading/unpacking psutil>=3.1.1 21:43:44 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 21:43:44 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 21:43:44 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 21:43:44 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 21:43:44 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 21:43:44 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 21:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:43:46 INFO - Installing collected packages: psutil 21:43:46 INFO - Running setup.py install for psutil 21:43:46 INFO - building 'psutil._psutil_linux' extension 21:43:46 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 21:43:47 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 21:43:47 INFO - building 'psutil._psutil_posix' extension 21:43:47 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 21:43:47 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 21:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:43:47 INFO - Successfully installed psutil 21:43:47 INFO - Cleaning up... 21:43:47 INFO - Return code: 0 21:43:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:43: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')]} 21:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43: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')]} 21:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:47 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:43:47 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 21:43:47 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 21:43:47 INFO - Using env: {'DISPLAY': ':0', 21:43:47 INFO - 'HOME': '/home/cltbld', 21:43:47 INFO - 'LANG': 'en_US.UTF-8', 21:43:47 INFO - 'LANGUAGE': 'en_US:en', 21:43:47 INFO - 'LOGNAME': 'cltbld', 21:43:47 INFO - 'MAIL': '/var/mail/cltbld', 21:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:47 INFO - 'MOZ_NO_REMOTE': '1', 21:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:47 INFO - 'NO_EM_RESTART': '1', 21:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:47 INFO - 'PWD': '/builds/slave/test', 21:43:47 INFO - 'SHELL': '/bin/bash', 21:43:47 INFO - 'SHLVL': '1', 21:43:47 INFO - 'TERM': 'linux', 21:43:47 INFO - 'TMOUT': '86400', 21:43:47 INFO - 'USER': 'cltbld', 21:43:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:47 INFO - '_': '/tools/buildbot/bin/python'} 21:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:43:47 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 21:43:47 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 21:43:47 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 21:43:47 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 21:43:47 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 21:43:47 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 21:43:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:43:49 INFO - Installing collected packages: mozsystemmonitor 21:43:49 INFO - Running setup.py install for mozsystemmonitor 21:43:49 INFO - Successfully installed mozsystemmonitor 21:43:49 INFO - Cleaning up... 21:43:49 INFO - Return code: 0 21:43:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:49 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:43:49 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 21:43:49 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 21:43:49 INFO - Using env: {'DISPLAY': ':0', 21:43:49 INFO - 'HOME': '/home/cltbld', 21:43:49 INFO - 'LANG': 'en_US.UTF-8', 21:43:49 INFO - 'LANGUAGE': 'en_US:en', 21:43:49 INFO - 'LOGNAME': 'cltbld', 21:43:49 INFO - 'MAIL': '/var/mail/cltbld', 21:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:49 INFO - 'MOZ_NO_REMOTE': '1', 21:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:49 INFO - 'NO_EM_RESTART': '1', 21:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:49 INFO - 'PWD': '/builds/slave/test', 21:43:49 INFO - 'SHELL': '/bin/bash', 21:43:49 INFO - 'SHLVL': '1', 21:43:49 INFO - 'TERM': 'linux', 21:43:49 INFO - 'TMOUT': '86400', 21:43:49 INFO - 'USER': 'cltbld', 21:43:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:49 INFO - '_': '/tools/buildbot/bin/python'} 21:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:49 INFO - Downloading/unpacking jsonschema==2.5.1 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:43:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:51 INFO - Downloading functools32-3.2.3-2.tar.gz 21:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:43:52 INFO - warning: no files found matching '*.txt' 21:43:52 INFO - no previously-included directories found matching 'build' 21:43:52 INFO - no previously-included directories found matching 'dist' 21:43:52 INFO - no previously-included directories found matching '.git*' 21:43:52 INFO - Installing collected packages: jsonschema, functools32 21:43:52 INFO - Running setup.py install for functools32 21:43:52 INFO - warning: no files found matching '*.txt' 21:43:52 INFO - no previously-included directories found matching 'build' 21:43:52 INFO - no previously-included directories found matching 'dist' 21:43:52 INFO - no previously-included directories found matching '.git*' 21:43:52 INFO - Successfully installed jsonschema functools32 21:43:52 INFO - Cleaning up... 21:43:52 INFO - Return code: 0 21:43:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:52 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:43:52 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 21:43:52 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 21:43:52 INFO - Using env: {'DISPLAY': ':0', 21:43:52 INFO - 'HOME': '/home/cltbld', 21:43:52 INFO - 'LANG': 'en_US.UTF-8', 21:43:52 INFO - 'LANGUAGE': 'en_US:en', 21:43:52 INFO - 'LOGNAME': 'cltbld', 21:43:52 INFO - 'MAIL': '/var/mail/cltbld', 21:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:52 INFO - 'MOZ_NO_REMOTE': '1', 21:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:52 INFO - 'NO_EM_RESTART': '1', 21:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:52 INFO - 'PWD': '/builds/slave/test', 21:43:52 INFO - 'SHELL': '/bin/bash', 21:43:52 INFO - 'SHLVL': '1', 21:43:52 INFO - 'TERM': 'linux', 21:43:52 INFO - 'TMOUT': '86400', 21:43:52 INFO - 'USER': 'cltbld', 21:43:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:52 INFO - '_': '/tools/buildbot/bin/python'} 21:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:43:52 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 21:43:52 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 21:43:52 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 21:43:52 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 21:43:52 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 21:43:52 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 21:43:54 INFO - Downloading blobuploader-1.2.4.tar.gz 21:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:43:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:43:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:55 INFO - Downloading docopt-0.6.1.tar.gz 21:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:43:55 INFO - Installing collected packages: blobuploader, requests, docopt 21:43:55 INFO - Running setup.py install for blobuploader 21:43:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:43:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:43:55 INFO - Running setup.py install for requests 21:43:55 INFO - Running setup.py install for docopt 21:43:55 INFO - Successfully installed blobuploader requests docopt 21:43:55 INFO - Cleaning up... 21:43:55 INFO - Return code: 0 21:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:55 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:43:55 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 21:43:55 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 21:43:55 INFO - Using env: {'DISPLAY': ':0', 21:43:55 INFO - 'HOME': '/home/cltbld', 21:43:55 INFO - 'LANG': 'en_US.UTF-8', 21:43:55 INFO - 'LANGUAGE': 'en_US:en', 21:43:55 INFO - 'LOGNAME': 'cltbld', 21:43:55 INFO - 'MAIL': '/var/mail/cltbld', 21:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:55 INFO - 'MOZ_NO_REMOTE': '1', 21:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:55 INFO - 'NO_EM_RESTART': '1', 21:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:55 INFO - 'PWD': '/builds/slave/test', 21:43:55 INFO - 'SHELL': '/bin/bash', 21:43:55 INFO - 'SHLVL': '1', 21:43:55 INFO - 'TERM': 'linux', 21:43:55 INFO - 'TMOUT': '86400', 21:43:55 INFO - 'USER': 'cltbld', 21:43:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:55 INFO - '_': '/tools/buildbot/bin/python'} 21:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:43:56 INFO - Running setup.py (path:/tmp/pip-NVk9pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:43:56 INFO - Running setup.py (path:/tmp/pip-g_HJnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:43:56 INFO - Running setup.py (path:/tmp/pip-ysOTSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:43:56 INFO - Running setup.py (path:/tmp/pip-jJLiE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:43:56 INFO - Running setup.py (path:/tmp/pip-ILXJij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:43:56 INFO - Running setup.py (path:/tmp/pip-Ydf0FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:43:56 INFO - Running setup.py (path:/tmp/pip-5XZjP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:43:56 INFO - Running setup.py (path:/tmp/pip-9W_KV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:43:56 INFO - Running setup.py (path:/tmp/pip-CNE3bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:43:56 INFO - Running setup.py (path:/tmp/pip-aJFyny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:43:56 INFO - Running setup.py (path:/tmp/pip-kjEqui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:43:56 INFO - Running setup.py (path:/tmp/pip-1Auau6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:43:57 INFO - Running setup.py (path:/tmp/pip-RszYRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:43:57 INFO - Running setup.py (path:/tmp/pip-2qHoCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:43:57 INFO - Running setup.py (path:/tmp/pip-mlgb5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:43:57 INFO - Running setup.py (path:/tmp/pip-G41_zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:43:57 INFO - Running setup.py (path:/tmp/pip-kS1PsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:43:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:43:57 INFO - Running setup.py install for manifestparser 21:43:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:43:57 INFO - Running setup.py install for mozcrash 21:43:57 INFO - Running setup.py install for mozdebug 21:43:57 INFO - Running setup.py install for mozdevice 21:43:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:43:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:43:57 INFO - Running setup.py install for mozfile 21:43:57 INFO - Running setup.py install for mozhttpd 21:43:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:43:57 INFO - Running setup.py install for mozinfo 21:43:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Running setup.py install for mozInstall 21:43:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Running setup.py install for mozleak 21:43:58 INFO - Running setup.py install for mozlog 21:43:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Running setup.py install for moznetwork 21:43:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Running setup.py install for mozprocess 21:43:58 INFO - Running setup.py install for mozprofile 21:43:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Running setup.py install for mozrunner 21:43:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:43:58 INFO - Running setup.py install for mozscreenshot 21:43:58 INFO - Running setup.py install for moztest 21:43:59 INFO - Running setup.py install for mozversion 21:43:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:43:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:43:59 INFO - Cleaning up... 21:43:59 INFO - Return code: 0 21:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:59 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:43:59 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 21:43:59 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 21:43:59 INFO - Using env: {'DISPLAY': ':0', 21:43:59 INFO - 'HOME': '/home/cltbld', 21:43:59 INFO - 'LANG': 'en_US.UTF-8', 21:43:59 INFO - 'LANGUAGE': 'en_US:en', 21:43:59 INFO - 'LOGNAME': 'cltbld', 21:43:59 INFO - 'MAIL': '/var/mail/cltbld', 21:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:59 INFO - 'MOZ_NO_REMOTE': '1', 21:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:43:59 INFO - 'NO_EM_RESTART': '1', 21:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:59 INFO - 'PWD': '/builds/slave/test', 21:43:59 INFO - 'SHELL': '/bin/bash', 21:43:59 INFO - 'SHLVL': '1', 21:43:59 INFO - 'TERM': 'linux', 21:43:59 INFO - 'TMOUT': '86400', 21:43:59 INFO - 'USER': 'cltbld', 21:43:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:59 INFO - '_': '/tools/buildbot/bin/python'} 21:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:43:59 INFO - Running setup.py (path:/tmp/pip-ba1UVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:43:59 INFO - Running setup.py (path:/tmp/pip-JPDE3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:43:59 INFO - Running setup.py (path:/tmp/pip-gXVXY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:43:59 INFO - Running setup.py (path:/tmp/pip-jUZfKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:43:59 INFO - Running setup.py (path:/tmp/pip-vcbD4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:43:59 INFO - Running setup.py (path:/tmp/pip-N6Zwgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:43:59 INFO - Running setup.py (path:/tmp/pip-BgMQmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:43:59 INFO - Running setup.py (path:/tmp/pip-f3kiH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:43:59 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)) 21:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:43:59 INFO - Running setup.py (path:/tmp/pip-FQZCZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:44:00 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:44:00 INFO - Running setup.py (path:/tmp/pip-Y8IjXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:44:00 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:44:00 INFO - Running setup.py (path:/tmp/pip-mahY1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:44:00 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:44:00 INFO - Running setup.py (path:/tmp/pip-ZsMw4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:44:00 INFO - Running setup.py (path:/tmp/pip-nY4Njs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:44:00 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:44:00 INFO - Running setup.py (path:/tmp/pip-_0_9Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:00 INFO - Running setup.py (path:/tmp/pip-lEtgVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:00 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:44:00 INFO - Running setup.py (path:/tmp/pip-n5HZRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:44:00 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)) 21:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:44:00 INFO - Running setup.py (path:/tmp/pip-FzjUXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:44:00 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)) 21:44:00 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)) 21:44:00 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)) 21:44:00 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)) 21:44:00 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)) 21:44:00 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)) 21:44:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:44:00 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 21:44:00 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 21:44:00 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 21:44:00 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 21:44:00 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 21:44:00 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 21:44:02 INFO - Downloading blessings-1.6.tar.gz 21:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:44:02 INFO - Installing collected packages: blessings 21:44:02 INFO - Running setup.py install for blessings 21:44:02 INFO - Successfully installed blessings 21:44:02 INFO - Cleaning up... 21:44:02 INFO - Return code: 0 21:44:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:44:02 INFO - Reading from file tmpfile_stdout 21:44:02 INFO - Current package versions: 21:44:02 INFO - argparse == 1.2.1 21:44:02 INFO - blessings == 1.6 21:44:02 INFO - blobuploader == 1.2.4 21:44:02 INFO - docopt == 0.6.1 21:44:02 INFO - functools32 == 3.2.3-2 21:44:02 INFO - jsonschema == 2.5.1 21:44:02 INFO - manifestparser == 1.1 21:44:02 INFO - mozInstall == 1.12 21:44:02 INFO - mozcrash == 0.17 21:44:02 INFO - mozdebug == 0.1 21:44:02 INFO - mozdevice == 0.48 21:44:02 INFO - mozfile == 1.2 21:44:02 INFO - mozhttpd == 0.7 21:44:02 INFO - mozinfo == 0.9 21:44:02 INFO - mozleak == 0.1 21:44:02 INFO - mozlog == 3.2 21:44:02 INFO - moznetwork == 0.27 21:44:02 INFO - mozprocess == 0.22 21:44:02 INFO - mozprofile == 0.28 21:44:02 INFO - mozrunner == 6.11 21:44:02 INFO - mozscreenshot == 0.1 21:44:02 INFO - mozsystemmonitor == 0.3 21:44:02 INFO - moztest == 0.7 21:44:02 INFO - mozversion == 1.4 21:44:02 INFO - psutil == 3.1.1 21:44:02 INFO - requests == 1.2.3 21:44:02 INFO - wsgiref == 0.1.2 21:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:02 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:44:02 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 21:44:02 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 21:44:02 INFO - Using env: {'DISPLAY': ':0', 21:44:02 INFO - 'HOME': '/home/cltbld', 21:44:02 INFO - 'LANG': 'en_US.UTF-8', 21:44:02 INFO - 'LANGUAGE': 'en_US:en', 21:44:02 INFO - 'LOGNAME': 'cltbld', 21:44:02 INFO - 'MAIL': '/var/mail/cltbld', 21:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:02 INFO - 'MOZ_NO_REMOTE': '1', 21:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:02 INFO - 'NO_EM_RESTART': '1', 21:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:02 INFO - 'PWD': '/builds/slave/test', 21:44:02 INFO - 'SHELL': '/bin/bash', 21:44:02 INFO - 'SHLVL': '1', 21:44:02 INFO - 'TERM': 'linux', 21:44:02 INFO - 'TMOUT': '86400', 21:44:02 INFO - 'USER': 'cltbld', 21:44:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:02 INFO - '_': '/tools/buildbot/bin/python'} 21:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 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)) 21:44:03 INFO - Cleaning up... 21:44:03 INFO - Return code: 0 21:44:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:44:03 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')]} 21:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:03 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')]} 21:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:03 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 0x17f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, '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': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', '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 21:44:03 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 21:44:03 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 21:44:03 INFO - Using env: {'DISPLAY': ':0', 21:44:03 INFO - 'HOME': '/home/cltbld', 21:44:03 INFO - 'LANG': 'en_US.UTF-8', 21:44:03 INFO - 'LANGUAGE': 'en_US:en', 21:44:03 INFO - 'LOGNAME': 'cltbld', 21:44:03 INFO - 'MAIL': '/var/mail/cltbld', 21:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:03 INFO - 'MOZ_NO_REMOTE': '1', 21:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:03 INFO - 'NO_EM_RESTART': '1', 21:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:03 INFO - 'PWD': '/builds/slave/test', 21:44:03 INFO - 'SHELL': '/bin/bash', 21:44:03 INFO - 'SHLVL': '1', 21:44:03 INFO - 'TERM': 'linux', 21:44:03 INFO - 'TMOUT': '86400', 21:44:03 INFO - 'USER': 'cltbld', 21:44:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:03 INFO - '_': '/tools/buildbot/bin/python'} 21:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:44:03 INFO - Cleaning up... 21:44:03 INFO - Return code: 0 21:44:03 INFO - Running post-action listener: _resource_record_post_action 21:44:03 INFO - Running post-action listener: _start_resource_monitoring 21:44:03 INFO - Starting resource monitoring. 21:44:03 INFO - ##### 21:44:03 INFO - ##### Finished create-virtualenv step (success) 21:44:03 INFO - ##### 21:44:03 INFO - ##### 21:44:03 INFO - ##### Running install step. 21:44:03 INFO - ##### 21:44:03 INFO - Running pre-action listener: _resource_record_pre_action 21:44:03 INFO - Running main action method: install 21:44:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:44:03 INFO - Reading from file tmpfile_stdout 21:44:03 INFO - Detecting whether we're running mozinstall >=1.0... 21:44:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:44:03 INFO - Reading from file tmpfile_stdout 21:44:03 INFO - Output received: 21:44:03 INFO - Usage: mozinstall [options] installer 21:44:03 INFO - Options: 21:44:03 INFO - -h, --help show this help message and exit 21:44:03 INFO - -d DEST, --destination=DEST 21:44:03 INFO - Directory to install application into. [default: 21:44:03 INFO - "/builds/slave/test"] 21:44:03 INFO - --app=APP Application being installed. [default: firefox] 21:44:03 INFO - mkdir: /builds/slave/test/build/application 21:44:03 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'] 21:44:03 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 21:44:20 INFO - Reading from file tmpfile_stdout 21:44:20 INFO - Output received: 21:44:20 INFO - /builds/slave/test/build/application/firefox/firefox 21:44:20 INFO - Running post-action listener: _resource_record_post_action 21:44:20 INFO - ##### 21:44:20 INFO - ##### Finished install step (success) 21:44:20 INFO - ##### 21:44:20 INFO - ##### 21:44:20 INFO - ##### Running run-tests step. 21:44:20 INFO - ##### 21:44:20 INFO - Running pre-action listener: _resource_record_pre_action 21:44:20 INFO - Running main action method: run_tests 21:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:44:20 INFO - Python 2.7.3 21:44:20 INFO - Return code: 0 21:44:20 INFO - grabbing minidump binary from tooltool 21:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:20 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 0x1ab83b0>, '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 0x1ab92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:44:20 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 21:44:20 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 21:44:20 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 21:44:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:44:20 INFO - Return code: 0 21:44:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:44:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:44:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:44:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:44:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:44:20 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/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 21:44:20 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/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 21:44:20 INFO - Using env: {'DISPLAY': ':0', 21:44:20 INFO - 'HOME': '/home/cltbld', 21:44:20 INFO - 'LANG': 'en_US.UTF-8', 21:44:20 INFO - 'LANGUAGE': 'en_US:en', 21:44:20 INFO - 'LOGNAME': 'cltbld', 21:44:20 INFO - 'MAIL': '/var/mail/cltbld', 21:44:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:44:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:20 INFO - 'MOZ_NO_REMOTE': '1', 21:44:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:44:20 INFO - 'NO_EM_RESTART': '1', 21:44:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:20 INFO - 'PWD': '/builds/slave/test', 21:44:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:44:20 INFO - 'SHELL': '/bin/bash', 21:44:20 INFO - 'SHLVL': '1', 21:44:20 INFO - 'TERM': 'linux', 21:44:20 INFO - 'TMOUT': '86400', 21:44:20 INFO - 'USER': 'cltbld', 21:44:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610', 21:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:20 INFO - '_': '/tools/buildbot/bin/python'} 21:44:20 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/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 21:44:20 INFO - mozversion application_buildid: 20160704205822 21:44:20 INFO - mozversion application_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 21:44:20 INFO - mozversion application_display_name: Nightly 21:44:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:44:20 INFO - mozversion application_name: Firefox 21:44:20 INFO - mozversion application_remotingname: firefox 21:44:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:44:20 INFO - mozversion application_vendor: Mozilla 21:44:20 INFO - mozversion application_version: 50.0a1 21:44:20 INFO - mozversion platform_buildid: 20160704205822 21:44:20 INFO - mozversion platform_changeset: 652fa69526ff82afbe7b7e6a360709c457fddf19 21:44:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:44:20 INFO - mozversion platform_version: 50.0a1 21:44:20 INFO - using testdate: 1467693860 21:44:20 INFO - actual date: 1467693860 21:44:20 INFO - starting webserver on 'localhost:57875' 21:44:20 INFO - SUITE-START | Running 2 tests 21:44:20 INFO - TEST-START | dromaeo_css 21:44:20 INFO - operating with platform_type : linux_ 21:44:20 INFO - Initialising browser for dromaeo_css test... 21:44:20 INFO - TEST-INFO | started process 24809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2Yooa/profile http://localhost:57875/getInfo.html) 21:44:24 INFO - PROCESS | 24809 | __metrics Screen width/height:1600/1200 21:44:24 INFO - PROCESS | 24809 | colorDepth:24 21:44:24 INFO - PROCESS | 24809 | Browser inner width/height: 1024/697 21:44:24 INFO - PROCESS | 24809 | __metrics 21:44:26 INFO - PROCESS | 24809 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:44:27 INFO - TEST-INFO | 24809: exit 0 21:44:27 INFO - Browser initialized. 21:44:27 INFO - Running cycle 1/1 for dromaeo_css test... 21:44:27 INFO - TEST-INFO | started process 24890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2Yooa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:44:39 INFO - PROCESS | 24890 | RSS: Main: 159543296 21:44:39 INFO - PROCESS | 24890 | 21:45:30 INFO - PROCESS | 24890 | 1467693930067 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] 21:47:43 INFO - PROCESS | 24890 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57875/tests/dromaeo/cssquery-ext.html) 21:47:44 INFO - PROCESS | 24890 | RSS: Main: 271495168 21:47:44 INFO - PROCESS | 24890 | 21:50:47 INFO - PROCESS | 24890 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-ext.html (next: http://localhost:57875/tests/dromaeo/cssquery-jquery.html) 21:50:47 INFO - PROCESS | 24890 | RSS: Main: 239480832 21:50:47 INFO - PROCESS | 24890 | 21:53:49 INFO - PROCESS | 24890 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57875/tests/dromaeo/cssquery-mootools.html) 21:53:50 INFO - PROCESS | 24890 | RSS: Main: 237146112 21:53:50 INFO - PROCESS | 24890 | 21:56:52 INFO - PROCESS | 24890 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57875/tests/dromaeo/cssquery-prototype.html) 21:56:53 INFO - PROCESS | 24890 | RSS: Main: 239812608 21:56:53 INFO - PROCESS | 24890 | 21:59:56 INFO - PROCESS | 24890 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57875/tests/dromaeo/cssquery-yui.html) 21:59:57 INFO - PROCESS | 24890 | RSS: Main: 224149504 21:59:57 INFO - PROCESS | 24890 | 22:02:59 INFO - PROCESS | 24890 | Cycle 1(1): loaded http://localhost:57875/tests/dromaeo/cssquery-yui.html (next: http://localhost:57875/tests/dromaeo/cssquery-dojo.html) 22:03:00 INFO - PROCESS | 24890 | RSS: Main: 279089152 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | __start_tp_report 22:03:00 INFO - PROCESS | 24890 | _x_x_mozilla_page_load 22:03:00 INFO - PROCESS | 24890 | _x_x_mozilla_page_load_details 22:03:00 INFO - PROCESS | 24890 | |i|pagename|runs| 22:03:00 INFO - PROCESS | 24890 | |0;dojo.html;2600.0379859452;2622.5672763993944;2635.038211052966;2675.2241849863526;2676.5583678693015;4734.266188740742;4766.122611464967;4817.22924332107;4860.999999999995;4912.754362281885;4808.350872632193;4834.444038935523;4850.34520339754;4868.878278043051;4875.561199492045;4395.252807022814;4415.315626077963;4437.334399840018;4488.07994361156;4512.684112112153;4417.160739459492;4494.146112238681;4515.819367225307;4533.795979180928;4553.5901768840795;4456.108778244364;4504.211762941489;4507.504174540798;4509.346144808985;4548.954510454902;4375.868723938255;4380.583844534796;4384.671149663788;4420.535843736426;4432.401625780511;4392.407025051641;4417.580329868657;4463.129689710508;4471.351654010183;4512.751798651073;4889.535494128052;4901.754912254373;4909.116359055369;4915.778789954461;4923.90152196954;5041.369828771403;5154.304168937183;5157.432682404932;5170.689758614495;5276.023935571931;5215.452377500345;5266.315379000744;5278.656887302313;5289.603279754034;5292.894142117136;4743.83396581118;4865.683730557503;4866.6106711463;4873.707577545359;4904.754762261872;5216.869578260498;5275.973620131875;5281.366236051698;5286.841394758163;5374.973125134349;5088.796448142033;5129.512696293846;5138;5139.177731562932;5143.537081662668;5015.82444614444;5165.612579056586;5272.472752724773;5281.603879709037;5293.417724050351;5126.102931986962;5174.97412512935;5205.27126202332;5212.635115541876;5244.187150991603;5175.585953123741;5188.092083885305;5200.531952124327;5207.1668533034535;5255.08036093682;4349.608535231781;4388.670849686287;4436.911261774746;4500.4149460569915;4511.030128522383;3866.8839934802;3895.610438956082;3902.492675952108;3918.7060970427333;3988.521377434726;4514.074614703978;4528.049109687003;4530.79611417487;4531.071130418256;4578.130155270488;5010.223415370623;5063.670861393997;5127.9230811537855;5235.921461178085;5294.523492885659;4464.732116073046;4482.529334419904;4498.77506124699;4533.365328853963;4552.567506086916;4696.647751418657;4707.223308154184;4708.764561771898;4715.952840471551;4755.500672429414;4757.405324334458;4810.855674329776;4852.927206091982;4864.975675121602;4875.463698993037;5203.271541984201;5227.4249832517635;5233.450487698737;5233.476652334736;5259.474052594863;4846.17615005457;4868.294097355934;4874.610031197425;4875.829345972874;4917.508249175054;4981.153203955264;5008.524190201925;5045.016221836707;5072.923906141337;5138.049460849755;5141.434442211428;5152.613553983391;5156.7421628917655;5160.09698302803;5165.793368265227;5013.147764880052;5018.046571151615;5019.3976722793495;5021.121303771898;5052;4936.802527898843;4953.65324427301;4966.230234313687;5002.724850133278;5005.399352077774;4885.731284779371;4909.018196360671;4915.631327650369;4948.554630083309;4956;4895.779689913891;5022.422421421583;5030.547250747451;5033.5721463676;5033.899322013613;4903.681260718042;4948.15881300187;4956.058348913695;4972.154733695353;4982.7508624569355 22:03:00 INFO - PROCESS | 24890 | |1;ext.html;543.7249326133068;576.0897781505222;583.8015074874543;591.3879135095177;596.6449962272446;27417.72582274179;29662.40675186495;29760.107196784076;29790.10629681113;29859.850700746494;29509.557356639667;41077;41922.37116443256;41955.37066943991;46292.07415851681;7934.206579342077;8069.39479539034;8082.151374105722;8090.312323452514;8090.838183236332;7961.402894782886;8043.436959412844;8048.195180481935;8062.475939063942;8063.475874068196;8033.799155021113;8092.2312380324065;8097.676092956274;8098.392620553453;8099;8005.919940800576;8024.759257222293;8029.879551806727;8044.1955804419085;8053.234942680436;7886.447948643598;7959.562224077674;7978.082520510099;7983.361331093499;7983.441159118864;39067;39217.80391098055;39366.40950385747;39379.8031009846;39479.21041579181;3013.9397212055856;3180.2685382361956;3197.5043868200464;3210.2455922858107;3234.9353012939846;29402.558961615592;29838.254043648867;30069.548956765666;30773.615187316624;31333;3390.677885600864;3391.406503861814;3408.9829550852337;3422.469517224834;3461.7576769626135;182202;182392;182554;185098;185151.07424462927;31881.043568692978;32803.835980819946;52809.73595132;53316.33545806774;53422.46577534175;33764.831175844454;33826.32347353039;33888.830555847555;33914.152146196546;33950.151246219044;13024.54414095502;13089.869101308865;13090.869091309156;13191.208527488381;13192.538261161006;11083.833742493869;11279.774404511863;11280.943595282135;11283.830742538868;11290.943545282385;7845.725399610987;7872.370210383156;7883.842323153504;7929.088154862149;7933.960330198427;3117.267442151093;3122.7657925655667;3146.1033605422344;3147.6380216274965;3165.493521036623;910.2490445382585;925.8796356473615;946.6024269806697;986.7286496213599;991.0634450444261;28032.299192519942;28227.57658635122;28700.712992869805;29330.560041599394;29426.558601620993;771.1621233859452;971.6793458158791;1000.3447741729179;1007.8488226765897;1010.2170817616259;14877.107373557405;14958.551243462714;15055.397784088515;15330.693386132214;15485.845141548665;411892;457540;469662;471026;724510;51364;51537.7423112882;51819.740901295256;51882.22176667353;51987.22019169715;1092.186321190718;1183.7691650128315;1213.417559571393;1236.9938150309372;1255.7049093463029;27948.86025569859;29506.55740163942;29799.553006704482;29989.250268742584;30372;41450.170996580506;41987.7900610495;42359;42427.7878610605;42473.57526424696;258872;259598;260469;260579;260823;22535.323940281818;24846.130385436423;25275.747242528076;25630.871845640653;25639;41184.1763164741;41375;42533;42658.36012459754;42727.3590896143;36031.81984090063;36746.448803268504;37165.62834371622;37211.44182837205;37653.2469350606;36536.45195322126;36568.817155914054;36956.63043369532;37004.81497592495;37243;35296.82351588226;37339.62660373362;37929.241415172095;38062.61937380591;40508.1898362037;31712;34003.65996340104;34009.48985765166;34697.306053879285;34818.82590587031;25613.3596660085;25694.743052569982;25730.614040789027;25892.741072589033;25927.22218333453 22:03:00 INFO - PROCESS | 24890 | |2;jquery.html;369.14358687844214;372.77260870868776;374.82757931351574;380.42935596605093;392.63288824948677;16082.437114700988;17731.822681773177;18018.20686350842;18195.545111372223;18244.179011944478;15890.84109158908;16547.255373508222;16578.66842663149;16844;16978.915105424454;5117.769700363474;5318.707471089088;5360.517553420192;5364.249005139264;5366.329208848894;3729.7762134271893;3774.7860208583056;3850.6128677454244;5264.894702105956;5525.640833345839;6206.627602343851;6209.844753881144;6212.75148994042;6223.626582405048;6223.87552248957;6022.6687532185715;6204.193454850885;6282.937170628326;6291.905621415705;6305.716242769086;3424.5890493140982;3574.749767516275;3577.7853328800356;5481.588880833953;5485.4788795064405;17470.825291747045;20078.69488483244;20546;21475.892620536953;21932.232371867067;1901.895395753233;1979.0540977973449;2005.7994200579972;2040.2960978462406;2041.030510507512;13413;13516.864831351659;13585.932070339684;13667.70156835099;13899.305034748222;1745.7555942168106;1746.2316580704448;1765.4527096600095;1788;1799.703048996914;69163;70107.64946175237;70607.64696176487;73040;74231.25768742351;8526.957365213135;9086.77328560649;9249.306302027375;9256.16694497485;9500.382475139093;12160.635180944586;12161.391930403444;12165.513379464723;12234.81647775284;12260.32568208757;6852.828679282959;7012.158540975013;7079.39825114871;7126.964365178244;7145.642717864086;7029.945508173712;7091.290870912868;7190.209077001526;7209.675564599605;7223.169335526377;3570.410882204459;3853.4797802296894;3876.4379165020914;3949.881503554898;3998.2603218404106;1695.2286709547127;1697.9066151361794;1727.5076603168036;1735.3492440334874;1832.2854086906118;834.6786487202471;848.3467729847982;884.9823003539893;950.7955789505289;956.550421301987;17019.23413446398;17261;17842.643147136983;18215.180316885773;18346.63306733858;864.6454953469173;876.8071024374627;883.7834730491071;893.0712059458091;896.6771962093641;8172.6730930762105;9888;10320.43237621938;10354.482275886327;10434.791304173874;404147;414647;426293;426416;427305;86807.56596216979;87714.12285877187;88101;88718;88820.55589722139;911.9179273865384;918.3846822628855;939.7133874168444;940.5626383731598;940.6613619097119;15665.843341566895;16049.358025679308;16150.67698646044;16169.191540422697;16202.513924582281;39947.80026099851;40283.59716402798;40846.387304191056;42269.78865105655;42639;56229;56716;57278.42721572731;57461;57466;6719.428848547928;7252.419806415369;7257;7488.138864030706;7949.682012719658;10965.835512467478;12600.180988235736;12682.239065656091;12811.423485942969;12938.223706577259;10830.512626931964;10965.61620343284;11001.834972475579;11056.115510758958;11152.16358773079;10568.947155264483;10731.302465339728;10771.838422423512;10875.456227188768;10926.836097458385;10584.782749983851;10893.891061089287;10976.12191024732;11100.444977751242;11119.610813621484;7236.782896513113;7248.0939882514685;7260.528065675714;7415.555066696015;7426.888596671162;8430.325573954191;10448.164146868385;10603.681889543326;10656.200784941006;10898.400587967737 22:03:00 INFO - PROCESS | 24890 | |3;mootools.html;1268.5116230251351;1391.4225596377503;1440.6542429816843;1515.3181068519161;1725.3788636091006;6490.383413575714;7356.337929586336;7537.924620753798;7555.16893141754;7798.96100519498;7589.279018493248;7649.655765490553;7720.61396930154;7726.690932362712;7730.690772369113;2208.216083290433;2231.4309850987975;2236.2285011670947;2236.9776302236933;2237.6643503474447;2156.644153714635;2173.9565208695817;2201.416624594484;2204.834637402193;2206.216793038472;2172.543765809182;2190.4195388222133;2196.7803219677985;2199.0324257326806;2202.6695995600626;2122.416335507732;2123.447903545074;2123.6920646506246;2131.1688441507827;2137.2199147311276;1969.3993332033724;2005.5988802239465;2009.9196032158695;2015.647261729206;2019.8485113616537;7483.326500614917;7642.388608911274;7670.5397676139055;7728.613569321511;7779.9611001945195;4596.103759766846;4703.764811759433;4704.0356726870905;4717.056588682243;4722.716637001757;2829.264391258267;2901.10065879578;2909.5490199019187;2952.232419570927;2953.5422009588547;963.393062370702;968.331851022792;970.6554173268458;994.8806143262782;1013.4983183324301;10349.327293725884;10504.579816807318;10505.212109091772;10524.894751052545;10554.313969592029;3898.922021559553;3990.660793832557;4013.3578627419474;4111.6299533042165;4146.979265103715;8346.666133354598;8378.49729016261;8379.37154713399;8397.412181147261;8434.831303373898;4505.842295519707;4511.526289739596;4513.074819661962;4513.255312873339;4515.0518391137575;3640.9453858192146;3827.75119617224;4174.08170202555;4176.415301857743;4197.790110494524;3453.6546345365264;3525.753197276217;3532.152283452004;3561.0385195997455;3581.8746343877838;1063.9255252132432;1071.4482041748506;1074.940878251688;1077.36435503052;1100.1693721240413;773.9032620922385;803.4536515169741;810.3598157455662;843.5242563077387;856.2165618459164;4976.104301225741;4986.775595098229;5024.070546948826;5041.395032596112;5118.001989612065;416.6312813160375;419.0571214766775;421.6226477302797;425.0160877568419;428.8927768057986;3383.424817780983;3467.1158854492446;3496.737744669109;3535.045537704805;3568.6431356864623;8756;9155.725328240163;9186.173244407903;9383.953080234554;9420.858687119699;9189.172974432333;9199.908000920039;9249.398789078688;9255.398399104037;9259.398139120936;7173.139223293134;7350.7427240046345;7366.116066072105;7367;7369.594672292968;5071.1632580625255;5299.072662284162;5315.176147697113;5486.396496385315;5548;8315.750527484186;8565.314774818124;8568.057513673615;9008.099190080939;9013.233875120688;7822.843543129219;8801.735947921572;8808.383413161017;8822.07368226327;8901.51041692713;5757.65454072757;6698.799036028927;6706.66466676674;6879.793606191823;6881.483888708467;7369.742059027908;7394.852102958018;7404.407647388089;7417.8887316689215;7460.403167746459;6674.699638516181;6799.3200679931615;6871.244163141951;6886.793396198122;6904.896426553505;6542.44389226902;6623.105880706043;6665.133532640726;6690.996350547457;6728.293529179366;6045.637261764308;6049.51603871698;6112.480439162721;6125.754969801158;6137.1101190328045;4450.399196108613;4566.429196350457;4595.885102872455;4615.93076103852;4645.6283497319455;4539.931901021553;4612.308153776826;4614.538546145359;4706.411698537683;4720.551547602972 22:03:00 INFO - PROCESS | 24890 | |4;prototype.html;297.99851000744997;305.8700052477697;307.08947969271105;317.8013741411618;319.22746952375263;4660.650451216164;4793.281007848825;4900.387451568554;4919.11455937931;4950.381202349707;4726.7400292983875;4863.586595139417;4864.221724524077;4878.48775878533;4892.339534162887;3828.636279553445;3864.246471937959;3874.535055793309;3881.165549406877;3895.5325360956726;3686.64976827201;3728.086618778403;3860.2279544091152;3866.3620502617173;3870.4194370844316;3841.865534706286;3852.614738526153;3860.40163774614;3862.38201887698;3870.567889880748;3839.9040023999346;3852.248811481762;3859.517560304962;3880.72834901557;3897.2400381925536;3456.948145777815;3465.982670086659;3469.60099588548;3472.8958131256104;3473.6179020307745;4590.862274131781;4724;4734.692245004098;4739.4075740532435;4746.21687421575;4364.367166760802;4389.231884420214;4394.879305777038;4416.55834416559;4425.380446737459;5068.822591209327;5087.465816089294;5110.233464980245;5115.488451154892;5155.144148106679;3660.1764602964386;3695.7228207884245;3735.2902948439983;3737.2157742481754;3763.7929913854728;5336.226247194135;5341.278927344798;5357.383900851413;5357.892842143136;5372.7313634318125;3819.8854034379015;3835.616438356142;3839.3665045267217;3845.692344612424;3864.864729734446;3587;3786.7159963002887;3903.8243279052513;3908.785016824045;3910.5335499187804;4288.764117973541;4298.247806633826;4299.591538803808;4308.375285583636;4315.11540134278;5076.923846142311;5092.606474956764;5102.5662818660085;5126.487351264844;5149;1245.339969815999;1254.2565833491453;1275.2985857778185;1278.284160869916;1278.9808152877715;820.1798201798201;882.594006756899;884.0805562215224;885.3359980014989;890.8262888736764;4490.169318676056;4510.391097201901;4511.819527218874;4527.977360113178;4543.795529201194;5211.348581427322;5227.294315267391;5235.1623740201385;5295.179247216687;5296.364436267596;4432.852674601069;4464.687471877002;4509.864704058883;4549.6805926281;4555.908881822411;2749.1615057407284;2761.295869553251;2781.3741908070524;2790.4558611070647;2797.37059161687;4854.854354369375;4856.587190088882;4878.853634390903;4893.608511319086;4906.209233629699;5030.4215015272985;5338.279332290091;5342.759575819097;5376.166694162411;5407.270018547524;4966.478519755446;4968.478309777422;5002.52476014778;5013.924791128136;5019.472955339636;5323.866903327448;5323.920141197807;5344.461380844068;5354.598405119709;5366.758495867617;4966.404031516096;5181.171012637959;5213.921791173059;5223.242629818579;5238.580913526985;4952.944528020975;4958.752062396794;4964.553190212898;4993.400791904995;4993.775280112331;3727.105494681311;3734.981325093357;3766.4162054881535;3785.148341623223;3790.507234059555;4932.21084626458;5121.206213036985;5232.712200828991;5248.895022099613;5259.868503287295;5096.413912400121;5103.795848166032;5122.231665250242;5126.4617215191865;5126.923096153486;5088.829569199031;5113.64204505681;5116.565091967224;5136.666116702402;5164.173732202829;4907.38255033557;4933.358663373739;5029.371328583927;5034.130545588979;5039.395272567315;5134.306868572695;5134.768935397841;5134.76893539799;5141.820036298712;5201.843944681666;5030.974845125751;5044.495550444926;5062.75962389217;5105.795768169231;5131.307273518177 22:03:00 INFO - PROCESS | 24890 | |5;yui.html;651.0592194279266;655.8721049395367;659.1365311442011;718.138234119057;792.3740245206287;12330.32183229922;12459.314737689434;12508.874911250885;12590.055745819078;12604.621861344174;13049.67375815605;13173.60479185626;13290.867091329084;13291.268980206085;13344.799828002588;771.7993321736346;791.3352783661722;794.7655441644699;798.1260519730886;798.393221151923;797.11520212564;801.3989507869098;802.4783890471211;802.8153524689325;803.0443771911436;825.0594322472386;830.1822704635929;831.3100126894693;832.2301870769514;832.7918020494876;821.0229826506497;822.313368337439;822.3708862720024;823.1932705948144;823.5964377455064;609.0802887639696;609.2871340531589;609.2932198649545;609.679918043031;609.7012463892705;12198.39008049594;12271.447784849703;12300.261984280973;12321.260724356567;12325.137240393176;11416.372099534523;11467.713307167303;11481.311121332747;11680.649580512598;12038.81941770874;9378.765530861714;9730.805383892282;9816.116549510507;9882.258830587663;10022.3485473444;3282.261491164493;3323.1692076980753;3337.666233376667;3351.1287065362935;3448.5861696596317;43567;51513.22730159051;55071.449285507435;58275;58518.41481585172;10584.312019718695;11008.669739907815;11147.331160130418;11167.847471345964;11603.187776855708;15807.446739364297;20313.898430507754;20373.694394584094;20381.18475260973;20383.8980805095;6863.931360686329;7059.92940070603;7146.428285737128;7246.058012458452;7278.526895751759;3831.731778775459;3844.442555829389;3853.1715681128694;3875.205582855508;3928.7642741435607;3116.812991220534;3199.3601279744144;3205.583274174389;3207.9679203208134;3219.839008049635;543.6248988198131;545.2174943700355;546.8086169840524;559.4573263933978;566.0631654611624;511.75691546515105;580.7096451774113;601.5488383712216;631.6557476175495;634.8317695810614;8247.95876020616;8346.457480263885;8652.74041778735;8662.2637075848;8730.781730456789;599.487438240307;611.3275397063195;623.4980840423412;623.9594426362272;628.1614045249552;4007.1785284016705;4092.4066010428323;4222.092250166168;4300.634446072119;4390.143921935256;53115.46884531105;73380.63309683418;86212.56893715491;95242.52378738062;96372.51813740886;50200.748996254784;80716.19283807087;81216.18783812204;81647;83050.58474707587;72396.63801680958;73406.63296683482;74137.62931185309;74157.6292118536;74945;7922.366210703015;8062;8180.754577362689;8223.136570660234;8256.339492840438;33978.66021339755;44349.77825110854;44885.10229795451;45392;46085.53914460813;65422.672886635264;66327.66836165788;66454.33545664481;66664.66667666631;66680;10665.253432259979;10922.890771092187;11317.660470185578;11436.256643318158;11763;10946.781064378827;11087.72280692989;11322.902694114237;11779.234349767237;11821.468033938665;9972.081747821589;10077.143442807443;10377;10410.115140213167;10674.786504269716;10926.836097458703;10950.726231844268;11082.22424430282;11450.770984580427;11560.826587601025;10246.6413675521;10331.450823784096;10724.410157441416;10726.249162558546;10740.892591074302;8868.246199072893;9018.143276388733;9058.094190581152;9211.447313161232;9260;9095.454272743656;9119.361644684808;9337.953310233406;9404.811903762024;9437.858432123387 22:03:00 INFO - PROCESS | 24890 | __end_tp_report 22:03:00 INFO - PROCESS | 24890 | __start_cc_report 22:03:00 INFO - PROCESS | 24890 | _x_x_mozilla_cycle_collect,996 22:03:00 INFO - PROCESS | 24890 | __end_cc_report 22:03:00 INFO - PROCESS | 24890 | __startTimestamp1467694980182__endTimestamp 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | ------- Summary: start ------- 22:03:00 INFO - PROCESS | 24890 | Number of tests: 6 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | [#0] dojo.html Cycles:165 Average:4790.94 Median:4904.75 stddev:501.14 (10.2%) stddev-sans-first:472.28 22:03:00 INFO - PROCESS | 24890 | Values: 2600.0 2622.6 2635.0 2675.2 2676.6 4734.3 4766.1 4817.2 4861.0 4912.8 4808.4 4834.4 4850.3 4868.9 4875.6 4395.3 4415.3 4437.3 4488.1 4512.7 4417.2 4494.1 4515.8 4533.8 4553.6 4456.1 4504.2 4507.5 4509.3 4549.0 4375.9 4380.6 4384.7 4420.5 4432.4 4392.4 4417.6 4463.1 4471.4 4512.8 4889.5 4901.8 4909.1 4915.8 4923.9 5041.4 5154.3 5157.4 5170.7 5276.0 5215.5 5266.3 5278.7 5289.6 5292.9 4743.8 4865.7 4866.6 4873.7 4904.8 5216.9 5276.0 5281.4 5286.8 5375.0 5088.8 5129.5 5138.0 5139.2 5143.5 5015.8 5165.6 5272.5 5281.6 5293.4 5126.1 5175.0 5205.3 5212.6 5244.2 5175.6 5188.1 5200.5 5207.2 5255.1 4349.6 4388.7 4436.9 4500.4 4511.0 3866.9 3895.6 3902.5 3918.7 3988.5 4514.1 4528.0 4530.8 4531.1 4578.1 5010.2 5063.7 5127.9 5235.9 5294.5 4464.7 4482.5 4498.8 4533.4 4552.6 4696.6 4707.2 4708.8 4716.0 4755.5 4757.4 4810.9 4852.9 4865.0 4875.5 5203.3 5227.4 5233.5 5233.5 5259.5 4846.2 4868.3 4874.6 4875.8 4917.5 4981.2 5008.5 5045.0 5072.9 5138.0 5141.4 5152.6 5156.7 5160.1 5165.8 5013.1 5018.0 5019.4 5021.1 5052.0 4936.8 4953.7 4966.2 5002.7 5005.4 4885.7 4909.0 4915.6 4948.6 4956.0 4895.8 5022.4 5030.5 5033.6 5033.9 4903.7 4948.2 4956.1 4972.2 4982.8 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | [#1] ext.html Cycles:180 Average:46096.15 Median:35057.82 stddev:94212.94 (268.7%) stddev-sans-first:94415.15 22:03:00 INFO - PROCESS | 24890 | Values: 543.7 576.1 583.8 591.4 596.6 27417.7 29662.4 29760.1 29790.1 29859.9 29509.6 41077.0 41922.4 41955.4 46292.1 7934.2 8069.4 8082.2 8090.3 8090.8 7961.4 8043.4 8048.2 8062.5 8063.5 8033.8 8092.2 8097.7 8098.4 8099.0 8005.9 8024.8 8029.9 8044.2 8053.2 7886.4 7959.6 7978.1 7983.4 7983.4 39067.0 39217.8 39366.4 39379.8 39479.2 3013.9 3180.3 3197.5 3210.2 3234.9 29402.6 29838.3 30069.5 30773.6 31333.0 3390.7 3391.4 3409.0 3422.5 3461.8 182202.0 182392.0 182554.0 185098.0 185151.1 31881.0 32803.8 52809.7 53316.3 53422.5 33764.8 33826.3 33888.8 33914.2 33950.2 13024.5 13089.9 13090.9 13191.2 13192.5 11083.8 11279.8 11280.9 11283.8 11290.9 7845.7 7872.4 7883.8 7929.1 7934.0 3117.3 3122.8 3146.1 3147.6 3165.5 910.2 925.9 946.6 986.7 991.1 28032.3 28227.6 28700.7 29330.6 29426.6 771.2 971.7 1000.3 1007.8 1010.2 14877.1 14958.6 15055.4 15330.7 15485.8 411892.0 457540.0 469662.0 471026.0 724510.0 51364.0 51537.7 51819.7 51882.2 51987.2 1092.2 1183.8 1213.4 1237.0 1255.7 27948.9 29506.6 29799.6 29989.3 30372.0 41450.2 41987.8 42359.0 42427.8 42473.6 258872.0 259598.0 260469.0 260579.0 260823.0 22535.3 24846.1 25275.7 25630.9 25639.0 41184.2 41375.0 42533.0 42658.4 42727.4 36031.8 36746.4 37165.6 37211.4 37653.2 36536.5 36568.8 36956.6 37004.8 37243.0 35296.8 37339.6 37929.2 38062.6 40508.2 31712.0 34003.7 34009.5 34697.3 34818.8 25613.4 25694.7 25730.6 25892.7 25927.2 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | [#2] jquery.html Cycles:180 Average:25933.54 Median:2171.26 stddev:69508.23 (3201.3%) stddev-sans-first:69676.71 22:03:00 INFO - PROCESS | 24890 | Values: 369.1 372.8 374.8 380.4 392.6 16082.4 17731.8 18018.2 18195.5 18244.2 15890.8 16547.3 16578.7 16844.0 16978.9 5117.8 5318.7 5360.5 5364.2 5366.3 3729.8 3774.8 3850.6 5264.9 5525.6 6206.6 6209.8 6212.8 6223.6 6223.9 6022.7 6204.2 6282.9 6291.9 6305.7 3424.6 3574.7 3577.8 5481.6 5485.5 17470.8 20078.7 20546.0 21475.9 21932.2 1901.9 1979.1 2005.8 2040.3 2041.0 13413.0 13516.9 13585.9 13667.7 13899.3 1745.8 1746.2 1765.5 1788.0 1799.7 69163.0 70107.6 70607.6 73040.0 74231.3 8527.0 9086.8 9249.3 9256.2 9500.4 12160.6 12161.4 12165.5 12234.8 12260.3 6852.8 7012.2 7079.4 7127.0 7145.6 7029.9 7091.3 7190.2 7209.7 7223.2 3570.4 3853.5 3876.4 3949.9 3998.3 1695.2 1697.9 1727.5 1735.3 1832.3 834.7 848.3 885.0 950.8 956.6 17019.2 17261.0 17842.6 18215.2 18346.6 864.6 876.8 883.8 893.1 896.7 8172.7 9888.0 10320.4 10354.5 10434.8 404147.0 414647.0 426293.0 426416.0 427305.0 86807.6 87714.1 88101.0 88718.0 88820.6 911.9 918.4 939.7 940.6 940.7 15665.8 16049.4 16150.7 16169.2 16202.5 39947.8 40283.6 40846.4 42269.8 42639.0 56229.0 56716.0 57278.4 57461.0 57466.0 6719.4 7252.4 7257.0 7488.1 7949.7 10965.8 12600.2 12682.2 12811.4 12938.2 10830.5 10965.6 11001.8 11056.1 11152.2 10568.9 10731.3 10771.8 10875.5 10926.8 10584.8 10893.9 10976.1 11100.4 11119.6 7236.8 7248.1 7260.5 7415.6 7426.9 8430.3 10448.2 10603.7 10656.2 10898.4 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | [#3] mootools.html Cycles:180 Average:5012.74 Median:4849.41 stddev:2796.95 (57.7%) stddev-sans-first:2790.64 22:03:00 INFO - PROCESS | 24890 | Values: 1268.5 1391.4 1440.7 1515.3 1725.4 6490.4 7356.3 7537.9 7555.2 7799.0 7589.3 7649.7 7720.6 7726.7 7730.7 2208.2 2231.4 2236.2 2237.0 2237.7 2156.6 2174.0 2201.4 2204.8 2206.2 2172.5 2190.4 2196.8 2199.0 2202.7 2122.4 2123.4 2123.7 2131.2 2137.2 1969.4 2005.6 2009.9 2015.6 2019.8 7483.3 7642.4 7670.5 7728.6 7780.0 4596.1 4703.8 4704.0 4717.1 4722.7 2829.3 2901.1 2909.5 2952.2 2953.5 963.4 968.3 970.7 994.9 1013.5 10349.3 10504.6 10505.2 10524.9 10554.3 3898.9 3990.7 4013.4 4111.6 4147.0 8346.7 8378.5 8379.4 8397.4 8434.8 4505.8 4511.5 4513.1 4513.3 4515.1 3640.9 3827.8 4174.1 4176.4 4197.8 3453.7 3525.8 3532.2 3561.0 3581.9 1063.9 1071.4 1074.9 1077.4 1100.2 773.9 803.5 810.4 843.5 856.2 4976.1 4986.8 5024.1 5041.4 5118.0 416.6 419.1 421.6 425.0 428.9 3383.4 3467.1 3496.7 3535.0 3568.6 8756.0 9155.7 9186.2 9384.0 9420.9 9189.2 9199.9 9249.4 9255.4 9259.4 7173.1 7350.7 7366.1 7367.0 7369.6 5071.2 5299.1 5315.2 5486.4 5548.0 8315.8 8565.3 8568.1 9008.1 9013.2 7822.8 8801.7 8808.4 8822.1 8901.5 5757.7 6698.8 6706.7 6879.8 6881.5 7369.7 7394.9 7404.4 7417.9 7460.4 6674.7 6799.3 6871.2 6886.8 6904.9 6542.4 6623.1 6665.1 6691.0 6728.3 6045.6 6049.5 6112.5 6125.8 6137.1 4450.4 4566.4 4595.9 4615.9 4645.6 4539.9 4612.3 4614.5 4706.4 4720.6 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | [#4] prototype.html Cycles:180 Average:4261.92 Median:4863.90 stddev:1228.03 (25.2%) stddev-sans-first:1194.89 22:03:00 INFO - PROCESS | 24890 | Values: 298.0 305.9 307.1 317.8 319.2 4660.7 4793.3 4900.4 4919.1 4950.4 4726.7 4863.6 4864.2 4878.5 4892.3 3828.6 3864.2 3874.5 3881.2 3895.5 3686.6 3728.1 3860.2 3866.4 3870.4 3841.9 3852.6 3860.4 3862.4 3870.6 3839.9 3852.2 3859.5 3880.7 3897.2 3456.9 3466.0 3469.6 3472.9 3473.6 4590.9 4724.0 4734.7 4739.4 4746.2 4364.4 4389.2 4394.9 4416.6 4425.4 5068.8 5087.5 5110.2 5115.5 5155.1 3660.2 3695.7 3735.3 3737.2 3763.8 5336.2 5341.3 5357.4 5357.9 5372.7 3819.9 3835.6 3839.4 3845.7 3864.9 3587.0 3786.7 3903.8 3908.8 3910.5 4288.8 4298.2 4299.6 4308.4 4315.1 5076.9 5092.6 5102.6 5126.5 5149.0 1245.3 1254.3 1275.3 1278.3 1279.0 820.2 882.6 884.1 885.3 890.8 4490.2 4510.4 4511.8 4528.0 4543.8 5211.3 5227.3 5235.2 5295.2 5296.4 4432.9 4464.7 4509.9 4549.7 4555.9 2749.2 2761.3 2781.4 2790.5 2797.4 4854.9 4856.6 4878.9 4893.6 4906.2 5030.4 5338.3 5342.8 5376.2 5407.3 4966.5 4968.5 5002.5 5013.9 5019.5 5323.9 5323.9 5344.5 5354.6 5366.8 4966.4 5181.2 5213.9 5223.2 5238.6 4952.9 4958.8 4964.6 4993.4 4993.8 3727.1 3735.0 3766.4 3785.1 3790.5 4932.2 5121.2 5232.7 5248.9 5259.9 5096.4 5103.8 5122.2 5126.5 5126.9 5088.8 5113.6 5116.6 5136.7 5164.2 4907.4 4933.4 5029.4 5034.1 5039.4 5134.3 5134.8 5134.8 5141.8 5201.8 5031.0 5044.5 5062.8 5105.8 5131.3 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - PROCESS | 24890 | [#5] yui.html Cycles:180 Average:16676.29 Median:573.39 stddev:23309.34 (4065.2%) stddev-sans-first:23343.67 22:03:00 INFO - PROCESS | 24890 | Values: 651.1 655.9 659.1 718.1 792.4 12330.3 12459.3 12508.9 12590.1 12604.6 13049.7 13173.6 13290.9 13291.3 13344.8 771.8 791.3 794.8 798.1 798.4 797.1 801.4 802.5 802.8 803.0 825.1 830.2 831.3 832.2 832.8 821.0 822.3 822.4 823.2 823.6 609.1 609.3 609.3 609.7 609.7 12198.4 12271.4 12300.3 12321.3 12325.1 11416.4 11467.7 11481.3 11680.6 12038.8 9378.8 9730.8 9816.1 9882.3 10022.3 3282.3 3323.2 3337.7 3351.1 3448.6 43567.0 51513.2 55071.4 58275.0 58518.4 10584.3 11008.7 11147.3 11167.8 11603.2 15807.4 20313.9 20373.7 20381.2 20383.9 6863.9 7059.9 7146.4 7246.1 7278.5 3831.7 3844.4 3853.2 3875.2 3928.8 3116.8 3199.4 3205.6 3208.0 3219.8 543.6 545.2 546.8 559.5 566.1 511.8 580.7 601.5 631.7 634.8 8248.0 8346.5 8652.7 8662.3 8730.8 599.5 611.3 623.5 624.0 628.2 4007.2 4092.4 4222.1 4300.6 4390.1 53115.5 73380.6 86212.6 95242.5 96372.5 50200.7 80716.2 81216.2 81647.0 83050.6 72396.6 73406.6 74137.6 74157.6 74945.0 7922.4 8062.0 8180.8 8223.1 8256.3 33978.7 44349.8 44885.1 45392.0 46085.5 65422.7 66327.7 66454.3 66664.7 66680.0 10665.3 10922.9 11317.7 11436.3 11763.0 10946.8 11087.7 11322.9 11779.2 11821.5 9972.1 10077.1 10377.0 10410.1 10674.8 10926.8 10950.7 11082.2 11450.8 11560.8 10246.6 10331.5 10724.4 10726.2 10740.9 8868.2 9018.1 9058.1 9211.4 9260.0 9095.5 9119.4 9338.0 9404.8 9437.9 22:03:00 INFO - PROCESS | 24890 | -------- Summary: end -------- 22:03:00 INFO - PROCESS | 24890 | 22:03:00 INFO - TEST-INFO | 24890: exit 0 22:03:01 INFO - TEST-OK | dromaeo_css | took 1120707ms 22:03:01 INFO - TEST-START | kraken 22:03:01 INFO - operating with platform_type : linux_ 22:03:01 INFO - Initialising browser for kraken test... 22:03:01 INFO - TEST-INFO | started process 25076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenjBae/profile http://localhost:57875/getInfo.html) 22:03:05 INFO - PROCESS | 25076 | __metrics Screen width/height:1600/1200 22:03:05 INFO - PROCESS | 25076 | colorDepth:24 22:03:05 INFO - PROCESS | 25076 | Browser inner width/height: 1024/697 22:03:05 INFO - PROCESS | 25076 | __metrics 22:03:06 INFO - PROCESS | 25076 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:03:08 INFO - TEST-INFO | 25076: exit 0 22:03:08 INFO - Browser initialized. 22:03:08 INFO - Running cycle 1/1 for kraken test... 22:03:08 INFO - TEST-INFO | started process 25158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenjBae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:03:19 INFO - PROCESS | 25158 | RSS: Main: 159031296 22:03:19 INFO - PROCESS | 25158 | 22:03:22 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-beat-detection) 22:03:23 INFO - PROCESS | 25158 | RSS: Main: 217235456 22:03:23 INFO - PROCESS | 25158 | 22:03:26 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-dft) 22:03:26 INFO - PROCESS | 25158 | RSS: Main: 203702272 22:03:26 INFO - PROCESS | 25158 | 22:03:30 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-fft) 22:03:30 INFO - PROCESS | 25158 | RSS: Main: 271351808 22:03:30 INFO - PROCESS | 25158 | 22:03:32 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57875/tests/kraken/driver.html?testName=audio-oscillator) 22:03:33 INFO - PROCESS | 25158 | RSS: Main: 182558720 22:03:33 INFO - PROCESS | 25158 | 22:03:35 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57875/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:03:36 INFO - PROCESS | 25158 | RSS: Main: 185786368 22:03:36 INFO - PROCESS | 25158 | 22:03:39 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57875/tests/kraken/driver.html?testName=imaging-darkroom) 22:03:40 INFO - PROCESS | 25158 | RSS: Main: 222289920 22:03:40 INFO - PROCESS | 25158 | 22:03:43 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57875/tests/kraken/driver.html?testName=imaging-desaturate) 22:03:44 INFO - PROCESS | 25158 | RSS: Main: 217575424 22:03:44 INFO - PROCESS | 25158 | 22:03:47 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57875/tests/kraken/driver.html?testName=json-parse-financial) 22:03:47 INFO - PROCESS | 25158 | RSS: Main: 220966912 22:03:47 INFO - PROCESS | 25158 | 22:03:49 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57875/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:03:50 INFO - PROCESS | 25158 | RSS: Main: 206692352 22:03:50 INFO - PROCESS | 25158 | 22:03:51 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:03:52 INFO - PROCESS | 25158 | RSS: Main: 211382272 22:03:52 INFO - PROCESS | 25158 | 22:03:54 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:03:55 INFO - PROCESS | 25158 | RSS: Main: 212791296 22:03:55 INFO - PROCESS | 25158 | 22:03:58 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:03:58 INFO - PROCESS | 25158 | RSS: Main: 226918400 22:03:58 INFO - PROCESS | 25158 | 22:04:01 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:04:02 INFO - PROCESS | 25158 | RSS: Main: 226299904 22:04:02 INFO - PROCESS | 25158 | 22:04:03 INFO - PROCESS | 25158 | Cycle 1(1): loaded http://localhost:57875/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57875/tests/kraken/driver.html?testName=ai-astar) 22:04:04 INFO - PROCESS | 25158 | RSS: Main: 268754944 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | __start_tp_report 22:04:04 INFO - PROCESS | 25158 | _x_x_mozilla_page_load 22:04:04 INFO - PROCESS | 25158 | _x_x_mozilla_page_load_details 22:04:04 INFO - PROCESS | 25158 | |i|pagename|runs| 22:04:04 INFO - PROCESS | 25158 | |0;ai-astar;104;115;112;113;114;113;113;114;113;116 22:04:04 INFO - PROCESS | 25158 | |1;audio-beat-detection;149;128;122;179;129;129;146;126;171;123 22:04:04 INFO - PROCESS | 25158 | |2;audio-dft;162;161;161;161;162;163;163;161;162;162 22:04:04 INFO - PROCESS | 25158 | |3;audio-fft;76;76;77;122;77;77;86;75;103;76 22:04:04 INFO - PROCESS | 25158 | |4;audio-oscillator;86;86;120;85;85;85;112;85;85;132 22:04:04 INFO - PROCESS | 25158 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 22:04:04 INFO - PROCESS | 25158 | |6;imaging-darkroom;146;146;145;146;146;146;147;146;146;145 22:04:04 INFO - PROCESS | 25158 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;95 22:04:04 INFO - PROCESS | 25158 | |8;json-parse-financial;65;64;66;65;64;64;65;64;64;64 22:04:04 INFO - PROCESS | 25158 | |9;json-stringify-tinderbox;64;63;64;64;64;64;64;64;64;65 22:04:04 INFO - PROCESS | 25158 | |10;stanford-crypto-aes;78;80;93;78;78;78;81;79;82;79 22:04:04 INFO - PROCESS | 25158 | |11;stanford-crypto-ccm;130;126;130;133;140;129;137;145;167;139 22:04:04 INFO - PROCESS | 25158 | |12;stanford-crypto-pbkdf2;167;172;167;169;171;168;168;168;171;170 22:04:04 INFO - PROCESS | 25158 | |13;stanford-crypto-sha256-iterative;71;67;67;66;67;67;68;67;65;66 22:04:04 INFO - PROCESS | 25158 | __end_tp_report 22:04:04 INFO - PROCESS | 25158 | __start_cc_report 22:04:04 INFO - PROCESS | 25158 | _x_x_mozilla_cycle_collect,1909 22:04:04 INFO - PROCESS | 25158 | __end_cc_report 22:04:04 INFO - PROCESS | 25158 | __startTimestamp1467695044153__endTimestamp 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | ------- Summary: start ------- 22:04:04 INFO - PROCESS | 25158 | Number of tests: 14 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:3.27 (2.9%) stddev-sans-first:1.22 22:04:04 INFO - PROCESS | 25158 | Values: 104.0 115.0 112.0 113.0 114.0 113.0 113.0 114.0 113.0 116.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:137.50 stddev:20.53 (14.9%) stddev-sans-first:21.53 22:04:04 INFO - PROCESS | 25158 | Values: 149.0 128.0 122.0 179.0 129.0 129.0 146.0 126.0 171.0 123.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 22:04:04 INFO - PROCESS | 25158 | Values: 162.0 161.0 161.0 161.0 162.0 163.0 163.0 161.0 162.0 162.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.50 stddev:15.73 (20.6%) stddev-sans-first:16.38 22:04:04 INFO - PROCESS | 25158 | Values: 76.0 76.0 77.0 122.0 77.0 77.0 86.0 75.0 103.0 76.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:18.05 (21.2%) stddev-sans-first:18.77 22:04:04 INFO - PROCESS | 25158 | Values: 86.0 86.0 120.0 85.0 85.0 85.0 112.0 85.0 85.0 132.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:04:04 INFO - PROCESS | 25158 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:04:04 INFO - PROCESS | 25158 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:04:04 INFO - PROCESS | 25158 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 22:04:04 INFO - PROCESS | 25158 | Values: 65.0 64.0 66.0 65.0 64.0 64.0 65.0 64.0 64.0 64.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 22:04:04 INFO - PROCESS | 25158 | Values: 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:4.58 (5.8%) stddev-sans-first:4.76 22:04:04 INFO - PROCESS | 25158 | Values: 78.0 80.0 93.0 78.0 78.0 78.0 81.0 79.0 82.0 79.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:138.00 stddev:11.89 (8.6%) stddev-sans-first:12.29 22:04:04 INFO - PROCESS | 25158 | Values: 130.0 126.0 130.0 133.0 140.0 129.0 137.0 145.0 167.0 139.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.50 stddev:1.79 (1.1%) stddev-sans-first:1.73 22:04:04 INFO - PROCESS | 25158 | Values: 167.0 172.0 167.0 169.0 171.0 168.0 168.0 168.0 171.0 170.0 22:04:04 INFO - PROCESS | 25158 | 22:04:04 INFO - PROCESS | 25158 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.60 (2.4%) stddev-sans-first:0.87 22:04:04 INFO - PROCESS | 25158 | Values: 71.0 67.0 67.0 66.0 67.0 67.0 68.0 67.0 65.0 66.0 22:04:04 INFO - PROCESS | 25158 | -------- Summary: end -------- 22:04:04 INFO - PROCESS | 25158 | 22:04:05 INFO - TEST-INFO | 25158: exit 0 22:04:05 INFO - TEST-OK | kraken | took 64212ms 22:04:05 INFO - SUITE-END | took 1184s 22:04:05 INFO - Completed test suite (00:19:45) 22:04:05 INFO - javascript benchmark 22:04:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.0379859452, 2622.5672763993944, 2635.038211052966, 2675.2241849863526, 2676.5583678693015, 4734.266188740742, 4766.122611464967, 4817.22924332107, 4860.999999999995, 4912.754362281885, 4808.350872632193, 4834.444038935523, 4850.34520339754, 4868.878278043051, 4875.561199492045, 4395.252807022814, 4415.315626077963, 4437.334399840018, 4488.07994361156, 4512.684112112153, 4417.160739459492, 4494.146112238681, 4515.819367225307, 4533.795979180928, 4553.5901768840795, 4456.108778244364, 4504.211762941489, 4507.504174540798, 4509.346144808985, 4548.954510454902, 4375.868723938255, 4380.583844534796, 4384.671149663788, 4420.535843736426, 4432.401625780511, 4392.407025051641, 4417.580329868657, 4463.129689710508, 4471.351654010183, 4512.751798651073, 4889.535494128052, 4901.754912254373, 4909.116359055369, 4915.778789954461, 4923.90152196954, 5041.369828771403, 5154.304168937183, 5157.432682404932, 5170.689758614495, 5276.023935571931, 5215.452377500345, 5266.315379000744, 5278.656887302313, 5289.603279754034, 5292.894142117136, 4743.83396581118, 4865.683730557503, 4866.6106711463, 4873.707577545359, 4904.754762261872, 5216.869578260498, 5275.973620131875, 5281.366236051698, 5286.841394758163, 5374.973125134349, 5088.796448142033, 5129.512696293846, 5138.0, 5139.177731562932, 5143.537081662668, 5015.82444614444, 5165.612579056586, 5272.472752724773, 5281.603879709037, 5293.417724050351, 5126.102931986962, 5174.97412512935, 5205.27126202332, 5212.635115541876, 5244.187150991603, 5175.585953123741, 5188.092083885305, 5200.531952124327, 5207.1668533034535, 5255.08036093682, 4349.608535231781, 4388.670849686287, 4436.911261774746, 4500.4149460569915, 4511.030128522383, 3866.8839934802, 3895.610438956082, 3902.492675952108, 3918.7060970427333, 3988.521377434726, 4514.074614703978, 4528.049109687003, 4530.79611417487, 4531.071130418256, 4578.130155270488, 5010.223415370623, 5063.670861393997, 5127.9230811537855, 5235.921461178085, 5294.523492885659, 4464.732116073046, 4482.529334419904, 4498.77506124699, 4533.365328853963, 4552.567506086916, 4696.647751418657, 4707.223308154184, 4708.764561771898, 4715.952840471551, 4755.500672429414, 4757.405324334458, 4810.855674329776, 4852.927206091982, 4864.975675121602, 4875.463698993037, 5203.271541984201, 5227.4249832517635, 5233.450487698737, 5233.476652334736, 5259.474052594863, 4846.17615005457, 4868.294097355934, 4874.610031197425, 4875.829345972874, 4917.508249175054, 4981.153203955264, 5008.524190201925, 5045.016221836707, 5072.923906141337, 5138.049460849755, 5141.434442211428, 5152.613553983391, 5156.7421628917655, 5160.09698302803, 5165.793368265227, 5013.147764880052, 5018.046571151615, 5019.3976722793495, 5021.121303771898, 5052.0, 4936.802527898843, 4953.65324427301, 4966.230234313687, 5002.724850133278, 5005.399352077774, 4885.731284779371, 4909.018196360671, 4915.631327650369, 4948.554630083309, 4956.0, 4895.779689913891, 5022.422421421583, 5030.547250747451, 5033.5721463676, 5033.899322013613, 4903.681260718042, 4948.15881300187, 4956.058348913695, 4972.154733695353, 4982.7508624569355], "value": 4758.384723808458, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.7249326133068, 576.0897781505222, 583.8015074874543, 591.3879135095177, 596.6449962272446, 27417.72582274179, 29662.40675186495, 29760.107196784076, 29790.10629681113, 29859.850700746494, 29509.557356639667, 41077.0, 41922.37116443256, 41955.37066943991, 46292.07415851681, 7934.206579342077, 8069.39479539034, 8082.151374105722, 8090.312323452514, 8090.838183236332, 7961.402894782886, 8043.436959412844, 8048.195180481935, 8062.475939063942, 8063.475874068196, 8033.799155021113, 8092.2312380324065, 8097.676092956274, 8098.392620553453, 8099.0, 8005.919940800576, 8024.759257222293, 8029.879551806727, 8044.1955804419085, 8053.234942680436, 7886.447948643598, 7959.562224077674, 7978.082520510099, 7983.361331093499, 7983.441159118864, 39067.0, 39217.80391098055, 39366.40950385747, 39379.8031009846, 39479.21041579181, 3013.9397212055856, 3180.2685382361956, 3197.5043868200464, 3210.2455922858107, 3234.9353012939846, 29402.558961615592, 29838.254043648867, 30069.548956765666, 30773.615187316624, 31333.0, 3390.677885600864, 3391.406503861814, 3408.9829550852337, 3422.469517224834, 3461.7576769626135, 182202.0, 182392.0, 182554.0, 185098.0, 185151.07424462927, 31881.043568692978, 32803.835980819946, 52809.73595132, 53316.33545806774, 53422.46577534175, 33764.831175844454, 33826.32347353039, 33888.830555847555, 33914.152146196546, 33950.151246219044, 13024.54414095502, 13089.869101308865, 13090.869091309156, 13191.208527488381, 13192.538261161006, 11083.833742493869, 11279.774404511863, 11280.943595282135, 11283.830742538868, 11290.943545282385, 7845.725399610987, 7872.370210383156, 7883.842323153504, 7929.088154862149, 7933.960330198427, 3117.267442151093, 3122.7657925655667, 3146.1033605422344, 3147.6380216274965, 3165.493521036623, 910.2490445382585, 925.8796356473615, 946.6024269806697, 986.7286496213599, 991.0634450444261, 28032.299192519942, 28227.57658635122, 28700.712992869805, 29330.560041599394, 29426.558601620993, 771.1621233859452, 971.6793458158791, 1000.3447741729179, 1007.8488226765897, 1010.2170817616259, 14877.107373557405, 14958.551243462714, 15055.397784088515, 15330.693386132214, 15485.845141548665, 411892.0, 457540.0, 469662.0, 471026.0, 724510.0, 51364.0, 51537.7423112882, 51819.740901295256, 51882.22176667353, 51987.22019169715, 1092.186321190718, 1183.7691650128315, 1213.417559571393, 1236.9938150309372, 1255.7049093463029, 27948.86025569859, 29506.55740163942, 29799.553006704482, 29989.250268742584, 30372.0, 41450.170996580506, 41987.7900610495, 42359.0, 42427.7878610605, 42473.57526424696, 258872.0, 259598.0, 260469.0, 260579.0, 260823.0, 22535.323940281818, 24846.130385436423, 25275.747242528076, 25630.871845640653, 25639.0, 41184.1763164741, 41375.0, 42533.0, 42658.36012459754, 42727.3590896143, 36031.81984090063, 36746.448803268504, 37165.62834371622, 37211.44182837205, 37653.2469350606, 36536.45195322126, 36568.817155914054, 36956.63043369532, 37004.81497592495, 37243.0, 35296.82351588226, 37339.62660373362, 37929.241415172095, 38062.61937380591, 40508.1898362037, 31712.0, 34003.65996340104, 34009.48985765166, 34697.306053879285, 34818.82590587031, 25613.3596660085, 25694.743052569982, 25730.614040789027, 25892.741072589033, 25927.22218333453], "value": 16417.092618335384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.14358687844214, 372.77260870868776, 374.82757931351574, 380.42935596605093, 392.63288824948677, 16082.437114700988, 17731.822681773177, 18018.20686350842, 18195.545111372223, 18244.179011944478, 15890.84109158908, 16547.255373508222, 16578.66842663149, 16844.0, 16978.915105424454, 5117.769700363474, 5318.707471089088, 5360.517553420192, 5364.249005139264, 5366.329208848894, 3729.7762134271893, 3774.7860208583056, 3850.6128677454244, 5264.894702105956, 5525.640833345839, 6206.627602343851, 6209.844753881144, 6212.75148994042, 6223.626582405048, 6223.87552248957, 6022.6687532185715, 6204.193454850885, 6282.937170628326, 6291.905621415705, 6305.716242769086, 3424.5890493140982, 3574.749767516275, 3577.7853328800356, 5481.588880833953, 5485.4788795064405, 17470.825291747045, 20078.69488483244, 20546.0, 21475.892620536953, 21932.232371867067, 1901.895395753233, 1979.0540977973449, 2005.7994200579972, 2040.2960978462406, 2041.030510507512, 13413.0, 13516.864831351659, 13585.932070339684, 13667.70156835099, 13899.305034748222, 1745.7555942168106, 1746.2316580704448, 1765.4527096600095, 1788.0, 1799.703048996914, 69163.0, 70107.64946175237, 70607.64696176487, 73040.0, 74231.25768742351, 8526.957365213135, 9086.77328560649, 9249.306302027375, 9256.16694497485, 9500.382475139093, 12160.635180944586, 12161.391930403444, 12165.513379464723, 12234.81647775284, 12260.32568208757, 6852.828679282959, 7012.158540975013, 7079.39825114871, 7126.964365178244, 7145.642717864086, 7029.945508173712, 7091.290870912868, 7190.209077001526, 7209.675564599605, 7223.169335526377, 3570.410882204459, 3853.4797802296894, 3876.4379165020914, 3949.881503554898, 3998.2603218404106, 1695.2286709547127, 1697.9066151361794, 1727.5076603168036, 1735.3492440334874, 1832.2854086906118, 834.6786487202471, 848.3467729847982, 884.9823003539893, 950.7955789505289, 956.550421301987, 17019.23413446398, 17261.0, 17842.643147136983, 18215.180316885773, 18346.63306733858, 864.6454953469173, 876.8071024374627, 883.7834730491071, 893.0712059458091, 896.6771962093641, 8172.6730930762105, 9888.0, 10320.43237621938, 10354.482275886327, 10434.791304173874, 404147.0, 414647.0, 426293.0, 426416.0, 427305.0, 86807.56596216979, 87714.12285877187, 88101.0, 88718.0, 88820.55589722139, 911.9179273865384, 918.3846822628855, 939.7133874168444, 940.5626383731598, 940.6613619097119, 15665.843341566895, 16049.358025679308, 16150.67698646044, 16169.191540422697, 16202.513924582281, 39947.80026099851, 40283.59716402798, 40846.387304191056, 42269.78865105655, 42639.0, 56229.0, 56716.0, 57278.42721572731, 57461.0, 57466.0, 6719.428848547928, 7252.419806415369, 7257.0, 7488.138864030706, 7949.682012719658, 10965.835512467478, 12600.180988235736, 12682.239065656091, 12811.423485942969, 12938.223706577259, 10830.512626931964, 10965.61620343284, 11001.834972475579, 11056.115510758958, 11152.16358773079, 10568.947155264483, 10731.302465339728, 10771.838422423512, 10875.456227188768, 10926.836097458385, 10584.782749983851, 10893.891061089287, 10976.12191024732, 11100.444977751242, 11119.610813621484, 7236.782896513113, 7248.0939882514685, 7260.528065675714, 7415.555066696015, 7426.888596671162, 8430.325573954191, 10448.164146868385, 10603.681889543326, 10656.200784941006, 10898.400587967737], "value": 8388.392996450546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.5116230251351, 1391.4225596377503, 1440.6542429816843, 1515.3181068519161, 1725.3788636091006, 6490.383413575714, 7356.337929586336, 7537.924620753798, 7555.16893141754, 7798.96100519498, 7589.279018493248, 7649.655765490553, 7720.61396930154, 7726.690932362712, 7730.690772369113, 2208.216083290433, 2231.4309850987975, 2236.2285011670947, 2236.9776302236933, 2237.6643503474447, 2156.644153714635, 2173.9565208695817, 2201.416624594484, 2204.834637402193, 2206.216793038472, 2172.543765809182, 2190.4195388222133, 2196.7803219677985, 2199.0324257326806, 2202.6695995600626, 2122.416335507732, 2123.447903545074, 2123.6920646506246, 2131.1688441507827, 2137.2199147311276, 1969.3993332033724, 2005.5988802239465, 2009.9196032158695, 2015.647261729206, 2019.8485113616537, 7483.326500614917, 7642.388608911274, 7670.5397676139055, 7728.613569321511, 7779.9611001945195, 4596.103759766846, 4703.764811759433, 4704.0356726870905, 4717.056588682243, 4722.716637001757, 2829.264391258267, 2901.10065879578, 2909.5490199019187, 2952.232419570927, 2953.5422009588547, 963.393062370702, 968.331851022792, 970.6554173268458, 994.8806143262782, 1013.4983183324301, 10349.327293725884, 10504.579816807318, 10505.212109091772, 10524.894751052545, 10554.313969592029, 3898.922021559553, 3990.660793832557, 4013.3578627419474, 4111.6299533042165, 4146.979265103715, 8346.666133354598, 8378.49729016261, 8379.37154713399, 8397.412181147261, 8434.831303373898, 4505.842295519707, 4511.526289739596, 4513.074819661962, 4513.255312873339, 4515.0518391137575, 3640.9453858192146, 3827.75119617224, 4174.08170202555, 4176.415301857743, 4197.790110494524, 3453.6546345365264, 3525.753197276217, 3532.152283452004, 3561.0385195997455, 3581.8746343877838, 1063.9255252132432, 1071.4482041748506, 1074.940878251688, 1077.36435503052, 1100.1693721240413, 773.9032620922385, 803.4536515169741, 810.3598157455662, 843.5242563077387, 856.2165618459164, 4976.104301225741, 4986.775595098229, 5024.070546948826, 5041.395032596112, 5118.001989612065, 416.6312813160375, 419.0571214766775, 421.6226477302797, 425.0160877568419, 428.8927768057986, 3383.424817780983, 3467.1158854492446, 3496.737744669109, 3535.045537704805, 3568.6431356864623, 8756.0, 9155.725328240163, 9186.173244407903, 9383.953080234554, 9420.858687119699, 9189.172974432333, 9199.908000920039, 9249.398789078688, 9255.398399104037, 9259.398139120936, 7173.139223293134, 7350.7427240046345, 7366.116066072105, 7367.0, 7369.594672292968, 5071.1632580625255, 5299.072662284162, 5315.176147697113, 5486.396496385315, 5548.0, 8315.750527484186, 8565.314774818124, 8568.057513673615, 9008.099190080939, 9013.233875120688, 7822.843543129219, 8801.735947921572, 8808.383413161017, 8822.07368226327, 8901.51041692713, 5757.65454072757, 6698.799036028927, 6706.66466676674, 6879.793606191823, 6881.483888708467, 7369.742059027908, 7394.852102958018, 7404.407647388089, 7417.8887316689215, 7460.403167746459, 6674.699638516181, 6799.3200679931615, 6871.244163141951, 6886.793396198122, 6904.896426553505, 6542.44389226902, 6623.105880706043, 6665.133532640726, 6690.996350547457, 6728.293529179366, 6045.637261764308, 6049.51603871698, 6112.480439162721, 6125.754969801158, 6137.1101190328045, 4450.399196108613, 4566.429196350457, 4595.885102872455, 4615.93076103852, 4645.6283497319455, 4539.931901021553, 4612.308153776826, 4614.538546145359, 4706.411698537683, 4720.551547602972], "value": 3984.467001479658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.99851000744997, 305.8700052477697, 307.08947969271105, 317.8013741411618, 319.22746952375263, 4660.650451216164, 4793.281007848825, 4900.387451568554, 4919.11455937931, 4950.381202349707, 4726.7400292983875, 4863.586595139417, 4864.221724524077, 4878.48775878533, 4892.339534162887, 3828.636279553445, 3864.246471937959, 3874.535055793309, 3881.165549406877, 3895.5325360956726, 3686.64976827201, 3728.086618778403, 3860.2279544091152, 3866.3620502617173, 3870.4194370844316, 3841.865534706286, 3852.614738526153, 3860.40163774614, 3862.38201887698, 3870.567889880748, 3839.9040023999346, 3852.248811481762, 3859.517560304962, 3880.72834901557, 3897.2400381925536, 3456.948145777815, 3465.982670086659, 3469.60099588548, 3472.8958131256104, 3473.6179020307745, 4590.862274131781, 4724.0, 4734.692245004098, 4739.4075740532435, 4746.21687421575, 4364.367166760802, 4389.231884420214, 4394.879305777038, 4416.55834416559, 4425.380446737459, 5068.822591209327, 5087.465816089294, 5110.233464980245, 5115.488451154892, 5155.144148106679, 3660.1764602964386, 3695.7228207884245, 3735.2902948439983, 3737.2157742481754, 3763.7929913854728, 5336.226247194135, 5341.278927344798, 5357.383900851413, 5357.892842143136, 5372.7313634318125, 3819.8854034379015, 3835.616438356142, 3839.3665045267217, 3845.692344612424, 3864.864729734446, 3587.0, 3786.7159963002887, 3903.8243279052513, 3908.785016824045, 3910.5335499187804, 4288.764117973541, 4298.247806633826, 4299.591538803808, 4308.375285583636, 4315.11540134278, 5076.923846142311, 5092.606474956764, 5102.5662818660085, 5126.487351264844, 5149.0, 1245.339969815999, 1254.2565833491453, 1275.2985857778185, 1278.284160869916, 1278.9808152877715, 820.1798201798201, 882.594006756899, 884.0805562215224, 885.3359980014989, 890.8262888736764, 4490.169318676056, 4510.391097201901, 4511.819527218874, 4527.977360113178, 4543.795529201194, 5211.348581427322, 5227.294315267391, 5235.1623740201385, 5295.179247216687, 5296.364436267596, 4432.852674601069, 4464.687471877002, 4509.864704058883, 4549.6805926281, 4555.908881822411, 2749.1615057407284, 2761.295869553251, 2781.3741908070524, 2790.4558611070647, 2797.37059161687, 4854.854354369375, 4856.587190088882, 4878.853634390903, 4893.608511319086, 4906.209233629699, 5030.4215015272985, 5338.279332290091, 5342.759575819097, 5376.166694162411, 5407.270018547524, 4966.478519755446, 4968.478309777422, 5002.52476014778, 5013.924791128136, 5019.472955339636, 5323.866903327448, 5323.920141197807, 5344.461380844068, 5354.598405119709, 5366.758495867617, 4966.404031516096, 5181.171012637959, 5213.921791173059, 5223.242629818579, 5238.580913526985, 4952.944528020975, 4958.752062396794, 4964.553190212898, 4993.400791904995, 4993.775280112331, 3727.105494681311, 3734.981325093357, 3766.4162054881535, 3785.148341623223, 3790.507234059555, 4932.21084626458, 5121.206213036985, 5232.712200828991, 5248.895022099613, 5259.868503287295, 5096.413912400121, 5103.795848166032, 5122.231665250242, 5126.4617215191865, 5126.923096153486, 5088.829569199031, 5113.64204505681, 5116.565091967224, 5136.666116702402, 5164.173732202829, 4907.38255033557, 4933.358663373739, 5029.371328583927, 5034.130545588979, 5039.395272567315, 5134.306868572695, 5134.768935397841, 5134.76893539799, 5141.820036298712, 5201.843944681666, 5030.974845125751, 5044.495550444926, 5062.75962389217, 5105.795768169231, 5131.307273518177], "value": 3870.852544560712, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.0592194279266, 655.8721049395367, 659.1365311442011, 718.138234119057, 792.3740245206287, 12330.32183229922, 12459.314737689434, 12508.874911250885, 12590.055745819078, 12604.621861344174, 13049.67375815605, 13173.60479185626, 13290.867091329084, 13291.268980206085, 13344.799828002588, 771.7993321736346, 791.3352783661722, 794.7655441644699, 798.1260519730886, 798.393221151923, 797.11520212564, 801.3989507869098, 802.4783890471211, 802.8153524689325, 803.0443771911436, 825.0594322472386, 830.1822704635929, 831.3100126894693, 832.2301870769514, 832.7918020494876, 821.0229826506497, 822.313368337439, 822.3708862720024, 823.1932705948144, 823.5964377455064, 609.0802887639696, 609.2871340531589, 609.2932198649545, 609.679918043031, 609.7012463892705, 12198.39008049594, 12271.447784849703, 12300.261984280973, 12321.260724356567, 12325.137240393176, 11416.372099534523, 11467.713307167303, 11481.311121332747, 11680.649580512598, 12038.81941770874, 9378.765530861714, 9730.805383892282, 9816.116549510507, 9882.258830587663, 10022.3485473444, 3282.261491164493, 3323.1692076980753, 3337.666233376667, 3351.1287065362935, 3448.5861696596317, 43567.0, 51513.22730159051, 55071.449285507435, 58275.0, 58518.41481585172, 10584.312019718695, 11008.669739907815, 11147.331160130418, 11167.847471345964, 11603.187776855708, 15807.446739364297, 20313.898430507754, 20373.694394584094, 20381.18475260973, 20383.8980805095, 6863.931360686329, 7059.92940070603, 7146.428285737128, 7246.058012458452, 7278.526895751759, 3831.731778775459, 3844.442555829389, 3853.1715681128694, 3875.205582855508, 3928.7642741435607, 3116.812991220534, 3199.3601279744144, 3205.583274174389, 3207.9679203208134, 3219.839008049635, 543.6248988198131, 545.2174943700355, 546.8086169840524, 559.4573263933978, 566.0631654611624, 511.75691546515105, 580.7096451774113, 601.5488383712216, 631.6557476175495, 634.8317695810614, 8247.95876020616, 8346.457480263885, 8652.74041778735, 8662.2637075848, 8730.781730456789, 599.487438240307, 611.3275397063195, 623.4980840423412, 623.9594426362272, 628.1614045249552, 4007.1785284016705, 4092.4066010428323, 4222.092250166168, 4300.634446072119, 4390.143921935256, 53115.46884531105, 73380.63309683418, 86212.56893715491, 95242.52378738062, 96372.51813740886, 50200.748996254784, 80716.19283807087, 81216.18783812204, 81647.0, 83050.58474707587, 72396.63801680958, 73406.63296683482, 74137.62931185309, 74157.6292118536, 74945.0, 7922.366210703015, 8062.0, 8180.754577362689, 8223.136570660234, 8256.339492840438, 33978.66021339755, 44349.77825110854, 44885.10229795451, 45392.0, 46085.53914460813, 65422.672886635264, 66327.66836165788, 66454.33545664481, 66664.66667666631, 66680.0, 10665.253432259979, 10922.890771092187, 11317.660470185578, 11436.256643318158, 11763.0, 10946.781064378827, 11087.72280692989, 11322.902694114237, 11779.234349767237, 11821.468033938665, 9972.081747821589, 10077.143442807443, 10377.0, 10410.115140213167, 10674.786504269716, 10926.836097458703, 10950.726231844268, 11082.22424430282, 11450.770984580427, 11560.826587601025, 10246.6413675521, 10331.450823784096, 10724.410157441416, 10726.249162558546, 10740.892591074302, 8868.246199072893, 9018.143276388733, 9058.094190581152, 9211.447313161232, 9260.0, 9095.454272743656, 9119.361644684808, 9337.953310233406, 9404.811903762024, 9437.858432123387], "value": 6454.5822552108075, "unit": "score"}], "name": "dromaeo_css", "value": 6344.846798442479, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 112.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 116.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 122.0, 179.0, 129.0, 129.0, 146.0, 126.0, 171.0, 123.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 163.0, 163.0, 161.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 122.0, 77.0, 77.0, 86.0, 75.0, 103.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 120.0, 85.0, 85.0, 85.0, 112.0, 85.0, 85.0, 132.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 93.0, 78.0, 78.0, 78.0, 81.0, 79.0, 82.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 130.0, 133.0, 140.0, 129.0, 137.0, 145.0, 167.0, 139.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 167.0, 169.0, 171.0, 168.0, 168.0, 168.0, 171.0, 170.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 65.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1535.6999999999994, "alertThreshold": 2.0}]} 22:04:05 INFO - Return code: 0 22:04:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:04:05 INFO - # TBPL SUCCESS # 22:04:05 INFO - Running post-action listener: _resource_record_post_action 22:04:05 INFO - ##### 22:04:05 INFO - ##### Finished run-tests step (success) 22:04:05 INFO - ##### 22:04:05 INFO - Running post-run listener: _resource_record_post_run 22:04:05 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533819392; Read time: 8; Write time: 968344 22:04:05 INFO - TinderboxPrint: CPU usage
13.0% 22:04:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:04:05 INFO - TinderboxPrint: I/O write bytes / time
533,819,392 / 968,344 22:04:05 INFO - TinderboxPrint: CPU idle
8,340.6 (87.0%) 22:04:05 INFO - TinderboxPrint: CPU user
1,198.2 (12.5%) 22:04:05 INFO - TinderboxPrint: Swap in / out
0 / 0 22:04:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245768192; Read time: 0; Write time: 454304 22:04:05 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 287436800; Read time: 0; Write time: 513996 22:04:06 INFO - Running post-run listener: _upload_blobber_files 22:04:06 INFO - Blob upload gear active. 22:04:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:04:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:04:06 INFO - (blobuploader) - INFO - Open directory for files ... 22:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:04:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:07 INFO - (blobuploader) - INFO - Done attempting. 22:04:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:04:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:11 INFO - (blobuploader) - INFO - Done attempting. 22:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:11 INFO - (blobuploader) - INFO - Done attempting. 22:04:11 INFO - (blobuploader) - INFO - Iteration through files over. 22:04:11 INFO - Return code: 0 22:04:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:04:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:04:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/103e0a047222e333264bd96305936ec633a0c5c09f78d8c83f9e9f1c7ea1338f395cd54dea4b4ff02c1621ea41a04bb35d3456a1cfb56d17732c69f907eabcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb6fe82cccbefa7ef2dccac77906223486ea5bdecdcbdd22ae2c5e5b85743ba7fb9f656d4d4e8cbb62ffd93b222e24d7c3b84e36e1f43a1a964424cafdd3d3f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ac0de34c348eace2cf61632ba2bb9a3aec7accf1a6dc9967d6dbbe36c6c375651961417827885fcb54e5549c7f303bbd5bb6ba543c02bc01a523ba5bae1f39"} 22:04:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:04:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:04:11 INFO - Contents: 22:04:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/103e0a047222e333264bd96305936ec633a0c5c09f78d8c83f9e9f1c7ea1338f395cd54dea4b4ff02c1621ea41a04bb35d3456a1cfb56d17732c69f907eabcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb6fe82cccbefa7ef2dccac77906223486ea5bdecdcbdd22ae2c5e5b85743ba7fb9f656d4d4e8cbb62ffd93b222e24d7c3b84e36e1f43a1a964424cafdd3d3f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ac0de34c348eace2cf61632ba2bb9a3aec7accf1a6dc9967d6dbbe36c6c375651961417827885fcb54e5549c7f303bbd5bb6ba543c02bc01a523ba5bae1f39"} 22:04:11 INFO - Running post-run listener: copy_logs_to_upload_dir 22:04:11 INFO - Copying logs to upload dir... 22:04:11 INFO - mkdir: /builds/slave/test/build/upload/logs 22:04:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.437580 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-04 22:04:11.614622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 22:04:11.617719) ========= 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=8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610 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/103e0a047222e333264bd96305936ec633a0c5c09f78d8c83f9e9f1c7ea1338f395cd54dea4b4ff02c1621ea41a04bb35d3456a1cfb56d17732c69f907eabcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb6fe82cccbefa7ef2dccac77906223486ea5bdecdcbdd22ae2c5e5b85743ba7fb9f656d4d4e8cbb62ffd93b222e24d7c3b84e36e1f43a1a964424cafdd3d3f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ac0de34c348eace2cf61632ba2bb9a3aec7accf1a6dc9967d6dbbe36c6c375651961417827885fcb54e5549c7f303bbd5bb6ba543c02bc01a523ba5bae1f39"} build_url:https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/RgjVTyQOQNSLBZMpTQ1usg/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/103e0a047222e333264bd96305936ec633a0c5c09f78d8c83f9e9f1c7ea1338f395cd54dea4b4ff02c1621ea41a04bb35d3456a1cfb56d17732c69f907eabcf5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb6fe82cccbefa7ef2dccac77906223486ea5bdecdcbdd22ae2c5e5b85743ba7fb9f656d4d4e8cbb62ffd93b222e24d7c3b84e36e1f43a1a964424cafdd3d3f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7ac0de34c348eace2cf61632ba2bb9a3aec7accf1a6dc9967d6dbbe36c6c375651961417827885fcb54e5549c7f303bbd5bb6ba543c02bc01a523ba5bae1f39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 22:04:11.647310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:04:11.647663) ========= 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=8783db0840cc980e80bb0bd400000236-1467688990.344175-688050610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 22:04:11.731988) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 22:04:11.732730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 22:04:11.733428) ========= ========= Total master_lag: 0.18 =========