builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1468989248.19 results: success (0) buildid: 20160719173014 builduid: 904ada7fc018483fb27221f303c6267e revision: abd1161f6a90962bc80c44b3f1d2f31392a118c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.195428) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.196516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.197063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.212165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.212684) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 21:34:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-07-19 21:34:09 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157747 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.390821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.391564) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020670 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.445316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:08.446102) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev abd1161f6a90962bc80c44b3f1d2f31392a118c6 --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 abd1161f6a90962bc80c44b3f1d2f31392a118c6 --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=9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 21:34:09,156 truncating revision to first 12 chars 2016-07-19 21:34:09,157 Setting DEBUG logging. 2016-07-19 21:34:09,157 attempt 1/10 2016-07-19 21:34:09,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/abd1161f6a90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 21:34:09,471 unpacking tar archive at: fx-team-abd1161f6a90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675192 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:09.135786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:09.136160) ========= script_repo_revision: abd1161f6a90962bc80c44b3f1d2f31392a118c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:09.136593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:09.136945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 21:34:09.146813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-19 21:34:09.147140) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:09 INFO - MultiFileLogger online at 20160719 21:34:09 in /builds/slave/test 21:34:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:34:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:09 INFO - {'append_to_log': False, 21:34:09 INFO - 'base_work_dir': '/builds/slave/test', 21:34:09 INFO - 'blob_upload_branch': 'Fx-Team', 21:34:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:09 INFO - 'branch': 'Fx-Team', 21:34:09 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:09 INFO - 'config_files': ('talos/linux_config.py',), 21:34:09 INFO - 'default_actions': ('clobber', 21:34:09 INFO - 'read-buildbot-config', 21:34:09 INFO - 'download-and-extract', 21:34:09 INFO - 'populate-webroot', 21:34:09 INFO - 'create-virtualenv', 21:34:09 INFO - 'install', 21:34:09 INFO - 'run-tests'), 21:34:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:09 INFO - 'download_minidump_stackwalk': True, 21:34:09 INFO - 'download_symbols': 'ondemand', 21:34:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:09 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:09 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:09 INFO - 'installer_path': 'installer.exe', 21:34:09 INFO - 'log_level': 'info', 21:34:09 INFO - 'log_name': 'talos', 21:34:09 INFO - 'log_to_console': True, 21:34:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:09 INFO - 'opt_config_files': (), 21:34:09 INFO - 'pip_index': False, 21:34:09 INFO - 'sps_profile': False, 21:34:09 INFO - 'sps_profile_interval': 0, 21:34:09 INFO - 'suite': 'dromaeojs', 21:34:09 INFO - 'system_bits': '32', 21:34:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:09 INFO - 'title': 'talos-linux64-ix-029', 21:34:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:09 INFO - 'use_talos_json': True, 21:34:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:09 INFO - 'work_dir': 'build'} 21:34:09 INFO - ##### 21:34:09 INFO - ##### Running clobber step. 21:34:09 INFO - ##### 21:34:09 INFO - Running pre-action listener: _resource_record_pre_action 21:34:09 INFO - Running main action method: clobber 21:34:09 INFO - rmtree: /builds/slave/test/build 21:34:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:10 INFO - Running post-action listener: _resource_record_post_action 21:34:10 INFO - ##### 21:34:10 INFO - ##### Finished clobber step (success) 21:34:10 INFO - ##### 21:34:10 INFO - ##### 21:34:10 INFO - ##### Running read-buildbot-config step. 21:34:10 INFO - ##### 21:34:10 INFO - Running pre-action listener: _resource_record_pre_action 21:34:10 INFO - Running main action method: read_buildbot_config 21:34:10 INFO - Using buildbot properties: 21:34:10 INFO - { 21:34:10 INFO - "project": "", 21:34:10 INFO - "product": "firefox", 21:34:10 INFO - "script_repo_revision": "production", 21:34:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:34:10 INFO - "repository": "", 21:34:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:34:10 INFO - "buildid": "20160719173014", 21:34:10 INFO - "pgo_build": "True", 21:34:10 INFO - "basedir": "/builds/slave/test", 21:34:10 INFO - "buildnumber": 914, 21:34:10 INFO - "slavename": "talos-linux64-ix-029", 21:34:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:34:10 INFO - "platform": "ubuntu64_hw", 21:34:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:34:10 INFO - "branch": "fx-team", 21:34:10 INFO - "repo_path": "integration/fx-team", 21:34:10 INFO - "revision": "abd1161f6a90962bc80c44b3f1d2f31392a118c6", 21:34:10 INFO - "stage_platform": "linux64-pgo", 21:34:10 INFO - "builduid": "904ada7fc018483fb27221f303c6267e", 21:34:10 INFO - "slavebuilddir": "test" 21:34:10 INFO - } 21:34:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:34:10 INFO - Running post-action listener: _resource_record_post_action 21:34:10 INFO - ##### 21:34:10 INFO - ##### Finished read-buildbot-config step (success) 21:34:10 INFO - ##### 21:34:10 INFO - ##### 21:34:10 INFO - ##### Running download-and-extract step. 21:34:10 INFO - ##### 21:34:10 INFO - Running pre-action listener: _resource_record_pre_action 21:34:10 INFO - Running main action method: download_and_extract 21:34:10 INFO - mkdir: /builds/slave/test/build/tests 21:34:10 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:34:10 INFO - https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:34:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:34:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:34:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:11 INFO - Downloaded 1361 bytes. 21:34:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:34:11 INFO - Using the following test package requirements: 21:34:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:34:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:34:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:34:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'jsshell-linux-x86_64.zip'], 21:34:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:34:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:34:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:34:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:34:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:34:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:34:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:34:11 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:34:11 INFO - https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:34:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:34:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:12 INFO - Downloaded 24333765 bytes. 21:34:12 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:34:12 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:34:13 INFO - Return code: 0 21:34:13 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:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:13 INFO - https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:34:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:34:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:14 INFO - Downloaded 24333765 bytes. 21:34:14 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:34:14 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:34:16 INFO - Return code: 0 21:34:16 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:34:16 INFO - https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:34:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:34:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:34:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:17 INFO - Downloaded 14403317 bytes. 21:34:17 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:34:17 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:34:17 INFO - Return code: 0 21:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:17 INFO - https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:34:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:34:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:34:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KVISglf-Sr6XWCLc7JAL3w/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:34:18 INFO - Downloaded 60850645 bytes. 21:34:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:34:18 INFO - mkdir: /builds/slave/test/properties 21:34:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:34:18 INFO - Writing to file /builds/slave/test/properties/build_url 21:34:18 INFO - Contents: 21:34:18 INFO - build_url:https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:34:19 INFO - Running post-action listener: _resource_record_post_action 21:34:19 INFO - Running post-action listener: set_extra_try_arguments 21:34:19 INFO - ##### 21:34:19 INFO - ##### Finished download-and-extract step (success) 21:34:19 INFO - ##### 21:34:19 INFO - ##### 21:34:19 INFO - ##### Running populate-webroot step. 21:34:19 INFO - ##### 21:34:19 INFO - Running pre-action listener: _resource_record_pre_action 21:34:19 INFO - Running main action method: populate_webroot 21:34:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:34:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:34:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:34:19 INFO - '--tppagecycles', 21:34:19 INFO - '7'], 21:34:19 INFO - 'tests': ['tsvgm']}}, 21:34:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:34:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:34:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:34:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:34:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['damp', 'tps']}, 21:34:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'tests': ['damp', 'tps']}, 21:34:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['dromaeo_dom']}, 21:34:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['basic_compositor_video']}, 21:34:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:34:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['a11yr', 21:34:19 INFO - 'ts_paint', 21:34:19 INFO - 'tpaint', 21:34:19 INFO - 'sessionrestore', 21:34:19 INFO - 'sessionrestore_no_auto_restore', 21:34:19 INFO - 'tabpaint']}, 21:34:19 INFO - 'other-e10s': {'tests': ['a11yr', 21:34:19 INFO - 'ts_paint', 21:34:19 INFO - 'tpaint', 21:34:19 INFO - 'sessionrestore', 21:34:19 INFO - 'sessionrestore_no_auto_restore', 21:34:19 INFO - 'tabpaint']}, 21:34:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:34:19 INFO - 'ts_paint', 21:34:19 INFO - 'tpaint', 21:34:19 INFO - 'sessionrestore', 21:34:19 INFO - 'sessionrestore_no_auto_restore', 21:34:19 INFO - 'tabpaint']}, 21:34:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:34:19 INFO - 'ts_paint', 21:34:19 INFO - 'tpaint', 21:34:19 INFO - 'sessionrestore', 21:34:19 INFO - 'sessionrestore_no_auto_restore', 21:34:19 INFO - 'tabpaint']}, 21:34:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['a11yr', 21:34:19 INFO - 'ts_paint', 21:34:19 INFO - 'tpaint', 21:34:19 INFO - 'sessionrestore', 21:34:19 INFO - 'sessionrestore_no_auto_restore', 21:34:19 INFO - 'tabpaint']}, 21:34:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['a11yr', 21:34:19 INFO - 'ts_paint', 21:34:19 INFO - 'tpaint', 21:34:19 INFO - 'sessionrestore', 21:34:19 INFO - 'sessionrestore_no_auto_restore', 21:34:19 INFO - 'tabpaint']}, 21:34:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['tsvgx', 21:34:19 INFO - 'tsvgr_opacity', 21:34:19 INFO - 'tart', 21:34:19 INFO - 'tscrollx', 21:34:19 INFO - 'cart']}, 21:34:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:34:19 INFO - 'tsvgr_opacity', 21:34:19 INFO - 'tart', 21:34:19 INFO - 'tscrollx', 21:34:19 INFO - 'cart']}, 21:34:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'talos_options': ['--disable-e10s'], 21:34:19 INFO - 'tests': ['tp5o']}, 21:34:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'tests': ['tp5o']}, 21:34:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'talos_options': ['--disable-e10s', 21:34:19 INFO - '--xperf_path', 21:34:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:19 INFO - 'tests': ['tp5n']}, 21:34:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:19 INFO - 'talos_options': ['--xperf_path', 21:34:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:19 INFO - 'tests': ['tp5n']}}, 21:34:19 INFO - 'talos.zip': {'path': '', 21:34:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:34:19 INFO - Running post-action listener: _resource_record_post_action 21:34:19 INFO - ##### 21:34:19 INFO - ##### Finished populate-webroot step (success) 21:34:19 INFO - ##### 21:34:19 INFO - ##### 21:34:19 INFO - ##### Running create-virtualenv step. 21:34:19 INFO - ##### 21:34:19 INFO - Running pre-action listener: _resource_record_pre_action 21:34:19 INFO - Running main action method: create_virtualenv 21:34:19 INFO - Creating virtualenv /builds/slave/test/build/venv 21:34:19 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:34:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:34:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:19 INFO - Using real prefix '/usr' 21:34:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:34:20 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:22 INFO - Installing pip.................done. 21:34:22 INFO - Return code: 0 21:34:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:22 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:34:22 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:34:22 INFO - Using env: {'DISPLAY': ':0', 21:34:22 INFO - 'HOME': '/home/cltbld', 21:34:22 INFO - 'LANG': 'en_US.UTF-8', 21:34:22 INFO - 'LANGUAGE': 'en_US:en', 21:34:22 INFO - 'LOGNAME': 'cltbld', 21:34:22 INFO - 'MAIL': '/var/mail/cltbld', 21:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:22 INFO - 'MOZ_NO_REMOTE': '1', 21:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:22 INFO - 'NO_EM_RESTART': '1', 21:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:22 INFO - 'PWD': '/builds/slave/test', 21:34:22 INFO - 'SHELL': '/bin/bash', 21:34:22 INFO - 'SHLVL': '1', 21:34:22 INFO - 'TERM': 'linux', 21:34:22 INFO - 'TMOUT': '86400', 21:34:22 INFO - 'USER': 'cltbld', 21:34:22 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:22 INFO - '_': '/tools/buildbot/bin/python'} 21:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:22 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:34:22 INFO - Cleaning up... 21:34:22 INFO - Return code: 0 21:34:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:22 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:22 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:34:22 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:34:22 INFO - Using env: {'DISPLAY': ':0', 21:34:22 INFO - 'HOME': '/home/cltbld', 21:34:22 INFO - 'LANG': 'en_US.UTF-8', 21:34:22 INFO - 'LANGUAGE': 'en_US:en', 21:34:22 INFO - 'LOGNAME': 'cltbld', 21:34:22 INFO - 'MAIL': '/var/mail/cltbld', 21:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:22 INFO - 'MOZ_NO_REMOTE': '1', 21:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:22 INFO - 'NO_EM_RESTART': '1', 21:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:22 INFO - 'PWD': '/builds/slave/test', 21:34:22 INFO - 'SHELL': '/bin/bash', 21:34:22 INFO - 'SHLVL': '1', 21:34:22 INFO - 'TERM': 'linux', 21:34:22 INFO - 'TMOUT': '86400', 21:34:22 INFO - 'USER': 'cltbld', 21:34:22 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:22 INFO - '_': '/tools/buildbot/bin/python'} 21:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:22 INFO - Downloading/unpacking psutil>=3.1.1 21:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:24 INFO - Installing collected packages: psutil 21:34:24 INFO - Running setup.py install for psutil 21:34:24 INFO - building 'psutil._psutil_linux' extension 21:34:24 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:34:24 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:34:24 INFO - building 'psutil._psutil_posix' extension 21:34:24 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:34:25 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:34:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:25 INFO - Successfully installed psutil 21:34:25 INFO - Cleaning up... 21:34:25 INFO - Return code: 0 21:34:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:34:25 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:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:25 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:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:25 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:25 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:34:25 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:34:25 INFO - Using env: {'DISPLAY': ':0', 21:34:25 INFO - 'HOME': '/home/cltbld', 21:34:25 INFO - 'LANG': 'en_US.UTF-8', 21:34:25 INFO - 'LANGUAGE': 'en_US:en', 21:34:25 INFO - 'LOGNAME': 'cltbld', 21:34:25 INFO - 'MAIL': '/var/mail/cltbld', 21:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:25 INFO - 'MOZ_NO_REMOTE': '1', 21:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:25 INFO - 'NO_EM_RESTART': '1', 21:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:25 INFO - 'PWD': '/builds/slave/test', 21:34:25 INFO - 'SHELL': '/bin/bash', 21:34:25 INFO - 'SHLVL': '1', 21:34:25 INFO - 'TERM': 'linux', 21:34:25 INFO - 'TMOUT': '86400', 21:34:25 INFO - 'USER': 'cltbld', 21:34:25 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:25 INFO - '_': '/tools/buildbot/bin/python'} 21:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:34:27 INFO - Installing collected packages: mozsystemmonitor 21:34:27 INFO - Running setup.py install for mozsystemmonitor 21:34:27 INFO - Successfully installed mozsystemmonitor 21:34:27 INFO - Cleaning up... 21:34:27 INFO - Return code: 0 21:34:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:27 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:27 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:34:27 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:34:27 INFO - Using env: {'DISPLAY': ':0', 21:34:27 INFO - 'HOME': '/home/cltbld', 21:34:27 INFO - 'LANG': 'en_US.UTF-8', 21:34:27 INFO - 'LANGUAGE': 'en_US:en', 21:34:27 INFO - 'LOGNAME': 'cltbld', 21:34:27 INFO - 'MAIL': '/var/mail/cltbld', 21:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:27 INFO - 'MOZ_NO_REMOTE': '1', 21:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:27 INFO - 'NO_EM_RESTART': '1', 21:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:27 INFO - 'PWD': '/builds/slave/test', 21:34:27 INFO - 'SHELL': '/bin/bash', 21:34:27 INFO - 'SHLVL': '1', 21:34:27 INFO - 'TERM': 'linux', 21:34:27 INFO - 'TMOUT': '86400', 21:34:27 INFO - 'USER': 'cltbld', 21:34:27 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:27 INFO - '_': '/tools/buildbot/bin/python'} 21:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:27 INFO - Downloading/unpacking jsonschema==2.5.1 21:34:27 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:34:27 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:34:27 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:34:27 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:34:27 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:34:27 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:34:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:34:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:34:29 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:34:29 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:34:29 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:34:29 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:34:29 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:34:29 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:34:29 INFO - Downloading functools32-3.2.3-2.tar.gz 21:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:34:29 INFO - warning: no files found matching '*.txt' 21:34:29 INFO - no previously-included directories found matching 'build' 21:34:29 INFO - no previously-included directories found matching 'dist' 21:34:29 INFO - no previously-included directories found matching '.git*' 21:34:29 INFO - Installing collected packages: jsonschema, functools32 21:34:29 INFO - Running setup.py install for functools32 21:34:30 INFO - warning: no files found matching '*.txt' 21:34:30 INFO - no previously-included directories found matching 'build' 21:34:30 INFO - no previously-included directories found matching 'dist' 21:34:30 INFO - no previously-included directories found matching '.git*' 21:34:30 INFO - Successfully installed jsonschema functools32 21:34:30 INFO - Cleaning up... 21:34:30 INFO - Return code: 0 21:34:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:30 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:30 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:34:30 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:34:30 INFO - Using env: {'DISPLAY': ':0', 21:34:30 INFO - 'HOME': '/home/cltbld', 21:34:30 INFO - 'LANG': 'en_US.UTF-8', 21:34:30 INFO - 'LANGUAGE': 'en_US:en', 21:34:30 INFO - 'LOGNAME': 'cltbld', 21:34:30 INFO - 'MAIL': '/var/mail/cltbld', 21:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:30 INFO - 'MOZ_NO_REMOTE': '1', 21:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:30 INFO - 'NO_EM_RESTART': '1', 21:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:30 INFO - 'PWD': '/builds/slave/test', 21:34:30 INFO - 'SHELL': '/bin/bash', 21:34:30 INFO - 'SHLVL': '1', 21:34:30 INFO - 'TERM': 'linux', 21:34:30 INFO - 'TMOUT': '86400', 21:34:30 INFO - 'USER': 'cltbld', 21:34:30 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:30 INFO - '_': '/tools/buildbot/bin/python'} 21:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:30 INFO - Downloading/unpacking blobuploader==1.2.4 21:34:30 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:34:30 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:34:30 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:34:30 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:34:30 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:34:30 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:34:32 INFO - Downloading blobuploader-1.2.4.tar.gz 21:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:34:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:34:32 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:34:32 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:34:32 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:34:32 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:34:32 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:34:32 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:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:34:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:34:32 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:34:32 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:34:32 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:34:32 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:34:32 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:34:32 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:34:32 INFO - Downloading docopt-0.6.1.tar.gz 21:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:34:33 INFO - Installing collected packages: blobuploader, requests, docopt 21:34:33 INFO - Running setup.py install for blobuploader 21:34:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:34:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:34:33 INFO - Running setup.py install for requests 21:34:33 INFO - Running setup.py install for docopt 21:34:33 INFO - Successfully installed blobuploader requests docopt 21:34:33 INFO - Cleaning up... 21:34:33 INFO - Return code: 0 21:34:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:33 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:33 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:34:33 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:34:33 INFO - Using env: {'DISPLAY': ':0', 21:34:33 INFO - 'HOME': '/home/cltbld', 21:34:33 INFO - 'LANG': 'en_US.UTF-8', 21:34:33 INFO - 'LANGUAGE': 'en_US:en', 21:34:33 INFO - 'LOGNAME': 'cltbld', 21:34:33 INFO - 'MAIL': '/var/mail/cltbld', 21:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:33 INFO - 'MOZ_NO_REMOTE': '1', 21:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:33 INFO - 'NO_EM_RESTART': '1', 21:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:33 INFO - 'PWD': '/builds/slave/test', 21:34:33 INFO - 'SHELL': '/bin/bash', 21:34:33 INFO - 'SHLVL': '1', 21:34:33 INFO - 'TERM': 'linux', 21:34:33 INFO - 'TMOUT': '86400', 21:34:33 INFO - 'USER': 'cltbld', 21:34:33 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:33 INFO - '_': '/tools/buildbot/bin/python'} 21:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:33 INFO - Running setup.py (path:/tmp/pip-RAKHZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:33 INFO - Running setup.py (path:/tmp/pip-NvNJzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:33 INFO - Running setup.py (path:/tmp/pip-lUKY83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:34 INFO - Running setup.py (path:/tmp/pip-mCDwxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:34 INFO - Running setup.py (path:/tmp/pip-lzT_ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:34 INFO - Running setup.py (path:/tmp/pip-aDuebA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:34 INFO - Running setup.py (path:/tmp/pip-YUubtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:34 INFO - Running setup.py (path:/tmp/pip-Zhzo3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:34 INFO - Running setup.py (path:/tmp/pip-9D2Fo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:34 INFO - Running setup.py (path:/tmp/pip-c4cWtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:34 INFO - Running setup.py (path:/tmp/pip-8QvdjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:34 INFO - Running setup.py (path:/tmp/pip-8bzBBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:34 INFO - Running setup.py (path:/tmp/pip-Jlm0lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:34 INFO - Running setup.py (path:/tmp/pip-2C4SU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:34 INFO - Running setup.py (path:/tmp/pip-7jTL_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:34 INFO - Running setup.py (path:/tmp/pip-NmpM3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:34 INFO - Running setup.py (path:/tmp/pip-Or_NeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:34:35 INFO - Running setup.py install for manifestparser 21:34:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Running setup.py install for mozcrash 21:34:35 INFO - Running setup.py install for mozdebug 21:34:35 INFO - Running setup.py install for mozdevice 21:34:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Running setup.py install for mozfile 21:34:35 INFO - Running setup.py install for mozhttpd 21:34:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Running setup.py install for mozinfo 21:34:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Running setup.py install for mozInstall 21:34:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:34:35 INFO - Running setup.py install for mozleak 21:34:35 INFO - Running setup.py install for mozlog 21:34:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:34:36 INFO - Running setup.py install for moznetwork 21:34:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:34:36 INFO - Running setup.py install for mozprocess 21:34:36 INFO - Running setup.py install for mozprofile 21:34:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:34:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:34:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:34:36 INFO - Running setup.py install for mozrunner 21:34:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:34:36 INFO - Running setup.py install for mozscreenshot 21:34:36 INFO - Running setup.py install for moztest 21:34:36 INFO - Running setup.py install for mozversion 21:34:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:34:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:34:36 INFO - Cleaning up... 21:34:36 INFO - Return code: 0 21:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:36 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:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:36 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:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:36 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:36 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:34:36 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:34:36 INFO - Using env: {'DISPLAY': ':0', 21:34:36 INFO - 'HOME': '/home/cltbld', 21:34:36 INFO - 'LANG': 'en_US.UTF-8', 21:34:36 INFO - 'LANGUAGE': 'en_US:en', 21:34:36 INFO - 'LOGNAME': 'cltbld', 21:34:36 INFO - 'MAIL': '/var/mail/cltbld', 21:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:36 INFO - 'MOZ_NO_REMOTE': '1', 21:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:36 INFO - 'NO_EM_RESTART': '1', 21:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:36 INFO - 'PWD': '/builds/slave/test', 21:34:36 INFO - 'SHELL': '/bin/bash', 21:34:36 INFO - 'SHLVL': '1', 21:34:36 INFO - 'TERM': 'linux', 21:34:36 INFO - 'TMOUT': '86400', 21:34:36 INFO - 'USER': 'cltbld', 21:34:36 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:36 INFO - '_': '/tools/buildbot/bin/python'} 21:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:34:37 INFO - Running setup.py (path:/tmp/pip-aIlHbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:34:37 INFO - Running setup.py (path:/tmp/pip-PqKr5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:34:37 INFO - Running setup.py (path:/tmp/pip-W7hhJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:34:37 INFO - Running setup.py (path:/tmp/pip-cWyKdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:34:37 INFO - Running setup.py (path:/tmp/pip-M64kZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:34:37 INFO - Running setup.py (path:/tmp/pip-36jJpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:34:37 INFO - Running setup.py (path:/tmp/pip-NDIIyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:34:37 INFO - Running setup.py (path:/tmp/pip-5x13Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:34:37 INFO - Running setup.py (path:/tmp/pip-pZJgqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:34:37 INFO - Running setup.py (path:/tmp/pip-jjrNyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:34:37 INFO - Running setup.py (path:/tmp/pip-dhNgNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:34:37 INFO - Running setup.py (path:/tmp/pip-F1yey2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:34:37 INFO - Running setup.py (path:/tmp/pip-NmoHbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:34:37 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:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:34:38 INFO - Running setup.py (path:/tmp/pip-afTDa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:38 INFO - Running setup.py (path:/tmp/pip-EeCUCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:34:38 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:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:34:38 INFO - Running setup.py (path:/tmp/pip-zo5_RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:34:38 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:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:34:38 INFO - Running setup.py (path:/tmp/pip-WoFEcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:34:38 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:34:38 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:34:38 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:34:38 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:34:38 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:34:38 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:34:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:40 INFO - Downloading blessings-1.6.tar.gz 21:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:34:40 INFO - Installing collected packages: blessings 21:34:40 INFO - Running setup.py install for blessings 21:34:40 INFO - Successfully installed blessings 21:34:40 INFO - Cleaning up... 21:34:40 INFO - Return code: 0 21:34:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:34:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:40 INFO - Reading from file tmpfile_stdout 21:34:40 INFO - Current package versions: 21:34:40 INFO - argparse == 1.2.1 21:34:40 INFO - blessings == 1.6 21:34:40 INFO - blobuploader == 1.2.4 21:34:40 INFO - docopt == 0.6.1 21:34:40 INFO - functools32 == 3.2.3-2 21:34:40 INFO - jsonschema == 2.5.1 21:34:40 INFO - manifestparser == 1.1 21:34:40 INFO - mozInstall == 1.12 21:34:40 INFO - mozcrash == 0.17 21:34:40 INFO - mozdebug == 0.1 21:34:40 INFO - mozdevice == 0.48 21:34:40 INFO - mozfile == 1.2 21:34:40 INFO - mozhttpd == 0.7 21:34:40 INFO - mozinfo == 0.9 21:34:40 INFO - mozleak == 0.1 21:34:40 INFO - mozlog == 3.2 21:34:40 INFO - moznetwork == 0.27 21:34:40 INFO - mozprocess == 0.23 21:34:40 INFO - mozprofile == 0.28 21:34:40 INFO - mozrunner == 6.12 21:34:40 INFO - mozscreenshot == 0.1 21:34:40 INFO - mozsystemmonitor == 0.3 21:34:40 INFO - moztest == 0.7 21:34:40 INFO - mozversion == 1.4 21:34:40 INFO - psutil == 3.1.1 21:34:40 INFO - requests == 1.2.3 21:34:40 INFO - wsgiref == 0.1.2 21:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:40 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 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:40 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:34:40 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:34:40 INFO - Using env: {'DISPLAY': ':0', 21:34:40 INFO - 'HOME': '/home/cltbld', 21:34:40 INFO - 'LANG': 'en_US.UTF-8', 21:34:40 INFO - 'LANGUAGE': 'en_US:en', 21:34:40 INFO - 'LOGNAME': 'cltbld', 21:34:40 INFO - 'MAIL': '/var/mail/cltbld', 21:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:40 INFO - 'MOZ_NO_REMOTE': '1', 21:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:40 INFO - 'NO_EM_RESTART': '1', 21:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:40 INFO - 'PWD': '/builds/slave/test', 21:34:40 INFO - 'SHELL': '/bin/bash', 21:34:40 INFO - 'SHLVL': '1', 21:34:40 INFO - 'TERM': 'linux', 21:34:40 INFO - 'TMOUT': '86400', 21:34:40 INFO - 'USER': 'cltbld', 21:34:40 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:40 INFO - '_': '/tools/buildbot/bin/python'} 21:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 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:34:40 INFO - Cleaning up... 21:34:40 INFO - Return code: 0 21:34:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', '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:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:34:40 INFO - Using env: {'DISPLAY': ':0', 21:34:40 INFO - 'HOME': '/home/cltbld', 21:34:40 INFO - 'LANG': 'en_US.UTF-8', 21:34:40 INFO - 'LANGUAGE': 'en_US:en', 21:34:40 INFO - 'LOGNAME': 'cltbld', 21:34:40 INFO - 'MAIL': '/var/mail/cltbld', 21:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:40 INFO - 'MOZ_NO_REMOTE': '1', 21:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:40 INFO - 'NO_EM_RESTART': '1', 21:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:40 INFO - 'PWD': '/builds/slave/test', 21:34:40 INFO - 'SHELL': '/bin/bash', 21:34:40 INFO - 'SHLVL': '1', 21:34:40 INFO - 'TERM': 'linux', 21:34:40 INFO - 'TMOUT': '86400', 21:34:40 INFO - 'USER': 'cltbld', 21:34:40 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:40 INFO - '_': '/tools/buildbot/bin/python'} 21:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:34:41 INFO - Cleaning up... 21:34:41 INFO - Return code: 0 21:34:41 INFO - Running post-action listener: _resource_record_post_action 21:34:41 INFO - Running post-action listener: _start_resource_monitoring 21:34:41 INFO - Starting resource monitoring. 21:34:41 INFO - ##### 21:34:41 INFO - ##### Finished create-virtualenv step (success) 21:34:41 INFO - ##### 21:34:41 INFO - ##### 21:34:41 INFO - ##### Running install step. 21:34:41 INFO - ##### 21:34:41 INFO - Running pre-action listener: _resource_record_pre_action 21:34:41 INFO - Running main action method: install 21:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:34:41 INFO - Reading from file tmpfile_stdout 21:34:41 INFO - Detecting whether we're running mozinstall >=1.0... 21:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:34:41 INFO - Reading from file tmpfile_stdout 21:34:41 INFO - Output received: 21:34:41 INFO - Usage: mozinstall [options] installer 21:34:41 INFO - Options: 21:34:41 INFO - -h, --help show this help message and exit 21:34:41 INFO - -d DEST, --destination=DEST 21:34:41 INFO - Directory to install application into. [default: 21:34:41 INFO - "/builds/slave/test"] 21:34:41 INFO - --app=APP Application being installed. [default: firefox] 21:34:41 INFO - mkdir: /builds/slave/test/build/application 21:34:41 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:34:41 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:34:58 INFO - Reading from file tmpfile_stdout 21:34:58 INFO - Output received: 21:34:58 INFO - /builds/slave/test/build/application/firefox/firefox 21:34:58 INFO - Running post-action listener: _resource_record_post_action 21:34:58 INFO - ##### 21:34:58 INFO - ##### Finished install step (success) 21:34:58 INFO - ##### 21:34:58 INFO - ##### 21:34:58 INFO - ##### Running run-tests step. 21:34:58 INFO - ##### 21:34:58 INFO - Running pre-action listener: _resource_record_pre_action 21:34:58 INFO - Running main action method: run_tests 21:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:34:58 INFO - Python 2.7.3 21:34:58 INFO - Return code: 0 21:34:58 INFO - grabbing minidump binary from tooltool 21:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:58 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 0x270f3b0>, '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 0x27102b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2710740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:34:58 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:34:58 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:34:58 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:34:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:34:58 INFO - Return code: 0 21:34:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:34:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:34:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:34:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:34:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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:34:58 INFO - Using env: {'DISPLAY': ':0', 21:34:58 INFO - 'HOME': '/home/cltbld', 21:34:58 INFO - 'LANG': 'en_US.UTF-8', 21:34:58 INFO - 'LANGUAGE': 'en_US:en', 21:34:58 INFO - 'LOGNAME': 'cltbld', 21:34:58 INFO - 'MAIL': '/var/mail/cltbld', 21:34:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:34:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:58 INFO - 'MOZ_NO_REMOTE': '1', 21:34:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:58 INFO - 'NO_EM_RESTART': '1', 21:34:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:58 INFO - 'PWD': '/builds/slave/test', 21:34:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:34:58 INFO - 'SHELL': '/bin/bash', 21:34:58 INFO - 'SHLVL': '1', 21:34:58 INFO - 'TERM': 'linux', 21:34:58 INFO - 'TMOUT': '86400', 21:34:58 INFO - 'USER': 'cltbld', 21:34:58 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836', 21:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:58 INFO - '_': '/tools/buildbot/bin/python'} 21:34:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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:34:58 INFO - mozversion application_buildid: 20160719173014 21:34:58 INFO - mozversion application_changeset: abd1161f6a90962bc80c44b3f1d2f31392a118c6 21:34:58 INFO - mozversion application_display_name: Nightly 21:34:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:34:58 INFO - mozversion application_name: Firefox 21:34:58 INFO - mozversion application_remotingname: firefox 21:34:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:34:58 INFO - mozversion application_vendor: Mozilla 21:34:58 INFO - mozversion application_version: 50.0a1 21:34:58 INFO - mozversion platform_buildid: 20160719173014 21:34:58 INFO - mozversion platform_changeset: abd1161f6a90962bc80c44b3f1d2f31392a118c6 21:34:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:34:58 INFO - mozversion platform_version: 50.0a1 21:34:58 INFO - using testdate: 1468989298 21:34:58 INFO - actual date: 1468989298 21:34:58 INFO - starting webserver on 'localhost:53725' 21:34:58 INFO - SUITE-START | Running 2 tests 21:34:58 INFO - TEST-START | dromaeo_css 21:34:58 INFO - operating with platform_type : linux_ 21:34:58 INFO - Initialising browser for dromaeo_css test... 21:34:58 INFO - TEST-INFO | started process 19617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaFOrqI/profile http://localhost:53725/getInfo.html) 21:35:03 INFO - PROCESS | 19617 | __metrics Screen width/height:1600/1200 21:35:03 INFO - PROCESS | 19617 | colorDepth:24 21:35:03 INFO - PROCESS | 19617 | Browser inner width/height: 1024/697 21:35:03 INFO - PROCESS | 19617 | __metrics 21:35:04 INFO - PROCESS | 19617 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:35:04 INFO - PROCESS | 19617 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:35:05 INFO - TEST-INFO | 19617: exit 0 21:35:05 INFO - Browser initialized. 21:35:05 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:05 INFO - TEST-INFO | started process 19695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaFOrqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:16 INFO - PROCESS | 19695 | RSS: Main: 156999680 21:35:16 INFO - PROCESS | 19695 | 21:36:08 INFO - PROCESS | 19695 | 1468989368529 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:38:16 INFO - PROCESS | 19695 | Cycle 1(1): loaded http://localhost:53725/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53725/tests/dromaeo/cssquery-ext.html) 21:38:17 INFO - PROCESS | 19695 | RSS: Main: 254042112 21:38:17 INFO - PROCESS | 19695 | 21:41:20 INFO - PROCESS | 19695 | Cycle 1(1): loaded http://localhost:53725/tests/dromaeo/cssquery-ext.html (next: http://localhost:53725/tests/dromaeo/cssquery-jquery.html) 21:41:21 INFO - PROCESS | 19695 | RSS: Main: 243961856 21:41:21 INFO - PROCESS | 19695 | 21:44:23 INFO - PROCESS | 19695 | Cycle 1(1): loaded http://localhost:53725/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53725/tests/dromaeo/cssquery-mootools.html) 21:44:23 INFO - PROCESS | 19695 | RSS: Main: 238190592 21:44:23 INFO - PROCESS | 19695 | 21:47:25 INFO - PROCESS | 19695 | Cycle 1(1): loaded http://localhost:53725/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53725/tests/dromaeo/cssquery-prototype.html) 21:47:26 INFO - PROCESS | 19695 | RSS: Main: 232808448 21:47:26 INFO - PROCESS | 19695 | 21:50:28 INFO - PROCESS | 19695 | Cycle 1(1): loaded http://localhost:53725/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53725/tests/dromaeo/cssquery-yui.html) 21:50:29 INFO - PROCESS | 19695 | RSS: Main: 203558912 21:50:29 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | Cycle 1(1): loaded http://localhost:53725/tests/dromaeo/cssquery-yui.html (next: http://localhost:53725/tests/dromaeo/cssquery-dojo.html) 21:53:32 INFO - PROCESS | 19695 | RSS: Main: 280604672 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | __start_tp_report 21:53:32 INFO - PROCESS | 19695 | _x_x_mozilla_page_load 21:53:32 INFO - PROCESS | 19695 | _x_x_mozilla_page_load_details 21:53:32 INFO - PROCESS | 19695 | |i|pagename|runs| 21:53:32 INFO - PROCESS | 19695 | |0;dojo.html;3012.367402845403;3016.351484430847;3052.6947305269464;3060.9081727548173;3064.096091652962;5267.604929630274;5330.333708286465;5338.91991620125;5360.571154307656;5395.91906121408;5309.30978972733;5319.813806516772;5329.227262047001;5361.624686271963;5361.919571206435;4799.040191961604;4884.511548845123;4895.975520122394;4910.091633047879;5027.924581131286;4935.9753201234125;4947.8268260610885;4983.551480366767;5000.224560983287;5010.398752149729;4847.491013443609;4849.903001939959;4856.660033797635;4876.146674332013;4889.217725163974;4834.057358815033;4837.274408838667;4902.411710594716;4910.975445122787;4955.380577427822;4874.65877388583;4880.048390563841;4897.289892965536;4899.240617704261;4951.3810773653295;5240.554552862973;5266.052110620087;5337.439568845293;5380.650257733235;5405.810796622139;5742.0238559445;5759.827205183851;5766.884662306772;5768;5771.220885180489;5628.521575666033;5736.311642602873;5788.82633520995;5792.768289268424;5798.1592669063175;5352.384475785257;5407.702576358299;5410.242566040757;5477.3427188737605;5478.808241711561;6000.5799594028;6015.879682406327;6019.337872833985;6020.127081573235;6022.789202377896;5429.782808687687;5526.585506086979;5611.494965453129;5613.017721898733;5620.747066382022;5601.495865372136;5751.1373294006235;5753.137029445533;5759.280089988752;5763.279590051244;5599.916001259984;5639.238702775155;5646;5649.830505084854;5691.146328050825;5601.551875849922;5627.606067575231;5629;5669;5670.092785154356;4331.198728235287;4341.956580434218;4347.8260869564865;4374.256376416017;4378.2994720845145;3858.228354329089;3877.2439374321734;3894.8831535053428;3918.9020274493364;3920.196359746245;5211.478852114758;5326.414094449608;5363.517283444431;5388.595855310868;5466.562674985991;5792.768289268382;5811.099279611667;5811.622244554091;5816.1566572846705;5854.414558544111;5417.83746487606;5437.265969094122;5442.537384322298;5447.319085114361;5478.945210547923;4858;4910.263460480885;4946.777395017233;4948.604111671058;5003.2995380646735;5902.6458412495385;5908.881822363614;5915.733791979371;5924.14099955504;5929.199558059607;5778.248827652378;5784.855378615568;5792.7103644818435;5793.536517078708;5796.449337312949;5745.166950792028;5850.063989761617;5897.351291357862;5901.232839730807;5933.080372542263;5592.916106258328;5653.208550802973;5653.830385088454;5663.66018038919;5664.376918538875;5514.972425137848;5729;5730.111832665943;5748.425157484218;5753.798617048383;5548.361938377138;5592.916106258328;5599.020171469895;5603.887922241451;5639.6334238274385;5610.410906854885;5637.238972738792;5646.9152962704775;5649.209110724584;5652.576056795675;5332.760025798771;5471.151971444432;5525.309336332958;5563.471470210324;5568.972155139199;5601.131824567198;5631.211630371669;5631.662100273997;5666.688332141772;5697.202391665253;5504.366997795305;5512.173174023928;5515.917261241165;5518.034343989866;5520.227168196536 21:53:32 INFO - PROCESS | 19695 | |1;ext.html;608.9556410755554;629.1475051305481;642.466752595346;642.9776655118361;653.7450394346206;33626.831865840664;44596.3310550342;45509;45704.771476142574;45713.77143114284;46647.30029049567;47010.529894701045;47018.52981470184;47030.29454558176;47133.293000604936;7807.765767026998;7891.289783919446;7913.366930645563;7917.9208207918045;7986.960065199695;10899.673009809718;11192.496337664825;11197.552097916074;11199.832002519968;11203.60787372442;11109.44452777362;11209.831852522178;11212;11227.887721122806;11231.66305010851;8123.959380203061;10729.08802751767;10902.291351062155;10980.450977451095;10981.725456863562;10575.048245657928;10909.890901091047;10915.290506117077;10916.07213386863;10924.508397122148;44054.55945440537;44345.334819977725;44358.112837743385;44478;44514.77742611299;3614.204874927512;3671.0822294426393;3686.8340924658187;3756.398976163828;4305.5694430557005;33831.6616833831;33913;34384.484232736526;34398;35434.11414714627;4436.689431739779;4531.56950089741;4606.815727370901;4643.744594047326;4690.859274221779;358779;359440;359743;360029;360770;60311.396886031456;60643.39356606466;60761;60933.390666093655;61133.694331528946;63202.99571540696;63402.68298658477;63545;63598;63611.363886360545;16913.7462938056;17208.397706080228;17215.053172075404;17217.741733874;17228.138593070296;12167;12333.383330833423;12345.753084938431;12362.938185309016;12689.175203611736;17563.73654395185;17650;17718.557036073944;17727.11364431773;17835.643287134444;6330.265143565319;6359.96820015897;6389.840253993687;6486.318936511692;6552.443042341454;988.8417853143462;1045.1168762395764;1086.255914698434;1158.2529268621693;1167.4046236419317;33583.83208083944;34011.65988340085;34172.31655366879;34197.65802341994;34411;1121.2487633285718;1150.0684445598924;1151.073385924322;1158.8319693644373;1172.6013155527162;17627.118644068003;17637.118144092743;17706.20322085509;17764.822351776576;17932.55168620795;577634;579492;584607;584926;585266;60371.39628603746;60567;60776.392236077074;60895;60966;1269.3716610277972;1327.8141060251573;1378.8069670246173;1382.7994940733538;1395.672017075966;34200;35018;35192.824035879654;35196.47205291872;35426.291474169855;52253;52674.736626316626;52737;52796.73601632121;52820;425390;427223;427556;428530;428641;36137.27725445424;41605.79197103995;41935.790321048196;42156.36765448582;45359.7732011351;50094.24858627051;50412.49587504078;50424;51007.744961274955;51709.7414512925;42457.5754242466;42921.35617965795;43279.68357421801;43788.34317485177;43858.342124867515;42531.1493770129;42627.57372426236;43127.784361078;43778.34332484951;43836.12327753363;42482.36276455794;42770.78614606907;42948.35577466403;43038.35442468428;44704.55295447004;35090.649093508735;37009.81495092507;37489;38187;39282.803585981885;28742.856285718437;29193.416131677674;29478.11565653034;29582.260443489085;29649.25876853096 21:53:32 INFO - PROCESS | 19695 | |2;jquery.html;387.142479408111;389.48198895468994;396.35196453798034;405.0440959335967;410.7268666336886;13018.553556804383;18966.90516547417;20166;20446.89776551119;20485;14670.973031887745;15253.084814911086;18963.62072758544;19308.3242086527;19683.5079123022;5753.798617048405;5777.306723193223;5914.053751399777;5920.555958303123;5923.111533270023;5646.57650676201;5732.111522713986;5765.6540607563475;5768.048272035109;5774.07614781635;4130;5715.971420142914;5719.399463056381;5721.170430287606;6168;6447.742090316382;6546.93453065468;6548.93451065488;6559.048937904001;6559.3112723164095;5509.146082357241;5697.9715101424645;5740.8851822963725;5744.310682718059;5750.137479378085;22485;22575.774242257532;22896.19863304793;23446.765532344627;23473.882630586737;2410.481746424527;2465.593177125772;2580.187241019073;2622.318197268724;2907.8031871119024;14816.703665926729;14858;14969.476068337555;14994.62513437162;15015.249237538079;1941.3205378117545;1958.4614231086423;1991.850611204151;2014.1238561225914;2026.827719643832;80015;83127.16872831255;83372.99999999939;83914;84654;10235.539400726986;10437.373757574418;10715.517801698943;10818.837717434244;10930.289531180448;14753.188574628284;14831.84938183979;14846;14856.702865942836;14859.777103343458;8013.158618345106;8200.138985406566;8398.118197589287;8568.400211985101;8589.26991205742;8038.437309388287;8290.709825156091;8390.077091519928;8552.144785521397;8566.914330856736;6453.580517266362;6567.408933195939;6626.204855417284;6711.395974362331;6736.027147114943;1953.1796645408963;1989.5821877405906;1991.7809041005478;2003.5592169722638;2023.4132101690639;961.8605302231277;1055.6305293147336;1085.6363118355282;1093.3741526350343;1097.8517900083546;19706.8029319705;19743.901280493505;19784.70322945157;19909.701354479694;19990.400287991382;1048.85840411545;1055.1084333737979;1058.2750815691122;1058.809414305417;1071.5713714514256;10711.12820487206;11241.550337986553;11253.156013299036;11328.886711132947;11429.142814288962;512256;514304;516775;519361;522529;54069;73552.63223683847;75245.24754752492;86728.56635716907;90814.54592726994;988.4958671077802;999.1457304005116;1024.1243736605245;1025.3181634213313;1062.9309094908806;13729;16460.588485287964;16551.586210344838;16653.50039498817;17153.914230428767;31122;36274.8186259067;40897.77306680804;42708.359374608786;44171.11657766891;56025.15962260651;58159.418405817094;58380.4161958375;59984;60124;8027;8112.581140676734;8187.877181842158;8242.381821363302;8518.70184543538;12386.81419778686;13080.411381488046;13147.474101036234;13222.272774997467;13308.667283317995;5670.546356291569;7546.9245307546225;11686.590969316034;11955.76088478243;12269.386530673251;11749.00133488663;11827.763444731228;11886.702832429259;11965.521379144737;12092.576759813715;11736.471858766205;11858.16992810495;11861.644150675493;11959.521619135137;12396.938015309866;7378.594177320084;7662.157162711986;7743.45795794289;8532.274756645755;8785.472871627722;8581.95709021451;11395.715107122389;11466.598669046543;11470.655880323604;11517.25137866036 21:53:32 INFO - PROCESS | 19695 | |3;mootools.html;1478.6894752102062;1499.8200215974084;1690.8140104588501;1807.674618568657;1843.557546188915;8185.918140818598;8860.379773415863;8934.731958041253;8936.64253429862;8960.955195224024;7692.230776922305;8323.126071762468;8488.745337639864;8513;9073.36486445949;2353.376355265856;2374.7625237476286;2386.9283921482383;2387.033251533132;2387.689600351952;2372.572936871371;2384.451576137481;2430.1008626808107;2432.343267317823;2433.0632706408073;2045.948851278715;2115.936521904345;2291.5875142474347;2358.9646155307682;2364.7635236476385;2408.8915998780008;2409.361519197414;2419.733829278778;2423.6364545318165;2424.2969538833718;2365.5150694107665;2366.503034362786;2368.336865677613;2369.668246445499;2372.2645979746335;8968.730938071803;9102.18080372763;9155.587998540082;9180.357374983754;9187.724368268962;5261.552768014723;5395.946040539584;5399.514043736082;5409.891802163935;5412.621116521845;3472.2013936794424;3480.9825950870336;3616.150204701893;3630.455431685242;3653.963460365389;1094.7591529863416;1104.447776111944;1125.1336470917347;1130.5816847766296;1139.5783560082739;12345.13584049117;12350.258984460961;12361.32012739299;12444.191127576769;12473;4599.770011499411;4682.9531704683195;4831.492693267227;4869.756512174377;4873.731944743073;10426.947865260625;10486.737831554272;10499.212559058102;10503.05472507478;10519.421431821323;5435;5446.782128714886;5457.20870473787;5457.372402173722;5461.563074953994;4922.778474968635;4973.2540118981715;4984.252362145708;5010.799568017312;5015.824446144367;4038.757674539537;4112.362583799516;4116;4183.030770206534;4204;1156.1271240213584;1302.0755263762835;1303.7653222420056;1326.8739469750358;1333.2667033131738;806.2099142839933;925.3661242049218;966.1497881863914;969.1084202533686;1004.5479534209488;5732.684702341411;5865.296164460292;5956.344802071769;5964.075568286922;5998.700064996733;911.4115910813322;975.9707208783748;981.8772653418323;996.1781530237583;1013.690824298596;4124.628783409507;4155.792210389468;4173.373993900939;4193.098483825992;4198.160367926427;10550.788984220273;10926.836097458545;11060.834087488694;11061.446927653586;11081.390523521284;9745.269104817167;11006;11014.39420831862;11020.779584408267;11025.724356890982;7828.099768526578;8153.103158652543;8178.223068808454;8360.163983601713;8365.372597055246;5914.497267732291;6067.029275315928;6123.8162855114415;6200.689965501797;6334.081558174131;9964.10323070927;10126.987301269814;10183.79632407333;10192.13366863825;10288.537015834156;10421.478926053818;10527.94736026315;10530.684079477627;10539.683809485728;10573.735656608646;7592;7791.961040194763;7894.486858354188;7945.1657575953695;8020.077691065602;8618.181272779077;8634.740957771277;8671.826563468821;8683.305335573014;8689.261412779731;7910.327622152182;8024.558649274346;8120.796980075545;8161.877571836309;8192.918070819454;7838;7877.8818317724135;7969.362451004022;7989.041315042232;8002.799930001564;6957.304269573002;6967.581945083109;7021.262767409348;7030.859382812418;7058.435325173871;4932.704037757602;5077.3145625341585;5085.135526960352;5088.363954505687;5113.769880355468;5109.182530795055;5139.691618502902;5159.355080614923;5206.843794686166;5314.734263286743 21:53:32 INFO - PROCESS | 19695 | |4;prototype.html;318.1124662192483;325.46298607297956;325.8403382342651;332.46473178183123;333.66133374624775;5388.784448622056;5466.699331536764;5472.179173124034;5477.835664930049;5493.2034854946005;5384.138537833947;5390.924494069782;5426.321709786277;5453.64551304166;5460.918086228699;4172.70791044627;4249.107687385653;4267.935980960296;4290.163418133465;4301.849435269766;4170.687198460112;4184.560621134783;4253.851115210969;4258.318669012959;4264.87205383839;4189;4192.308269135589;4205.642520385771;4216.430781844458;4233.555476674951;4022.617851304136;4152.8131234094535;4166.0626359068965;4179.749215047107;4219.493660760713;3348.6270629041974;3635.581908080578;3636.9636303637153;3643.362411577963;3652.5982141964364;5226.163813789775;5232.529072383504;5238.60710446718;5249.816256431045;5252.921206181911;4551.613112885409;4667.579917807379;4668.229742092551;4669.41632295963;4743.383360163157;5545.390007099216;5562.805301814457;5565.3599836018975;5585.273914391144;5620.634658747168;4090.713650044498;4092.9972156821473;4094.303968325362;4094.303968325392;4113.095119073799;5706.942930570683;5835.533157347402;5844.123381492767;5920.2895652521975;5935.287765468128;4183.205191013698;4187.864189263498;4190.16196760643;4191.161767646483;4200.348945913388;4227.51383590891;4252.425922500484;4253.383259427427;4257.446531950888;4257.595528424795;4606.825259558791;4811.326414302001;4818.71087734737;4821.818654429687;4829.106615276185;5556.13879848616;5584.804531841366;5596.524295434852;5628.311506548019;5638.830835074954;1408.9084209526347;1429.3782204740971;1443.0403781485195;1447.5657302809116;1450.158907833475;902.0502435345957;929.7210836748948;937.864009718587;939.1219210038636;958.1951161024633;4853.587445067138;4862.343583616237;4868.853934381974;4895.339129217581;4904.675737550841;5115.897682046339;5119.641625086283;5127.743882634554;5152.716600587004;5179.2749015137915;4681.812727490862;4787.853057962704;4882.633802464758;4909.576222895392;4946.925796113062;2709.647745793034;2709.6883858356146;2735.9863200683867;2752.4495100979884;2760.6687197536426;5281.468374171447;5305.787768489295;5317.776911310343;5349.411564727877;5350.732463376816;4883.316335713003;5162.5095615916425;5234.685918844882;5244.475552444725;5283.524482796567;5171.2501687255135;5258.184981327824;5275.180062878301;5322.2548843161985;5339.813106541253;5022.673526220784;5059.659190314644;5089.262057001788;5144.536991670768;5170.793168273377;5085.923711144262;5396.78412863481;5780.468175933297;5794.62334948227;5796.913046304225;6037.15479832815;6054.7275372607455;6075.210222671201;6082.665453400105;6116.633002019893;4050.23045621331;4132.173565287015;4138.627523522898;4153.522344930372;4153.667706583406;5813.157092221689;5815.975692639719;5856.531477481706;5887.969605318966;5914.112883067574;5658.801941932013;5693.829185124453;5693.886122277614;5742.483176514133;5769.653820770767;5550.555955523468;5708.57185711065;5720.3707592164;5720.427957204246;5732.656040637575;5542.168674698827;5551.807036220751;5574.526165275997;5606.299212598426;5627.718614069198;5665.49010589049;5732.742026608896;5757.136429535436;5764.510016648632;5775.48020678141;5359.3032905722;5583.776648934159;5610.831675049755;5646.2942132233475;5671.574631902541 21:53:32 INFO - PROCESS | 19695 | |5;yui.html;768.258630421643;768.5471579145959;821.4332110843513;839.24048735894;842.9452085614435;15617.375304987801;17000.82999170008;17013.91493042533;17448.56378590536;17913;16984.49046528603;17012.149392530388;17126.743098853527;17149.742753858704;17152.82847171528;681.0363335879724;818.8198596308803;836.7364280251732;837.5226121110969;837.7905523619095;804.1877703519458;830.1490971753971;830.3689196210893;839.6515446089866;840.865461526156;875.9605817738185;882.5940067568926;886.0076714080207;886.2688282167205;886.5833058462513;697.7174244431013;856.6744637037885;881.5063564403922;882.1972005475019;883.8409086364452;629.2480485819448;633.379288297471;635.8505751148476;635.996820015897;636.226984214182;15161.696766064617;15187.544373668808;15210.315535800915;15225.086494810346;15237.16195609241;14604.634884127876;15057.472988445461;15207.08757474555;15211.087334759839;15259.08445493274;13934.93032534841;14025.859741402659;14095.22476263805;14111.082779619395;14180.574582762534;4676.36869022681;4717.575418212343;4733.219018861883;4845.328361715237;4874.073925954058;69252;89372.10627893703;90855.54572227162;91385.54307228488;94049.99999999932;11991.760164796655;12115;12150.635480935585;12211.572594959134;12616.873831261753;21931.890340548194;21942.122315107536;21973.78026219749;21989.230376937052;21996.120155193934;8651.221390074797;8814.955925220333;8823.823523529622;8831.955840220759;9046.366754327266;4990.251462280615;5022.547970682656;5043.9747801260755;5187.818426355059;5268.236105764643;3562;3695.5195824543175;3702.5742039665784;3703.703703703697;3704.759190652599;595.5563105486353;598.2641351138125;604.8246008657528;611.4435863364317;614.2904944788776;587.3040447070235;591.5918016568554;613.984650383744;619.9039148931832;625.1154616218;9626.90373096274;9866.30935834499;9966.80066398668;9995.950020249853;10329.586816527255;613.9938600613937;627.3162253144095;634.7334119669657;639.2616527910271;690.7375197425047;4572.314152877095;4685.5782979532005;4721.763911804396;4842.927356089591;4843.903121937541;130168;131304;132001;136449;137946;115163.42418288022;119390;119455;120693.39653301677;120898;97221.51389243008;102803.4859825711;102849.48575257076;105773.47113264384;109566.45216773865;9373.484458354857;9381.671641492516;9384.856479736554;9485.193758530602;9648.469334186688;56447.43552564422;56466.435335646114;56498.717506412206;57247.713761430925;58008.709956449944;80308;81562.59218703868;82699.5865020671;86765.56617216874;89887.10112899049;11169.218154729091;11279.379634120201;11315.490802914053;11546.884531154918;11693.298402095901;12286.81569776472;12406.379681015733;12526.248425094524;12573;13163.210207387587;11989.520419183484;12037.458314375699;12240;12429.689257768267;12801.48794048265;10984;11184.94407527957;11257.662270131908;11537.134714896583;11652.708682282671;11444.256123351955;11695.239809412362;11979.04464726329;12064.336461494702;12428.875711242772;9871.062249086326;9899.851502227617;10170.542325595514;10445.738856528647;10546.578136874747;9956.402615843073;10219.540120694735;10271.383716977005;10278.897211027794;10280.17758579297 21:53:32 INFO - PROCESS | 19695 | __end_tp_report 21:53:32 INFO - PROCESS | 19695 | __start_cc_report 21:53:32 INFO - PROCESS | 19695 | _x_x_mozilla_cycle_collect,796 21:53:32 INFO - PROCESS | 19695 | __end_cc_report 21:53:32 INFO - PROCESS | 19695 | __startTimestamp1468990412616__endTimestamp 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | ------- Summary: start ------- 21:53:32 INFO - PROCESS | 19695 | Number of tests: 6 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | [#0] dojo.html Cycles:165 Average:5323.97 Median:5518.03 stddev:611.82 (11.1%) stddev-sans-first:586.21 21:53:32 INFO - PROCESS | 19695 | Values: 3012.4 3016.4 3052.7 3060.9 3064.1 5267.6 5330.3 5338.9 5360.6 5395.9 5309.3 5319.8 5329.2 5361.6 5361.9 4799.0 4884.5 4896.0 4910.1 5027.9 4936.0 4947.8 4983.6 5000.2 5010.4 4847.5 4849.9 4856.7 4876.1 4889.2 4834.1 4837.3 4902.4 4911.0 4955.4 4874.7 4880.0 4897.3 4899.2 4951.4 5240.6 5266.1 5337.4 5380.7 5405.8 5742.0 5759.8 5766.9 5768.0 5771.2 5628.5 5736.3 5788.8 5792.8 5798.2 5352.4 5407.7 5410.2 5477.3 5478.8 6000.6 6015.9 6019.3 6020.1 6022.8 5429.8 5526.6 5611.5 5613.0 5620.7 5601.5 5751.1 5753.1 5759.3 5763.3 5599.9 5639.2 5646.0 5649.8 5691.1 5601.6 5627.6 5629.0 5669.0 5670.1 4331.2 4342.0 4347.8 4374.3 4378.3 3858.2 3877.2 3894.9 3918.9 3920.2 5211.5 5326.4 5363.5 5388.6 5466.6 5792.8 5811.1 5811.6 5816.2 5854.4 5417.8 5437.3 5442.5 5447.3 5478.9 4858.0 4910.3 4946.8 4948.6 5003.3 5902.6 5908.9 5915.7 5924.1 5929.2 5778.2 5784.9 5792.7 5793.5 5796.4 5745.2 5850.1 5897.4 5901.2 5933.1 5592.9 5653.2 5653.8 5663.7 5664.4 5515.0 5729.0 5730.1 5748.4 5753.8 5548.4 5592.9 5599.0 5603.9 5639.6 5610.4 5637.2 5646.9 5649.2 5652.6 5332.8 5471.2 5525.3 5563.5 5569.0 5601.1 5631.2 5631.7 5666.7 5697.2 5504.4 5512.2 5515.9 5518.0 5520.2 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | [#1] ext.html Cycles:180 Average:63027.98 Median:42046.08 stddev:123494.18 (293.7%) stddev-sans-first:123751.69 21:53:32 INFO - PROCESS | 19695 | Values: 609.0 629.1 642.5 643.0 653.7 33626.8 44596.3 45509.0 45704.8 45713.8 46647.3 47010.5 47018.5 47030.3 47133.3 7807.8 7891.3 7913.4 7917.9 7987.0 10899.7 11192.5 11197.6 11199.8 11203.6 11109.4 11209.8 11212.0 11227.9 11231.7 8124.0 10729.1 10902.3 10980.5 10981.7 10575.0 10909.9 10915.3 10916.1 10924.5 44054.6 44345.3 44358.1 44478.0 44514.8 3614.2 3671.1 3686.8 3756.4 4305.6 33831.7 33913.0 34384.5 34398.0 35434.1 4436.7 4531.6 4606.8 4643.7 4690.9 358779.0 359440.0 359743.0 360029.0 360770.0 60311.4 60643.4 60761.0 60933.4 61133.7 63203.0 63402.7 63545.0 63598.0 63611.4 16913.7 17208.4 17215.1 17217.7 17228.1 12167.0 12333.4 12345.8 12362.9 12689.2 17563.7 17650.0 17718.6 17727.1 17835.6 6330.3 6360.0 6389.8 6486.3 6552.4 988.8 1045.1 1086.3 1158.3 1167.4 33583.8 34011.7 34172.3 34197.7 34411.0 1121.2 1150.1 1151.1 1158.8 1172.6 17627.1 17637.1 17706.2 17764.8 17932.6 577634.0 579492.0 584607.0 584926.0 585266.0 60371.4 60567.0 60776.4 60895.0 60966.0 1269.4 1327.8 1378.8 1382.8 1395.7 34200.0 35018.0 35192.8 35196.5 35426.3 52253.0 52674.7 52737.0 52796.7 52820.0 425390.0 427223.0 427556.0 428530.0 428641.0 36137.3 41605.8 41935.8 42156.4 45359.8 50094.2 50412.5 50424.0 51007.7 51709.7 42457.6 42921.4 43279.7 43788.3 43858.3 42531.1 42627.6 43127.8 43778.3 43836.1 42482.4 42770.8 42948.4 43038.4 44704.6 35090.6 37009.8 37489.0 38187.0 39282.8 28742.9 29193.4 29478.1 29582.3 29649.3 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | [#2] jquery.html Cycles:180 Average:29361.21 Median:2522.89 stddev:84868.12 (3363.9%) stddev-sans-first:85078.31 21:53:32 INFO - PROCESS | 19695 | Values: 387.1 389.5 396.4 405.0 410.7 13018.6 18966.9 20166.0 20446.9 20485.0 14671.0 15253.1 18963.6 19308.3 19683.5 5753.8 5777.3 5914.1 5920.6 5923.1 5646.6 5732.1 5765.7 5768.0 5774.1 4130.0 5716.0 5719.4 5721.2 6168.0 6447.7 6546.9 6548.9 6559.0 6559.3 5509.1 5698.0 5740.9 5744.3 5750.1 22485.0 22575.8 22896.2 23446.8 23473.9 2410.5 2465.6 2580.2 2622.3 2907.8 14816.7 14858.0 14969.5 14994.6 15015.2 1941.3 1958.5 1991.9 2014.1 2026.8 80015.0 83127.2 83373.0 83914.0 84654.0 10235.5 10437.4 10715.5 10818.8 10930.3 14753.2 14831.8 14846.0 14856.7 14859.8 8013.2 8200.1 8398.1 8568.4 8589.3 8038.4 8290.7 8390.1 8552.1 8566.9 6453.6 6567.4 6626.2 6711.4 6736.0 1953.2 1989.6 1991.8 2003.6 2023.4 961.9 1055.6 1085.6 1093.4 1097.9 19706.8 19743.9 19784.7 19909.7 19990.4 1048.9 1055.1 1058.3 1058.8 1071.6 10711.1 11241.6 11253.2 11328.9 11429.1 512256.0 514304.0 516775.0 519361.0 522529.0 54069.0 73552.6 75245.2 86728.6 90814.5 988.5 999.1 1024.1 1025.3 1062.9 13729.0 16460.6 16551.6 16653.5 17153.9 31122.0 36274.8 40897.8 42708.4 44171.1 56025.2 58159.4 58380.4 59984.0 60124.0 8027.0 8112.6 8187.9 8242.4 8518.7 12386.8 13080.4 13147.5 13222.3 13308.7 5670.5 7546.9 11686.6 11955.8 12269.4 11749.0 11827.8 11886.7 11965.5 12092.6 11736.5 11858.2 11861.6 11959.5 12396.9 7378.6 7662.2 7743.5 8532.3 8785.5 8582.0 11395.7 11466.6 11470.7 11517.3 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | [#3] mootools.html Cycles:180 Average:5883.00 Median:4927.74 stddev:3313.93 (67.3%) stddev-sans-first:3306.70 21:53:32 INFO - PROCESS | 19695 | Values: 1478.7 1499.8 1690.8 1807.7 1843.6 8185.9 8860.4 8934.7 8936.6 8961.0 7692.2 8323.1 8488.7 8513.0 9073.4 2353.4 2374.8 2386.9 2387.0 2387.7 2372.6 2384.5 2430.1 2432.3 2433.1 2045.9 2115.9 2291.6 2359.0 2364.8 2408.9 2409.4 2419.7 2423.6 2424.3 2365.5 2366.5 2368.3 2369.7 2372.3 8968.7 9102.2 9155.6 9180.4 9187.7 5261.6 5395.9 5399.5 5409.9 5412.6 3472.2 3481.0 3616.2 3630.5 3654.0 1094.8 1104.4 1125.1 1130.6 1139.6 12345.1 12350.3 12361.3 12444.2 12473.0 4599.8 4683.0 4831.5 4869.8 4873.7 10426.9 10486.7 10499.2 10503.1 10519.4 5435.0 5446.8 5457.2 5457.4 5461.6 4922.8 4973.3 4984.3 5010.8 5015.8 4038.8 4112.4 4116.0 4183.0 4204.0 1156.1 1302.1 1303.8 1326.9 1333.3 806.2 925.4 966.1 969.1 1004.5 5732.7 5865.3 5956.3 5964.1 5998.7 911.4 976.0 981.9 996.2 1013.7 4124.6 4155.8 4173.4 4193.1 4198.2 10550.8 10926.8 11060.8 11061.4 11081.4 9745.3 11006.0 11014.4 11020.8 11025.7 7828.1 8153.1 8178.2 8360.2 8365.4 5914.5 6067.0 6123.8 6200.7 6334.1 9964.1 10127.0 10183.8 10192.1 10288.5 10421.5 10527.9 10530.7 10539.7 10573.7 7592.0 7792.0 7894.5 7945.2 8020.1 8618.2 8634.7 8671.8 8683.3 8689.3 7910.3 8024.6 8120.8 8161.9 8192.9 7838.0 7877.9 7969.4 7989.0 8002.8 6957.3 6967.6 7021.3 7030.9 7058.4 4932.7 5077.3 5085.1 5088.4 5113.8 5109.2 5139.7 5159.4 5206.8 5314.7 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | [#4] prototype.html Cycles:180 Average:4627.94 Median:5166.65 stddev:1351.93 (26.2%) stddev-sans-first:1316.46 21:53:32 INFO - PROCESS | 19695 | Values: 318.1 325.5 325.8 332.5 333.7 5388.8 5466.7 5472.2 5477.8 5493.2 5384.1 5390.9 5426.3 5453.6 5460.9 4172.7 4249.1 4267.9 4290.2 4301.8 4170.7 4184.6 4253.9 4258.3 4264.9 4189.0 4192.3 4205.6 4216.4 4233.6 4022.6 4152.8 4166.1 4179.7 4219.5 3348.6 3635.6 3637.0 3643.4 3652.6 5226.2 5232.5 5238.6 5249.8 5252.9 4551.6 4667.6 4668.2 4669.4 4743.4 5545.4 5562.8 5565.4 5585.3 5620.6 4090.7 4093.0 4094.3 4094.3 4113.1 5706.9 5835.5 5844.1 5920.3 5935.3 4183.2 4187.9 4190.2 4191.2 4200.3 4227.5 4252.4 4253.4 4257.4 4257.6 4606.8 4811.3 4818.7 4821.8 4829.1 5556.1 5584.8 5596.5 5628.3 5638.8 1408.9 1429.4 1443.0 1447.6 1450.2 902.1 929.7 937.9 939.1 958.2 4853.6 4862.3 4868.9 4895.3 4904.7 5115.9 5119.6 5127.7 5152.7 5179.3 4681.8 4787.9 4882.6 4909.6 4946.9 2709.6 2709.7 2736.0 2752.4 2760.7 5281.5 5305.8 5317.8 5349.4 5350.7 4883.3 5162.5 5234.7 5244.5 5283.5 5171.3 5258.2 5275.2 5322.3 5339.8 5022.7 5059.7 5089.3 5144.5 5170.8 5085.9 5396.8 5780.5 5794.6 5796.9 6037.2 6054.7 6075.2 6082.7 6116.6 4050.2 4132.2 4138.6 4153.5 4153.7 5813.2 5816.0 5856.5 5888.0 5914.1 5658.8 5693.8 5693.9 5742.5 5769.7 5550.6 5708.6 5720.4 5720.4 5732.7 5542.2 5551.8 5574.5 5606.3 5627.7 5665.5 5732.7 5757.1 5764.5 5775.5 5359.3 5583.8 5610.8 5646.3 5671.6 21:53:32 INFO - PROCESS | 19695 | 21:53:32 INFO - PROCESS | 19695 | [#5] yui.html Cycles:180 Average:23061.34 Median:4719.67 stddev:35375.33 (749.5%) stddev-sans-first:35434.96 21:53:32 INFO - PROCESS | 19695 | Values: 768.3 768.5 821.4 839.2 842.9 15617.4 17000.8 17013.9 17448.6 17913.0 16984.5 17012.1 17126.7 17149.7 17152.8 681.0 818.8 836.7 837.5 837.8 804.2 830.1 830.4 839.7 840.9 876.0 882.6 886.0 886.3 886.6 697.7 856.7 881.5 882.2 883.8 629.2 633.4 635.9 636.0 636.2 15161.7 15187.5 15210.3 15225.1 15237.2 14604.6 15057.5 15207.1 15211.1 15259.1 13934.9 14025.9 14095.2 14111.1 14180.6 4676.4 4717.6 4733.2 4845.3 4874.1 69252.0 89372.1 90855.5 91385.5 94050.0 11991.8 12115.0 12150.6 12211.6 12616.9 21931.9 21942.1 21973.8 21989.2 21996.1 8651.2 8815.0 8823.8 8832.0 9046.4 4990.3 5022.5 5044.0 5187.8 5268.2 3562.0 3695.5 3702.6 3703.7 3704.8 595.6 598.3 604.8 611.4 614.3 587.3 591.6 614.0 619.9 625.1 9626.9 9866.3 9966.8 9996.0 10329.6 614.0 627.3 634.7 639.3 690.7 4572.3 4685.6 4721.8 4842.9 4843.9 130168.0 131304.0 132001.0 136449.0 137946.0 115163.4 119390.0 119455.0 120693.4 120898.0 97221.5 102803.5 102849.5 105773.5 109566.5 9373.5 9381.7 9384.9 9485.2 9648.5 56447.4 56466.4 56498.7 57247.7 58008.7 80308.0 81562.6 82699.6 86765.6 89887.1 11169.2 11279.4 11315.5 11546.9 11693.3 12286.8 12406.4 12526.2 12573.0 13163.2 11989.5 12037.5 12240.0 12429.7 12801.5 10984.0 11184.9 11257.7 11537.1 11652.7 11444.3 11695.2 11979.0 12064.3 12428.9 9871.1 9899.9 10170.5 10445.7 10546.6 9956.4 10219.5 10271.4 10278.9 10280.2 21:53:32 INFO - PROCESS | 19695 | -------- Summary: end -------- 21:53:32 INFO - PROCESS | 19695 | 21:53:33 INFO - TEST-INFO | 19695: exit 0 21:53:33 INFO - TEST-OK | dromaeo_css | took 1114431ms 21:53:33 INFO - TEST-START | kraken 21:53:33 INFO - operating with platform_type : linux_ 21:53:33 INFO - Initialising browser for kraken test... 21:53:33 INFO - TEST-INFO | started process 19889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcNzHN/profile http://localhost:53725/getInfo.html) 21:53:37 INFO - PROCESS | 19889 | __metrics Screen width/height:1600/1200 21:53:37 INFO - PROCESS | 19889 | colorDepth:24 21:53:37 INFO - PROCESS | 19889 | Browser inner width/height: 1024/697 21:53:37 INFO - PROCESS | 19889 | __metrics 21:53:38 INFO - PROCESS | 19889 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:53:38 INFO - PROCESS | 19889 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:53:39 INFO - TEST-INFO | 19889: exit 0 21:53:39 INFO - Browser initialized. 21:53:39 INFO - Running cycle 1/1 for kraken test... 21:53:39 INFO - TEST-INFO | started process 19970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcNzHN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:53:51 INFO - PROCESS | 19970 | RSS: Main: 157327360 21:53:51 INFO - PROCESS | 19970 | 21:53:53 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53725/tests/kraken/driver.html?testName=audio-beat-detection) 21:53:54 INFO - PROCESS | 19970 | RSS: Main: 217300992 21:53:54 INFO - PROCESS | 19970 | 21:53:57 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53725/tests/kraken/driver.html?testName=audio-dft) 21:53:57 INFO - PROCESS | 19970 | RSS: Main: 205242368 21:53:57 INFO - PROCESS | 19970 | 21:54:01 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53725/tests/kraken/driver.html?testName=audio-fft) 21:54:01 INFO - PROCESS | 19970 | RSS: Main: 269856768 21:54:01 INFO - PROCESS | 19970 | 21:54:03 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53725/tests/kraken/driver.html?testName=audio-oscillator) 21:54:04 INFO - PROCESS | 19970 | RSS: Main: 180817920 21:54:04 INFO - PROCESS | 19970 | 21:54:06 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53725/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:07 INFO - PROCESS | 19970 | RSS: Main: 185765888 21:54:07 INFO - PROCESS | 19970 | 21:54:10 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53725/tests/kraken/driver.html?testName=imaging-darkroom) 21:54:10 INFO - PROCESS | 19970 | RSS: Main: 219766784 21:54:10 INFO - PROCESS | 19970 | 21:54:13 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53725/tests/kraken/driver.html?testName=imaging-desaturate) 21:54:14 INFO - PROCESS | 19970 | RSS: Main: 221265920 21:54:14 INFO - PROCESS | 19970 | 21:54:17 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53725/tests/kraken/driver.html?testName=json-parse-financial) 21:54:17 INFO - PROCESS | 19970 | RSS: Main: 221499392 21:54:17 INFO - PROCESS | 19970 | 21:54:19 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53725/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:54:20 INFO - PROCESS | 19970 | RSS: Main: 210198528 21:54:20 INFO - PROCESS | 19970 | 21:54:21 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:54:22 INFO - PROCESS | 19970 | RSS: Main: 213487616 21:54:22 INFO - PROCESS | 19970 | 21:54:24 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:54:25 INFO - PROCESS | 19970 | RSS: Main: 210227200 21:54:25 INFO - PROCESS | 19970 | 21:54:27 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:28 INFO - PROCESS | 19970 | RSS: Main: 228651008 21:54:28 INFO - PROCESS | 19970 | 21:54:30 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:54:31 INFO - PROCESS | 19970 | RSS: Main: 224575488 21:54:31 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | Cycle 1(1): loaded http://localhost:53725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53725/tests/kraken/driver.html?testName=ai-astar) 21:54:33 INFO - PROCESS | 19970 | RSS: Main: 267001856 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | __start_tp_report 21:54:33 INFO - PROCESS | 19970 | _x_x_mozilla_page_load 21:54:33 INFO - PROCESS | 19970 | _x_x_mozilla_page_load_details 21:54:33 INFO - PROCESS | 19970 | |i|pagename|runs| 21:54:33 INFO - PROCESS | 19970 | |0;ai-astar;105;113;111;112;113;115;114;111;113;114 21:54:33 INFO - PROCESS | 19970 | |1;audio-beat-detection;160;120;124;178;123;118;139;115;160;116 21:54:33 INFO - PROCESS | 19970 | |2;audio-dft;161;159;160;160;160;160;159;161;160;160 21:54:33 INFO - PROCESS | 19970 | |3;audio-fft;74;74;74;112;75;75;74;74;106;74 21:54:33 INFO - PROCESS | 19970 | |4;audio-oscillator;84;83;113;83;83;84;119;83;84;120 21:54:33 INFO - PROCESS | 19970 | |5;imaging-gaussian-blur;116;117;116;116;116;117;117;116;117;117 21:54:33 INFO - PROCESS | 19970 | |6;imaging-darkroom;148;144;145;146;147;145;146;145;146;146 21:54:33 INFO - PROCESS | 19970 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;94 21:54:33 INFO - PROCESS | 19970 | |8;json-parse-financial;54;54;53;53;53;54;53;54;53;53 21:54:33 INFO - PROCESS | 19970 | |9;json-stringify-tinderbox;60;61;61;61;61;61;61;60;61;60 21:54:33 INFO - PROCESS | 19970 | |10;stanford-crypto-aes;76;78;82;75;76;75;74;80;75;79 21:54:33 INFO - PROCESS | 19970 | |11;stanford-crypto-ccm;124;118;128;118;119;125;119;120;154;121 21:54:33 INFO - PROCESS | 19970 | |12;stanford-crypto-pbkdf2;159;157;159;159;157;156;157;158;156;156 21:54:33 INFO - PROCESS | 19970 | |13;stanford-crypto-sha256-iterative;62;67;64;67;63;62;62;67;62;61 21:54:33 INFO - PROCESS | 19970 | __end_tp_report 21:54:33 INFO - PROCESS | 19970 | __start_cc_report 21:54:33 INFO - PROCESS | 19970 | _x_x_mozilla_cycle_collect,1681 21:54:33 INFO - PROCESS | 19970 | __end_cc_report 21:54:33 INFO - PROCESS | 19970 | __startTimestamp1468990473434__endTimestamp 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | ------- Summary: start ------- 21:54:33 INFO - PROCESS | 19970 | Number of tests: 14 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.81 (2.5%) stddev-sans-first:1.36 21:54:33 INFO - PROCESS | 19970 | Values: 105.0 113.0 111.0 112.0 113.0 115.0 114.0 111.0 113.0 114.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:131.50 stddev:22.74 (17.3%) stddev-sans-first:22.29 21:54:33 INFO - PROCESS | 19970 | Values: 160.0 120.0 124.0 178.0 123.0 118.0 139.0 115.0 160.0 116.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 21:54:33 INFO - PROCESS | 19970 | Values: 161.0 159.0 160.0 160.0 160.0 160.0 159.0 161.0 160.0 160.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#3] audio-fft Cycles:10 Average:81.20 Median:74.00 stddev:14.73 (19.9%) stddev-sans-first:15.39 21:54:33 INFO - PROCESS | 19970 | Values: 74.0 74.0 74.0 112.0 75.0 75.0 74.0 74.0 106.0 74.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:16.48 (19.9%) stddev-sans-first:17.11 21:54:33 INFO - PROCESS | 19970 | Values: 84.0 83.0 113.0 83.0 83.0 84.0 119.0 83.0 84.0 120.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:54:33 INFO - PROCESS | 19970 | Values: 116.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.14 (0.8%) stddev-sans-first:0.88 21:54:33 INFO - PROCESS | 19970 | Values: 148.0 144.0 145.0 146.0 147.0 145.0 146.0 145.0 146.0 146.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:54:33 INFO - PROCESS | 19970 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.50 21:54:33 INFO - PROCESS | 19970 | Values: 54.0 54.0 53.0 53.0 53.0 54.0 53.0 54.0 53.0 53.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 21:54:33 INFO - PROCESS | 19970 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 60.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.00 stddev:2.62 (3.4%) stddev-sans-first:2.76 21:54:33 INFO - PROCESS | 19970 | Values: 76.0 78.0 82.0 75.0 76.0 75.0 74.0 80.0 75.0 79.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:122.50 stddev:10.85 (8.9%) stddev-sans-first:11.51 21:54:33 INFO - PROCESS | 19970 | Values: 124.0 118.0 128.0 118.0 119.0 125.0 119.0 120.0 154.0 121.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:157.50 stddev:1.26 (0.8%) stddev-sans-first:1.20 21:54:33 INFO - PROCESS | 19970 | Values: 159.0 157.0 159.0 159.0 157.0 156.0 157.0 158.0 156.0 156.0 21:54:33 INFO - PROCESS | 19970 | 21:54:33 INFO - PROCESS | 19970 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:2.41 (3.8%) stddev-sans-first:2.47 21:54:33 INFO - PROCESS | 19970 | Values: 62.0 67.0 64.0 67.0 63.0 62.0 62.0 67.0 62.0 61.0 21:54:33 INFO - PROCESS | 19970 | -------- Summary: end -------- 21:54:33 INFO - PROCESS | 19970 | 21:54:34 INFO - TEST-INFO | 19970: exit 0 21:54:34 INFO - TEST-OK | kraken | took 60992ms 21:54:34 INFO - SUITE-END | took 1175s 21:54:34 INFO - Completed test suite (00:19:35) 21:54:34 INFO - javascript benchmark 21:54:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3012.367402845403, 3016.351484430847, 3052.6947305269464, 3060.9081727548173, 3064.096091652962, 5267.604929630274, 5330.333708286465, 5338.91991620125, 5360.571154307656, 5395.91906121408, 5309.30978972733, 5319.813806516772, 5329.227262047001, 5361.624686271963, 5361.919571206435, 4799.040191961604, 4884.511548845123, 4895.975520122394, 4910.091633047879, 5027.924581131286, 4935.9753201234125, 4947.8268260610885, 4983.551480366767, 5000.224560983287, 5010.398752149729, 4847.491013443609, 4849.903001939959, 4856.660033797635, 4876.146674332013, 4889.217725163974, 4834.057358815033, 4837.274408838667, 4902.411710594716, 4910.975445122787, 4955.380577427822, 4874.65877388583, 4880.048390563841, 4897.289892965536, 4899.240617704261, 4951.3810773653295, 5240.554552862973, 5266.052110620087, 5337.439568845293, 5380.650257733235, 5405.810796622139, 5742.0238559445, 5759.827205183851, 5766.884662306772, 5768.0, 5771.220885180489, 5628.521575666033, 5736.311642602873, 5788.82633520995, 5792.768289268424, 5798.1592669063175, 5352.384475785257, 5407.702576358299, 5410.242566040757, 5477.3427188737605, 5478.808241711561, 6000.5799594028, 6015.879682406327, 6019.337872833985, 6020.127081573235, 6022.789202377896, 5429.782808687687, 5526.585506086979, 5611.494965453129, 5613.017721898733, 5620.747066382022, 5601.495865372136, 5751.1373294006235, 5753.137029445533, 5759.280089988752, 5763.279590051244, 5599.916001259984, 5639.238702775155, 5646.0, 5649.830505084854, 5691.146328050825, 5601.551875849922, 5627.606067575231, 5629.0, 5669.0, 5670.092785154356, 4331.198728235287, 4341.956580434218, 4347.8260869564865, 4374.256376416017, 4378.2994720845145, 3858.228354329089, 3877.2439374321734, 3894.8831535053428, 3918.9020274493364, 3920.196359746245, 5211.478852114758, 5326.414094449608, 5363.517283444431, 5388.595855310868, 5466.562674985991, 5792.768289268382, 5811.099279611667, 5811.622244554091, 5816.1566572846705, 5854.414558544111, 5417.83746487606, 5437.265969094122, 5442.537384322298, 5447.319085114361, 5478.945210547923, 4858.0, 4910.263460480885, 4946.777395017233, 4948.604111671058, 5003.2995380646735, 5902.6458412495385, 5908.881822363614, 5915.733791979371, 5924.14099955504, 5929.199558059607, 5778.248827652378, 5784.855378615568, 5792.7103644818435, 5793.536517078708, 5796.449337312949, 5745.166950792028, 5850.063989761617, 5897.351291357862, 5901.232839730807, 5933.080372542263, 5592.916106258328, 5653.208550802973, 5653.830385088454, 5663.66018038919, 5664.376918538875, 5514.972425137848, 5729.0, 5730.111832665943, 5748.425157484218, 5753.798617048383, 5548.361938377138, 5592.916106258328, 5599.020171469895, 5603.887922241451, 5639.6334238274385, 5610.410906854885, 5637.238972738792, 5646.9152962704775, 5649.209110724584, 5652.576056795675, 5332.760025798771, 5471.151971444432, 5525.309336332958, 5563.471470210324, 5568.972155139199, 5601.131824567198, 5631.211630371669, 5631.662100273997, 5666.688332141772, 5697.202391665253, 5504.366997795305, 5512.173174023928, 5515.917261241165, 5518.034343989866, 5520.227168196536], "value": 5281.683735474434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.9556410755554, 629.1475051305481, 642.466752595346, 642.9776655118361, 653.7450394346206, 33626.831865840664, 44596.3310550342, 45509.0, 45704.771476142574, 45713.77143114284, 46647.30029049567, 47010.529894701045, 47018.52981470184, 47030.29454558176, 47133.293000604936, 7807.765767026998, 7891.289783919446, 7913.366930645563, 7917.9208207918045, 7986.960065199695, 10899.673009809718, 11192.496337664825, 11197.552097916074, 11199.832002519968, 11203.60787372442, 11109.44452777362, 11209.831852522178, 11212.0, 11227.887721122806, 11231.66305010851, 8123.959380203061, 10729.08802751767, 10902.291351062155, 10980.450977451095, 10981.725456863562, 10575.048245657928, 10909.890901091047, 10915.290506117077, 10916.07213386863, 10924.508397122148, 44054.55945440537, 44345.334819977725, 44358.112837743385, 44478.0, 44514.77742611299, 3614.204874927512, 3671.0822294426393, 3686.8340924658187, 3756.398976163828, 4305.5694430557005, 33831.6616833831, 33913.0, 34384.484232736526, 34398.0, 35434.11414714627, 4436.689431739779, 4531.56950089741, 4606.815727370901, 4643.744594047326, 4690.859274221779, 358779.0, 359440.0, 359743.0, 360029.0, 360770.0, 60311.396886031456, 60643.39356606466, 60761.0, 60933.390666093655, 61133.694331528946, 63202.99571540696, 63402.68298658477, 63545.0, 63598.0, 63611.363886360545, 16913.7462938056, 17208.397706080228, 17215.053172075404, 17217.741733874, 17228.138593070296, 12167.0, 12333.383330833423, 12345.753084938431, 12362.938185309016, 12689.175203611736, 17563.73654395185, 17650.0, 17718.557036073944, 17727.11364431773, 17835.643287134444, 6330.265143565319, 6359.96820015897, 6389.840253993687, 6486.318936511692, 6552.443042341454, 988.8417853143462, 1045.1168762395764, 1086.255914698434, 1158.2529268621693, 1167.4046236419317, 33583.83208083944, 34011.65988340085, 34172.31655366879, 34197.65802341994, 34411.0, 1121.2487633285718, 1150.0684445598924, 1151.073385924322, 1158.8319693644373, 1172.6013155527162, 17627.118644068003, 17637.118144092743, 17706.20322085509, 17764.822351776576, 17932.55168620795, 577634.0, 579492.0, 584607.0, 584926.0, 585266.0, 60371.39628603746, 60567.0, 60776.392236077074, 60895.0, 60966.0, 1269.3716610277972, 1327.8141060251573, 1378.8069670246173, 1382.7994940733538, 1395.672017075966, 34200.0, 35018.0, 35192.824035879654, 35196.47205291872, 35426.291474169855, 52253.0, 52674.736626316626, 52737.0, 52796.73601632121, 52820.0, 425390.0, 427223.0, 427556.0, 428530.0, 428641.0, 36137.27725445424, 41605.79197103995, 41935.790321048196, 42156.36765448582, 45359.7732011351, 50094.24858627051, 50412.49587504078, 50424.0, 51007.744961274955, 51709.7414512925, 42457.5754242466, 42921.35617965795, 43279.68357421801, 43788.34317485177, 43858.342124867515, 42531.1493770129, 42627.57372426236, 43127.784361078, 43778.34332484951, 43836.12327753363, 42482.36276455794, 42770.78614606907, 42948.35577466403, 43038.35442468428, 44704.55295447004, 35090.649093508735, 37009.81495092507, 37489.0, 38187.0, 39282.803585981885, 28742.856285718437, 29193.416131677674, 29478.11565653034, 29582.260443489085, 29649.25876853096], "value": 21310.01522995509, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.142479408111, 389.48198895468994, 396.35196453798034, 405.0440959335967, 410.7268666336886, 13018.553556804383, 18966.90516547417, 20166.0, 20446.89776551119, 20485.0, 14670.973031887745, 15253.084814911086, 18963.62072758544, 19308.3242086527, 19683.5079123022, 5753.798617048405, 5777.306723193223, 5914.053751399777, 5920.555958303123, 5923.111533270023, 5646.57650676201, 5732.111522713986, 5765.6540607563475, 5768.048272035109, 5774.07614781635, 4130.0, 5715.971420142914, 5719.399463056381, 5721.170430287606, 6168.0, 6447.742090316382, 6546.93453065468, 6548.93451065488, 6559.048937904001, 6559.3112723164095, 5509.146082357241, 5697.9715101424645, 5740.8851822963725, 5744.310682718059, 5750.137479378085, 22485.0, 22575.774242257532, 22896.19863304793, 23446.765532344627, 23473.882630586737, 2410.481746424527, 2465.593177125772, 2580.187241019073, 2622.318197268724, 2907.8031871119024, 14816.703665926729, 14858.0, 14969.476068337555, 14994.62513437162, 15015.249237538079, 1941.3205378117545, 1958.4614231086423, 1991.850611204151, 2014.1238561225914, 2026.827719643832, 80015.0, 83127.16872831255, 83372.99999999939, 83914.0, 84654.0, 10235.539400726986, 10437.373757574418, 10715.517801698943, 10818.837717434244, 10930.289531180448, 14753.188574628284, 14831.84938183979, 14846.0, 14856.702865942836, 14859.777103343458, 8013.158618345106, 8200.138985406566, 8398.118197589287, 8568.400211985101, 8589.26991205742, 8038.437309388287, 8290.709825156091, 8390.077091519928, 8552.144785521397, 8566.914330856736, 6453.580517266362, 6567.408933195939, 6626.204855417284, 6711.395974362331, 6736.027147114943, 1953.1796645408963, 1989.5821877405906, 1991.7809041005478, 2003.5592169722638, 2023.4132101690639, 961.8605302231277, 1055.6305293147336, 1085.6363118355282, 1093.3741526350343, 1097.8517900083546, 19706.8029319705, 19743.901280493505, 19784.70322945157, 19909.701354479694, 19990.400287991382, 1048.85840411545, 1055.1084333737979, 1058.2750815691122, 1058.809414305417, 1071.5713714514256, 10711.12820487206, 11241.550337986553, 11253.156013299036, 11328.886711132947, 11429.142814288962, 512256.0, 514304.0, 516775.0, 519361.0, 522529.0, 54069.0, 73552.63223683847, 75245.24754752492, 86728.56635716907, 90814.54592726994, 988.4958671077802, 999.1457304005116, 1024.1243736605245, 1025.3181634213313, 1062.9309094908806, 13729.0, 16460.588485287964, 16551.586210344838, 16653.50039498817, 17153.914230428767, 31122.0, 36274.8186259067, 40897.77306680804, 42708.359374608786, 44171.11657766891, 56025.15962260651, 58159.418405817094, 58380.4161958375, 59984.0, 60124.0, 8027.0, 8112.581140676734, 8187.877181842158, 8242.381821363302, 8518.70184543538, 12386.81419778686, 13080.411381488046, 13147.474101036234, 13222.272774997467, 13308.667283317995, 5670.546356291569, 7546.9245307546225, 11686.590969316034, 11955.76088478243, 12269.386530673251, 11749.00133488663, 11827.763444731228, 11886.702832429259, 11965.521379144737, 12092.576759813715, 11736.471858766205, 11858.16992810495, 11861.644150675493, 11959.521619135137, 12396.938015309866, 7378.594177320084, 7662.157162711986, 7743.45795794289, 8532.274756645755, 8785.472871627722, 8581.95709021451, 11395.715107122389, 11466.598669046543, 11470.655880323604, 11517.25137866036], "value": 9358.867249394261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.6894752102062, 1499.8200215974084, 1690.8140104588501, 1807.674618568657, 1843.557546188915, 8185.918140818598, 8860.379773415863, 8934.731958041253, 8936.64253429862, 8960.955195224024, 7692.230776922305, 8323.126071762468, 8488.745337639864, 8513.0, 9073.36486445949, 2353.376355265856, 2374.7625237476286, 2386.9283921482383, 2387.033251533132, 2387.689600351952, 2372.572936871371, 2384.451576137481, 2430.1008626808107, 2432.343267317823, 2433.0632706408073, 2045.948851278715, 2115.936521904345, 2291.5875142474347, 2358.9646155307682, 2364.7635236476385, 2408.8915998780008, 2409.361519197414, 2419.733829278778, 2423.6364545318165, 2424.2969538833718, 2365.5150694107665, 2366.503034362786, 2368.336865677613, 2369.668246445499, 2372.2645979746335, 8968.730938071803, 9102.18080372763, 9155.587998540082, 9180.357374983754, 9187.724368268962, 5261.552768014723, 5395.946040539584, 5399.514043736082, 5409.891802163935, 5412.621116521845, 3472.2013936794424, 3480.9825950870336, 3616.150204701893, 3630.455431685242, 3653.963460365389, 1094.7591529863416, 1104.447776111944, 1125.1336470917347, 1130.5816847766296, 1139.5783560082739, 12345.13584049117, 12350.258984460961, 12361.32012739299, 12444.191127576769, 12473.0, 4599.770011499411, 4682.9531704683195, 4831.492693267227, 4869.756512174377, 4873.731944743073, 10426.947865260625, 10486.737831554272, 10499.212559058102, 10503.05472507478, 10519.421431821323, 5435.0, 5446.782128714886, 5457.20870473787, 5457.372402173722, 5461.563074953994, 4922.778474968635, 4973.2540118981715, 4984.252362145708, 5010.799568017312, 5015.824446144367, 4038.757674539537, 4112.362583799516, 4116.0, 4183.030770206534, 4204.0, 1156.1271240213584, 1302.0755263762835, 1303.7653222420056, 1326.8739469750358, 1333.2667033131738, 806.2099142839933, 925.3661242049218, 966.1497881863914, 969.1084202533686, 1004.5479534209488, 5732.684702341411, 5865.296164460292, 5956.344802071769, 5964.075568286922, 5998.700064996733, 911.4115910813322, 975.9707208783748, 981.8772653418323, 996.1781530237583, 1013.690824298596, 4124.628783409507, 4155.792210389468, 4173.373993900939, 4193.098483825992, 4198.160367926427, 10550.788984220273, 10926.836097458545, 11060.834087488694, 11061.446927653586, 11081.390523521284, 9745.269104817167, 11006.0, 11014.39420831862, 11020.779584408267, 11025.724356890982, 7828.099768526578, 8153.103158652543, 8178.223068808454, 8360.163983601713, 8365.372597055246, 5914.497267732291, 6067.029275315928, 6123.8162855114415, 6200.689965501797, 6334.081558174131, 9964.10323070927, 10126.987301269814, 10183.79632407333, 10192.13366863825, 10288.537015834156, 10421.478926053818, 10527.94736026315, 10530.684079477627, 10539.683809485728, 10573.735656608646, 7592.0, 7791.961040194763, 7894.486858354188, 7945.1657575953695, 8020.077691065602, 8618.181272779077, 8634.740957771277, 8671.826563468821, 8683.305335573014, 8689.261412779731, 7910.327622152182, 8024.558649274346, 8120.796980075545, 8161.877571836309, 8192.918070819454, 7838.0, 7877.8818317724135, 7969.362451004022, 7989.041315042232, 8002.799930001564, 6957.304269573002, 6967.581945083109, 7021.262767409348, 7030.859382812418, 7058.435325173871, 4932.704037757602, 5077.3145625341585, 5085.135526960352, 5088.363954505687, 5113.769880355468, 5109.182530795055, 5139.691618502902, 5159.355080614923, 5206.843794686166, 5314.734263286743], "value": 4717.448560238402, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.1124662192483, 325.46298607297956, 325.8403382342651, 332.46473178183123, 333.66133374624775, 5388.784448622056, 5466.699331536764, 5472.179173124034, 5477.835664930049, 5493.2034854946005, 5384.138537833947, 5390.924494069782, 5426.321709786277, 5453.64551304166, 5460.918086228699, 4172.70791044627, 4249.107687385653, 4267.935980960296, 4290.163418133465, 4301.849435269766, 4170.687198460112, 4184.560621134783, 4253.851115210969, 4258.318669012959, 4264.87205383839, 4189.0, 4192.308269135589, 4205.642520385771, 4216.430781844458, 4233.555476674951, 4022.617851304136, 4152.8131234094535, 4166.0626359068965, 4179.749215047107, 4219.493660760713, 3348.6270629041974, 3635.581908080578, 3636.9636303637153, 3643.362411577963, 3652.5982141964364, 5226.163813789775, 5232.529072383504, 5238.60710446718, 5249.816256431045, 5252.921206181911, 4551.613112885409, 4667.579917807379, 4668.229742092551, 4669.41632295963, 4743.383360163157, 5545.390007099216, 5562.805301814457, 5565.3599836018975, 5585.273914391144, 5620.634658747168, 4090.713650044498, 4092.9972156821473, 4094.303968325362, 4094.303968325392, 4113.095119073799, 5706.942930570683, 5835.533157347402, 5844.123381492767, 5920.2895652521975, 5935.287765468128, 4183.205191013698, 4187.864189263498, 4190.16196760643, 4191.161767646483, 4200.348945913388, 4227.51383590891, 4252.425922500484, 4253.383259427427, 4257.446531950888, 4257.595528424795, 4606.825259558791, 4811.326414302001, 4818.71087734737, 4821.818654429687, 4829.106615276185, 5556.13879848616, 5584.804531841366, 5596.524295434852, 5628.311506548019, 5638.830835074954, 1408.9084209526347, 1429.3782204740971, 1443.0403781485195, 1447.5657302809116, 1450.158907833475, 902.0502435345957, 929.7210836748948, 937.864009718587, 939.1219210038636, 958.1951161024633, 4853.587445067138, 4862.343583616237, 4868.853934381974, 4895.339129217581, 4904.675737550841, 5115.897682046339, 5119.641625086283, 5127.743882634554, 5152.716600587004, 5179.2749015137915, 4681.812727490862, 4787.853057962704, 4882.633802464758, 4909.576222895392, 4946.925796113062, 2709.647745793034, 2709.6883858356146, 2735.9863200683867, 2752.4495100979884, 2760.6687197536426, 5281.468374171447, 5305.787768489295, 5317.776911310343, 5349.411564727877, 5350.732463376816, 4883.316335713003, 5162.5095615916425, 5234.685918844882, 5244.475552444725, 5283.524482796567, 5171.2501687255135, 5258.184981327824, 5275.180062878301, 5322.2548843161985, 5339.813106541253, 5022.673526220784, 5059.659190314644, 5089.262057001788, 5144.536991670768, 5170.793168273377, 5085.923711144262, 5396.78412863481, 5780.468175933297, 5794.62334948227, 5796.913046304225, 6037.15479832815, 6054.7275372607455, 6075.210222671201, 6082.665453400105, 6116.633002019893, 4050.23045621331, 4132.173565287015, 4138.627523522898, 4153.522344930372, 4153.667706583406, 5813.157092221689, 5815.975692639719, 5856.531477481706, 5887.969605318966, 5914.112883067574, 5658.801941932013, 5693.829185124453, 5693.886122277614, 5742.483176514133, 5769.653820770767, 5550.555955523468, 5708.57185711065, 5720.3707592164, 5720.427957204246, 5732.656040637575, 5542.168674698827, 5551.807036220751, 5574.526165275997, 5606.299212598426, 5627.718614069198, 5665.49010589049, 5732.742026608896, 5757.136429535436, 5764.510016648632, 5775.48020678141, 5359.3032905722, 5583.776648934159, 5610.831675049755, 5646.2942132233475, 5671.574631902541], "value": 4196.067396509306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.258630421643, 768.5471579145959, 821.4332110843513, 839.24048735894, 842.9452085614435, 15617.375304987801, 17000.82999170008, 17013.91493042533, 17448.56378590536, 17913.0, 16984.49046528603, 17012.149392530388, 17126.743098853527, 17149.742753858704, 17152.82847171528, 681.0363335879724, 818.8198596308803, 836.7364280251732, 837.5226121110969, 837.7905523619095, 804.1877703519458, 830.1490971753971, 830.3689196210893, 839.6515446089866, 840.865461526156, 875.9605817738185, 882.5940067568926, 886.0076714080207, 886.2688282167205, 886.5833058462513, 697.7174244431013, 856.6744637037885, 881.5063564403922, 882.1972005475019, 883.8409086364452, 629.2480485819448, 633.379288297471, 635.8505751148476, 635.996820015897, 636.226984214182, 15161.696766064617, 15187.544373668808, 15210.315535800915, 15225.086494810346, 15237.16195609241, 14604.634884127876, 15057.472988445461, 15207.08757474555, 15211.087334759839, 15259.08445493274, 13934.93032534841, 14025.859741402659, 14095.22476263805, 14111.082779619395, 14180.574582762534, 4676.36869022681, 4717.575418212343, 4733.219018861883, 4845.328361715237, 4874.073925954058, 69252.0, 89372.10627893703, 90855.54572227162, 91385.54307228488, 94049.99999999932, 11991.760164796655, 12115.0, 12150.635480935585, 12211.572594959134, 12616.873831261753, 21931.890340548194, 21942.122315107536, 21973.78026219749, 21989.230376937052, 21996.120155193934, 8651.221390074797, 8814.955925220333, 8823.823523529622, 8831.955840220759, 9046.366754327266, 4990.251462280615, 5022.547970682656, 5043.9747801260755, 5187.818426355059, 5268.236105764643, 3562.0, 3695.5195824543175, 3702.5742039665784, 3703.703703703697, 3704.759190652599, 595.5563105486353, 598.2641351138125, 604.8246008657528, 611.4435863364317, 614.2904944788776, 587.3040447070235, 591.5918016568554, 613.984650383744, 619.9039148931832, 625.1154616218, 9626.90373096274, 9866.30935834499, 9966.80066398668, 9995.950020249853, 10329.586816527255, 613.9938600613937, 627.3162253144095, 634.7334119669657, 639.2616527910271, 690.7375197425047, 4572.314152877095, 4685.5782979532005, 4721.763911804396, 4842.927356089591, 4843.903121937541, 130168.0, 131304.0, 132001.0, 136449.0, 137946.0, 115163.42418288022, 119390.0, 119455.0, 120693.39653301677, 120898.0, 97221.51389243008, 102803.4859825711, 102849.48575257076, 105773.47113264384, 109566.45216773865, 9373.484458354857, 9381.671641492516, 9384.856479736554, 9485.193758530602, 9648.469334186688, 56447.43552564422, 56466.435335646114, 56498.717506412206, 57247.713761430925, 58008.709956449944, 80308.0, 81562.59218703868, 82699.5865020671, 86765.56617216874, 89887.10112899049, 11169.218154729091, 11279.379634120201, 11315.490802914053, 11546.884531154918, 11693.298402095901, 12286.81569776472, 12406.379681015733, 12526.248425094524, 12573.0, 13163.210207387587, 11989.520419183484, 12037.458314375699, 12240.0, 12429.689257768267, 12801.48794048265, 10984.0, 11184.94407527957, 11257.662270131908, 11537.134714896583, 11652.708682282671, 11444.256123351955, 11695.239809412362, 11979.04464726329, 12064.336461494702, 12428.875711242772, 9871.062249086326, 9899.851502227617, 10170.542325595514, 10445.738856528647, 10546.578136874747, 9956.402615843073, 10219.540120694735, 10271.383716977005, 10278.897211027794, 10280.17758579297], "value": 7721.84498251401, "unit": "score"}], "name": "dromaeo_css", "value": 7375.92136701849, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 112.0, 113.0, 115.0, 114.0, 111.0, 113.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 120.0, 124.0, 178.0, 123.0, 118.0, 139.0, 115.0, 160.0, 116.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 160.0, 160.0, 159.0, 161.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 112.0, 75.0, 75.0, 74.0, 74.0, 106.0, 74.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 113.0, 83.0, 83.0, 84.0, 119.0, 83.0, 84.0, 120.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 144.0, 145.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 53.0, 54.0, 53.0, 54.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 82.0, 75.0, 76.0, 75.0, 74.0, 80.0, 75.0, 79.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 128.0, 118.0, 119.0, 125.0, 119.0, 120.0, 154.0, 121.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 159.0, 159.0, 157.0, 156.0, 157.0, 158.0, 156.0, 156.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 64.0, 67.0, 63.0, 62.0, 62.0, 67.0, 62.0, 61.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1476.0, "alertThreshold": 2.0}]} 21:54:34 INFO - Return code: 0 21:54:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:54:34 INFO - # TBPL SUCCESS # 21:54:34 INFO - Running post-action listener: _resource_record_post_action 21:54:34 INFO - ##### 21:54:34 INFO - ##### Finished run-tests step (success) 21:54:34 INFO - ##### 21:54:34 INFO - Running post-run listener: _resource_record_post_run 21:54:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 557883392; Read time: 0; Write time: 523020 21:54:34 INFO - TinderboxPrint: CPU usage
13.1% 21:54:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:54:34 INFO - TinderboxPrint: I/O write bytes / time
557,883,392 / 523,020 21:54:34 INFO - TinderboxPrint: CPU idle
8,277.5 (86.9%) 21:54:34 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 21:54:34 INFO - TinderboxPrint: Swap in / out
0 / 0 21:54:34 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 260980736; Read time: 0; Write time: 303692 21:54:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 296902656; Read time: 0; Write time: 219328 21:54:35 INFO - Running post-run listener: _upload_blobber_files 21:54:35 INFO - Blob upload gear active. 21:54:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:54:35 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 21:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:54:35 INFO - (blobuploader) - INFO - Open directory for files ... 21:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:51 INFO - (blobuploader) - INFO - Done attempting. 21:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:52 INFO - (blobuploader) - INFO - Done attempting. 21:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:54:53 INFO - (blobuploader) - INFO - Done attempting. 21:54:53 INFO - (blobuploader) - INFO - Iteration through files over. 21:54:53 INFO - Return code: 0 21:54:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:54:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:54:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8459ffd796a88cdd72162ab802a67764908a5f293ac5f0555a9cfa047c93ba0c2b167ef9e7b1a1aba93d4e5fe596c75332339b5b3682e071ca0d09d75516e627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9884845cea176c0ca3d72c1833f57dd157f984dad446088b715dac3cd526e95eb0c0cd3a56c304c9889c880c08e80c46e64fd5be071efa8756298f869910eaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef4a6253560d05d8e113124c6335d3ac612aa63f411bd352a61735ea18467f41291ec283f17844f51bcaa885d7b1cba660d8f3858f20fe416b7ee16000284b0a"} 21:54:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:54:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:54:53 INFO - Contents: 21:54:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8459ffd796a88cdd72162ab802a67764908a5f293ac5f0555a9cfa047c93ba0c2b167ef9e7b1a1aba93d4e5fe596c75332339b5b3682e071ca0d09d75516e627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9884845cea176c0ca3d72c1833f57dd157f984dad446088b715dac3cd526e95eb0c0cd3a56c304c9889c880c08e80c46e64fd5be071efa8756298f869910eaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef4a6253560d05d8e113124c6335d3ac612aa63f411bd352a61735ea18467f41291ec283f17844f51bcaa885d7b1cba660d8f3858f20fe416b7ee16000284b0a"} 21:54:53 INFO - Running post-run listener: copy_logs_to_upload_dir 21:54:53 INFO - Copying logs to upload dir... 21:54:53 INFO - mkdir: /builds/slave/test/build/upload/logs 21:54:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.810319 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-19 21:54:52.969331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 21:54:52.973364) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836 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/sha512/8459ffd796a88cdd72162ab802a67764908a5f293ac5f0555a9cfa047c93ba0c2b167ef9e7b1a1aba93d4e5fe596c75332339b5b3682e071ca0d09d75516e627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9884845cea176c0ca3d72c1833f57dd157f984dad446088b715dac3cd526e95eb0c0cd3a56c304c9889c880c08e80c46e64fd5be071efa8756298f869910eaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef4a6253560d05d8e113124c6335d3ac612aa63f411bd352a61735ea18467f41291ec283f17844f51bcaa885d7b1cba660d8f3858f20fe416b7ee16000284b0a"} build_url:https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/KVISglf-Sr6XWCLc7JAL3w/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/sha512/8459ffd796a88cdd72162ab802a67764908a5f293ac5f0555a9cfa047c93ba0c2b167ef9e7b1a1aba93d4e5fe596c75332339b5b3682e071ca0d09d75516e627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9884845cea176c0ca3d72c1833f57dd157f984dad446088b715dac3cd526e95eb0c0cd3a56c304c9889c880c08e80c46e64fd5be071efa8756298f869910eaf6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef4a6253560d05d8e113124c6335d3ac612aa63f411bd352a61735ea18467f41291ec283f17844f51bcaa885d7b1cba660d8f3858f20fe416b7ee16000284b0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 21:54:52.998857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:54:52.999212) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468989248.120007-1954874836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 21:54:53.081845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 21:54:53.082187) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 21:54:53.082502) ========= ========= Total master_lag: 0.17 =========