builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1468844276.77 results: success (0) buildid: 20160718023044 builduid: 129cbaccaa354d5aabc322f22abe817a revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.766738) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.767134) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.767428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.804569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.804867) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 05:17:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.1M=0s 2016-07-18 05:17:57 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.943713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.943993) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018977 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:56.993306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 05:17:56.993652) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bc547f508f58108db8b9ad9c2b94f130c07de194 --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 bc547f508f58108db8b9ad9c2b94f130c07de194 --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=e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 05:17:57,733 truncating revision to first 12 chars 2016-07-18 05:17:57,733 Setting DEBUG logging. 2016-07-18 05:17:57,733 attempt 1/10 2016-07-18 05:17:57,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bc547f508f58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 05:17:58,941 unpacking tar archive at: fx-team-bc547f508f58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.529998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 05:17:58.537145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:58.537527) ========= script_repo_revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:58.537911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:58.538181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:17:58.546922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-18 05:17:58.547391) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:59 INFO - MultiFileLogger online at 20160718 05:17:59 in /builds/slave/test 05:17:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:17:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:59 INFO - {'append_to_log': False, 05:17:59 INFO - 'base_work_dir': '/builds/slave/test', 05:17:59 INFO - 'blob_upload_branch': 'Fx-Team', 05:17:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:59 INFO - 'branch': 'Fx-Team', 05:17:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:59 INFO - 'config_files': ('talos/linux_config.py',), 05:17:59 INFO - 'default_actions': ('clobber', 05:17:59 INFO - 'read-buildbot-config', 05:17:59 INFO - 'download-and-extract', 05:17:59 INFO - 'populate-webroot', 05:17:59 INFO - 'create-virtualenv', 05:17:59 INFO - 'install', 05:17:59 INFO - 'run-tests'), 05:17:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:59 INFO - 'download_minidump_stackwalk': True, 05:17:59 INFO - 'download_symbols': 'ondemand', 05:17:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:59 INFO - 'installer_path': 'installer.exe', 05:17:59 INFO - 'log_level': 'info', 05:17:59 INFO - 'log_name': 'talos', 05:17:59 INFO - 'log_to_console': True, 05:17:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:59 INFO - 'opt_config_files': (), 05:17:59 INFO - 'pip_index': False, 05:17:59 INFO - 'sps_profile': False, 05:17:59 INFO - 'sps_profile_interval': 0, 05:17:59 INFO - 'suite': 'dromaeojs-e10s', 05:17:59 INFO - 'system_bits': '32', 05:17:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:59 INFO - 'title': 'talos-linux64-ix-067', 05:17:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:59 INFO - 'use_talos_json': True, 05:17:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:59 INFO - 'work_dir': 'build'} 05:17:59 INFO - ##### 05:17:59 INFO - ##### Running clobber step. 05:17:59 INFO - ##### 05:17:59 INFO - Running pre-action listener: _resource_record_pre_action 05:17:59 INFO - Running main action method: clobber 05:17:59 INFO - rmtree: /builds/slave/test/build 05:17:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:59 INFO - Running post-action listener: _resource_record_post_action 05:17:59 INFO - ##### 05:17:59 INFO - ##### Finished clobber step (success) 05:17:59 INFO - ##### 05:17:59 INFO - ##### 05:17:59 INFO - ##### Running read-buildbot-config step. 05:17:59 INFO - ##### 05:17:59 INFO - Running pre-action listener: _resource_record_pre_action 05:17:59 INFO - Running main action method: read_buildbot_config 05:17:59 INFO - Using buildbot properties: 05:17:59 INFO - { 05:17:59 INFO - "project": "", 05:17:59 INFO - "product": "firefox", 05:17:59 INFO - "script_repo_revision": "production", 05:17:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:17:59 INFO - "repository": "", 05:17:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:17:59 INFO - "buildid": "20160718023044", 05:17:59 INFO - "pgo_build": "True", 05:17:59 INFO - "basedir": "/builds/slave/test", 05:17:59 INFO - "buildnumber": 937, 05:17:59 INFO - "slavename": "talos-linux64-ix-067", 05:17:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:17:59 INFO - "platform": "ubuntu64_hw", 05:17:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:17:59 INFO - "branch": "fx-team", 05:17:59 INFO - "repo_path": "integration/fx-team", 05:17:59 INFO - "revision": "bc547f508f58108db8b9ad9c2b94f130c07de194", 05:17:59 INFO - "stage_platform": "linux64-pgo", 05:17:59 INFO - "builduid": "129cbaccaa354d5aabc322f22abe817a", 05:17:59 INFO - "slavebuilddir": "test" 05:17:59 INFO - } 05:17:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:17:59 INFO - Running post-action listener: _resource_record_post_action 05:17:59 INFO - ##### 05:17:59 INFO - ##### Finished read-buildbot-config step (success) 05:17:59 INFO - ##### 05:17:59 INFO - ##### 05:17:59 INFO - ##### Running download-and-extract step. 05:17:59 INFO - ##### 05:17:59 INFO - Running pre-action listener: _resource_record_pre_action 05:17:59 INFO - Running main action method: download_and_extract 05:17:59 INFO - mkdir: /builds/slave/test/build/tests 05:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:59 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:00 INFO - Downloaded 1361 bytes. 05:18:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:18:00 INFO - Using the following test package requirements: 05:18:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:18:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:18:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'jsshell-linux-x86_64.zip'], 05:18:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:18:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:18:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:18:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:18:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:18:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:00 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:01 INFO - Downloaded 24334234 bytes. 05:18:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:18:03 INFO - Return code: 0 05:18:03 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 05:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:03 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:04 INFO - Downloaded 24334234 bytes. 05:18:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:18:05 INFO - Return code: 0 05:18:05 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')]} 05:18:05 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:06 INFO - Downloaded 14403317 bytes. 05:18:06 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'] 05:18:06 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 05:18:06 INFO - Return code: 0 05:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:06 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/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 05:18:08 INFO - Downloaded 60818167 bytes. 05:18:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:08 INFO - mkdir: /builds/slave/test/properties 05:18:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:08 INFO - Contents: 05:18:08 INFO - build_url:https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:09 INFO - Running post-action listener: _resource_record_post_action 05:18:09 INFO - Running post-action listener: set_extra_try_arguments 05:18:09 INFO - ##### 05:18:09 INFO - ##### Finished download-and-extract step (success) 05:18:09 INFO - ##### 05:18:09 INFO - ##### 05:18:09 INFO - ##### Running populate-webroot step. 05:18:09 INFO - ##### 05:18:09 INFO - Running pre-action listener: _resource_record_pre_action 05:18:09 INFO - Running main action method: populate_webroot 05:18:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:09 INFO - '--tppagecycles', 05:18:09 INFO - '7'], 05:18:09 INFO - 'tests': ['tsvgm']}}, 05:18:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:18:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:18:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['damp', 'tps']}, 05:18:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'tests': ['damp', 'tps']}, 05:18:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['dromaeo_dom']}, 05:18:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['basic_compositor_video']}, 05:18:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:18:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['a11yr', 05:18:09 INFO - 'ts_paint', 05:18:09 INFO - 'tpaint', 05:18:09 INFO - 'sessionrestore', 05:18:09 INFO - 'sessionrestore_no_auto_restore', 05:18:09 INFO - 'tabpaint']}, 05:18:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:18:09 INFO - 'ts_paint', 05:18:09 INFO - 'tpaint', 05:18:09 INFO - 'sessionrestore', 05:18:09 INFO - 'sessionrestore_no_auto_restore', 05:18:09 INFO - 'tabpaint']}, 05:18:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:18:09 INFO - 'ts_paint', 05:18:09 INFO - 'tpaint', 05:18:09 INFO - 'sessionrestore', 05:18:09 INFO - 'sessionrestore_no_auto_restore', 05:18:09 INFO - 'tabpaint']}, 05:18:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:18:09 INFO - 'ts_paint', 05:18:09 INFO - 'tpaint', 05:18:09 INFO - 'sessionrestore', 05:18:09 INFO - 'sessionrestore_no_auto_restore', 05:18:09 INFO - 'tabpaint']}, 05:18:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['a11yr', 05:18:09 INFO - 'ts_paint', 05:18:09 INFO - 'tpaint', 05:18:09 INFO - 'sessionrestore', 05:18:09 INFO - 'sessionrestore_no_auto_restore', 05:18:09 INFO - 'tabpaint']}, 05:18:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['a11yr', 05:18:09 INFO - 'ts_paint', 05:18:09 INFO - 'tpaint', 05:18:09 INFO - 'sessionrestore', 05:18:09 INFO - 'sessionrestore_no_auto_restore', 05:18:09 INFO - 'tabpaint']}, 05:18:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['tsvgx', 05:18:09 INFO - 'tsvgr_opacity', 05:18:09 INFO - 'tart', 05:18:09 INFO - 'tscrollx', 05:18:09 INFO - 'cart']}, 05:18:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:18:09 INFO - 'tsvgr_opacity', 05:18:09 INFO - 'tart', 05:18:09 INFO - 'tscrollx', 05:18:09 INFO - 'cart']}, 05:18:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'talos_options': ['--disable-e10s'], 05:18:09 INFO - 'tests': ['tp5o']}, 05:18:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'tests': ['tp5o']}, 05:18:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'talos_options': ['--disable-e10s', 05:18:09 INFO - '--xperf_path', 05:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:09 INFO - 'tests': ['tp5n']}, 05:18:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:09 INFO - 'talos_options': ['--xperf_path', 05:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:09 INFO - 'tests': ['tp5n']}}, 05:18:09 INFO - 'talos.zip': {'path': '', 05:18:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:09 INFO - Running post-action listener: _resource_record_post_action 05:18:09 INFO - ##### 05:18:09 INFO - ##### Finished populate-webroot step (success) 05:18:09 INFO - ##### 05:18:09 INFO - ##### 05:18:09 INFO - ##### Running create-virtualenv step. 05:18:09 INFO - ##### 05:18:09 INFO - Running pre-action listener: _resource_record_pre_action 05:18:09 INFO - Running main action method: create_virtualenv 05:18:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:18:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:09 INFO - Using real prefix '/usr' 05:18:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:11 INFO - Installing pip.................done. 05:18:11 INFO - Return code: 0 05:18:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:11 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:11 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 05:18:11 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 05:18:11 INFO - Using env: {'DISPLAY': ':0', 05:18:11 INFO - 'HOME': '/home/cltbld', 05:18:11 INFO - 'LANG': 'en_US.UTF-8', 05:18:11 INFO - 'LANGUAGE': 'en_US:en', 05:18:11 INFO - 'LOGNAME': 'cltbld', 05:18:11 INFO - 'MAIL': '/var/mail/cltbld', 05:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:11 INFO - 'MOZ_NO_REMOTE': '1', 05:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:11 INFO - 'NO_EM_RESTART': '1', 05:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:11 INFO - 'PWD': '/builds/slave/test', 05:18:11 INFO - 'SHELL': '/bin/bash', 05:18:11 INFO - 'SHLVL': '1', 05:18:11 INFO - 'TERM': 'linux', 05:18:11 INFO - 'TMOUT': '86400', 05:18:11 INFO - 'USER': 'cltbld', 05:18:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:11 INFO - '_': '/tools/buildbot/bin/python'} 05:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:12 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 05:18:12 INFO - Cleaning up... 05:18:12 INFO - Return code: 0 05:18:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:18:12 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')]} 05:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:12 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')]} 05:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:12 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:12 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 05:18:12 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 05:18:12 INFO - Using env: {'DISPLAY': ':0', 05:18:12 INFO - 'HOME': '/home/cltbld', 05:18:12 INFO - 'LANG': 'en_US.UTF-8', 05:18:12 INFO - 'LANGUAGE': 'en_US:en', 05:18:12 INFO - 'LOGNAME': 'cltbld', 05:18:12 INFO - 'MAIL': '/var/mail/cltbld', 05:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:12 INFO - 'MOZ_NO_REMOTE': '1', 05:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:12 INFO - 'NO_EM_RESTART': '1', 05:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:12 INFO - 'PWD': '/builds/slave/test', 05:18:12 INFO - 'SHELL': '/bin/bash', 05:18:12 INFO - 'SHLVL': '1', 05:18:12 INFO - 'TERM': 'linux', 05:18:12 INFO - 'TMOUT': '86400', 05:18:12 INFO - 'USER': 'cltbld', 05:18:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:12 INFO - '_': '/tools/buildbot/bin/python'} 05:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:12 INFO - Downloading/unpacking psutil>=3.1.1 05:18:12 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 05:18:12 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 05:18:12 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 05:18:12 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 05:18:12 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 05:18:12 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 05:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:14 INFO - Installing collected packages: psutil 05:18:14 INFO - Running setup.py install for psutil 05:18:14 INFO - building 'psutil._psutil_linux' extension 05:18:14 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 05:18:14 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 05:18:14 INFO - building 'psutil._psutil_posix' extension 05:18:14 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 05:18:14 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 05:18:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:14 INFO - Successfully installed psutil 05:18:14 INFO - Cleaning up... 05:18:14 INFO - Return code: 0 05:18:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:14 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:14 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 05:18:14 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 05:18:14 INFO - Using env: {'DISPLAY': ':0', 05:18:14 INFO - 'HOME': '/home/cltbld', 05:18:14 INFO - 'LANG': 'en_US.UTF-8', 05:18:14 INFO - 'LANGUAGE': 'en_US:en', 05:18:14 INFO - 'LOGNAME': 'cltbld', 05:18:14 INFO - 'MAIL': '/var/mail/cltbld', 05:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:14 INFO - 'MOZ_NO_REMOTE': '1', 05:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:14 INFO - 'NO_EM_RESTART': '1', 05:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:14 INFO - 'PWD': '/builds/slave/test', 05:18:14 INFO - 'SHELL': '/bin/bash', 05:18:14 INFO - 'SHLVL': '1', 05:18:14 INFO - 'TERM': 'linux', 05:18:14 INFO - 'TMOUT': '86400', 05:18:14 INFO - 'USER': 'cltbld', 05:18:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:14 INFO - '_': '/tools/buildbot/bin/python'} 05:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:18:15 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 05:18:15 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 05:18:15 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 05:18:15 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 05:18:15 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 05:18:15 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 05:18:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:18:17 INFO - Installing collected packages: mozsystemmonitor 05:18:17 INFO - Running setup.py install for mozsystemmonitor 05:18:17 INFO - Successfully installed mozsystemmonitor 05:18:17 INFO - Cleaning up... 05:18:17 INFO - Return code: 0 05:18:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:17 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 05:18:17 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 05:18:17 INFO - Using env: {'DISPLAY': ':0', 05:18:17 INFO - 'HOME': '/home/cltbld', 05:18:17 INFO - 'LANG': 'en_US.UTF-8', 05:18:17 INFO - 'LANGUAGE': 'en_US:en', 05:18:17 INFO - 'LOGNAME': 'cltbld', 05:18:17 INFO - 'MAIL': '/var/mail/cltbld', 05:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:17 INFO - 'MOZ_NO_REMOTE': '1', 05:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:17 INFO - 'NO_EM_RESTART': '1', 05:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:17 INFO - 'PWD': '/builds/slave/test', 05:18:17 INFO - 'SHELL': '/bin/bash', 05:18:17 INFO - 'SHLVL': '1', 05:18:17 INFO - 'TERM': 'linux', 05:18:17 INFO - 'TMOUT': '86400', 05:18:17 INFO - 'USER': 'cltbld', 05:18:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:17 INFO - '_': '/tools/buildbot/bin/python'} 05:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:18:17 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 05:18:17 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 05:18:17 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 05:18:17 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 05:18:17 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 05:18:17 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 05:18:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:18:19 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 05:18:19 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 05:18:19 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 05:18:19 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 05:18:19 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 05:18:19 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 05:18:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:19 INFO - warning: no files found matching '*.txt' 05:18:19 INFO - no previously-included directories found matching 'build' 05:18:19 INFO - no previously-included directories found matching 'dist' 05:18:19 INFO - no previously-included directories found matching '.git*' 05:18:19 INFO - Installing collected packages: jsonschema, functools32 05:18:19 INFO - Running setup.py install for functools32 05:18:19 INFO - warning: no files found matching '*.txt' 05:18:19 INFO - no previously-included directories found matching 'build' 05:18:19 INFO - no previously-included directories found matching 'dist' 05:18:19 INFO - no previously-included directories found matching '.git*' 05:18:19 INFO - Successfully installed jsonschema functools32 05:18:19 INFO - Cleaning up... 05:18:19 INFO - Return code: 0 05:18:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:19 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')]} 05:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:19 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')]} 05:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:19 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:19 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 05:18:19 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 05:18:19 INFO - Using env: {'DISPLAY': ':0', 05:18:19 INFO - 'HOME': '/home/cltbld', 05:18:19 INFO - 'LANG': 'en_US.UTF-8', 05:18:19 INFO - 'LANGUAGE': 'en_US:en', 05:18:19 INFO - 'LOGNAME': 'cltbld', 05:18:19 INFO - 'MAIL': '/var/mail/cltbld', 05:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:19 INFO - 'MOZ_NO_REMOTE': '1', 05:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:19 INFO - 'NO_EM_RESTART': '1', 05:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:19 INFO - 'PWD': '/builds/slave/test', 05:18:19 INFO - 'SHELL': '/bin/bash', 05:18:19 INFO - 'SHLVL': '1', 05:18:19 INFO - 'TERM': 'linux', 05:18:19 INFO - 'TMOUT': '86400', 05:18:19 INFO - 'USER': 'cltbld', 05:18:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:19 INFO - '_': '/tools/buildbot/bin/python'} 05:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:20 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 05:18:20 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 05:18:20 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 05:18:20 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 05:18:20 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 05:18:20 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 05:18:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18:22 INFO - Downloading docopt-0.6.1.tar.gz 05:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:22 INFO - Running setup.py install for blobuploader 05:18:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:22 INFO - Running setup.py install for requests 05:18:23 INFO - Running setup.py install for docopt 05:18:23 INFO - Successfully installed blobuploader requests docopt 05:18:23 INFO - Cleaning up... 05:18:23 INFO - Return code: 0 05:18:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:23 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:23 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 05:18:23 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 05:18:23 INFO - Using env: {'DISPLAY': ':0', 05:18:23 INFO - 'HOME': '/home/cltbld', 05:18:23 INFO - 'LANG': 'en_US.UTF-8', 05:18:23 INFO - 'LANGUAGE': 'en_US:en', 05:18:23 INFO - 'LOGNAME': 'cltbld', 05:18:23 INFO - 'MAIL': '/var/mail/cltbld', 05:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:23 INFO - 'MOZ_NO_REMOTE': '1', 05:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:23 INFO - 'NO_EM_RESTART': '1', 05:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:23 INFO - 'PWD': '/builds/slave/test', 05:18:23 INFO - 'SHELL': '/bin/bash', 05:18:23 INFO - 'SHLVL': '1', 05:18:23 INFO - 'TERM': 'linux', 05:18:23 INFO - 'TMOUT': '86400', 05:18:23 INFO - 'USER': 'cltbld', 05:18:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:23 INFO - '_': '/tools/buildbot/bin/python'} 05:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:23 INFO - Running setup.py (path:/tmp/pip-1ck3bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:23 INFO - Running setup.py (path:/tmp/pip-dvOhxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:23 INFO - Running setup.py (path:/tmp/pip-ER_Amt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:23 INFO - Running setup.py (path:/tmp/pip-EKIBwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:23 INFO - Running setup.py (path:/tmp/pip-lDQUKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:23 INFO - Running setup.py (path:/tmp/pip-bi_X42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:23 INFO - Running setup.py (path:/tmp/pip-344mzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:24 INFO - Running setup.py (path:/tmp/pip-a1HXwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:24 INFO - Running setup.py (path:/tmp/pip-t7olNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:24 INFO - Running setup.py (path:/tmp/pip-QdKRtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:24 INFO - Running setup.py (path:/tmp/pip-dGT2dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:24 INFO - Running setup.py (path:/tmp/pip-kwO_Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:24 INFO - Running setup.py (path:/tmp/pip-a9VaTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:24 INFO - Running setup.py (path:/tmp/pip-Id2Ze7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:24 INFO - Running setup.py (path:/tmp/pip-gE2Igw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:24 INFO - Running setup.py (path:/tmp/pip-F1VJ96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:24 INFO - Running setup.py (path:/tmp/pip-jrvPPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:24 INFO - Running setup.py install for manifestparser 05:18:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:24 INFO - Running setup.py install for mozcrash 05:18:24 INFO - Running setup.py install for mozdebug 05:18:25 INFO - Running setup.py install for mozdevice 05:18:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Running setup.py install for mozfile 05:18:25 INFO - Running setup.py install for mozhttpd 05:18:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Running setup.py install for mozinfo 05:18:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Running setup.py install for mozInstall 05:18:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Running setup.py install for mozleak 05:18:25 INFO - Running setup.py install for mozlog 05:18:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Running setup.py install for moznetwork 05:18:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:25 INFO - Running setup.py install for mozprocess 05:18:26 INFO - Running setup.py install for mozprofile 05:18:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:26 INFO - Running setup.py install for mozrunner 05:18:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:26 INFO - Running setup.py install for mozscreenshot 05:18:26 INFO - Running setup.py install for moztest 05:18:26 INFO - Running setup.py install for mozversion 05:18:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:26 INFO - Cleaning up... 05:18:26 INFO - Return code: 0 05:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:26 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:26 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 05:18:26 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 05:18:26 INFO - Using env: {'DISPLAY': ':0', 05:18:26 INFO - 'HOME': '/home/cltbld', 05:18:26 INFO - 'LANG': 'en_US.UTF-8', 05:18:26 INFO - 'LANGUAGE': 'en_US:en', 05:18:26 INFO - 'LOGNAME': 'cltbld', 05:18:26 INFO - 'MAIL': '/var/mail/cltbld', 05:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:26 INFO - 'MOZ_NO_REMOTE': '1', 05:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:26 INFO - 'NO_EM_RESTART': '1', 05:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:26 INFO - 'PWD': '/builds/slave/test', 05:18:26 INFO - 'SHELL': '/bin/bash', 05:18:26 INFO - 'SHLVL': '1', 05:18:26 INFO - 'TERM': 'linux', 05:18:26 INFO - 'TMOUT': '86400', 05:18:26 INFO - 'USER': 'cltbld', 05:18:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:26 INFO - '_': '/tools/buildbot/bin/python'} 05:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:26 INFO - Running setup.py (path:/tmp/pip-SActx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:26 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)) 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:26 INFO - Running setup.py (path:/tmp/pip-8C1u0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:26 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)) 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:26 INFO - Running setup.py (path:/tmp/pip-03UtbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:27 INFO - Running setup.py (path:/tmp/pip-HeQ4Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:27 INFO - Running setup.py (path:/tmp/pip-oanQ_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:27 INFO - Running setup.py (path:/tmp/pip-J9xo7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:27 INFO - Running setup.py (path:/tmp/pip-ahVIM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:27 INFO - Running setup.py (path:/tmp/pip-eh0sag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:27 INFO - Running setup.py (path:/tmp/pip-4dk3ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:27 INFO - Running setup.py (path:/tmp/pip-um3YCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:27 INFO - Running setup.py (path:/tmp/pip-0Po0_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:27 INFO - Running setup.py (path:/tmp/pip-vK9AfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:27 INFO - Running setup.py (path:/tmp/pip-myz4VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:27 INFO - Running setup.py (path:/tmp/pip-Kl8Rbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:27 INFO - Running setup.py (path:/tmp/pip-gCaEPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:27 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)) 05:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:27 INFO - Running setup.py (path:/tmp/pip-7wruQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:27 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)) 05:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:28 INFO - Running setup.py (path:/tmp/pip-cTplQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:28 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)) 05:18:28 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)) 05:18:28 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)) 05:18:28 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)) 05:18:28 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)) 05:18:28 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)) 05:18:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:28 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 05:18:28 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 05:18:28 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 05:18:28 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 05:18:28 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 05:18:28 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 05:18:29 INFO - Downloading blessings-1.6.tar.gz 05:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:30 INFO - Installing collected packages: blessings 05:18:30 INFO - Running setup.py install for blessings 05:18:30 INFO - Successfully installed blessings 05:18:30 INFO - Cleaning up... 05:18:30 INFO - Return code: 0 05:18:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:30 INFO - Reading from file tmpfile_stdout 05:18:30 INFO - Current package versions: 05:18:30 INFO - argparse == 1.2.1 05:18:30 INFO - blessings == 1.6 05:18:30 INFO - blobuploader == 1.2.4 05:18:30 INFO - docopt == 0.6.1 05:18:30 INFO - functools32 == 3.2.3-2 05:18:30 INFO - jsonschema == 2.5.1 05:18:30 INFO - manifestparser == 1.1 05:18:30 INFO - mozInstall == 1.12 05:18:30 INFO - mozcrash == 0.17 05:18:30 INFO - mozdebug == 0.1 05:18:30 INFO - mozdevice == 0.48 05:18:30 INFO - mozfile == 1.2 05:18:30 INFO - mozhttpd == 0.7 05:18:30 INFO - mozinfo == 0.9 05:18:30 INFO - mozleak == 0.1 05:18:30 INFO - mozlog == 3.2 05:18:30 INFO - moznetwork == 0.27 05:18:30 INFO - mozprocess == 0.23 05:18:30 INFO - mozprofile == 0.28 05:18:30 INFO - mozrunner == 6.12 05:18:30 INFO - mozscreenshot == 0.1 05:18:30 INFO - mozsystemmonitor == 0.3 05:18:30 INFO - moztest == 0.7 05:18:30 INFO - mozversion == 1.4 05:18:30 INFO - psutil == 3.1.1 05:18:30 INFO - requests == 1.2.3 05:18:30 INFO - wsgiref == 0.1.2 05:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:30 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 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18:30 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 05:18:30 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 05:18:30 INFO - Using env: {'DISPLAY': ':0', 05:18:30 INFO - 'HOME': '/home/cltbld', 05:18:30 INFO - 'LANG': 'en_US.UTF-8', 05:18:30 INFO - 'LANGUAGE': 'en_US:en', 05:18:30 INFO - 'LOGNAME': 'cltbld', 05:18:30 INFO - 'MAIL': '/var/mail/cltbld', 05:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:30 INFO - 'MOZ_NO_REMOTE': '1', 05:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:30 INFO - 'NO_EM_RESTART': '1', 05:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:30 INFO - 'PWD': '/builds/slave/test', 05:18:30 INFO - 'SHELL': '/bin/bash', 05:18:30 INFO - 'SHLVL': '1', 05:18:30 INFO - 'TERM': 'linux', 05:18:30 INFO - 'TMOUT': '86400', 05:18:30 INFO - 'USER': 'cltbld', 05:18:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:30 INFO - '_': '/tools/buildbot/bin/python'} 05:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 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)) 05:18:30 INFO - Cleaning up... 05:18:30 INFO - Return code: 0 05:18:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1998030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c59180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', '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 05:18: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', 'jsonschema'] in /builds/slave/test/build 05:18: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 jsonschema 05:18:30 INFO - Using env: {'DISPLAY': ':0', 05:18:30 INFO - 'HOME': '/home/cltbld', 05:18:30 INFO - 'LANG': 'en_US.UTF-8', 05:18:30 INFO - 'LANGUAGE': 'en_US:en', 05:18:30 INFO - 'LOGNAME': 'cltbld', 05:18:30 INFO - 'MAIL': '/var/mail/cltbld', 05:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:30 INFO - 'MOZ_NO_REMOTE': '1', 05:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:30 INFO - 'NO_EM_RESTART': '1', 05:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:30 INFO - 'PWD': '/builds/slave/test', 05:18:30 INFO - 'SHELL': '/bin/bash', 05:18:30 INFO - 'SHLVL': '1', 05:18:30 INFO - 'TERM': 'linux', 05:18:30 INFO - 'TMOUT': '86400', 05:18:30 INFO - 'USER': 'cltbld', 05:18:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:30 INFO - '_': '/tools/buildbot/bin/python'} 05:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:18:30 INFO - Cleaning up... 05:18:30 INFO - Return code: 0 05:18:30 INFO - Running post-action listener: _resource_record_post_action 05:18:30 INFO - Running post-action listener: _start_resource_monitoring 05:18:30 INFO - Starting resource monitoring. 05:18:30 INFO - ##### 05:18:30 INFO - ##### Finished create-virtualenv step (success) 05:18:30 INFO - ##### 05:18:30 INFO - ##### 05:18:30 INFO - ##### Running install step. 05:18:30 INFO - ##### 05:18:30 INFO - Running pre-action listener: _resource_record_pre_action 05:18:30 INFO - Running main action method: install 05:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:31 INFO - Reading from file tmpfile_stdout 05:18:31 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:31 INFO - Reading from file tmpfile_stdout 05:18:31 INFO - Output received: 05:18:31 INFO - Usage: mozinstall [options] installer 05:18:31 INFO - Options: 05:18:31 INFO - -h, --help show this help message and exit 05:18:31 INFO - -d DEST, --destination=DEST 05:18:31 INFO - Directory to install application into. [default: 05:18:31 INFO - "/builds/slave/test"] 05:18:31 INFO - --app=APP Application being installed. [default: firefox] 05:18:31 INFO - mkdir: /builds/slave/test/build/application 05:18:31 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'] 05:18:31 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 05:18:48 INFO - Reading from file tmpfile_stdout 05:18:48 INFO - Output received: 05:18:48 INFO - /builds/slave/test/build/application/firefox/firefox 05:18:48 INFO - Running post-action listener: _resource_record_post_action 05:18:48 INFO - ##### 05:18:48 INFO - ##### Finished install step (success) 05:18:48 INFO - ##### 05:18:48 INFO - ##### 05:18:48 INFO - ##### Running run-tests step. 05:18:48 INFO - ##### 05:18:48 INFO - Running pre-action listener: _resource_record_pre_action 05:18:48 INFO - Running main action method: run_tests 05:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:48 INFO - Python 2.7.3 05:18:48 INFO - Return code: 0 05:18:48 INFO - grabbing minidump binary from tooltool 05:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:48 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 0x1c573b0>, '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 0x1c582b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c58740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:48 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 05:18:48 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 05:18:48 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 05:18:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:48 INFO - Return code: 0 05:18:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:18:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:18:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:18:48 INFO - Using env: {'DISPLAY': ':0', 05:18:48 INFO - 'HOME': '/home/cltbld', 05:18:48 INFO - 'LANG': 'en_US.UTF-8', 05:18:48 INFO - 'LANGUAGE': 'en_US:en', 05:18:48 INFO - 'LOGNAME': 'cltbld', 05:18:48 INFO - 'MAIL': '/var/mail/cltbld', 05:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:48 INFO - 'MOZ_NO_REMOTE': '1', 05:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:48 INFO - 'NO_EM_RESTART': '1', 05:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:48 INFO - 'PWD': '/builds/slave/test', 05:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:48 INFO - 'SHELL': '/bin/bash', 05:18:48 INFO - 'SHLVL': '1', 05:18:48 INFO - 'TERM': 'linux', 05:18:48 INFO - 'TMOUT': '86400', 05:18:48 INFO - 'USER': 'cltbld', 05:18:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595', 05:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:48 INFO - '_': '/tools/buildbot/bin/python'} 05:18:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:18:48 INFO - mozversion application_buildid: 20160718023044 05:18:48 INFO - mozversion application_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:18:48 INFO - mozversion application_display_name: Nightly 05:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:48 INFO - mozversion application_name: Firefox 05:18:48 INFO - mozversion application_remotingname: firefox 05:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:18:48 INFO - mozversion application_vendor: Mozilla 05:18:48 INFO - mozversion application_version: 50.0a1 05:18:48 INFO - mozversion platform_buildid: 20160718023044 05:18:48 INFO - mozversion platform_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:18:48 INFO - mozversion platform_version: 50.0a1 05:18:48 INFO - using testdate: 1468844328 05:18:48 INFO - actual date: 1468844328 05:18:48 INFO - starting webserver on 'localhost:60321' 05:18:48 INFO - SUITE-START | Running 2 tests 05:18:48 INFO - TEST-START | dromaeo_css 05:18:48 INFO - operating with platform_type : linux_ 05:18:48 INFO - Initialising browser for dromaeo_css test... 05:18:48 INFO - TEST-INFO | started process 11473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeQ0k1/profile http://localhost:60321/getInfo.html) 05:18:51 INFO - PROCESS | 11473 | JavaScript error: , line 0: uncaught exception: undefined 05:18:52 INFO - PROCESS | 11473 | __metrics Screen width/height:1600/1200 05:18:52 INFO - PROCESS | 11473 | colorDepth:24 05:18:52 INFO - PROCESS | 11473 | Browser inner width/height: 1024/697 05:18:52 INFO - PROCESS | 11473 | __metrics 05:18:53 ERROR - PROCESS | 11473 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:18:54 INFO - TEST-INFO | 11473: exit 0 05:18:54 INFO - Browser initialized. 05:18:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:54 INFO - TEST-INFO | started process 11596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeQ0k1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:05 INFO - PROCESS | 11596 | RSS: Main: 168411136 05:19:05 INFO - PROCESS | 11596 | 05:19:55 INFO - PROCESS | 11596 | 1468844395486 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] 05:22:03 INFO - PROCESS | 11596 | Cycle 1(1): loaded http://localhost:60321/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60321/tests/dromaeo/cssquery-ext.html) 05:22:04 INFO - PROCESS | 11596 | RSS: Main: 171986944 05:22:04 INFO - PROCESS | 11596 | 05:25:06 INFO - PROCESS | 11596 | Cycle 1(1): loaded http://localhost:60321/tests/dromaeo/cssquery-ext.html (next: http://localhost:60321/tests/dromaeo/cssquery-jquery.html) 05:25:06 INFO - PROCESS | 11596 | RSS: Main: 169975808 05:25:06 INFO - PROCESS | 11596 | 05:28:08 INFO - PROCESS | 11596 | Cycle 1(1): loaded http://localhost:60321/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60321/tests/dromaeo/cssquery-mootools.html) 05:28:09 INFO - PROCESS | 11596 | RSS: Main: 172785664 05:28:09 INFO - PROCESS | 11596 | 05:31:11 INFO - PROCESS | 11596 | Cycle 1(1): loaded http://localhost:60321/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60321/tests/dromaeo/cssquery-prototype.html) 05:31:11 INFO - PROCESS | 11596 | RSS: Main: 167436288 05:31:11 INFO - PROCESS | 11596 | 05:34:14 INFO - PROCESS | 11596 | Cycle 1(1): loaded http://localhost:60321/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60321/tests/dromaeo/cssquery-yui.html) 05:34:14 INFO - PROCESS | 11596 | RSS: Main: 169472000 05:34:14 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | Cycle 1(1): loaded http://localhost:60321/tests/dromaeo/cssquery-yui.html (next: http://localhost:60321/tests/dromaeo/cssquery-dojo.html) 05:37:17 INFO - PROCESS | 11596 | RSS: Main: 173191168 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | __start_tp_report 05:37:17 INFO - PROCESS | 11596 | _x_x_mozilla_page_load 05:37:17 INFO - PROCESS | 11596 | _x_x_mozilla_page_load_details 05:37:17 INFO - PROCESS | 11596 | |i|pagename|runs| 05:37:17 INFO - PROCESS | 11596 | |0;dojo.html;3108.8756449742014;3145.622525296965;3152.2907345847175;3162.5098109792984;3184.8248346340943;5402.78388864446;5427.91858122128;5449.836504904854;5567.972160139194;5572.749226284816;5353.304070470843;5428.945710542894;5461.617686761928;5467.535259502937;5519.69641669708;4887.560119589228;4935.80256789728;5037.596992240612;5078.339815823938;5124.538791508763;513.6086703609589;4891.266310053485;4930.211166213407;4967.056259310738;5033.924491132636;4923.753812309388;4951.133551628451;4955.959248557807;4962.57818085465;4999.050180465718;4981.252812078181;4995.450500444948;4997.175466048097;5002.1246281900885;5036.622253330978;4899.240617704226;4946.703197808143;4956.925646115311;4986.052649996525;5008.048470790538;5479;5509.889802203974;5511;5516.972415137939;5554.694491802949;5716.485516303511;5867.178594996704;5874.706264686749;5881.617694849821;5938.495227905633;5807.157962095514;5825.38833422493;5902.557308201859;5905.734241959122;5919.970400148015;5459.017376872162;5465.125579907196;5480.287562616834;5503.9174412383445;5507.0637991541535;5788.652680839079;5846.386129456431;6034.125051867454;6038.215032045806;6041.305249896318;5706.9714651426475;5715.8856822864145;5749;5787.623804452697;5798.217240672455;5862.062070068769;5862.794802181988;5871.442212989759;5878.941210587925;5896.498797602166;5690.2033715279895;5816.680082595413;5847.649141051465;5864.2083318752275;5880.029795083763;5830.300363956268;5840.269966254218;5845.181674565564;5892.587518873724;5923.496502797224;4469.061497085583;4481.932771008437;4485.932711009337;4498.257787465097;4524.411826462539;3902.70729695274;3936.8622098226424;3997.300472417315;4004.759714417086;4043.1913617276664;5581.832545023656;5612.466815652507;5637.26715526987;5637.548996080303;5681.119426488901;5826.912596311059;5883.646981181143;5884.205632239678;5901.055831067095;5911.970440147772;5480.26016487777;5532.28080349552;5664;5673.120666296731;5707.229524014205;5038.2190760432195;5145.3568303962;5168.043911876315;5171.50870667286;5227.973860130675;6198.194234749454;6214.564980451415;6229.626222426669;6235.345288744707;6236.469900058455;5636.633618814764;5826.737796799239;5855.707214639337;6007.669578173155;6017.939820601738;6073.119397687222;6090.604110732788;6096.359882212481;6112.169143789283;6133.601315914451;5774;5779;5779.104238842986;5787.594868359174;5788.652680839163;5770.653760774367;5856.238688970407;5883.911741323969;5887.764489420375;5944.286685597756;5796.971015145066;5824.825255242349;5838.678872662044;5840.094785308284;5841.32824725162;5763.049096898964;5789.044807606698;5811.4188581143235;5818.2436283282905;5821.679807610622;5497.175423686479;5528.419515950767;5579.386267510489;5580.5535557156145;5618.606697531297;5752.942470575241;5775.047117225611;5795.739191736467;5855.414458554111;5878.412158784258;5693.174489699053;5698.088305871206;5698.743556539883;5717.313922329181;5732 05:37:17 INFO - PROCESS | 11596 | |1;ext.html;561.2367180634336;598.5092224376011;605.5276884030458;609.4636719686677;620.6679426506817;41495;42762;42795.57204427955;42796.93007674813;47077;43940.560594394046;44268.3359749604;44606.776966115205;44622.77688611553;44850.775746121224;8892.199702026832;9018.503982280972;9059.094090590954;9073.863892041625;9081.95459022704;8920.598573064228;9000.144986226298;9005.729828105135;9012.504312262823;9018.639254429847;9060.003399626035;9073.455592664428;9082.682106126287;9099.818003639923;9125.361224714272;9014.414063085911;9024.548772561346;9054.411463254934;9058.184763371262;9084.227840633554;8670.176333248332;8741.344399170088;8781.912180878173;8792.780180495474;8817.030126686059;41933.790331048454;42364.57635423637;42371;42375.57624423778;42383.788081059705;3610.151614370647;3660.68884144848;3688.8524459021605;3719.088823238324;3753.5683396409217;32440.18899527507;32745.508817367758;32984.83507582471;33675.49486757676;34616;4415.116976604692;4523.570260825217;4532.138893610204;4560.338750881137;4706.576408123286;367696.9999999973;369880;370480;370521;370620;58098.419015809304;58291;58584.707076465194;58612.12081818776;59056.704716476146;32180;32902.83548582242;60467.69766151229;60859.39140608626;61039;17127.48617541451;17385.91307043482;17432.738508922375;17458.388956386465;17483.213255403538;13008.869911300766;13201.273929933754;13210.207387556777;13287.468501259842;13299.66750831237;19562.510937226398;19707.605847882962;19789.406317810488;19906.701399479018;19908.70136947947;7101.431885449152;7114.466415018791;7297.233790452032;7349.112839961473;7427.851442971219;962.841131213356;1025.2823023883311;1138.9829152562718;1155.9942200288945;1158.25871442277;33722.831385843405;33957.830210848784;34054.65945340564;34083.82958085194;34218.82890585531;1100.785346857355;1139.1797905508022;1156.259993604094;1165.9941700291445;1204.2232759869835;17599.912000439916;17878.463646090637;17907.73138402925;17914.91042544779;17917.462476125736;158014;158447.20776396044;159184;160420;160843;60972.390276096674;62289.68855155695;62463.6876815613;62479;62497.37502624915;1313.1727011982389;1365.7200273943818;1376.5870238928283;1384.6884450998646;1386.4939297156466;31978.840105800253;32800.1799955003;32957.835210823796;33473.3267804485;33958.8302058498;53174;53310.73344633252;53343.199852001475;53451;53466;509602;512564;512582;516072;516490;28021.439571208055;28330.433391331644;28467.430651386443;28565;28632;49729.75135124446;50139.24791128209;50729.23906141337;51207.48792512027;51587;43231.35152972645;43355.349669754345;43390.566094338654;44107.338389923534;44659.77670111629;42199;42707.35938960856;42758.78620606877;43065.354019689104;43375;36674.633253667125;41955.37066943937;42486.78756606197;42796.786016069724;43420.56579434165;36086;38549.6145038546;38589.228215434974;39131;39229.80385098056;29007.41985160327;29148.562771558867;29274.56088158722;29588.704112958596;29971.400571988874 05:37:17 INFO - PROCESS | 11596 | |2;jquery.html;374.53183520599254;384.59041121205905;386.9903252418691;387.31831975722724;397.5368695469778;15243.923780381083;16329.428470003551;17624.20691068902;20272.797272027296;20285.59428811423;17610.911945440286;18921.24315027397;19218.135183916722;19234.32679856205;19797;5553.4724201201025;5729.39841316662;5873.794417195399;5912.320083190445;5918.911216331759;3925.3326934421216;5596.972015139939;5832.56255780816;5841.415858414167;5843;5834.387389324123;5910.940890591082;5915.5859089863725;5918.2898052233795;5928.7628494860155;6301.6534090625;6550.148480697502;6573.671316434183;6604;6640.136782218281;5024.673396229234;5305.389880163753;5757.942420575824;5760.135979603051;5818;12950.611481655566;13079.822815946516;13127.803082953764;13291;13306.40121194539;2170.6635471501786;2239.484918468745;2284.6344584866342;2323.314622186459;2324.1633012115626;10041.447720375376;10129.088382045651;10136.746581335452;10457.267991240617;10667.986541278644;1885.9666573827244;1897.6204759048107;1914.8755330903446;1920.3566805120302;1961.5586493039095;76625;81017;81263;91509.54245228798;93038.06961930361;10573.524191411405;10925.890741092646;11011.394373309546;11164.162687798447;11210.719732006602;15385.615229639423;15422.46021389246;15441.768373474408;15453;15528.223588820514;7869.2130786922;8027.959860200662;8138.83722325562;8259.339252859756;8280.213379728915;7583.355414789805;7700.961495192488;7794.8051298716855;7855.489393189425;7875.409344299201;4388.319810429389;4605.148047611203;4735.029318989667;4764.237721964539;4808.783604737725;1717.9656406871793;1815.5370380552874;1915.8754680945694;1989.8507611928874;2012.8993550322718;996.0836030851634;997.7555498902815;1005.4319309590059;1051;1100.9119270458505;19530.511737206685;20028.89985550063;20058.598828023358;20062.890252010962;20110.195592176442;1003.2726273451835;1006.5470538257813;1017.1354348803458;1037.7198156497702;1094.5731164845718;10635.202359823044;11115.610953616746;11164.330140191614;11198.104151667847;11292;441139;447095;447525;500948;548389;90727.54636226776;92282;94809;94834;96481;946.9195118415012;1012.5595366015659;1014.1937159957852;1023.150784848574;1023.4319952426326;17377.47867563975;17469.65060698804;17769;18048.368307109187;18098;42547.3617895738;43061.35407968946;43648;44536.214421774515;44936.550634494546;60961;61930;62596;62733.37266627275;63128.36871631225;8310.958445207736;8592.398532102943;8609.268212201783;8651.134886511298;8707.47755134694;10622.84065738999;12102.576409825613;13470.93264533671;13608.795868061788;13665.795013074612;11588.94205528967;12003.63989080329;12157.81763273534;12187;12386.3187524687;11069;11356.091512679131;11945.940270298594;12030.458629361525;12194.57318993831;11770.234934729215;12029.218100823418;12193.817092743438;12354.567590134302;12410.875891241334;8530.658773648984;8536.530892811963;8647.481151130953;8658.48049117055;8808;10351.482425878827;11740.765184696087;11764.82352764692;12071.456784444545;12124.333161676192 05:37:17 INFO - PROCESS | 11596 | |3;mootools.html;1487.4273404739179;1510.3505492638164;1657.8673706103514;1761.2954818072778;1772.9556761080964;7933.2463415975535;8567.271781898538;8599.828003439943;9175.862362064574;9181.081891810816;8692.000419951708;8926.866097008533;9013.143751343629;9016.413933094344;9019.323550733705;2299.9310020699404;2323.082382458928;2335.311083230451;2339.040993192791;2339.8128149748063;2250.2911582851348;2285.3715228312262;2287.7369102553253;2296.0930432479245;2320.5938960681897;2265.320403878838;2271.5684020036224;2288.485090854561;2297.6668383084443;2310.1798861404213;2245.4835387860803;2253.4929640830846;2254.763249858766;2261.9660705089436;2266.4447210433386;2254.8534345267503;2276.3284830974735;2278.225403362848;2286.6112760830697;2292.6102562564406;8980.506072166094;9011.369204155711;9052.728418147466;9053.411528250708;9069;5093.134167191586;5178.559822415099;5196.142636464979;5198.636095473318;5202.947970520322;3184.1561986073707;3236.304194598149;3339.9833000835083;3367.915802104967;3375.4135556288506;1191.3328536019856;1193.2065176657513;2168.6746987951933;2233.519793244444;2262.1290803040783;12480.375981200903;12524.937375313066;12578.81131783024;12627.43176557048;12654.114212005163;4259.169461954951;4410.735355878657;4419.18245124653;4575.656825738083;4580.267157254823;9775.071368220008;9837.508124593742;9879.506024698736;9887.258455615714;9893.109620134222;5174.663646862942;5174.689518628894;5180.171172612364;5180.9740951295;5183.870403239874;4221.430106935524;4730.739809310521;4833.226683730586;4889.095517329305;4891.51084891508;3680.1535646801385;3722.218334149805;3786.1481166737262;3826.349520581508;3830.482884810515;1086.9239153259355;1091.5633746501305;1097.9451027448595;1107.6621630402644;1107.8449017137607;799.6961154761153;822.9094799572042;875.9562021898879;957.3585697582497;991.8270680781008;5824.155497452845;5915.674637894957;5938.28740551128;5938.435848594377;6025.728842202111;402.32007906638273;405.736271423577;413.56782162640116;1040.505759764106;1055.176961969665;4202.201581699467;4251.404803327537;4254.574542545721;4254.829806807755;4264.829406823692;11028.117750580095;11227.101831853432;11260.493277802518;11290.491927863266;11336.886631133748;11271.267367621078;11273.887261127447;11289.54841806335;11293.491792869341;11307.095432365391;7951.721689740832;8308.83382332362;8319.459235149696;8424.241818236389;8547.059823419419;5905.291365036223;5964.075568286922;5995;6206.286277078013;6370.267419246846;10249.436281004617;10319.690409287734;10441.477926103513;10562.155027597928;10577.31247468912;10526.368417894952;10555.894441055798;10602.628907988183;10689.732756680834;10840.024397804236;6951.652417379212;7730.149683534919;7918.920810791818;7949.602519873867;7991.800204994689;8822.294216462538;8823.514706690938;8826.5586720665;8875.911240887508;8898.243649289883;7466.664000120117;7617.5048621841615;7735.187805280365;7742.458027938215;8046.195380461907;7548.320651141424;7551.395888329031;7568.81077973033;7645.044369453818;7730.304272615492;7337.559746415232;7411.777646670608;7415.666295016845;7425.443091768031;7443.4789564729945;4933.383327084114;5054.09026375256;5181.248718935809;5199.92200116991;5227.059129356752;5238.057149713089;5318.122509785842;5327.840164795062;5338.199270109515;5379.220013098001 05:37:17 INFO - PROCESS | 11596 | |4;prototype.html;321.2434716243247;326.67985374333153;331.59048575009865;332.55769826131245;332.7853534470265;5646.6894320812335;5675.432456754323;5683.788659407437;5689.175069614904;5706.600537962344;5519.31008623922;5528.336599608053;5547.55619550436;5562.360328562217;5579.191017302489;4110.5067391912935;4198.91602167958;4280;4281.507626622932;4325.82696692132;4277.25148099083;4287.121140166259;4296.453276820343;4318.654507639381;4325.956740432587;4257.74453532789;4304.160688665712;4321.891952701176;4329.285667864814;4330.350447432878;4061.2283666103344;4264.50095149617;4280.357946308079;4280.6789490788005;4317.589828966243;3693.9261214775825;3706.870259540903;3709.146896213859;3713.3316003119426;3727.9813600932093;5469.371022332443;5474.534664553517;5492.450754924515;5498.917516237259;5517.751701173457;4822.71063736177;4847.854564363075;4905.583025442842;4915.5084491550915;4931.087748766489;5758.222639943596;5767.682777447239;5818.272715910512;5824.961263557763;5902.881942361171;4081.2245673322273;4084.1831633673087;4095.672346212296;4096.836126554934;4099.795010249476;5897.262842144732;6010.9699451502465;6044.607100538451;6054.062699936022;6060.30306514752;4185;4211.241976444269;4213.2837417639075;4222.218889505451;4237.6821738369745;4283.1433713257475;4300.204462174508;4307.203167414038;4311.116221174651;4321.762303073361;4649.767511624405;4932.704037757674;4936.975315123402;4944.332515110486;4952.702837829742;5852.678102704307;5860.765569377178;5882.55880808941;5923;5932.466078052909;1453.1862157192006;1472.49935022093;1472.580314610331;1476.6603681153395;1477.6822983058694;914.9588268527932;915.7573243090586;946.7491114854569;974.697843668465;983.9606415743433;5702.800401985911;5747.36778954323;5757.827265182052;5797.2173756542325;5806.854828629318;5918.23063001807;5935.317438494542;5965.522758179335;5980.312264089598;6099.451049405575;5541.5843811714285;5699.629524080921;5873.2658417697785;5877.0596704527925;5887.676177810176;3214.9839250803598;3217.790843595159;3225.193701574606;3238.36851813894;3265.934681306408;6121.143039974407;6233.812985610439;6279.717412716439;6286.779962701284;6294.748210071637;6149.754009839646;6193.84515387119;6198.318184999646;6207.751689932352;6229.53278504114;5946.226990491122;6188.721507532172;6192.876142477216;6243.094751261133;6250.1874756282305;6015.578909476295;6027.276726792813;6033.939660603513;6036.577439579188;6040.6979651018155;5921.3782552831335;5969.552283578836;6000.429959153874;6002.909956350571;6016.2479690038745;6006.15913772081;6193.194884664965;6208.379162083756;6224.346443623354;6231.626102433868;4174.457320548309;4190.329547272422;4219.2194444027955;4230.2174097792;4272;5733.8566535836935;5807.186993820784;6074.544409169242;6101.969490152698;6148.815535533941;5875.41245875409;5889.911651325319;5889.970550147222;5911.290645122613;5936.22829032223;5838.824835254949;5854.619449735754;5877.2376982818005;5894.231730480753;5952.315483719428;5561.775289884079;5766.884662306814;5809.970950145392;5812.447817457335;5830.7959221427045;5764.337101233412;5903.586748927705;5917.28992520883;5945.286565612154;5972.492338151305;5458.8362349128;5745.827625171084;5756.16535602327;5759.884802304015;5783.2240524547615 05:37:17 INFO - PROCESS | 11596 | |5;yui.html;730.2514922204742;750.5946788734084;806.201860158443;840.8906842110524;852.9872051919223;13537.323133843305;14321.713565728693;14730.1161930284;14803.629909252275;14810;12791.48834046637;12997.155184912997;13142.408591613377;13370.130941488796;13411.93294033531;788.8304014636838;799.848028874512;800.6197056398222;801.2548330053048;806.2139414071263;689.841336492607;811.7686459359084;818.4598165210962;818.467995802727;821.2772759971217;842.8946381702287;847.7711018025129;849.762066621347;851.1743608699583;851.4805968359327;847.5380917400032;848.0163010907348;848.567230712335;849.562475325208;850.1880703927734;614.8954677704801;621.7481919822434;622.4802290087782;622.5082185073786;622.8691974685322;12963.740725185538;13005.284709340982;13120.86879131206;13131.0808243423;13204.273764942924;14165.575032749033;14344.49794257196;14377.71244575113;14424.278786060655;14504.41982320706;11806.173567850254;11846.348450835201;11944.88055119455;12062.638120856389;12391.876081239252;3876.8255428505504;3895.2988462076814;3912.647861692433;4050.1494686115952;4061.167460670585;77288.61355693241;78883.6055819723;78980;79227;79707.60146199232;10889.128869690407;10949.726256843483;10969.725756856142;11210.04714599252;11711.414429278502;22833.31500055001;22960.196393126495;23174.1889033883;23291.18480853162;23486.882565587064;7651.273129052731;7864;8096.271335579826;8467.237948584658;8697.21725044749;4483.260262056724;4596.563326483979;4693.20215563355;4725.36207611968;4750.904981900343;3421.4354631486026;3533.681968622785;3545.308664810337;3546.91132721684;3553.129483276614;624.7063879976404;630.9179806625109;632.7880160146402;638.1225814505055;638.9073584330339;702.8313204830804;732.827785470414;744.5607091815855;772.0850791811721;802.7792357101844;10009.499525023719;10092.848607270897;10208.744781380376;10236.948815255875;10262.692119236435;641.4131070070927;683.3405763438207;717.6411794102949;762.5196126440308;783.6669415498504;4429.844955426544;4464.687471877002;4598.931016034762;4659.415798628414;5035;98894;102467.48766256121;102534;110020;111373.44313278382;109267.45366273118;109989;113110.43444782724;114065;114065.85934140718;75288.62355688187;96841.51579242059;100465;100847;101036.49481752691;9019.864702029607;9229.016900380988;9340.392874463138;9793.670709605454;9944.403335799876;45672.31491527696;56744.14883776829;56793.43206567881;57283.42716572781;58329;66322;76199.19004049886;76251.23748762663;76295.61852190703;78926.6053669728;12954;13209.801852972021;13391.531296404579;13730.244836533688;14035.087719298213;14220.146791192561;14360.56918292453;14425.278736063365;14495.565133046026;14644.560663180122;13380;13461.932690336485;13741.725165496833;13760.587182384545;13768.724625507233;12728.363581821057;13002.869971300166;13120.671983200496;13357.732845342844;13639.249841258827;11889.762204755683;12711.300878451404;12786.332988459331;13043.34783260852;13934.651633709238;10514.421706806199;11193.554170069543;11392.658220253406;11396.772064558496;11868.584599538975;11575.131865109983;11783.705407364541;11832.645020649394;11955.163138580216;12061.847485213155 05:37:17 INFO - PROCESS | 11596 | __end_tp_report 05:37:17 INFO - PROCESS | 11596 | __start_cc_report 05:37:17 INFO - PROCESS | 11596 | _x_x_mozilla_cycle_collect,346 05:37:17 INFO - PROCESS | 11596 | __end_cc_report 05:37:17 INFO - PROCESS | 11596 | __startTimestamp1468845437732__endTimestamp 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | ------- Summary: start ------- 05:37:17 INFO - PROCESS | 11596 | Number of tests: 6 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | [#0] dojo.html Cycles:165 Average:5435.25 Median:5698.09 stddev:738.24 (13.0%) stddev-sans-first:717.59 05:37:17 INFO - PROCESS | 11596 | Values: 3108.9 3145.6 3152.3 3162.5 3184.8 5402.8 5427.9 5449.8 5568.0 5572.7 5353.3 5428.9 5461.6 5467.5 5519.7 4887.6 4935.8 5037.6 5078.3 5124.5 513.6 4891.3 4930.2 4967.1 5033.9 4923.8 4951.1 4956.0 4962.6 4999.1 4981.3 4995.5 4997.2 5002.1 5036.6 4899.2 4946.7 4956.9 4986.1 5008.0 5479.0 5509.9 5511.0 5517.0 5554.7 5716.5 5867.2 5874.7 5881.6 5938.5 5807.2 5825.4 5902.6 5905.7 5920.0 5459.0 5465.1 5480.3 5503.9 5507.1 5788.7 5846.4 6034.1 6038.2 6041.3 5707.0 5715.9 5749.0 5787.6 5798.2 5862.1 5862.8 5871.4 5878.9 5896.5 5690.2 5816.7 5847.6 5864.2 5880.0 5830.3 5840.3 5845.2 5892.6 5923.5 4469.1 4481.9 4485.9 4498.3 4524.4 3902.7 3936.9 3997.3 4004.8 4043.2 5581.8 5612.5 5637.3 5637.5 5681.1 5826.9 5883.6 5884.2 5901.1 5912.0 5480.3 5532.3 5664.0 5673.1 5707.2 5038.2 5145.4 5168.0 5171.5 5228.0 6198.2 6214.6 6229.6 6235.3 6236.5 5636.6 5826.7 5855.7 6007.7 6017.9 6073.1 6090.6 6096.4 6112.2 6133.6 5774.0 5779.0 5779.1 5787.6 5788.7 5770.7 5856.2 5883.9 5887.8 5944.3 5797.0 5824.8 5838.7 5840.1 5841.3 5763.0 5789.0 5811.4 5818.2 5821.7 5497.2 5528.4 5579.4 5580.6 5618.6 5752.9 5775.0 5795.7 5855.4 5878.4 5693.2 5698.1 5698.7 5717.3 5732.0 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | [#1] ext.html Cycles:180 Average:52897.11 Median:42597.07 stddev:100244.18 (235.3%) stddev-sans-first:100448.38 05:37:17 INFO - PROCESS | 11596 | Values: 561.2 598.5 605.5 609.5 620.7 41495.0 42762.0 42795.6 42796.9 47077.0 43940.6 44268.3 44606.8 44622.8 44850.8 8892.2 9018.5 9059.1 9073.9 9082.0 8920.6 9000.1 9005.7 9012.5 9018.6 9060.0 9073.5 9082.7 9099.8 9125.4 9014.4 9024.5 9054.4 9058.2 9084.2 8670.2 8741.3 8781.9 8792.8 8817.0 41933.8 42364.6 42371.0 42375.6 42383.8 3610.2 3660.7 3688.9 3719.1 3753.6 32440.2 32745.5 32984.8 33675.5 34616.0 4415.1 4523.6 4532.1 4560.3 4706.6 367697.0 369880.0 370480.0 370521.0 370620.0 58098.4 58291.0 58584.7 58612.1 59056.7 32180.0 32902.8 60467.7 60859.4 61039.0 17127.5 17385.9 17432.7 17458.4 17483.2 13008.9 13201.3 13210.2 13287.5 13299.7 19562.5 19707.6 19789.4 19906.7 19908.7 7101.4 7114.5 7297.2 7349.1 7427.9 962.8 1025.3 1139.0 1156.0 1158.3 33722.8 33957.8 34054.7 34083.8 34218.8 1100.8 1139.2 1156.3 1166.0 1204.2 17599.9 17878.5 17907.7 17914.9 17917.5 158014.0 158447.2 159184.0 160420.0 160843.0 60972.4 62289.7 62463.7 62479.0 62497.4 1313.2 1365.7 1376.6 1384.7 1386.5 31978.8 32800.2 32957.8 33473.3 33958.8 53174.0 53310.7 53343.2 53451.0 53466.0 509602.0 512564.0 512582.0 516072.0 516490.0 28021.4 28330.4 28467.4 28565.0 28632.0 49729.8 50139.2 50729.2 51207.5 51587.0 43231.4 43355.3 43390.6 44107.3 44659.8 42199.0 42707.4 42758.8 43065.4 43375.0 36674.6 41955.4 42486.8 42796.8 43420.6 36086.0 38549.6 38589.2 39131.0 39229.8 29007.4 29148.6 29274.6 29588.7 29971.4 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | [#2] jquery.html Cycles:180 Average:28716.73 Median:20279.20 stddev:79240.55 (390.7%) stddev-sans-first:79434.26 05:37:17 INFO - PROCESS | 11596 | Values: 374.5 384.6 387.0 387.3 397.5 15243.9 16329.4 17624.2 20272.8 20285.6 17610.9 18921.2 19218.1 19234.3 19797.0 5553.5 5729.4 5873.8 5912.3 5918.9 3925.3 5597.0 5832.6 5841.4 5843.0 5834.4 5910.9 5915.6 5918.3 5928.8 6301.7 6550.1 6573.7 6604.0 6640.1 5024.7 5305.4 5757.9 5760.1 5818.0 12950.6 13079.8 13127.8 13291.0 13306.4 2170.7 2239.5 2284.6 2323.3 2324.2 10041.4 10129.1 10136.7 10457.3 10668.0 1886.0 1897.6 1914.9 1920.4 1961.6 76625.0 81017.0 81263.0 91509.5 93038.1 10573.5 10925.9 11011.4 11164.2 11210.7 15385.6 15422.5 15441.8 15453.0 15528.2 7869.2 8028.0 8138.8 8259.3 8280.2 7583.4 7701.0 7794.8 7855.5 7875.4 4388.3 4605.1 4735.0 4764.2 4808.8 1718.0 1815.5 1915.9 1989.9 2012.9 996.1 997.8 1005.4 1051.0 1100.9 19530.5 20028.9 20058.6 20062.9 20110.2 1003.3 1006.5 1017.1 1037.7 1094.6 10635.2 11115.6 11164.3 11198.1 11292.0 441139.0 447095.0 447525.0 500948.0 548389.0 90727.5 92282.0 94809.0 94834.0 96481.0 946.9 1012.6 1014.2 1023.2 1023.4 17377.5 17469.7 17769.0 18048.4 18098.0 42547.4 43061.4 43648.0 44536.2 44936.6 60961.0 61930.0 62596.0 62733.4 63128.4 8311.0 8592.4 8609.3 8651.1 8707.5 10622.8 12102.6 13470.9 13608.8 13665.8 11588.9 12003.6 12157.8 12187.0 12386.3 11069.0 11356.1 11945.9 12030.5 12194.6 11770.2 12029.2 12193.8 12354.6 12410.9 8530.7 8536.5 8647.5 8658.5 8808.0 10351.5 11740.8 11764.8 12071.5 12124.3 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | [#3] mootools.html Cycles:180 Average:5863.93 Median:4655.50 stddev:3384.13 (72.7%) stddev-sans-first:3377.65 05:37:17 INFO - PROCESS | 11596 | Values: 1487.4 1510.4 1657.9 1761.3 1773.0 7933.2 8567.3 8599.8 9175.9 9181.1 8692.0 8926.9 9013.1 9016.4 9019.3 2299.9 2323.1 2335.3 2339.0 2339.8 2250.3 2285.4 2287.7 2296.1 2320.6 2265.3 2271.6 2288.5 2297.7 2310.2 2245.5 2253.5 2254.8 2262.0 2266.4 2254.9 2276.3 2278.2 2286.6 2292.6 8980.5 9011.4 9052.7 9053.4 9069.0 5093.1 5178.6 5196.1 5198.6 5202.9 3184.2 3236.3 3340.0 3367.9 3375.4 1191.3 1193.2 2168.7 2233.5 2262.1 12480.4 12524.9 12578.8 12627.4 12654.1 4259.2 4410.7 4419.2 4575.7 4580.3 9775.1 9837.5 9879.5 9887.3 9893.1 5174.7 5174.7 5180.2 5181.0 5183.9 4221.4 4730.7 4833.2 4889.1 4891.5 3680.2 3722.2 3786.1 3826.3 3830.5 1086.9 1091.6 1097.9 1107.7 1107.8 799.7 822.9 876.0 957.4 991.8 5824.2 5915.7 5938.3 5938.4 6025.7 402.3 405.7 413.6 1040.5 1055.2 4202.2 4251.4 4254.6 4254.8 4264.8 11028.1 11227.1 11260.5 11290.5 11336.9 11271.3 11273.9 11289.5 11293.5 11307.1 7951.7 8308.8 8319.5 8424.2 8547.1 5905.3 5964.1 5995.0 6206.3 6370.3 10249.4 10319.7 10441.5 10562.2 10577.3 10526.4 10555.9 10602.6 10689.7 10840.0 6951.7 7730.1 7918.9 7949.6 7991.8 8822.3 8823.5 8826.6 8875.9 8898.2 7466.7 7617.5 7735.2 7742.5 8046.2 7548.3 7551.4 7568.8 7645.0 7730.3 7337.6 7411.8 7415.7 7425.4 7443.5 4933.4 5054.1 5181.2 5199.9 5227.1 5238.1 5318.1 5327.8 5338.2 5379.2 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | [#4] prototype.html Cycles:180 Average:4923.14 Median:5739.84 stddev:1475.04 (25.7%) stddev-sans-first:1438.17 05:37:17 INFO - PROCESS | 11596 | Values: 321.2 326.7 331.6 332.6 332.8 5646.7 5675.4 5683.8 5689.2 5706.6 5519.3 5528.3 5547.6 5562.4 5579.2 4110.5 4198.9 4280.0 4281.5 4325.8 4277.3 4287.1 4296.5 4318.7 4326.0 4257.7 4304.2 4321.9 4329.3 4330.4 4061.2 4264.5 4280.4 4280.7 4317.6 3693.9 3706.9 3709.1 3713.3 3728.0 5469.4 5474.5 5492.5 5498.9 5517.8 4822.7 4847.9 4905.6 4915.5 4931.1 5758.2 5767.7 5818.3 5825.0 5902.9 4081.2 4084.2 4095.7 4096.8 4099.8 5897.3 6011.0 6044.6 6054.1 6060.3 4185.0 4211.2 4213.3 4222.2 4237.7 4283.1 4300.2 4307.2 4311.1 4321.8 4649.8 4932.7 4937.0 4944.3 4952.7 5852.7 5860.8 5882.6 5923.0 5932.5 1453.2 1472.5 1472.6 1476.7 1477.7 915.0 915.8 946.7 974.7 984.0 5702.8 5747.4 5757.8 5797.2 5806.9 5918.2 5935.3 5965.5 5980.3 6099.5 5541.6 5699.6 5873.3 5877.1 5887.7 3215.0 3217.8 3225.2 3238.4 3265.9 6121.1 6233.8 6279.7 6286.8 6294.7 6149.8 6193.8 6198.3 6207.8 6229.5 5946.2 6188.7 6192.9 6243.1 6250.2 6015.6 6027.3 6033.9 6036.6 6040.7 5921.4 5969.6 6000.4 6002.9 6016.2 6006.2 6193.2 6208.4 6224.3 6231.6 4174.5 4190.3 4219.2 4230.2 4272.0 5733.9 5807.2 6074.5 6102.0 6148.8 5875.4 5889.9 5890.0 5911.3 5936.2 5838.8 5854.6 5877.2 5894.2 5952.3 5561.8 5766.9 5810.0 5812.4 5830.8 5764.3 5903.6 5917.3 5945.3 5972.5 5458.8 5745.8 5756.2 5759.9 5783.2 05:37:17 INFO - PROCESS | 11596 | 05:37:17 INFO - PROCESS | 11596 | [#5] yui.html Cycles:180 Average:21222.27 Median:3550.02 stddev:31031.00 (874.1%) stddev-sans-first:31079.90 05:37:17 INFO - PROCESS | 11596 | Values: 730.3 750.6 806.2 840.9 853.0 13537.3 14321.7 14730.1 14803.6 14810.0 12791.5 12997.2 13142.4 13370.1 13411.9 788.8 799.8 800.6 801.3 806.2 689.8 811.8 818.5 818.5 821.3 842.9 847.8 849.8 851.2 851.5 847.5 848.0 848.6 849.6 850.2 614.9 621.7 622.5 622.5 622.9 12963.7 13005.3 13120.9 13131.1 13204.3 14165.6 14344.5 14377.7 14424.3 14504.4 11806.2 11846.3 11944.9 12062.6 12391.9 3876.8 3895.3 3912.6 4050.1 4061.2 77288.6 78883.6 78980.0 79227.0 79707.6 10889.1 10949.7 10969.7 11210.0 11711.4 22833.3 22960.2 23174.2 23291.2 23486.9 7651.3 7864.0 8096.3 8467.2 8697.2 4483.3 4596.6 4693.2 4725.4 4750.9 3421.4 3533.7 3545.3 3546.9 3553.1 624.7 630.9 632.8 638.1 638.9 702.8 732.8 744.6 772.1 802.8 10009.5 10092.8 10208.7 10236.9 10262.7 641.4 683.3 717.6 762.5 783.7 4429.8 4464.7 4598.9 4659.4 5035.0 98894.0 102467.5 102534.0 110020.0 111373.4 109267.5 109989.0 113110.4 114065.0 114065.9 75288.6 96841.5 100465.0 100847.0 101036.5 9019.9 9229.0 9340.4 9793.7 9944.4 45672.3 56744.1 56793.4 57283.4 58329.0 66322.0 76199.2 76251.2 76295.6 78926.6 12954.0 13209.8 13391.5 13730.2 14035.1 14220.1 14360.6 14425.3 14495.6 14644.6 13380.0 13461.9 13741.7 13760.6 13768.7 12728.4 13002.9 13120.7 13357.7 13639.2 11889.8 12711.3 12786.3 13043.3 13934.7 10514.4 11193.6 11392.7 11396.8 11868.6 11575.1 11783.7 11832.6 11955.2 12061.8 05:37:17 INFO - PROCESS | 11596 | -------- Summary: end -------- 05:37:17 INFO - PROCESS | 11596 | 05:37:18 INFO - TEST-INFO | 11596: exit 0 05:37:18 INFO - TEST-OK | dromaeo_css | took 1109785ms 05:37:18 INFO - TEST-START | kraken 05:37:18 INFO - operating with platform_type : linux_ 05:37:18 INFO - Initialising browser for kraken test... 05:37:18 INFO - TEST-INFO | started process 11840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2gS2m/profile http://localhost:60321/getInfo.html) 05:37:21 INFO - PROCESS | 11840 | JavaScript error: , line 0: uncaught exception: undefined 05:37:22 INFO - PROCESS | 11840 | __metrics Screen width/height:1600/1200 05:37:22 INFO - PROCESS | 11840 | colorDepth:24 05:37:22 INFO - PROCESS | 11840 | Browser inner width/height: 1024/697 05:37:22 INFO - PROCESS | 11840 | __metrics 05:37:22 ERROR - PROCESS | 11840 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:37:23 INFO - TEST-INFO | 11840: exit 0 05:37:23 INFO - Browser initialized. 05:37:23 INFO - Running cycle 1/1 for kraken test... 05:37:23 INFO - TEST-INFO | started process 11963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2gS2m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:35 INFO - PROCESS | 11963 | RSS: Main: 168394752 05:37:35 INFO - PROCESS | 11963 | 05:37:38 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60321/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:38 INFO - PROCESS | 11963 | RSS: Main: 173121536 05:37:38 INFO - PROCESS | 11963 | 05:37:41 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60321/tests/kraken/driver.html?testName=audio-dft) 05:37:42 INFO - PROCESS | 11963 | RSS: Main: 172937216 05:37:42 INFO - PROCESS | 11963 | 05:37:45 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60321/tests/kraken/driver.html?testName=audio-fft) 05:37:45 INFO - PROCESS | 11963 | RSS: Main: 167141376 05:37:45 INFO - PROCESS | 11963 | 05:37:47 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60321/tests/kraken/driver.html?testName=audio-oscillator) 05:37:48 INFO - PROCESS | 11963 | RSS: Main: 167776256 05:37:48 INFO - PROCESS | 11963 | 05:37:50 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60321/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:51 INFO - PROCESS | 11963 | RSS: Main: 168517632 05:37:51 INFO - PROCESS | 11963 | 05:37:54 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60321/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:54 INFO - PROCESS | 11963 | RSS: Main: 168857600 05:37:54 INFO - PROCESS | 11963 | 05:37:58 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60321/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:59 INFO - PROCESS | 11963 | RSS: Main: 167063552 05:37:59 INFO - PROCESS | 11963 | 05:38:01 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60321/tests/kraken/driver.html?testName=json-parse-financial) 05:38:02 INFO - PROCESS | 11963 | RSS: Main: 168112128 05:38:02 INFO - PROCESS | 11963 | 05:38:04 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60321/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:04 INFO - PROCESS | 11963 | RSS: Main: 168513536 05:38:04 INFO - PROCESS | 11963 | 05:38:06 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:07 INFO - PROCESS | 11963 | RSS: Main: 169541632 05:38:07 INFO - PROCESS | 11963 | 05:38:09 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:09 INFO - PROCESS | 11963 | RSS: Main: 169791488 05:38:09 INFO - PROCESS | 11963 | 05:38:12 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:13 INFO - PROCESS | 11963 | RSS: Main: 169312256 05:38:13 INFO - PROCESS | 11963 | 05:38:15 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:16 INFO - PROCESS | 11963 | RSS: Main: 168898560 05:38:16 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | Cycle 1(1): loaded http://localhost:60321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60321/tests/kraken/driver.html?testName=ai-astar) 05:38:18 INFO - PROCESS | 11963 | RSS: Main: 169803776 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | __start_tp_report 05:38:18 INFO - PROCESS | 11963 | _x_x_mozilla_page_load 05:38:18 INFO - PROCESS | 11963 | _x_x_mozilla_page_load_details 05:38:18 INFO - PROCESS | 11963 | |i|pagename|runs| 05:38:18 INFO - PROCESS | 11963 | |0;ai-astar;103;113;106;112;110;111;113;110;112;111 05:38:18 INFO - PROCESS | 11963 | |1;audio-beat-detection;149;118;146;168;118;155;148;121;192;118 05:38:18 INFO - PROCESS | 11963 | |2;audio-dft;164;162;161;163;164;165;172;162;162;161 05:38:18 INFO - PROCESS | 11963 | |3;audio-fft;76;76;75;157;76;77;75;76;183;78 05:38:18 INFO - PROCESS | 11963 | |4;audio-oscillator;84;85;165;85;84;85;145;84;84;143 05:38:18 INFO - PROCESS | 11963 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;117;117 05:38:18 INFO - PROCESS | 11963 | |6;imaging-darkroom;147;147;146;147;147;201;147;147;146;146 05:38:18 INFO - PROCESS | 11963 | |7;imaging-desaturate;95;97;96;96;96;96;96;96;96;96 05:38:18 INFO - PROCESS | 11963 | |8;json-parse-financial;54;56;53;55;54;52;53;55;54;54 05:38:18 INFO - PROCESS | 11963 | |9;json-stringify-tinderbox;63;63;63;63;68;63;63;63;64;64 05:38:18 INFO - PROCESS | 11963 | |10;stanford-crypto-aes;75;82;75;77;77;76;76;81;83;85 05:38:18 INFO - PROCESS | 11963 | |11;stanford-crypto-ccm;141;134;131;125;140;127;122;122;155;129 05:38:18 INFO - PROCESS | 11963 | |12;stanford-crypto-pbkdf2;163;160;159;159;161;161;168;159;157;159 05:38:18 INFO - PROCESS | 11963 | |13;stanford-crypto-sha256-iterative;62;65;66;65;65;62;63;67;65;63 05:38:18 INFO - PROCESS | 11963 | __end_tp_report 05:38:18 INFO - PROCESS | 11963 | __start_cc_report 05:38:18 INFO - PROCESS | 11963 | _x_x_mozilla_cycle_collect,904 05:38:18 INFO - PROCESS | 11963 | __end_cc_report 05:38:18 INFO - PROCESS | 11963 | __startTimestamp1468845498468__endTimestamp 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | ------- Summary: start ------- 05:38:18 INFO - PROCESS | 11963 | Number of tests: 14 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:3.21 (2.9%) stddev-sans-first:2.15 05:38:18 INFO - PROCESS | 11963 | Values: 103.0 113.0 106.0 112.0 110.0 111.0 113.0 110.0 112.0 111.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:148.50 stddev:24.94 (16.8%) stddev-sans-first:26.37 05:38:18 INFO - PROCESS | 11963 | Values: 149.0 118.0 146.0 168.0 118.0 155.0 148.0 121.0 192.0 118.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.24 (2.0%) stddev-sans-first:3.43 05:38:18 INFO - PROCESS | 11963 | Values: 164.0 162.0 161.0 163.0 164.0 165.0 172.0 162.0 162.0 161.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:40.06 (52.7%) stddev-sans-first:41.90 05:38:18 INFO - PROCESS | 11963 | Values: 76.0 76.0 75.0 157.0 76.0 77.0 75.0 76.0 183.0 78.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:84.00 stddev:32.67 (38.9%) stddev-sans-first:33.80 05:38:18 INFO - PROCESS | 11963 | Values: 84.0 85.0 165.0 85.0 84.0 85.0 145.0 84.0 84.0 143.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:38:18 INFO - PROCESS | 11963 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:147.00 stddev:17.19 (11.7%) stddev-sans-first:18.13 05:38:18 INFO - PROCESS | 11963 | Values: 147.0 147.0 146.0 147.0 147.0 201.0 147.0 147.0 146.0 146.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 05:38:18 INFO - PROCESS | 11963 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 05:38:18 INFO - PROCESS | 11963 | Values: 54.0 56.0 53.0 55.0 54.0 52.0 53.0 55.0 54.0 54.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.64 05:38:18 INFO - PROCESS | 11963 | Values: 63.0 63.0 63.0 63.0 68.0 63.0 63.0 63.0 64.0 64.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:3.68 (4.7%) stddev-sans-first:3.66 05:38:18 INFO - PROCESS | 11963 | Values: 75.0 82.0 75.0 77.0 77.0 76.0 76.0 81.0 83.0 85.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.50 stddev:10.32 (7.8%) stddev-sans-first:10.49 05:38:18 INFO - PROCESS | 11963 | Values: 141.0 134.0 131.0 125.0 140.0 127.0 122.0 122.0 155.0 129.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.50 stddev:3.06 (1.9%) stddev-sans-first:3.12 05:38:18 INFO - PROCESS | 11963 | Values: 163.0 160.0 159.0 159.0 161.0 161.0 168.0 159.0 157.0 159.0 05:38:18 INFO - PROCESS | 11963 | 05:38:18 INFO - PROCESS | 11963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.70 (2.6%) stddev-sans-first:1.59 05:38:18 INFO - PROCESS | 11963 | Values: 62.0 65.0 66.0 65.0 65.0 62.0 63.0 67.0 65.0 63.0 05:38:18 INFO - PROCESS | 11963 | -------- Summary: end -------- 05:38:18 INFO - PROCESS | 11963 | 05:38:19 INFO - TEST-INFO | 11963: exit 0 05:38:19 INFO - TEST-OK | kraken | took 61046ms 05:38:19 INFO - SUITE-END | took 1170s 05:38:19 INFO - Completed test suite (00:19:30) 05:38:19 INFO - javascript benchmark 05:38:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7319.921930028111, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.8756449742014, 3145.622525296965, 3152.2907345847175, 3162.5098109792984, 3184.8248346340943, 5402.78388864446, 5427.91858122128, 5449.836504904854, 5567.972160139194, 5572.749226284816, 5353.304070470843, 5428.945710542894, 5461.617686761928, 5467.535259502937, 5519.69641669708, 4887.560119589228, 4935.80256789728, 5037.596992240612, 5078.339815823938, 5124.538791508763, 513.6086703609589, 4891.266310053485, 4930.211166213407, 4967.056259310738, 5033.924491132636, 4923.753812309388, 4951.133551628451, 4955.959248557807, 4962.57818085465, 4999.050180465718, 4981.252812078181, 4995.450500444948, 4997.175466048097, 5002.1246281900885, 5036.622253330978, 4899.240617704226, 4946.703197808143, 4956.925646115311, 4986.052649996525, 5008.048470790538, 5479.0, 5509.889802203974, 5511.0, 5516.972415137939, 5554.694491802949, 5716.485516303511, 5867.178594996704, 5874.706264686749, 5881.617694849821, 5938.495227905633, 5807.157962095514, 5825.38833422493, 5902.557308201859, 5905.734241959122, 5919.970400148015, 5459.017376872162, 5465.125579907196, 5480.287562616834, 5503.9174412383445, 5507.0637991541535, 5788.652680839079, 5846.386129456431, 6034.125051867454, 6038.215032045806, 6041.305249896318, 5706.9714651426475, 5715.8856822864145, 5749.0, 5787.623804452697, 5798.217240672455, 5862.062070068769, 5862.794802181988, 5871.442212989759, 5878.941210587925, 5896.498797602166, 5690.2033715279895, 5816.680082595413, 5847.649141051465, 5864.2083318752275, 5880.029795083763, 5830.300363956268, 5840.269966254218, 5845.181674565564, 5892.587518873724, 5923.496502797224, 4469.061497085583, 4481.932771008437, 4485.932711009337, 4498.257787465097, 4524.411826462539, 3902.70729695274, 3936.8622098226424, 3997.300472417315, 4004.759714417086, 4043.1913617276664, 5581.832545023656, 5612.466815652507, 5637.26715526987, 5637.548996080303, 5681.119426488901, 5826.912596311059, 5883.646981181143, 5884.205632239678, 5901.055831067095, 5911.970440147772, 5480.26016487777, 5532.28080349552, 5664.0, 5673.120666296731, 5707.229524014205, 5038.2190760432195, 5145.3568303962, 5168.043911876315, 5171.50870667286, 5227.973860130675, 6198.194234749454, 6214.564980451415, 6229.626222426669, 6235.345288744707, 6236.469900058455, 5636.633618814764, 5826.737796799239, 5855.707214639337, 6007.669578173155, 6017.939820601738, 6073.119397687222, 6090.604110732788, 6096.359882212481, 6112.169143789283, 6133.601315914451, 5774.0, 5779.0, 5779.104238842986, 5787.594868359174, 5788.652680839163, 5770.653760774367, 5856.238688970407, 5883.911741323969, 5887.764489420375, 5944.286685597756, 5796.971015145066, 5824.825255242349, 5838.678872662044, 5840.094785308284, 5841.32824725162, 5763.049096898964, 5789.044807606698, 5811.4188581143235, 5818.2436283282905, 5821.679807610622, 5497.175423686479, 5528.419515950767, 5579.386267510489, 5580.5535557156145, 5618.606697531297, 5752.942470575241, 5775.047117225611, 5795.739191736467, 5855.414458554111, 5878.412158784258, 5693.174489699053, 5698.088305871206, 5698.743556539883, 5717.313922329181, 5732.0], "value": 5386.370974060182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2367180634336, 598.5092224376011, 605.5276884030458, 609.4636719686677, 620.6679426506817, 41495.0, 42762.0, 42795.57204427955, 42796.93007674813, 47077.0, 43940.560594394046, 44268.3359749604, 44606.776966115205, 44622.77688611553, 44850.775746121224, 8892.199702026832, 9018.503982280972, 9059.094090590954, 9073.863892041625, 9081.95459022704, 8920.598573064228, 9000.144986226298, 9005.729828105135, 9012.504312262823, 9018.639254429847, 9060.003399626035, 9073.455592664428, 9082.682106126287, 9099.818003639923, 9125.361224714272, 9014.414063085911, 9024.548772561346, 9054.411463254934, 9058.184763371262, 9084.227840633554, 8670.176333248332, 8741.344399170088, 8781.912180878173, 8792.780180495474, 8817.030126686059, 41933.790331048454, 42364.57635423637, 42371.0, 42375.57624423778, 42383.788081059705, 3610.151614370647, 3660.68884144848, 3688.8524459021605, 3719.088823238324, 3753.5683396409217, 32440.18899527507, 32745.508817367758, 32984.83507582471, 33675.49486757676, 34616.0, 4415.116976604692, 4523.570260825217, 4532.138893610204, 4560.338750881137, 4706.576408123286, 367696.9999999973, 369880.0, 370480.0, 370521.0, 370620.0, 58098.419015809304, 58291.0, 58584.707076465194, 58612.12081818776, 59056.704716476146, 32180.0, 32902.83548582242, 60467.69766151229, 60859.39140608626, 61039.0, 17127.48617541451, 17385.91307043482, 17432.738508922375, 17458.388956386465, 17483.213255403538, 13008.869911300766, 13201.273929933754, 13210.207387556777, 13287.468501259842, 13299.66750831237, 19562.510937226398, 19707.605847882962, 19789.406317810488, 19906.701399479018, 19908.70136947947, 7101.431885449152, 7114.466415018791, 7297.233790452032, 7349.112839961473, 7427.851442971219, 962.841131213356, 1025.2823023883311, 1138.9829152562718, 1155.9942200288945, 1158.25871442277, 33722.831385843405, 33957.830210848784, 34054.65945340564, 34083.82958085194, 34218.82890585531, 1100.785346857355, 1139.1797905508022, 1156.259993604094, 1165.9941700291445, 1204.2232759869835, 17599.912000439916, 17878.463646090637, 17907.73138402925, 17914.91042544779, 17917.462476125736, 158014.0, 158447.20776396044, 159184.0, 160420.0, 160843.0, 60972.390276096674, 62289.68855155695, 62463.6876815613, 62479.0, 62497.37502624915, 1313.1727011982389, 1365.7200273943818, 1376.5870238928283, 1384.6884450998646, 1386.4939297156466, 31978.840105800253, 32800.1799955003, 32957.835210823796, 33473.3267804485, 33958.8302058498, 53174.0, 53310.73344633252, 53343.199852001475, 53451.0, 53466.0, 509602.0, 512564.0, 512582.0, 516072.0, 516490.0, 28021.439571208055, 28330.433391331644, 28467.430651386443, 28565.0, 28632.0, 49729.75135124446, 50139.24791128209, 50729.23906141337, 51207.48792512027, 51587.0, 43231.35152972645, 43355.349669754345, 43390.566094338654, 44107.338389923534, 44659.77670111629, 42199.0, 42707.35938960856, 42758.78620606877, 43065.354019689104, 43375.0, 36674.633253667125, 41955.37066943937, 42486.78756606197, 42796.786016069724, 43420.56579434165, 36086.0, 38549.6145038546, 38589.228215434974, 39131.0, 39229.80385098056, 29007.41985160327, 29148.562771558867, 29274.56088158722, 29588.704112958596, 29971.400571988874], "value": 19979.96878566553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.53183520599254, 384.59041121205905, 386.9903252418691, 387.31831975722724, 397.5368695469778, 15243.923780381083, 16329.428470003551, 17624.20691068902, 20272.797272027296, 20285.59428811423, 17610.911945440286, 18921.24315027397, 19218.135183916722, 19234.32679856205, 19797.0, 5553.4724201201025, 5729.39841316662, 5873.794417195399, 5912.320083190445, 5918.911216331759, 3925.3326934421216, 5596.972015139939, 5832.56255780816, 5841.415858414167, 5843.0, 5834.387389324123, 5910.940890591082, 5915.5859089863725, 5918.2898052233795, 5928.7628494860155, 6301.6534090625, 6550.148480697502, 6573.671316434183, 6604.0, 6640.136782218281, 5024.673396229234, 5305.389880163753, 5757.942420575824, 5760.135979603051, 5818.0, 12950.611481655566, 13079.822815946516, 13127.803082953764, 13291.0, 13306.40121194539, 2170.6635471501786, 2239.484918468745, 2284.6344584866342, 2323.314622186459, 2324.1633012115626, 10041.447720375376, 10129.088382045651, 10136.746581335452, 10457.267991240617, 10667.986541278644, 1885.9666573827244, 1897.6204759048107, 1914.8755330903446, 1920.3566805120302, 1961.5586493039095, 76625.0, 81017.0, 81263.0, 91509.54245228798, 93038.06961930361, 10573.524191411405, 10925.890741092646, 11011.394373309546, 11164.162687798447, 11210.719732006602, 15385.615229639423, 15422.46021389246, 15441.768373474408, 15453.0, 15528.223588820514, 7869.2130786922, 8027.959860200662, 8138.83722325562, 8259.339252859756, 8280.213379728915, 7583.355414789805, 7700.961495192488, 7794.8051298716855, 7855.489393189425, 7875.409344299201, 4388.319810429389, 4605.148047611203, 4735.029318989667, 4764.237721964539, 4808.783604737725, 1717.9656406871793, 1815.5370380552874, 1915.8754680945694, 1989.8507611928874, 2012.8993550322718, 996.0836030851634, 997.7555498902815, 1005.4319309590059, 1051.0, 1100.9119270458505, 19530.511737206685, 20028.89985550063, 20058.598828023358, 20062.890252010962, 20110.195592176442, 1003.2726273451835, 1006.5470538257813, 1017.1354348803458, 1037.7198156497702, 1094.5731164845718, 10635.202359823044, 11115.610953616746, 11164.330140191614, 11198.104151667847, 11292.0, 441139.0, 447095.0, 447525.0, 500948.0, 548389.0, 90727.54636226776, 92282.0, 94809.0, 94834.0, 96481.0, 946.9195118415012, 1012.5595366015659, 1014.1937159957852, 1023.150784848574, 1023.4319952426326, 17377.47867563975, 17469.65060698804, 17769.0, 18048.368307109187, 18098.0, 42547.3617895738, 43061.35407968946, 43648.0, 44536.214421774515, 44936.550634494546, 60961.0, 61930.0, 62596.0, 62733.37266627275, 63128.36871631225, 8310.958445207736, 8592.398532102943, 8609.268212201783, 8651.134886511298, 8707.47755134694, 10622.84065738999, 12102.576409825613, 13470.93264533671, 13608.795868061788, 13665.795013074612, 11588.94205528967, 12003.63989080329, 12157.81763273534, 12187.0, 12386.3187524687, 11069.0, 11356.091512679131, 11945.940270298594, 12030.458629361525, 12194.57318993831, 11770.234934729215, 12029.218100823418, 12193.817092743438, 12354.567590134302, 12410.875891241334, 8530.658773648984, 8536.530892811963, 8647.481151130953, 8658.48049117055, 8808.0, 10351.482425878827, 11740.765184696087, 11764.82352764692, 12071.456784444545, 12124.333161676192], "value": 9142.70264332903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.4273404739179, 1510.3505492638164, 1657.8673706103514, 1761.2954818072778, 1772.9556761080964, 7933.2463415975535, 8567.271781898538, 8599.828003439943, 9175.862362064574, 9181.081891810816, 8692.000419951708, 8926.866097008533, 9013.143751343629, 9016.413933094344, 9019.323550733705, 2299.9310020699404, 2323.082382458928, 2335.311083230451, 2339.040993192791, 2339.8128149748063, 2250.2911582851348, 2285.3715228312262, 2287.7369102553253, 2296.0930432479245, 2320.5938960681897, 2265.320403878838, 2271.5684020036224, 2288.485090854561, 2297.6668383084443, 2310.1798861404213, 2245.4835387860803, 2253.4929640830846, 2254.763249858766, 2261.9660705089436, 2266.4447210433386, 2254.8534345267503, 2276.3284830974735, 2278.225403362848, 2286.6112760830697, 2292.6102562564406, 8980.506072166094, 9011.369204155711, 9052.728418147466, 9053.411528250708, 9069.0, 5093.134167191586, 5178.559822415099, 5196.142636464979, 5198.636095473318, 5202.947970520322, 3184.1561986073707, 3236.304194598149, 3339.9833000835083, 3367.915802104967, 3375.4135556288506, 1191.3328536019856, 1193.2065176657513, 2168.6746987951933, 2233.519793244444, 2262.1290803040783, 12480.375981200903, 12524.937375313066, 12578.81131783024, 12627.43176557048, 12654.114212005163, 4259.169461954951, 4410.735355878657, 4419.18245124653, 4575.656825738083, 4580.267157254823, 9775.071368220008, 9837.508124593742, 9879.506024698736, 9887.258455615714, 9893.109620134222, 5174.663646862942, 5174.689518628894, 5180.171172612364, 5180.9740951295, 5183.870403239874, 4221.430106935524, 4730.739809310521, 4833.226683730586, 4889.095517329305, 4891.51084891508, 3680.1535646801385, 3722.218334149805, 3786.1481166737262, 3826.349520581508, 3830.482884810515, 1086.9239153259355, 1091.5633746501305, 1097.9451027448595, 1107.6621630402644, 1107.8449017137607, 799.6961154761153, 822.9094799572042, 875.9562021898879, 957.3585697582497, 991.8270680781008, 5824.155497452845, 5915.674637894957, 5938.28740551128, 5938.435848594377, 6025.728842202111, 402.32007906638273, 405.736271423577, 413.56782162640116, 1040.505759764106, 1055.176961969665, 4202.201581699467, 4251.404803327537, 4254.574542545721, 4254.829806807755, 4264.829406823692, 11028.117750580095, 11227.101831853432, 11260.493277802518, 11290.491927863266, 11336.886631133748, 11271.267367621078, 11273.887261127447, 11289.54841806335, 11293.491792869341, 11307.095432365391, 7951.721689740832, 8308.83382332362, 8319.459235149696, 8424.241818236389, 8547.059823419419, 5905.291365036223, 5964.075568286922, 5995.0, 6206.286277078013, 6370.267419246846, 10249.436281004617, 10319.690409287734, 10441.477926103513, 10562.155027597928, 10577.31247468912, 10526.368417894952, 10555.894441055798, 10602.628907988183, 10689.732756680834, 10840.024397804236, 6951.652417379212, 7730.149683534919, 7918.920810791818, 7949.602519873867, 7991.800204994689, 8822.294216462538, 8823.514706690938, 8826.5586720665, 8875.911240887508, 8898.243649289883, 7466.664000120117, 7617.5048621841615, 7735.187805280365, 7742.458027938215, 8046.195380461907, 7548.320651141424, 7551.395888329031, 7568.81077973033, 7645.044369453818, 7730.304272615492, 7337.559746415232, 7411.777646670608, 7415.666295016845, 7425.443091768031, 7443.4789564729945, 4933.383327084114, 5054.09026375256, 5181.248718935809, 5199.92200116991, 5227.059129356752, 5238.057149713089, 5318.122509785842, 5327.840164795062, 5338.199270109515, 5379.220013098001], "value": 4649.287317229789, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.2434716243247, 326.67985374333153, 331.59048575009865, 332.55769826131245, 332.7853534470265, 5646.6894320812335, 5675.432456754323, 5683.788659407437, 5689.175069614904, 5706.600537962344, 5519.31008623922, 5528.336599608053, 5547.55619550436, 5562.360328562217, 5579.191017302489, 4110.5067391912935, 4198.91602167958, 4280.0, 4281.507626622932, 4325.82696692132, 4277.25148099083, 4287.121140166259, 4296.453276820343, 4318.654507639381, 4325.956740432587, 4257.74453532789, 4304.160688665712, 4321.891952701176, 4329.285667864814, 4330.350447432878, 4061.2283666103344, 4264.50095149617, 4280.357946308079, 4280.6789490788005, 4317.589828966243, 3693.9261214775825, 3706.870259540903, 3709.146896213859, 3713.3316003119426, 3727.9813600932093, 5469.371022332443, 5474.534664553517, 5492.450754924515, 5498.917516237259, 5517.751701173457, 4822.71063736177, 4847.854564363075, 4905.583025442842, 4915.5084491550915, 4931.087748766489, 5758.222639943596, 5767.682777447239, 5818.272715910512, 5824.961263557763, 5902.881942361171, 4081.2245673322273, 4084.1831633673087, 4095.672346212296, 4096.836126554934, 4099.795010249476, 5897.262842144732, 6010.9699451502465, 6044.607100538451, 6054.062699936022, 6060.30306514752, 4185.0, 4211.241976444269, 4213.2837417639075, 4222.218889505451, 4237.6821738369745, 4283.1433713257475, 4300.204462174508, 4307.203167414038, 4311.116221174651, 4321.762303073361, 4649.767511624405, 4932.704037757674, 4936.975315123402, 4944.332515110486, 4952.702837829742, 5852.678102704307, 5860.765569377178, 5882.55880808941, 5923.0, 5932.466078052909, 1453.1862157192006, 1472.49935022093, 1472.580314610331, 1476.6603681153395, 1477.6822983058694, 914.9588268527932, 915.7573243090586, 946.7491114854569, 974.697843668465, 983.9606415743433, 5702.800401985911, 5747.36778954323, 5757.827265182052, 5797.2173756542325, 5806.854828629318, 5918.23063001807, 5935.317438494542, 5965.522758179335, 5980.312264089598, 6099.451049405575, 5541.5843811714285, 5699.629524080921, 5873.2658417697785, 5877.0596704527925, 5887.676177810176, 3214.9839250803598, 3217.790843595159, 3225.193701574606, 3238.36851813894, 3265.934681306408, 6121.143039974407, 6233.812985610439, 6279.717412716439, 6286.779962701284, 6294.748210071637, 6149.754009839646, 6193.84515387119, 6198.318184999646, 6207.751689932352, 6229.53278504114, 5946.226990491122, 6188.721507532172, 6192.876142477216, 6243.094751261133, 6250.1874756282305, 6015.578909476295, 6027.276726792813, 6033.939660603513, 6036.577439579188, 6040.6979651018155, 5921.3782552831335, 5969.552283578836, 6000.429959153874, 6002.909956350571, 6016.2479690038745, 6006.15913772081, 6193.194884664965, 6208.379162083756, 6224.346443623354, 6231.626102433868, 4174.457320548309, 4190.329547272422, 4219.2194444027955, 4230.2174097792, 4272.0, 5733.8566535836935, 5807.186993820784, 6074.544409169242, 6101.969490152698, 6148.815535533941, 5875.41245875409, 5889.911651325319, 5889.970550147222, 5911.290645122613, 5936.22829032223, 5838.824835254949, 5854.619449735754, 5877.2376982818005, 5894.231730480753, 5952.315483719428, 5561.775289884079, 5766.884662306814, 5809.970950145392, 5812.447817457335, 5830.7959221427045, 5764.337101233412, 5903.586748927705, 5917.28992520883, 5945.286565612154, 5972.492338151305, 5458.8362349128, 5745.827625171084, 5756.16535602327, 5759.884802304015, 5783.2240524547615], "value": 4443.096516644249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.2514922204742, 750.5946788734084, 806.201860158443, 840.8906842110524, 852.9872051919223, 13537.323133843305, 14321.713565728693, 14730.1161930284, 14803.629909252275, 14810.0, 12791.48834046637, 12997.155184912997, 13142.408591613377, 13370.130941488796, 13411.93294033531, 788.8304014636838, 799.848028874512, 800.6197056398222, 801.2548330053048, 806.2139414071263, 689.841336492607, 811.7686459359084, 818.4598165210962, 818.467995802727, 821.2772759971217, 842.8946381702287, 847.7711018025129, 849.762066621347, 851.1743608699583, 851.4805968359327, 847.5380917400032, 848.0163010907348, 848.567230712335, 849.562475325208, 850.1880703927734, 614.8954677704801, 621.7481919822434, 622.4802290087782, 622.5082185073786, 622.8691974685322, 12963.740725185538, 13005.284709340982, 13120.86879131206, 13131.0808243423, 13204.273764942924, 14165.575032749033, 14344.49794257196, 14377.71244575113, 14424.278786060655, 14504.41982320706, 11806.173567850254, 11846.348450835201, 11944.88055119455, 12062.638120856389, 12391.876081239252, 3876.8255428505504, 3895.2988462076814, 3912.647861692433, 4050.1494686115952, 4061.167460670585, 77288.61355693241, 78883.6055819723, 78980.0, 79227.0, 79707.60146199232, 10889.128869690407, 10949.726256843483, 10969.725756856142, 11210.04714599252, 11711.414429278502, 22833.31500055001, 22960.196393126495, 23174.1889033883, 23291.18480853162, 23486.882565587064, 7651.273129052731, 7864.0, 8096.271335579826, 8467.237948584658, 8697.21725044749, 4483.260262056724, 4596.563326483979, 4693.20215563355, 4725.36207611968, 4750.904981900343, 3421.4354631486026, 3533.681968622785, 3545.308664810337, 3546.91132721684, 3553.129483276614, 624.7063879976404, 630.9179806625109, 632.7880160146402, 638.1225814505055, 638.9073584330339, 702.8313204830804, 732.827785470414, 744.5607091815855, 772.0850791811721, 802.7792357101844, 10009.499525023719, 10092.848607270897, 10208.744781380376, 10236.948815255875, 10262.692119236435, 641.4131070070927, 683.3405763438207, 717.6411794102949, 762.5196126440308, 783.6669415498504, 4429.844955426544, 4464.687471877002, 4598.931016034762, 4659.415798628414, 5035.0, 98894.0, 102467.48766256121, 102534.0, 110020.0, 111373.44313278382, 109267.45366273118, 109989.0, 113110.43444782724, 114065.0, 114065.85934140718, 75288.62355688187, 96841.51579242059, 100465.0, 100847.0, 101036.49481752691, 9019.864702029607, 9229.016900380988, 9340.392874463138, 9793.670709605454, 9944.403335799876, 45672.31491527696, 56744.14883776829, 56793.43206567881, 57283.42716572781, 58329.0, 66322.0, 76199.19004049886, 76251.23748762663, 76295.61852190703, 78926.6053669728, 12954.0, 13209.801852972021, 13391.531296404579, 13730.244836533688, 14035.087719298213, 14220.146791192561, 14360.56918292453, 14425.278736063365, 14495.565133046026, 14644.560663180122, 13380.0, 13461.932690336485, 13741.725165496833, 13760.587182384545, 13768.724625507233, 12728.363581821057, 13002.869971300166, 13120.671983200496, 13357.732845342844, 13639.249841258827, 11889.762204755683, 12711.300878451404, 12786.332988459331, 13043.34783260852, 13934.651633709238, 10514.421706806199, 11193.554170069543, 11392.658220253406, 11396.772064558496, 11868.584599538975, 11575.131865109983, 11783.705407364541, 11832.645020649394, 11955.163138580216, 12061.847485213155], "value": 7567.6054648625795, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 106.0, 112.0, 110.0, 111.0, 113.0, 110.0, 112.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 146.0, 168.0, 118.0, 155.0, 148.0, 121.0, 192.0, 118.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 163.0, 164.0, 165.0, 172.0, 162.0, 162.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 157.0, 76.0, 77.0, 75.0, 76.0, 183.0, 78.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 165.0, 85.0, 84.0, 85.0, 145.0, 84.0, 84.0, 143.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 201.0, 147.0, 147.0, 146.0, 146.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 55.0, 54.0, 52.0, 53.0, 55.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 68.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 75.0, 77.0, 77.0, 76.0, 76.0, 81.0, 83.0, 85.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 134.0, 131.0, 125.0, 140.0, 127.0, 122.0, 122.0, 155.0, 129.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 159.0, 159.0, 161.0, 161.0, 168.0, 159.0, 157.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 66.0, 65.0, 65.0, 62.0, 63.0, 67.0, 65.0, 63.0], "value": 64.3, "unit": "score"}]}]} 05:38:19 INFO - Return code: 0 05:38:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:38:19 ERROR - # TBPL SUCCESS # 05:38:19 INFO - Running post-action listener: _resource_record_post_action 05:38:19 INFO - ##### 05:38:19 INFO - ##### Finished run-tests step (success) 05:38:19 INFO - ##### 05:38:19 INFO - Running post-run listener: _resource_record_post_run 05:38:19 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 568025088; Read time: 12; Write time: 397428 05:38:19 INFO - TinderboxPrint: CPU usage
13.3% 05:38:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:38:19 INFO - TinderboxPrint: I/O write bytes / time
568,025,088 / 397,428 05:38:19 INFO - TinderboxPrint: CPU idle
8,213.9 (86.6%) 05:38:19 INFO - TinderboxPrint: CPU user
1,214.1 (12.8%) 05:38:19 INFO - TinderboxPrint: Swap in / out
0 / 0 05:38:19 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 267927552; Read time: 0; Write time: 196376 05:38:19 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 300097536; Read time: 0; Write time: 201052 05:38:20 INFO - Running post-run listener: _upload_blobber_files 05:38:20 INFO - Blob upload gear active. 05:38:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:20 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 05:38:20 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'] 05:38:20 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 05:38:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:38:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:38:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:21 INFO - (blobuploader) - INFO - Done attempting. 05:38:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:38:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:38:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:26 INFO - (blobuploader) - INFO - Done attempting. 05:38:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:38:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:38:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:27 INFO - (blobuploader) - INFO - Done attempting. 05:38:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:27 INFO - Return code: 0 05:38:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238d4c6d66f560c55d3255ac28cd80f0b920f5bcafbaadb2c559a8a3416d81b155ffd7ff4ae32dbb54d171aeff60c993f9f268092f52a86b24e634a33ee01df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ad34877622ea56c5f7d94b555e1efc31db371af99b2cef22ddb3d841f4ebdd6160a5e5b4148602e04adee18860af3b258953b670cdb5db43342cb192fd2c9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a8bec364f60b2adfa33211c84c255122a70c74ea44b09660e4f1840eecbe5be64e90ef834c90b51adba7430dfdbb688144c01ce7bfa07f1199279805cd75c50"} 05:38:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:27 INFO - Contents: 05:38:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238d4c6d66f560c55d3255ac28cd80f0b920f5bcafbaadb2c559a8a3416d81b155ffd7ff4ae32dbb54d171aeff60c993f9f268092f52a86b24e634a33ee01df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ad34877622ea56c5f7d94b555e1efc31db371af99b2cef22ddb3d841f4ebdd6160a5e5b4148602e04adee18860af3b258953b670cdb5db43342cb192fd2c9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a8bec364f60b2adfa33211c84c255122a70c74ea44b09660e4f1840eecbe5be64e90ef834c90b51adba7430dfdbb688144c01ce7bfa07f1199279805cd75c50"} 05:38:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:27 INFO - Copying logs to upload dir... 05:38:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.100540 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-18 05:38:26.651066) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:38:26.655017) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238d4c6d66f560c55d3255ac28cd80f0b920f5bcafbaadb2c559a8a3416d81b155ffd7ff4ae32dbb54d171aeff60c993f9f268092f52a86b24e634a33ee01df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ad34877622ea56c5f7d94b555e1efc31db371af99b2cef22ddb3d841f4ebdd6160a5e5b4148602e04adee18860af3b258953b670cdb5db43342cb192fd2c9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a8bec364f60b2adfa33211c84c255122a70c74ea44b09660e4f1840eecbe5be64e90ef834c90b51adba7430dfdbb688144c01ce7bfa07f1199279805cd75c50"} build_url:https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238d4c6d66f560c55d3255ac28cd80f0b920f5bcafbaadb2c559a8a3416d81b155ffd7ff4ae32dbb54d171aeff60c993f9f268092f52a86b24e634a33ee01df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ad34877622ea56c5f7d94b555e1efc31db371af99b2cef22ddb3d841f4ebdd6160a5e5b4148602e04adee18860af3b258953b670cdb5db43342cb192fd2c9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a8bec364f60b2adfa33211c84c255122a70c74ea44b09660e4f1840eecbe5be64e90ef834c90b51adba7430dfdbb688144c01ce7bfa07f1199279805cd75c50"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:38:26.685660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:38:26.686015) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1468844231.244355-627195595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:38:26.769393) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:38:26.769742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:38:26.770045) ========= ========= Total master_lag: 0.16 =========