builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1468418597.85 results: success (0) buildid: 20160713063326 builduid: 6650a7acfdc6450097760a34ad35a332 revision: 016e4fdb5a52374d139e3553fc564a7ae0f9ea74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:17.852538) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:17.853000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:17.853302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:17.868570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:17.868835) ========= 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=41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 07:03:17-- 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% 45.8M=0s 2016-07-13 07:03:18 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.012828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.013119) ========= 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=41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019856 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.063826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.064194) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 016e4fdb5a52374d139e3553fc564a7ae0f9ea74 --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 016e4fdb5a52374d139e3553fc564a7ae0f9ea74 --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=41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 07:03:18,208 truncating revision to first 12 chars 2016-07-13 07:03:18,208 Setting DEBUG logging. 2016-07-13 07:03:18,208 attempt 1/10 2016-07-13 07:03:18,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/016e4fdb5a52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 07:03:18,526 unpacking tar archive at: fx-team-016e4fdb5a52/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.719409) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.719722) ========= script_repo_revision: 016e4fdb5a52374d139e3553fc564a7ae0f9ea74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.720135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.720419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 07:03:18.728497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 07:03:18.728780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:18 INFO - MultiFileLogger online at 20160713 07:03:18 in /builds/slave/test 07:03:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:03:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:03:18 INFO - {'append_to_log': False, 07:03:18 INFO - 'base_work_dir': '/builds/slave/test', 07:03:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:03:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:03:18 INFO - 'branch': 'Fx-Team-Non-PGO', 07:03:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:18 INFO - 'config_files': ('talos/linux_config.py',), 07:03:18 INFO - 'default_actions': ('clobber', 07:03:18 INFO - 'read-buildbot-config', 07:03:18 INFO - 'download-and-extract', 07:03:18 INFO - 'populate-webroot', 07:03:18 INFO - 'create-virtualenv', 07:03:18 INFO - 'install', 07:03:18 INFO - 'run-tests'), 07:03:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:18 INFO - 'download_minidump_stackwalk': True, 07:03:18 INFO - 'download_symbols': 'ondemand', 07:03:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:03:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:03:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:03:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:03:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:18 INFO - 'installer_path': 'installer.exe', 07:03:18 INFO - 'log_level': 'info', 07:03:18 INFO - 'log_name': 'talos', 07:03:18 INFO - 'log_to_console': True, 07:03:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:18 INFO - 'opt_config_files': (), 07:03:18 INFO - 'pip_index': False, 07:03:18 INFO - 'sps_profile': False, 07:03:18 INFO - 'sps_profile_interval': 0, 07:03:18 INFO - 'suite': 'dromaeojs-e10s', 07:03:18 INFO - 'system_bits': '32', 07:03:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:18 INFO - 'title': 'talos-linux64-ix-026', 07:03:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:18 INFO - 'use_talos_json': True, 07:03:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:03:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:18 INFO - 'work_dir': 'build'} 07:03:18 INFO - ##### 07:03:18 INFO - ##### Running clobber step. 07:03:18 INFO - ##### 07:03:18 INFO - Running pre-action listener: _resource_record_pre_action 07:03:18 INFO - Running main action method: clobber 07:03:18 INFO - rmtree: /builds/slave/test/build 07:03:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:03:19 INFO - Running post-action listener: _resource_record_post_action 07:03:19 INFO - ##### 07:03:19 INFO - ##### Finished clobber step (success) 07:03:19 INFO - ##### 07:03:19 INFO - ##### 07:03:19 INFO - ##### Running read-buildbot-config step. 07:03:19 INFO - ##### 07:03:19 INFO - Running pre-action listener: _resource_record_pre_action 07:03:19 INFO - Running main action method: read_buildbot_config 07:03:19 INFO - Using buildbot properties: 07:03:19 INFO - { 07:03:19 INFO - "project": "", 07:03:19 INFO - "product": "firefox", 07:03:19 INFO - "script_repo_revision": "production", 07:03:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:03:19 INFO - "repository": "", 07:03:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:03:19 INFO - "buildid": "20160713063326", 07:03:19 INFO - "pgo_build": "False", 07:03:19 INFO - "basedir": "/builds/slave/test", 07:03:19 INFO - "buildnumber": 1475, 07:03:19 INFO - "slavename": "talos-linux64-ix-026", 07:03:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:03:19 INFO - "platform": "ubuntu64_hw", 07:03:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:03:19 INFO - "branch": "fx-team", 07:03:19 INFO - "repo_path": "integration/fx-team", 07:03:19 INFO - "revision": "016e4fdb5a52374d139e3553fc564a7ae0f9ea74", 07:03:19 INFO - "stage_platform": "linux64", 07:03:19 INFO - "builduid": "6650a7acfdc6450097760a34ad35a332", 07:03:19 INFO - "slavebuilddir": "test" 07:03:19 INFO - } 07:03:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:03:19 INFO - Running post-action listener: _resource_record_post_action 07:03:19 INFO - ##### 07:03:19 INFO - ##### Finished read-buildbot-config step (success) 07:03:19 INFO - ##### 07:03:19 INFO - ##### 07:03:19 INFO - ##### Running download-and-extract step. 07:03:19 INFO - ##### 07:03:19 INFO - Running pre-action listener: _resource_record_pre_action 07:03:19 INFO - Running main action method: download_and_extract 07:03:19 INFO - mkdir: /builds/slave/test/build/tests 07:03: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')]} 07:03:19 INFO - https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:03:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:03:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:03:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:20 INFO - Downloaded 1361 bytes. 07:03:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:03:20 INFO - Using the following test package requirements: 07:03:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:03:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:03:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:03:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'jsshell-linux-x86_64.zip'], 07:03:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:03:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:03:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:03:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:03:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:03:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:03:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:03:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:20 INFO - https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:03:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:21 INFO - Downloaded 22750981 bytes. 07:03:21 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'] 07:03:21 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 07:03:22 INFO - Return code: 0 07:03:22 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 07:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:22 INFO - https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:03:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:03:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:27 INFO - Downloaded 22750981 bytes. 07:03:27 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'] 07:03:27 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 07:03:29 INFO - Return code: 0 07:03:29 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')]} 07:03:29 INFO - https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:30 INFO - Downloaded 14403317 bytes. 07:03:30 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'] 07:03:30 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 07:03:30 INFO - Return code: 0 07:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:30 INFO - https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baObuCPCQZGzGUgsrja3Sg/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 07:03:31 INFO - Downloaded 56988222 bytes. 07:03:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:31 INFO - mkdir: /builds/slave/test/properties 07:03:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:31 INFO - Contents: 07:03:31 INFO - build_url:https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:03:32 INFO - Running post-action listener: _resource_record_post_action 07:03:32 INFO - Running post-action listener: set_extra_try_arguments 07:03:32 INFO - ##### 07:03:32 INFO - ##### Finished download-and-extract step (success) 07:03:32 INFO - ##### 07:03:32 INFO - ##### 07:03:32 INFO - ##### Running populate-webroot step. 07:03:32 INFO - ##### 07:03:32 INFO - Running pre-action listener: _resource_record_pre_action 07:03:32 INFO - Running main action method: populate_webroot 07:03:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:03:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:03:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:03:32 INFO - '--tppagecycles', 07:03:32 INFO - '7'], 07:03:32 INFO - 'tests': ['tsvgm']}}, 07:03:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:03:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:03:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:03:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:03:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['damp', 'tps']}, 07:03:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'tests': ['damp', 'tps']}, 07:03:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['dromaeo_dom']}, 07:03:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['basic_compositor_video']}, 07:03:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:03:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['a11yr', 07:03:32 INFO - 'ts_paint', 07:03:32 INFO - 'tpaint', 07:03:32 INFO - 'sessionrestore', 07:03:32 INFO - 'sessionrestore_no_auto_restore', 07:03:32 INFO - 'tabpaint']}, 07:03:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:03:32 INFO - 'ts_paint', 07:03:32 INFO - 'tpaint', 07:03:32 INFO - 'sessionrestore', 07:03:32 INFO - 'sessionrestore_no_auto_restore', 07:03:32 INFO - 'tabpaint']}, 07:03:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:03:32 INFO - 'ts_paint', 07:03:32 INFO - 'tpaint', 07:03:32 INFO - 'sessionrestore', 07:03:32 INFO - 'sessionrestore_no_auto_restore', 07:03:32 INFO - 'tabpaint']}, 07:03:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:03:32 INFO - 'ts_paint', 07:03:32 INFO - 'tpaint', 07:03:32 INFO - 'sessionrestore', 07:03:32 INFO - 'sessionrestore_no_auto_restore', 07:03:32 INFO - 'tabpaint']}, 07:03:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['a11yr', 07:03:32 INFO - 'ts_paint', 07:03:32 INFO - 'tpaint', 07:03:32 INFO - 'sessionrestore', 07:03:32 INFO - 'sessionrestore_no_auto_restore', 07:03:32 INFO - 'tabpaint']}, 07:03:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['a11yr', 07:03:32 INFO - 'ts_paint', 07:03:32 INFO - 'tpaint', 07:03:32 INFO - 'sessionrestore', 07:03:32 INFO - 'sessionrestore_no_auto_restore', 07:03:32 INFO - 'tabpaint']}, 07:03:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['tsvgx', 07:03:32 INFO - 'tsvgr_opacity', 07:03:32 INFO - 'tart', 07:03:32 INFO - 'tscrollx', 07:03:32 INFO - 'cart']}, 07:03:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:03:32 INFO - 'tsvgr_opacity', 07:03:32 INFO - 'tart', 07:03:32 INFO - 'tscrollx', 07:03:32 INFO - 'cart']}, 07:03:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'talos_options': ['--disable-e10s'], 07:03:32 INFO - 'tests': ['tp5o']}, 07:03:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'tests': ['tp5o']}, 07:03:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'talos_options': ['--disable-e10s', 07:03:32 INFO - '--xperf_path', 07:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:32 INFO - 'tests': ['tp5n']}, 07:03:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:32 INFO - 'talos_options': ['--xperf_path', 07:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:32 INFO - 'tests': ['tp5n']}}, 07:03:32 INFO - 'talos.zip': {'path': '', 07:03:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:03:32 INFO - Running post-action listener: _resource_record_post_action 07:03:32 INFO - ##### 07:03:32 INFO - ##### Finished populate-webroot step (success) 07:03:32 INFO - ##### 07:03:32 INFO - ##### 07:03:32 INFO - ##### Running create-virtualenv step. 07:03:32 INFO - ##### 07:03:32 INFO - Running pre-action listener: _resource_record_pre_action 07:03:32 INFO - Running main action method: create_virtualenv 07:03:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:32 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 07:03:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:03:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:32 INFO - Using real prefix '/usr' 07:03:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:03:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:03:35 INFO - Installing pip.................done. 07:03:35 INFO - Return code: 0 07:03:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:03:35 INFO - Using env: {'DISPLAY': ':0', 07:03:35 INFO - 'HOME': '/home/cltbld', 07:03:35 INFO - 'LANG': 'en_US.UTF-8', 07:03:35 INFO - 'LANGUAGE': 'en_US:en', 07:03:35 INFO - 'LOGNAME': 'cltbld', 07:03:35 INFO - 'MAIL': '/var/mail/cltbld', 07:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:35 INFO - 'MOZ_NO_REMOTE': '1', 07:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:35 INFO - 'NO_EM_RESTART': '1', 07:03:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:35 INFO - 'PWD': '/builds/slave/test', 07:03:35 INFO - 'SHELL': '/bin/bash', 07:03:35 INFO - 'SHLVL': '1', 07:03:35 INFO - 'TERM': 'linux', 07:03:35 INFO - 'TMOUT': '86400', 07:03:35 INFO - 'USER': 'cltbld', 07:03:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:35 INFO - '_': '/tools/buildbot/bin/python'} 07:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:35 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 07:03:35 INFO - Cleaning up... 07:03:35 INFO - Return code: 0 07:03:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:03:35 INFO - Using env: {'DISPLAY': ':0', 07:03:35 INFO - 'HOME': '/home/cltbld', 07:03:35 INFO - 'LANG': 'en_US.UTF-8', 07:03:35 INFO - 'LANGUAGE': 'en_US:en', 07:03:35 INFO - 'LOGNAME': 'cltbld', 07:03:35 INFO - 'MAIL': '/var/mail/cltbld', 07:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:35 INFO - 'MOZ_NO_REMOTE': '1', 07:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:35 INFO - 'NO_EM_RESTART': '1', 07:03:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:35 INFO - 'PWD': '/builds/slave/test', 07:03:35 INFO - 'SHELL': '/bin/bash', 07:03:35 INFO - 'SHLVL': '1', 07:03:35 INFO - 'TERM': 'linux', 07:03:35 INFO - 'TMOUT': '86400', 07:03:35 INFO - 'USER': 'cltbld', 07:03:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:35 INFO - '_': '/tools/buildbot/bin/python'} 07:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:35 INFO - Downloading/unpacking psutil>=3.1.1 07:03:35 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 07:03:35 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 07:03:35 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 07:03:35 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 07:03:35 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 07:03:35 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 07:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:03:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:37 INFO - Installing collected packages: psutil 07:03:37 INFO - Running setup.py install for psutil 07:03:37 INFO - building 'psutil._psutil_linux' extension 07:03:37 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 07:03:37 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 07:03:38 INFO - building 'psutil._psutil_posix' extension 07:03:38 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 07:03:38 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 07:03:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:38 INFO - Successfully installed psutil 07:03:38 INFO - Cleaning up... 07:03:38 INFO - Return code: 0 07:03:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:03: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')]} 07:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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')]} 07:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:03: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 mozsystemmonitor==0.3 07:03:38 INFO - Using env: {'DISPLAY': ':0', 07:03:38 INFO - 'HOME': '/home/cltbld', 07:03:38 INFO - 'LANG': 'en_US.UTF-8', 07:03:38 INFO - 'LANGUAGE': 'en_US:en', 07:03:38 INFO - 'LOGNAME': 'cltbld', 07:03:38 INFO - 'MAIL': '/var/mail/cltbld', 07:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:38 INFO - 'MOZ_NO_REMOTE': '1', 07:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:38 INFO - 'NO_EM_RESTART': '1', 07:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:38 INFO - 'PWD': '/builds/slave/test', 07:03:38 INFO - 'SHELL': '/bin/bash', 07:03:38 INFO - 'SHLVL': '1', 07:03:38 INFO - 'TERM': 'linux', 07:03:38 INFO - 'TMOUT': '86400', 07:03:38 INFO - 'USER': 'cltbld', 07:03:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:38 INFO - '_': '/tools/buildbot/bin/python'} 07:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:03:40 INFO - Installing collected packages: mozsystemmonitor 07:03:40 INFO - Running setup.py install for mozsystemmonitor 07:03:40 INFO - Successfully installed mozsystemmonitor 07:03:40 INFO - Cleaning up... 07:03:40 INFO - Return code: 0 07:03:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:03:40 INFO - Using env: {'DISPLAY': ':0', 07:03:40 INFO - 'HOME': '/home/cltbld', 07:03:40 INFO - 'LANG': 'en_US.UTF-8', 07:03:40 INFO - 'LANGUAGE': 'en_US:en', 07:03:40 INFO - 'LOGNAME': 'cltbld', 07:03:40 INFO - 'MAIL': '/var/mail/cltbld', 07:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:40 INFO - 'MOZ_NO_REMOTE': '1', 07:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:40 INFO - 'NO_EM_RESTART': '1', 07:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:40 INFO - 'PWD': '/builds/slave/test', 07:03:40 INFO - 'SHELL': '/bin/bash', 07:03:40 INFO - 'SHLVL': '1', 07:03:40 INFO - 'TERM': 'linux', 07:03:40 INFO - 'TMOUT': '86400', 07:03:40 INFO - 'USER': 'cltbld', 07:03:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:40 INFO - '_': '/tools/buildbot/bin/python'} 07:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:40 INFO - Downloading/unpacking jsonschema==2.5.1 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:03:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:03:42 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 07:03:42 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 07:03:42 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 07:03:42 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 07:03:42 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 07:03:42 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 07:03:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:03:42 INFO - warning: no files found matching '*.txt' 07:03:42 INFO - no previously-included directories found matching 'build' 07:03:42 INFO - no previously-included directories found matching 'dist' 07:03:42 INFO - no previously-included directories found matching '.git*' 07:03:42 INFO - Installing collected packages: jsonschema, functools32 07:03:43 INFO - Running setup.py install for functools32 07:03:43 INFO - warning: no files found matching '*.txt' 07:03:43 INFO - no previously-included directories found matching 'build' 07:03:43 INFO - no previously-included directories found matching 'dist' 07:03:43 INFO - no previously-included directories found matching '.git*' 07:03:43 INFO - Successfully installed jsonschema functools32 07:03:43 INFO - Cleaning up... 07:03:43 INFO - Return code: 0 07:03:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:03:43 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')]} 07:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:43 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')]} 07:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:43 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 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:43 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 07:03:43 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 07:03:43 INFO - Using env: {'DISPLAY': ':0', 07:03:43 INFO - 'HOME': '/home/cltbld', 07:03:43 INFO - 'LANG': 'en_US.UTF-8', 07:03:43 INFO - 'LANGUAGE': 'en_US:en', 07:03:43 INFO - 'LOGNAME': 'cltbld', 07:03:43 INFO - 'MAIL': '/var/mail/cltbld', 07:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:43 INFO - 'MOZ_NO_REMOTE': '1', 07:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:43 INFO - 'NO_EM_RESTART': '1', 07:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:43 INFO - 'PWD': '/builds/slave/test', 07:03:43 INFO - 'SHELL': '/bin/bash', 07:03:43 INFO - 'SHLVL': '1', 07:03:43 INFO - 'TERM': 'linux', 07:03:43 INFO - 'TMOUT': '86400', 07:03:43 INFO - 'USER': 'cltbld', 07:03:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:43 INFO - '_': '/tools/buildbot/bin/python'} 07:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03: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 07:03:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:03:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:03:46 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 07:03:46 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 07:03:46 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 07:03:46 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 07:03:46 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 07:03:46 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 07:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:03:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:03:46 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 07:03:46 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 07:03:46 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 07:03:46 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 07:03:46 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 07:03:46 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 07:03:47 INFO - Downloading docopt-0.6.1.tar.gz 07:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:03:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:03:47 INFO - Running setup.py install for blobuploader 07:03:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:03:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:03:47 INFO - Running setup.py install for requests 07:03:47 INFO - Running setup.py install for docopt 07:03:47 INFO - Successfully installed blobuploader requests docopt 07:03:47 INFO - Cleaning up... 07:03:47 INFO - Return code: 0 07:03:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:47 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 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:47 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 07:03:47 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 07:03:47 INFO - Using env: {'DISPLAY': ':0', 07:03:47 INFO - 'HOME': '/home/cltbld', 07:03:47 INFO - 'LANG': 'en_US.UTF-8', 07:03:47 INFO - 'LANGUAGE': 'en_US:en', 07:03:47 INFO - 'LOGNAME': 'cltbld', 07:03:47 INFO - 'MAIL': '/var/mail/cltbld', 07:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:47 INFO - 'MOZ_NO_REMOTE': '1', 07:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:47 INFO - 'NO_EM_RESTART': '1', 07:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:47 INFO - 'PWD': '/builds/slave/test', 07:03:47 INFO - 'SHELL': '/bin/bash', 07:03:47 INFO - 'SHLVL': '1', 07:03:47 INFO - 'TERM': 'linux', 07:03:47 INFO - 'TMOUT': '86400', 07:03:47 INFO - 'USER': 'cltbld', 07:03:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:47 INFO - '_': '/tools/buildbot/bin/python'} 07:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:47 INFO - Running setup.py (path:/tmp/pip-7p5ZFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:47 INFO - Running setup.py (path:/tmp/pip-ppllQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:48 INFO - Running setup.py (path:/tmp/pip-AkWXL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:48 INFO - Running setup.py (path:/tmp/pip-FIoypM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:48 INFO - Running setup.py (path:/tmp/pip-ld6TEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:48 INFO - Running setup.py (path:/tmp/pip-7DmvIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:48 INFO - Running setup.py (path:/tmp/pip-P_XAit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:48 INFO - Running setup.py (path:/tmp/pip-jVhSyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:48 INFO - Running setup.py (path:/tmp/pip-a7tDgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:48 INFO - Running setup.py (path:/tmp/pip-B2ccTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:48 INFO - Running setup.py (path:/tmp/pip-0zdYg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:48 INFO - Running setup.py (path:/tmp/pip-Tc248w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:48 INFO - Running setup.py (path:/tmp/pip-3fvgdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:48 INFO - Running setup.py (path:/tmp/pip-3axmAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:48 INFO - Running setup.py (path:/tmp/pip-fLOlK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:48 INFO - Running setup.py (path:/tmp/pip-Jn919W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:49 INFO - Running setup.py (path:/tmp/pip-tWaEFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:03:49 INFO - Running setup.py install for manifestparser 07:03:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Running setup.py install for mozcrash 07:03:49 INFO - Running setup.py install for mozdebug 07:03:49 INFO - Running setup.py install for mozdevice 07:03:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Running setup.py install for mozfile 07:03:49 INFO - Running setup.py install for mozhttpd 07:03:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Running setup.py install for mozinfo 07:03:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Running setup.py install for mozInstall 07:03:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:03:49 INFO - Running setup.py install for mozleak 07:03:50 INFO - Running setup.py install for mozlog 07:03:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:03:50 INFO - Running setup.py install for moznetwork 07:03:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:03:50 INFO - Running setup.py install for mozprocess 07:03:50 INFO - Running setup.py install for mozprofile 07:03:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:03:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:03:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:03:50 INFO - Running setup.py install for mozrunner 07:03:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:03:50 INFO - Running setup.py install for mozscreenshot 07:03:50 INFO - Running setup.py install for moztest 07:03:50 INFO - Running setup.py install for mozversion 07:03:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:03:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:03:50 INFO - Cleaning up... 07:03:50 INFO - Return code: 0 07:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:50 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')]} 07:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:50 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')]} 07:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:50 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 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:50 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 07:03:50 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 07:03:50 INFO - Using env: {'DISPLAY': ':0', 07:03:50 INFO - 'HOME': '/home/cltbld', 07:03:50 INFO - 'LANG': 'en_US.UTF-8', 07:03:50 INFO - 'LANGUAGE': 'en_US:en', 07:03:50 INFO - 'LOGNAME': 'cltbld', 07:03:50 INFO - 'MAIL': '/var/mail/cltbld', 07:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:50 INFO - 'MOZ_NO_REMOTE': '1', 07:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:50 INFO - 'NO_EM_RESTART': '1', 07:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:50 INFO - 'PWD': '/builds/slave/test', 07:03:50 INFO - 'SHELL': '/bin/bash', 07:03:50 INFO - 'SHLVL': '1', 07:03:50 INFO - 'TERM': 'linux', 07:03:50 INFO - 'TMOUT': '86400', 07:03:50 INFO - 'USER': 'cltbld', 07:03:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:50 INFO - '_': '/tools/buildbot/bin/python'} 07:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:51 INFO - Running setup.py (path:/tmp/pip-D0W9dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:51 INFO - Running setup.py (path:/tmp/pip-gpubws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:51 INFO - Running setup.py (path:/tmp/pip-C9ZNEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:51 INFO - Running setup.py (path:/tmp/pip-CxQftc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:51 INFO - Running setup.py (path:/tmp/pip-pEI_pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:51 INFO - Running setup.py (path:/tmp/pip-HON8uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:51 INFO - Running setup.py (path:/tmp/pip-N94Rm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:51 INFO - Running setup.py (path:/tmp/pip-ZYxzqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:51 INFO - Running setup.py (path:/tmp/pip-cGkmA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:51 INFO - Running setup.py (path:/tmp/pip-MJ4Pf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:51 INFO - Running setup.py (path:/tmp/pip-FcXUhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:51 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)) 07:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:51 INFO - Running setup.py (path:/tmp/pip-_zP2Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:52 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)) 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:52 INFO - Running setup.py (path:/tmp/pip-KKfAXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:52 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)) 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:52 INFO - Running setup.py (path:/tmp/pip-Ii7kE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:52 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)) 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:52 INFO - Running setup.py (path:/tmp/pip-SYUK3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:52 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)) 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:52 INFO - Running setup.py (path:/tmp/pip-mnG7lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:52 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)) 07:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:52 INFO - Running setup.py (path:/tmp/pip-cudya9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:52 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)) 07:03:52 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)) 07:03:52 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)) 07:03:52 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)) 07:03:52 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)) 07:03:52 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)) 07:03:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:54 INFO - Downloading blessings-1.6.tar.gz 07:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:03:54 INFO - Installing collected packages: blessings 07:03:54 INFO - Running setup.py install for blessings 07:03:54 INFO - Successfully installed blessings 07:03:54 INFO - Cleaning up... 07:03:54 INFO - Return code: 0 07:03:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:03:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:54 INFO - Reading from file tmpfile_stdout 07:03:54 INFO - Current package versions: 07:03:54 INFO - argparse == 1.2.1 07:03:54 INFO - blessings == 1.6 07:03:54 INFO - blobuploader == 1.2.4 07:03:54 INFO - docopt == 0.6.1 07:03:54 INFO - functools32 == 3.2.3-2 07:03:54 INFO - jsonschema == 2.5.1 07:03:54 INFO - manifestparser == 1.1 07:03:54 INFO - mozInstall == 1.12 07:03:54 INFO - mozcrash == 0.17 07:03:54 INFO - mozdebug == 0.1 07:03:54 INFO - mozdevice == 0.48 07:03:54 INFO - mozfile == 1.2 07:03:54 INFO - mozhttpd == 0.7 07:03:54 INFO - mozinfo == 0.9 07:03:54 INFO - mozleak == 0.1 07:03:54 INFO - mozlog == 3.2 07:03:54 INFO - moznetwork == 0.27 07:03:54 INFO - mozprocess == 0.23 07:03:54 INFO - mozprofile == 0.28 07:03:54 INFO - mozrunner == 6.12 07:03:54 INFO - mozscreenshot == 0.1 07:03:54 INFO - mozsystemmonitor == 0.3 07:03:54 INFO - moztest == 0.7 07:03:54 INFO - mozversion == 1.4 07:03:54 INFO - psutil == 3.1.1 07:03:54 INFO - requests == 1.2.3 07:03:54 INFO - wsgiref == 0.1.2 07:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:54 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')]} 07:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 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')]} 07:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 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 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:54 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 07:03:54 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 07:03:54 INFO - Using env: {'DISPLAY': ':0', 07:03:54 INFO - 'HOME': '/home/cltbld', 07:03:54 INFO - 'LANG': 'en_US.UTF-8', 07:03:54 INFO - 'LANGUAGE': 'en_US:en', 07:03:54 INFO - 'LOGNAME': 'cltbld', 07:03:54 INFO - 'MAIL': '/var/mail/cltbld', 07:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:54 INFO - 'MOZ_NO_REMOTE': '1', 07:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:54 INFO - 'NO_EM_RESTART': '1', 07:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:54 INFO - 'PWD': '/builds/slave/test', 07:03:54 INFO - 'SHELL': '/bin/bash', 07:03:54 INFO - 'SHLVL': '1', 07:03:54 INFO - 'TERM': 'linux', 07:03:54 INFO - 'TMOUT': '86400', 07:03:54 INFO - 'USER': 'cltbld', 07:03:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:54 INFO - '_': '/tools/buildbot/bin/python'} 07:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 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)) 07:03:54 INFO - Cleaning up... 07:03:54 INFO - Return code: 0 07:03:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:03:54 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')]} 07:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 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')]} 07:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:54 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 0x29b9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, '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': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', '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 07:03:54 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 07:03:54 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 07:03:54 INFO - Using env: {'DISPLAY': ':0', 07:03:54 INFO - 'HOME': '/home/cltbld', 07:03:54 INFO - 'LANG': 'en_US.UTF-8', 07:03:54 INFO - 'LANGUAGE': 'en_US:en', 07:03:54 INFO - 'LOGNAME': 'cltbld', 07:03:54 INFO - 'MAIL': '/var/mail/cltbld', 07:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:54 INFO - 'MOZ_NO_REMOTE': '1', 07:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:54 INFO - 'NO_EM_RESTART': '1', 07:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:54 INFO - 'PWD': '/builds/slave/test', 07:03:54 INFO - 'SHELL': '/bin/bash', 07:03:54 INFO - 'SHLVL': '1', 07:03:54 INFO - 'TERM': 'linux', 07:03:54 INFO - 'TMOUT': '86400', 07:03:54 INFO - 'USER': 'cltbld', 07:03:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:54 INFO - '_': '/tools/buildbot/bin/python'} 07:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:03:55 INFO - Cleaning up... 07:03:55 INFO - Return code: 0 07:03:55 INFO - Running post-action listener: _resource_record_post_action 07:03:55 INFO - Running post-action listener: _start_resource_monitoring 07:03:55 INFO - Starting resource monitoring. 07:03:55 INFO - ##### 07:03:55 INFO - ##### Finished create-virtualenv step (success) 07:03:55 INFO - ##### 07:03:55 INFO - ##### 07:03:55 INFO - ##### Running install step. 07:03:55 INFO - ##### 07:03:55 INFO - Running pre-action listener: _resource_record_pre_action 07:03:55 INFO - Running main action method: install 07:03:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:55 INFO - Reading from file tmpfile_stdout 07:03:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:03:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:03:55 INFO - Reading from file tmpfile_stdout 07:03:55 INFO - Output received: 07:03:55 INFO - Usage: mozinstall [options] installer 07:03:55 INFO - Options: 07:03:55 INFO - -h, --help show this help message and exit 07:03:55 INFO - -d DEST, --destination=DEST 07:03:55 INFO - Directory to install application into. [default: 07:03:55 INFO - "/builds/slave/test"] 07:03:55 INFO - --app=APP Application being installed. [default: firefox] 07:03:55 INFO - mkdir: /builds/slave/test/build/application 07:03:55 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'] 07:03:55 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 07:04:11 INFO - Reading from file tmpfile_stdout 07:04:11 INFO - Output received: 07:04:11 INFO - /builds/slave/test/build/application/firefox/firefox 07:04:11 INFO - Running post-action listener: _resource_record_post_action 07:04:11 INFO - ##### 07:04:11 INFO - ##### Finished install step (success) 07:04:11 INFO - ##### 07:04:11 INFO - ##### 07:04:11 INFO - ##### Running run-tests step. 07:04:11 INFO - ##### 07:04:11 INFO - Running pre-action listener: _resource_record_pre_action 07:04:11 INFO - Running main action method: run_tests 07:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:04:11 INFO - Python 2.7.3 07:04:11 INFO - Return code: 0 07:04:11 INFO - grabbing minidump binary from tooltool 07:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:04:11 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 0x2c77570>, '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 0x2c78470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c78900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:04:11 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 07:04:11 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 07:04:11 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 07:04:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:11 INFO - Return code: 0 07:04:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:04:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:04:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:04:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:04:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 07:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 07:04:11 INFO - Using env: {'DISPLAY': ':0', 07:04:11 INFO - 'HOME': '/home/cltbld', 07:04:11 INFO - 'LANG': 'en_US.UTF-8', 07:04:11 INFO - 'LANGUAGE': 'en_US:en', 07:04:11 INFO - 'LOGNAME': 'cltbld', 07:04:11 INFO - 'MAIL': '/var/mail/cltbld', 07:04:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:11 INFO - 'MOZ_NO_REMOTE': '1', 07:04:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:11 INFO - 'NO_EM_RESTART': '1', 07:04:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:11 INFO - 'PWD': '/builds/slave/test', 07:04:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:11 INFO - 'SHELL': '/bin/bash', 07:04:11 INFO - 'SHLVL': '1', 07:04:11 INFO - 'TERM': 'linux', 07:04:11 INFO - 'TMOUT': '86400', 07:04:11 INFO - 'USER': 'cltbld', 07:04:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830', 07:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:11 INFO - '_': '/tools/buildbot/bin/python'} 07:04:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 07:04:12 INFO - mozversion application_buildid: 20160713063326 07:04:12 INFO - mozversion application_changeset: 016e4fdb5a52374d139e3553fc564a7ae0f9ea74 07:04:12 INFO - mozversion application_display_name: Nightly 07:04:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:12 INFO - mozversion application_name: Firefox 07:04:12 INFO - mozversion application_remotingname: firefox 07:04:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:04:12 INFO - mozversion application_vendor: Mozilla 07:04:12 INFO - mozversion application_version: 50.0a1 07:04:12 INFO - mozversion platform_buildid: 20160713063326 07:04:12 INFO - mozversion platform_changeset: 016e4fdb5a52374d139e3553fc564a7ae0f9ea74 07:04:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:04:12 INFO - mozversion platform_version: 50.0a1 07:04:12 INFO - using testdate: 1468418652 07:04:12 INFO - actual date: 1468418652 07:04:12 INFO - starting webserver on 'localhost:57243' 07:04:12 INFO - SUITE-START | Running 2 tests 07:04:12 INFO - TEST-START | dromaeo_css 07:04:12 INFO - operating with platform_type : linux_ 07:04:12 INFO - Initialising browser for dromaeo_css test... 07:04:12 INFO - TEST-INFO | started process 12360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppb3EoX/profile http://localhost:57243/getInfo.html) 07:04:16 INFO - PROCESS | 12360 | __metrics Screen width/height:1600/1200 07:04:16 INFO - PROCESS | 12360 | colorDepth:24 07:04:16 INFO - PROCESS | 12360 | Browser inner width/height: 1024/697 07:04:16 INFO - PROCESS | 12360 | __metrics 07:04:17 ERROR - PROCESS | 12360 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 07:04:18 INFO - TEST-INFO | 12360: exit 0 07:04:18 INFO - Browser initialized. 07:04:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:18 INFO - TEST-INFO | started process 12480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppb3EoX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:30 INFO - PROCESS | 12480 | RSS: Main: 168710144 07:04:30 INFO - PROCESS | 12480 | 07:05:19 INFO - PROCESS | 12480 | 1468418719978 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] 07:07:32 INFO - PROCESS | 12480 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57243/tests/dromaeo/cssquery-ext.html) 07:07:33 INFO - PROCESS | 12480 | RSS: Main: 169091072 07:07:33 INFO - PROCESS | 12480 | 07:10:35 INFO - PROCESS | 12480 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-ext.html (next: http://localhost:57243/tests/dromaeo/cssquery-jquery.html) 07:10:36 INFO - PROCESS | 12480 | RSS: Main: 168480768 07:10:36 INFO - PROCESS | 12480 | 07:13:38 INFO - PROCESS | 12480 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57243/tests/dromaeo/cssquery-mootools.html) 07:13:38 INFO - PROCESS | 12480 | RSS: Main: 171671552 07:13:38 INFO - PROCESS | 12480 | 07:16:40 INFO - PROCESS | 12480 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57243/tests/dromaeo/cssquery-prototype.html) 07:16:41 INFO - PROCESS | 12480 | RSS: Main: 167600128 07:16:41 INFO - PROCESS | 12480 | 07:19:44 INFO - PROCESS | 12480 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57243/tests/dromaeo/cssquery-yui.html) 07:19:44 INFO - PROCESS | 12480 | RSS: Main: 170057728 07:19:44 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | Cycle 1(1): loaded http://localhost:57243/tests/dromaeo/cssquery-yui.html (next: http://localhost:57243/tests/dromaeo/cssquery-dojo.html) 07:22:47 INFO - PROCESS | 12480 | RSS: Main: 170647552 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | __start_tp_report 07:22:47 INFO - PROCESS | 12480 | _x_x_mozilla_page_load 07:22:47 INFO - PROCESS | 12480 | _x_x_mozilla_page_load_details 07:22:47 INFO - PROCESS | 12480 | |i|pagename|runs| 07:22:47 INFO - PROCESS | 12480 | |0;dojo.html;2620.5938079597663;2680.249530131564;2687.1132526266324;2694.6496955395796;2696.743809338112;4606.424196975382;4672.205725026745;4689.179393606122;4783.402074740658;4807.2789081637775;4600.17196904557;4703.929441058387;4717.811287548502;4751.40607424072;4781.282807578857;4266.338717498793;4351.499577548575;4413.117376524692;4437.600615944564;4463.955360446386;575.9200501473302;4254.404383386328;4258.403823464718;4315.180115778008;4375.912481750363;4376.2122817892605;4377.190219809346;4417.028253784162;4429.557044295577;4476.194285028693;4397.2304846651705;4429.867103986886;4436.600705936449;4437.7781110944325;4467.530909254514;4301.677374196916;4359.062801497693;4371.846985355497;4388.626966707834;4399.670024748157;4752.857414277577;4779.952200477986;4788.7845046972625;4798.424189097295;4804.6876952997945;4954.133026720309;4997.925031124536;5101.234814777813;5118.59051275897;5131.204663277161;5050.671706339076;5066.771995260222;5068.923966140511;5074.416442109168;5124.0776660201145;4733.479317275097;4813.663043586916;4814.807407703723;4833.323334733105;4854;5158.097332966716;5211.270422140903;5289.259503669412;5301.814436494781;5362.51737343641;5002.499750025041;5020.7740651670765;5026.54761071498;5027.095122877917;5084;5046.318746969112;5107.055194788902;5130.076586214443;5136.563392111638;5167.689938603696;4996.725180115129;5066.594672426197;5067.670601410897;5070.366204224472;5093.134167191586;5021.322121513622;5029.270755740397;5045.293658887758;5052.545270925634;5058.038972595195;4189.476315460567;4357.9128417431475;4360.585744354281;4377.868663940087;4417.646588272931;3708.4622729704583;3738.775673459601;3767.2842159990064;3813.694904407641;3814.1418180909072;4351.151525452507;4360.694751367374;4393.033532622818;4419.337099435046;4459.152760975404;5128;5137.691738495702;5137.897242055138;5140.794368225229;5145.408278048072;4318.265894797892;4349.608535231844;4381.342798580238;4400.317950717644;4405.163019026439;4600.930986035212;4608.5852273294895;4611.769411529477;4626.8149274028665;4669.486356500782;4645.512221216723;4824.541668541553;4828.686135401188;4832.420109586802;4840.903181936271;5082.847514574569;5132.563732082665;5169.922451163311;5183.844484665466;5233.528982391603;4864;4893.363862697969;4894.486078961801;4898.24077268024;4948.579370753526;5009.9248511271635;5081.212412076134;5086.644198746415;5089.643724939367;5093.516115968977;5109.5912327013;5143.537081662519;5169.508896654812;5169.53474187325;5219.399769026459;5002.174641184164;5009.448960614257;5009.870804907972;5014.87462813418;5070.619703522177;4883.096627123993;4908.386451693538;4951.925721114114;5009.148444764472;5031.84904452867;4861.392325959255;4881.145799485147;4892.535209155125;4901.436334821541;4907.631927605516;5007.69953802773;5009.5491405773655;5018.096742586369;5023.146065169003;5090.160123579568;4707.223308154254;4783.091212669582;4801.4958429364415;4831.323614693875;4856.805727770849 07:22:47 INFO - PROCESS | 12480 | |1;ext.html;552.4116815591395;553.7231384307846;557.7573755416394;567.5317862763219;593.9970300148499;35900;39456.40815387768;39754;39766.8011659942;39818.80090599543;38514;38587.22825543487;38617.22765544688;38843;38981.22037559247;7639.961800191005;7806.453548251625;7826.726064587712;7863.449558530905;7874.212578742137;7798.2981531662135;7817.648205830751;7872.921270787276;7879.527228366288;7900.9728735264625;7899.091604465502;7933.365330773524;7947.165547617504;7956.204379562056;7977.24216199463;7875.369970402354;7896.565688887109;7910.841783164333;7917.7624671259955;7953.840923181562;7732.49738766984;7784.221577842227;7787.96106019472;7794.337481314095;7796.61016949156;38308.616913831065;38405;38417;38692;38769.22461550782;3038.863251153681;3046.1775320663296;3116.594842670461;3134.420132275536;3602.873899413508;30022.549661755093;30412.8479357604;30493.69506304931;30568.484624268272;31447;3023;3272.5582046423665;3284.965235950668;3294.8352582370785;3372.763906526544;174976;175325;175972;176816;176823.11588442104;55533.72233138808;55730.44269557253;55964;56094.71952640211;56155.157672634945;33472.49791253133;34174.316513670085;34418.82790586031;36260.27479450396;59039.11441328384;15390.923045384701;15762.054276743433;15820.60448488797;15828.366865325488;15858.127802970717;11872.762544749057;12007.879921200676;12038.759224815454;12063.758724825455;12153.392330383445;18618.348357807412;18709.158087886077;18867.245310187438;18902.905485472485;18959.90520047391;6917.412019978358;7117.537360071578;7118.608476533736;7162.7493037743425;7164.21193668696;817.264461984219;937.9859302110474;1008.6620981970975;1014.4377658405972;1025.3642741500319;27741.58387624187;27799;27830.44339113247;28035;28121;813.32494029955;951.8767853932288;973.522973742875;1004.7237009822358;1027.8282757656277;14168.291585420688;14427.20650364219;14572.41710331596;14821.555353339418;14831.70336593262;416069;419359;420933;422677;424440;49301;49397;49608;49640.75179624151;49663.25505117426;1160.460385920551;1178.4284621958343;1196;1202.729385888168;1215.5623975369037;23587;23893.761062389847;24568.877155614107;24705.135320264424;24843.254702358958;43029.35455968226;43769.34345984749;43836.561634383244;43910.19391994246;43928.78035609802;284886;353121;355668;356014;356816;25316.746832532175;25643.615345770202;25656;25713;25737.871310643328;41855.58144418517;42687.35968960406;42889.142217156106;43436;43630.56369436392;36420.635793641726;36609.45085823662;36660.0834979117;36724.08189795277;36988.44517332188;36605.729877216916;36788.63211367852;37032.25935481329;37226.627733722315;37268.627313726516;30594.541081884236;35318.47022294616;36010.63989360073;36327;36604;31850.681493184773;33101.372766630215;33147.27776099394;33286.833565832014;33647.663523364456;24362.51274974526;24495.755042449346;24643.260702178963;24945;25048.499030019662 07:22:47 INFO - PROCESS | 12480 | |2;jquery.html;369.0588998054959;370.2280744647411;371.873562988584;383.04074658123704;383.9462475253465;16327.83672163278;16804.495865124052;17834.821651783477;17896.19467123979;17906.552336191602;12298.508059677602;16323.265453054611;17233;17237.82762172378;17845;4445.310976798593;4829.541193586604;4830.830920917769;4834.371531700874;4852.150873597124;4773.427188737339;4794.280857871312;4800.303955926406;4801.255805350159;5031.949680503203;5017.774200160983;5150.098732721759;5157.3811142662935;5168.198929165986;5205.479452054802;5049.419316778544;5118.436971933084;5152;5161.509656582619;5171.637985341028;5219.791208351661;5223.11207094791;5259;5264.499872512105;5281.445448227958;18985.43043708691;20119.899400502905;21187.046582903808;21212;21230.150793968223;1731.37670438642;1769.9911500442545;1803.9909800450914;1893.7632795900513;2252.6958860553777;8985.775355616097;9146;9188.816223675556;9344.205742511895;9400.905990940071;1614.6851363984028;1636.4272504623405;1711.4523352527196;1821.4535639308288;1869.6447674941853;67467.66266168687;70646.64676676635;72517.27482725157;73028.26971730268;73088.63455682687;9988.60045598168;10136.239782016379;10321.793564128675;10394.636187733393;10504.789904201873;13915.512957046658;13938.163710177421;13945.442182312796;14009.299535023209;14052.36764345607;7048.682809273595;7073.398761105261;7208.963955180296;7315.4147668186415;7347.55914645123;6702.296258892844;6736.360045795642;6755.2906944771075;6847.657617119125;6926.341997510229;3960.6237407446247;3991.0820511281986;4310.4611923509565;4337.349397590324;4367.62875155609;1842.834144926963;1864.7762268527863;1868.775951751605;1883.7174423836261;1884.6136542008855;826.4669288309007;841.2722994609619;905.7056456651615;945.5697657565792;972.0959507657946;14473.565793026226;16387.684430905978;16803.831961680473;17059.658806823794;17075.40236091731;830.4602008694397;853.9146085391411;854.974350769478;856.8629019356873;877.2850127146355;9579.185769209556;9621.51892405391;9744.658936937314;9805.970373110864;9986.800263994824;367516;369656;371740;373663;374871;75988;80478;81069.59465202637;81223.59388203021;81612.59193703994;898.7842917699836;912.726182145367;921.2583869984727;923.0769230769231;932.911373419524;15130.773038404654;15587.376504939675;15631.84368156304;15889.602759931095;16119.355225790838;36504.634953651184;37233.25533489369;37701.24597507979;38253;39766.40350394689;48813.75593122012;48944.75527622339;53068.73465632647;53436.465635344706;53504;6287.2769631492965;6813.2846051163915;6983.594444277887;6986.9650651746415;7005.964970175117;9579.90420095818;10589.311694739818;10768.838467422838;11040.33757974524;11234.213605047567;9573.138417542455;9792.46141462198;9823.21414286841;10055.849162262719;10069.446180460145;9788.265880059167;9872.111509964137;9929.304948653526;9960.452175130438;9995.900040999788;9802.705918822447;9850.802983940137;9860.753481163028;10041.899581004096;10346.689599312032;7002.649867506706;7031.1211098612675;7094.574325540484;7107.538010029539;7121.537100088478;8654.913450865412;9716.076972687584;9803.313768036169;10127.696169114939;10214.642487513198 07:22:47 INFO - PROCESS | 12480 | |3;mootools.html;1269.0989397527756;1321.9801702974455;1412.5197432872822;1609.7504886742558;1662.2270644150476;6205.0692396140485;7020.017197592341;7160.498765086446;7673.462857599963;7676.692932282709;7087.71649134034;7265.963670181642;7370.668319925603;7418.517796343234;7422.665980030898;2164.9567008659856;2219.7891200335944;2227.40973641985;2227.721534808149;2229.052652622637;2166.198506552578;2180.672899065145;2226.209695558078;2230.587341341849;2233.0174723121854;2219.156720446228;2222.1111555377815;2226.7216597925258;2231.6206244938317;2251.133313674231;2158.902849371782;2176.836737244713;2177.2923799765063;2182.519845633958;2182.90176942038;2150.4623844038993;2179.7384313882276;2183.54145629418;2187.3547303545333;2191.9780802191935;7278.272172782732;7287.5627462351895;7407.296306850841;7467.066616672916;7550.811229719246;4464.910701785979;4606.976965115186;4610.2854057621125;4612.53874612536;4621.676482646216;2819.0978886756247;2868.225579093633;2880.395117025427;2912.7184039022763;2941;847.9067302596709;901.7745563609097;918.6279556779448;920.5673333533229;922.5802259971697;9871.111599956039;10038.247131465096;10094.141997930112;10150.238732095122;10157;4032.2338755636333;4107.219628270679;4255.170241802881;4270.935935960901;4276.679249056333;8581.313494920516;8593.183647553598;8622.482651040958;8685.044645089036;8690.956545217234;4511.932321015187;4513.255312873404;4583.862484125481;4594.839180628662;4606.95393046072;3521.3133438979153;4031.274370613259;4144.8756537303925;4164.8542301019315;4212;3568.286342731464;3581.83881725323;3676.1361080146144;3686.5391826021746;3705.4627079073384;1178.711215752129;1212.3635091576994;1213.6237766292477;1219.2014230678742;1226.2531928480141;820.6061090676509;821.6302663801314;842.7303262955918;862.4307956748515;872.9170728780756;5061.544460998454;5083.61872859537;5123.494081171028;5238;5277.182036784305;416.0410254363721;419.55108034402895;422.14726252969444;423.883432056187;428.3510481620348;3496.7727097738566;3504.491848681978;3526.947095793565;3584.874529391459;3607.4408466687705;8632.093630168867;8908.242799362128;8972.37193396469;8994.145556172152;9038.231750301298;8883.73348799537;8893.822123557493;8919.643214271486;8926.642934282556;8927.196552310323;6828.112345395067;6893.414059804973;6954.165500140016;6960.965195174093;6966.407855332353;4880.585150262267;4890.070886531547;4924.212126059813;4938.407391113089;4988.12707776145;8384.496930184208;8404.033536143423;8423.410361274651;8446.197611226924;8475.067742548192;8317.542535160625;8455.32357411418;8590.699325523577;8616.870746938926;8631.611577479154;5758.424157584375;6112.663803490851;6123.234595675541;6662.800115996528;7029.402500787286;7032.8593428130125;7248.855022899618;7252.818679533054;7289.854202916018;7329.486935914648;6432;6501.869962600627;6515.12045873801;6556.573822701509;6579.046038324512;6220.346863579259;6462.3537646235;6463.25672547663;6528.347165283433;6550.672466376757;6055.485283750931;6193.84515387119;6209.19280493551;6213.96893015532;6214.4407003369915;4142.606452387018;4445.466544014739;4502.302143167814;4546.068056048436;4560.8859778504475;4410.184115938561;4577.061702350943;4607.838725644587;4676.625869930465;4695.248760198352 07:22:47 INFO - PROCESS | 12480 | |4;prototype.html;279.6253020951924;287.439492988672;289.7768718087074;293.94562006028883;300.1565600662139;4999.625103096646;5029.371328583927;5087.771050302731;5102.897942041157;5115.283860259562;4966.925496117552;4975.950240497594;4984.526469985355;4996.225585034325;5003.224500202466;3754.8310326035394;3780.9810950945343;3898.66861316787;3907.921841563167;3930.7445016074007;3878.2437424702193;3895.6493915547735;3898.6354775828377;3927.5483319418345;3930.6069393060607;3909.4722212501374;3926.7447615905016;3928.410738389236;3929;3939.4681717968137;3847.5952529668957;3917.6474117329576;3934.488516492838;3944.9408258876138;3950.8814735557835;3423.7774544654767;3452.2405070884365;3452.361313157074;3455.6198818129988;3463.1515278756615;4906.215005599122;4911.214205727067;4928.901421971541;4929.584503593213;4936.6297527685565;4325.740455572675;4501.7524036178;4507.729536227836;4515.390422293014;4522.7060241084555;5185.870353241162;5191.974040129813;5221.024016310705;5243.614155559211;5271.970291437786;3722.9255414891823;3727.9934417707336;3776.697864170887;3780.546334439885;3786.958586388738;5308.177232528926;5455.236266922634;5497.532709719679;5501.367342755594;5501.834944951658;3784.7539909905768;3857.1514266861245;3874.6319099685484;3878.7284890057426;3885.2812229737588;3899.7520793345857;3930.4890364252465;3943.9014024649614;3949.2496425679606;3972.5431575369203;4458.754768487699;4467.374567560544;4474.239379305526;4475.507694153641;4475.955240447619;5033.144365457881;5178.896422071537;5252.133397989365;5263.921041184385;5263.973680131575;1354.3566805767182;1373.4574842936984;1377.0429551461839;1377.1668140774887;1379.8137251470923;858.6822875535967;879.6041781198486;892.3797960417577;907.7322189953848;913.981720365589;4370.322599996942;4548.044910568751;4557.521460246693;4567.2464043432465;4623.4451865775645;5388.625900395374;5391.272178255964;5403.298350824588;5420.24116623673;5484.561235101182;4509.751963642031;4598.494165641777;4609.723416595015;4624.121416930772;4640.164770341304;2857.6285082939085;2896.000879696501;2916.9708302917124;2919.985400072986;2921.8246905185756;5115.5396014358885;5141.948580514222;5156.252343410185;5160;5160.18769770476;5372.462753724596;5505.917411238835;5513.751881165357;5571.972140139354;5581.944180558143;5075.568576671024;5115.2071428928575;5123.692578445305;5128.897422051538;5147.2279158126585;5403.243545903655;5417.945820541744;5420.376656684374;5426.565874729933;5454.59090568201;4983.327250821093;5251.190613022015;5256.763445644879;5264.605154613496;5271.207789351639;5121.41103773056;5131.306668799362;5155.690658560498;5157.896842063213;5172.275881376686;3939.2318497892634;3942.8817135485983;3951.723379363532;3957.6635985941516;3962.582824477009;5153.742312884416;5440.700761458;5446.754896029609;5448.809291674773;5478.91781623268;5317.494837990384;5324.227986941949;5326.8934621308135;5339.973300133474;5341.973290133525;5157.8452646420665;5291.391489978701;5322.228276899906;5322.574194064543;5359.196120581788;5202.167653175474;5209.6874187548865;5218.225803226921;5221.451747566451;5234.764435600331;5093.490650935025;5168.191133103383;5302.1781623848365;5336.919946200887;5358.571314294769;5225.947740522546;5234.921476177937;5240.737963101906;5249.343832020997;5254.97372513135 07:22:47 INFO - PROCESS | 12480 | |5;yui.html;536.6484952356205;565.3526711914858;624.434886427783;654.7282877605791;664.3854434647949;11982.580609678664;12353.567625133122;12486.625401237978;12828.935855320722;12834.550790722327;12636.11547191697;12756.744865102692;12764.489420423171;12772.233665980048;12835.358232088405;607.9817605471843;736.1718067174429;756.9432292578065;768.8077980504873;771.4137255685691;774.6049514747491;776.7281451491989;777.1878387085509;779.0806847919453;780.6682160081971;829.6473998550622;831.7795784117213;832.176145615839;833.012879737513;833.891594092767;814.7555733279992;815.975520734379;817.0440584516131;825.7316372179035;826.995865020674;598.413554716376;605.255535691098;606.0243008755899;607.104520831774;608.0241212853396;13028.674283142997;13348.532801352003;13382.799258011137;13440;13447.260400677958;13397.330133493384;13510.527131550349;13525.932370338085;13558.389872455764;13828.861711382959;10637.787244255072;10731.409772462512;10777.407242601654;10897.12822974168;10912.072473839653;2846.288427893027;2852.429514097189;2890.523063694488;2903.3177203357195;2915.4314908592833;67572.59347653152;68591.65704171447;68879;68885.65557172181;69441.3055869445;10789.352638841694;10852.186086043579;10913.83629245562;10926.672199834018;10977;20317.18731250763;20445.79554204439;20574.69137962932;20748.066337014872;20974.47563810917;6983.8603227935155;6999.720011199597;7020.297970203041;7025.192102908129;7122.145342558822;3834.1564855731694;3942.56631770505;3964.524257089168;3968.8214030368126;3971.2851686696094;2753.366725653111;2856.243095579673;2858.5283428234106;2861.3848022675224;2875.7124287571496;477.99522004780204;480.18129089901635;481.07393267959037;490.2399490866399;496.1268168024303;470.7246260937321;501.41334638473074;527.941926388097;544.1565573361274;594.2037669522774;8531.360147988926;8543.231109200202;8617.267532259828;8879;8965.641374345083;479.69299648224467;527.749319073437;586.9031609784338;590.8020813027598;682.1439093937078;3874.7868867212574;3886.25450629011;4099.385092236129;4164.8125834337525;4298.161858437637;53944.73027634837;74899;87526.56236718904;91388.54305728429;93012;47356;56530.717346413;73941;75444.24555754372;76268;45625.31562026572;56758.71620641871;71877.64061179766;72798;73318.63340683369;8522.872156917527;9003.594838232164;9137.223336016246;9196.632134714537;9231.215346695606;37968.24063518769;38325.233495330496;40515.79742101271;41403.7929810349;41903.371449428894;40142.397864032646;40393;41491.37762933498;62035;62825.685871572176;10623.628173013907;10765.192610554082;11476;11656.475458604213;11899.524019039141;12624.55814046504;13327.866721332663;13389.866101338863;13463.798043029557;13683.179009259477;12101.636950891487;12247.571335003233;12287.324197168884;12318.384080796104;12766.29785361814;11596.768064638829;11872.168948173545;11980.58067967617;12088.818667719815;12263.38683065861;8023.398245131521;11453.255538389978;11473.770524589629;11512.021478174449;11682.532698691957;10491.68524944253;10734.463276835972;10768.569257229623;11033.724156896142;11195.944020279847;10023.448710321003;10363.430011349448;10392.168626510012;10427.582896684351;10543.57825686964 07:22:47 INFO - PROCESS | 12480 | __end_tp_report 07:22:47 INFO - PROCESS | 12480 | __start_cc_report 07:22:47 INFO - PROCESS | 12480 | _x_x_mozilla_cycle_collect,385 07:22:47 INFO - PROCESS | 12480 | __end_cc_report 07:22:47 INFO - PROCESS | 12480 | __startTimestamp1468419767581__endTimestamp 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | ------- Summary: start ------- 07:22:47 INFO - PROCESS | 12480 | Number of tests: 6 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | [#0] dojo.html Cycles:165 Average:4694.59 Median:4854.00 stddev:592.79 (12.2%) stddev-sans-first:571.84 07:22:47 INFO - PROCESS | 12480 | Values: 2620.6 2680.2 2687.1 2694.6 2696.7 4606.4 4672.2 4689.2 4783.4 4807.3 4600.2 4703.9 4717.8 4751.4 4781.3 4266.3 4351.5 4413.1 4437.6 4464.0 575.9 4254.4 4258.4 4315.2 4375.9 4376.2 4377.2 4417.0 4429.6 4476.2 4397.2 4429.9 4436.6 4437.8 4467.5 4301.7 4359.1 4371.8 4388.6 4399.7 4752.9 4780.0 4788.8 4798.4 4804.7 4954.1 4997.9 5101.2 5118.6 5131.2 5050.7 5066.8 5068.9 5074.4 5124.1 4733.5 4813.7 4814.8 4833.3 4854.0 5158.1 5211.3 5289.3 5301.8 5362.5 5002.5 5020.8 5026.5 5027.1 5084.0 5046.3 5107.1 5130.1 5136.6 5167.7 4996.7 5066.6 5067.7 5070.4 5093.1 5021.3 5029.3 5045.3 5052.5 5058.0 4189.5 4357.9 4360.6 4377.9 4417.6 3708.5 3738.8 3767.3 3813.7 3814.1 4351.2 4360.7 4393.0 4419.3 4459.2 5128.0 5137.7 5137.9 5140.8 5145.4 4318.3 4349.6 4381.3 4400.3 4405.2 4600.9 4608.6 4611.8 4626.8 4669.5 4645.5 4824.5 4828.7 4832.4 4840.9 5082.8 5132.6 5169.9 5183.8 5233.5 4864.0 4893.4 4894.5 4898.2 4948.6 5009.9 5081.2 5086.6 5089.6 5093.5 5109.6 5143.5 5169.5 5169.5 5219.4 5002.2 5009.4 5009.9 5014.9 5070.6 4883.1 4908.4 4951.9 5009.1 5031.8 4861.4 4881.1 4892.5 4901.4 4907.6 5007.7 5009.5 5018.1 5023.1 5090.2 4707.2 4783.1 4801.5 4831.3 4856.8 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | [#1] ext.html Cycles:180 Average:46611.87 Median:36604.86 stddev:87238.62 (238.3%) stddev-sans-first:87414.81 07:22:47 INFO - PROCESS | 12480 | Values: 552.4 553.7 557.8 567.5 594.0 35900.0 39456.4 39754.0 39766.8 39818.8 38514.0 38587.2 38617.2 38843.0 38981.2 7640.0 7806.5 7826.7 7863.4 7874.2 7798.3 7817.6 7872.9 7879.5 7901.0 7899.1 7933.4 7947.2 7956.2 7977.2 7875.4 7896.6 7910.8 7917.8 7953.8 7732.5 7784.2 7788.0 7794.3 7796.6 38308.6 38405.0 38417.0 38692.0 38769.2 3038.9 3046.2 3116.6 3134.4 3602.9 30022.5 30412.8 30493.7 30568.5 31447.0 3023.0 3272.6 3285.0 3294.8 3372.8 174976.0 175325.0 175972.0 176816.0 176823.1 55533.7 55730.4 55964.0 56094.7 56155.2 33472.5 34174.3 34418.8 36260.3 59039.1 15390.9 15762.1 15820.6 15828.4 15858.1 11872.8 12007.9 12038.8 12063.8 12153.4 18618.3 18709.2 18867.2 18902.9 18959.9 6917.4 7117.5 7118.6 7162.7 7164.2 817.3 938.0 1008.7 1014.4 1025.4 27741.6 27799.0 27830.4 28035.0 28121.0 813.3 951.9 973.5 1004.7 1027.8 14168.3 14427.2 14572.4 14821.6 14831.7 416069.0 419359.0 420933.0 422677.0 424440.0 49301.0 49397.0 49608.0 49640.8 49663.3 1160.5 1178.4 1196.0 1202.7 1215.6 23587.0 23893.8 24568.9 24705.1 24843.3 43029.4 43769.3 43836.6 43910.2 43928.8 284886.0 353121.0 355668.0 356014.0 356816.0 25316.7 25643.6 25656.0 25713.0 25737.9 41855.6 42687.4 42889.1 43436.0 43630.6 36420.6 36609.5 36660.1 36724.1 36988.4 36605.7 36788.6 37032.3 37226.6 37268.6 30594.5 35318.5 36010.6 36327.0 36604.0 31850.7 33101.4 33147.3 33286.8 33647.7 24362.5 24495.8 24643.3 24945.0 25048.5 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | [#2] jquery.html Cycles:180 Average:23819.64 Median:5024.86 stddev:61643.43 (1226.8%) stddev-sans-first:61791.21 07:22:47 INFO - PROCESS | 12480 | Values: 369.1 370.2 371.9 383.0 383.9 16327.8 16804.5 17834.8 17896.2 17906.6 12298.5 16323.3 17233.0 17237.8 17845.0 4445.3 4829.5 4830.8 4834.4 4852.2 4773.4 4794.3 4800.3 4801.3 5031.9 5017.8 5150.1 5157.4 5168.2 5205.5 5049.4 5118.4 5152.0 5161.5 5171.6 5219.8 5223.1 5259.0 5264.5 5281.4 18985.4 20119.9 21187.0 21212.0 21230.2 1731.4 1770.0 1804.0 1893.8 2252.7 8985.8 9146.0 9188.8 9344.2 9400.9 1614.7 1636.4 1711.5 1821.5 1869.6 67467.7 70646.6 72517.3 73028.3 73088.6 9988.6 10136.2 10321.8 10394.6 10504.8 13915.5 13938.2 13945.4 14009.3 14052.4 7048.7 7073.4 7209.0 7315.4 7347.6 6702.3 6736.4 6755.3 6847.7 6926.3 3960.6 3991.1 4310.5 4337.3 4367.6 1842.8 1864.8 1868.8 1883.7 1884.6 826.5 841.3 905.7 945.6 972.1 14473.6 16387.7 16803.8 17059.7 17075.4 830.5 853.9 855.0 856.9 877.3 9579.2 9621.5 9744.7 9806.0 9986.8 367516.0 369656.0 371740.0 373663.0 374871.0 75988.0 80478.0 81069.6 81223.6 81612.6 898.8 912.7 921.3 923.1 932.9 15130.8 15587.4 15631.8 15889.6 16119.4 36504.6 37233.3 37701.2 38253.0 39766.4 48813.8 48944.8 53068.7 53436.5 53504.0 6287.3 6813.3 6983.6 6987.0 7006.0 9579.9 10589.3 10768.8 11040.3 11234.2 9573.1 9792.5 9823.2 10055.8 10069.4 9788.3 9872.1 9929.3 9960.5 9995.9 9802.7 9850.8 9860.8 10041.9 10346.7 7002.6 7031.1 7094.6 7107.5 7121.5 8654.9 9716.1 9803.3 10127.7 10214.6 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | [#3] mootools.html Cycles:180 Average:4925.70 Median:4907.14 stddev:2685.16 (54.7%) stddev-sans-first:2678.63 07:22:47 INFO - PROCESS | 12480 | Values: 1269.1 1322.0 1412.5 1609.8 1662.2 6205.1 7020.0 7160.5 7673.5 7676.7 7087.7 7266.0 7370.7 7418.5 7422.7 2165.0 2219.8 2227.4 2227.7 2229.1 2166.2 2180.7 2226.2 2230.6 2233.0 2219.2 2222.1 2226.7 2231.6 2251.1 2158.9 2176.8 2177.3 2182.5 2182.9 2150.5 2179.7 2183.5 2187.4 2192.0 7278.3 7287.6 7407.3 7467.1 7550.8 4464.9 4607.0 4610.3 4612.5 4621.7 2819.1 2868.2 2880.4 2912.7 2941.0 847.9 901.8 918.6 920.6 922.6 9871.1 10038.2 10094.1 10150.2 10157.0 4032.2 4107.2 4255.2 4270.9 4276.7 8581.3 8593.2 8622.5 8685.0 8691.0 4511.9 4513.3 4583.9 4594.8 4607.0 3521.3 4031.3 4144.9 4164.9 4212.0 3568.3 3581.8 3676.1 3686.5 3705.5 1178.7 1212.4 1213.6 1219.2 1226.3 820.6 821.6 842.7 862.4 872.9 5061.5 5083.6 5123.5 5238.0 5277.2 416.0 419.6 422.1 423.9 428.4 3496.8 3504.5 3526.9 3584.9 3607.4 8632.1 8908.2 8972.4 8994.1 9038.2 8883.7 8893.8 8919.6 8926.6 8927.2 6828.1 6893.4 6954.2 6961.0 6966.4 4880.6 4890.1 4924.2 4938.4 4988.1 8384.5 8404.0 8423.4 8446.2 8475.1 8317.5 8455.3 8590.7 8616.9 8631.6 5758.4 6112.7 6123.2 6662.8 7029.4 7032.9 7248.9 7252.8 7289.9 7329.5 6432.0 6501.9 6515.1 6556.6 6579.0 6220.3 6462.4 6463.3 6528.3 6550.7 6055.5 6193.8 6209.2 6214.0 6214.4 4142.6 4445.5 4502.3 4546.1 4560.9 4410.2 4577.1 4607.8 4676.6 4695.2 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | [#4] prototype.html Cycles:180 Average:4378.74 Median:5001.42 stddev:1268.55 (25.4%) stddev-sans-first:1234.23 07:22:47 INFO - PROCESS | 12480 | Values: 279.6 287.4 289.8 293.9 300.2 4999.6 5029.4 5087.8 5102.9 5115.3 4966.9 4976.0 4984.5 4996.2 5003.2 3754.8 3781.0 3898.7 3907.9 3930.7 3878.2 3895.6 3898.6 3927.5 3930.6 3909.5 3926.7 3928.4 3929.0 3939.5 3847.6 3917.6 3934.5 3944.9 3950.9 3423.8 3452.2 3452.4 3455.6 3463.2 4906.2 4911.2 4928.9 4929.6 4936.6 4325.7 4501.8 4507.7 4515.4 4522.7 5185.9 5192.0 5221.0 5243.6 5272.0 3722.9 3728.0 3776.7 3780.5 3787.0 5308.2 5455.2 5497.5 5501.4 5501.8 3784.8 3857.2 3874.6 3878.7 3885.3 3899.8 3930.5 3943.9 3949.2 3972.5 4458.8 4467.4 4474.2 4475.5 4476.0 5033.1 5178.9 5252.1 5263.9 5264.0 1354.4 1373.5 1377.0 1377.2 1379.8 858.7 879.6 892.4 907.7 914.0 4370.3 4548.0 4557.5 4567.2 4623.4 5388.6 5391.3 5403.3 5420.2 5484.6 4509.8 4598.5 4609.7 4624.1 4640.2 2857.6 2896.0 2917.0 2920.0 2921.8 5115.5 5141.9 5156.3 5160.0 5160.2 5372.5 5505.9 5513.8 5572.0 5581.9 5075.6 5115.2 5123.7 5128.9 5147.2 5403.2 5417.9 5420.4 5426.6 5454.6 4983.3 5251.2 5256.8 5264.6 5271.2 5121.4 5131.3 5155.7 5157.9 5172.3 3939.2 3942.9 3951.7 3957.7 3962.6 5153.7 5440.7 5446.8 5448.8 5478.9 5317.5 5324.2 5326.9 5340.0 5342.0 5157.8 5291.4 5322.2 5322.6 5359.2 5202.2 5209.7 5218.2 5221.5 5234.8 5093.5 5168.2 5302.2 5336.9 5358.6 5225.9 5234.9 5240.7 5249.3 5255.0 07:22:47 INFO - PROCESS | 12480 | 07:22:47 INFO - PROCESS | 12480 | [#5] yui.html Cycles:180 Average:16333.33 Median:22307.59 stddev:21894.53 (98.1%) stddev-sans-first:21923.82 07:22:47 INFO - PROCESS | 12480 | Values: 536.6 565.4 624.4 654.7 664.4 11982.6 12353.6 12486.6 12828.9 12834.6 12636.1 12756.7 12764.5 12772.2 12835.4 608.0 736.2 756.9 768.8 771.4 774.6 776.7 777.2 779.1 780.7 829.6 831.8 832.2 833.0 833.9 814.8 816.0 817.0 825.7 827.0 598.4 605.3 606.0 607.1 608.0 13028.7 13348.5 13382.8 13440.0 13447.3 13397.3 13510.5 13525.9 13558.4 13828.9 10637.8 10731.4 10777.4 10897.1 10912.1 2846.3 2852.4 2890.5 2903.3 2915.4 67572.6 68591.7 68879.0 68885.7 69441.3 10789.4 10852.2 10913.8 10926.7 10977.0 20317.2 20445.8 20574.7 20748.1 20974.5 6983.9 6999.7 7020.3 7025.2 7122.1 3834.2 3942.6 3964.5 3968.8 3971.3 2753.4 2856.2 2858.5 2861.4 2875.7 478.0 480.2 481.1 490.2 496.1 470.7 501.4 527.9 544.2 594.2 8531.4 8543.2 8617.3 8879.0 8965.6 479.7 527.7 586.9 590.8 682.1 3874.8 3886.3 4099.4 4164.8 4298.2 53944.7 74899.0 87526.6 91388.5 93012.0 47356.0 56530.7 73941.0 75444.2 76268.0 45625.3 56758.7 71877.6 72798.0 73318.6 8522.9 9003.6 9137.2 9196.6 9231.2 37968.2 38325.2 40515.8 41403.8 41903.4 40142.4 40393.0 41491.4 62035.0 62825.7 10623.6 10765.2 11476.0 11656.5 11899.5 12624.6 13327.9 13389.9 13463.8 13683.2 12101.6 12247.6 12287.3 12318.4 12766.3 11596.8 11872.2 11980.6 12088.8 12263.4 8023.4 11453.3 11473.8 11512.0 11682.5 10491.7 10734.5 10768.6 11033.7 11195.9 10023.4 10363.4 10392.2 10427.6 10543.6 07:22:47 INFO - PROCESS | 12480 | -------- Summary: end -------- 07:22:47 INFO - PROCESS | 12480 | 07:22:48 INFO - TEST-INFO | 12480: exit 0 07:22:48 INFO - TEST-OK | dromaeo_css | took 1116232ms 07:22:48 INFO - TEST-START | kraken 07:22:48 INFO - operating with platform_type : linux_ 07:22:48 INFO - Initialising browser for kraken test... 07:22:48 INFO - TEST-INFO | started process 12726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1t2eFX/profile http://localhost:57243/getInfo.html) 07:22:52 INFO - PROCESS | 12726 | __metrics Screen width/height:1600/1200 07:22:52 INFO - PROCESS | 12726 | colorDepth:24 07:22:52 INFO - PROCESS | 12726 | Browser inner width/height: 1024/697 07:22:52 INFO - PROCESS | 12726 | __metrics 07:22:53 ERROR - PROCESS | 12726 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 07:22:54 INFO - TEST-INFO | 12726: exit 0 07:22:54 INFO - Browser initialized. 07:22:54 INFO - Running cycle 1/1 for kraken test... 07:22:54 INFO - TEST-INFO | started process 12846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1t2eFX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:06 INFO - PROCESS | 12846 | RSS: Main: 168652800 07:23:06 INFO - PROCESS | 12846 | 07:23:08 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:09 INFO - PROCESS | 12846 | RSS: Main: 173817856 07:23:09 INFO - PROCESS | 12846 | 07:23:12 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-dft) 07:23:13 INFO - PROCESS | 12846 | RSS: Main: 173740032 07:23:13 INFO - PROCESS | 12846 | 07:23:16 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-fft) 07:23:16 INFO - PROCESS | 12846 | RSS: Main: 168542208 07:23:16 INFO - PROCESS | 12846 | 07:23:18 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57243/tests/kraken/driver.html?testName=audio-oscillator) 07:23:19 INFO - PROCESS | 12846 | RSS: Main: 169070592 07:23:19 INFO - PROCESS | 12846 | 07:23:21 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:22 INFO - PROCESS | 12846 | RSS: Main: 169492480 07:23:22 INFO - PROCESS | 12846 | 07:23:25 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57243/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:26 INFO - PROCESS | 12846 | RSS: Main: 170225664 07:23:26 INFO - PROCESS | 12846 | 07:23:29 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57243/tests/kraken/driver.html?testName=imaging-desaturate) 07:23:30 INFO - PROCESS | 12846 | RSS: Main: 167673856 07:23:30 INFO - PROCESS | 12846 | 07:23:33 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57243/tests/kraken/driver.html?testName=json-parse-financial) 07:23:34 INFO - PROCESS | 12846 | RSS: Main: 168448000 07:23:34 INFO - PROCESS | 12846 | 07:23:35 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:23:36 INFO - PROCESS | 12846 | RSS: Main: 169140224 07:23:36 INFO - PROCESS | 12846 | 07:23:38 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:23:38 INFO - PROCESS | 12846 | RSS: Main: 169304064 07:23:38 INFO - PROCESS | 12846 | 07:23:40 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:23:41 INFO - PROCESS | 12846 | RSS: Main: 169324544 07:23:41 INFO - PROCESS | 12846 | 07:23:44 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:23:45 INFO - PROCESS | 12846 | RSS: Main: 169803776 07:23:45 INFO - PROCESS | 12846 | 07:23:48 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:23:48 INFO - PROCESS | 12846 | RSS: Main: 169889792 07:23:48 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | Cycle 1(1): loaded http://localhost:57243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57243/tests/kraken/driver.html?testName=ai-astar) 07:23:50 INFO - PROCESS | 12846 | RSS: Main: 170455040 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | __start_tp_report 07:23:50 INFO - PROCESS | 12846 | _x_x_mozilla_page_load 07:23:50 INFO - PROCESS | 12846 | _x_x_mozilla_page_load_details 07:23:50 INFO - PROCESS | 12846 | |i|pagename|runs| 07:23:50 INFO - PROCESS | 12846 | |0;ai-astar;106;117;108;116;114;117;117;114;114;115 07:23:50 INFO - PROCESS | 12846 | |1;audio-beat-detection;158;124;144;185;124;146;149;133;179;124 07:23:50 INFO - PROCESS | 12846 | |2;audio-dft;165;163;163;166;174;165;162;163;164;164 07:23:50 INFO - PROCESS | 12846 | |3;audio-fft;76;76;77;149;78;76;88;77;171;81 07:23:50 INFO - PROCESS | 12846 | |4;audio-oscillator;87;85;152;87;86;87;137;87;86;140 07:23:50 INFO - PROCESS | 12846 | |5;imaging-gaussian-blur;118;117;118;118;118;117;119;118;118;118 07:23:50 INFO - PROCESS | 12846 | |6;imaging-darkroom;147;147;147;147;148;148;148;148;147;149 07:23:50 INFO - PROCESS | 12846 | |7;imaging-desaturate;95;95;96;96;96;95;95;96;96;96 07:23:50 INFO - PROCESS | 12846 | |8;json-parse-financial;70;62;63;64;63;64;67;72;64;64 07:23:50 INFO - PROCESS | 12846 | |9;json-stringify-tinderbox;65;66;65;66;66;66;65;65;65;65 07:23:50 INFO - PROCESS | 12846 | |10;stanford-crypto-aes;79;86;79;80;80;80;79;79;89;80 07:23:50 INFO - PROCESS | 12846 | |11;stanford-crypto-ccm;148;136;144;138;138;140;141;141;172;142 07:23:50 INFO - PROCESS | 12846 | |12;stanford-crypto-pbkdf2;174;174;170;170;172;177;169;168;170;169 07:23:50 INFO - PROCESS | 12846 | |13;stanford-crypto-sha256-iterative;68;67;68;68;70;70;71;71;67;69 07:23:50 INFO - PROCESS | 12846 | __end_tp_report 07:23:50 INFO - PROCESS | 12846 | __start_cc_report 07:23:50 INFO - PROCESS | 12846 | _x_x_mozilla_cycle_collect,1011 07:23:50 INFO - PROCESS | 12846 | __end_cc_report 07:23:50 INFO - PROCESS | 12846 | __startTimestamp1468419830809__endTimestamp 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | ------- Summary: start ------- 07:23:50 INFO - PROCESS | 12846 | Number of tests: 14 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.50 stddev:3.82 (3.3%) stddev-sans-first:2.83 07:23:50 INFO - PROCESS | 12846 | Values: 106.0 117.0 108.0 116.0 114.0 117.0 117.0 114.0 114.0 115.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:147.50 stddev:22.07 (15.0%) stddev-sans-first:23.02 07:23:50 INFO - PROCESS | 12846 | Values: 158.0 124.0 144.0 185.0 124.0 146.0 149.0 133.0 179.0 124.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.41 (2.1%) stddev-sans-first:3.62 07:23:50 INFO - PROCESS | 12846 | Values: 165.0 163.0 163.0 166.0 174.0 165.0 162.0 163.0 164.0 164.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#3] audio-fft Cycles:10 Average:94.90 Median:77.00 stddev:34.89 (45.3%) stddev-sans-first:36.33 07:23:50 INFO - PROCESS | 12846 | Values: 76.0 76.0 77.0 149.0 78.0 76.0 88.0 77.0 171.0 81.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:86.50 stddev:27.59 (31.9%) stddev-sans-first:28.62 07:23:50 INFO - PROCESS | 12846 | Values: 87.0 85.0 152.0 87.0 86.0 87.0 137.0 87.0 86.0 140.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:23:50 INFO - PROCESS | 12846 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 119.0 118.0 118.0 118.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:23:50 INFO - PROCESS | 12846 | Values: 147.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 147.0 149.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:23:50 INFO - PROCESS | 12846 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:64.00 stddev:3.30 (5.2%) stddev-sans-first:3.03 07:23:50 INFO - PROCESS | 12846 | Values: 70.0 62.0 63.0 64.0 63.0 64.0 67.0 72.0 64.0 64.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:23:50 INFO - PROCESS | 12846 | Values: 65.0 66.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.00 stddev:3.48 (4.3%) stddev-sans-first:3.61 07:23:50 INFO - PROCESS | 12846 | Values: 79.0 86.0 79.0 80.0 80.0 80.0 79.0 79.0 89.0 80.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:141.50 stddev:10.40 (7.4%) stddev-sans-first:10.93 07:23:50 INFO - PROCESS | 12846 | Values: 148.0 136.0 144.0 138.0 138.0 140.0 141.0 141.0 172.0 142.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.00 stddev:2.87 (1.7%) stddev-sans-first:2.87 07:23:50 INFO - PROCESS | 12846 | Values: 174.0 174.0 170.0 170.0 172.0 177.0 169.0 168.0 170.0 169.0 07:23:50 INFO - PROCESS | 12846 | 07:23:50 INFO - PROCESS | 12846 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.52 (2.2%) stddev-sans-first:1.58 07:23:50 INFO - PROCESS | 12846 | Values: 68.0 67.0 68.0 68.0 70.0 70.0 71.0 71.0 67.0 69.0 07:23:50 INFO - PROCESS | 12846 | -------- Summary: end -------- 07:23:50 INFO - PROCESS | 12846 | 07:23:51 INFO - TEST-INFO | 12846: exit 0 07:23:51 INFO - TEST-OK | kraken | took 63490ms 07:23:51 INFO - SUITE-END | took 1179s 07:23:51 INFO - Completed test suite (00:19:39) 07:23:51 INFO - javascript benchmark 07:23:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6355.44194370996, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.5938079597663, 2680.249530131564, 2687.1132526266324, 2694.6496955395796, 2696.743809338112, 4606.424196975382, 4672.205725026745, 4689.179393606122, 4783.402074740658, 4807.2789081637775, 4600.17196904557, 4703.929441058387, 4717.811287548502, 4751.40607424072, 4781.282807578857, 4266.338717498793, 4351.499577548575, 4413.117376524692, 4437.600615944564, 4463.955360446386, 575.9200501473302, 4254.404383386328, 4258.403823464718, 4315.180115778008, 4375.912481750363, 4376.2122817892605, 4377.190219809346, 4417.028253784162, 4429.557044295577, 4476.194285028693, 4397.2304846651705, 4429.867103986886, 4436.600705936449, 4437.7781110944325, 4467.530909254514, 4301.677374196916, 4359.062801497693, 4371.846985355497, 4388.626966707834, 4399.670024748157, 4752.857414277577, 4779.952200477986, 4788.7845046972625, 4798.424189097295, 4804.6876952997945, 4954.133026720309, 4997.925031124536, 5101.234814777813, 5118.59051275897, 5131.204663277161, 5050.671706339076, 5066.771995260222, 5068.923966140511, 5074.416442109168, 5124.0776660201145, 4733.479317275097, 4813.663043586916, 4814.807407703723, 4833.323334733105, 4854.0, 5158.097332966716, 5211.270422140903, 5289.259503669412, 5301.814436494781, 5362.51737343641, 5002.499750025041, 5020.7740651670765, 5026.54761071498, 5027.095122877917, 5084.0, 5046.318746969112, 5107.055194788902, 5130.076586214443, 5136.563392111638, 5167.689938603696, 4996.725180115129, 5066.594672426197, 5067.670601410897, 5070.366204224472, 5093.134167191586, 5021.322121513622, 5029.270755740397, 5045.293658887758, 5052.545270925634, 5058.038972595195, 4189.476315460567, 4357.9128417431475, 4360.585744354281, 4377.868663940087, 4417.646588272931, 3708.4622729704583, 3738.775673459601, 3767.2842159990064, 3813.694904407641, 3814.1418180909072, 4351.151525452507, 4360.694751367374, 4393.033532622818, 4419.337099435046, 4459.152760975404, 5128.0, 5137.691738495702, 5137.897242055138, 5140.794368225229, 5145.408278048072, 4318.265894797892, 4349.608535231844, 4381.342798580238, 4400.317950717644, 4405.163019026439, 4600.930986035212, 4608.5852273294895, 4611.769411529477, 4626.8149274028665, 4669.486356500782, 4645.512221216723, 4824.541668541553, 4828.686135401188, 4832.420109586802, 4840.903181936271, 5082.847514574569, 5132.563732082665, 5169.922451163311, 5183.844484665466, 5233.528982391603, 4864.0, 4893.363862697969, 4894.486078961801, 4898.24077268024, 4948.579370753526, 5009.9248511271635, 5081.212412076134, 5086.644198746415, 5089.643724939367, 5093.516115968977, 5109.5912327013, 5143.537081662519, 5169.508896654812, 5169.53474187325, 5219.399769026459, 5002.174641184164, 5009.448960614257, 5009.870804907972, 5014.87462813418, 5070.619703522177, 4883.096627123993, 4908.386451693538, 4951.925721114114, 5009.148444764472, 5031.84904452867, 4861.392325959255, 4881.145799485147, 4892.535209155125, 4901.436334821541, 4907.631927605516, 5007.69953802773, 5009.5491405773655, 5018.096742586369, 5023.146065169003, 5090.160123579568, 4707.223308154254, 4783.091212669582, 4801.4958429364415, 4831.323614693875, 4856.805727770849], "value": 4658.322260086493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4116815591395, 553.7231384307846, 557.7573755416394, 567.5317862763219, 593.9970300148499, 35900.0, 39456.40815387768, 39754.0, 39766.8011659942, 39818.80090599543, 38514.0, 38587.22825543487, 38617.22765544688, 38843.0, 38981.22037559247, 7639.961800191005, 7806.453548251625, 7826.726064587712, 7863.449558530905, 7874.212578742137, 7798.2981531662135, 7817.648205830751, 7872.921270787276, 7879.527228366288, 7900.9728735264625, 7899.091604465502, 7933.365330773524, 7947.165547617504, 7956.204379562056, 7977.24216199463, 7875.369970402354, 7896.565688887109, 7910.841783164333, 7917.7624671259955, 7953.840923181562, 7732.49738766984, 7784.221577842227, 7787.96106019472, 7794.337481314095, 7796.61016949156, 38308.616913831065, 38405.0, 38417.0, 38692.0, 38769.22461550782, 3038.863251153681, 3046.1775320663296, 3116.594842670461, 3134.420132275536, 3602.873899413508, 30022.549661755093, 30412.8479357604, 30493.69506304931, 30568.484624268272, 31447.0, 3023.0, 3272.5582046423665, 3284.965235950668, 3294.8352582370785, 3372.763906526544, 174976.0, 175325.0, 175972.0, 176816.0, 176823.11588442104, 55533.72233138808, 55730.44269557253, 55964.0, 56094.71952640211, 56155.157672634945, 33472.49791253133, 34174.316513670085, 34418.82790586031, 36260.27479450396, 59039.11441328384, 15390.923045384701, 15762.054276743433, 15820.60448488797, 15828.366865325488, 15858.127802970717, 11872.762544749057, 12007.879921200676, 12038.759224815454, 12063.758724825455, 12153.392330383445, 18618.348357807412, 18709.158087886077, 18867.245310187438, 18902.905485472485, 18959.90520047391, 6917.412019978358, 7117.537360071578, 7118.608476533736, 7162.7493037743425, 7164.21193668696, 817.264461984219, 937.9859302110474, 1008.6620981970975, 1014.4377658405972, 1025.3642741500319, 27741.58387624187, 27799.0, 27830.44339113247, 28035.0, 28121.0, 813.32494029955, 951.8767853932288, 973.522973742875, 1004.7237009822358, 1027.8282757656277, 14168.291585420688, 14427.20650364219, 14572.41710331596, 14821.555353339418, 14831.70336593262, 416069.0, 419359.0, 420933.0, 422677.0, 424440.0, 49301.0, 49397.0, 49608.0, 49640.75179624151, 49663.25505117426, 1160.460385920551, 1178.4284621958343, 1196.0, 1202.729385888168, 1215.5623975369037, 23587.0, 23893.761062389847, 24568.877155614107, 24705.135320264424, 24843.254702358958, 43029.35455968226, 43769.34345984749, 43836.561634383244, 43910.19391994246, 43928.78035609802, 284886.0, 353121.0, 355668.0, 356014.0, 356816.0, 25316.746832532175, 25643.615345770202, 25656.0, 25713.0, 25737.871310643328, 41855.58144418517, 42687.35968960406, 42889.142217156106, 43436.0, 43630.56369436392, 36420.635793641726, 36609.45085823662, 36660.0834979117, 36724.08189795277, 36988.44517332188, 36605.729877216916, 36788.63211367852, 37032.25935481329, 37226.627733722315, 37268.627313726516, 30594.541081884236, 35318.47022294616, 36010.63989360073, 36327.0, 36604.0, 31850.681493184773, 33101.372766630215, 33147.27776099394, 33286.833565832014, 33647.663523364456, 24362.51274974526, 24495.755042449346, 24643.260702178963, 24945.0, 25048.499030019662], "value": 17378.66074910726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.0588998054959, 370.2280744647411, 371.873562988584, 383.04074658123704, 383.9462475253465, 16327.83672163278, 16804.495865124052, 17834.821651783477, 17896.19467123979, 17906.552336191602, 12298.508059677602, 16323.265453054611, 17233.0, 17237.82762172378, 17845.0, 4445.310976798593, 4829.541193586604, 4830.830920917769, 4834.371531700874, 4852.150873597124, 4773.427188737339, 4794.280857871312, 4800.303955926406, 4801.255805350159, 5031.949680503203, 5017.774200160983, 5150.098732721759, 5157.3811142662935, 5168.198929165986, 5205.479452054802, 5049.419316778544, 5118.436971933084, 5152.0, 5161.509656582619, 5171.637985341028, 5219.791208351661, 5223.11207094791, 5259.0, 5264.499872512105, 5281.445448227958, 18985.43043708691, 20119.899400502905, 21187.046582903808, 21212.0, 21230.150793968223, 1731.37670438642, 1769.9911500442545, 1803.9909800450914, 1893.7632795900513, 2252.6958860553777, 8985.775355616097, 9146.0, 9188.816223675556, 9344.205742511895, 9400.905990940071, 1614.6851363984028, 1636.4272504623405, 1711.4523352527196, 1821.4535639308288, 1869.6447674941853, 67467.66266168687, 70646.64676676635, 72517.27482725157, 73028.26971730268, 73088.63455682687, 9988.60045598168, 10136.239782016379, 10321.793564128675, 10394.636187733393, 10504.789904201873, 13915.512957046658, 13938.163710177421, 13945.442182312796, 14009.299535023209, 14052.36764345607, 7048.682809273595, 7073.398761105261, 7208.963955180296, 7315.4147668186415, 7347.55914645123, 6702.296258892844, 6736.360045795642, 6755.2906944771075, 6847.657617119125, 6926.341997510229, 3960.6237407446247, 3991.0820511281986, 4310.4611923509565, 4337.349397590324, 4367.62875155609, 1842.834144926963, 1864.7762268527863, 1868.775951751605, 1883.7174423836261, 1884.6136542008855, 826.4669288309007, 841.2722994609619, 905.7056456651615, 945.5697657565792, 972.0959507657946, 14473.565793026226, 16387.684430905978, 16803.831961680473, 17059.658806823794, 17075.40236091731, 830.4602008694397, 853.9146085391411, 854.974350769478, 856.8629019356873, 877.2850127146355, 9579.185769209556, 9621.51892405391, 9744.658936937314, 9805.970373110864, 9986.800263994824, 367516.0, 369656.0, 371740.0, 373663.0, 374871.0, 75988.0, 80478.0, 81069.59465202637, 81223.59388203021, 81612.59193703994, 898.7842917699836, 912.726182145367, 921.2583869984727, 923.0769230769231, 932.911373419524, 15130.773038404654, 15587.376504939675, 15631.84368156304, 15889.602759931095, 16119.355225790838, 36504.634953651184, 37233.25533489369, 37701.24597507979, 38253.0, 39766.40350394689, 48813.75593122012, 48944.75527622339, 53068.73465632647, 53436.465635344706, 53504.0, 6287.2769631492965, 6813.2846051163915, 6983.594444277887, 6986.9650651746415, 7005.964970175117, 9579.90420095818, 10589.311694739818, 10768.838467422838, 11040.33757974524, 11234.213605047567, 9573.138417542455, 9792.46141462198, 9823.21414286841, 10055.849162262719, 10069.446180460145, 9788.265880059167, 9872.111509964137, 9929.304948653526, 9960.452175130438, 9995.900040999788, 9802.705918822447, 9850.802983940137, 9860.753481163028, 10041.899581004096, 10346.689599312032, 7002.649867506706, 7031.1211098612675, 7094.574325540484, 7107.538010029539, 7121.537100088478, 8654.913450865412, 9716.076972687584, 9803.313768036169, 10127.696169114939, 10214.642487513198], "value": 8051.416465833136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.0989397527756, 1321.9801702974455, 1412.5197432872822, 1609.7504886742558, 1662.2270644150476, 6205.0692396140485, 7020.017197592341, 7160.498765086446, 7673.462857599963, 7676.692932282709, 7087.71649134034, 7265.963670181642, 7370.668319925603, 7418.517796343234, 7422.665980030898, 2164.9567008659856, 2219.7891200335944, 2227.40973641985, 2227.721534808149, 2229.052652622637, 2166.198506552578, 2180.672899065145, 2226.209695558078, 2230.587341341849, 2233.0174723121854, 2219.156720446228, 2222.1111555377815, 2226.7216597925258, 2231.6206244938317, 2251.133313674231, 2158.902849371782, 2176.836737244713, 2177.2923799765063, 2182.519845633958, 2182.90176942038, 2150.4623844038993, 2179.7384313882276, 2183.54145629418, 2187.3547303545333, 2191.9780802191935, 7278.272172782732, 7287.5627462351895, 7407.296306850841, 7467.066616672916, 7550.811229719246, 4464.910701785979, 4606.976965115186, 4610.2854057621125, 4612.53874612536, 4621.676482646216, 2819.0978886756247, 2868.225579093633, 2880.395117025427, 2912.7184039022763, 2941.0, 847.9067302596709, 901.7745563609097, 918.6279556779448, 920.5673333533229, 922.5802259971697, 9871.111599956039, 10038.247131465096, 10094.141997930112, 10150.238732095122, 10157.0, 4032.2338755636333, 4107.219628270679, 4255.170241802881, 4270.935935960901, 4276.679249056333, 8581.313494920516, 8593.183647553598, 8622.482651040958, 8685.044645089036, 8690.956545217234, 4511.932321015187, 4513.255312873404, 4583.862484125481, 4594.839180628662, 4606.95393046072, 3521.3133438979153, 4031.274370613259, 4144.8756537303925, 4164.8542301019315, 4212.0, 3568.286342731464, 3581.83881725323, 3676.1361080146144, 3686.5391826021746, 3705.4627079073384, 1178.711215752129, 1212.3635091576994, 1213.6237766292477, 1219.2014230678742, 1226.2531928480141, 820.6061090676509, 821.6302663801314, 842.7303262955918, 862.4307956748515, 872.9170728780756, 5061.544460998454, 5083.61872859537, 5123.494081171028, 5238.0, 5277.182036784305, 416.0410254363721, 419.55108034402895, 422.14726252969444, 423.883432056187, 428.3510481620348, 3496.7727097738566, 3504.491848681978, 3526.947095793565, 3584.874529391459, 3607.4408466687705, 8632.093630168867, 8908.242799362128, 8972.37193396469, 8994.145556172152, 9038.231750301298, 8883.73348799537, 8893.822123557493, 8919.643214271486, 8926.642934282556, 8927.196552310323, 6828.112345395067, 6893.414059804973, 6954.165500140016, 6960.965195174093, 6966.407855332353, 4880.585150262267, 4890.070886531547, 4924.212126059813, 4938.407391113089, 4988.12707776145, 8384.496930184208, 8404.033536143423, 8423.410361274651, 8446.197611226924, 8475.067742548192, 8317.542535160625, 8455.32357411418, 8590.699325523577, 8616.870746938926, 8631.611577479154, 5758.424157584375, 6112.663803490851, 6123.234595675541, 6662.800115996528, 7029.402500787286, 7032.8593428130125, 7248.855022899618, 7252.818679533054, 7289.854202916018, 7329.486935914648, 6432.0, 6501.869962600627, 6515.12045873801, 6556.573822701509, 6579.046038324512, 6220.346863579259, 6462.3537646235, 6463.25672547663, 6528.347165283433, 6550.672466376757, 6055.485283750931, 6193.84515387119, 6209.19280493551, 6213.96893015532, 6214.4407003369915, 4142.606452387018, 4445.466544014739, 4502.302143167814, 4546.068056048436, 4560.8859778504475, 4410.184115938561, 4577.061702350943, 4607.838725644587, 4676.625869930465, 4695.248760198352], "value": 3954.791406251812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.6253020951924, 287.439492988672, 289.7768718087074, 293.94562006028883, 300.1565600662139, 4999.625103096646, 5029.371328583927, 5087.771050302731, 5102.897942041157, 5115.283860259562, 4966.925496117552, 4975.950240497594, 4984.526469985355, 4996.225585034325, 5003.224500202466, 3754.8310326035394, 3780.9810950945343, 3898.66861316787, 3907.921841563167, 3930.7445016074007, 3878.2437424702193, 3895.6493915547735, 3898.6354775828377, 3927.5483319418345, 3930.6069393060607, 3909.4722212501374, 3926.7447615905016, 3928.410738389236, 3929.0, 3939.4681717968137, 3847.5952529668957, 3917.6474117329576, 3934.488516492838, 3944.9408258876138, 3950.8814735557835, 3423.7774544654767, 3452.2405070884365, 3452.361313157074, 3455.6198818129988, 3463.1515278756615, 4906.215005599122, 4911.214205727067, 4928.901421971541, 4929.584503593213, 4936.6297527685565, 4325.740455572675, 4501.7524036178, 4507.729536227836, 4515.390422293014, 4522.7060241084555, 5185.870353241162, 5191.974040129813, 5221.024016310705, 5243.614155559211, 5271.970291437786, 3722.9255414891823, 3727.9934417707336, 3776.697864170887, 3780.546334439885, 3786.958586388738, 5308.177232528926, 5455.236266922634, 5497.532709719679, 5501.367342755594, 5501.834944951658, 3784.7539909905768, 3857.1514266861245, 3874.6319099685484, 3878.7284890057426, 3885.2812229737588, 3899.7520793345857, 3930.4890364252465, 3943.9014024649614, 3949.2496425679606, 3972.5431575369203, 4458.754768487699, 4467.374567560544, 4474.239379305526, 4475.507694153641, 4475.955240447619, 5033.144365457881, 5178.896422071537, 5252.133397989365, 5263.921041184385, 5263.973680131575, 1354.3566805767182, 1373.4574842936984, 1377.0429551461839, 1377.1668140774887, 1379.8137251470923, 858.6822875535967, 879.6041781198486, 892.3797960417577, 907.7322189953848, 913.981720365589, 4370.322599996942, 4548.044910568751, 4557.521460246693, 4567.2464043432465, 4623.4451865775645, 5388.625900395374, 5391.272178255964, 5403.298350824588, 5420.24116623673, 5484.561235101182, 4509.751963642031, 4598.494165641777, 4609.723416595015, 4624.121416930772, 4640.164770341304, 2857.6285082939085, 2896.000879696501, 2916.9708302917124, 2919.985400072986, 2921.8246905185756, 5115.5396014358885, 5141.948580514222, 5156.252343410185, 5160.0, 5160.18769770476, 5372.462753724596, 5505.917411238835, 5513.751881165357, 5571.972140139354, 5581.944180558143, 5075.568576671024, 5115.2071428928575, 5123.692578445305, 5128.897422051538, 5147.2279158126585, 5403.243545903655, 5417.945820541744, 5420.376656684374, 5426.565874729933, 5454.59090568201, 4983.327250821093, 5251.190613022015, 5256.763445644879, 5264.605154613496, 5271.207789351639, 5121.41103773056, 5131.306668799362, 5155.690658560498, 5157.896842063213, 5172.275881376686, 3939.2318497892634, 3942.8817135485983, 3951.723379363532, 3957.6635985941516, 3962.582824477009, 5153.742312884416, 5440.700761458, 5446.754896029609, 5448.809291674773, 5478.91781623268, 5317.494837990384, 5324.227986941949, 5326.8934621308135, 5339.973300133474, 5341.973290133525, 5157.8452646420665, 5291.391489978701, 5322.228276899906, 5322.574194064543, 5359.196120581788, 5202.167653175474, 5209.6874187548865, 5218.225803226921, 5221.451747566451, 5234.764435600331, 5093.490650935025, 5168.191133103383, 5302.1781623848365, 5336.919946200887, 5358.571314294769, 5225.947740522546, 5234.921476177937, 5240.737963101906, 5249.343832020997, 5254.97372513135], "value": 3968.9478227196428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.6484952356205, 565.3526711914858, 624.434886427783, 654.7282877605791, 664.3854434647949, 11982.580609678664, 12353.567625133122, 12486.625401237978, 12828.935855320722, 12834.550790722327, 12636.11547191697, 12756.744865102692, 12764.489420423171, 12772.233665980048, 12835.358232088405, 607.9817605471843, 736.1718067174429, 756.9432292578065, 768.8077980504873, 771.4137255685691, 774.6049514747491, 776.7281451491989, 777.1878387085509, 779.0806847919453, 780.6682160081971, 829.6473998550622, 831.7795784117213, 832.176145615839, 833.012879737513, 833.891594092767, 814.7555733279992, 815.975520734379, 817.0440584516131, 825.7316372179035, 826.995865020674, 598.413554716376, 605.255535691098, 606.0243008755899, 607.104520831774, 608.0241212853396, 13028.674283142997, 13348.532801352003, 13382.799258011137, 13440.0, 13447.260400677958, 13397.330133493384, 13510.527131550349, 13525.932370338085, 13558.389872455764, 13828.861711382959, 10637.787244255072, 10731.409772462512, 10777.407242601654, 10897.12822974168, 10912.072473839653, 2846.288427893027, 2852.429514097189, 2890.523063694488, 2903.3177203357195, 2915.4314908592833, 67572.59347653152, 68591.65704171447, 68879.0, 68885.65557172181, 69441.3055869445, 10789.352638841694, 10852.186086043579, 10913.83629245562, 10926.672199834018, 10977.0, 20317.18731250763, 20445.79554204439, 20574.69137962932, 20748.066337014872, 20974.47563810917, 6983.8603227935155, 6999.720011199597, 7020.297970203041, 7025.192102908129, 7122.145342558822, 3834.1564855731694, 3942.56631770505, 3964.524257089168, 3968.8214030368126, 3971.2851686696094, 2753.366725653111, 2856.243095579673, 2858.5283428234106, 2861.3848022675224, 2875.7124287571496, 477.99522004780204, 480.18129089901635, 481.07393267959037, 490.2399490866399, 496.1268168024303, 470.7246260937321, 501.41334638473074, 527.941926388097, 544.1565573361274, 594.2037669522774, 8531.360147988926, 8543.231109200202, 8617.267532259828, 8879.0, 8965.641374345083, 479.69299648224467, 527.749319073437, 586.9031609784338, 590.8020813027598, 682.1439093937078, 3874.7868867212574, 3886.25450629011, 4099.385092236129, 4164.8125834337525, 4298.161858437637, 53944.73027634837, 74899.0, 87526.56236718904, 91388.54305728429, 93012.0, 47356.0, 56530.717346413, 73941.0, 75444.24555754372, 76268.0, 45625.31562026572, 56758.71620641871, 71877.64061179766, 72798.0, 73318.63340683369, 8522.872156917527, 9003.594838232164, 9137.223336016246, 9196.632134714537, 9231.215346695606, 37968.24063518769, 38325.233495330496, 40515.79742101271, 41403.7929810349, 41903.371449428894, 40142.397864032646, 40393.0, 41491.37762933498, 62035.0, 62825.685871572176, 10623.628173013907, 10765.192610554082, 11476.0, 11656.475458604213, 11899.524019039141, 12624.55814046504, 13327.866721332663, 13389.866101338863, 13463.798043029557, 13683.179009259477, 12101.636950891487, 12247.571335003233, 12287.324197168884, 12318.384080796104, 12766.29785361814, 11596.768064638829, 11872.168948173545, 11980.58067967617, 12088.818667719815, 12263.38683065861, 8023.398245131521, 11453.255538389978, 11473.770524589629, 11512.021478174449, 11682.532698691957, 10491.68524944253, 10734.463276835972, 10768.569257229623, 11033.724156896142, 11195.944020279847, 10023.448710321003, 10363.430011349448, 10392.168626510012, 10427.582896684351, 10543.57825686964], "value": 6440.337494249471, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 108.0, 116.0, 114.0, 117.0, 117.0, 114.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 144.0, 185.0, 124.0, 146.0, 149.0, 133.0, 179.0, 124.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 166.0, 174.0, 165.0, 162.0, 163.0, 164.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 149.0, 78.0, 76.0, 88.0, 77.0, 171.0, 81.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 152.0, 87.0, 86.0, 87.0, 137.0, 87.0, 86.0, 140.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 62.0, 63.0, 64.0, 63.0, 64.0, 67.0, 72.0, 64.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 79.0, 80.0, 80.0, 80.0, 79.0, 79.0, 89.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 136.0, 144.0, 138.0, 138.0, 140.0, 141.0, 141.0, 172.0, 142.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 170.0, 170.0, 172.0, 177.0, 169.0, 168.0, 170.0, 169.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 70.0, 70.0, 71.0, 71.0, 67.0, 69.0], "value": 68.9, "unit": "score"}]}]} 07:23:52 INFO - Return code: 0 07:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:23:52 ERROR - # TBPL SUCCESS # 07:23:52 INFO - Running post-action listener: _resource_record_post_action 07:23:52 INFO - ##### 07:23:52 INFO - ##### Finished run-tests step (success) 07:23:52 INFO - ##### 07:23:52 INFO - Running post-run listener: _resource_record_post_run 07:23:52 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 547098624; Read time: 24; Write time: 482952 07:23:52 INFO - TinderboxPrint: CPU usage
13.3% 07:23:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 07:23:52 INFO - TinderboxPrint: I/O write bytes / time
547,098,624 / 482,952 07:23:52 INFO - TinderboxPrint: CPU idle
8,274.3 (86.7%) 07:23:52 INFO - TinderboxPrint: CPU user
1,218.6 (12.8%) 07:23:52 INFO - TinderboxPrint: Swap in / out
0 / 0 07:23:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258842624; Read time: 0; Write time: 294252 07:23:52 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288256000; Read time: 16; Write time: 188700 07:23:52 INFO - Running post-run listener: _upload_blobber_files 07:23:52 INFO - Blob upload gear active. 07:23:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:23:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:23:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:53 INFO - (blobuploader) - INFO - Done attempting. 07:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:54 INFO - (blobuploader) - INFO - Done attempting. 07:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:58 INFO - (blobuploader) - INFO - Done attempting. 07:23:58 INFO - (blobuploader) - INFO - Iteration through files over. 07:23:58 INFO - Return code: 0 07:23:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:23:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:23:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/15119ac82b8ad9f2d8364720bfca911e68689820c25e646de4bed8170150d5455c0d44fd7dae13db8c1e05797a5f9035140270a62eb9afc050fd13eb323bfdc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaeb0bb2a826ac1abb369481c422367b0d0c85cb05b530b8762c022f28027ed4ca59918d21bfc02a4e43da0d555d851143dd2c8ef2824260e482f6f0e93ed113", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc64a093dcd6eb4c0ca6bc4d0a06a668a2bd0de9efbf546e9be21cda653c2e16ad129a8cf2cfc9bd66f3e0998b8732b81628be4e937a373960ae7e6af3b9ca3"} 07:23:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:23:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:23:58 INFO - Contents: 07:23:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/15119ac82b8ad9f2d8364720bfca911e68689820c25e646de4bed8170150d5455c0d44fd7dae13db8c1e05797a5f9035140270a62eb9afc050fd13eb323bfdc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaeb0bb2a826ac1abb369481c422367b0d0c85cb05b530b8762c022f28027ed4ca59918d21bfc02a4e43da0d555d851143dd2c8ef2824260e482f6f0e93ed113", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc64a093dcd6eb4c0ca6bc4d0a06a668a2bd0de9efbf546e9be21cda653c2e16ad129a8cf2cfc9bd66f3e0998b8732b81628be4e937a373960ae7e6af3b9ca3"} 07:23:58 INFO - Running post-run listener: copy_logs_to_upload_dir 07:23:58 INFO - Copying logs to upload dir... 07:23:58 INFO - mkdir: /builds/slave/test/build/upload/logs 07:23:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.357961 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 07:23:58.117191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 07:23:58.126729) ========= 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=41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830 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-Non-PGO/sha512/15119ac82b8ad9f2d8364720bfca911e68689820c25e646de4bed8170150d5455c0d44fd7dae13db8c1e05797a5f9035140270a62eb9afc050fd13eb323bfdc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaeb0bb2a826ac1abb369481c422367b0d0c85cb05b530b8762c022f28027ed4ca59918d21bfc02a4e43da0d555d851143dd2c8ef2824260e482f6f0e93ed113", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc64a093dcd6eb4c0ca6bc4d0a06a668a2bd0de9efbf546e9be21cda653c2e16ad129a8cf2cfc9bd66f3e0998b8732b81628be4e937a373960ae7e6af3b9ca3"} build_url:https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/baObuCPCQZGzGUgsrja3Sg/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-Non-PGO/sha512/15119ac82b8ad9f2d8364720bfca911e68689820c25e646de4bed8170150d5455c0d44fd7dae13db8c1e05797a5f9035140270a62eb9afc050fd13eb323bfdc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaeb0bb2a826ac1abb369481c422367b0d0c85cb05b530b8762c022f28027ed4ca59918d21bfc02a4e43da0d555d851143dd2c8ef2824260e482f6f0e93ed113", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afc64a093dcd6eb4c0ca6bc4d0a06a668a2bd0de9efbf546e9be21cda653c2e16ad129a8cf2cfc9bd66f3e0998b8732b81628be4e937a373960ae7e6af3b9ca3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 07:23:58.154902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:23:58.155263) ========= 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=41bf3e9aed84707956354da8000001c5-1468415057.67397-1091973830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 07:23:58.235201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 07:23:58.238089) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 07:23:58.238435) ========= ========= Total master_lag: 0.18 =========