builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1468700174.28 results: success (0) buildid: 20160716103004 builduid: 0a20baba015240249ef8f4f2f7f3fe6f revision: dc97f8b36a22d36be518e56261df85205bb535d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.281515) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.281967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.282312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.331564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.331921) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 13:16:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.9M=0s 2016-07-16 13:16:14 (34.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.510499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.510822) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.115370 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.638652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:14.639060) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dc97f8b36a22d36be518e56261df85205bb535d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dc97f8b36a22d36be518e56261df85205bb535d2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 13:16:14,843 truncating revision to first 12 chars 2016-07-16 13:16:14,844 Setting DEBUG logging. 2016-07-16 13:16:14,844 attempt 1/10 2016-07-16 13:16:14,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dc97f8b36a22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 13:16:15,169 unpacking tar archive at: mozilla-inbound-dc97f8b36a22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697218 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:15.349728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:15.350055) ========= script_repo_revision: dc97f8b36a22d36be518e56261df85205bb535d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:15.350434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:15.350699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 13:16:15.359391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-16 13:16:15.359765) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:16:15 INFO - MultiFileLogger online at 20160716 13:16:15 in /builds/slave/test 13:16:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:16:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:15 INFO - {'append_to_log': False, 13:16:15 INFO - 'base_work_dir': '/builds/slave/test', 13:16:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:16:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:15 INFO - 'branch': 'Mozilla-Inbound', 13:16:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:15 INFO - 'config_files': ('talos/linux_config.py',), 13:16:15 INFO - 'default_actions': ('clobber', 13:16:15 INFO - 'read-buildbot-config', 13:16:15 INFO - 'download-and-extract', 13:16:15 INFO - 'populate-webroot', 13:16:15 INFO - 'create-virtualenv', 13:16:15 INFO - 'install', 13:16:15 INFO - 'run-tests'), 13:16:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:15 INFO - 'download_minidump_stackwalk': True, 13:16:15 INFO - 'download_symbols': 'ondemand', 13:16:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:16:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:16:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:16:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:16:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:15 INFO - 'installer_path': 'installer.exe', 13:16:15 INFO - 'log_level': 'info', 13:16:15 INFO - 'log_name': 'talos', 13:16:15 INFO - 'log_to_console': True, 13:16:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:16:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:16:15 INFO - 'opt_config_files': (), 13:16:15 INFO - 'pip_index': False, 13:16:15 INFO - 'sps_profile': False, 13:16:15 INFO - 'sps_profile_interval': 0, 13:16:15 INFO - 'suite': 'dromaeojs-e10s', 13:16:15 INFO - 'system_bits': '32', 13:16:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:15 INFO - 'title': 'talos-linux64-ix-004', 13:16:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:15 INFO - 'use_talos_json': True, 13:16:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:15 INFO - 'work_dir': 'build'} 13:16:15 INFO - ##### 13:16:15 INFO - ##### Running clobber step. 13:16:15 INFO - ##### 13:16:15 INFO - Running pre-action listener: _resource_record_pre_action 13:16:15 INFO - Running main action method: clobber 13:16:15 INFO - rmtree: /builds/slave/test/build 13:16:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:20 INFO - Running post-action listener: _resource_record_post_action 13:16:20 INFO - ##### 13:16:20 INFO - ##### Finished clobber step (success) 13:16:20 INFO - ##### 13:16:20 INFO - ##### 13:16:20 INFO - ##### Running read-buildbot-config step. 13:16:20 INFO - ##### 13:16:20 INFO - Running pre-action listener: _resource_record_pre_action 13:16:20 INFO - Running main action method: read_buildbot_config 13:16:20 INFO - Using buildbot properties: 13:16:20 INFO - { 13:16:20 INFO - "project": "", 13:16:20 INFO - "product": "firefox", 13:16:20 INFO - "script_repo_revision": "production", 13:16:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:16:20 INFO - "repository": "", 13:16:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:16:20 INFO - "buildid": "20160716103004", 13:16:20 INFO - "pgo_build": "True", 13:16:20 INFO - "basedir": "/builds/slave/test", 13:16:20 INFO - "buildnumber": 1044, 13:16:20 INFO - "slavename": "talos-linux64-ix-004", 13:16:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:16:20 INFO - "platform": "ubuntu64_hw", 13:16:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:16:20 INFO - "branch": "mozilla-inbound", 13:16:20 INFO - "repo_path": "integration/mozilla-inbound", 13:16:20 INFO - "revision": "dc97f8b36a22d36be518e56261df85205bb535d2", 13:16:20 INFO - "stage_platform": "linux64-pgo", 13:16:20 INFO - "builduid": "0a20baba015240249ef8f4f2f7f3fe6f", 13:16:20 INFO - "slavebuilddir": "test" 13:16:20 INFO - } 13:16:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:16:20 INFO - Running post-action listener: _resource_record_post_action 13:16:20 INFO - ##### 13:16:20 INFO - ##### Finished read-buildbot-config step (success) 13:16:20 INFO - ##### 13:16:20 INFO - ##### 13:16:20 INFO - ##### Running download-and-extract step. 13:16:20 INFO - ##### 13:16:20 INFO - Running pre-action listener: _resource_record_pre_action 13:16:20 INFO - Running main action method: download_and_extract 13:16:20 INFO - mkdir: /builds/slave/test/build/tests 13:16: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')]} 13:16:20 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:20 INFO - Downloaded 1361 bytes. 13:16:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:16:20 INFO - Using the following test package requirements: 13:16:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:16:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:16:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'jsshell-linux-x86_64.zip'], 13:16:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:16:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:16:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:16:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:16:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:16:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:16:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:16:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:16: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')]} 13:16:20 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:23 INFO - Downloaded 24334583 bytes. 13:16:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:16:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:16:24 INFO - Return code: 0 13:16:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:24 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:26 INFO - Downloaded 24334583 bytes. 13:16:26 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'] 13:16:26 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 13:16:27 INFO - Return code: 0 13:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:27 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:28 INFO - Downloaded 14403317 bytes. 13:16:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:16:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:16:28 INFO - Return code: 0 13:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:28 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/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 13:16:30 INFO - Downloaded 60806289 bytes. 13:16:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:30 INFO - mkdir: /builds/slave/test/properties 13:16:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:16:30 INFO - Writing to file /builds/slave/test/properties/build_url 13:16:30 INFO - Contents: 13:16:30 INFO - build_url:https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:16:30 INFO - Running post-action listener: _resource_record_post_action 13:16:30 INFO - Running post-action listener: set_extra_try_arguments 13:16:30 INFO - ##### 13:16:30 INFO - ##### Finished download-and-extract step (success) 13:16:30 INFO - ##### 13:16:30 INFO - ##### 13:16:30 INFO - ##### Running populate-webroot step. 13:16:30 INFO - ##### 13:16:30 INFO - Running pre-action listener: _resource_record_pre_action 13:16:30 INFO - Running main action method: populate_webroot 13:16:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:16:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:16:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:16:30 INFO - '--tppagecycles', 13:16:30 INFO - '7'], 13:16:30 INFO - 'tests': ['tsvgm']}}, 13:16:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:16:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:16:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:16:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:16:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['damp', 'tps']}, 13:16:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'tests': ['damp', 'tps']}, 13:16:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['dromaeo_dom']}, 13:16:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:16:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['basic_compositor_video']}, 13:16:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:16:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['a11yr', 13:16:30 INFO - 'ts_paint', 13:16:30 INFO - 'tpaint', 13:16:30 INFO - 'sessionrestore', 13:16:30 INFO - 'sessionrestore_no_auto_restore', 13:16:30 INFO - 'tabpaint']}, 13:16:30 INFO - 'other-e10s': {'tests': ['a11yr', 13:16:30 INFO - 'ts_paint', 13:16:30 INFO - 'tpaint', 13:16:30 INFO - 'sessionrestore', 13:16:30 INFO - 'sessionrestore_no_auto_restore', 13:16:30 INFO - 'tabpaint']}, 13:16:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:16:30 INFO - 'ts_paint', 13:16:30 INFO - 'tpaint', 13:16:30 INFO - 'sessionrestore', 13:16:30 INFO - 'sessionrestore_no_auto_restore', 13:16:30 INFO - 'tabpaint']}, 13:16:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:16:30 INFO - 'ts_paint', 13:16:30 INFO - 'tpaint', 13:16:30 INFO - 'sessionrestore', 13:16:30 INFO - 'sessionrestore_no_auto_restore', 13:16:30 INFO - 'tabpaint']}, 13:16:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['a11yr', 13:16:30 INFO - 'ts_paint', 13:16:30 INFO - 'tpaint', 13:16:30 INFO - 'sessionrestore', 13:16:30 INFO - 'sessionrestore_no_auto_restore', 13:16:30 INFO - 'tabpaint']}, 13:16:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['a11yr', 13:16:30 INFO - 'ts_paint', 13:16:30 INFO - 'tpaint', 13:16:30 INFO - 'sessionrestore', 13:16:30 INFO - 'sessionrestore_no_auto_restore', 13:16:30 INFO - 'tabpaint']}, 13:16:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['tsvgx', 13:16:30 INFO - 'tsvgr_opacity', 13:16:30 INFO - 'tart', 13:16:30 INFO - 'tscrollx', 13:16:30 INFO - 'cart']}, 13:16:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:16:30 INFO - 'tsvgr_opacity', 13:16:30 INFO - 'tart', 13:16:30 INFO - 'tscrollx', 13:16:30 INFO - 'cart']}, 13:16:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'talos_options': ['--disable-e10s'], 13:16:30 INFO - 'tests': ['tp5o']}, 13:16:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'tests': ['tp5o']}, 13:16:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'talos_options': ['--disable-e10s', 13:16:30 INFO - '--xperf_path', 13:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:30 INFO - 'tests': ['tp5n']}, 13:16:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:16:30 INFO - 'talos_options': ['--xperf_path', 13:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:30 INFO - 'tests': ['tp5n']}}, 13:16:30 INFO - 'talos.zip': {'path': '', 13:16:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:16:30 INFO - Running post-action listener: _resource_record_post_action 13:16:30 INFO - ##### 13:16:30 INFO - ##### Finished populate-webroot step (success) 13:16:30 INFO - ##### 13:16:30 INFO - ##### 13:16:30 INFO - ##### Running create-virtualenv step. 13:16:30 INFO - ##### 13:16:30 INFO - Running pre-action listener: _resource_record_pre_action 13:16:30 INFO - Running main action method: create_virtualenv 13:16:30 INFO - Creating virtualenv /builds/slave/test/build/venv 13:16:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:16:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:16:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:16:31 INFO - Using real prefix '/usr' 13:16:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:16:32 INFO - Installing distribute.............................................................................................................................................................................................done. 13:16:34 INFO - Installing pip.................done. 13:16:34 INFO - Return code: 0 13:16:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:16:34 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')]} 13:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:34 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')]} 13:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:34 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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16:34 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 13:16:34 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 13:16:34 INFO - Using env: {'DISPLAY': ':0', 13:16:34 INFO - 'HOME': '/home/cltbld', 13:16:34 INFO - 'LANG': 'en_US.UTF-8', 13:16:34 INFO - 'LANGUAGE': 'en_US:en', 13:16:34 INFO - 'LOGNAME': 'cltbld', 13:16:34 INFO - 'MAIL': '/var/mail/cltbld', 13:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:34 INFO - 'MOZ_NO_REMOTE': '1', 13:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:34 INFO - 'NO_EM_RESTART': '1', 13:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:34 INFO - 'PWD': '/builds/slave/test', 13:16:34 INFO - 'SHELL': '/bin/bash', 13:16:34 INFO - 'SHLVL': '1', 13:16:34 INFO - 'TERM': 'linux', 13:16:34 INFO - 'TMOUT': '86400', 13:16:34 INFO - 'USER': 'cltbld', 13:16:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:34 INFO - '_': '/tools/buildbot/bin/python'} 13:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:34 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 13:16:34 INFO - Cleaning up... 13:16:34 INFO - Return code: 0 13:16:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:16:34 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')]} 13:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:34 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')]} 13:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:34 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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16:34 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 13:16:34 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 13:16:34 INFO - Using env: {'DISPLAY': ':0', 13:16:34 INFO - 'HOME': '/home/cltbld', 13:16:34 INFO - 'LANG': 'en_US.UTF-8', 13:16:34 INFO - 'LANGUAGE': 'en_US:en', 13:16:34 INFO - 'LOGNAME': 'cltbld', 13:16:34 INFO - 'MAIL': '/var/mail/cltbld', 13:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:34 INFO - 'MOZ_NO_REMOTE': '1', 13:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:34 INFO - 'NO_EM_RESTART': '1', 13:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:34 INFO - 'PWD': '/builds/slave/test', 13:16:34 INFO - 'SHELL': '/bin/bash', 13:16:34 INFO - 'SHLVL': '1', 13:16:34 INFO - 'TERM': 'linux', 13:16:34 INFO - 'TMOUT': '86400', 13:16:34 INFO - 'USER': 'cltbld', 13:16:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:34 INFO - '_': '/tools/buildbot/bin/python'} 13:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:34 INFO - Downloading/unpacking psutil>=3.1.1 13:16:34 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 13:16:34 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 13:16:34 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 13:16:34 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 13:16:34 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 13:16:34 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 13:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:16:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:36 INFO - Installing collected packages: psutil 13:16:36 INFO - Running setup.py install for psutil 13:16:37 INFO - building 'psutil._psutil_linux' extension 13:16: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 13:16: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:16:38 INFO - building 'psutil._psutil_posix' extension 13:16: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 13:16:39 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 13:16:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:39 INFO - Successfully installed psutil 13:16:39 INFO - Cleaning up... 13:16:39 INFO - Return code: 0 13:16:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:39 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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16:39 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 13:16:39 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 13:16:39 INFO - Using env: {'DISPLAY': ':0', 13:16:39 INFO - 'HOME': '/home/cltbld', 13:16:39 INFO - 'LANG': 'en_US.UTF-8', 13:16:39 INFO - 'LANGUAGE': 'en_US:en', 13:16:39 INFO - 'LOGNAME': 'cltbld', 13:16:39 INFO - 'MAIL': '/var/mail/cltbld', 13:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:39 INFO - 'MOZ_NO_REMOTE': '1', 13:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:39 INFO - 'NO_EM_RESTART': '1', 13:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:39 INFO - 'PWD': '/builds/slave/test', 13:16:39 INFO - 'SHELL': '/bin/bash', 13:16:39 INFO - 'SHLVL': '1', 13:16:39 INFO - 'TERM': 'linux', 13:16:39 INFO - 'TMOUT': '86400', 13:16:39 INFO - 'USER': 'cltbld', 13:16:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:39 INFO - '_': '/tools/buildbot/bin/python'} 13:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:16:39 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 13:16:39 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 13:16:39 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 13:16:39 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 13:16:39 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 13:16:39 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 13:16:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:16:41 INFO - Installing collected packages: mozsystemmonitor 13:16:41 INFO - Running setup.py install for mozsystemmonitor 13:16:41 INFO - Successfully installed mozsystemmonitor 13:16:41 INFO - Cleaning up... 13:16:41 INFO - Return code: 0 13:16:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:16:41 INFO - Using env: {'DISPLAY': ':0', 13:16:41 INFO - 'HOME': '/home/cltbld', 13:16:41 INFO - 'LANG': 'en_US.UTF-8', 13:16:41 INFO - 'LANGUAGE': 'en_US:en', 13:16:41 INFO - 'LOGNAME': 'cltbld', 13:16:41 INFO - 'MAIL': '/var/mail/cltbld', 13:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:41 INFO - 'MOZ_NO_REMOTE': '1', 13:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:41 INFO - 'NO_EM_RESTART': '1', 13:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:41 INFO - 'PWD': '/builds/slave/test', 13:16:41 INFO - 'SHELL': '/bin/bash', 13:16:41 INFO - 'SHLVL': '1', 13:16:41 INFO - 'TERM': 'linux', 13:16:41 INFO - 'TMOUT': '86400', 13:16:41 INFO - 'USER': 'cltbld', 13:16:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:41 INFO - '_': '/tools/buildbot/bin/python'} 13:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:41 INFO - Downloading/unpacking jsonschema==2.5.1 13:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:16:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16:44 INFO - Downloading functools32-3.2.3-2.tar.gz 13:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:16:44 INFO - warning: no files found matching '*.txt' 13:16:44 INFO - no previously-included directories found matching 'build' 13:16:44 INFO - no previously-included directories found matching 'dist' 13:16:44 INFO - no previously-included directories found matching '.git*' 13:16:44 INFO - Installing collected packages: jsonschema, functools32 13:16:44 INFO - Running setup.py install for functools32 13:16:44 INFO - warning: no files found matching '*.txt' 13:16:44 INFO - no previously-included directories found matching 'build' 13:16:44 INFO - no previously-included directories found matching 'dist' 13:16:44 INFO - no previously-included directories found matching '.git*' 13:16:44 INFO - Successfully installed jsonschema functools32 13:16:44 INFO - Cleaning up... 13:16:44 INFO - Return code: 0 13:16:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:16:44 INFO - Using env: {'DISPLAY': ':0', 13:16:44 INFO - 'HOME': '/home/cltbld', 13:16:44 INFO - 'LANG': 'en_US.UTF-8', 13:16:44 INFO - 'LANGUAGE': 'en_US:en', 13:16:44 INFO - 'LOGNAME': 'cltbld', 13:16:44 INFO - 'MAIL': '/var/mail/cltbld', 13:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:44 INFO - 'MOZ_NO_REMOTE': '1', 13:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:44 INFO - 'NO_EM_RESTART': '1', 13:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:44 INFO - 'PWD': '/builds/slave/test', 13:16:44 INFO - 'SHELL': '/bin/bash', 13:16:44 INFO - 'SHLVL': '1', 13:16:44 INFO - 'TERM': 'linux', 13:16:44 INFO - 'TMOUT': '86400', 13:16:44 INFO - 'USER': 'cltbld', 13:16:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:44 INFO - '_': '/tools/buildbot/bin/python'} 13:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:44 INFO - Downloading/unpacking blobuploader==1.2.4 13:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:46 INFO - Downloading blobuploader-1.2.4.tar.gz 13:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:16:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:16:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:47 INFO - Downloading docopt-0.6.1.tar.gz 13:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:16:47 INFO - Installing collected packages: blobuploader, requests, docopt 13:16:47 INFO - Running setup.py install for blobuploader 13:16:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:16:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:16:47 INFO - Running setup.py install for requests 13:16:47 INFO - Running setup.py install for docopt 13:16:47 INFO - Successfully installed blobuploader requests docopt 13:16:47 INFO - Cleaning up... 13:16:47 INFO - Return code: 0 13:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16: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')]} 13:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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')]} 13:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16: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 13:16: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 13:16:47 INFO - Using env: {'DISPLAY': ':0', 13:16:47 INFO - 'HOME': '/home/cltbld', 13:16:47 INFO - 'LANG': 'en_US.UTF-8', 13:16:47 INFO - 'LANGUAGE': 'en_US:en', 13:16:47 INFO - 'LOGNAME': 'cltbld', 13:16:47 INFO - 'MAIL': '/var/mail/cltbld', 13:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:47 INFO - 'MOZ_NO_REMOTE': '1', 13:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:47 INFO - 'NO_EM_RESTART': '1', 13:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:47 INFO - 'PWD': '/builds/slave/test', 13:16:47 INFO - 'SHELL': '/bin/bash', 13:16:47 INFO - 'SHLVL': '1', 13:16:47 INFO - 'TERM': 'linux', 13:16:47 INFO - 'TMOUT': '86400', 13:16:47 INFO - 'USER': 'cltbld', 13:16:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:47 INFO - '_': '/tools/buildbot/bin/python'} 13:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:48 INFO - Running setup.py (path:/tmp/pip-9gjv6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:48 INFO - Running setup.py (path:/tmp/pip-TysZM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:48 INFO - Running setup.py (path:/tmp/pip-LNvNlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:48 INFO - Running setup.py (path:/tmp/pip-DWX1Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:48 INFO - Running setup.py (path:/tmp/pip-8dWA11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:48 INFO - Running setup.py (path:/tmp/pip-K2tWAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:48 INFO - Running setup.py (path:/tmp/pip-DruJ4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:48 INFO - Running setup.py (path:/tmp/pip-3T55Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:48 INFO - Running setup.py (path:/tmp/pip-Im5VnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:48 INFO - Running setup.py (path:/tmp/pip-upeqt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:48 INFO - Running setup.py (path:/tmp/pip-hF6jCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:48 INFO - Running setup.py (path:/tmp/pip-EKhE8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:49 INFO - Running setup.py (path:/tmp/pip-D8ABLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:49 INFO - Running setup.py (path:/tmp/pip-9JFFr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:49 INFO - Running setup.py (path:/tmp/pip-62pA7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:49 INFO - Running setup.py (path:/tmp/pip-GOB0J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:49 INFO - Running setup.py (path:/tmp/pip-s9qnKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:16:49 INFO - Running setup.py install for manifestparser 13:16:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:16:49 INFO - Running setup.py install for mozcrash 13:16:49 INFO - Running setup.py install for mozdebug 13:16:49 INFO - Running setup.py install for mozdevice 13:16:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:16:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:16:49 INFO - Running setup.py install for mozfile 13:16:49 INFO - Running setup.py install for mozhttpd 13:16:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:16:49 INFO - Running setup.py install for mozinfo 13:16:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Running setup.py install for mozInstall 13:16:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Running setup.py install for mozleak 13:16:50 INFO - Running setup.py install for mozlog 13:16:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Running setup.py install for moznetwork 13:16:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Running setup.py install for mozprocess 13:16:50 INFO - Running setup.py install for mozprofile 13:16:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Running setup.py install for mozrunner 13:16:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:16:50 INFO - Running setup.py install for mozscreenshot 13:16:50 INFO - Running setup.py install for moztest 13:16:51 INFO - Running setup.py install for mozversion 13:16:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:16:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:16:51 INFO - Cleaning up... 13:16:51 INFO - Return code: 0 13:16:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:51 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')]} 13:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:51 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')]} 13:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:51 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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16:51 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 13:16:51 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 13:16:51 INFO - Using env: {'DISPLAY': ':0', 13:16:51 INFO - 'HOME': '/home/cltbld', 13:16:51 INFO - 'LANG': 'en_US.UTF-8', 13:16:51 INFO - 'LANGUAGE': 'en_US:en', 13:16:51 INFO - 'LOGNAME': 'cltbld', 13:16:51 INFO - 'MAIL': '/var/mail/cltbld', 13:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:51 INFO - 'MOZ_NO_REMOTE': '1', 13:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:51 INFO - 'NO_EM_RESTART': '1', 13:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:51 INFO - 'PWD': '/builds/slave/test', 13:16:51 INFO - 'SHELL': '/bin/bash', 13:16:51 INFO - 'SHLVL': '1', 13:16:51 INFO - 'TERM': 'linux', 13:16:51 INFO - 'TMOUT': '86400', 13:16:51 INFO - 'USER': 'cltbld', 13:16:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:51 INFO - '_': '/tools/buildbot/bin/python'} 13:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:51 INFO - Running setup.py (path:/tmp/pip-lKZBCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:51 INFO - Running setup.py (path:/tmp/pip-cmlsfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:51 INFO - Running setup.py (path:/tmp/pip-_2YlWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:51 INFO - Running setup.py (path:/tmp/pip-NPT2vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:51 INFO - Running setup.py (path:/tmp/pip-6k0ARW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:51 INFO - Running setup.py (path:/tmp/pip-A3_uBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:51 INFO - Running setup.py (path:/tmp/pip-NENxEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:51 INFO - Running setup.py (path:/tmp/pip-u61M4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16: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)) 13:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:51 INFO - Running setup.py (path:/tmp/pip-fxpLrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:52 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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:52 INFO - Running setup.py (path:/tmp/pip-5QS6F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:52 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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:52 INFO - Running setup.py (path:/tmp/pip-JOtsTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:52 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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:52 INFO - Running setup.py (path:/tmp/pip-dJMCju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16: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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:52 INFO - Running setup.py (path:/tmp/pip-2wfBQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16: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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:52 INFO - Running setup.py (path:/tmp/pip-SzmAkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16: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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:52 INFO - Running setup.py (path:/tmp/pip-PdmzEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16: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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:52 INFO - Running setup.py (path:/tmp/pip-7JYuAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16: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)) 13:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:52 INFO - Running setup.py (path:/tmp/pip-marE_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16: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)) 13:16: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)) 13:16: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)) 13:16: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)) 13:16: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)) 13:16: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)) 13:16:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16: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 13:16:54 INFO - Downloading blessings-1.6.tar.gz 13:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:16:54 INFO - Installing collected packages: blessings 13:16:54 INFO - Running setup.py install for blessings 13:16:54 INFO - Successfully installed blessings 13:16:54 INFO - Cleaning up... 13:16:54 INFO - Return code: 0 13:16:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:54 INFO - Reading from file tmpfile_stdout 13:16:54 INFO - Current package versions: 13:16:54 INFO - argparse == 1.2.1 13:16:54 INFO - blessings == 1.6 13:16:54 INFO - blobuploader == 1.2.4 13:16:54 INFO - docopt == 0.6.1 13:16:54 INFO - functools32 == 3.2.3-2 13:16:54 INFO - jsonschema == 2.5.1 13:16:54 INFO - manifestparser == 1.1 13:16:54 INFO - mozInstall == 1.12 13:16:54 INFO - mozcrash == 0.17 13:16:54 INFO - mozdebug == 0.1 13:16:54 INFO - mozdevice == 0.48 13:16:54 INFO - mozfile == 1.2 13:16:54 INFO - mozhttpd == 0.7 13:16:54 INFO - mozinfo == 0.9 13:16:54 INFO - mozleak == 0.1 13:16:54 INFO - mozlog == 3.2 13:16:54 INFO - moznetwork == 0.27 13:16:54 INFO - mozprocess == 0.23 13:16:54 INFO - mozprofile == 0.28 13:16:54 INFO - mozrunner == 6.12 13:16:54 INFO - mozscreenshot == 0.1 13:16:54 INFO - mozsystemmonitor == 0.3 13:16:54 INFO - moztest == 0.7 13:16:54 INFO - mozversion == 1.4 13:16:54 INFO - psutil == 3.1.1 13:16:54 INFO - requests == 1.2.3 13:16:54 INFO - wsgiref == 0.1.2 13:16:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16: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')]} 13:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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')]} 13:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16: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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16: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 13:16: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 13:16:54 INFO - Using env: {'DISPLAY': ':0', 13:16:54 INFO - 'HOME': '/home/cltbld', 13:16:54 INFO - 'LANG': 'en_US.UTF-8', 13:16:55 INFO - 'LANGUAGE': 'en_US:en', 13:16:55 INFO - 'LOGNAME': 'cltbld', 13:16:55 INFO - 'MAIL': '/var/mail/cltbld', 13:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:55 INFO - 'MOZ_NO_REMOTE': '1', 13:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:55 INFO - 'NO_EM_RESTART': '1', 13:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:55 INFO - 'PWD': '/builds/slave/test', 13:16:55 INFO - 'SHELL': '/bin/bash', 13:16:55 INFO - 'SHLVL': '1', 13:16:55 INFO - 'TERM': 'linux', 13:16:55 INFO - 'TMOUT': '86400', 13:16:55 INFO - 'USER': 'cltbld', 13:16:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:55 INFO - '_': '/tools/buildbot/bin/python'} 13:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 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)) 13:16:55 INFO - Cleaning up... 13:16:55 INFO - Return code: 0 13:16:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:55 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 0x1bb7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', '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 13:16:55 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 13:16:55 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 13:16:55 INFO - Using env: {'DISPLAY': ':0', 13:16:55 INFO - 'HOME': '/home/cltbld', 13:16:55 INFO - 'LANG': 'en_US.UTF-8', 13:16:55 INFO - 'LANGUAGE': 'en_US:en', 13:16:55 INFO - 'LOGNAME': 'cltbld', 13:16:55 INFO - 'MAIL': '/var/mail/cltbld', 13:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:55 INFO - 'MOZ_NO_REMOTE': '1', 13:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:55 INFO - 'NO_EM_RESTART': '1', 13:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:55 INFO - 'PWD': '/builds/slave/test', 13:16:55 INFO - 'SHELL': '/bin/bash', 13:16:55 INFO - 'SHLVL': '1', 13:16:55 INFO - 'TERM': 'linux', 13:16:55 INFO - 'TMOUT': '86400', 13:16:55 INFO - 'USER': 'cltbld', 13:16:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:55 INFO - '_': '/tools/buildbot/bin/python'} 13:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:16:55 INFO - Cleaning up... 13:16:55 INFO - Return code: 0 13:16:55 INFO - Running post-action listener: _resource_record_post_action 13:16:55 INFO - Running post-action listener: _start_resource_monitoring 13:16:55 INFO - Starting resource monitoring. 13:16:55 INFO - ##### 13:16:55 INFO - ##### Finished create-virtualenv step (success) 13:16:55 INFO - ##### 13:16:55 INFO - ##### 13:16:55 INFO - ##### Running install step. 13:16:55 INFO - ##### 13:16:55 INFO - Running pre-action listener: _resource_record_pre_action 13:16:55 INFO - Running main action method: install 13:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:55 INFO - Reading from file tmpfile_stdout 13:16:55 INFO - Detecting whether we're running mozinstall >=1.0... 13:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:16:55 INFO - Reading from file tmpfile_stdout 13:16:55 INFO - Output received: 13:16:55 INFO - Usage: mozinstall [options] installer 13:16:55 INFO - Options: 13:16:55 INFO - -h, --help show this help message and exit 13:16:55 INFO - -d DEST, --destination=DEST 13:16:55 INFO - Directory to install application into. [default: 13:16:55 INFO - "/builds/slave/test"] 13:16:55 INFO - --app=APP Application being installed. [default: firefox] 13:16:55 INFO - mkdir: /builds/slave/test/build/application 13:16: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'] 13:16: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 13:17:12 INFO - Reading from file tmpfile_stdout 13:17:12 INFO - Output received: 13:17:12 INFO - /builds/slave/test/build/application/firefox/firefox 13:17:12 INFO - Running post-action listener: _resource_record_post_action 13:17:12 INFO - ##### 13:17:12 INFO - ##### Finished install step (success) 13:17:12 INFO - ##### 13:17:12 INFO - ##### 13:17:12 INFO - ##### Running run-tests step. 13:17:12 INFO - ##### 13:17:12 INFO - Running pre-action listener: _resource_record_pre_action 13:17:12 INFO - Running main action method: run_tests 13:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:17:12 INFO - Python 2.7.3 13:17:12 INFO - Return code: 0 13:17:12 INFO - grabbing minidump binary from tooltool 13:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:12 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 0x1e75570>, '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 0x1e76470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e76900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:17:12 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 13:17:12 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 13:17:12 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 13:17:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:17:13 INFO - Return code: 0 13:17:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:17:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:17:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:17:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:17:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:17:13 INFO - Using env: {'DISPLAY': ':0', 13:17:13 INFO - 'HOME': '/home/cltbld', 13:17:13 INFO - 'LANG': 'en_US.UTF-8', 13:17:13 INFO - 'LANGUAGE': 'en_US:en', 13:17:13 INFO - 'LOGNAME': 'cltbld', 13:17:13 INFO - 'MAIL': '/var/mail/cltbld', 13:17:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:17:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:13 INFO - 'MOZ_NO_REMOTE': '1', 13:17:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:13 INFO - 'NO_EM_RESTART': '1', 13:17:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:13 INFO - 'PWD': '/builds/slave/test', 13:17:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:17:13 INFO - 'SHELL': '/bin/bash', 13:17:13 INFO - 'SHLVL': '1', 13:17:13 INFO - 'TERM': 'linux', 13:17:13 INFO - 'TMOUT': '86400', 13:17:13 INFO - 'USER': 'cltbld', 13:17:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306', 13:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:13 INFO - '_': '/tools/buildbot/bin/python'} 13:17:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:17:13 INFO - mozversion application_buildid: 20160716103004 13:17:13 INFO - mozversion application_changeset: dc97f8b36a22d36be518e56261df85205bb535d2 13:17:13 INFO - mozversion application_display_name: Nightly 13:17:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:17:13 INFO - mozversion application_name: Firefox 13:17:13 INFO - mozversion application_remotingname: firefox 13:17:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:17:13 INFO - mozversion application_vendor: Mozilla 13:17:13 INFO - mozversion application_version: 50.0a1 13:17:13 INFO - mozversion platform_buildid: 20160716103004 13:17:13 INFO - mozversion platform_changeset: dc97f8b36a22d36be518e56261df85205bb535d2 13:17:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:17:13 INFO - mozversion platform_version: 50.0a1 13:17:13 INFO - using testdate: 1468700233 13:17:13 INFO - actual date: 1468700233 13:17:13 INFO - starting webserver on 'localhost:51287' 13:17:13 INFO - SUITE-START | Running 2 tests 13:17:13 INFO - TEST-START | dromaeo_css 13:17:13 INFO - operating with platform_type : linux_ 13:17:13 INFO - Initialising browser for dromaeo_css test... 13:17:13 INFO - TEST-INFO | started process 3324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjnTvH/profile http://localhost:51287/getInfo.html) 13:17:17 INFO - PROCESS | 3324 | JavaScript error: , line 0: uncaught exception: undefined 13:17:19 INFO - PROCESS | 3324 | __metrics Screen width/height:1600/1200 13:17:19 INFO - PROCESS | 3324 | colorDepth:24 13:17:19 INFO - PROCESS | 3324 | Browser inner width/height: 1024/697 13:17:19 INFO - PROCESS | 3324 | __metrics 13:17:20 ERROR - PROCESS | 3324 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:17:21 INFO - TEST-INFO | 3324: exit 0 13:17:21 INFO - Browser initialized. 13:17:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:17:21 INFO - TEST-INFO | started process 3444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjnTvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:33 INFO - PROCESS | 3444 | RSS: Main: 167960576 13:17:33 INFO - PROCESS | 3444 | 13:18:22 INFO - PROCESS | 3444 | 1468700302750 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] 13:20:30 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:51287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51287/tests/dromaeo/cssquery-ext.html) 13:20:31 INFO - PROCESS | 3444 | RSS: Main: 171835392 13:20:31 INFO - PROCESS | 3444 | 13:23:33 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:51287/tests/dromaeo/cssquery-ext.html (next: http://localhost:51287/tests/dromaeo/cssquery-jquery.html) 13:23:34 INFO - PROCESS | 3444 | RSS: Main: 168591360 13:23:34 INFO - PROCESS | 3444 | 13:26:36 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:51287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51287/tests/dromaeo/cssquery-mootools.html) 13:26:36 INFO - PROCESS | 3444 | RSS: Main: 173330432 13:26:36 INFO - PROCESS | 3444 | 13:29:38 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:51287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51287/tests/dromaeo/cssquery-prototype.html) 13:29:39 INFO - PROCESS | 3444 | RSS: Main: 168038400 13:29:39 INFO - PROCESS | 3444 | 13:32:41 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:51287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51287/tests/dromaeo/cssquery-yui.html) 13:32:42 INFO - PROCESS | 3444 | RSS: Main: 169873408 13:32:42 INFO - PROCESS | 3444 | 13:35:44 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:51287/tests/dromaeo/cssquery-yui.html (next: http://localhost:51287/tests/dromaeo/cssquery-dojo.html) 13:35:45 INFO - PROCESS | 3444 | RSS: Main: 173031424 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | __start_tp_report 13:35:45 INFO - PROCESS | 3444 | _x_x_mozilla_page_load 13:35:45 INFO - PROCESS | 3444 | _x_x_mozilla_page_load_details 13:35:45 INFO - PROCESS | 3444 | |i|pagename|runs| 13:35:45 INFO - PROCESS | 3444 | |0;dojo.html;3068.401661675973;3080.3839232153573;3096.5510001049834;3118.76609254306;3144.8113113213208;5388.353397592285;5392.352917649882;5428.212909128179;5469;5545.694986775726;5302.708351040691;5392.083345831208;5397.514223719864;5469.589780766439;5502.944970550293;4896.853094407174;4965.602751779858;5011.473795251482;5012.69923804571;5053.696778193302;4920.655554111214;5040.5967522598285;5043.823466178685;5068.366454193226;5084.110280700881;685.6154226396441;4951.628627852908;4959.82640607577;5020.7489625518765;5047.899042019158;4912.975435122838;4916.336294600219;4917.114919314522;4928.260760885896;4956.677815941988;4883.8779030524165;4887.413510378742;4906.754662266908;4906.828261010884;4935.457099719028;5201.661891977009;5276.92084618731;5295.629305948585;5371.838844834622;5428.37573679028;5707.857303567403;5710.914336284959;5711;5747.339056008529;5789.681567513785;5774.047282198432;5788.957987562237;5800.158976948361;5800.680962547058;5805.82582522525;5309.973450132725;5354.544863686552;5398.2982212312545;5409.864753381157;5410.48600382963;5890.116482527569;5891.852703682356;5894.6757928314355;5971.313298970587;5980.222571065734;5751.166080918243;5760.971195143998;5775.826725198251;5778.797742079007;5785.681787501644;5795.072788353843;5822.621529600562;5857.824265272048;5876.529877609781;5889.057750759858;5774.942250577525;5820.650760954271;5841.240638716939;5844.795432159939;5845.1232315153065;5641.379448260688;5780.88438231233;5822.417758224144;5860.150278209721;5870.765169393177;4338.631216346583;4376.715513491677;4444.511103778582;4475.977620111878;4483.461984561874;3948.309045916953;3959.8416063357145;3965.385365268388;3985.661218796377;3999.7400168988925;5318.042752304622;5406.243125962368;5489.176623506506;5516.172574113834;5517.227588137664;5782.739776710058;5830.3586605473365;5843.824685259449;5847.415258474119;5877.882442351129;5431.402545719968;5474.42518535556;5477.315335583052;5495.422980587061;5515.669059856422;4738.407699037621;4785.090832741768;4786.353842231324;4882.853514394574;4943;5886.205362276123;5930.258717660293;5933.643981361132;5956.255468066492;5973.462388385066;5672.234248376416;5675.460831221028;5676.20533125371;5678.4605462480995;5705.058665320175;5844.736986835687;5854.531637468907;5876.41235876409;5921.319048309328;5948.613340132878;5698.772049117989;5709.25779648643;5715.799947001835;5724.79963201286;5731.942680573141;5757.798477053283;5782.392848750821;5802.796902108406;5815.563832712479;5819.6508209507565;5586.050371436947;5686.2323586315315;5728.770849165987;5729.169270455677;5736.971315143564;5698.4016678249845;5706.372299047184;5707.7716891325545;5718.51392631631;5748.051571490657;5375.354957405137;5584.832455026356;5641.492265696107;5641.971790141023;5645.745941432728;5600.159976003469;5624.775008999594;5653.152027195789;5663;5676.829695109153;5578.721063946868;5581.804636837691;5624.634398764068;5687.971560142173;5696.8006119785605 13:35:45 INFO - PROCESS | 3444 | |1;ext.html;560.442712128977;576.2508738639768;591.1192323438075;596.0641792385954;632.876589065132;42190.57809421905;43128;43299.35050974238;43630.12739745207;43662.345064824054;43733.34399984003;44015.77992110043;44377.55622443774;44516;44574.10851782963;8796.956015219946;8991.595378207963;8992.730218093468;8993.595288212045;8995;8864;8965.865512017292;8971.865422018675;8978.595963181673;8978.685745998859;8983.685571005017;9003.324750643695;9013.188813006827;9015.098490150998;9061;8908.821823563492;8931.50876701781;9022.45865248084;9025.548722563879;9052.049534798884;8860.069692682304;8890.822183556358;8926.107389261022;8940.195382415548;8964.596593153325;33418.83290583556;41132.38301425481;41496.79251603753;41733.1653366931;41860;3300.9834950825334;3452.7755695879687;3540.291941611688;3554.5023696682483;3709.1654377764785;31158;31539.36921261562;31729.682703172904;31863;32064.679353206404;4156.397322388237;4204.810783514718;4246.830126794925;4278.122984788111;4442.666799990014;315501;316626;318126;319981;319997.40001300076;34369.82815085958;34388;34618.13454663603;35354.82322588422;35416.64583354133;36579.817100914326;36687.449688254696;36700.63299367025;36764.44853327202;36854;14848.331825067899;14889.553313400615;15025.549233523012;15030.924845375921;15040.849591504164;11923.70190745221;12047.216930899638;12077.51689932393;12078.818817717742;12103.636890893287;8212.794680132925;8235.464694794819;8262.132476089924;8323.25090741824;8329.416940814206;3226.6934641209045;3252.3820474109843;3257.1694217974264;3264.477683570665;3319.13702437368;980.2011360740973;1050.9737256568494;1084.9294795838246;1100.7908497385472;1159.2812456277163;33146.66853331484;33564.832175838965;35477.645223547435;36167.81916090403;36185.276294473966;1093.294824837975;1112.4715760013928;1119.6417146513038;1161.5702190189684;1204.873488283735;15912.984068202628;16716.24776885043;16844.24200910962;16901;17038.82961170397;562707;568944;569440;570897;571170;54075.188872166946;55534.72232638811;55856.88286234334;55918.440815592134;56080.15879761725;1368.8494265630773;1374.6082366525493;1378.4417310989065;1382.5644921849585;1390.8887289017057;29753.3526685012;31120.844395777876;31131;31360.68639313669;32012.839935800173;49838.75080624719;50255;50625.49374506208;50932.23601645904;50951.23573146332;479994;480091;480727;484221;485044;26869;26928.596071059343;27166.72833271642;27494.725052749218;27525.72474275312;46834.76582617065;46847.76576117097;47140;47564.762176188895;47713.5228647723;40409.797951010056;40429;40807.795961020005;40847.591524084375;40961.38557921574;39834;39923.40114898221;40082.799586001885;40249;41434.1713165741;39282.803585981885;39645.40531892081;40357.1928561433;40573.594264056985;40624.79687601661;32680.50979235361;35566.64433355633;35797.64202357943;36183.819080904424;36493;26818.59772103459;27054.864725676245;27269.318267043484;27418.31454213581;27623.861880690467 13:35:45 INFO - PROCESS | 3444 | |2;jquery.html;393.24104478356776;395.16028439565923;398.9082511022465;400.3274498841946;422.7505771594758;14422.423103075864;18801.529961750944;18804.43586692398;20427.387178384633;20431.795682043175;19630;19994;20095.196192152333;20857.895710521465;20903;5658.207850900877;5736.741846616891;5795.4784069433745;5813.418658134195;5830.621009634381;5578.246936663539;5704.48659620634;5719.25649665545;5742.7415766290405;5750.482456578907;5556.055470569992;5627.7186140693;5749.281339832521;5753.309602847664;5753.453421924911;5652.689102099363;5670.432956704338;5690.40250773667;5692.459216374438;5712.828615141531;4958.9008219835405;5021.17150670139;5051.621128415383;5058.822941197041;5067.8986420271385;17462.30150793967;21614.243501477373;23868.283951481484;24048.879755601283;24365.756342436704;2174.695542624034;2405.5549723301247;2425.417899704076;2452.264320703782;2526.660869739041;10531.947340263327;10532.42071686057;10589.629362972259;10774.5690172393;10832.72918177044;1946.746922900028;1950.4733721895009;2016.536196674773;2034.3998520436508;2046.1815273890413;89102;90350.09649903483;90695;91745.62381564348;92817.53591232;10963.232573719923;11164.162687798447;11168.888311116785;11280.492377843017;11352.14858885587;15251.542453726406;15378.384864605514;15500.30248638814;15523.37906483728;15538.844611553966;7928.563928983961;8203.466774659628;8221.301189398848;8289.8342033159;8350.4154709171;8053.395995300376;8114.594270286462;8184.345252379795;8289.502629842229;8334.291585215204;4334.956650433455;4361.236783562864;4426.84506042287;4511.593956543927;4767.880802979884;1942.9708554371696;1974.4993804708238;2022.797720227995;2049.5900819835792;2107.599556084339;922.0134456131874;985.1478471122427;1005.6178652112151;1010.7321559786662;1032.5456799008412;19471.610567788564;20389.286374976804;20405.795942040688;20406.387808365773;20450.897745511178;994.5623925472769;997.7505623594102;1058.867641544807;1060.6340812419703;1098.2477003252798;10818.891811081945;11185.66443006711;11348.886511134948;11414.714632134263;11432.828507572392;399195;402821;449535;514278;537252;105520.47239763905;106056;106681.46659266653;106964.46517767361;107378.3893241602;1021.7649940513575;1060.3796778884284;1063.8244689626124;1066.893310668927;1072.7908057928785;17731.64536709233;18128.365507207185;18485.168167432766;18612.627747444705;19031.42905712831;31104.22239444032;34373.140671483416;44880;45143.548564513934;45385.773071134434;64131.3586864144;64978.67510662416;65209.34790652033;67137.66431167813;67429.66285168543;5626.409227031267;7546.358559522502;7754.573498457414;8637.827243455222;8857.64569417216;13376.398062087035;13473.86526134726;14110.858891411364;14399.92800035993;14415.927920360331;11700.531978720755;12043;12101.939490302491;12370.876291237333;12489.31308778026;11818;11858.584949526725;12161;12232.816507752568;12432.751344972869;11726.648200553997;11781.116416268642;11800.468978896142;11950.402479876146;12460.937695311466;7618.961905190438;7783.766487005399;7898.960505197667;8779.517126558101;8949.821003580022;8641.654333826827;11154.665360039211;11264.267822591506;11735.76528469443;11839.05287577009 13:35:45 INFO - PROCESS | 3444 | |3;mootools.html;1491.5376233367656;1501.151849205199;1671.8746094042942;1783.6611043901667;1810.7464954906307;7555.546667199972;8395.328373730103;8525.701600443987;9121.452712837226;9166.54167291636;8485.957570212156;8845.823083538326;8877.334199934998;8909.554522273893;8951.283897288218;2389.8327117101853;2411.553862535428;2431.598786200275;2432.404061005056;2440.1093600835657;2401.3036219496325;2413.2760171948435;2451.595486744694;2456.508698260346;2458.9754102458924;2381.5594115088766;2397.1130681647815;2400.519896020794;2403.939901502468;2409.5662780699467;2319.6752454656275;2332.521833024226;2334.3347146063375;2334.754850740682;2362.4330160761465;2307.653851922208;2316.108298305148;2318.4783423729696;2327.6392159215347;2334.043042352644;8991;9012.63949442028;9044.954775226082;9060.320475964263;9073.228775554086;5536.363318218376;5643.407442218549;5673;5684.516816070639;5694.8325593253285;3484.285721427101;3550.822458877046;3596.9280614387567;3618.0773902654655;3625.075605720551;1170.3387586013876;1188.5780547905542;1214.7570485902766;1216.7201543644924;1233.722412457199;12745.36273186337;12807.359632018362;12928.030397720115;12928.353582320846;12932.806007909889;4694.859154225379;4716.316134160596;4748.477667456577;4764.472766313199;4911.435184953776;9927.900720992842;9988.450635214987;10027.699169024942;10046.598136074475;10083.294169408218;5387.4073851876265;5397.379301380313;5407.972960135253;5414.160805075219;5425.240466334716;4378.4745830499905;4978.6763860348965;5094.4141423736;5126.666766660155;5162.328897243409;3877.689784817208;3924.6860251179837;3980.124372638015;4019.8191081401405;4070.3080476319096;1193.6478738772082;1211.1279878487476;1217.5799349224503;1226.7730469863104;1227.3863068465766;848.868425394065;851.8296340731879;981.2787601113176;1015.9796804063877;1042.11940909931;6070.332263451017;6208.937910620836;6252.237203197702;6284.528660350492;6373.936260637427;974.1962880623372;997.8702768640176;1002.2783595811004;1003.7039073473343;1027.5170669785339;4367.519572846984;4462.576055274743;4518.751468669189;4528.932066019012;4633.86098417048;11317;11552.711182220512;11606.24559403636;11669.649910502698;11704.414779261004;10595.682129536126;11099.778004439866;11338.263012904135;11549.076073914066;11552.537898484135;8424.663013479514;8490.320774338039;8510.872336914952;8610.483370997761;8617;6245.750169993149;6620.172478440195;6633.2371777246235;6665.933340666531;6673.666316684244;9546.90453095488;10259.384436933808;10740.355578665305;10748.892511075102;10767.3539587625;9941.155001824925;10164.390136591828;10197.847032294374;10284;10289.9485502572;7074.752383666753;7691.077070751546;7919.643616037177;8069.435139540175;8258.132896046069;8787.736367908972;8883.689070882747;8899.688510902088;8925.107489251022;8952.23905967974;7787.10448298453;7875.684972601261;7943.880841787493;8075.071366792659;8103.230193131643;7898;7940.880886786587;7941.205879412013;8108.837823243384;8196.67213311461;7320.597367144645;7426.034615499951;7456.850862982818;7483.064616922885;7542.396608271435;5537.643277397064;5552.500274975271;5623.971880140737;5647.124695672177;5699.886002279848;5496.065668836228;5532.873926231666;5631.8592035199445;5638.5771067170945;5688.800891968761 13:35:45 INFO - PROCESS | 3444 | |4;prototype.html;328.22047636862453;333.2468620916728;340.119091552878;342.9691327780499;343.7061312577744;5458.890822183554;5577.932137324466;5599.216109744634;5776.39347868474;5794.884102317957;5556.333240011204;5560.972195139018;5598.440155984399;5622.91565626516;5622.943770562293;4365.279728844736;4410.536893626155;4412.426384570002;4415.359772832937;4432.3573081903105;4111.588841115894;4365.585269399402;4369.803358848843;4428;4432.512423633414;4330.02574420756;4330.675199360045;4342.066455712022;4346.782660866944;4356.281213599752;4358.673099517533;4366.0134638739455;4366.476022877243;4376.6498680105515;4380.430544029287;3743.569489508714;3798.753081049723;3836.9424458633143;3839.7904660032;3840.2127563849344;5441.537469315113;5449.291592093003;5475.67145971239;5507.531859791922;5546.057170281021;4963.478834722375;4989.750512474398;5000.924986125211;5002.849914502571;5007.173816320303;5677.829665110054;5811.360750317462;5838.2118414013985;5928.377520360386;5947.37552556984;4126.773027483518;4138.8551400700835;4147.398627199039;4148.709590328648;4149.502059752819;6047.455728984412;6066;6082.574219804571;6109.847253818646;6162.599431036968;4150.626443620089;4259.659227261874;4261.446012018418;4268.40242366069;4271.295236286041;4279.486461624625;4294.162638285567;4305.203537345538;4310.181065597527;4329.372241025097;4989.17678583037;4999.125153098194;5006.424261210008;5006.949930500721;5014.924776128361;5686.886262274731;5872.500837428866;5897.76408943646;5936.881262374728;6031.668258245839;1436.18137661534;1442.4158215922569;1453.280626090071;1458.9927050364681;1462.232328027794;897.1477096758106;923.3029063057348;925.6852670092201;937.9718608441758;944.617429940875;4944.3572335596145;4974.502549744997;5004.7469145055275;5046.924296135561;5058.974705126451;5290.312259406252;5325.307709997753;5333.5199832015305;5357.785688572491;5388.973055134699;5100.628207883352;5180.222966554971;5185.248139019821;5361.329833770778;5792.623479473821;3222.2105584132037;3241.5623890774914;3265.6734326567152;3273.3780581689402;3295.467607562495;6035.921679943261;6304.873902522016;6357.396047375492;6364;6369.5222858285815;6110.327863934964;6188.659623720739;6198.194234749544;6209.223847019122;6220;6249.7187626556915;6317.9684101580115;6327.955887278639;6336.578247746257;6348.714307856158;5781.913271301018;6072.939270607238;6122.785702500391;6127.20346354971;6132.332435390441;6031.24609423822;6042.818715438544;6109.175261339662;6110;6118.868009418272;6185.319614842454;6242.625442473284;6351;6387.914054610635;6408;4234.1108367241995;4266.914661706811;4280.250956082736;4283.74297542136;4295.634871035997;6177.683368736723;6184;6194.0708893666315;6196.47329976939;6204.937950620436;5890.3226128994;5899.380565040609;5921.378255283305;5942.465178133989;5990.7903223386975;5845.970770146122;5886.646801191942;5923.348431672599;5933.436323549256;5984.640921544721;5599.524040456444;5872.765089396376;5901.3213480450295;5915.911261330997;5962.850928726816;5981.970090149695;5990.9700451497465;6009.849753756191;6014.398560144125;6073.178046586095;5813.883722325614;5831.300243970581;5883.176355310175;5903.822885313448;5911.467967882912 13:35:45 INFO - PROCESS | 3444 | |5;yui.html;769.8267889724809;781.3788038509384;816.5672193737321;833.691534132371;863.4473936680523;14879.925600371997;15312.846871531281;15776.290066946985;15821.288042038108;15936.362545498196;14467.78298325526;14503.637409064779;14630.926845365784;14638.048526845774;14638.48765293215;672.2773019004566;807.0758980966804;808.0989696488432;825.7110011495959;828.6975254032295;825.0305890578546;825.6078362777663;827.6275675945849;828.718235799828;830.9127541608135;867.5055218525443;872.520113937332;872.8559787635032;872.8865247517846;875.3566128895256;863.6459051788736;871.1332224436662;872.2672954718035;873.2271939333672;874.5539774714878;634.2040738872686;634.337117711992;634.7651368993502;635.965021923794;636.4908073541148;14832;14867.553973380816;14905.70188596222;14916.328765205591;14923.328450219766;15824.76262856058;15869.444569440015;16021.359145634277;16060.678786424323;16205.432809851716;12208.267503949792;12301.261924284572;12436.191647542972;12483.563075292412;13102.148360356547;3981.5023122109737;4000.2799496090693;4004.4794176756836;4026.2148880968225;4156.106437116035;76658.23341766623;77514.22485775183;78248;78373.60813195897;80182;11769.352685602375;11803.940980295043;11807.76384472323;11881.346525940984;12011.579594714143;23104.53790924172;23315.533689326458;23370.415739606306;23449.296521104396;23450;9100.499472528942;9115.088491150831;9279.621468108793;9357.90642093584;9440.811183776286;4893.266010098514;5092.694438333712;5108.744562771846;5167.147420675622;5532.197831314437;3613.4218525035867;3725.4970578972034;3727.9254414912093;3727.981360093182;3728.515293011891;617.7251123250111;658.8748137853793;662.7680311890799;665.710415969055;670.7317073170673;714.4605822603901;723.1900271695735;729.1323325242944;743.0748717846316;747.689708770854;9068.591913363915;9531.952340238255;9743.561539730586;9817;9821.508924553744;613.420317799675;639.414935334164;697.5431092634333;721.2679130682361;722.8807246804323;4514.887127821765;4669.906601868011;4763.880902977453;4780.784864681098;4828.396450443694;120163;120848;125788;126848;127614;107553.46223268834;108847;109310.99999999841;110327.44836275767;110701;93302;93391.53304233435;95929.04070959201;96405;97277.5136124329;8976;9125.634974600942;9174.357794954556;10185.541650625592;10199.541020654236;38131.618683812805;39393.21213575655;45514.089718204785;51616;53383.73308133434;50968.74515627398;51088.23367649563;60375.698121509115;75822.24177758372;79138;13892.474618846774;13995.440182392591;14049.859501404855;14171.929140354232;14315.928420357832;15573.766393504333;15846.44537441184;15931.123788191297;16177.352905883632;16316.592085197964;13791.448342066205;13975.09161904473;14760.557183284518;14857.702845943237;15425.614359641098;14529.854701453272;14568.781468277772;14595.708085838436;14781.113133212042;15169.317380717674;13588.864111359155;13680.452781889011;14313.713725725636;14499.565013049625;14956.637692120168;11712.355820429959;11841.96830841057;12024.819627705767;12091.818622720843;12435.626931192079;11787.823182652439;12271;12437.315947622968;12820.807687884875;12938.482460701844 13:35:45 INFO - PROCESS | 3444 | __end_tp_report 13:35:45 INFO - PROCESS | 3444 | __start_cc_report 13:35:45 INFO - PROCESS | 3444 | _x_x_mozilla_cycle_collect,346 13:35:45 INFO - PROCESS | 3444 | __end_cc_report 13:35:45 INFO - PROCESS | 3444 | __startTimestamp1468701345177__endTimestamp 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | ------- Summary: start ------- 13:35:45 INFO - PROCESS | 3444 | Number of tests: 6 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | [#0] dojo.html Cycles:165 Average:5351.41 Median:5641.38 stddev:710.80 (12.6%) stddev-sans-first:690.05 13:35:45 INFO - PROCESS | 3444 | Values: 3068.4 3080.4 3096.6 3118.8 3144.8 5388.4 5392.4 5428.2 5469.0 5545.7 5302.7 5392.1 5397.5 5469.6 5502.9 4896.9 4965.6 5011.5 5012.7 5053.7 4920.7 5040.6 5043.8 5068.4 5084.1 685.6 4951.6 4959.8 5020.7 5047.9 4913.0 4916.3 4917.1 4928.3 4956.7 4883.9 4887.4 4906.8 4906.8 4935.5 5201.7 5276.9 5295.6 5371.8 5428.4 5707.9 5710.9 5711.0 5747.3 5789.7 5774.0 5789.0 5800.2 5800.7 5805.8 5310.0 5354.5 5398.3 5409.9 5410.5 5890.1 5891.9 5894.7 5971.3 5980.2 5751.2 5761.0 5775.8 5778.8 5785.7 5795.1 5822.6 5857.8 5876.5 5889.1 5774.9 5820.7 5841.2 5844.8 5845.1 5641.4 5780.9 5822.4 5860.2 5870.8 4338.6 4376.7 4444.5 4476.0 4483.5 3948.3 3959.8 3965.4 3985.7 3999.7 5318.0 5406.2 5489.2 5516.2 5517.2 5782.7 5830.4 5843.8 5847.4 5877.9 5431.4 5474.4 5477.3 5495.4 5515.7 4738.4 4785.1 4786.4 4882.9 4943.0 5886.2 5930.3 5933.6 5956.3 5973.5 5672.2 5675.5 5676.2 5678.5 5705.1 5844.7 5854.5 5876.4 5921.3 5948.6 5698.8 5709.3 5715.8 5724.8 5731.9 5757.8 5782.4 5802.8 5815.6 5819.7 5586.1 5686.2 5728.8 5729.2 5737.0 5698.4 5706.4 5707.8 5718.5 5748.1 5375.4 5584.8 5641.5 5642.0 5645.7 5600.2 5624.8 5653.2 5663.0 5676.8 5578.7 5581.8 5624.6 5688.0 5696.8 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | [#1] ext.html Cycles:180 Average:59482.58 Median:40303.10 stddev:124768.33 (309.6%) stddev-sans-first:125039.91 13:35:45 INFO - PROCESS | 3444 | Values: 560.4 576.3 591.1 596.1 632.9 42190.6 43128.0 43299.4 43630.1 43662.3 43733.3 44015.8 44377.6 44516.0 44574.1 8797.0 8991.6 8992.7 8993.6 8995.0 8864.0 8965.9 8971.9 8978.6 8978.7 8983.7 9003.3 9013.2 9015.1 9061.0 8908.8 8931.5 9022.5 9025.5 9052.0 8860.1 8890.8 8926.1 8940.2 8964.6 33418.8 41132.4 41496.8 41733.2 41860.0 3301.0 3452.8 3540.3 3554.5 3709.2 31158.0 31539.4 31729.7 31863.0 32064.7 4156.4 4204.8 4246.8 4278.1 4442.7 315501.0 316626.0 318126.0 319981.0 319997.4 34369.8 34388.0 34618.1 35354.8 35416.6 36579.8 36687.4 36700.6 36764.4 36854.0 14848.3 14889.6 15025.5 15030.9 15040.8 11923.7 12047.2 12077.5 12078.8 12103.6 8212.8 8235.5 8262.1 8323.3 8329.4 3226.7 3252.4 3257.2 3264.5 3319.1 980.2 1051.0 1084.9 1100.8 1159.3 33146.7 33564.8 35477.6 36167.8 36185.3 1093.3 1112.5 1119.6 1161.6 1204.9 15913.0 16716.2 16844.2 16901.0 17038.8 562707.0 568944.0 569440.0 570897.0 571170.0 54075.2 55534.7 55856.9 55918.4 56080.2 1368.8 1374.6 1378.4 1382.6 1390.9 29753.4 31120.8 31131.0 31360.7 32012.8 49838.8 50255.0 50625.5 50932.2 50951.2 479994.0 480091.0 480727.0 484221.0 485044.0 26869.0 26928.6 27166.7 27494.7 27525.7 46834.8 46847.8 47140.0 47564.8 47713.5 40409.8 40429.0 40807.8 40847.6 40961.4 39834.0 39923.4 40082.8 40249.0 41434.2 39282.8 39645.4 40357.2 40573.6 40624.8 32680.5 35566.6 35797.6 36183.8 36493.0 26818.6 27054.9 27269.3 27418.3 27623.9 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | [#2] jquery.html Cycles:180 Average:29109.12 Median:11860.92 stddev:77366.61 (652.3%) stddev-sans-first:77553.60 13:35:45 INFO - PROCESS | 3444 | Values: 393.2 395.2 398.9 400.3 422.8 14422.4 18801.5 18804.4 20427.4 20431.8 19630.0 19994.0 20095.2 20857.9 20903.0 5658.2 5736.7 5795.5 5813.4 5830.6 5578.2 5704.5 5719.3 5742.7 5750.5 5556.1 5627.7 5749.3 5753.3 5753.5 5652.7 5670.4 5690.4 5692.5 5712.8 4958.9 5021.2 5051.6 5058.8 5067.9 17462.3 21614.2 23868.3 24048.9 24365.8 2174.7 2405.6 2425.4 2452.3 2526.7 10531.9 10532.4 10589.6 10774.6 10832.7 1946.7 1950.5 2016.5 2034.4 2046.2 89102.0 90350.1 90695.0 91745.6 92817.5 10963.2 11164.2 11168.9 11280.5 11352.1 15251.5 15378.4 15500.3 15523.4 15538.8 7928.6 8203.5 8221.3 8289.8 8350.4 8053.4 8114.6 8184.3 8289.5 8334.3 4335.0 4361.2 4426.8 4511.6 4767.9 1943.0 1974.5 2022.8 2049.6 2107.6 922.0 985.1 1005.6 1010.7 1032.5 19471.6 20389.3 20405.8 20406.4 20450.9 994.6 997.8 1058.9 1060.6 1098.2 10818.9 11185.7 11348.9 11414.7 11432.8 399195.0 402821.0 449535.0 514278.0 537252.0 105520.5 106056.0 106681.5 106964.5 107378.4 1021.8 1060.4 1063.8 1066.9 1072.8 17731.6 18128.4 18485.2 18612.6 19031.4 31104.2 34373.1 44880.0 45143.5 45385.8 64131.4 64978.7 65209.3 67137.7 67429.7 5626.4 7546.4 7754.6 8637.8 8857.6 13376.4 13473.9 14110.9 14399.9 14415.9 11700.5 12043.0 12101.9 12370.9 12489.3 11818.0 11858.6 12161.0 12232.8 12432.8 11726.6 11781.1 11800.5 11950.4 12460.9 7619.0 7783.8 7899.0 8779.5 8949.8 8641.7 11154.7 11264.3 11735.8 11839.1 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | [#3] mootools.html Cycles:180 Average:6002.35 Median:4837.95 stddev:3376.36 (69.8%) stddev-sans-first:3368.81 13:35:45 INFO - PROCESS | 3444 | Values: 1491.5 1501.2 1671.9 1783.7 1810.7 7555.5 8395.3 8525.7 9121.5 9166.5 8486.0 8845.8 8877.3 8909.6 8951.3 2389.8 2411.6 2431.6 2432.4 2440.1 2401.3 2413.3 2451.6 2456.5 2459.0 2381.6 2397.1 2400.5 2403.9 2409.6 2319.7 2332.5 2334.3 2334.8 2362.4 2307.7 2316.1 2318.5 2327.6 2334.0 8991.0 9012.6 9045.0 9060.3 9073.2 5536.4 5643.4 5673.0 5684.5 5694.8 3484.3 3550.8 3596.9 3618.1 3625.1 1170.3 1188.6 1214.8 1216.7 1233.7 12745.4 12807.4 12928.0 12928.4 12932.8 4694.9 4716.3 4748.5 4764.5 4911.4 9927.9 9988.5 10027.7 10046.6 10083.3 5387.4 5397.4 5408.0 5414.2 5425.2 4378.5 4978.7 5094.4 5126.7 5162.3 3877.7 3924.7 3980.1 4019.8 4070.3 1193.6 1211.1 1217.6 1226.8 1227.4 848.9 851.8 981.3 1016.0 1042.1 6070.3 6208.9 6252.2 6284.5 6373.9 974.2 997.9 1002.3 1003.7 1027.5 4367.5 4462.6 4518.8 4528.9 4633.9 11317.0 11552.7 11606.2 11669.6 11704.4 10595.7 11099.8 11338.3 11549.1 11552.5 8424.7 8490.3 8510.9 8610.5 8617.0 6245.8 6620.2 6633.2 6665.9 6673.7 9546.9 10259.4 10740.4 10748.9 10767.4 9941.2 10164.4 10197.8 10284.0 10289.9 7074.8 7691.1 7919.6 8069.4 8258.1 8787.7 8883.7 8899.7 8925.1 8952.2 7787.1 7875.7 7943.9 8075.1 8103.2 7898.0 7940.9 7941.2 8108.8 8196.7 7320.6 7426.0 7456.9 7483.1 7542.4 5537.6 5552.5 5624.0 5647.1 5699.9 5496.1 5532.9 5631.9 5638.6 5688.8 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | [#4] prototype.html Cycles:180 Average:4928.03 Median:5558.65 stddev:1472.70 (26.5%) stddev-sans-first:1435.79 13:35:45 INFO - PROCESS | 3444 | Values: 328.2 333.2 340.1 343.0 343.7 5458.9 5577.9 5599.2 5776.4 5794.9 5556.3 5561.0 5598.4 5622.9 5622.9 4365.3 4410.5 4412.4 4415.4 4432.4 4111.6 4365.6 4369.8 4428.0 4432.5 4330.0 4330.7 4342.1 4346.8 4356.3 4358.7 4366.0 4366.5 4376.6 4380.4 3743.6 3798.8 3836.9 3839.8 3840.2 5441.5 5449.3 5475.7 5507.5 5546.1 4963.5 4989.8 5000.9 5002.8 5007.2 5677.8 5811.4 5838.2 5928.4 5947.4 4126.8 4138.9 4147.4 4148.7 4149.5 6047.5 6066.0 6082.6 6109.8 6162.6 4150.6 4259.7 4261.4 4268.4 4271.3 4279.5 4294.2 4305.2 4310.2 4329.4 4989.2 4999.1 5006.4 5006.9 5014.9 5686.9 5872.5 5897.8 5936.9 6031.7 1436.2 1442.4 1453.3 1459.0 1462.2 897.1 923.3 925.7 938.0 944.6 4944.4 4974.5 5004.7 5046.9 5059.0 5290.3 5325.3 5333.5 5357.8 5389.0 5100.6 5180.2 5185.2 5361.3 5792.6 3222.2 3241.6 3265.7 3273.4 3295.5 6035.9 6304.9 6357.4 6364.0 6369.5 6110.3 6188.7 6198.2 6209.2 6220.0 6249.7 6318.0 6328.0 6336.6 6348.7 5781.9 6072.9 6122.8 6127.2 6132.3 6031.2 6042.8 6109.2 6110.0 6118.9 6185.3 6242.6 6351.0 6387.9 6408.0 4234.1 4266.9 4280.3 4283.7 4295.6 6177.7 6184.0 6194.1 6196.5 6204.9 5890.3 5899.4 5921.4 5942.5 5990.8 5846.0 5886.6 5923.3 5933.4 5984.6 5599.5 5872.8 5901.3 5915.9 5962.9 5982.0 5991.0 6009.8 6014.4 6073.2 5813.9 5831.3 5883.2 5903.8 5911.5 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - PROCESS | 3444 | [#5] yui.html Cycles:180 Average:21548.41 Median:4002.38 stddev:31572.66 (788.8%) stddev-sans-first:31622.68 13:35:45 INFO - PROCESS | 3444 | Values: 769.8 781.4 816.6 833.7 863.4 14879.9 15312.8 15776.3 15821.3 15936.4 14467.8 14503.6 14630.9 14638.0 14638.5 672.3 807.1 808.1 825.7 828.7 825.0 825.6 827.6 828.7 830.9 867.5 872.5 872.9 872.9 875.4 863.6 871.1 872.3 873.2 874.6 634.2 634.3 634.8 636.0 636.5 14832.0 14867.6 14905.7 14916.3 14923.3 15824.8 15869.4 16021.4 16060.7 16205.4 12208.3 12301.3 12436.2 12483.6 13102.1 3981.5 4000.3 4004.5 4026.2 4156.1 76658.2 77514.2 78248.0 78373.6 80182.0 11769.4 11803.9 11807.8 11881.3 12011.6 23104.5 23315.5 23370.4 23449.3 23450.0 9100.5 9115.1 9279.6 9357.9 9440.8 4893.3 5092.7 5108.7 5167.1 5532.2 3613.4 3725.5 3727.9 3728.0 3728.5 617.7 658.9 662.8 665.7 670.7 714.5 723.2 729.1 743.1 747.7 9068.6 9532.0 9743.6 9817.0 9821.5 613.4 639.4 697.5 721.3 722.9 4514.9 4669.9 4763.9 4780.8 4828.4 120163.0 120848.0 125788.0 126848.0 127614.0 107553.5 108847.0 109311.0 110327.4 110701.0 93302.0 93391.5 95929.0 96405.0 97277.5 8976.0 9125.6 9174.4 10185.5 10199.5 38131.6 39393.2 45514.1 51616.0 53383.7 50968.7 51088.2 60375.7 75822.2 79138.0 13892.5 13995.4 14049.9 14171.9 14315.9 15573.8 15846.4 15931.1 16177.4 16316.6 13791.4 13975.1 14760.6 14857.7 15425.6 14529.9 14568.8 14595.7 14781.1 15169.3 13588.9 13680.5 14313.7 14499.6 14956.6 11712.4 11842.0 12024.8 12091.8 12435.6 11787.8 12271.0 12437.3 12820.8 12938.5 13:35:45 INFO - PROCESS | 3444 | -------- Summary: end -------- 13:35:45 INFO - PROCESS | 3444 | 13:35:45 INFO - TEST-INFO | 3444: exit 0 13:35:45 INFO - TEST-OK | dromaeo_css | took 1112372ms 13:35:45 INFO - TEST-START | kraken 13:35:45 INFO - operating with platform_type : linux_ 13:35:45 INFO - Initialising browser for kraken test... 13:35:45 INFO - TEST-INFO | started process 3689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzoXhCD/profile http://localhost:51287/getInfo.html) 13:35:49 INFO - PROCESS | 3689 | JavaScript error: , line 0: uncaught exception: undefined 13:35:50 INFO - PROCESS | 3689 | __metrics Screen width/height:1600/1200 13:35:50 INFO - PROCESS | 3689 | colorDepth:24 13:35:50 INFO - PROCESS | 3689 | Browser inner width/height: 1024/697 13:35:50 INFO - PROCESS | 3689 | __metrics 13:35:51 ERROR - PROCESS | 3689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:35:52 INFO - TEST-INFO | 3689: exit 0 13:35:52 INFO - Browser initialized. 13:35:52 INFO - Running cycle 1/1 for kraken test... 13:35:52 INFO - TEST-INFO | started process 3809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzoXhCD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:03 INFO - PROCESS | 3809 | RSS: Main: 167936000 13:36:03 INFO - PROCESS | 3809 | 13:36:06 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51287/tests/kraken/driver.html?testName=audio-beat-detection) 13:36:07 INFO - PROCESS | 3809 | RSS: Main: 173756416 13:36:07 INFO - PROCESS | 3809 | 13:36:09 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51287/tests/kraken/driver.html?testName=audio-dft) 13:36:10 INFO - PROCESS | 3809 | RSS: Main: 172683264 13:36:10 INFO - PROCESS | 3809 | 13:36:13 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51287/tests/kraken/driver.html?testName=audio-fft) 13:36:14 INFO - PROCESS | 3809 | RSS: Main: 167743488 13:36:14 INFO - PROCESS | 3809 | 13:36:16 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51287/tests/kraken/driver.html?testName=audio-oscillator) 13:36:16 INFO - PROCESS | 3809 | RSS: Main: 168312832 13:36:16 INFO - PROCESS | 3809 | 13:36:18 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:36:19 INFO - PROCESS | 3809 | RSS: Main: 168783872 13:36:19 INFO - PROCESS | 3809 | 13:36:22 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51287/tests/kraken/driver.html?testName=imaging-darkroom) 13:36:23 INFO - PROCESS | 3809 | RSS: Main: 168296448 13:36:23 INFO - PROCESS | 3809 | 13:36:26 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51287/tests/kraken/driver.html?testName=imaging-desaturate) 13:36:27 INFO - PROCESS | 3809 | RSS: Main: 169451520 13:36:27 INFO - PROCESS | 3809 | 13:36:30 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51287/tests/kraken/driver.html?testName=json-parse-financial) 13:36:30 INFO - PROCESS | 3809 | RSS: Main: 169066496 13:36:30 INFO - PROCESS | 3809 | 13:36:32 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:36:32 INFO - PROCESS | 3809 | RSS: Main: 168865792 13:36:32 INFO - PROCESS | 3809 | 13:36:34 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:36:35 INFO - PROCESS | 3809 | RSS: Main: 169328640 13:36:35 INFO - PROCESS | 3809 | 13:36:37 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:36:38 INFO - PROCESS | 3809 | RSS: Main: 169934848 13:36:38 INFO - PROCESS | 3809 | 13:36:40 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:36:41 INFO - PROCESS | 3809 | RSS: Main: 170160128 13:36:41 INFO - PROCESS | 3809 | 13:36:44 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:36:44 INFO - PROCESS | 3809 | RSS: Main: 169631744 13:36:44 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:51287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51287/tests/kraken/driver.html?testName=ai-astar) 13:36:46 INFO - PROCESS | 3809 | RSS: Main: 170479616 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | __start_tp_report 13:36:46 INFO - PROCESS | 3809 | _x_x_mozilla_page_load 13:36:46 INFO - PROCESS | 3809 | _x_x_mozilla_page_load_details 13:36:46 INFO - PROCESS | 3809 | |i|pagename|runs| 13:36:46 INFO - PROCESS | 3809 | |0;ai-astar;102;111;106;109;111;112;116;113;111;114 13:36:46 INFO - PROCESS | 3809 | |1;audio-beat-detection;147;128;142;170;118;148;149;122;174;117 13:36:46 INFO - PROCESS | 3809 | |2;audio-dft;162;162;163;160;161;165;169;166;160;162 13:36:46 INFO - PROCESS | 3809 | |3;audio-fft;76;74;76;148;76;76;77;76;177;76 13:36:46 INFO - PROCESS | 3809 | |4;audio-oscillator;85;84;149;85;84;83;148;83;84;140 13:36:46 INFO - PROCESS | 3809 | |5;imaging-gaussian-blur;117;117;117;117;118;120;118;118;118;118 13:36:46 INFO - PROCESS | 3809 | |6;imaging-darkroom;147;147;147;148;146;147;146;146;146;148 13:36:46 INFO - PROCESS | 3809 | |7;imaging-desaturate;96;98;98;95;96;96;96;96;96;95 13:36:46 INFO - PROCESS | 3809 | |8;json-parse-financial;53;55;53;55;56;53;54;55;55;52 13:36:46 INFO - PROCESS | 3809 | |9;json-stringify-tinderbox;62;62;65;63;63;63;63;62;63;63 13:36:46 INFO - PROCESS | 3809 | |10;stanford-crypto-aes;86;82;76;82;77;76;78;77;80;78 13:36:46 INFO - PROCESS | 3809 | |11;stanford-crypto-ccm;126;130;138;134;138;127;128;133;170;123 13:36:46 INFO - PROCESS | 3809 | |12;stanford-crypto-pbkdf2;163;161;163;163;161;168;161;161;155;161 13:36:46 INFO - PROCESS | 3809 | |13;stanford-crypto-sha256-iterative;64;68;65;64;65;63;67;64;64;64 13:36:46 INFO - PROCESS | 3809 | __end_tp_report 13:36:46 INFO - PROCESS | 3809 | __start_cc_report 13:36:46 INFO - PROCESS | 3809 | _x_x_mozilla_cycle_collect,861 13:36:46 INFO - PROCESS | 3809 | __end_cc_report 13:36:46 INFO - PROCESS | 3809 | __startTimestamp1468701406694__endTimestamp 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | ------- Summary: start ------- 13:36:46 INFO - PROCESS | 3809 | Number of tests: 14 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:4.03 (3.6%) stddev-sans-first:2.88 13:36:46 INFO - PROCESS | 3809 | Values: 102.0 111.0 106.0 109.0 111.0 112.0 116.0 113.0 111.0 114.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.50 stddev:20.31 (13.8%) stddev-sans-first:21.44 13:36:46 INFO - PROCESS | 3809 | Values: 147.0 128.0 142.0 170.0 118.0 148.0 149.0 122.0 174.0 117.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.87 (1.8%) stddev-sans-first:3.02 13:36:46 INFO - PROCESS | 3809 | Values: 162.0 162.0 163.0 160.0 161.0 165.0 169.0 166.0 160.0 162.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:37.17 (48.9%) stddev-sans-first:38.90 13:36:46 INFO - PROCESS | 3809 | Values: 76.0 74.0 76.0 148.0 76.0 76.0 77.0 76.0 177.0 76.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:29.89 (35.6%) stddev-sans-first:31.02 13:36:46 INFO - PROCESS | 3809 | Values: 85.0 84.0 149.0 85.0 84.0 83.0 148.0 83.0 84.0 140.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 13:36:46 INFO - PROCESS | 3809 | Values: 117.0 117.0 117.0 117.0 118.0 120.0 118.0 118.0 118.0 118.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:36:46 INFO - PROCESS | 3809 | Values: 147.0 147.0 147.0 148.0 146.0 147.0 146.0 146.0 146.0 148.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.09 13:36:46 INFO - PROCESS | 3809 | Values: 96.0 98.0 98.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:1.29 (2.3%) stddev-sans-first:1.30 13:36:46 INFO - PROCESS | 3809 | Values: 53.0 55.0 53.0 55.0 56.0 53.0 54.0 55.0 55.0 52.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 13:36:46 INFO - PROCESS | 3809 | Values: 62.0 62.0 65.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:3.26 (4.1%) stddev-sans-first:2.35 13:36:46 INFO - PROCESS | 3809 | Values: 86.0 82.0 76.0 82.0 77.0 76.0 78.0 77.0 80.0 78.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:133.50 stddev:13.38 (10.0%) stddev-sans-first:13.81 13:36:46 INFO - PROCESS | 3809 | Values: 126.0 130.0 138.0 134.0 138.0 127.0 128.0 133.0 170.0 123.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:3.20 (2.0%) stddev-sans-first:3.36 13:36:46 INFO - PROCESS | 3809 | Values: 163.0 161.0 163.0 163.0 161.0 168.0 161.0 161.0 155.0 161.0 13:36:46 INFO - PROCESS | 3809 | 13:36:46 INFO - PROCESS | 3809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:1.55 (2.4%) stddev-sans-first:1.62 13:36:46 INFO - PROCESS | 3809 | Values: 64.0 68.0 65.0 64.0 65.0 63.0 67.0 64.0 64.0 64.0 13:36:46 INFO - PROCESS | 3809 | -------- Summary: end -------- 13:36:46 INFO - PROCESS | 3809 | 13:36:47 INFO - TEST-INFO | 3809: exit 0 13:36:47 INFO - TEST-OK | kraken | took 61748ms 13:36:47 INFO - SUITE-END | took 1174s 13:36:47 INFO - Completed test suite (00:19:34) 13:36:47 INFO - javascript benchmark 13:36:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7322.1872728249145, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.401661675973, 3080.3839232153573, 3096.5510001049834, 3118.76609254306, 3144.8113113213208, 5388.353397592285, 5392.352917649882, 5428.212909128179, 5469.0, 5545.694986775726, 5302.708351040691, 5392.083345831208, 5397.514223719864, 5469.589780766439, 5502.944970550293, 4896.853094407174, 4965.602751779858, 5011.473795251482, 5012.69923804571, 5053.696778193302, 4920.655554111214, 5040.5967522598285, 5043.823466178685, 5068.366454193226, 5084.110280700881, 685.6154226396441, 4951.628627852908, 4959.82640607577, 5020.7489625518765, 5047.899042019158, 4912.975435122838, 4916.336294600219, 4917.114919314522, 4928.260760885896, 4956.677815941988, 4883.8779030524165, 4887.413510378742, 4906.754662266908, 4906.828261010884, 4935.457099719028, 5201.661891977009, 5276.92084618731, 5295.629305948585, 5371.838844834622, 5428.37573679028, 5707.857303567403, 5710.914336284959, 5711.0, 5747.339056008529, 5789.681567513785, 5774.047282198432, 5788.957987562237, 5800.158976948361, 5800.680962547058, 5805.82582522525, 5309.973450132725, 5354.544863686552, 5398.2982212312545, 5409.864753381157, 5410.48600382963, 5890.116482527569, 5891.852703682356, 5894.6757928314355, 5971.313298970587, 5980.222571065734, 5751.166080918243, 5760.971195143998, 5775.826725198251, 5778.797742079007, 5785.681787501644, 5795.072788353843, 5822.621529600562, 5857.824265272048, 5876.529877609781, 5889.057750759858, 5774.942250577525, 5820.650760954271, 5841.240638716939, 5844.795432159939, 5845.1232315153065, 5641.379448260688, 5780.88438231233, 5822.417758224144, 5860.150278209721, 5870.765169393177, 4338.631216346583, 4376.715513491677, 4444.511103778582, 4475.977620111878, 4483.461984561874, 3948.309045916953, 3959.8416063357145, 3965.385365268388, 3985.661218796377, 3999.7400168988925, 5318.042752304622, 5406.243125962368, 5489.176623506506, 5516.172574113834, 5517.227588137664, 5782.739776710058, 5830.3586605473365, 5843.824685259449, 5847.415258474119, 5877.882442351129, 5431.402545719968, 5474.42518535556, 5477.315335583052, 5495.422980587061, 5515.669059856422, 4738.407699037621, 4785.090832741768, 4786.353842231324, 4882.853514394574, 4943.0, 5886.205362276123, 5930.258717660293, 5933.643981361132, 5956.255468066492, 5973.462388385066, 5672.234248376416, 5675.460831221028, 5676.20533125371, 5678.4605462480995, 5705.058665320175, 5844.736986835687, 5854.531637468907, 5876.41235876409, 5921.319048309328, 5948.613340132878, 5698.772049117989, 5709.25779648643, 5715.799947001835, 5724.79963201286, 5731.942680573141, 5757.798477053283, 5782.392848750821, 5802.796902108406, 5815.563832712479, 5819.6508209507565, 5586.050371436947, 5686.2323586315315, 5728.770849165987, 5729.169270455677, 5736.971315143564, 5698.4016678249845, 5706.372299047184, 5707.7716891325545, 5718.51392631631, 5748.051571490657, 5375.354957405137, 5584.832455026356, 5641.492265696107, 5641.971790141023, 5645.745941432728, 5600.159976003469, 5624.775008999594, 5653.152027195789, 5663.0, 5676.829695109153, 5578.721063946868, 5581.804636837691, 5624.634398764068, 5687.971560142173, 5696.8006119785605], "value": 5305.489648148922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.442712128977, 576.2508738639768, 591.1192323438075, 596.0641792385954, 632.876589065132, 42190.57809421905, 43128.0, 43299.35050974238, 43630.12739745207, 43662.345064824054, 43733.34399984003, 44015.77992110043, 44377.55622443774, 44516.0, 44574.10851782963, 8796.956015219946, 8991.595378207963, 8992.730218093468, 8993.595288212045, 8995.0, 8864.0, 8965.865512017292, 8971.865422018675, 8978.595963181673, 8978.685745998859, 8983.685571005017, 9003.324750643695, 9013.188813006827, 9015.098490150998, 9061.0, 8908.821823563492, 8931.50876701781, 9022.45865248084, 9025.548722563879, 9052.049534798884, 8860.069692682304, 8890.822183556358, 8926.107389261022, 8940.195382415548, 8964.596593153325, 33418.83290583556, 41132.38301425481, 41496.79251603753, 41733.1653366931, 41860.0, 3300.9834950825334, 3452.7755695879687, 3540.291941611688, 3554.5023696682483, 3709.1654377764785, 31158.0, 31539.36921261562, 31729.682703172904, 31863.0, 32064.679353206404, 4156.397322388237, 4204.810783514718, 4246.830126794925, 4278.122984788111, 4442.666799990014, 315501.0, 316626.0, 318126.0, 319981.0, 319997.40001300076, 34369.82815085958, 34388.0, 34618.13454663603, 35354.82322588422, 35416.64583354133, 36579.817100914326, 36687.449688254696, 36700.63299367025, 36764.44853327202, 36854.0, 14848.331825067899, 14889.553313400615, 15025.549233523012, 15030.924845375921, 15040.849591504164, 11923.70190745221, 12047.216930899638, 12077.51689932393, 12078.818817717742, 12103.636890893287, 8212.794680132925, 8235.464694794819, 8262.132476089924, 8323.25090741824, 8329.416940814206, 3226.6934641209045, 3252.3820474109843, 3257.1694217974264, 3264.477683570665, 3319.13702437368, 980.2011360740973, 1050.9737256568494, 1084.9294795838246, 1100.7908497385472, 1159.2812456277163, 33146.66853331484, 33564.832175838965, 35477.645223547435, 36167.81916090403, 36185.276294473966, 1093.294824837975, 1112.4715760013928, 1119.6417146513038, 1161.5702190189684, 1204.873488283735, 15912.984068202628, 16716.24776885043, 16844.24200910962, 16901.0, 17038.82961170397, 562707.0, 568944.0, 569440.0, 570897.0, 571170.0, 54075.188872166946, 55534.72232638811, 55856.88286234334, 55918.440815592134, 56080.15879761725, 1368.8494265630773, 1374.6082366525493, 1378.4417310989065, 1382.5644921849585, 1390.8887289017057, 29753.3526685012, 31120.844395777876, 31131.0, 31360.68639313669, 32012.839935800173, 49838.75080624719, 50255.0, 50625.49374506208, 50932.23601645904, 50951.23573146332, 479994.0, 480091.0, 480727.0, 484221.0, 485044.0, 26869.0, 26928.596071059343, 27166.72833271642, 27494.725052749218, 27525.72474275312, 46834.76582617065, 46847.76576117097, 47140.0, 47564.762176188895, 47713.5228647723, 40409.797951010056, 40429.0, 40807.795961020005, 40847.591524084375, 40961.38557921574, 39834.0, 39923.40114898221, 40082.799586001885, 40249.0, 41434.1713165741, 39282.803585981885, 39645.40531892081, 40357.1928561433, 40573.594264056985, 40624.79687601661, 32680.50979235361, 35566.64433355633, 35797.64202357943, 36183.819080904424, 36493.0, 26818.59772103459, 27054.864725676245, 27269.318267043484, 27418.31454213581, 27623.861880690467], "value": 18564.373428236897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.24104478356776, 395.16028439565923, 398.9082511022465, 400.3274498841946, 422.7505771594758, 14422.423103075864, 18801.529961750944, 18804.43586692398, 20427.387178384633, 20431.795682043175, 19630.0, 19994.0, 20095.196192152333, 20857.895710521465, 20903.0, 5658.207850900877, 5736.741846616891, 5795.4784069433745, 5813.418658134195, 5830.621009634381, 5578.246936663539, 5704.48659620634, 5719.25649665545, 5742.7415766290405, 5750.482456578907, 5556.055470569992, 5627.7186140693, 5749.281339832521, 5753.309602847664, 5753.453421924911, 5652.689102099363, 5670.432956704338, 5690.40250773667, 5692.459216374438, 5712.828615141531, 4958.9008219835405, 5021.17150670139, 5051.621128415383, 5058.822941197041, 5067.8986420271385, 17462.30150793967, 21614.243501477373, 23868.283951481484, 24048.879755601283, 24365.756342436704, 2174.695542624034, 2405.5549723301247, 2425.417899704076, 2452.264320703782, 2526.660869739041, 10531.947340263327, 10532.42071686057, 10589.629362972259, 10774.5690172393, 10832.72918177044, 1946.746922900028, 1950.4733721895009, 2016.536196674773, 2034.3998520436508, 2046.1815273890413, 89102.0, 90350.09649903483, 90695.0, 91745.62381564348, 92817.53591232, 10963.232573719923, 11164.162687798447, 11168.888311116785, 11280.492377843017, 11352.14858885587, 15251.542453726406, 15378.384864605514, 15500.30248638814, 15523.37906483728, 15538.844611553966, 7928.563928983961, 8203.466774659628, 8221.301189398848, 8289.8342033159, 8350.4154709171, 8053.395995300376, 8114.594270286462, 8184.345252379795, 8289.502629842229, 8334.291585215204, 4334.956650433455, 4361.236783562864, 4426.84506042287, 4511.593956543927, 4767.880802979884, 1942.9708554371696, 1974.4993804708238, 2022.797720227995, 2049.5900819835792, 2107.599556084339, 922.0134456131874, 985.1478471122427, 1005.6178652112151, 1010.7321559786662, 1032.5456799008412, 19471.610567788564, 20389.286374976804, 20405.795942040688, 20406.387808365773, 20450.897745511178, 994.5623925472769, 997.7505623594102, 1058.867641544807, 1060.6340812419703, 1098.2477003252798, 10818.891811081945, 11185.66443006711, 11348.886511134948, 11414.714632134263, 11432.828507572392, 399195.0, 402821.0, 449535.0, 514278.0, 537252.0, 105520.47239763905, 106056.0, 106681.46659266653, 106964.46517767361, 107378.3893241602, 1021.7649940513575, 1060.3796778884284, 1063.8244689626124, 1066.893310668927, 1072.7908057928785, 17731.64536709233, 18128.365507207185, 18485.168167432766, 18612.627747444705, 19031.42905712831, 31104.22239444032, 34373.140671483416, 44880.0, 45143.548564513934, 45385.773071134434, 64131.3586864144, 64978.67510662416, 65209.34790652033, 67137.66431167813, 67429.66285168543, 5626.409227031267, 7546.358559522502, 7754.573498457414, 8637.827243455222, 8857.64569417216, 13376.398062087035, 13473.86526134726, 14110.858891411364, 14399.92800035993, 14415.927920360331, 11700.531978720755, 12043.0, 12101.939490302491, 12370.876291237333, 12489.31308778026, 11818.0, 11858.584949526725, 12161.0, 12232.816507752568, 12432.751344972869, 11726.648200553997, 11781.116416268642, 11800.468978896142, 11950.402479876146, 12460.937695311466, 7618.961905190438, 7783.766487005399, 7898.960505197667, 8779.517126558101, 8949.821003580022, 8641.654333826827, 11154.665360039211, 11264.267822591506, 11735.76528469443, 11839.05287577009], "value": 9348.314110623814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.5376233367656, 1501.151849205199, 1671.8746094042942, 1783.6611043901667, 1810.7464954906307, 7555.546667199972, 8395.328373730103, 8525.701600443987, 9121.452712837226, 9166.54167291636, 8485.957570212156, 8845.823083538326, 8877.334199934998, 8909.554522273893, 8951.283897288218, 2389.8327117101853, 2411.553862535428, 2431.598786200275, 2432.404061005056, 2440.1093600835657, 2401.3036219496325, 2413.2760171948435, 2451.595486744694, 2456.508698260346, 2458.9754102458924, 2381.5594115088766, 2397.1130681647815, 2400.519896020794, 2403.939901502468, 2409.5662780699467, 2319.6752454656275, 2332.521833024226, 2334.3347146063375, 2334.754850740682, 2362.4330160761465, 2307.653851922208, 2316.108298305148, 2318.4783423729696, 2327.6392159215347, 2334.043042352644, 8991.0, 9012.63949442028, 9044.954775226082, 9060.320475964263, 9073.228775554086, 5536.363318218376, 5643.407442218549, 5673.0, 5684.516816070639, 5694.8325593253285, 3484.285721427101, 3550.822458877046, 3596.9280614387567, 3618.0773902654655, 3625.075605720551, 1170.3387586013876, 1188.5780547905542, 1214.7570485902766, 1216.7201543644924, 1233.722412457199, 12745.36273186337, 12807.359632018362, 12928.030397720115, 12928.353582320846, 12932.806007909889, 4694.859154225379, 4716.316134160596, 4748.477667456577, 4764.472766313199, 4911.435184953776, 9927.900720992842, 9988.450635214987, 10027.699169024942, 10046.598136074475, 10083.294169408218, 5387.4073851876265, 5397.379301380313, 5407.972960135253, 5414.160805075219, 5425.240466334716, 4378.4745830499905, 4978.6763860348965, 5094.4141423736, 5126.666766660155, 5162.328897243409, 3877.689784817208, 3924.6860251179837, 3980.124372638015, 4019.8191081401405, 4070.3080476319096, 1193.6478738772082, 1211.1279878487476, 1217.5799349224503, 1226.7730469863104, 1227.3863068465766, 848.868425394065, 851.8296340731879, 981.2787601113176, 1015.9796804063877, 1042.11940909931, 6070.332263451017, 6208.937910620836, 6252.237203197702, 6284.528660350492, 6373.936260637427, 974.1962880623372, 997.8702768640176, 1002.2783595811004, 1003.7039073473343, 1027.5170669785339, 4367.519572846984, 4462.576055274743, 4518.751468669189, 4528.932066019012, 4633.86098417048, 11317.0, 11552.711182220512, 11606.24559403636, 11669.649910502698, 11704.414779261004, 10595.682129536126, 11099.778004439866, 11338.263012904135, 11549.076073914066, 11552.537898484135, 8424.663013479514, 8490.320774338039, 8510.872336914952, 8610.483370997761, 8617.0, 6245.750169993149, 6620.172478440195, 6633.2371777246235, 6665.933340666531, 6673.666316684244, 9546.90453095488, 10259.384436933808, 10740.355578665305, 10748.892511075102, 10767.3539587625, 9941.155001824925, 10164.390136591828, 10197.847032294374, 10284.0, 10289.9485502572, 7074.752383666753, 7691.077070751546, 7919.643616037177, 8069.435139540175, 8258.132896046069, 8787.736367908972, 8883.689070882747, 8899.688510902088, 8925.107489251022, 8952.23905967974, 7787.10448298453, 7875.684972601261, 7943.880841787493, 8075.071366792659, 8103.230193131643, 7898.0, 7940.880886786587, 7941.205879412013, 8108.837823243384, 8196.67213311461, 7320.597367144645, 7426.034615499951, 7456.850862982818, 7483.064616922885, 7542.396608271435, 5537.643277397064, 5552.500274975271, 5623.971880140737, 5647.124695672177, 5699.886002279848, 5496.065668836228, 5532.873926231666, 5631.8592035199445, 5638.5771067170945, 5688.800891968761], "value": 4808.064919497812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.22047636862453, 333.2468620916728, 340.119091552878, 342.9691327780499, 343.7061312577744, 5458.890822183554, 5577.932137324466, 5599.216109744634, 5776.39347868474, 5794.884102317957, 5556.333240011204, 5560.972195139018, 5598.440155984399, 5622.91565626516, 5622.943770562293, 4365.279728844736, 4410.536893626155, 4412.426384570002, 4415.359772832937, 4432.3573081903105, 4111.588841115894, 4365.585269399402, 4369.803358848843, 4428.0, 4432.512423633414, 4330.02574420756, 4330.675199360045, 4342.066455712022, 4346.782660866944, 4356.281213599752, 4358.673099517533, 4366.0134638739455, 4366.476022877243, 4376.6498680105515, 4380.430544029287, 3743.569489508714, 3798.753081049723, 3836.9424458633143, 3839.7904660032, 3840.2127563849344, 5441.537469315113, 5449.291592093003, 5475.67145971239, 5507.531859791922, 5546.057170281021, 4963.478834722375, 4989.750512474398, 5000.924986125211, 5002.849914502571, 5007.173816320303, 5677.829665110054, 5811.360750317462, 5838.2118414013985, 5928.377520360386, 5947.37552556984, 4126.773027483518, 4138.8551400700835, 4147.398627199039, 4148.709590328648, 4149.502059752819, 6047.455728984412, 6066.0, 6082.574219804571, 6109.847253818646, 6162.599431036968, 4150.626443620089, 4259.659227261874, 4261.446012018418, 4268.40242366069, 4271.295236286041, 4279.486461624625, 4294.162638285567, 4305.203537345538, 4310.181065597527, 4329.372241025097, 4989.17678583037, 4999.125153098194, 5006.424261210008, 5006.949930500721, 5014.924776128361, 5686.886262274731, 5872.500837428866, 5897.76408943646, 5936.881262374728, 6031.668258245839, 1436.18137661534, 1442.4158215922569, 1453.280626090071, 1458.9927050364681, 1462.232328027794, 897.1477096758106, 923.3029063057348, 925.6852670092201, 937.9718608441758, 944.617429940875, 4944.3572335596145, 4974.502549744997, 5004.7469145055275, 5046.924296135561, 5058.974705126451, 5290.312259406252, 5325.307709997753, 5333.5199832015305, 5357.785688572491, 5388.973055134699, 5100.628207883352, 5180.222966554971, 5185.248139019821, 5361.329833770778, 5792.623479473821, 3222.2105584132037, 3241.5623890774914, 3265.6734326567152, 3273.3780581689402, 3295.467607562495, 6035.921679943261, 6304.873902522016, 6357.396047375492, 6364.0, 6369.5222858285815, 6110.327863934964, 6188.659623720739, 6198.194234749544, 6209.223847019122, 6220.0, 6249.7187626556915, 6317.9684101580115, 6327.955887278639, 6336.578247746257, 6348.714307856158, 5781.913271301018, 6072.939270607238, 6122.785702500391, 6127.20346354971, 6132.332435390441, 6031.24609423822, 6042.818715438544, 6109.175261339662, 6110.0, 6118.868009418272, 6185.319614842454, 6242.625442473284, 6351.0, 6387.914054610635, 6408.0, 4234.1108367241995, 4266.914661706811, 4280.250956082736, 4283.74297542136, 4295.634871035997, 6177.683368736723, 6184.0, 6194.0708893666315, 6196.47329976939, 6204.937950620436, 5890.3226128994, 5899.380565040609, 5921.378255283305, 5942.465178133989, 5990.7903223386975, 5845.970770146122, 5886.646801191942, 5923.348431672599, 5933.436323549256, 5984.640921544721, 5599.524040456444, 5872.765089396376, 5901.3213480450295, 5915.911261330997, 5962.850928726816, 5981.970090149695, 5990.9700451497465, 6009.849753756191, 6014.398560144125, 6073.178046586095, 5813.883722325614, 5831.300243970581, 5883.176355310175, 5903.822885313448, 5911.467967882912], "value": 4449.483816646767, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.8267889724809, 781.3788038509384, 816.5672193737321, 833.691534132371, 863.4473936680523, 14879.925600371997, 15312.846871531281, 15776.290066946985, 15821.288042038108, 15936.362545498196, 14467.78298325526, 14503.637409064779, 14630.926845365784, 14638.048526845774, 14638.48765293215, 672.2773019004566, 807.0758980966804, 808.0989696488432, 825.7110011495959, 828.6975254032295, 825.0305890578546, 825.6078362777663, 827.6275675945849, 828.718235799828, 830.9127541608135, 867.5055218525443, 872.520113937332, 872.8559787635032, 872.8865247517846, 875.3566128895256, 863.6459051788736, 871.1332224436662, 872.2672954718035, 873.2271939333672, 874.5539774714878, 634.2040738872686, 634.337117711992, 634.7651368993502, 635.965021923794, 636.4908073541148, 14832.0, 14867.553973380816, 14905.70188596222, 14916.328765205591, 14923.328450219766, 15824.76262856058, 15869.444569440015, 16021.359145634277, 16060.678786424323, 16205.432809851716, 12208.267503949792, 12301.261924284572, 12436.191647542972, 12483.563075292412, 13102.148360356547, 3981.5023122109737, 4000.2799496090693, 4004.4794176756836, 4026.2148880968225, 4156.106437116035, 76658.23341766623, 77514.22485775183, 78248.0, 78373.60813195897, 80182.0, 11769.352685602375, 11803.940980295043, 11807.76384472323, 11881.346525940984, 12011.579594714143, 23104.53790924172, 23315.533689326458, 23370.415739606306, 23449.296521104396, 23450.0, 9100.499472528942, 9115.088491150831, 9279.621468108793, 9357.90642093584, 9440.811183776286, 4893.266010098514, 5092.694438333712, 5108.744562771846, 5167.147420675622, 5532.197831314437, 3613.4218525035867, 3725.4970578972034, 3727.9254414912093, 3727.981360093182, 3728.515293011891, 617.7251123250111, 658.8748137853793, 662.7680311890799, 665.710415969055, 670.7317073170673, 714.4605822603901, 723.1900271695735, 729.1323325242944, 743.0748717846316, 747.689708770854, 9068.591913363915, 9531.952340238255, 9743.561539730586, 9817.0, 9821.508924553744, 613.420317799675, 639.414935334164, 697.5431092634333, 721.2679130682361, 722.8807246804323, 4514.887127821765, 4669.906601868011, 4763.880902977453, 4780.784864681098, 4828.396450443694, 120163.0, 120848.0, 125788.0, 126848.0, 127614.0, 107553.46223268834, 108847.0, 109310.99999999841, 110327.44836275767, 110701.0, 93302.0, 93391.53304233435, 95929.04070959201, 96405.0, 97277.5136124329, 8976.0, 9125.634974600942, 9174.357794954556, 10185.541650625592, 10199.541020654236, 38131.618683812805, 39393.21213575655, 45514.089718204785, 51616.0, 53383.73308133434, 50968.74515627398, 51088.23367649563, 60375.698121509115, 75822.24177758372, 79138.0, 13892.474618846774, 13995.440182392591, 14049.859501404855, 14171.929140354232, 14315.928420357832, 15573.766393504333, 15846.44537441184, 15931.123788191297, 16177.352905883632, 16316.592085197964, 13791.448342066205, 13975.09161904473, 14760.557183284518, 14857.702845943237, 15425.614359641098, 14529.854701453272, 14568.781468277772, 14595.708085838436, 14781.113133212042, 15169.317380717674, 13588.864111359155, 13680.452781889011, 14313.713725725636, 14499.565013049625, 14956.637692120168, 11712.355820429959, 11841.96830841057, 12024.819627705767, 12091.818622720843, 12435.626931192079, 11787.823182652439, 12271.0, 12437.315947622968, 12820.807687884875, 12938.482460701844], "value": 7823.240915304945, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 109.0, 111.0, 112.0, 116.0, 113.0, 111.0, 114.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 128.0, 142.0, 170.0, 118.0, 148.0, 149.0, 122.0, 174.0, 117.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 160.0, 161.0, 165.0, 169.0, 166.0, 160.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 148.0, 76.0, 76.0, 77.0, 76.0, 177.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 149.0, 85.0, 84.0, 83.0, 148.0, 83.0, 84.0, 140.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 120.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 98.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 55.0, 56.0, 53.0, 54.0, 55.0, 55.0, 52.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 76.0, 82.0, 77.0, 76.0, 78.0, 77.0, 80.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 138.0, 134.0, 138.0, 127.0, 128.0, 133.0, 170.0, 123.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 161.0, 168.0, 161.0, 161.0, 155.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 65.0, 64.0, 65.0, 63.0, 67.0, 64.0, 64.0, 64.0], "value": 64.8, "unit": "score"}]}]} 13:36:47 INFO - Return code: 0 13:36:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:36:47 ERROR - # TBPL SUCCESS # 13:36:47 INFO - Running post-action listener: _resource_record_post_action 13:36:47 INFO - ##### 13:36:47 INFO - ##### Finished run-tests step (success) 13:36:47 INFO - ##### 13:36:47 INFO - Running post-run listener: _resource_record_post_run 13:36:48 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7651328; Write bytes: 373243904; Read time: 1320; Write time: 318964 13:36:48 INFO - TinderboxPrint: CPU usage
13.3% 13:36:48 INFO - TinderboxPrint: I/O read bytes / time
7,651,328 / 1,320 13:36:48 INFO - TinderboxPrint: I/O write bytes / time
373,243,904 / 318,964 13:36:48 INFO - TinderboxPrint: CPU idle
8,244.8 (86.7%) 13:36:48 INFO - TinderboxPrint: CPU user
1,211.5 (12.7%) 13:36:48 INFO - TinderboxPrint: Swap in / out
0 / 0 13:36:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 64294912; Read time: 28; Write time: 26588 13:36:48 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 5591040; Write bytes: 259747840; Read time: 1000; Write time: 221304 13:36:48 INFO - Running post-run listener: _upload_blobber_files 13:36:48 INFO - Blob upload gear active. 13:36:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:36:48 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 13:36:48 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:36:48 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:36:49 INFO - (blobuploader) - INFO - Open directory for files ... 13:36:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:36:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:36:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:49 INFO - (blobuploader) - INFO - Done attempting. 13:36:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:36:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:50 INFO - (blobuploader) - INFO - Done attempting. 13:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:53 INFO - (blobuploader) - INFO - Done attempting. 13:36:53 INFO - (blobuploader) - INFO - Iteration through files over. 13:36:53 INFO - Return code: 0 13:36:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:36:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:36:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ded8bd7782b8aed6d13b4bb103dedae3049e44cf3c530871402258b728097ed7c74721c41d7720be1e8a32fde5f492fb3a9e643fc525840071b2d1a593e65f13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50a33d271e0cd3bef83a945de3cfa0ea8c24f62c64333516a36e1ab4ece319c8c351331b548a34950c2555bb319741b90afbd142f0d6deab4caa614b4dd41766", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd208ab3ccc51d58c9f8ebe96e83664aa2c2696864701669dc15654a04b4d9f10491e555754cd1b83aea1f0c78fc1b901efc5ee80541df6cb7e0dc4c1adff802"} 13:36:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:36:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:36:53 INFO - Contents: 13:36:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ded8bd7782b8aed6d13b4bb103dedae3049e44cf3c530871402258b728097ed7c74721c41d7720be1e8a32fde5f492fb3a9e643fc525840071b2d1a593e65f13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50a33d271e0cd3bef83a945de3cfa0ea8c24f62c64333516a36e1ab4ece319c8c351331b548a34950c2555bb319741b90afbd142f0d6deab4caa614b4dd41766", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd208ab3ccc51d58c9f8ebe96e83664aa2c2696864701669dc15654a04b4d9f10491e555754cd1b83aea1f0c78fc1b901efc5ee80541df6cb7e0dc4c1adff802"} 13:36:53 INFO - Running post-run listener: copy_logs_to_upload_dir 13:36:53 INFO - Copying logs to upload dir... 13:36:53 INFO - mkdir: /builds/slave/test/build/upload/logs 13:36:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.372869 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-16 13:36:53.746699) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 13:36:53.750487) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306 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/Mozilla-Inbound/sha512/ded8bd7782b8aed6d13b4bb103dedae3049e44cf3c530871402258b728097ed7c74721c41d7720be1e8a32fde5f492fb3a9e643fc525840071b2d1a593e65f13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50a33d271e0cd3bef83a945de3cfa0ea8c24f62c64333516a36e1ab4ece319c8c351331b548a34950c2555bb319741b90afbd142f0d6deab4caa614b4dd41766", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd208ab3ccc51d58c9f8ebe96e83664aa2c2696864701669dc15654a04b4d9f10491e555754cd1b83aea1f0c78fc1b901efc5ee80541df6cb7e0dc4c1adff802"} build_url:https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/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/Mozilla-Inbound/sha512/ded8bd7782b8aed6d13b4bb103dedae3049e44cf3c530871402258b728097ed7c74721c41d7720be1e8a32fde5f492fb3a9e643fc525840071b2d1a593e65f13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50a33d271e0cd3bef83a945de3cfa0ea8c24f62c64333516a36e1ab4ece319c8c351331b548a34950c2555bb319741b90afbd142f0d6deab4caa614b4dd41766", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fd208ab3ccc51d58c9f8ebe96e83664aa2c2696864701669dc15654a04b4d9f10491e555754cd1b83aea1f0c78fc1b901efc5ee80541df6cb7e0dc4c1adff802"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 13:36:53.777673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:36:53.778220) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1468686968.271584-521468306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:36:53.864195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 13:36:53.864774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 13:36:53.865380) ========= ========= Total master_lag: 0.16 =========