builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1468843754.36 results: success (0) buildid: 20160718023044 builduid: 129cbaccaa354d5aabc322f22abe817a revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.364983) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.365718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.366309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.383673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.384353) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 05:09:14-- 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% 221M=0s 2016-07-18 05:09:14 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091248 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.491377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.491677) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021643 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.542772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:14.543119) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 05:09:15,092 truncating revision to first 12 chars 2016-07-18 05:09:15,092 Setting DEBUG logging. 2016-07-18 05:09:15,092 attempt 1/10 2016-07-18 05:09:15,092 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:09:15,396 unpacking tar archive at: fx-team-bc547f508f58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727129 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:15.293117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:15.293417) ========= script_repo_revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:15.293806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:15.294141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:09:15.305642) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-18 05:09:15.305962) ========= /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=c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:15 INFO - MultiFileLogger online at 20160718 05:09:15 in /builds/slave/test 05:09:15 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:09:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:15 INFO - {'append_to_log': False, 05:09:15 INFO - 'base_work_dir': '/builds/slave/test', 05:09:15 INFO - 'blob_upload_branch': 'Fx-Team', 05:09:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:15 INFO - 'branch': 'Fx-Team', 05:09:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:15 INFO - 'config_files': ('talos/linux_config.py',), 05:09:15 INFO - 'default_actions': ('clobber', 05:09:15 INFO - 'read-buildbot-config', 05:09:15 INFO - 'download-and-extract', 05:09:15 INFO - 'populate-webroot', 05:09:15 INFO - 'create-virtualenv', 05:09:15 INFO - 'install', 05:09:15 INFO - 'run-tests'), 05:09:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:15 INFO - 'download_minidump_stackwalk': True, 05:09:15 INFO - 'download_symbols': 'ondemand', 05:09:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:15 INFO - 'installer_path': 'installer.exe', 05:09:15 INFO - 'log_level': 'info', 05:09:15 INFO - 'log_name': 'talos', 05:09:15 INFO - 'log_to_console': True, 05:09:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:15 INFO - 'opt_config_files': (), 05:09:15 INFO - 'pip_index': False, 05:09:15 INFO - 'sps_profile': False, 05:09:15 INFO - 'sps_profile_interval': 0, 05:09:15 INFO - 'suite': 'dromaeojs-e10s', 05:09:15 INFO - 'system_bits': '32', 05:09:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:15 INFO - 'title': 'talos-linux64-ix-004', 05:09:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:15 INFO - 'use_talos_json': True, 05:09:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:15 INFO - 'work_dir': 'build'} 05:09:15 INFO - ##### 05:09:15 INFO - ##### Running clobber step. 05:09:15 INFO - ##### 05:09:15 INFO - Running pre-action listener: _resource_record_pre_action 05:09:15 INFO - Running main action method: clobber 05:09:15 INFO - rmtree: /builds/slave/test/build 05:09:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:16 INFO - Running post-action listener: _resource_record_post_action 05:09:16 INFO - ##### 05:09:16 INFO - ##### Finished clobber step (success) 05:09:16 INFO - ##### 05:09:16 INFO - ##### 05:09:16 INFO - ##### Running read-buildbot-config step. 05:09:16 INFO - ##### 05:09:16 INFO - Running pre-action listener: _resource_record_pre_action 05:09:16 INFO - Running main action method: read_buildbot_config 05:09:16 INFO - Using buildbot properties: 05:09:16 INFO - { 05:09:16 INFO - "project": "", 05:09:16 INFO - "product": "firefox", 05:09:16 INFO - "script_repo_revision": "production", 05:09:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:09:16 INFO - "repository": "", 05:09:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:09:16 INFO - "buildid": "20160718023044", 05:09:16 INFO - "pgo_build": "True", 05:09:16 INFO - "basedir": "/builds/slave/test", 05:09:16 INFO - "buildnumber": 627, 05:09:16 INFO - "slavename": "talos-linux64-ix-004", 05:09:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:09:16 INFO - "platform": "ubuntu64_hw", 05:09:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:09:16 INFO - "branch": "fx-team", 05:09:16 INFO - "repo_path": "integration/fx-team", 05:09:16 INFO - "revision": "bc547f508f58108db8b9ad9c2b94f130c07de194", 05:09:16 INFO - "stage_platform": "linux64-pgo", 05:09:16 INFO - "builduid": "129cbaccaa354d5aabc322f22abe817a", 05:09:16 INFO - "slavebuilddir": "test" 05:09:16 INFO - } 05:09:16 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:09:16 INFO - Running post-action listener: _resource_record_post_action 05:09:16 INFO - ##### 05:09:16 INFO - ##### Finished read-buildbot-config step (success) 05:09:16 INFO - ##### 05:09:16 INFO - ##### 05:09:16 INFO - ##### Running download-and-extract step. 05:09:16 INFO - ##### 05:09:16 INFO - Running pre-action listener: _resource_record_pre_action 05:09:16 INFO - Running main action method: download_and_extract 05:09:16 INFO - mkdir: /builds/slave/test/build/tests 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:19 INFO - Downloaded 1361 bytes. 05:09:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:09:19 INFO - Using the following test package requirements: 05:09:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:09:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:09:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'jsshell-linux-x86_64.zip'], 05:09:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:09:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:09:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:09:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:09:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:09:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:09: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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:23 INFO - Downloaded 24334234 bytes. 05:09:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:24 INFO - Return code: 0 05:09:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:25 INFO - Downloaded 24334234 bytes. 05:09:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:27 INFO - Return code: 0 05:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:28 INFO - Downloaded 14403317 bytes. 05:09:28 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:09:28 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:09:28 INFO - Return code: 0 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:30 INFO - Downloaded 60818167 bytes. 05:09:30 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:09:30 INFO - mkdir: /builds/slave/test/properties 05:09:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:30 INFO - Contents: 05:09:30 INFO - build_url:https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:09:30 INFO - Running post-action listener: _resource_record_post_action 05:09:30 INFO - Running post-action listener: set_extra_try_arguments 05:09:30 INFO - ##### 05:09:30 INFO - ##### Finished download-and-extract step (success) 05:09:30 INFO - ##### 05:09:30 INFO - ##### 05:09:30 INFO - ##### Running populate-webroot step. 05:09:30 INFO - ##### 05:09:30 INFO - Running pre-action listener: _resource_record_pre_action 05:09:30 INFO - Running main action method: populate_webroot 05:09:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:30 INFO - '--tppagecycles', 05:09:30 INFO - '7'], 05:09:30 INFO - 'tests': ['tsvgm']}}, 05:09:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['damp', 'tps']}, 05:09:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'tests': ['damp', 'tps']}, 05:09:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['dromaeo_dom']}, 05:09:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['basic_compositor_video']}, 05:09:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:09:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['a11yr', 05:09:30 INFO - 'ts_paint', 05:09:30 INFO - 'tpaint', 05:09:30 INFO - 'sessionrestore', 05:09:30 INFO - 'sessionrestore_no_auto_restore', 05:09:30 INFO - 'tabpaint']}, 05:09:30 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:30 INFO - 'ts_paint', 05:09:30 INFO - 'tpaint', 05:09:30 INFO - 'sessionrestore', 05:09:30 INFO - 'sessionrestore_no_auto_restore', 05:09:30 INFO - 'tabpaint']}, 05:09:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:30 INFO - 'ts_paint', 05:09:30 INFO - 'tpaint', 05:09:30 INFO - 'sessionrestore', 05:09:30 INFO - 'sessionrestore_no_auto_restore', 05:09:30 INFO - 'tabpaint']}, 05:09:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:30 INFO - 'ts_paint', 05:09:30 INFO - 'tpaint', 05:09:30 INFO - 'sessionrestore', 05:09:30 INFO - 'sessionrestore_no_auto_restore', 05:09:30 INFO - 'tabpaint']}, 05:09:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['a11yr', 05:09:30 INFO - 'ts_paint', 05:09:30 INFO - 'tpaint', 05:09:30 INFO - 'sessionrestore', 05:09:30 INFO - 'sessionrestore_no_auto_restore', 05:09:30 INFO - 'tabpaint']}, 05:09:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['a11yr', 05:09:30 INFO - 'ts_paint', 05:09:30 INFO - 'tpaint', 05:09:30 INFO - 'sessionrestore', 05:09:30 INFO - 'sessionrestore_no_auto_restore', 05:09:30 INFO - 'tabpaint']}, 05:09:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['tsvgx', 05:09:30 INFO - 'tsvgr_opacity', 05:09:30 INFO - 'tart', 05:09:30 INFO - 'tscrollx', 05:09:30 INFO - 'cart']}, 05:09:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:30 INFO - 'tsvgr_opacity', 05:09:30 INFO - 'tart', 05:09:30 INFO - 'tscrollx', 05:09:30 INFO - 'cart']}, 05:09:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'talos_options': ['--disable-e10s'], 05:09:30 INFO - 'tests': ['tp5o']}, 05:09:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'tests': ['tp5o']}, 05:09:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'talos_options': ['--disable-e10s', 05:09:30 INFO - '--xperf_path', 05:09:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:30 INFO - 'tests': ['tp5n']}, 05:09:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:30 INFO - 'talos_options': ['--xperf_path', 05:09:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:30 INFO - 'tests': ['tp5n']}}, 05:09:30 INFO - 'talos.zip': {'path': '', 05:09:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:30 INFO - Running post-action listener: _resource_record_post_action 05:09:30 INFO - ##### 05:09:30 INFO - ##### Finished populate-webroot step (success) 05:09:30 INFO - ##### 05:09:30 INFO - ##### 05:09:30 INFO - ##### Running create-virtualenv step. 05:09:30 INFO - ##### 05:09:30 INFO - Running pre-action listener: _resource_record_pre_action 05:09:30 INFO - Running main action method: create_virtualenv 05:09:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:09:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:30 INFO - Using real prefix '/usr' 05:09:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:33 INFO - Installing pip.................done. 05:09:33 INFO - Return code: 0 05:09:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:09:33 INFO - Using env: {'DISPLAY': ':0', 05:09:33 INFO - 'HOME': '/home/cltbld', 05:09:33 INFO - 'LANG': 'en_US.UTF-8', 05:09:33 INFO - 'LANGUAGE': 'en_US:en', 05:09:33 INFO - 'LOGNAME': 'cltbld', 05:09:33 INFO - 'MAIL': '/var/mail/cltbld', 05:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:33 INFO - 'MOZ_NO_REMOTE': '1', 05:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:33 INFO - 'NO_EM_RESTART': '1', 05:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:33 INFO - 'PWD': '/builds/slave/test', 05:09:33 INFO - 'SHELL': '/bin/bash', 05:09:33 INFO - 'SHLVL': '1', 05:09:33 INFO - 'TERM': 'linux', 05:09:33 INFO - 'TMOUT': '86400', 05:09:33 INFO - 'USER': 'cltbld', 05:09:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:33 INFO - '_': '/tools/buildbot/bin/python'} 05:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:09:33 INFO - Cleaning up... 05:09:33 INFO - Return code: 0 05:09:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:09:33 INFO - Using env: {'DISPLAY': ':0', 05:09:33 INFO - 'HOME': '/home/cltbld', 05:09:33 INFO - 'LANG': 'en_US.UTF-8', 05:09:33 INFO - 'LANGUAGE': 'en_US:en', 05:09:33 INFO - 'LOGNAME': 'cltbld', 05:09:33 INFO - 'MAIL': '/var/mail/cltbld', 05:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:33 INFO - 'MOZ_NO_REMOTE': '1', 05:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:33 INFO - 'NO_EM_RESTART': '1', 05:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:33 INFO - 'PWD': '/builds/slave/test', 05:09:33 INFO - 'SHELL': '/bin/bash', 05:09:33 INFO - 'SHLVL': '1', 05:09:33 INFO - 'TERM': 'linux', 05:09:33 INFO - 'TMOUT': '86400', 05:09:33 INFO - 'USER': 'cltbld', 05:09:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:33 INFO - '_': '/tools/buildbot/bin/python'} 05:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:33 INFO - Downloading/unpacking psutil>=3.1.1 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:35 INFO - Installing collected packages: psutil 05:09:35 INFO - Running setup.py install for psutil 05:09:35 INFO - building 'psutil._psutil_linux' extension 05:09:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:09:36 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:09:36 INFO - building 'psutil._psutil_posix' extension 05:09:36 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:09:36 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:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:36 INFO - Successfully installed psutil 05:09:36 INFO - Cleaning up... 05:09:36 INFO - Return code: 0 05:09:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:36 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 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:36 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:09:36 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:09:36 INFO - Using env: {'DISPLAY': ':0', 05:09:36 INFO - 'HOME': '/home/cltbld', 05:09:36 INFO - 'LANG': 'en_US.UTF-8', 05:09:36 INFO - 'LANGUAGE': 'en_US:en', 05:09:36 INFO - 'LOGNAME': 'cltbld', 05:09:36 INFO - 'MAIL': '/var/mail/cltbld', 05:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:36 INFO - 'MOZ_NO_REMOTE': '1', 05:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:36 INFO - 'NO_EM_RESTART': '1', 05:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:36 INFO - 'PWD': '/builds/slave/test', 05:09:36 INFO - 'SHELL': '/bin/bash', 05:09:36 INFO - 'SHLVL': '1', 05:09:36 INFO - 'TERM': 'linux', 05:09:36 INFO - 'TMOUT': '86400', 05:09:36 INFO - 'USER': 'cltbld', 05:09:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:36 INFO - '_': '/tools/buildbot/bin/python'} 05:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:09:38 INFO - Installing collected packages: mozsystemmonitor 05:09:38 INFO - Running setup.py install for mozsystemmonitor 05:09:38 INFO - Successfully installed mozsystemmonitor 05:09:38 INFO - Cleaning up... 05:09:38 INFO - Return code: 0 05:09:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:09:38 INFO - Using env: {'DISPLAY': ':0', 05:09:38 INFO - 'HOME': '/home/cltbld', 05:09:38 INFO - 'LANG': 'en_US.UTF-8', 05:09:38 INFO - 'LANGUAGE': 'en_US:en', 05:09:38 INFO - 'LOGNAME': 'cltbld', 05:09:38 INFO - 'MAIL': '/var/mail/cltbld', 05:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:38 INFO - 'MOZ_NO_REMOTE': '1', 05:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:38 INFO - 'NO_EM_RESTART': '1', 05:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:38 INFO - 'PWD': '/builds/slave/test', 05:09:38 INFO - 'SHELL': '/bin/bash', 05:09:38 INFO - 'SHLVL': '1', 05:09:38 INFO - 'TERM': 'linux', 05:09:38 INFO - 'TMOUT': '86400', 05:09:38 INFO - 'USER': 'cltbld', 05:09:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:38 INFO - '_': '/tools/buildbot/bin/python'} 05:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:41 INFO - warning: no files found matching '*.txt' 05:09:41 INFO - no previously-included directories found matching 'build' 05:09:41 INFO - no previously-included directories found matching 'dist' 05:09:41 INFO - no previously-included directories found matching '.git*' 05:09:41 INFO - Installing collected packages: jsonschema, functools32 05:09:41 INFO - Running setup.py install for functools32 05:09:41 INFO - warning: no files found matching '*.txt' 05:09:41 INFO - no previously-included directories found matching 'build' 05:09:41 INFO - no previously-included directories found matching 'dist' 05:09:41 INFO - no previously-included directories found matching '.git*' 05:09:41 INFO - Successfully installed jsonschema functools32 05:09:41 INFO - Cleaning up... 05:09:41 INFO - Return code: 0 05:09:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:41 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 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:41 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:09:41 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:09:41 INFO - Using env: {'DISPLAY': ':0', 05:09:41 INFO - 'HOME': '/home/cltbld', 05:09:41 INFO - 'LANG': 'en_US.UTF-8', 05:09:41 INFO - 'LANGUAGE': 'en_US:en', 05:09:41 INFO - 'LOGNAME': 'cltbld', 05:09:41 INFO - 'MAIL': '/var/mail/cltbld', 05:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:41 INFO - 'MOZ_NO_REMOTE': '1', 05:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:41 INFO - 'NO_EM_RESTART': '1', 05:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:41 INFO - 'PWD': '/builds/slave/test', 05:09:41 INFO - 'SHELL': '/bin/bash', 05:09:41 INFO - 'SHLVL': '1', 05:09:41 INFO - 'TERM': 'linux', 05:09:41 INFO - 'TMOUT': '86400', 05:09:41 INFO - 'USER': 'cltbld', 05:09:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:41 INFO - '_': '/tools/buildbot/bin/python'} 05:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:44 INFO - Downloading docopt-0.6.1.tar.gz 05:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:44 INFO - Running setup.py install for blobuploader 05:09:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:44 INFO - Running setup.py install for requests 05:09:44 INFO - Running setup.py install for docopt 05:09:44 INFO - Successfully installed blobuploader requests docopt 05:09:44 INFO - Cleaning up... 05:09:44 INFO - Return code: 0 05:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:44 INFO - Using env: {'DISPLAY': ':0', 05:09:44 INFO - 'HOME': '/home/cltbld', 05:09:44 INFO - 'LANG': 'en_US.UTF-8', 05:09:44 INFO - 'LANGUAGE': 'en_US:en', 05:09:44 INFO - 'LOGNAME': 'cltbld', 05:09:44 INFO - 'MAIL': '/var/mail/cltbld', 05:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:44 INFO - 'MOZ_NO_REMOTE': '1', 05:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:44 INFO - 'NO_EM_RESTART': '1', 05:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:44 INFO - 'PWD': '/builds/slave/test', 05:09:44 INFO - 'SHELL': '/bin/bash', 05:09:44 INFO - 'SHLVL': '1', 05:09:44 INFO - 'TERM': 'linux', 05:09:44 INFO - 'TMOUT': '86400', 05:09:44 INFO - 'USER': 'cltbld', 05:09:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:44 INFO - '_': '/tools/buildbot/bin/python'} 05:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:45 INFO - Running setup.py (path:/tmp/pip-khKE8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:45 INFO - Running setup.py (path:/tmp/pip-EIJwsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:45 INFO - Running setup.py (path:/tmp/pip-Pu6lfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:45 INFO - Running setup.py (path:/tmp/pip-PIfyWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:45 INFO - Running setup.py (path:/tmp/pip-x5R2aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:45 INFO - Running setup.py (path:/tmp/pip-jje5Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:45 INFO - Running setup.py (path:/tmp/pip-1JZacI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:45 INFO - Running setup.py (path:/tmp/pip-JzqtOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:45 INFO - Running setup.py (path:/tmp/pip-kBKjc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:45 INFO - Running setup.py (path:/tmp/pip-yQ1aow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:45 INFO - Running setup.py (path:/tmp/pip-bwQDFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:46 INFO - Running setup.py (path:/tmp/pip-r5AB5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:46 INFO - Running setup.py (path:/tmp/pip-kgzrq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:46 INFO - Running setup.py (path:/tmp/pip-7IHREb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:46 INFO - Running setup.py (path:/tmp/pip-TL44jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:46 INFO - Running setup.py (path:/tmp/pip-u4Res3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:46 INFO - Running setup.py (path:/tmp/pip-NYheEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:46 INFO - Running setup.py install for manifestparser 05:09:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:46 INFO - Running setup.py install for mozcrash 05:09:46 INFO - Running setup.py install for mozdebug 05:09:46 INFO - Running setup.py install for mozdevice 05:09:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:46 INFO - Running setup.py install for mozfile 05:09:46 INFO - Running setup.py install for mozhttpd 05:09:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Running setup.py install for mozinfo 05:09:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Running setup.py install for mozInstall 05:09:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Running setup.py install for mozleak 05:09:47 INFO - Running setup.py install for mozlog 05:09:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Running setup.py install for moznetwork 05:09:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Running setup.py install for mozprocess 05:09:47 INFO - Running setup.py install for mozprofile 05:09:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Running setup.py install for mozrunner 05:09:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:47 INFO - Running setup.py install for mozscreenshot 05:09:48 INFO - Running setup.py install for moztest 05:09:48 INFO - Running setup.py install for mozversion 05:09:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:48 INFO - Cleaning up... 05:09:48 INFO - Return code: 0 05:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:48 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 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:48 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:09:48 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:09:48 INFO - Using env: {'DISPLAY': ':0', 05:09:48 INFO - 'HOME': '/home/cltbld', 05:09:48 INFO - 'LANG': 'en_US.UTF-8', 05:09:48 INFO - 'LANGUAGE': 'en_US:en', 05:09:48 INFO - 'LOGNAME': 'cltbld', 05:09:48 INFO - 'MAIL': '/var/mail/cltbld', 05:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:48 INFO - 'MOZ_NO_REMOTE': '1', 05:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:48 INFO - 'NO_EM_RESTART': '1', 05:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:48 INFO - 'PWD': '/builds/slave/test', 05:09:48 INFO - 'SHELL': '/bin/bash', 05:09:48 INFO - 'SHLVL': '1', 05:09:48 INFO - 'TERM': 'linux', 05:09:48 INFO - 'TMOUT': '86400', 05:09:48 INFO - 'USER': 'cltbld', 05:09:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:48 INFO - '_': '/tools/buildbot/bin/python'} 05:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:48 INFO - Running setup.py (path:/tmp/pip-_wi_pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:48 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:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:48 INFO - Running setup.py (path:/tmp/pip-2wQHaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:48 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:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:48 INFO - Running setup.py (path:/tmp/pip-DuKaYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:48 INFO - Running setup.py (path:/tmp/pip-4s6SIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:48 INFO - Running setup.py (path:/tmp/pip-EFBN2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:48 INFO - Running setup.py (path:/tmp/pip-8E8Tnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:48 INFO - Running setup.py (path:/tmp/pip-VY6wLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:48 INFO - Running setup.py (path:/tmp/pip-18SSPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:49 INFO - Running setup.py (path:/tmp/pip-BHE8tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:49 INFO - Running setup.py (path:/tmp/pip-9xSbFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:49 INFO - Running setup.py (path:/tmp/pip-Plh_Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:49 INFO - Running setup.py (path:/tmp/pip-O_s6A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:49 INFO - Running setup.py (path:/tmp/pip-buJMvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:49 INFO - Running setup.py (path:/tmp/pip-yl0foi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:49 INFO - Running setup.py (path:/tmp/pip-GeFNeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:49 INFO - Running setup.py (path:/tmp/pip-JrFtpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:49 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:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:49 INFO - Running setup.py (path:/tmp/pip-R9ahjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:51 INFO - Downloading blessings-1.6.tar.gz 05:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:51 INFO - Installing collected packages: blessings 05:09:51 INFO - Running setup.py install for blessings 05:09:51 INFO - Successfully installed blessings 05:09:51 INFO - Cleaning up... 05:09:51 INFO - Return code: 0 05:09:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:52 INFO - Reading from file tmpfile_stdout 05:09:52 INFO - Current package versions: 05:09:52 INFO - argparse == 1.2.1 05:09:52 INFO - blessings == 1.6 05:09:52 INFO - blobuploader == 1.2.4 05:09:52 INFO - docopt == 0.6.1 05:09:52 INFO - functools32 == 3.2.3-2 05:09:52 INFO - jsonschema == 2.5.1 05:09:52 INFO - manifestparser == 1.1 05:09:52 INFO - mozInstall == 1.12 05:09:52 INFO - mozcrash == 0.17 05:09:52 INFO - mozdebug == 0.1 05:09:52 INFO - mozdevice == 0.48 05:09:52 INFO - mozfile == 1.2 05:09:52 INFO - mozhttpd == 0.7 05:09:52 INFO - mozinfo == 0.9 05:09:52 INFO - mozleak == 0.1 05:09:52 INFO - mozlog == 3.2 05:09:52 INFO - moznetwork == 0.27 05:09:52 INFO - mozprocess == 0.23 05:09:52 INFO - mozprofile == 0.28 05:09:52 INFO - mozrunner == 6.12 05:09:52 INFO - mozscreenshot == 0.1 05:09:52 INFO - mozsystemmonitor == 0.3 05:09:52 INFO - moztest == 0.7 05:09:52 INFO - mozversion == 1.4 05:09:52 INFO - psutil == 3.1.1 05:09:52 INFO - requests == 1.2.3 05:09:52 INFO - wsgiref == 0.1.2 05:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:52 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 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:52 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:09:52 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:09:52 INFO - Using env: {'DISPLAY': ':0', 05:09:52 INFO - 'HOME': '/home/cltbld', 05:09:52 INFO - 'LANG': 'en_US.UTF-8', 05:09:52 INFO - 'LANGUAGE': 'en_US:en', 05:09:52 INFO - 'LOGNAME': 'cltbld', 05:09:52 INFO - 'MAIL': '/var/mail/cltbld', 05:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:52 INFO - 'MOZ_NO_REMOTE': '1', 05:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:52 INFO - 'NO_EM_RESTART': '1', 05:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:52 INFO - 'PWD': '/builds/slave/test', 05:09:52 INFO - 'SHELL': '/bin/bash', 05:09:52 INFO - 'SHLVL': '1', 05:09:52 INFO - 'TERM': 'linux', 05:09:52 INFO - 'TMOUT': '86400', 05:09:52 INFO - 'USER': 'cltbld', 05:09:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:52 INFO - '_': '/tools/buildbot/bin/python'} 05:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 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:09:52 INFO - Cleaning up... 05:09:52 INFO - Return code: 0 05:09:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb36030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', '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:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:09:52 INFO - Using env: {'DISPLAY': ':0', 05:09:52 INFO - 'HOME': '/home/cltbld', 05:09:52 INFO - 'LANG': 'en_US.UTF-8', 05:09:52 INFO - 'LANGUAGE': 'en_US:en', 05:09:52 INFO - 'LOGNAME': 'cltbld', 05:09:52 INFO - 'MAIL': '/var/mail/cltbld', 05:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:52 INFO - 'MOZ_NO_REMOTE': '1', 05:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:52 INFO - 'NO_EM_RESTART': '1', 05:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:52 INFO - 'PWD': '/builds/slave/test', 05:09:52 INFO - 'SHELL': '/bin/bash', 05:09:52 INFO - 'SHLVL': '1', 05:09:52 INFO - 'TERM': 'linux', 05:09:52 INFO - 'TMOUT': '86400', 05:09:52 INFO - 'USER': 'cltbld', 05:09:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:52 INFO - '_': '/tools/buildbot/bin/python'} 05:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:52 INFO - Cleaning up... 05:09:52 INFO - Return code: 0 05:09:52 INFO - Running post-action listener: _resource_record_post_action 05:09:52 INFO - Running post-action listener: _start_resource_monitoring 05:09:52 INFO - Starting resource monitoring. 05:09:52 INFO - ##### 05:09:52 INFO - ##### Finished create-virtualenv step (success) 05:09:52 INFO - ##### 05:09:52 INFO - ##### 05:09:52 INFO - ##### Running install step. 05:09:52 INFO - ##### 05:09:52 INFO - Running pre-action listener: _resource_record_pre_action 05:09:52 INFO - Running main action method: install 05:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:52 INFO - Reading from file tmpfile_stdout 05:09:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:52 INFO - Reading from file tmpfile_stdout 05:09:52 INFO - Output received: 05:09:52 INFO - Usage: mozinstall [options] installer 05:09:52 INFO - Options: 05:09:52 INFO - -h, --help show this help message and exit 05:09:52 INFO - -d DEST, --destination=DEST 05:09:52 INFO - Directory to install application into. [default: 05:09:52 INFO - "/builds/slave/test"] 05:09:52 INFO - --app=APP Application being installed. [default: firefox] 05:09:52 INFO - mkdir: /builds/slave/test/build/application 05:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:10:10 INFO - Reading from file tmpfile_stdout 05:10:10 INFO - Output received: 05:10:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:10 INFO - Running post-action listener: _resource_record_post_action 05:10:10 INFO - ##### 05:10:10 INFO - ##### Finished install step (success) 05:10:10 INFO - ##### 05:10:10 INFO - ##### 05:10:10 INFO - ##### Running run-tests step. 05:10:10 INFO - ##### 05:10:10 INFO - Running pre-action listener: _resource_record_pre_action 05:10:10 INFO - Running main action method: run_tests 05:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:10 INFO - Python 2.7.3 05:10:10 INFO - Return code: 0 05:10:10 INFO - grabbing minidump binary from tooltool 05:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:10 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 0xdf53b0>, '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 0xdf62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:10 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:10:10 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:10:10 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:10:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:10 INFO - Return code: 0 05:10:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:10 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-004', '--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:10:10 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-004 --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:10:10 INFO - Using env: {'DISPLAY': ':0', 05:10:10 INFO - 'HOME': '/home/cltbld', 05:10:10 INFO - 'LANG': 'en_US.UTF-8', 05:10:10 INFO - 'LANGUAGE': 'en_US:en', 05:10:10 INFO - 'LOGNAME': 'cltbld', 05:10:10 INFO - 'MAIL': '/var/mail/cltbld', 05:10:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:10 INFO - 'MOZ_NO_REMOTE': '1', 05:10:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:10 INFO - 'NO_EM_RESTART': '1', 05:10:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:10 INFO - 'PWD': '/builds/slave/test', 05:10:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:10 INFO - 'SHELL': '/bin/bash', 05:10:10 INFO - 'SHLVL': '1', 05:10:10 INFO - 'TERM': 'linux', 05:10:10 INFO - 'TMOUT': '86400', 05:10:10 INFO - 'USER': 'cltbld', 05:10:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808', 05:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:10 INFO - '_': '/tools/buildbot/bin/python'} 05:10:10 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-004', '--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:10:10 INFO - mozversion application_buildid: 20160718023044 05:10:10 INFO - mozversion application_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:10:10 INFO - mozversion application_display_name: Nightly 05:10:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:10 INFO - mozversion application_name: Firefox 05:10:10 INFO - mozversion application_remotingname: firefox 05:10:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:10 INFO - mozversion application_vendor: Mozilla 05:10:10 INFO - mozversion application_version: 50.0a1 05:10:10 INFO - mozversion platform_buildid: 20160718023044 05:10:10 INFO - mozversion platform_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:10:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:10 INFO - mozversion platform_version: 50.0a1 05:10:10 INFO - using testdate: 1468843810 05:10:10 INFO - actual date: 1468843810 05:10:10 INFO - starting webserver on 'localhost:40139' 05:10:10 INFO - SUITE-START | Running 2 tests 05:10:10 INFO - TEST-START | dromaeo_css 05:10:10 INFO - operating with platform_type : linux_ 05:10:10 INFO - Initialising browser for dromaeo_css test... 05:10:10 INFO - TEST-INFO | started process 5335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6vdPH2/profile http://localhost:40139/getInfo.html) 05:10:13 INFO - PROCESS | 5335 | JavaScript error: , line 0: uncaught exception: undefined 05:10:15 INFO - PROCESS | 5335 | __metrics Screen width/height:1600/1200 05:10:15 INFO - PROCESS | 5335 | colorDepth:24 05:10:15 INFO - PROCESS | 5335 | Browser inner width/height: 1024/697 05:10:15 INFO - PROCESS | 5335 | __metrics 05:10:15 ERROR - PROCESS | 5335 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:10:16 INFO - TEST-INFO | 5335: exit 0 05:10:16 INFO - Browser initialized. 05:10:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:16 INFO - TEST-INFO | started process 5457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6vdPH2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:28 INFO - PROCESS | 5457 | RSS: Main: 168124416 05:10:28 INFO - PROCESS | 5457 | 05:11:17 INFO - PROCESS | 5457 | 1468843877969 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:13:25 INFO - PROCESS | 5457 | Cycle 1(1): loaded http://localhost:40139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40139/tests/dromaeo/cssquery-ext.html) 05:13:26 INFO - PROCESS | 5457 | RSS: Main: 172306432 05:13:26 INFO - PROCESS | 5457 | 05:16:28 INFO - PROCESS | 5457 | Cycle 1(1): loaded http://localhost:40139/tests/dromaeo/cssquery-ext.html (next: http://localhost:40139/tests/dromaeo/cssquery-jquery.html) 05:16:29 INFO - PROCESS | 5457 | RSS: Main: 168775680 05:16:29 INFO - PROCESS | 5457 | 05:19:31 INFO - PROCESS | 5457 | Cycle 1(1): loaded http://localhost:40139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40139/tests/dromaeo/cssquery-mootools.html) 05:19:32 INFO - PROCESS | 5457 | RSS: Main: 172150784 05:19:32 INFO - PROCESS | 5457 | 05:22:33 INFO - PROCESS | 5457 | Cycle 1(1): loaded http://localhost:40139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40139/tests/dromaeo/cssquery-prototype.html) 05:22:34 INFO - PROCESS | 5457 | RSS: Main: 166842368 05:22:34 INFO - PROCESS | 5457 | 05:25:36 INFO - PROCESS | 5457 | Cycle 1(1): loaded http://localhost:40139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40139/tests/dromaeo/cssquery-yui.html) 05:25:37 INFO - PROCESS | 5457 | RSS: Main: 169152512 05:25:37 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | Cycle 1(1): loaded http://localhost:40139/tests/dromaeo/cssquery-yui.html (next: http://localhost:40139/tests/dromaeo/cssquery-dojo.html) 05:28:40 INFO - PROCESS | 5457 | RSS: Main: 172843008 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | __start_tp_report 05:28:40 INFO - PROCESS | 5457 | _x_x_mozilla_page_load 05:28:40 INFO - PROCESS | 5457 | _x_x_mozilla_page_load_details 05:28:40 INFO - PROCESS | 5457 | |i|pagename|runs| 05:28:40 INFO - PROCESS | 5457 | |0;dojo.html;3065.2643365592257;3140.984295078524;3149.543316219149;3175.079227024162;3184.219866132798;5391.353037635485;5455.67265964042;5466.808661696841;5526.336839579246;5603.047481928072;5335.386430560487;5357.517823395893;5399.325084364455;5433.375161856387;5533.031719449091;4908.0920029794515;4918.877028074309;5006.674566153207;5037.546620804127;5077.238414237857;717.2869182696853;4871.269309603553;4878.70727756334;4888.633352498559;5016.949830501703;4918.0901533216465;4926.950730492685;4931.211006238985;4960.355153830015;4965.925511117354;4951.950480495185;4958.057968985917;4974.129527332702;4977.975110124463;5001.674891132065;4929.75351232437;4973.950260497421;4979.7759100840185;5015.1975683890405;5019.247112933052;5434.7826086956475;5468.453154684539;5479.671219726829;5522.696251706155;5581.3302403711405;5604.635698679573;5737.454941780524;5806.071028635441;5810.941890581124;5826.126081087828;5832.270966129234;5957.791477298274;5960.433758792908;5963.612365196248;6006.879862402771;5454.10007348787;5470.480304371078;5518.006758783417;5541.0580201365465;5543.196236545718;5884.293884733774;5892.322382925932;5987.161797348374;6102.664353460514;6103;5811.476967072984;5818.156367326714;5823.650580965155;5826.912596311059;5830.212921255661;5953.910691339634;5965.940340596539;5967.5524335675;5973.223480947536;5976.402359763989;5781.971090144607;5822.650640961556;5877.353491115974;5884.676342801102;5937.673427961504;5862.765489380377;5870.178175055496;5902.970485147547;5916.911246331309;5932.139839723216;4362.236608593484;4478.41780568524;4485.820567177277;4492.326151077299;4528.275475923836;3870.554886188068;3939.074317535377;3968.3650615901315;4000.239954408653;4007.5591684914634;5600;5658.858528536737;5683.147527870852;5707.6290041147195;5724.599278050579;5705.885882282331;5948.791792287336;5969.880602388015;5971.581989260797;5983.730732117066;5471.753771080311;5570.442955704397;5592.105263157875;5608.831735047955;5610.214569960209;4997.475265097185;5038.899222015539;5046.243063540425;5059.114654935372;5083.262926875583;5964.045752679551;6040.063790112539;6066.363031881677;6073.726682299307;6080;5789.45000224978;5849.94150058494;5892.263467066617;5904.114382842608;5912.142739302863;6033.728482218398;6036.63780173191;6053.848653783691;6064.3026052002815;6066.848328791815;5650.802221922213;5765.192872997867;5765.654060756368;5770.942290577041;5782.421757824184;5750.6262092963825;5782.045962416154;5801.564882633735;5826.271716035496;5826.446487583673;5598.636088654224;5654.547636189177;5664.150377443417;5684.943150568607;5687.715614219355;5614.803481878114;5625.09998400254;5652.236948011966;5670.914936275876;5693.4875861172695;5628.465295796893;5682.801101961411;5717.685527296038;5730.885382292414;5756.510696590837;5751.568632352674;5760.683162426107;5768.711564421846;5787.102999035156;5789.884202316014;5448.618596698351;5554.222408862682;5600.355959064596;5643.463870932255;5645.745941432728 05:28:40 INFO - PROCESS | 5457 | |1;ext.html;561.1162419189775;598.279073716172;598.3448124303889;616.8026231605886;640.8269767162869;40593.3910991335;41954.16091678165;44619.553804461946;44815.551844481546;44825.32762008572;45665.31502027472;45824.083518329615;46026.539734602644;46213.53786462134;46417;8947.642094316236;9139.817203655923;9183;9184.127507886773;9195.034521375259;9100.63597456101;9186.632534698603;9201.355905086646;9208.723738287863;9263.675771348004;9167.358284920057;9188.770280743001;9224.815503689922;9246.768830779218;9247.12152345526;9195.678151264707;9245.352825302232;9259.120383563584;9282.396644218104;9282.489463079528;9068.183863452256;9153.496557689325;9157.038510956387;9158.084191580856;9158.221551168159;32821.343573128404;43397.34903976443;43485.56514434879;43721.12557748859;43752.343714844304;3395.7453191010773;3449.534312867781;3614.548181477315;3634.854605815764;4006.8597599084183;32187;32528;32646.18384540382;32769.6723032769;32863.178420539436;4023.7786921719294;4082.040720430696;4088.12105397341;4130.855420060314;4193.769342686151;311719;313775;314414;315848;316743.9953602791;33164;33626.49560256598;34519.309613807585;35663.82168089143;35707.4643880342;35771.10572235715;36163.55345786192;36216.27567448689;36278;36365.63634363622;15310.770338444932;15410.537683869501;15459.690806184039;15487.380504779683;15549.689006219813;12955.417006234742;12955.740885182244;12990.480380784851;13003.739925201444;13078.411471483807;8064.516129032277;8150.307223886036;8175.14161013097;8213.34293256538;8255.298299644477;3169.508726147451;3177.9841100794347;3216.083416226364;3219.3561287742546;3284.0476261883787;978.6574698855486;1041.3075304922143;1083.377058191543;1101.24014430043;1111.5525975961093;33326.666733332844;33422.87643052572;33565.664343356744;33749;33797.49303760446;1131.9434028298551;1139.4986206069302;1184.7689700508317;1216.9878301217052;1241;17433.73849392235;17545.649087018188;17576.296948121933;17683.20425580826;17861.7320740189;598288;605979;606656;609643;614791;59441.702791486634;61509.692451537456;61570.69214653988;61707;62077.68961155165;1376.1880490510646;1389.1942673249491;1390.6592884743302;1391.8886489080849;1404.0873432269107;30733.69266307308;32679.18302042468;32688.83655581707;32843.671563284064;33330.16674583155;52081.47918520918;55158;56987.145192821314;57048.71475642595;63271.6836415815;568914;569324;571063;572116;573485;45189.774051129534;46075.53924460713;46094.76952615215;46140.84732374102;46634.76682616565;50551;51149.744251278506;51867.481325186265;51898.740506297225;52361;42908.35637465503;43352;43580.56419435765;43688.344674830536;45167.32249016202;43543.782281088395;43693.78153109214;44090;44144.7792761047;44153;42543.1491370177;43512.78243608762;43765;44299.557004429545;46251.306230407245;35866;38946;39300.21399571935;39327.41008884926;39511;29885;29964.850175748983;30146.24634384158;30202.24494387658;30463.543046854757 05:28:40 INFO - PROCESS | 5457 | |2;jquery.html;385.6432799660317;386.5091334005811;392.239056230912;395.2371922190173;414.09520198366573;14204.218767967757;18694.90652546737;19108;20381.49046273844;20414.69377959332;18780.71828922564;18881.527961800963;19354;19803.20787168515;20127.28918041968;5443.129099344106;5701.116326969326;5745.454181852718;5782.421757824226;5830.921279563273;5499.312585926759;5669.659820410768;5761.539076873861;5802.564807639423;5841.123831425278;5786.797462088828;5840.240768700063;5886.146508756227;5903.3211180714125;5910.379410161936;5871.236739223895;5898.115282707607;6054.878902421971;6080.787172448965;6091.238595175603;5839.386864379264;5856.385079566669;5903.822885313404;5930.7924222652;5944.138099975523;22946.426339341484;23193.76806231933;23966.76033239663;24094;24109.276721698378;2362.6456031595226;2488.191337815217;2606.4005278785794;2626.8704457083445;2811.9578206326923;10186.898131018668;10243.180545556337;10306.175505959505;10350.378977261313;10435.113015393701;1735.8350956659224;1816.7729033870767;1860.079260765916;1906.8855868647786;1918.2614693343023;84604.57697711534;86325;87363;88728;88934.11065889387;9189.494577798285;9749.31754777173;9855.176792293305;9890.258230632731;10133.847992279974;13144.014198934927;13216.273104979125;13242;13261.403236854365;13338.333083345988;7865.764027079197;8050.5169689818795;8111.351091912633;8262.380321475914;8313.792155196168;8285.751427457186;8292.875606865902;8357.164283571716;8564.700235491728;8569.95715021421;4032.516098068251;4094.2425651254016;4095.9180816383505;4137.420761093449;4153.501579810442;1947.795481474453;1953.404211715412;1970.0496508456524;2008.8794672319707;2018.6063717574932;921.8432866412726;984.675057231112;991.7272749993809;996.3922007575374;1055.7307886488895;19107.713384299248;20338;20496.897515512625;20684.896575517327;22136.77863221347;1013.9493025348851;1024.1960061351804;1046.4819914142397;1052.8736551613702;1100.0869278498826;10959.780804383867;11485.770284594428;11574.88425115755;11583.305001699757;11674.124440666814;512906;513081;514238;514998;559569;99048;99642;103304.48347758214;103446.4827675872;105076;1010.0808264479289;1049.4070849969742;1049.58541376156;1065.6802959112235;1069.1340014588209;17861;18074.548136296697;18528.629427411644;18586.814131858508;18759.718604220674;41514.792426037675;42186;43894.561054390324;44100.77949610232;44635;55201.72399137979;58241.4175858236;65418.67290663516;65710.67144664246;67196;7384.889226661497;7695.115061767969;7760.767176984699;7896.84206315859;8358.373122015995;9637.835661781117;13601.319934003459;13633.250171240677;13784.793228101787;13797.24115173675;11343.716407089889;11379.203455758348;11998.98008669238;12041.819372709591;12209.877901220874;11226.326420414802;11688.357140357362;11709;11735.178537502294;11869.5845645402;11347.886521135013;11901.345426001653;11916;12079.335636540074;12084.939575302067;7759.857257810596;7905.446618736633;7928.524288542706;7994.0407151142235;8004.159563245776;9939.204863611038;11118.49966751482;11255.324680519196;11650;11962.34207118582 05:28:40 INFO - PROCESS | 5457 | |3;mootools.html;1480.4744315767905;1514.2958524286205;1638.2791571708447;1751.0981844350154;1789.3737191982816;7751;8711.346649001318;8749.518776467292;9281.535923203846;9325.673601423952;8771.868421973675;8948.239399651022;9119.726408207764;9122.726318210463;9169.449833010023;2264.67162261472;2302.309307207831;2310.5378924215142;2314.6643736658175;2318.5362927414585;2152.7847215278503;2189.4964158243615;2192.0464597899886;2208.492046829222;2233.2630232023394;2279.31620513846;2286.4969706664506;2300.884955752214;2303.8041766449874;2312.271634435156;2233.5197932444603;2255.8984845681903;2256.4922892349173;2257.1535674122206;2272.534130503243;2131.3286314810784;2132.381609333307;2133.615949129156;2144.4531644430726;2145.989270053655;9141.634334626608;9172;9188.678396256166;9236;9246.398984066014;5128.692278463304;5237.921431178535;5258.1849813279005;5262.605304602132;5267.815626453094;3148.952765708493;3154.0853152585723;3217.581714377116;3228.564143840575;3263.983680081584;1086.5056399338362;1097.412884107007;1100.961466348682;1102.0522350778324;1113.9275947063495;12481.251124932533;12575.119741618091;12608.054395920342;12610.873891261153;12620.873791262062;4389.780510974502;4462.464504259509;4569.497355290915;4649;4667.486576476585;10461.633842815465;10554.102901253325;10558.102561282378;10567.841482377771;10615.416152111553;5244.685318880879;5252.527272545489;5259.737013149327;5275.5515781158265;5292.788288468495;4235.915281694411;4578.40480737502;4773.7374444405195;4850.902981940412;4870.4155501340065;3973.980130099331;3986.8405263789123;4018.4374187613757;4051.817668204938;4257.318828987347;1232.2668012532529;1291.0446269760498;1295.436485128972;1295.7732396830706;1299.3698056442618;990.0841721407669;997.0876647867266;1011.3325205364424;1012.6101450941441;1020.2959957629212;5929.6145750526075;6092.238470191226;6177.567570270128;6195.070739389038;6245.500359971192;427.3333599584658;430.3845500933695;439.2401146017344;439.3300217168779;443.49441636534374;4153.169366126726;4192.601702838226;4193.098483825931;4228.682848786353;4234.3860140279485;10622.681319560426;10863.130949524018;10909.290896091728;10917.454127293604;11012.614558490415;10814.080803131665;10816.296940698829;10817.350958942332;10819.404932728776;10876.61931832398;8054.838903221903;8250.133735957757;8312.459690120122;8352.373571982125;8474.703385381483;5946.791862284972;5968.731407086779;6075.726592303446;6120.08198770188;6235.158253635883;10207.285490015925;10244.436555989492;10325.483725813829;10461.424621645578;10555;10131.797364052825;10183.33808302458;10435.68692939213;10638.627648032281;10646.509488671438;7479;8171.959140204261;8407.663693452194;8638.13618638131;8661.307095432225;8761.868571971298;8765.868511972452;8804.779880503038;8836.823263534821;8845.646174153218;7671.2712292332135;7731.110922244014;7882.763517094496;7976.042874855055;8067.273945344947;7897.420515896729;7907.130215676156;7944.04671439431;8003.959980200062;8023.318017968305;7408.777736667908;7423.628818559158;7507.099148102263;7508.662110204945;7526.586037767756;4949.950500494949;5016.4198277542455;5029.974850125726;5044.394672639307;5086.084504789025;5151.793928242828;5176.844694659167;5199.610029247897;5202.8959420812125;5257 05:28:40 INFO - PROCESS | 5457 | |4;prototype.html;316.35147946709253;326.3798782313604;330.91561651778795;336.9444041733111;337.95099710541973;5563.471470210328;5568.916466253005;5617.297837770278;5648.378678345379;5658.349289831671;5520.889582208363;5584.776608935637;5597.076482380413;5609.625641717775;5619.353774315955;4382.145481631083;4390.297552391618;4405.80173892174;4406.294992801152;4415.867523974286;4267.679924005696;4346.521882592912;4354.825806967718;4379.08039311745;4397.846075387362;4293.1199104183725;4304.7632380219075;4310.56894310568;4324.718893271943;4343.978280108611;4350.390945267665;4352.933531284855;4373.890652733675;4375.321825117112;4390.341448782676;3561.4301711726;3719.925601487982;3866.6520013198665;3870.632289932452;3887.300285948528;5419.83740487786;5449.455054494559;5453.182022696587;5465.59008074392;5491.560675145979;4883.291922671193;4903.41159060915;4933.210686290212;4935.703857768545;4965.354503914504;5660.801871934463;5746.511546518551;5764.33710123337;5822.737976791054;5900.144479050514;4069.3895915612597;4075.49056367954;4093.1199792044854;4118.176364727036;4137.524184718765;5853.7365818538265;5898.469137777578;6114.419130182626;6121.265448146251;6140.324564297924;4102.610252026053;4104.4664193655235;4135.875923722293;4174.749515029108;4184.037671335549;4225.239456897788;4226.302660061056;4227.365895115758;4230.2174097792;4236.428082208862;4712.434507859079;4902.313676085351;4902.730349830794;4904.8038078477175;4924.482929292444;5838.065909454467;5847.666829906912;5864.882702346014;5872.0898260769645;5893.410658934158;1467.581739204343;1468.3465857693438;1468.9706205876037;1476.2987580898987;1477.8522147785136;897.6274845938992;923.879895613566;932.8927173375013;937.0910217089412;942.528735632184;4993.425756038029;5032.345795046621;5042.369703787027;5140.588752899759;5183.704073981505;5275.707451674288;5403.000444917624;5403.540699040547;5437.265969094122;5441.782328706808;5081.2632168335385;5096.388433388017;5139.252654097625;5338.91991620126;5810.738516766755;3205.8717651294155;3223.3069889973767;3226.48376259802;3237.5953005874267;3246.3994161080277;6023.668698221552;6164.321924588292;6216.316205217422;6262.342454042351;6354.714037868307;6050.42520960508;6129.938700612936;6139.29398119222;6145.477634401126;6148.415900489446;6189.514516516094;6213.565050446516;6241.063840423973;6274.780382686584;6309.917727150029;5825.854353641023;6007.249093863267;6068.423499767691;6074.605150665193;6110.450059494667;5964.314103877936;5976.342602313829;5982.192404025401;5989.64062156272;6070.726817293144;5904.439078287556;5977.625146216307;6180.351063138485;6182.196314479089;6218.22272215973;4206.179794939957;4206.47419072616;4208.305629571087;4218.409422680766;4223.746575205498;5851.239338885917;6038.245219347582;6111.297200821962;6133.478654314434;6135.570510064253;5826.446487583673;5934.851628709144;5944.881102377842;5988.706211583524;6024.9397506026135;5815.33123690764;5867.530597552271;5894.968380533303;5955.225820643289;5967.8209653710455;5698.629589076697;5813.418658134153;5824.854578527547;5845.912311315248;5861.648301101947;5989.460948514655;5991.281046274475;6000.639961602318;6019.006863867413;6050.878982420239;5664.518515926027;5764.423557644202;5796.232149194536;5852.4440178183;5872.970635146797 05:28:40 INFO - PROCESS | 5457 | |5;yui.html;705.1362081450225;705.7741522712731;716.1263258824233;766.8197973476234;845.3406343052419;13522.594322170326;14504.63738406539;14603.123812571253;14623.122612643236;14707;12988.675283117927;13077.67305817355;13303.534376296831;13339.599812005656;13422.39599218035;820.3314298846436;831.8377916306292;836.1554829622095;838.0278876503257;839.2069494327862;836.8870202522672;837.2757564706516;840.7015509494133;842.1157784326464;843.3590471241839;869.652139144341;874.623911717961;879.9956000220022;882.5675419044654;883.8320719063357;871.3508436214997;872.4634349874781;872.7120050383359;874.558348034245;878.1525827576355;638.8945823939044;639.341478277375;639.7313128486047;640.7725257533555;641.4515589171285;12563.623091307276;12583.307918064504;12601.873981260162;12602.621921342374;12608.36958152098;12343.876561234363;12364.258144511268;12466;12618.558350457783;12673.873261267361;10842.783144337069;11258.718532036764;11297.717557061056;11570.305781653127;11781.121207607164;4426.402435671175;4440.600345968878;4441.977790111029;4444.177827101997;4675.7895894684825;57630.423695762925;68824.31175688279;73009;73744.89382659318;80190.59904700439;11372.20394572372;11625.88374116265;11680.88319116815;11720.120990925714;11737.413129343498;23042.539149216922;23112.191073312355;23195.76804231936;23362.182323618592;23410.297691069296;8140.3487720982175;8328.958355208186;8486.787830304293;8584.914150858536;8740.082291359317;4695.7886895089805;4800.1119792838435;4801.711897286104;4806.351142595775;4842.031593681278;3567;3632.4551317302617;3651.835667394974;3661.395869681526;3667.688246499024;655.0926966151819;667.8430568816422;668.518666560076;674.1270055278426;679.1646275081579;705.1960764728213;771.7453240430644;802.253903869407;811.7158994352047;840.3739214285397;9903.306768526278;9960.501974901372;10002.399856008662;10159.898401015895;10261.127804136731;748.9438292128112;756.0795579228807;763.091920614467;767.3630886364305;795.157133438557;4612.561806628365;4693.5775780179265;4835.274708793639;4846;4903.215485522371;92770;108084.45957770318;113802;113926.43036784929;115261;101058.49470752747;101436;102369.48815255876;102512;102943;87917;88784;88799.55600221957;90048;92193;9358;9628.133467987915;9646.42121472714;9660.903390966001;9663.710088697351;39749.60250397459;47663.76168119276;48181.5181848177;53742.46257537531;53785.19322210248;50344.48277586179;50609.746951265006;50612;76123.77054492226;81771.18228817874;13630.86369136296;13660.112092713942;13886.791698124334;13927.651808704863;14395.928020359832;13835.723285534032;13921.651958700708;14014.719705606034;14050.297485125908;14145.858541414866;13559.186448813103;13573.932130339284;13672.52146174879;13724.313784310545;14578.198199099152;13205.471781128646;13243;13463.932680336535;13487.32563371847;13499.595012149652;13224.669383265495;13226.867731322563;13603.183808971493;13604.319784010957;13630.386632601358;10370.481475926023;10395.584176633152;10610.257281990494;10940.835887461535;10954.507047182737;11719.472623731783;11750.29498230109;11758.176927614984;11821.622215343432;12443 05:28:40 INFO - PROCESS | 5457 | __end_tp_report 05:28:40 INFO - PROCESS | 5457 | __start_cc_report 05:28:40 INFO - PROCESS | 5457 | _x_x_mozilla_cycle_collect,372 05:28:40 INFO - PROCESS | 5457 | __end_cc_report 05:28:40 INFO - PROCESS | 5457 | __startTimestamp1468844920379__endTimestamp 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | ------- Summary: start ------- 05:28:40 INFO - PROCESS | 5457 | Number of tests: 6 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | [#0] dojo.html Cycles:165 Average:5416.83 Median:5654.55 stddev:728.77 (12.9%) stddev-sans-first:707.27 05:28:40 INFO - PROCESS | 5457 | Values: 3065.3 3141.0 3149.5 3175.1 3184.2 5391.4 5455.7 5466.8 5526.3 5603.0 5335.4 5357.5 5399.3 5433.4 5533.0 4908.1 4918.9 5006.7 5037.5 5077.2 717.3 4871.3 4878.7 4888.6 5016.9 4918.1 4927.0 4931.2 4960.4 4965.9 4952.0 4958.1 4974.1 4978.0 5001.7 4929.8 4974.0 4979.8 5015.2 5019.2 5434.8 5468.5 5479.7 5522.7 5581.3 5604.6 5737.5 5806.1 5810.9 5826.1 5832.3 5957.8 5960.4 5963.6 6006.9 5454.1 5470.5 5518.0 5541.1 5543.2 5884.3 5892.3 5987.2 6102.7 6103.0 5811.5 5818.2 5823.7 5826.9 5830.2 5953.9 5965.9 5967.6 5973.2 5976.4 5782.0 5822.7 5877.4 5884.7 5937.7 5862.8 5870.2 5903.0 5916.9 5932.1 4362.2 4478.4 4485.8 4492.3 4528.3 3870.6 3939.1 3968.4 4000.2 4007.6 5600.0 5658.9 5683.1 5707.6 5724.6 5705.9 5948.8 5969.9 5971.6 5983.7 5471.8 5570.4 5592.1 5608.8 5610.2 4997.5 5038.9 5046.2 5059.1 5083.3 5964.0 6040.1 6066.4 6073.7 6080.0 5789.5 5849.9 5892.3 5904.1 5912.1 6033.7 6036.6 6053.8 6064.3 6066.8 5650.8 5765.2 5765.7 5770.9 5782.4 5750.6 5782.0 5801.6 5826.3 5826.4 5598.6 5654.5 5664.2 5684.9 5687.7 5614.8 5625.1 5652.2 5670.9 5693.5 5628.5 5682.8 5717.7 5730.9 5756.5 5751.6 5760.7 5768.7 5787.1 5789.9 5448.6 5554.2 5600.4 5643.5 5645.7 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | [#1] ext.html Cycles:180 Average:64562.85 Median:43441.46 stddev:137428.85 (316.4%) stddev-sans-first:137730.36 05:28:40 INFO - PROCESS | 5457 | Values: 561.1 598.3 598.3 616.8 640.8 40593.4 41954.2 44619.6 44815.6 44825.3 45665.3 45824.1 46026.5 46213.5 46417.0 8947.6 9139.8 9183.0 9184.1 9195.0 9100.6 9186.6 9201.4 9208.7 9263.7 9167.4 9188.8 9224.8 9246.8 9247.1 9195.7 9245.4 9259.1 9282.4 9282.5 9068.2 9153.5 9157.0 9158.1 9158.2 32821.3 43397.3 43485.6 43721.1 43752.3 3395.7 3449.5 3614.5 3634.9 4006.9 32187.0 32528.0 32646.2 32769.7 32863.2 4023.8 4082.0 4088.1 4130.9 4193.8 311719.0 313775.0 314414.0 315848.0 316744.0 33164.0 33626.5 34519.3 35663.8 35707.5 35771.1 36163.6 36216.3 36278.0 36365.6 15310.8 15410.5 15459.7 15487.4 15549.7 12955.4 12955.7 12990.5 13003.7 13078.4 8064.5 8150.3 8175.1 8213.3 8255.3 3169.5 3178.0 3216.1 3219.4 3284.0 978.7 1041.3 1083.4 1101.2 1111.6 33326.7 33422.9 33565.7 33749.0 33797.5 1131.9 1139.5 1184.8 1217.0 1241.0 17433.7 17545.6 17576.3 17683.2 17861.7 598288.0 605979.0 606656.0 609643.0 614791.0 59441.7 61509.7 61570.7 61707.0 62077.7 1376.2 1389.2 1390.7 1391.9 1404.1 30733.7 32679.2 32688.8 32843.7 33330.2 52081.5 55158.0 56987.1 57048.7 63271.7 568914.0 569324.0 571063.0 572116.0 573485.0 45189.8 46075.5 46094.8 46140.8 46634.8 50551.0 51149.7 51867.5 51898.7 52361.0 42908.4 43352.0 43580.6 43688.3 45167.3 43543.8 43693.8 44090.0 44144.8 44153.0 42543.1 43512.8 43765.0 44299.6 46251.3 35866.0 38946.0 39300.2 39327.4 39511.0 29885.0 29964.9 30146.2 30202.2 30463.5 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | [#2] jquery.html Cycles:180 Average:30499.55 Median:2616.64 stddev:86502.94 (3305.9%) stddev-sans-first:86716.06 05:28:40 INFO - PROCESS | 5457 | Values: 385.6 386.5 392.2 395.2 414.1 14204.2 18694.9 19108.0 20381.5 20414.7 18780.7 18881.5 19354.0 19803.2 20127.3 5443.1 5701.1 5745.5 5782.4 5830.9 5499.3 5669.7 5761.5 5802.6 5841.1 5786.8 5840.2 5886.1 5903.3 5910.4 5871.2 5898.1 6054.9 6080.8 6091.2 5839.4 5856.4 5903.8 5930.8 5944.1 22946.4 23193.8 23966.8 24094.0 24109.3 2362.6 2488.2 2606.4 2626.9 2812.0 10186.9 10243.2 10306.2 10350.4 10435.1 1735.8 1816.8 1860.1 1906.9 1918.3 84604.6 86325.0 87363.0 88728.0 88934.1 9189.5 9749.3 9855.2 9890.3 10133.8 13144.0 13216.3 13242.0 13261.4 13338.3 7865.8 8050.5 8111.4 8262.4 8313.8 8285.8 8292.9 8357.2 8564.7 8570.0 4032.5 4094.2 4095.9 4137.4 4153.5 1947.8 1953.4 1970.0 2008.9 2018.6 921.8 984.7 991.7 996.4 1055.7 19107.7 20338.0 20496.9 20684.9 22136.8 1013.9 1024.2 1046.5 1052.9 1100.1 10959.8 11485.8 11574.9 11583.3 11674.1 512906.0 513081.0 514238.0 514998.0 559569.0 99048.0 99642.0 103304.5 103446.5 105076.0 1010.1 1049.4 1049.6 1065.7 1069.1 17861.0 18074.5 18528.6 18586.8 18759.7 41514.8 42186.0 43894.6 44100.8 44635.0 55201.7 58241.4 65418.7 65710.7 67196.0 7384.9 7695.1 7760.8 7896.8 8358.4 9637.8 13601.3 13633.3 13784.8 13797.2 11343.7 11379.2 11999.0 12041.8 12209.9 11226.3 11688.4 11709.0 11735.2 11869.6 11347.9 11901.3 11916.0 12079.3 12084.9 7759.9 7905.4 7928.5 7994.0 8004.2 9939.2 11118.5 11255.3 11650.0 11962.3 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | [#3] mootools.html Cycles:180 Average:5874.17 Median:2410.08 stddev:3416.57 (141.8%) stddev-sans-first:3410.21 05:28:40 INFO - PROCESS | 5457 | Values: 1480.5 1514.3 1638.3 1751.1 1789.4 7751.0 8711.3 8749.5 9281.5 9325.7 8771.9 8948.2 9119.7 9122.7 9169.4 2264.7 2302.3 2310.5 2314.7 2318.5 2152.8 2189.5 2192.0 2208.5 2233.3 2279.3 2286.5 2300.9 2303.8 2312.3 2233.5 2255.9 2256.5 2257.2 2272.5 2131.3 2132.4 2133.6 2144.5 2146.0 9141.6 9172.0 9188.7 9236.0 9246.4 5128.7 5237.9 5258.2 5262.6 5267.8 3149.0 3154.1 3217.6 3228.6 3264.0 1086.5 1097.4 1101.0 1102.1 1113.9 12481.3 12575.1 12608.1 12610.9 12620.9 4389.8 4462.5 4569.5 4649.0 4667.5 10461.6 10554.1 10558.1 10567.8 10615.4 5244.7 5252.5 5259.7 5275.6 5292.8 4235.9 4578.4 4773.7 4850.9 4870.4 3974.0 3986.8 4018.4 4051.8 4257.3 1232.3 1291.0 1295.4 1295.8 1299.4 990.1 997.1 1011.3 1012.6 1020.3 5929.6 6092.2 6177.6 6195.1 6245.5 427.3 430.4 439.2 439.3 443.5 4153.2 4192.6 4193.1 4228.7 4234.4 10622.7 10863.1 10909.3 10917.5 11012.6 10814.1 10816.3 10817.4 10819.4 10876.6 8054.8 8250.1 8312.5 8352.4 8474.7 5946.8 5968.7 6075.7 6120.1 6235.2 10207.3 10244.4 10325.5 10461.4 10555.0 10131.8 10183.3 10435.7 10638.6 10646.5 7479.0 8172.0 8407.7 8638.1 8661.3 8761.9 8765.9 8804.8 8836.8 8845.6 7671.3 7731.1 7882.8 7976.0 8067.3 7897.4 7907.1 7944.0 8004.0 8023.3 7408.8 7423.6 7507.1 7508.7 7526.6 4950.0 5016.4 5030.0 5044.4 5086.1 5151.8 5176.8 5199.6 5202.9 5257.0 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | [#4] prototype.html Cycles:180 Average:4886.59 Median:5566.19 stddev:1455.41 (26.1%) stddev-sans-first:1418.49 05:28:40 INFO - PROCESS | 5457 | Values: 316.4 326.4 330.9 336.9 338.0 5563.5 5568.9 5617.3 5648.4 5658.3 5520.9 5584.8 5597.1 5609.6 5619.4 4382.1 4390.3 4405.8 4406.3 4415.9 4267.7 4346.5 4354.8 4379.1 4397.8 4293.1 4304.8 4310.6 4324.7 4344.0 4350.4 4352.9 4373.9 4375.3 4390.3 3561.4 3719.9 3866.7 3870.6 3887.3 5419.8 5449.5 5453.2 5465.6 5491.6 4883.3 4903.4 4933.2 4935.7 4965.4 5660.8 5746.5 5764.3 5822.7 5900.1 4069.4 4075.5 4093.1 4118.2 4137.5 5853.7 5898.5 6114.4 6121.3 6140.3 4102.6 4104.5 4135.9 4174.7 4184.0 4225.2 4226.3 4227.4 4230.2 4236.4 4712.4 4902.3 4902.7 4904.8 4924.5 5838.1 5847.7 5864.9 5872.1 5893.4 1467.6 1468.3 1469.0 1476.3 1477.9 897.6 923.9 932.9 937.1 942.5 4993.4 5032.3 5042.4 5140.6 5183.7 5275.7 5403.0 5403.5 5437.3 5441.8 5081.3 5096.4 5139.3 5338.9 5810.7 3205.9 3223.3 3226.5 3237.6 3246.4 6023.7 6164.3 6216.3 6262.3 6354.7 6050.4 6129.9 6139.3 6145.5 6148.4 6189.5 6213.6 6241.1 6274.8 6309.9 5825.9 6007.2 6068.4 6074.6 6110.5 5964.3 5976.3 5982.2 5989.6 6070.7 5904.4 5977.6 6180.4 6182.2 6218.2 4206.2 4206.5 4208.3 4218.4 4223.7 5851.2 6038.2 6111.3 6133.5 6135.6 5826.4 5934.9 5944.9 5988.7 6024.9 5815.3 5867.5 5895.0 5955.2 5967.8 5698.6 5813.4 5824.9 5845.9 5861.6 5989.5 5991.3 6000.6 6019.0 6050.9 5664.5 5764.4 5796.2 5852.4 5873.0 05:28:40 INFO - PROCESS | 5457 | 05:28:40 INFO - PROCESS | 5457 | [#5] yui.html Cycles:180 Average:20122.72 Median:4443.08 stddev:29081.78 (654.5%) stddev-sans-first:29126.81 05:28:40 INFO - PROCESS | 5457 | Values: 705.1 705.8 716.1 766.8 845.3 13522.6 14504.6 14603.1 14623.1 14707.0 12988.7 13077.7 13303.5 13339.6 13422.4 820.3 831.8 836.2 838.0 839.2 836.9 837.3 840.7 842.1 843.4 869.7 874.6 880.0 882.6 883.8 871.4 872.5 872.7 874.6 878.2 638.9 639.3 639.7 640.8 641.5 12563.6 12583.3 12601.9 12602.6 12608.4 12343.9 12364.3 12466.0 12618.6 12673.9 10842.8 11258.7 11297.7 11570.3 11781.1 4426.4 4440.6 4442.0 4444.2 4675.8 57630.4 68824.3 73009.0 73744.9 80190.6 11372.2 11625.9 11680.9 11720.1 11737.4 23042.5 23112.2 23195.8 23362.2 23410.3 8140.3 8329.0 8486.8 8584.9 8740.1 4695.8 4800.1 4801.7 4806.4 4842.0 3567.0 3632.5 3651.8 3661.4 3667.7 655.1 667.8 668.5 674.1 679.2 705.2 771.7 802.3 811.7 840.4 9903.3 9960.5 10002.4 10159.9 10261.1 748.9 756.1 763.1 767.4 795.2 4612.6 4693.6 4835.3 4846.0 4903.2 92770.0 108084.5 113802.0 113926.4 115261.0 101058.5 101436.0 102369.5 102512.0 102943.0 87917.0 88784.0 88799.6 90048.0 92193.0 9358.0 9628.1 9646.4 9660.9 9663.7 39749.6 47663.8 48181.5 53742.5 53785.2 50344.5 50609.7 50612.0 76123.8 81771.2 13630.9 13660.1 13886.8 13927.7 14395.9 13835.7 13921.7 14014.7 14050.3 14145.9 13559.2 13573.9 13672.5 13724.3 14578.2 13205.5 13243.0 13463.9 13487.3 13499.6 13224.7 13226.9 13603.2 13604.3 13630.4 10370.5 10395.6 10610.3 10940.8 10954.5 11719.5 11750.3 11758.2 11821.6 12443.0 05:28:40 INFO - PROCESS | 5457 | -------- Summary: end -------- 05:28:40 INFO - PROCESS | 5457 | 05:28:41 INFO - TEST-INFO | 5457: exit 0 05:28:41 INFO - TEST-OK | dromaeo_css | took 1110830ms 05:28:41 INFO - TEST-START | kraken 05:28:41 INFO - operating with platform_type : linux_ 05:28:41 INFO - Initialising browser for kraken test... 05:28:41 INFO - TEST-INFO | started process 5703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNIhEk/profile http://localhost:40139/getInfo.html) 05:28:44 INFO - PROCESS | 5703 | JavaScript error: , line 0: uncaught exception: undefined 05:28:45 INFO - PROCESS | 5703 | __metrics Screen width/height:1600/1200 05:28:45 INFO - PROCESS | 5703 | colorDepth:24 05:28:45 INFO - PROCESS | 5703 | Browser inner width/height: 1024/697 05:28:45 INFO - PROCESS | 5703 | __metrics 05:28:46 ERROR - PROCESS | 5703 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:28:47 INFO - TEST-INFO | 5703: exit 0 05:28:47 INFO - Browser initialized. 05:28:47 INFO - Running cycle 1/1 for kraken test... 05:28:47 INFO - TEST-INFO | started process 5825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNIhEk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:58 INFO - PROCESS | 5825 | RSS: Main: 168411136 05:28:58 INFO - PROCESS | 5825 | 05:29:01 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40139/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:02 INFO - PROCESS | 5825 | RSS: Main: 173305856 05:29:02 INFO - PROCESS | 5825 | 05:29:04 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40139/tests/kraken/driver.html?testName=audio-dft) 05:29:05 INFO - PROCESS | 5825 | RSS: Main: 172646400 05:29:05 INFO - PROCESS | 5825 | 05:29:08 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40139/tests/kraken/driver.html?testName=audio-fft) 05:29:08 INFO - PROCESS | 5825 | RSS: Main: 167383040 05:29:08 INFO - PROCESS | 5825 | 05:29:11 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40139/tests/kraken/driver.html?testName=audio-oscillator) 05:29:11 INFO - PROCESS | 5825 | RSS: Main: 168620032 05:29:11 INFO - PROCESS | 5825 | 05:29:13 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:14 INFO - PROCESS | 5825 | RSS: Main: 168886272 05:29:14 INFO - PROCESS | 5825 | 05:29:17 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40139/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:18 INFO - PROCESS | 5825 | RSS: Main: 168722432 05:29:18 INFO - PROCESS | 5825 | 05:29:21 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40139/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:22 INFO - PROCESS | 5825 | RSS: Main: 169721856 05:29:22 INFO - PROCESS | 5825 | 05:29:25 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40139/tests/kraken/driver.html?testName=json-parse-financial) 05:29:25 INFO - PROCESS | 5825 | RSS: Main: 169148416 05:29:25 INFO - PROCESS | 5825 | 05:29:27 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:27 INFO - PROCESS | 5825 | RSS: Main: 169132032 05:29:27 INFO - PROCESS | 5825 | 05:29:29 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:30 INFO - PROCESS | 5825 | RSS: Main: 169889792 05:29:30 INFO - PROCESS | 5825 | 05:29:32 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:33 INFO - PROCESS | 5825 | RSS: Main: 170065920 05:29:33 INFO - PROCESS | 5825 | 05:29:35 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:36 INFO - PROCESS | 5825 | RSS: Main: 169930752 05:29:36 INFO - PROCESS | 5825 | 05:29:39 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:39 INFO - PROCESS | 5825 | RSS: Main: 170348544 05:29:39 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | Cycle 1(1): loaded http://localhost:40139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40139/tests/kraken/driver.html?testName=ai-astar) 05:29:41 INFO - PROCESS | 5825 | RSS: Main: 170483712 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | __start_tp_report 05:29:41 INFO - PROCESS | 5825 | _x_x_mozilla_page_load 05:29:41 INFO - PROCESS | 5825 | _x_x_mozilla_page_load_details 05:29:41 INFO - PROCESS | 5825 | |i|pagename|runs| 05:29:41 INFO - PROCESS | 5825 | |0;ai-astar;100;111;107;111;111;114;112;112;110;110 05:29:41 INFO - PROCESS | 5825 | |1;audio-beat-detection;156;119;149;166;126;151;156;120;196;120 05:29:41 INFO - PROCESS | 5825 | |2;audio-dft;162;164;167;162;163;164;177;167;163;163 05:29:41 INFO - PROCESS | 5825 | |3;audio-fft;75;75;76;171;76;76;76;76;165;76 05:29:41 INFO - PROCESS | 5825 | |4;audio-oscillator;83;84;144;84;85;84;148;84;85;155 05:29:41 INFO - PROCESS | 5825 | |5;imaging-gaussian-blur;119;118;118;117;118;117;117;117;118;117 05:29:41 INFO - PROCESS | 5825 | |6;imaging-darkroom;148;148;147;147;148;147;147;147;149;148 05:29:41 INFO - PROCESS | 5825 | |7;imaging-desaturate;96;97;96;95;96;96;95;96;95;96 05:29:41 INFO - PROCESS | 5825 | |8;json-parse-financial;52;56;53;56;55;53;55;54;52;54 05:29:41 INFO - PROCESS | 5825 | |9;json-stringify-tinderbox;63;63;62;63;64;63;63;64;63;63 05:29:41 INFO - PROCESS | 5825 | |10;stanford-crypto-aes;85;75;77;76;84;81;76;76;81;79 05:29:41 INFO - PROCESS | 5825 | |11;stanford-crypto-ccm;139;119;129;117;120;121;150;121;181;126 05:29:41 INFO - PROCESS | 5825 | |12;stanford-crypto-pbkdf2;161;162;159;156;158;157;160;158;161;155 05:29:41 INFO - PROCESS | 5825 | |13;stanford-crypto-sha256-iterative;64;65;63;63;64;63;65;63;62;62 05:29:41 INFO - PROCESS | 5825 | __end_tp_report 05:29:41 INFO - PROCESS | 5825 | __start_cc_report 05:29:41 INFO - PROCESS | 5825 | _x_x_mozilla_cycle_collect,927 05:29:41 INFO - PROCESS | 5825 | __end_cc_report 05:29:41 INFO - PROCESS | 5825 | __startTimestamp1468844981653__endTimestamp 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | ------- Summary: start ------- 05:29:41 INFO - PROCESS | 5825 | Number of tests: 14 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.88 (3.5%) stddev-sans-first:1.90 05:29:41 INFO - PROCESS | 5825 | Values: 100.0 111.0 107.0 111.0 111.0 114.0 112.0 112.0 110.0 110.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:153.50 stddev:24.98 (16.3%) stddev-sans-first:26.22 05:29:41 INFO - PROCESS | 5825 | Values: 156.0 119.0 149.0 166.0 126.0 151.0 156.0 120.0 196.0 120.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:4.52 (2.8%) stddev-sans-first:4.64 05:29:41 INFO - PROCESS | 5825 | Values: 162.0 164.0 167.0 162.0 163.0 164.0 177.0 167.0 163.0 163.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:38.92 (51.2%) stddev-sans-first:40.66 05:29:41 INFO - PROCESS | 5825 | Values: 75.0 75.0 76.0 171.0 76.0 76.0 76.0 76.0 165.0 76.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.00 stddev:31.44 (37.4%) stddev-sans-first:32.46 05:29:41 INFO - PROCESS | 5825 | Values: 83.0 84.0 144.0 84.0 85.0 84.0 148.0 84.0 85.0 155.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 05:29:41 INFO - PROCESS | 5825 | Values: 119.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 05:29:41 INFO - PROCESS | 5825 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 149.0 148.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:29:41 INFO - PROCESS | 5825 | Values: 96.0 97.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.50 stddev:1.49 (2.7%) stddev-sans-first:1.39 05:29:41 INFO - PROCESS | 5825 | Values: 52.0 56.0 53.0 56.0 55.0 53.0 55.0 54.0 52.0 54.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 05:29:41 INFO - PROCESS | 5825 | Values: 63.0 63.0 62.0 63.0 64.0 63.0 63.0 64.0 63.0 63.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:80.00 stddev:3.59 (4.5%) stddev-sans-first:3.08 05:29:41 INFO - PROCESS | 5825 | Values: 85.0 75.0 77.0 76.0 84.0 81.0 76.0 76.0 81.0 79.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:127.50 stddev:19.99 (15.7%) stddev-sans-first:21.06 05:29:41 INFO - PROCESS | 5825 | Values: 139.0 119.0 129.0 117.0 120.0 121.0 150.0 121.0 181.0 126.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.50 stddev:2.31 (1.4%) stddev-sans-first:2.30 05:29:41 INFO - PROCESS | 5825 | Values: 161.0 162.0 159.0 156.0 158.0 157.0 160.0 158.0 161.0 155.0 05:29:41 INFO - PROCESS | 5825 | 05:29:41 INFO - PROCESS | 5825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.07 (1.7%) stddev-sans-first:1.12 05:29:41 INFO - PROCESS | 5825 | Values: 64.0 65.0 63.0 63.0 64.0 63.0 65.0 63.0 62.0 62.0 05:29:41 INFO - PROCESS | 5825 | -------- Summary: end -------- 05:29:41 INFO - PROCESS | 5825 | 05:29:42 INFO - TEST-INFO | 5825: exit 0 05:29:42 INFO - TEST-OK | kraken | took 61486ms 05:29:42 INFO - SUITE-END | took 1172s 05:29:42 INFO - Completed test suite (00:19:32) 05:29:42 INFO - javascript benchmark 05:29:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7277.197681983562, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.2643365592257, 3140.984295078524, 3149.543316219149, 3175.079227024162, 3184.219866132798, 5391.353037635485, 5455.67265964042, 5466.808661696841, 5526.336839579246, 5603.047481928072, 5335.386430560487, 5357.517823395893, 5399.325084364455, 5433.375161856387, 5533.031719449091, 4908.0920029794515, 4918.877028074309, 5006.674566153207, 5037.546620804127, 5077.238414237857, 717.2869182696853, 4871.269309603553, 4878.70727756334, 4888.633352498559, 5016.949830501703, 4918.0901533216465, 4926.950730492685, 4931.211006238985, 4960.355153830015, 4965.925511117354, 4951.950480495185, 4958.057968985917, 4974.129527332702, 4977.975110124463, 5001.674891132065, 4929.75351232437, 4973.950260497421, 4979.7759100840185, 5015.1975683890405, 5019.247112933052, 5434.7826086956475, 5468.453154684539, 5479.671219726829, 5522.696251706155, 5581.3302403711405, 5604.635698679573, 5737.454941780524, 5806.071028635441, 5810.941890581124, 5826.126081087828, 5832.270966129234, 5957.791477298274, 5960.433758792908, 5963.612365196248, 6006.879862402771, 5454.10007348787, 5470.480304371078, 5518.006758783417, 5541.0580201365465, 5543.196236545718, 5884.293884733774, 5892.322382925932, 5987.161797348374, 6102.664353460514, 6103.0, 5811.476967072984, 5818.156367326714, 5823.650580965155, 5826.912596311059, 5830.212921255661, 5953.910691339634, 5965.940340596539, 5967.5524335675, 5973.223480947536, 5976.402359763989, 5781.971090144607, 5822.650640961556, 5877.353491115974, 5884.676342801102, 5937.673427961504, 5862.765489380377, 5870.178175055496, 5902.970485147547, 5916.911246331309, 5932.139839723216, 4362.236608593484, 4478.41780568524, 4485.820567177277, 4492.326151077299, 4528.275475923836, 3870.554886188068, 3939.074317535377, 3968.3650615901315, 4000.239954408653, 4007.5591684914634, 5600.0, 5658.858528536737, 5683.147527870852, 5707.6290041147195, 5724.599278050579, 5705.885882282331, 5948.791792287336, 5969.880602388015, 5971.581989260797, 5983.730732117066, 5471.753771080311, 5570.442955704397, 5592.105263157875, 5608.831735047955, 5610.214569960209, 4997.475265097185, 5038.899222015539, 5046.243063540425, 5059.114654935372, 5083.262926875583, 5964.045752679551, 6040.063790112539, 6066.363031881677, 6073.726682299307, 6080.0, 5789.45000224978, 5849.94150058494, 5892.263467066617, 5904.114382842608, 5912.142739302863, 6033.728482218398, 6036.63780173191, 6053.848653783691, 6064.3026052002815, 6066.848328791815, 5650.802221922213, 5765.192872997867, 5765.654060756368, 5770.942290577041, 5782.421757824184, 5750.6262092963825, 5782.045962416154, 5801.564882633735, 5826.271716035496, 5826.446487583673, 5598.636088654224, 5654.547636189177, 5664.150377443417, 5684.943150568607, 5687.715614219355, 5614.803481878114, 5625.09998400254, 5652.236948011966, 5670.914936275876, 5693.4875861172695, 5628.465295796893, 5682.801101961411, 5717.685527296038, 5730.885382292414, 5756.510696590837, 5751.568632352674, 5760.683162426107, 5768.711564421846, 5787.102999035156, 5789.884202316014, 5448.618596698351, 5554.222408862682, 5600.355959064596, 5643.463870932255, 5645.745941432728], "value": 5368.17208323448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1162419189775, 598.279073716172, 598.3448124303889, 616.8026231605886, 640.8269767162869, 40593.3910991335, 41954.16091678165, 44619.553804461946, 44815.551844481546, 44825.32762008572, 45665.31502027472, 45824.083518329615, 46026.539734602644, 46213.53786462134, 46417.0, 8947.642094316236, 9139.817203655923, 9183.0, 9184.127507886773, 9195.034521375259, 9100.63597456101, 9186.632534698603, 9201.355905086646, 9208.723738287863, 9263.675771348004, 9167.358284920057, 9188.770280743001, 9224.815503689922, 9246.768830779218, 9247.12152345526, 9195.678151264707, 9245.352825302232, 9259.120383563584, 9282.396644218104, 9282.489463079528, 9068.183863452256, 9153.496557689325, 9157.038510956387, 9158.084191580856, 9158.221551168159, 32821.343573128404, 43397.34903976443, 43485.56514434879, 43721.12557748859, 43752.343714844304, 3395.7453191010773, 3449.534312867781, 3614.548181477315, 3634.854605815764, 4006.8597599084183, 32187.0, 32528.0, 32646.18384540382, 32769.6723032769, 32863.178420539436, 4023.7786921719294, 4082.040720430696, 4088.12105397341, 4130.855420060314, 4193.769342686151, 311719.0, 313775.0, 314414.0, 315848.0, 316743.9953602791, 33164.0, 33626.49560256598, 34519.309613807585, 35663.82168089143, 35707.4643880342, 35771.10572235715, 36163.55345786192, 36216.27567448689, 36278.0, 36365.63634363622, 15310.770338444932, 15410.537683869501, 15459.690806184039, 15487.380504779683, 15549.689006219813, 12955.417006234742, 12955.740885182244, 12990.480380784851, 13003.739925201444, 13078.411471483807, 8064.516129032277, 8150.307223886036, 8175.14161013097, 8213.34293256538, 8255.298299644477, 3169.508726147451, 3177.9841100794347, 3216.083416226364, 3219.3561287742546, 3284.0476261883787, 978.6574698855486, 1041.3075304922143, 1083.377058191543, 1101.24014430043, 1111.5525975961093, 33326.666733332844, 33422.87643052572, 33565.664343356744, 33749.0, 33797.49303760446, 1131.9434028298551, 1139.4986206069302, 1184.7689700508317, 1216.9878301217052, 1241.0, 17433.73849392235, 17545.649087018188, 17576.296948121933, 17683.20425580826, 17861.7320740189, 598288.0, 605979.0, 606656.0, 609643.0, 614791.0, 59441.702791486634, 61509.692451537456, 61570.69214653988, 61707.0, 62077.68961155165, 1376.1880490510646, 1389.1942673249491, 1390.6592884743302, 1391.8886489080849, 1404.0873432269107, 30733.69266307308, 32679.18302042468, 32688.83655581707, 32843.671563284064, 33330.16674583155, 52081.47918520918, 55158.0, 56987.145192821314, 57048.71475642595, 63271.6836415815, 568914.0, 569324.0, 571063.0, 572116.0, 573485.0, 45189.774051129534, 46075.53924460713, 46094.76952615215, 46140.84732374102, 46634.76682616565, 50551.0, 51149.744251278506, 51867.481325186265, 51898.740506297225, 52361.0, 42908.35637465503, 43352.0, 43580.56419435765, 43688.344674830536, 45167.32249016202, 43543.782281088395, 43693.78153109214, 44090.0, 44144.7792761047, 44153.0, 42543.1491370177, 43512.78243608762, 43765.0, 44299.557004429545, 46251.306230407245, 35866.0, 38946.0, 39300.21399571935, 39327.41008884926, 39511.0, 29885.0, 29964.850175748983, 30146.24634384158, 30202.24494387658, 30463.543046854757], "value": 19565.06182849005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6432799660317, 386.5091334005811, 392.239056230912, 395.2371922190173, 414.09520198366573, 14204.218767967757, 18694.90652546737, 19108.0, 20381.49046273844, 20414.69377959332, 18780.71828922564, 18881.527961800963, 19354.0, 19803.20787168515, 20127.28918041968, 5443.129099344106, 5701.116326969326, 5745.454181852718, 5782.421757824226, 5830.921279563273, 5499.312585926759, 5669.659820410768, 5761.539076873861, 5802.564807639423, 5841.123831425278, 5786.797462088828, 5840.240768700063, 5886.146508756227, 5903.3211180714125, 5910.379410161936, 5871.236739223895, 5898.115282707607, 6054.878902421971, 6080.787172448965, 6091.238595175603, 5839.386864379264, 5856.385079566669, 5903.822885313404, 5930.7924222652, 5944.138099975523, 22946.426339341484, 23193.76806231933, 23966.76033239663, 24094.0, 24109.276721698378, 2362.6456031595226, 2488.191337815217, 2606.4005278785794, 2626.8704457083445, 2811.9578206326923, 10186.898131018668, 10243.180545556337, 10306.175505959505, 10350.378977261313, 10435.113015393701, 1735.8350956659224, 1816.7729033870767, 1860.079260765916, 1906.8855868647786, 1918.2614693343023, 84604.57697711534, 86325.0, 87363.0, 88728.0, 88934.11065889387, 9189.494577798285, 9749.31754777173, 9855.176792293305, 9890.258230632731, 10133.847992279974, 13144.014198934927, 13216.273104979125, 13242.0, 13261.403236854365, 13338.333083345988, 7865.764027079197, 8050.5169689818795, 8111.351091912633, 8262.380321475914, 8313.792155196168, 8285.751427457186, 8292.875606865902, 8357.164283571716, 8564.700235491728, 8569.95715021421, 4032.516098068251, 4094.2425651254016, 4095.9180816383505, 4137.420761093449, 4153.501579810442, 1947.795481474453, 1953.404211715412, 1970.0496508456524, 2008.8794672319707, 2018.6063717574932, 921.8432866412726, 984.675057231112, 991.7272749993809, 996.3922007575374, 1055.7307886488895, 19107.713384299248, 20338.0, 20496.897515512625, 20684.896575517327, 22136.77863221347, 1013.9493025348851, 1024.1960061351804, 1046.4819914142397, 1052.8736551613702, 1100.0869278498826, 10959.780804383867, 11485.770284594428, 11574.88425115755, 11583.305001699757, 11674.124440666814, 512906.0, 513081.0, 514238.0, 514998.0, 559569.0, 99048.0, 99642.0, 103304.48347758214, 103446.4827675872, 105076.0, 1010.0808264479289, 1049.4070849969742, 1049.58541376156, 1065.6802959112235, 1069.1340014588209, 17861.0, 18074.548136296697, 18528.629427411644, 18586.814131858508, 18759.718604220674, 41514.792426037675, 42186.0, 43894.561054390324, 44100.77949610232, 44635.0, 55201.72399137979, 58241.4175858236, 65418.67290663516, 65710.67144664246, 67196.0, 7384.889226661497, 7695.115061767969, 7760.767176984699, 7896.84206315859, 8358.373122015995, 9637.835661781117, 13601.319934003459, 13633.250171240677, 13784.793228101787, 13797.24115173675, 11343.716407089889, 11379.203455758348, 11998.98008669238, 12041.819372709591, 12209.877901220874, 11226.326420414802, 11688.357140357362, 11709.0, 11735.178537502294, 11869.5845645402, 11347.886521135013, 11901.345426001653, 11916.0, 12079.335636540074, 12084.939575302067, 7759.857257810596, 7905.446618736633, 7928.524288542706, 7994.0407151142235, 8004.159563245776, 9939.204863611038, 11118.49966751482, 11255.324680519196, 11650.0, 11962.34207118582], "value": 9284.846447041824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.4744315767905, 1514.2958524286205, 1638.2791571708447, 1751.0981844350154, 1789.3737191982816, 7751.0, 8711.346649001318, 8749.518776467292, 9281.535923203846, 9325.673601423952, 8771.868421973675, 8948.239399651022, 9119.726408207764, 9122.726318210463, 9169.449833010023, 2264.67162261472, 2302.309307207831, 2310.5378924215142, 2314.6643736658175, 2318.5362927414585, 2152.7847215278503, 2189.4964158243615, 2192.0464597899886, 2208.492046829222, 2233.2630232023394, 2279.31620513846, 2286.4969706664506, 2300.884955752214, 2303.8041766449874, 2312.271634435156, 2233.5197932444603, 2255.8984845681903, 2256.4922892349173, 2257.1535674122206, 2272.534130503243, 2131.3286314810784, 2132.381609333307, 2133.615949129156, 2144.4531644430726, 2145.989270053655, 9141.634334626608, 9172.0, 9188.678396256166, 9236.0, 9246.398984066014, 5128.692278463304, 5237.921431178535, 5258.1849813279005, 5262.605304602132, 5267.815626453094, 3148.952765708493, 3154.0853152585723, 3217.581714377116, 3228.564143840575, 3263.983680081584, 1086.5056399338362, 1097.412884107007, 1100.961466348682, 1102.0522350778324, 1113.9275947063495, 12481.251124932533, 12575.119741618091, 12608.054395920342, 12610.873891261153, 12620.873791262062, 4389.780510974502, 4462.464504259509, 4569.497355290915, 4649.0, 4667.486576476585, 10461.633842815465, 10554.102901253325, 10558.102561282378, 10567.841482377771, 10615.416152111553, 5244.685318880879, 5252.527272545489, 5259.737013149327, 5275.5515781158265, 5292.788288468495, 4235.915281694411, 4578.40480737502, 4773.7374444405195, 4850.902981940412, 4870.4155501340065, 3973.980130099331, 3986.8405263789123, 4018.4374187613757, 4051.817668204938, 4257.318828987347, 1232.2668012532529, 1291.0446269760498, 1295.436485128972, 1295.7732396830706, 1299.3698056442618, 990.0841721407669, 997.0876647867266, 1011.3325205364424, 1012.6101450941441, 1020.2959957629212, 5929.6145750526075, 6092.238470191226, 6177.567570270128, 6195.070739389038, 6245.500359971192, 427.3333599584658, 430.3845500933695, 439.2401146017344, 439.3300217168779, 443.49441636534374, 4153.169366126726, 4192.601702838226, 4193.098483825931, 4228.682848786353, 4234.3860140279485, 10622.681319560426, 10863.130949524018, 10909.290896091728, 10917.454127293604, 11012.614558490415, 10814.080803131665, 10816.296940698829, 10817.350958942332, 10819.404932728776, 10876.61931832398, 8054.838903221903, 8250.133735957757, 8312.459690120122, 8352.373571982125, 8474.703385381483, 5946.791862284972, 5968.731407086779, 6075.726592303446, 6120.08198770188, 6235.158253635883, 10207.285490015925, 10244.436555989492, 10325.483725813829, 10461.424621645578, 10555.0, 10131.797364052825, 10183.33808302458, 10435.68692939213, 10638.627648032281, 10646.509488671438, 7479.0, 8171.959140204261, 8407.663693452194, 8638.13618638131, 8661.307095432225, 8761.868571971298, 8765.868511972452, 8804.779880503038, 8836.823263534821, 8845.646174153218, 7671.2712292332135, 7731.110922244014, 7882.763517094496, 7976.042874855055, 8067.273945344947, 7897.420515896729, 7907.130215676156, 7944.04671439431, 8003.959980200062, 8023.318017968305, 7408.777736667908, 7423.628818559158, 7507.099148102263, 7508.662110204945, 7526.586037767756, 4949.950500494949, 5016.4198277542455, 5029.974850125726, 5044.394672639307, 5086.084504789025, 5151.793928242828, 5176.844694659167, 5199.610029247897, 5202.8959420812125, 5257.0], "value": 4577.994456074411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.35147946709253, 326.3798782313604, 330.91561651778795, 336.9444041733111, 337.95099710541973, 5563.471470210328, 5568.916466253005, 5617.297837770278, 5648.378678345379, 5658.349289831671, 5520.889582208363, 5584.776608935637, 5597.076482380413, 5609.625641717775, 5619.353774315955, 4382.145481631083, 4390.297552391618, 4405.80173892174, 4406.294992801152, 4415.867523974286, 4267.679924005696, 4346.521882592912, 4354.825806967718, 4379.08039311745, 4397.846075387362, 4293.1199104183725, 4304.7632380219075, 4310.56894310568, 4324.718893271943, 4343.978280108611, 4350.390945267665, 4352.933531284855, 4373.890652733675, 4375.321825117112, 4390.341448782676, 3561.4301711726, 3719.925601487982, 3866.6520013198665, 3870.632289932452, 3887.300285948528, 5419.83740487786, 5449.455054494559, 5453.182022696587, 5465.59008074392, 5491.560675145979, 4883.291922671193, 4903.41159060915, 4933.210686290212, 4935.703857768545, 4965.354503914504, 5660.801871934463, 5746.511546518551, 5764.33710123337, 5822.737976791054, 5900.144479050514, 4069.3895915612597, 4075.49056367954, 4093.1199792044854, 4118.176364727036, 4137.524184718765, 5853.7365818538265, 5898.469137777578, 6114.419130182626, 6121.265448146251, 6140.324564297924, 4102.610252026053, 4104.4664193655235, 4135.875923722293, 4174.749515029108, 4184.037671335549, 4225.239456897788, 4226.302660061056, 4227.365895115758, 4230.2174097792, 4236.428082208862, 4712.434507859079, 4902.313676085351, 4902.730349830794, 4904.8038078477175, 4924.482929292444, 5838.065909454467, 5847.666829906912, 5864.882702346014, 5872.0898260769645, 5893.410658934158, 1467.581739204343, 1468.3465857693438, 1468.9706205876037, 1476.2987580898987, 1477.8522147785136, 897.6274845938992, 923.879895613566, 932.8927173375013, 937.0910217089412, 942.528735632184, 4993.425756038029, 5032.345795046621, 5042.369703787027, 5140.588752899759, 5183.704073981505, 5275.707451674288, 5403.000444917624, 5403.540699040547, 5437.265969094122, 5441.782328706808, 5081.2632168335385, 5096.388433388017, 5139.252654097625, 5338.91991620126, 5810.738516766755, 3205.8717651294155, 3223.3069889973767, 3226.48376259802, 3237.5953005874267, 3246.3994161080277, 6023.668698221552, 6164.321924588292, 6216.316205217422, 6262.342454042351, 6354.714037868307, 6050.42520960508, 6129.938700612936, 6139.29398119222, 6145.477634401126, 6148.415900489446, 6189.514516516094, 6213.565050446516, 6241.063840423973, 6274.780382686584, 6309.917727150029, 5825.854353641023, 6007.249093863267, 6068.423499767691, 6074.605150665193, 6110.450059494667, 5964.314103877936, 5976.342602313829, 5982.192404025401, 5989.64062156272, 6070.726817293144, 5904.439078287556, 5977.625146216307, 6180.351063138485, 6182.196314479089, 6218.22272215973, 4206.179794939957, 4206.47419072616, 4208.305629571087, 4218.409422680766, 4223.746575205498, 5851.239338885917, 6038.245219347582, 6111.297200821962, 6133.478654314434, 6135.570510064253, 5826.446487583673, 5934.851628709144, 5944.881102377842, 5988.706211583524, 6024.9397506026135, 5815.33123690764, 5867.530597552271, 5894.968380533303, 5955.225820643289, 5967.8209653710455, 5698.629589076697, 5813.418658134153, 5824.854578527547, 5845.912311315248, 5861.648301101947, 5989.460948514655, 5991.281046274475, 6000.639961602318, 6019.006863867413, 6050.878982420239, 5664.518515926027, 5764.423557644202, 5796.232149194536, 5852.4440178183, 5872.970635146797], "value": 4413.632747771442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.1362081450225, 705.7741522712731, 716.1263258824233, 766.8197973476234, 845.3406343052419, 13522.594322170326, 14504.63738406539, 14603.123812571253, 14623.122612643236, 14707.0, 12988.675283117927, 13077.67305817355, 13303.534376296831, 13339.599812005656, 13422.39599218035, 820.3314298846436, 831.8377916306292, 836.1554829622095, 838.0278876503257, 839.2069494327862, 836.8870202522672, 837.2757564706516, 840.7015509494133, 842.1157784326464, 843.3590471241839, 869.652139144341, 874.623911717961, 879.9956000220022, 882.5675419044654, 883.8320719063357, 871.3508436214997, 872.4634349874781, 872.7120050383359, 874.558348034245, 878.1525827576355, 638.8945823939044, 639.341478277375, 639.7313128486047, 640.7725257533555, 641.4515589171285, 12563.623091307276, 12583.307918064504, 12601.873981260162, 12602.621921342374, 12608.36958152098, 12343.876561234363, 12364.258144511268, 12466.0, 12618.558350457783, 12673.873261267361, 10842.783144337069, 11258.718532036764, 11297.717557061056, 11570.305781653127, 11781.121207607164, 4426.402435671175, 4440.600345968878, 4441.977790111029, 4444.177827101997, 4675.7895894684825, 57630.423695762925, 68824.31175688279, 73009.0, 73744.89382659318, 80190.59904700439, 11372.20394572372, 11625.88374116265, 11680.88319116815, 11720.120990925714, 11737.413129343498, 23042.539149216922, 23112.191073312355, 23195.76804231936, 23362.182323618592, 23410.297691069296, 8140.3487720982175, 8328.958355208186, 8486.787830304293, 8584.914150858536, 8740.082291359317, 4695.7886895089805, 4800.1119792838435, 4801.711897286104, 4806.351142595775, 4842.031593681278, 3567.0, 3632.4551317302617, 3651.835667394974, 3661.395869681526, 3667.688246499024, 655.0926966151819, 667.8430568816422, 668.518666560076, 674.1270055278426, 679.1646275081579, 705.1960764728213, 771.7453240430644, 802.253903869407, 811.7158994352047, 840.3739214285397, 9903.306768526278, 9960.501974901372, 10002.399856008662, 10159.898401015895, 10261.127804136731, 748.9438292128112, 756.0795579228807, 763.091920614467, 767.3630886364305, 795.157133438557, 4612.561806628365, 4693.5775780179265, 4835.274708793639, 4846.0, 4903.215485522371, 92770.0, 108084.45957770318, 113802.0, 113926.43036784929, 115261.0, 101058.49470752747, 101436.0, 102369.48815255876, 102512.0, 102943.0, 87917.0, 88784.0, 88799.55600221957, 90048.0, 92193.0, 9358.0, 9628.133467987915, 9646.42121472714, 9660.903390966001, 9663.710088697351, 39749.60250397459, 47663.76168119276, 48181.5181848177, 53742.46257537531, 53785.19322210248, 50344.48277586179, 50609.746951265006, 50612.0, 76123.77054492226, 81771.18228817874, 13630.86369136296, 13660.112092713942, 13886.791698124334, 13927.651808704863, 14395.928020359832, 13835.723285534032, 13921.651958700708, 14014.719705606034, 14050.297485125908, 14145.858541414866, 13559.186448813103, 13573.932130339284, 13672.52146174879, 13724.313784310545, 14578.198199099152, 13205.471781128646, 13243.0, 13463.932680336535, 13487.32563371847, 13499.595012149652, 13224.669383265495, 13226.867731322563, 13603.183808971493, 13604.319784010957, 13630.386632601358, 10370.481475926023, 10395.584176633152, 10610.257281990494, 10940.835887461535, 10954.507047182737, 11719.472623731783, 11750.29498230109, 11758.176927614984, 11821.622215343432, 12443.0], "value": 7536.826591409949, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 107.0, 111.0, 111.0, 114.0, 112.0, 112.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 149.0, 166.0, 126.0, 151.0, 156.0, 120.0, 196.0, 120.0], "value": 145.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 167.0, 162.0, 163.0, 164.0, 177.0, 167.0, 163.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 171.0, 76.0, 76.0, 76.0, 76.0, 165.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 144.0, 84.0, 85.0, 84.0, 148.0, 84.0, 85.0, 155.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 53.0, 56.0, 55.0, 53.0, 55.0, 54.0, 52.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 75.0, 77.0, 76.0, 84.0, 81.0, 76.0, 76.0, 81.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 119.0, 129.0, 117.0, 120.0, 121.0, 150.0, 121.0, 181.0, 126.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 156.0, 158.0, 157.0, 160.0, 158.0, 161.0, 155.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 63.0, 64.0, 63.0, 65.0, 63.0, 62.0, 62.0], "value": 63.4, "unit": "score"}]}]} 05:29:42 INFO - Return code: 0 05:29:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:42 ERROR - # TBPL SUCCESS # 05:29:42 INFO - Running post-action listener: _resource_record_post_action 05:29:42 INFO - ##### 05:29:42 INFO - ##### Finished run-tests step (success) 05:29:42 INFO - ##### 05:29:42 INFO - Running post-run listener: _resource_record_post_run 05:29:43 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 572362752; Read time: 8; Write time: 499800 05:29:43 INFO - TinderboxPrint: CPU usage
13.4% 05:29:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:29:43 INFO - TinderboxPrint: I/O write bytes / time
572,362,752 / 499,800 05:29:43 INFO - TinderboxPrint: CPU idle
8,225.8 (86.6%) 05:29:43 INFO - TinderboxPrint: CPU user
1,215.7 (12.8%) 05:29:43 INFO - TinderboxPrint: Swap in / out
0 / 0 05:29:43 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 275087360; Read time: 0; Write time: 257444 05:29:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297086976; Read time: 0; Write time: 242336 05:29:43 INFO - Running post-run listener: _upload_blobber_files 05:29:43 INFO - Blob upload gear active. 05:29:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:43 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:29:43 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:29:43 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:29:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:44 INFO - (blobuploader) - INFO - Done attempting. 05:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:45 INFO - (blobuploader) - INFO - Done attempting. 05:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:57 INFO - (blobuploader) - INFO - Done attempting. 05:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:57 INFO - Return code: 0 05:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ab824b64dd649f631d767bec90f974fb247bb04b20e5155e41312911999026c8e5eeeba4cc002673d69dd248d91c9f80a822b565018b82dbfd56749189e3853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b82cb0de6e5e3af2ce1a03ce2a54c8f9121789ea8453ea200309d7d66f8cc803220839cfeca46cdb3dc38016335cd44ab79559d809923766fe609a8ee515ac8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c524a00aef4961606ec2f5b18939f6e06417b23602af83e30305bb0d56ac5737fc6bdca0a7e71049fc1e025cee52fbc12b16f1db808191cf95c75ab5e6611858"} 05:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:57 INFO - Contents: 05:29:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ab824b64dd649f631d767bec90f974fb247bb04b20e5155e41312911999026c8e5eeeba4cc002673d69dd248d91c9f80a822b565018b82dbfd56749189e3853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b82cb0de6e5e3af2ce1a03ce2a54c8f9121789ea8453ea200309d7d66f8cc803220839cfeca46cdb3dc38016335cd44ab79559d809923766fe609a8ee515ac8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c524a00aef4961606ec2f5b18939f6e06417b23602af83e30305bb0d56ac5737fc6bdca0a7e71049fc1e025cee52fbc12b16f1db808191cf95c75ab5e6611858"} 05:29:57 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:57 INFO - Copying logs to upload dir... 05:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.257167 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-18 05:29:56.581603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:56.585286) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808 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/2ab824b64dd649f631d767bec90f974fb247bb04b20e5155e41312911999026c8e5eeeba4cc002673d69dd248d91c9f80a822b565018b82dbfd56749189e3853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b82cb0de6e5e3af2ce1a03ce2a54c8f9121789ea8453ea200309d7d66f8cc803220839cfeca46cdb3dc38016335cd44ab79559d809923766fe609a8ee515ac8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c524a00aef4961606ec2f5b18939f6e06417b23602af83e30305bb0d56ac5737fc6bdca0a7e71049fc1e025cee52fbc12b16f1db808191cf95c75ab5e6611858"} 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.011315 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/2ab824b64dd649f631d767bec90f974fb247bb04b20e5155e41312911999026c8e5eeeba4cc002673d69dd248d91c9f80a822b565018b82dbfd56749189e3853", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b82cb0de6e5e3af2ce1a03ce2a54c8f9121789ea8453ea200309d7d66f8cc803220839cfeca46cdb3dc38016335cd44ab79559d809923766fe609a8ee515ac8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c524a00aef4961606ec2f5b18939f6e06417b23602af83e30305bb0d56ac5737fc6bdca0a7e71049fc1e025cee52fbc12b16f1db808191cf95c75ab5e6611858"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:56.612861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:56.613568) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468843311.951091-1411974808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:56.696317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:29:56.697036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:29:56.697674) ========= ========= Total master_lag: 0.18 =========