builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1468901197.49 results: success (0) buildid: 20160718191319 builduid: b653080b3371414e9be74419378d9497 revision: c2c393c85d041b196936a0dd53aff0db1c58d516 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.494769) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.495348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.495652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.510285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.510576) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 21:06:37-- 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% 70.4M=0s 2016-07-18 21:06:37 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.654268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.654591) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.704418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:37.704765) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c2c393c85d041b196936a0dd53aff0db1c58d516 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c2c393c85d041b196936a0dd53aff0db1c58d516 --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=a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 21:06:38,074 truncating revision to first 12 chars 2016-07-18 21:06:38,074 Setting DEBUG logging. 2016-07-18 21:06:38,074 attempt 1/10 2016-07-18 21:06:38,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c2c393c85d04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 21:06:38,455 unpacking tar archive at: autoland-c2c393c85d04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:38.423481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:38.423813) ========= script_repo_revision: c2c393c85d041b196936a0dd53aff0db1c58d516 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:38.424260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:38.424522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 21:06:38.434338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-18 21:06:38.434616) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:06:38 INFO - MultiFileLogger online at 20160718 21:06:38 in /builds/slave/test 21:06:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 21:06:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:06:38 INFO - {'append_to_log': False, 21:06:38 INFO - 'base_work_dir': '/builds/slave/test', 21:06:38 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 21:06:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:06:38 INFO - 'branch': 'Autoland-Non-PGO', 21:06:38 INFO - 'buildbot_json_path': 'buildprops.json', 21:06:38 INFO - 'config_files': ('talos/linux_config.py',), 21:06:38 INFO - 'default_actions': ('clobber', 21:06:38 INFO - 'read-buildbot-config', 21:06:38 INFO - 'download-and-extract', 21:06:38 INFO - 'populate-webroot', 21:06:38 INFO - 'create-virtualenv', 21:06:38 INFO - 'install', 21:06:38 INFO - 'run-tests'), 21:06:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:06:38 INFO - 'download_minidump_stackwalk': True, 21:06:38 INFO - 'download_symbols': 'ondemand', 21:06:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:06:38 INFO - 'tooltool.py': '/tools/tooltool.py', 21:06:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:06:38 INFO - '/tools/misc-python/virtualenv.py')}, 21:06:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:06:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:06:38 INFO - 'installer_path': 'installer.exe', 21:06:38 INFO - 'log_level': 'info', 21:06:38 INFO - 'log_name': 'talos', 21:06:38 INFO - 'log_to_console': True, 21:06:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:06:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:06:38 INFO - 'opt_config_files': (), 21:06:38 INFO - 'pip_index': False, 21:06:38 INFO - 'sps_profile': False, 21:06:38 INFO - 'sps_profile_interval': 0, 21:06:38 INFO - 'suite': 'dromaeojs-e10s', 21:06:38 INFO - 'system_bits': '32', 21:06:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:06:38 INFO - 'title': 'talos-linux64-ix-002', 21:06:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:06:38 INFO - 'use_talos_json': True, 21:06:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:06:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:06:38 INFO - 'work_dir': 'build'} 21:06:38 INFO - ##### 21:06:38 INFO - ##### Running clobber step. 21:06:38 INFO - ##### 21:06:38 INFO - Running pre-action listener: _resource_record_pre_action 21:06:38 INFO - Running main action method: clobber 21:06:38 INFO - rmtree: /builds/slave/test/build 21:06:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:06:39 INFO - Running post-action listener: _resource_record_post_action 21:06:39 INFO - ##### 21:06:39 INFO - ##### Finished clobber step (success) 21:06:39 INFO - ##### 21:06:39 INFO - ##### 21:06:39 INFO - ##### Running read-buildbot-config step. 21:06:39 INFO - ##### 21:06:39 INFO - Running pre-action listener: _resource_record_pre_action 21:06:39 INFO - Running main action method: read_buildbot_config 21:06:39 INFO - Using buildbot properties: 21:06:39 INFO - { 21:06:39 INFO - "project": "", 21:06:39 INFO - "product": "firefox", 21:06:39 INFO - "script_repo_revision": "production", 21:06:39 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:06:39 INFO - "repository": "", 21:06:39 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 21:06:39 INFO - "buildid": "20160718191319", 21:06:39 INFO - "pgo_build": "False", 21:06:39 INFO - "basedir": "/builds/slave/test", 21:06:39 INFO - "buildnumber": 80, 21:06:39 INFO - "slavename": "talos-linux64-ix-002", 21:06:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:06:39 INFO - "platform": "ubuntu64_hw", 21:06:39 INFO - "scheduler": "tests-autoland-linux64-talos", 21:06:39 INFO - "branch": "autoland", 21:06:39 INFO - "repo_path": "integration/autoland", 21:06:39 INFO - "revision": "c2c393c85d041b196936a0dd53aff0db1c58d516", 21:06:39 INFO - "stage_platform": "linux64", 21:06:39 INFO - "builduid": "b653080b3371414e9be74419378d9497", 21:06:39 INFO - "slavebuilddir": "test" 21:06:39 INFO - } 21:06:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:06:39 INFO - Running post-action listener: _resource_record_post_action 21:06:39 INFO - ##### 21:06:39 INFO - ##### Finished read-buildbot-config step (success) 21:06:39 INFO - ##### 21:06:39 INFO - ##### 21:06:39 INFO - ##### Running download-and-extract step. 21:06:39 INFO - ##### 21:06:39 INFO - Running pre-action listener: _resource_record_pre_action 21:06:39 INFO - Running main action method: download_and_extract 21:06:39 INFO - mkdir: /builds/slave/test/build/tests 21:06: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')]} 21:06:39 INFO - https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:06:40 INFO - Downloaded 1361 bytes. 21:06:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:06:40 INFO - Using the following test package requirements: 21:06:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:06:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:06:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:06:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'jsshell-linux-x86_64.zip'], 21:06:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:06:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:06:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:06:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:06:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:06:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:06:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:06:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:40 INFO - https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:06:41 INFO - Downloaded 22765083 bytes. 21:06:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:06:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:06:42 INFO - Return code: 0 21:06:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:42 INFO - https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:06:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:06:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:06:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:06:43 INFO - Downloaded 22765083 bytes. 21:06:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:06:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:06:44 INFO - Return code: 0 21:06: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')]} 21:06:44 INFO - https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:06:45 INFO - Downloaded 14403317 bytes. 21:06:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:06:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:06:46 INFO - Return code: 0 21:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:46 INFO - https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:06:47 INFO - Downloaded 57135189 bytes. 21:06:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:06:47 INFO - mkdir: /builds/slave/test/properties 21:06:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:06:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:06:47 INFO - Contents: 21:06:47 INFO - build_url:https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:06:48 INFO - Running post-action listener: _resource_record_post_action 21:06:48 INFO - Running post-action listener: set_extra_try_arguments 21:06:48 INFO - ##### 21:06:48 INFO - ##### Finished download-and-extract step (success) 21:06:48 INFO - ##### 21:06:48 INFO - ##### 21:06:48 INFO - ##### Running populate-webroot step. 21:06:48 INFO - ##### 21:06:48 INFO - Running pre-action listener: _resource_record_pre_action 21:06:48 INFO - Running main action method: populate_webroot 21:06:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:06:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:06:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:06:48 INFO - '--tppagecycles', 21:06:48 INFO - '7'], 21:06:48 INFO - 'tests': ['tsvgm']}}, 21:06:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:06:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:06:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:06:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:06:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:06:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:06:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['damp', 'tps']}, 21:06:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'tests': ['damp', 'tps']}, 21:06:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['dromaeo_dom']}, 21:06:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:06:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['basic_compositor_video']}, 21:06:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:06:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['a11yr', 21:06:48 INFO - 'ts_paint', 21:06:48 INFO - 'tpaint', 21:06:48 INFO - 'sessionrestore', 21:06:48 INFO - 'sessionrestore_no_auto_restore', 21:06:48 INFO - 'tabpaint']}, 21:06:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:06:48 INFO - 'ts_paint', 21:06:48 INFO - 'tpaint', 21:06:48 INFO - 'sessionrestore', 21:06:48 INFO - 'sessionrestore_no_auto_restore', 21:06:48 INFO - 'tabpaint']}, 21:06:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:06:48 INFO - 'ts_paint', 21:06:48 INFO - 'tpaint', 21:06:48 INFO - 'sessionrestore', 21:06:48 INFO - 'sessionrestore_no_auto_restore', 21:06:48 INFO - 'tabpaint']}, 21:06:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:06:48 INFO - 'ts_paint', 21:06:48 INFO - 'tpaint', 21:06:48 INFO - 'sessionrestore', 21:06:48 INFO - 'sessionrestore_no_auto_restore', 21:06:48 INFO - 'tabpaint']}, 21:06:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['a11yr', 21:06:48 INFO - 'ts_paint', 21:06:48 INFO - 'tpaint', 21:06:48 INFO - 'sessionrestore', 21:06:48 INFO - 'sessionrestore_no_auto_restore', 21:06:48 INFO - 'tabpaint']}, 21:06:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['a11yr', 21:06:48 INFO - 'ts_paint', 21:06:48 INFO - 'tpaint', 21:06:48 INFO - 'sessionrestore', 21:06:48 INFO - 'sessionrestore_no_auto_restore', 21:06:48 INFO - 'tabpaint']}, 21:06:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['tsvgx', 21:06:48 INFO - 'tsvgr_opacity', 21:06:48 INFO - 'tart', 21:06:48 INFO - 'tscrollx', 21:06:48 INFO - 'cart']}, 21:06:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:06:48 INFO - 'tsvgr_opacity', 21:06:48 INFO - 'tart', 21:06:48 INFO - 'tscrollx', 21:06:48 INFO - 'cart']}, 21:06:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'talos_options': ['--disable-e10s'], 21:06:48 INFO - 'tests': ['tp5o']}, 21:06:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'tests': ['tp5o']}, 21:06:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'talos_options': ['--disable-e10s', 21:06:48 INFO - '--xperf_path', 21:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:06:48 INFO - 'tests': ['tp5n']}, 21:06:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:48 INFO - 'talos_options': ['--xperf_path', 21:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:06:48 INFO - 'tests': ['tp5n']}}, 21:06:48 INFO - 'talos.zip': {'path': '', 21:06:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:06:48 INFO - Running post-action listener: _resource_record_post_action 21:06:48 INFO - ##### 21:06:48 INFO - ##### Finished populate-webroot step (success) 21:06:48 INFO - ##### 21:06:48 INFO - ##### 21:06:48 INFO - ##### Running create-virtualenv step. 21:06:48 INFO - ##### 21:06:48 INFO - Running pre-action listener: _resource_record_pre_action 21:06:48 INFO - Running main action method: create_virtualenv 21:06:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:06:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:06:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:06:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:06:48 INFO - Using real prefix '/usr' 21:06:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:06:48 INFO - Installing distribute.............................................................................................................................................................................................done. 21:06:50 INFO - Installing pip.................done. 21:06:50 INFO - Return code: 0 21:06:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:50 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:06:50 INFO - Using env: {'DISPLAY': ':0', 21:06:50 INFO - 'HOME': '/home/cltbld', 21:06:50 INFO - 'LANG': 'en_US.UTF-8', 21:06:50 INFO - 'LANGUAGE': 'en_US:en', 21:06:50 INFO - 'LOGNAME': 'cltbld', 21:06:50 INFO - 'MAIL': '/var/mail/cltbld', 21:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:50 INFO - 'MOZ_NO_REMOTE': '1', 21:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:50 INFO - 'NO_EM_RESTART': '1', 21:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:50 INFO - 'PWD': '/builds/slave/test', 21:06:50 INFO - 'SHELL': '/bin/bash', 21:06:50 INFO - 'SHLVL': '1', 21:06:50 INFO - 'TERM': 'linux', 21:06:50 INFO - 'TMOUT': '86400', 21:06:50 INFO - 'USER': 'cltbld', 21:06:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:50 INFO - '_': '/tools/buildbot/bin/python'} 21:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:06:51 INFO - Cleaning up... 21:06:51 INFO - Return code: 0 21:06:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:06: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')]} 21:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06: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')]} 21:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:51 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:06:51 INFO - Using env: {'DISPLAY': ':0', 21:06:51 INFO - 'HOME': '/home/cltbld', 21:06:51 INFO - 'LANG': 'en_US.UTF-8', 21:06:51 INFO - 'LANGUAGE': 'en_US:en', 21:06:51 INFO - 'LOGNAME': 'cltbld', 21:06:51 INFO - 'MAIL': '/var/mail/cltbld', 21:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:51 INFO - 'MOZ_NO_REMOTE': '1', 21:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:51 INFO - 'NO_EM_RESTART': '1', 21:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:51 INFO - 'PWD': '/builds/slave/test', 21:06:51 INFO - 'SHELL': '/bin/bash', 21:06:51 INFO - 'SHLVL': '1', 21:06:51 INFO - 'TERM': 'linux', 21:06:51 INFO - 'TMOUT': '86400', 21:06:51 INFO - 'USER': 'cltbld', 21:06:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:51 INFO - '_': '/tools/buildbot/bin/python'} 21:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:51 INFO - Downloading/unpacking psutil>=3.1.1 21:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:06:53 INFO - Installing collected packages: psutil 21:06:53 INFO - Running setup.py install for psutil 21:06:53 INFO - building 'psutil._psutil_linux' extension 21:06:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:06:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:06:53 INFO - building 'psutil._psutil_posix' extension 21:06:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:06:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:06:53 INFO - Successfully installed psutil 21:06:53 INFO - Cleaning up... 21:06:53 INFO - Return code: 0 21:06:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:53 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:06:53 INFO - Using env: {'DISPLAY': ':0', 21:06:53 INFO - 'HOME': '/home/cltbld', 21:06:53 INFO - 'LANG': 'en_US.UTF-8', 21:06:53 INFO - 'LANGUAGE': 'en_US:en', 21:06:53 INFO - 'LOGNAME': 'cltbld', 21:06:53 INFO - 'MAIL': '/var/mail/cltbld', 21:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:53 INFO - 'MOZ_NO_REMOTE': '1', 21:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:53 INFO - 'NO_EM_RESTART': '1', 21:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:53 INFO - 'PWD': '/builds/slave/test', 21:06:53 INFO - 'SHELL': '/bin/bash', 21:06:53 INFO - 'SHLVL': '1', 21:06:53 INFO - 'TERM': 'linux', 21:06:53 INFO - 'TMOUT': '86400', 21:06:53 INFO - 'USER': 'cltbld', 21:06:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:53 INFO - '_': '/tools/buildbot/bin/python'} 21:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:06:56 INFO - Installing collected packages: mozsystemmonitor 21:06:56 INFO - Running setup.py install for mozsystemmonitor 21:06:56 INFO - Successfully installed mozsystemmonitor 21:06:56 INFO - Cleaning up... 21:06:56 INFO - Return code: 0 21:06:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:56 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:06:56 INFO - Using env: {'DISPLAY': ':0', 21:06:56 INFO - 'HOME': '/home/cltbld', 21:06:56 INFO - 'LANG': 'en_US.UTF-8', 21:06:56 INFO - 'LANGUAGE': 'en_US:en', 21:06:56 INFO - 'LOGNAME': 'cltbld', 21:06:56 INFO - 'MAIL': '/var/mail/cltbld', 21:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:56 INFO - 'MOZ_NO_REMOTE': '1', 21:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:56 INFO - 'NO_EM_RESTART': '1', 21:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:56 INFO - 'PWD': '/builds/slave/test', 21:06:56 INFO - 'SHELL': '/bin/bash', 21:06:56 INFO - 'SHLVL': '1', 21:06:56 INFO - 'TERM': 'linux', 21:06:56 INFO - 'TMOUT': '86400', 21:06:56 INFO - 'USER': 'cltbld', 21:06:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:56 INFO - '_': '/tools/buildbot/bin/python'} 21:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:56 INFO - Downloading/unpacking jsonschema==2.5.1 21:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:06:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 21:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:06:58 INFO - warning: no files found matching '*.txt' 21:06:58 INFO - no previously-included directories found matching 'build' 21:06:58 INFO - no previously-included directories found matching 'dist' 21:06:58 INFO - no previously-included directories found matching '.git*' 21:06:58 INFO - Installing collected packages: jsonschema, functools32 21:06:58 INFO - Running setup.py install for functools32 21:06:58 INFO - warning: no files found matching '*.txt' 21:06:58 INFO - no previously-included directories found matching 'build' 21:06:58 INFO - no previously-included directories found matching 'dist' 21:06:58 INFO - no previously-included directories found matching '.git*' 21:06:58 INFO - Successfully installed jsonschema functools32 21:06:58 INFO - Cleaning up... 21:06:58 INFO - Return code: 0 21:06:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:58 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:06:58 INFO - Using env: {'DISPLAY': ':0', 21:06:58 INFO - 'HOME': '/home/cltbld', 21:06:58 INFO - 'LANG': 'en_US.UTF-8', 21:06:58 INFO - 'LANGUAGE': 'en_US:en', 21:06:58 INFO - 'LOGNAME': 'cltbld', 21:06:58 INFO - 'MAIL': '/var/mail/cltbld', 21:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:58 INFO - 'MOZ_NO_REMOTE': '1', 21:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:58 INFO - 'NO_EM_RESTART': '1', 21:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:58 INFO - 'PWD': '/builds/slave/test', 21:06:58 INFO - 'SHELL': '/bin/bash', 21:06:58 INFO - 'SHLVL': '1', 21:06:58 INFO - 'TERM': 'linux', 21:06:58 INFO - 'TMOUT': '86400', 21:06:58 INFO - 'USER': 'cltbld', 21:06:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:58 INFO - '_': '/tools/buildbot/bin/python'} 21:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:59 INFO - Downloading/unpacking blobuploader==1.2.4 21:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:00 INFO - Downloading blobuploader-1.2.4.tar.gz 21:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:07:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:07:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:01 INFO - Downloading docopt-0.6.1.tar.gz 21:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:07:01 INFO - Installing collected packages: blobuploader, requests, docopt 21:07:01 INFO - Running setup.py install for blobuploader 21:07:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:07:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:07:01 INFO - Running setup.py install for requests 21:07:02 INFO - Running setup.py install for docopt 21:07:02 INFO - Successfully installed blobuploader requests docopt 21:07:02 INFO - Cleaning up... 21:07:02 INFO - Return code: 0 21:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:02 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:07:02 INFO - Using env: {'DISPLAY': ':0', 21:07:02 INFO - 'HOME': '/home/cltbld', 21:07:02 INFO - 'LANG': 'en_US.UTF-8', 21:07:02 INFO - 'LANGUAGE': 'en_US:en', 21:07:02 INFO - 'LOGNAME': 'cltbld', 21:07:02 INFO - 'MAIL': '/var/mail/cltbld', 21:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:02 INFO - 'MOZ_NO_REMOTE': '1', 21:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:02 INFO - 'NO_EM_RESTART': '1', 21:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:02 INFO - 'PWD': '/builds/slave/test', 21:07:02 INFO - 'SHELL': '/bin/bash', 21:07:02 INFO - 'SHLVL': '1', 21:07:02 INFO - 'TERM': 'linux', 21:07:02 INFO - 'TMOUT': '86400', 21:07:02 INFO - 'USER': 'cltbld', 21:07:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:02 INFO - '_': '/tools/buildbot/bin/python'} 21:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:07:02 INFO - Running setup.py (path:/tmp/pip-Welnye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:07:02 INFO - Running setup.py (path:/tmp/pip-fB_dRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:07:02 INFO - Running setup.py (path:/tmp/pip-hwlgCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:07:02 INFO - Running setup.py (path:/tmp/pip-keocM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:07:02 INFO - Running setup.py (path:/tmp/pip-mwebmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:07:02 INFO - Running setup.py (path:/tmp/pip-p0GbIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:07:03 INFO - Running setup.py (path:/tmp/pip-gXVjAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:07:03 INFO - Running setup.py (path:/tmp/pip-hUC7Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:07:03 INFO - Running setup.py (path:/tmp/pip-g2uKQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:07:03 INFO - Running setup.py (path:/tmp/pip-4nhKuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:07:03 INFO - Running setup.py (path:/tmp/pip-RiXjW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:07:03 INFO - Running setup.py (path:/tmp/pip-OKaS0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:07:03 INFO - Running setup.py (path:/tmp/pip-v95yDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:07:03 INFO - Running setup.py (path:/tmp/pip-M40EnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:03 INFO - Running setup.py (path:/tmp/pip-ooF_Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:07:03 INFO - Running setup.py (path:/tmp/pip-Ovhx4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:07:03 INFO - Running setup.py (path:/tmp/pip-VJRa6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:07:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:07:03 INFO - Running setup.py install for manifestparser 21:07:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:07:03 INFO - Running setup.py install for mozcrash 21:07:04 INFO - Running setup.py install for mozdebug 21:07:04 INFO - Running setup.py install for mozdevice 21:07:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Running setup.py install for mozfile 21:07:04 INFO - Running setup.py install for mozhttpd 21:07:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Running setup.py install for mozinfo 21:07:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Running setup.py install for mozInstall 21:07:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Running setup.py install for mozleak 21:07:04 INFO - Running setup.py install for mozlog 21:07:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Running setup.py install for moznetwork 21:07:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:07:04 INFO - Running setup.py install for mozprocess 21:07:05 INFO - Running setup.py install for mozprofile 21:07:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:07:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:07:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:07:05 INFO - Running setup.py install for mozrunner 21:07:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:07:05 INFO - Running setup.py install for mozscreenshot 21:07:05 INFO - Running setup.py install for moztest 21:07:05 INFO - Running setup.py install for mozversion 21:07:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:07:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:07:05 INFO - Cleaning up... 21:07:05 INFO - Return code: 0 21:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:05 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:07:05 INFO - Using env: {'DISPLAY': ':0', 21:07:05 INFO - 'HOME': '/home/cltbld', 21:07:05 INFO - 'LANG': 'en_US.UTF-8', 21:07:05 INFO - 'LANGUAGE': 'en_US:en', 21:07:05 INFO - 'LOGNAME': 'cltbld', 21:07:05 INFO - 'MAIL': '/var/mail/cltbld', 21:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:05 INFO - 'MOZ_NO_REMOTE': '1', 21:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:05 INFO - 'NO_EM_RESTART': '1', 21:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:05 INFO - 'PWD': '/builds/slave/test', 21:07:05 INFO - 'SHELL': '/bin/bash', 21:07:05 INFO - 'SHLVL': '1', 21:07:05 INFO - 'TERM': 'linux', 21:07:05 INFO - 'TMOUT': '86400', 21:07:05 INFO - 'USER': 'cltbld', 21:07:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:05 INFO - '_': '/tools/buildbot/bin/python'} 21:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:07:05 INFO - Running setup.py (path:/tmp/pip-dhaUgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:07:05 INFO - Running setup.py (path:/tmp/pip-Qoi_q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:07:06 INFO - Running setup.py (path:/tmp/pip-Ikmz2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:07:06 INFO - Running setup.py (path:/tmp/pip-jk40XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:07:06 INFO - Running setup.py (path:/tmp/pip-uiQP9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:07:06 INFO - Running setup.py (path:/tmp/pip-pGaY_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:07:06 INFO - Running setup.py (path:/tmp/pip-rkTwTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:07:06 INFO - Running setup.py (path:/tmp/pip-Vb4xGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:07:06 INFO - Running setup.py (path:/tmp/pip-otQd35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:07:06 INFO - Running setup.py (path:/tmp/pip-7EGKA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:07:06 INFO - Running setup.py (path:/tmp/pip-vhetKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:07:06 INFO - Running setup.py (path:/tmp/pip-Iy9nBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:07:06 INFO - Running setup.py (path:/tmp/pip-oW3haZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:07:06 INFO - Running setup.py (path:/tmp/pip-hVJOdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:06 INFO - Running setup.py (path:/tmp/pip-iQR7pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:07:06 INFO - Running setup.py (path:/tmp/pip-C083CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:07:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:07:07 INFO - Running setup.py (path:/tmp/pip-hHSe4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:07:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:09 INFO - Downloading blessings-1.6.tar.gz 21:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:07:09 INFO - Installing collected packages: blessings 21:07:09 INFO - Running setup.py install for blessings 21:07:09 INFO - Successfully installed blessings 21:07:09 INFO - Cleaning up... 21:07:09 INFO - Return code: 0 21:07:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:07:09 INFO - Reading from file tmpfile_stdout 21:07:09 INFO - Current package versions: 21:07:09 INFO - argparse == 1.2.1 21:07:09 INFO - blessings == 1.6 21:07:09 INFO - blobuploader == 1.2.4 21:07:09 INFO - docopt == 0.6.1 21:07:09 INFO - functools32 == 3.2.3-2 21:07:09 INFO - jsonschema == 2.5.1 21:07:09 INFO - manifestparser == 1.1 21:07:09 INFO - mozInstall == 1.12 21:07:09 INFO - mozcrash == 0.17 21:07:09 INFO - mozdebug == 0.1 21:07:09 INFO - mozdevice == 0.48 21:07:09 INFO - mozfile == 1.2 21:07:09 INFO - mozhttpd == 0.7 21:07:09 INFO - mozinfo == 0.9 21:07:09 INFO - mozleak == 0.1 21:07:09 INFO - mozlog == 3.2 21:07:09 INFO - moznetwork == 0.27 21:07:09 INFO - mozprocess == 0.23 21:07:09 INFO - mozprofile == 0.28 21:07:09 INFO - mozrunner == 6.12 21:07:09 INFO - mozscreenshot == 0.1 21:07:09 INFO - mozsystemmonitor == 0.3 21:07:09 INFO - moztest == 0.7 21:07:09 INFO - mozversion == 1.4 21:07:09 INFO - psutil == 3.1.1 21:07:09 INFO - requests == 1.2.3 21:07:09 INFO - wsgiref == 0.1.2 21:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:09 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:07:09 INFO - Using env: {'DISPLAY': ':0', 21:07:09 INFO - 'HOME': '/home/cltbld', 21:07:09 INFO - 'LANG': 'en_US.UTF-8', 21:07:09 INFO - 'LANGUAGE': 'en_US:en', 21:07:09 INFO - 'LOGNAME': 'cltbld', 21:07:09 INFO - 'MAIL': '/var/mail/cltbld', 21:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:09 INFO - 'MOZ_NO_REMOTE': '1', 21:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:09 INFO - 'NO_EM_RESTART': '1', 21:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:09 INFO - 'PWD': '/builds/slave/test', 21:07:09 INFO - 'SHELL': '/bin/bash', 21:07:09 INFO - 'SHLVL': '1', 21:07:09 INFO - 'TERM': 'linux', 21:07:09 INFO - 'TMOUT': '86400', 21:07:09 INFO - 'USER': 'cltbld', 21:07:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:09 INFO - '_': '/tools/buildbot/bin/python'} 21:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:07:09 INFO - Cleaning up... 21:07:09 INFO - Return code: 0 21:07:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:09 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 0x29e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:07:09 INFO - Using env: {'DISPLAY': ':0', 21:07:09 INFO - 'HOME': '/home/cltbld', 21:07:09 INFO - 'LANG': 'en_US.UTF-8', 21:07:09 INFO - 'LANGUAGE': 'en_US:en', 21:07:09 INFO - 'LOGNAME': 'cltbld', 21:07:09 INFO - 'MAIL': '/var/mail/cltbld', 21:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:09 INFO - 'MOZ_NO_REMOTE': '1', 21:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:09 INFO - 'NO_EM_RESTART': '1', 21:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:09 INFO - 'PWD': '/builds/slave/test', 21:07:09 INFO - 'SHELL': '/bin/bash', 21:07:09 INFO - 'SHLVL': '1', 21:07:09 INFO - 'TERM': 'linux', 21:07:09 INFO - 'TMOUT': '86400', 21:07:09 INFO - 'USER': 'cltbld', 21:07:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:09 INFO - '_': '/tools/buildbot/bin/python'} 21:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:07:09 INFO - Cleaning up... 21:07:09 INFO - Return code: 0 21:07:09 INFO - Running post-action listener: _resource_record_post_action 21:07:09 INFO - Running post-action listener: _start_resource_monitoring 21:07:09 INFO - Starting resource monitoring. 21:07:09 INFO - ##### 21:07:09 INFO - ##### Finished create-virtualenv step (success) 21:07:09 INFO - ##### 21:07:09 INFO - ##### 21:07:09 INFO - ##### Running install step. 21:07:09 INFO - ##### 21:07:09 INFO - Running pre-action listener: _resource_record_pre_action 21:07:09 INFO - Running main action method: install 21:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:07:10 INFO - Reading from file tmpfile_stdout 21:07:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:07:10 INFO - Reading from file tmpfile_stdout 21:07:10 INFO - Output received: 21:07:10 INFO - Usage: mozinstall [options] installer 21:07:10 INFO - Options: 21:07:10 INFO - -h, --help show this help message and exit 21:07:10 INFO - -d DEST, --destination=DEST 21:07:10 INFO - Directory to install application into. [default: 21:07:10 INFO - "/builds/slave/test"] 21:07:10 INFO - --app=APP Application being installed. [default: firefox] 21:07:10 INFO - mkdir: /builds/slave/test/build/application 21:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:07:26 INFO - Reading from file tmpfile_stdout 21:07:26 INFO - Output received: 21:07:26 INFO - /builds/slave/test/build/application/firefox/firefox 21:07:26 INFO - Running post-action listener: _resource_record_post_action 21:07:26 INFO - ##### 21:07:26 INFO - ##### Finished install step (success) 21:07:26 INFO - ##### 21:07:26 INFO - ##### 21:07:26 INFO - ##### Running run-tests step. 21:07:26 INFO - ##### 21:07:26 INFO - Running pre-action listener: _resource_record_pre_action 21:07:26 INFO - Running main action method: run_tests 21:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:07:26 INFO - Python 2.7.3 21:07:26 INFO - Return code: 0 21:07:26 INFO - grabbing minidump binary from tooltool 21:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:07:26 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 0x2ca1570>, '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 0x2ca2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:07:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:07:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:07:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:07:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:07:26 INFO - Return code: 0 21:07:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:07:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:07:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:07:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:07:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 21:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 21:07:26 INFO - Using env: {'DISPLAY': ':0', 21:07:26 INFO - 'HOME': '/home/cltbld', 21:07:26 INFO - 'LANG': 'en_US.UTF-8', 21:07:26 INFO - 'LANGUAGE': 'en_US:en', 21:07:26 INFO - 'LOGNAME': 'cltbld', 21:07:26 INFO - 'MAIL': '/var/mail/cltbld', 21:07:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:07:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:26 INFO - 'MOZ_NO_REMOTE': '1', 21:07:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:26 INFO - 'NO_EM_RESTART': '1', 21:07:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:26 INFO - 'PWD': '/builds/slave/test', 21:07:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:07:26 INFO - 'SHELL': '/bin/bash', 21:07:26 INFO - 'SHLVL': '1', 21:07:26 INFO - 'TERM': 'linux', 21:07:26 INFO - 'TMOUT': '86400', 21:07:26 INFO - 'USER': 'cltbld', 21:07:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500', 21:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:26 INFO - '_': '/tools/buildbot/bin/python'} 21:07:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 21:07:26 INFO - mozversion application_buildid: 20160718191319 21:07:26 INFO - mozversion application_changeset: c2c393c85d041b196936a0dd53aff0db1c58d516 21:07:26 INFO - mozversion application_display_name: Nightly 21:07:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:07:26 INFO - mozversion application_name: Firefox 21:07:26 INFO - mozversion application_remotingname: firefox 21:07:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:07:26 INFO - mozversion application_vendor: Mozilla 21:07:26 INFO - mozversion application_version: 50.0a1 21:07:26 INFO - mozversion platform_buildid: 20160718191319 21:07:26 INFO - mozversion platform_changeset: c2c393c85d041b196936a0dd53aff0db1c58d516 21:07:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:07:26 INFO - mozversion platform_version: 50.0a1 21:07:26 INFO - using testdate: 1468901246 21:07:26 INFO - actual date: 1468901246 21:07:26 INFO - starting webserver on 'localhost:56396' 21:07:26 INFO - SUITE-START | Running 2 tests 21:07:26 INFO - TEST-START | dromaeo_css 21:07:26 INFO - operating with platform_type : linux_ 21:07:26 INFO - Initialising browser for dromaeo_css test... 21:07:26 INFO - TEST-INFO | started process 9215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBHOlAT/profile http://localhost:56396/getInfo.html) 21:07:31 INFO - PROCESS | 9215 | __metrics Screen width/height:1600/1200 21:07:31 INFO - PROCESS | 9215 | colorDepth:24 21:07:31 INFO - PROCESS | 9215 | Browser inner width/height: 1024/697 21:07:31 INFO - PROCESS | 9215 | __metrics 21:07:32 ERROR - PROCESS | 9215 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:07:33 INFO - TEST-INFO | 9215: exit 0 21:07:33 INFO - Browser initialized. 21:07:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:07:33 INFO - TEST-INFO | started process 9332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBHOlAT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:45 INFO - PROCESS | 9332 | RSS: Main: 168861696 21:07:45 INFO - PROCESS | 9332 | 21:08:34 INFO - PROCESS | 9332 | 1468901314848 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:10:47 INFO - PROCESS | 9332 | Cycle 1(1): loaded http://localhost:56396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56396/tests/dromaeo/cssquery-ext.html) 21:10:48 INFO - PROCESS | 9332 | RSS: Main: 172548096 21:10:48 INFO - PROCESS | 9332 | 21:13:51 INFO - PROCESS | 9332 | Cycle 1(1): loaded http://localhost:56396/tests/dromaeo/cssquery-ext.html (next: http://localhost:56396/tests/dromaeo/cssquery-jquery.html) 21:13:51 INFO - PROCESS | 9332 | RSS: Main: 168636416 21:13:51 INFO - PROCESS | 9332 | 21:16:53 INFO - PROCESS | 9332 | Cycle 1(1): loaded http://localhost:56396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56396/tests/dromaeo/cssquery-mootools.html) 21:16:54 INFO - PROCESS | 9332 | RSS: Main: 171704320 21:16:54 INFO - PROCESS | 9332 | 21:19:56 INFO - PROCESS | 9332 | Cycle 1(1): loaded http://localhost:56396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56396/tests/dromaeo/cssquery-prototype.html) 21:19:56 INFO - PROCESS | 9332 | RSS: Main: 166125568 21:19:56 INFO - PROCESS | 9332 | 21:22:59 INFO - PROCESS | 9332 | Cycle 1(1): loaded http://localhost:56396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56396/tests/dromaeo/cssquery-yui.html) 21:23:00 INFO - PROCESS | 9332 | RSS: Main: 169275392 21:23:00 INFO - PROCESS | 9332 | 21:26:02 INFO - PROCESS | 9332 | Cycle 1(1): loaded http://localhost:56396/tests/dromaeo/cssquery-yui.html (next: http://localhost:56396/tests/dromaeo/cssquery-dojo.html) 21:26:03 INFO - PROCESS | 9332 | RSS: Main: 169517056 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | __start_tp_report 21:26:03 INFO - PROCESS | 9332 | _x_x_mozilla_page_load 21:26:03 INFO - PROCESS | 9332 | _x_x_mozilla_page_load_details 21:26:03 INFO - PROCESS | 9332 | |i|pagename|runs| 21:26:03 INFO - PROCESS | 9332 | |0;dojo.html;2609.98695006525;2665.8800353984075;2668.786497080234;2687.1132526266333;2706.120510833978;4786.2342025276;4835.0571638530455;4864.294677271793;4866.805327786893;4880.365552478182;4718.598919091873;4768.308595253686;4876.561109500144;4892.168331383665;4901.3138160657445;4369.060651959828;4370.628496577787;4483.237849565566;4490.7530085845265;4499.842505512308;4178.749275043507;4491.056878055596;4495.505494395614;4569.565891240327;4586.8394606188795;4321.157374312011;4409.074094440171;4440.622547083502;4504.729716217037;4514.706544074657;4441.067375851075;4479.865604031885;4480.843170489017;4497.730136191839;4532.410786597754;4472.262076757331;4472.619827314682;4481.619062379702;4486.147631949919;4512.187806194884;4758.357621721093;4867.586255168279;4883.291922671193;4891.364122664031;4900.117978763821;5201.271821944931;5225.555827754645;5232.73836308183;5244.108501554745;5272.525472707436;5034.11902916988;5156.716380599066;5255.054090263751;5261.973690131563;5272.551833094191;4810.110129625996;4840.733759643183;4848.12733707936;4852.272159176152;4899.681520701179;5315.123004704258;5327.09439395296;5330.866728331823;5330.9733451332495;5386.757595908193;4899.828506002273;4963.478834722375;4990;5107.693538387709;5114.43741188469;5019.52314530119;5075.289459475676;5081.720505372166;5091.821786237464;5093.694378337312;5106.974465127725;5159.406668233126;5165;5173.71544565045;5227.424983251839;5106.080905437057;5109.259157422227;5115.693058416507;5118.948810511847;5161.767720452589;4155.771432571238;4216.072464057902;4220.388043733641;4223.028703398236;4286.721363111388;3744.8314825832904;3782.8486860525272;3785.261873934556;3815.828287727059;3819.52255968004;4409.977950110293;4430.800613972379;4432.246518091933;4450.688451808407;4454.5990860822685;4959.603231741452;5176.456472070454;5177.145770947752;5180.274761533388;5191.8182863599595;4487.842925497592;4505.805961420227;4518.548145185455;4530.682852200314;4542.046170304273;4674.719516829001;4708.717476951394;4712.505186955389;4730.905381892343;4764.30917516965;4631.421072365954;4834.854954351375;4853.587445067067;4882.60939124862;4951.232558953368;5097.158968770112;5130.204818253177;5150.047241260229;5155.690658560498;5197.064528384927;4873.46391896884;4874.463808980939;4886.926696099633;4898.681585696918;4933.186024306093;4931.950680493293;4989.25161225819;5034.0686972910125;5046.394432667957;5052.545270925634;5077.949220507895;5108.719020453911;5115;5117.488251174853;5163.5610973066205;4778.856634300976;4961.181405068123;4962.528559786814;4981.252812078217;4983.352164218629;4847.563719265283;4952.479989601185;4976.10430122567;4981.800727970841;5043.949560504348;4893.535114164149;4915.926261106158;4919.1883339248625;4924.63065270099;5018.5232402921665;4840.128776820206;5065.164247899055;5074.619403544675;5081.974590127025;5090.440051594248;4867.269909513459;4906.435759887659;4919.729414882216;4923.950760492349;4929.457759646508 21:26:03 INFO - PROCESS | 9332 | |1;ext.html;555.802690045034;560.4591569135781;571.6970005896874;576.7923547522893;594.0465552787779;34863.128421789435;39493.40759888597;39538.209235815266;39565.20869582607;39642.801785991105;39993.800030999875;40204.59795402045;40464;40577;40698.796506017505;7768.339691126247;7921.049474063092;7962.40281978851;7963.641636126359;7975.361971042303;7852.528848269094;7891.092524359715;7905.288524032836;7929;7933.484323518982;7819.9218007820045;7906.407019473534;7908.841823163533;7943.523388596674;7961;7893.0922943861615;7913.802154946115;7936.920630793676;7940.483868548526;7951.642176102089;7828.843423131506;7900.288973992311;7928.167542408022;7941.722039728582;7943.682252709885;38023.66917157914;38399.232015359536;38441.80779096087;38452.80773596114;38528.42207366892;2956.763458923281;3111.424386488507;3113.081640915935;3143.7327827134723;3154.7318477929402;29645.258868528243;29695.70304296951;29746.553801692993;30162.09513714592;30316.393672126655;3389.1357703785375;3421.9828900855337;3435.7423193260606;3477.9130521736906;3483.2336885885065;254334;254573;256270;256539;257562.99999999814;31401.685983139876;31951.840240799113;54370.72814635901;54664.45335546673;54715.45284547183;33083.834580826944;33517.49723754146;33548.83225583905;33563.16092097717;33621.327573448885;13247.536336228186;13343.466261349631;13408.262545560088;13430.328483575977;13481.797773033413;10959.83560246597;10975;10987.736410312757;11063.059639930696;11111.444427778579;7777.455578109591;7884.093329267093;7909.932159158555;7945.602719863984;7966.880496792553;3114.408262430131;3119.0642807158215;3131.3424180921807;3142.2301536123796;3149.2441813964483;884.4516399832145;889.2752406788446;929.3401684803865;982.626601891291;984.2224642532319;26266.868665656548;27219.86390068037;27326.713008937437;27588.586171207447;27603.171904842486;880.7930136417937;938.8826396700413;971.504532688334;987.7579992901785;1027.1782573940966;14699.265036748333;14926.179060151579;15073;15087.822334596;15148.924255378874;380509;385309;386434;389181;389756;50368.74815625898;50394;50745.23882141771;50773;51033.74483127635;1154.5151036564664;1187.0147777344955;1191.7139886427194;1192.874748151449;1202.8496437945432;26047.609285860348;27474;27515.31211719723;27574.172774816787;27579.31051723723;43166.352504711824;43445.78277108721;43690.126197475234;43697;43754.562454375045;329640;331216;331459;332352;333148;25228.62157067609;25538.872305638353;25816.514770505742;25911.22266332013;25919;39174.60825391824;41185.176296473306;42234.57765422307;42379.364309535995;42677;36400;36609;36680.633193668786;36888.63111368852;37006.44490332701;35527.46708799319;36035.63964360323;36099;36159;36607.26785464329;30055.398892022473;34420.24638029002;34968.65031349654;35553.82223088972;37476.25047499089;31419.528707068956;33234;33367.49948750722;33457.66542334643;33560.83219583886;24738.752612473643;25480.8725956369;25734.871325643253;25809;25824.8708756455 21:26:03 INFO - PROCESS | 9332 | |2;jquery.html;362.62106099126413;365.72570572070947;373.33918963434724;374.1357464257567;384.6653411531968;15790.289436975336;17525.29898804048;17691.911540442314;18147.81852181481;18184.363547275814;15765.290561924712;16873.493795186132;17909.10454477274;18004.189811458484;18050.27798888043;4622.953770462294;4788.832390866321;4825;4827.710337379768;4836.951630483685;3567.3757092508836;4703.388559487279;5294.735263236842;5565.972170139164;5578.888422231553;5597.384287728347;5633.155026746001;5646.830595082133;5648.209250704905;5657;5531.612787104904;5580.107182850745;5641.68970706611;5650.3219613646215;5653.010723123458;5387.1380579107545;5428.67427954324;5449.373322067973;5454.672719636835;5464.453554644543;12837.358132093357;14483;20284.188632454683;20885.68671469929;20900.790992090035;1728.9394871179447;1764.0738612228554;1889.697648376267;1890.6596812573732;2003.8396928245852;9108.59011344491;9139.360244782867;9284.118008789153;9369.109934556207;9587.376820506644;1655.8592519635724;1711.366794286122;1724.4998950304396;1753.1672455583623;1755.4382597568783;71041.64479177623;71209.28790712079;71428.2857171432;73250.63374683092;75716.62141689312;9873.555689993967;10083;10106.140978016803;10137.797244055226;10322.845157322647;13851.930740346234;14017.929910350587;14040.648983775283;14156;14171.503997360043;7279.59962202084;7366.189719130892;7538.623068846536;7612.657430415645;7665.961670191725;7175.928240717631;7299.671514781848;7341.045664063638;7387.963060184665;7429.5542267464125;4255.127698821734;4281.828726850891;4363.149185908717;4369.257226271541;4460.553944605578;1674.8995060296422;1687.637158011009;1767.3460819496868;1873.681474149398;1907.9904600477187;763.6067425275987;894.4990805149138;936.3258453913172;952.6951375559754;976.1848856205006;17184.484465466056;17268.481945541655;17278.30886764515;17709.911450442665;18018.549536261435;856.0497847389393;859.9570021499026;890.3144578674385;927.5779520318239;939.2626787971546;9651.806963860683;9876.111149996535;9897.554610042565;9957.950210248902;9977.800443991226;400802;402596;406324;420397;421885;79422;80242.19757802464;80727.59636201781;80737.19262807297;80913;887.4292502270944;889.3418870036256;900.617237673999;903.214203642835;904.7511934218011;15358.923205384348;15491.380344786083;15547.222638868237;15582.298796554409;16057.598560036093;36888.63111368852;37662.623373767005;38417;38909.6109038906;39930.60069399385;54163;54401.455985439636;54822;54990;55024.72487637536;7439.8140046499275;7465.776026719207;7768.689252429839;7838.80402989907;7878.015248093989;10304.742381440525;11410.201285909907;11431.828522572334;11560.42197890119;11893.108016898594;10277;10481.213908956706;10706.357618542912;10803.189760767817;10806.513706883366;8571.742847714579;8690.739277821676;10211.387316761018;10328.845067323846;10388.42863642507;10353.430561318899;10465.319754215952;10747.838782418114;10856.402897840695;11305.604303849326;6641.933580664131;6996.720131194696;7101.467389945671;7108.147022357351;7626.923730762622;7846.568438735924;9955.701328960144;10632.362058276529;10792.730181745519;10808.675739727822 21:26:03 INFO - PROCESS | 9332 | |3;mootools.html;1386.6048176269762;1421.4669498937897;1519.9696006079878;1689.9915500422496;1717.064200010993;6780.355866192704;7479;7604.429667774912;7995.120536740954;8013.799655008627;7713.151553329143;7931.405144614148;7953;8013.559254241014;8021.959890200541;2181.8799966001825;2210.115953618549;2212.1151539384296;2215.1693115081844;2220.944476388087;2147.559750251203;2177.7168968034134;2217.84475086744;2220.0342850859847;2221.244776775896;2162.859414138076;2163.210428193706;2169.652855543113;2177.2597316912247;2209.0832304593573;2164.512984578465;2173.880436575988;2174.1086154676664;2174.749903761072;2175.1625624134663;2111.4721319670084;2168;2173.71741673583;2174.63031284682;2175.1299480207886;7970.601469926539;8082.636281367352;8092.1503242159315;8101.837963240761;8125.471844330159;4443;4580.061087477059;4591.977040114812;4609.170349337118;4610.67725259232;2751.697313295536;2764.14311563416;2825.7456828885497;2839.105681710255;2876.5685147227873;855.3456605696647;869.3436455476138;889.1020069729619;895.7447127568612;897.7082448204294;10183.134433573156;10257.43584102874;10261.640842570549;10271.69184924446;10288.022637849392;3981.6018398159954;4085.2442298174933;4192.727472714264;4201.789910504463;4216.810243539048;8968.955155224183;8984.730458086267;8997;9005.324600654978;9026.954865225633;4572.177008138567;4575.7483338416705;4576.222042252825;4578.610818080434;4585.885352866205;3660.194757153422;4199.832006719758;4207.26372884744;4264.168487145039;4436.979494716169;3674.375356189454;3732.346839303111;3772.962270377316;3804.771713697187;3829.119302560371;1178.9233699809486;1190.4404929683035;1213.3266037349179;1217.896478799312;1227.2697744841805;771.4561234329784;866.9293422623056;880.2561835249204;897.3628723606313;912.2792993535033;5492.642978206483;5502.284702988586;5502.915270440543;5571.192177134374;5798.797042103506;395.8931088606118;412.62451169435667;417.7347384410921;418.1511531590875;420.487005852859;3805.9809700951873;3850.114473671071;3913.373860182357;3923.097687531884;3938.822752976123;9217.76955576116;9868.963758805223;9885.25860560461;9909.752256193653;10004.649837255662;9632.47021413829;9897.455639939872;9900.059494348025;9938.105570498545;9955.203583713286;7470.551766894004;7518.812029699301;7578.886316705254;7594.354479869273;7597.772066837893;5208.557272631869;5259.39516955555;5503.7798488060025;5543.6396634218645;5650;8961.372703910663;9219.078092190728;9264.72205833826;9280.860787088064;9282.814343713222;8946.239569636653;9215.86176207344;9272.907270927204;9447.385919915183;9474.478903660365;6165.691715414301;6458.289588145206;6655.700493477902;6974.895376569457;7015.193252775792;7666.041744781903;7689.730859419893;7699.191584883507;7736.071671399468;7775.494592851446;6647.7008534617025;6657.900131498128;6686.732530698718;6714.462842972453;6716.764913228014;6719.092922455406;6770.966145169243;6828.931710682829;6893.345132212432;6963.512554121163;6469.417752402118;6472.805815825533;6478.611283323015;6511.088447617242;6574.901376479261;4601.539846015372;4676.462206846256;4677.602403795716;4683.1336202802595;4742.336072949859;4410.647148228199;4469.329600559942;4583.472900616472;4591.770411479346;4619.053094115766 21:26:03 INFO - PROCESS | 9332 | |4;prototype.html;292.4253841202038;297.3799627776087;309.6315384692215;310.46444882577555;310.8461311650733;4869.975650121744;4925.753712314379;5047.596192304616;5125.513076257755;5132.127538318486;4946.258061290808;4985.775640096195;5020.322256495372;5025.924611130836;5047.974760126194;3945.7632542047427;3962.346212874872;3964.980175099128;3991.4853642205517;3991.540972788123;3875;3957.1689945111416;3969.0871099646956;3995.1809878974886;4007.657434759359;3913.2956067907767;3918.804059797013;3931.2727145478034;3932.154586763845;3961.6236457536634;3927.9214415711526;3935.9803200983956;3949.5063117110217;3957.7625342479255;3969.7419667721506;3352.7150192233444;3465.8440370183403;3483.477478378238;3502.5446691929887;3506.0884170115955;4837.153498137812;4872.439669438025;4880.365552478191;4890.193118135503;4891.168501354743;4462;4463.665225108098;4485.865424037284;4507.977460112711;4516.525764794715;4958.256261560795;5223.37319521656;5241.606879484016;5262.921146147289;5289.788408463657;3853.614638536152;3859.7298189126773;3861.6524512793985;3870.78710670913;3873.1866308075337;5510.9448905510835;5585.664860108406;5588.273524441796;5591.524720398771;5592.384837667853;3682.410814269704;3944.3097457944746;3957.56466788653;3960.2475529649273;3961.8811435656976;3954.4463775071513;3968.6229808168177;3984.362501999666;3985.720999530005;4013.7391069580385;4503.594676479132;4528.909421811545;4533.38799262102;4537.886552836139;4544.613707834871;5311.468853114658;5312.1500559911;5316.175992721134;5329.387120481117;5334.586334621328;1340.5040135150057;1382.8755412012968;1383.3359987205997;1391.1653008195;1392.6587985943509;877.5963056993854;885.5129678676702;894.1371576428647;907.7231444409387;916.6241840845355;4097.221527909687;4102.692298077656;4130.339145736668;4159.584041595876;4170.666346692257;4782.665213435026;4819;4819.674589487919;4820.325154478376;4856.854294371175;4131.442255295497;4148.771817550064;4170.350942924941;4171.290880550314;4184.937225941613;2439.7682220189054;2547.7707006369515;2548.949021019569;2549.5028469448653;2554.948901021969;4531.410916580823;4540.364348991144;4540.954590454119;4545.5908968193025;4634.768261586907;4799.904001919942;4803.687760295639;4810.470848206694;4846.903061938741;4859.198232291632;4328.696991210585;4394.572233657752;4538.500764915857;4542;4552.385427967182;4762.333273341805;4770.666053376369;4774.7851346688785;4781.306710526885;4826.517348265286;4619.769011549476;4629;4650.651311119737;4682.789274482589;4686.203345431217;4297.935530967101;4544.795484203285;4598.793054312497;4607.769611519478;4656.534346565317;3576.4098923678343;3708.610595887501;3745.85016599333;3871.535415750128;3879.5344558652014;5337.439568845371;5410.78356865721;5413.160960051198;5431.5926305526455;5444.6188766785945;5226.398964119175;5232.450592687713;5239.266502689703;5241.292425522505;5269.314989051399;5093.516115968977;5108.9233661495855;5170.3278573785165;5212.296339994053;5221.269022336952;5064.404712515546;5093.898122037464;5137.974310128426;5154.175331946871;5186.455422180617;5216.452272511484;5283.101872681576;5286.180642000496;5291.814786482455;5340.5994550408095;5013.197888337849;5105.744712764273;5132.153194722829;5145.511176438382;5149.356330458692 21:26:03 INFO - PROCESS | 9332 | |5;yui.html;630.6909614288994;636.3382082634058;645.303072681504;719.8776208044632;732.168988198395;12107.636770896865;12684.238945663266;12807.743845123092;12855.55005574805;12862.292573908442;12828;13161.670958226048;13162.341882905841;13170.341482925864;13201;739.2496615934831;756.4137793210278;758.8216769059267;791.5211297165218;795.1412474527497;783.7100272899036;789.6604460082162;791.2996997657058;794.527256282511;795.0697683710044;823.5923218007094;827.3794654009492;829.1873963515758;831.6922738586732;833.6665333866441;820.3929092471558;822.6421506644568;823.9134890836466;825.1171246765933;825.5748289630845;602.1269159718382;604.5526310530176;605.6063558686844;607.3046361915582;607.3046361915626;13040.347982600832;13084.411201495956;13149.737005259936;13177.472901083946;13226.404811783494;12905.35473226335;13087.672808179777;13146.342682865818;13374.13068150567;13750.312484375841;10818.22626186033;10830.512626931728;10849.511771970201;10953.945230273797;11130.220884538086;3232.773705840592;3287.7534184936226;3293.7859039162618;3311.9172020699434;3323.5845519310087;63391.36608633947;64140.358596413906;64166.358336416975;64374;64704;10191.101806590843;10380.896191037993;10446.947765261126;10489.685309440729;10613.363198208132;16560.834391655928;16589.419370322223;16664.666706665797;16695.49913502597;16707.498775036525;6834.521583489108;6946.235914049451;6961.443084553223;7055.188653304833;7227.819304517324;3895.6299151580556;3952.5849785772657;3961.445397644332;3993.880183594497;4040.6565441937178;2903.129061281607;3002.0993701889347;3016.9849150754108;3017.683143269925;3025.3495498467937;501.8068043803162;506.98732531686267;514.238926388939;520.9921851172236;523.3196844102652;533.5918022712628;576.7952376906222;595.6188039654625;631.2141383976887;632.6330728177646;8173.713920012771;8274.255317021498;8444.028936672361;8473.3644976627;8495.320374370036;589.8053642298117;596.7105953612495;598.5540772124795;612.5650787940523;621.6239175298879;3812.237552489458;4135.31767258405;4157.97921010393;4256.191323648497;4301.978490107529;84365.57817210998;94962;96979.51510242544;97477.5126124379;97635.09459621678;76401;81780;82491.58754206191;82531.7620235697;82601;59495.405045949854;62153.067703984474;72463.27536724671;72899;75595;8413.915860841558;8589.871151932852;8748.69379571712;9013.549322533716;9236.676716314896;32103.839480802446;34410.655893440744;40306.193876121724;43228;45454.31818522791;56527.434725652216;64350.67824660847;64907.67546162239;65528;65620;11123.555057797597;11140.33158010522;11148.108151348035;11285.37930413835;11384.772304554028;12832.358382080673;12953.676158096123;12972;13575.592732217654;13807.081320651121;11464.598739044093;11575.76848463043;11742.471588778697;11833.940830295793;12254.754904901674;12064.336461494702;12151.210171338835;12590.370481476073;13025.869741302466;13125.803112953123;10939.179561533076;11479.770404591694;11694.064474842162;11927.403629818647;11974.700632484257;9796;9905.653302134391;10092.646757363456;10221.33561318512;10607.257491975488;9831.705048848546;10244.385336879812;10299;10430.68707938763;10612.469376530988 21:26:03 INFO - PROCESS | 9332 | __end_tp_report 21:26:03 INFO - PROCESS | 9332 | __start_cc_report 21:26:03 INFO - PROCESS | 9332 | _x_x_mozilla_cycle_collect,405 21:26:03 INFO - PROCESS | 9332 | __end_cc_report 21:26:03 INFO - PROCESS | 9332 | __startTimestamp1468902363182__endTimestamp 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | ------- Summary: start ------- 21:26:03 INFO - PROCESS | 9332 | Number of tests: 6 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | [#0] dojo.html Cycles:165 Average:4760.66 Median:4892.17 stddev:502.15 (10.3%) stddev-sans-first:474.50 21:26:03 INFO - PROCESS | 9332 | Values: 2610.0 2665.9 2668.8 2687.1 2706.1 4786.2 4835.1 4864.3 4866.8 4880.4 4718.6 4768.3 4876.6 4892.2 4901.3 4369.1 4370.6 4483.2 4490.8 4499.8 4178.7 4491.1 4495.5 4569.6 4586.8 4321.2 4409.1 4440.6 4504.7 4514.7 4441.1 4479.9 4480.8 4497.7 4532.4 4472.3 4472.6 4481.6 4486.1 4512.2 4758.4 4867.6 4883.3 4891.4 4900.1 5201.3 5225.6 5232.7 5244.1 5272.5 5034.1 5156.7 5255.1 5262.0 5272.6 4810.1 4840.7 4848.1 4852.3 4899.7 5315.1 5327.1 5330.9 5331.0 5386.8 4899.8 4963.5 4990.0 5107.7 5114.4 5019.5 5075.3 5081.7 5091.8 5093.7 5107.0 5159.4 5165.0 5173.7 5227.4 5106.1 5109.3 5115.7 5118.9 5161.8 4155.8 4216.1 4220.4 4223.0 4286.7 3744.8 3782.8 3785.3 3815.8 3819.5 4410.0 4430.8 4432.2 4450.7 4454.6 4959.6 5176.5 5177.1 5180.3 5191.8 4487.8 4505.8 4518.5 4530.7 4542.0 4674.7 4708.7 4712.5 4730.9 4764.3 4631.4 4834.9 4853.6 4882.6 4951.2 5097.2 5130.2 5150.0 5155.7 5197.1 4873.5 4874.5 4886.9 4898.7 4933.2 4932.0 4989.3 5034.1 5046.4 5052.5 5077.9 5108.7 5115.0 5117.5 5163.6 4778.9 4961.2 4962.5 4981.3 4983.4 4847.6 4952.5 4976.1 4981.8 5043.9 4893.5 4915.9 4919.2 4924.6 5018.5 4840.1 5065.2 5074.6 5082.0 5090.4 4867.3 4906.4 4919.7 4924.0 4929.5 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | [#1] ext.html Cycles:180 Average:46713.75 Median:36129.00 stddev:86794.10 (240.2%) stddev-sans-first:86968.39 21:26:03 INFO - PROCESS | 9332 | Values: 555.8 560.5 571.7 576.8 594.0 34863.1 39493.4 39538.2 39565.2 39642.8 39993.8 40204.6 40464.0 40577.0 40698.8 7768.3 7921.0 7962.4 7963.6 7975.4 7852.5 7891.1 7905.3 7929.0 7933.5 7819.9 7906.4 7908.8 7943.5 7961.0 7893.1 7913.8 7936.9 7940.5 7951.6 7828.8 7900.3 7928.2 7941.7 7943.7 38023.7 38399.2 38441.8 38452.8 38528.4 2956.8 3111.4 3113.1 3143.7 3154.7 29645.3 29695.7 29746.6 30162.1 30316.4 3389.1 3422.0 3435.7 3477.9 3483.2 254334.0 254573.0 256270.0 256539.0 257563.0 31401.7 31951.8 54370.7 54664.5 54715.5 33083.8 33517.5 33548.8 33563.2 33621.3 13247.5 13343.5 13408.3 13430.3 13481.8 10959.8 10975.0 10987.7 11063.1 11111.4 7777.5 7884.1 7909.9 7945.6 7966.9 3114.4 3119.1 3131.3 3142.2 3149.2 884.5 889.3 929.3 982.6 984.2 26266.9 27219.9 27326.7 27588.6 27603.2 880.8 938.9 971.5 987.8 1027.2 14699.3 14926.2 15073.0 15087.8 15148.9 380509.0 385309.0 386434.0 389181.0 389756.0 50368.7 50394.0 50745.2 50773.0 51033.7 1154.5 1187.0 1191.7 1192.9 1202.8 26047.6 27474.0 27515.3 27574.2 27579.3 43166.4 43445.8 43690.1 43697.0 43754.6 329640.0 331216.0 331459.0 332352.0 333148.0 25228.6 25538.9 25816.5 25911.2 25919.0 39174.6 41185.2 42234.6 42379.4 42677.0 36400.0 36609.0 36680.6 36888.6 37006.4 35527.5 36035.6 36099.0 36159.0 36607.3 30055.4 34420.2 34968.7 35553.8 37476.3 31419.5 33234.0 33367.5 33457.7 33560.8 24738.8 25480.9 25734.9 25809.0 25824.9 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | [#2] jquery.html Cycles:180 Average:25182.41 Median:4541.75 stddev:67845.16 (1493.8%) stddev-sans-first:68009.89 21:26:03 INFO - PROCESS | 9332 | Values: 362.6 365.7 373.3 374.1 384.7 15790.3 17525.3 17691.9 18147.8 18184.4 15765.3 16873.5 17909.1 18004.2 18050.3 4623.0 4788.8 4825.0 4827.7 4837.0 3567.4 4703.4 5294.7 5566.0 5578.9 5597.4 5633.2 5646.8 5648.2 5657.0 5531.6 5580.1 5641.7 5650.3 5653.0 5387.1 5428.7 5449.4 5454.7 5464.5 12837.4 14483.0 20284.2 20885.7 20900.8 1728.9 1764.1 1889.7 1890.7 2003.8 9108.6 9139.4 9284.1 9369.1 9587.4 1655.9 1711.4 1724.5 1753.2 1755.4 71041.6 71209.3 71428.3 73250.6 75716.6 9873.6 10083.0 10106.1 10137.8 10322.8 13851.9 14017.9 14040.6 14156.0 14171.5 7279.6 7366.2 7538.6 7612.7 7666.0 7175.9 7299.7 7341.0 7388.0 7429.6 4255.1 4281.8 4363.1 4369.3 4460.6 1674.9 1687.6 1767.3 1873.7 1908.0 763.6 894.5 936.3 952.7 976.2 17184.5 17268.5 17278.3 17709.9 18018.5 856.0 860.0 890.3 927.6 939.3 9651.8 9876.1 9897.6 9958.0 9977.8 400802.0 402596.0 406324.0 420397.0 421885.0 79422.0 80242.2 80727.6 80737.2 80913.0 887.4 889.3 900.6 903.2 904.8 15358.9 15491.4 15547.2 15582.3 16057.6 36888.6 37662.6 38417.0 38909.6 39930.6 54163.0 54401.5 54822.0 54990.0 55024.7 7439.8 7465.8 7768.7 7838.8 7878.0 10304.7 11410.2 11431.8 11560.4 11893.1 10277.0 10481.2 10706.4 10803.2 10806.5 8571.7 8690.7 10211.4 10328.8 10388.4 10353.4 10465.3 10747.8 10856.4 11305.6 6641.9 6996.7 7101.5 7108.1 7626.9 7846.6 9955.7 10632.4 10792.7 10808.7 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | [#3] mootools.html Cycles:180 Average:5189.43 Median:4975.45 stddev:2925.24 (58.8%) stddev-sans-first:2919.49 21:26:03 INFO - PROCESS | 9332 | Values: 1386.6 1421.5 1520.0 1690.0 1717.1 6780.4 7479.0 7604.4 7995.1 8013.8 7713.2 7931.4 7953.0 8013.6 8022.0 2181.9 2210.1 2212.1 2215.2 2220.9 2147.6 2177.7 2217.8 2220.0 2221.2 2162.9 2163.2 2169.7 2177.3 2209.1 2164.5 2173.9 2174.1 2174.7 2175.2 2111.5 2168.0 2173.7 2174.6 2175.1 7970.6 8082.6 8092.2 8101.8 8125.5 4443.0 4580.1 4592.0 4609.2 4610.7 2751.7 2764.1 2825.7 2839.1 2876.6 855.3 869.3 889.1 895.7 897.7 10183.1 10257.4 10261.6 10271.7 10288.0 3981.6 4085.2 4192.7 4201.8 4216.8 8969.0 8984.7 8997.0 9005.3 9027.0 4572.2 4575.7 4576.2 4578.6 4585.9 3660.2 4199.8 4207.3 4264.2 4437.0 3674.4 3732.3 3773.0 3804.8 3829.1 1178.9 1190.4 1213.3 1217.9 1227.3 771.5 866.9 880.3 897.4 912.3 5492.6 5502.3 5502.9 5571.2 5798.8 395.9 412.6 417.7 418.2 420.5 3806.0 3850.1 3913.4 3923.1 3938.8 9217.8 9869.0 9885.3 9909.8 10004.6 9632.5 9897.5 9900.1 9938.1 9955.2 7470.6 7518.8 7578.9 7594.4 7597.8 5208.6 5259.4 5503.8 5543.6 5650.0 8961.4 9219.1 9264.7 9280.9 9282.8 8946.2 9215.9 9272.9 9447.4 9474.5 6165.7 6458.3 6655.7 6974.9 7015.2 7666.0 7689.7 7699.2 7736.1 7775.5 6647.7 6657.9 6686.7 6714.5 6716.8 6719.1 6771.0 6828.9 6893.3 6963.5 6469.4 6472.8 6478.6 6511.1 6574.9 4601.5 4676.5 4677.6 4683.1 4742.3 4410.6 4469.3 4583.5 4591.8 4619.1 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | [#4] prototype.html Cycles:180 Average:4226.82 Median:4575.59 stddev:1207.94 (26.4%) stddev-sans-first:1174.68 21:26:03 INFO - PROCESS | 9332 | Values: 292.4 297.4 309.6 310.5 310.8 4870.0 4925.8 5047.6 5125.5 5132.1 4946.3 4985.8 5020.3 5025.9 5048.0 3945.8 3962.3 3965.0 3991.5 3991.5 3875.0 3957.2 3969.1 3995.2 4007.7 3913.3 3918.8 3931.3 3932.2 3961.6 3927.9 3936.0 3949.5 3957.8 3969.7 3352.7 3465.8 3483.5 3502.5 3506.1 4837.2 4872.4 4880.4 4890.2 4891.2 4462.0 4463.7 4485.9 4508.0 4516.5 4958.3 5223.4 5241.6 5262.9 5289.8 3853.6 3859.7 3861.7 3870.8 3873.2 5510.9 5585.7 5588.3 5591.5 5592.4 3682.4 3944.3 3957.6 3960.2 3961.9 3954.4 3968.6 3984.4 3985.7 4013.7 4503.6 4528.9 4533.4 4537.9 4544.6 5311.5 5312.2 5316.2 5329.4 5334.6 1340.5 1382.9 1383.3 1391.2 1392.7 877.6 885.5 894.1 907.7 916.6 4097.2 4102.7 4130.3 4159.6 4170.7 4782.7 4819.0 4819.7 4820.3 4856.9 4131.4 4148.8 4170.4 4171.3 4184.9 2439.8 2547.8 2548.9 2549.5 2554.9 4531.4 4540.4 4541.0 4545.6 4634.8 4799.9 4803.7 4810.5 4846.9 4859.2 4328.7 4394.6 4538.5 4542.0 4552.4 4762.3 4770.7 4774.8 4781.3 4826.5 4619.8 4629.0 4650.7 4682.8 4686.2 4297.9 4544.8 4598.8 4607.8 4656.5 3576.4 3708.6 3745.9 3871.5 3879.5 5337.4 5410.8 5413.2 5431.6 5444.6 5226.4 5232.5 5239.3 5241.3 5269.3 5093.5 5108.9 5170.3 5212.3 5221.3 5064.4 5093.9 5138.0 5154.2 5186.5 5216.5 5283.1 5286.2 5291.8 5340.6 5013.2 5105.7 5132.2 5145.5 5149.4 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - PROCESS | 9332 | [#5] yui.html Cycles:180 Average:17398.20 Median:44341.16 stddev:24465.62 (55.2%) stddev-sans-first:24501.86 21:26:03 INFO - PROCESS | 9332 | Values: 630.7 636.3 645.3 719.9 732.2 12107.6 12684.2 12807.7 12855.6 12862.3 12828.0 13161.7 13162.3 13170.3 13201.0 739.2 756.4 758.8 791.5 795.1 783.7 789.7 791.3 794.5 795.1 823.6 827.4 829.2 831.7 833.7 820.4 822.6 823.9 825.1 825.6 602.1 604.6 605.6 607.3 607.3 13040.3 13084.4 13149.7 13177.5 13226.4 12905.4 13087.7 13146.3 13374.1 13750.3 10818.2 10830.5 10849.5 10953.9 11130.2 3232.8 3287.8 3293.8 3311.9 3323.6 63391.4 64140.4 64166.4 64374.0 64704.0 10191.1 10380.9 10446.9 10489.7 10613.4 16560.8 16589.4 16664.7 16695.5 16707.5 6834.5 6946.2 6961.4 7055.2 7227.8 3895.6 3952.6 3961.4 3993.9 4040.7 2903.1 3002.1 3017.0 3017.7 3025.3 501.8 507.0 514.2 521.0 523.3 533.6 576.8 595.6 631.2 632.6 8173.7 8274.3 8444.0 8473.4 8495.3 589.8 596.7 598.6 612.6 621.6 3812.2 4135.3 4158.0 4256.2 4302.0 84365.6 94962.0 96979.5 97477.5 97635.1 76401.0 81780.0 82491.6 82531.8 82601.0 59495.4 62153.1 72463.3 72899.0 75595.0 8413.9 8589.9 8748.7 9013.5 9236.7 32103.8 34410.7 40306.2 43228.0 45454.3 56527.4 64350.7 64907.7 65528.0 65620.0 11123.6 11140.3 11148.1 11285.4 11384.8 12832.4 12953.7 12972.0 13575.6 13807.1 11464.6 11575.8 11742.5 11833.9 12254.8 12064.3 12151.2 12590.4 13025.9 13125.8 10939.2 11479.8 11694.1 11927.4 11974.7 9796.0 9905.7 10092.6 10221.3 10607.3 9831.7 10244.4 10299.0 10430.7 10612.5 21:26:03 INFO - PROCESS | 9332 | -------- Summary: end -------- 21:26:03 INFO - PROCESS | 9332 | 21:26:03 INFO - TEST-INFO | 9332: exit 0 21:26:03 INFO - TEST-OK | dromaeo_css | took 1117000ms 21:26:03 INFO - TEST-START | kraken 21:26:03 INFO - operating with platform_type : linux_ 21:26:03 INFO - Initialising browser for kraken test... 21:26:03 INFO - TEST-INFO | started process 9572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsx255/profile http://localhost:56396/getInfo.html) 21:26:08 INFO - PROCESS | 9572 | __metrics Screen width/height:1600/1200 21:26:08 INFO - PROCESS | 9572 | colorDepth:24 21:26:08 INFO - PROCESS | 9572 | Browser inner width/height: 1024/697 21:26:08 INFO - PROCESS | 9572 | __metrics 21:26:09 ERROR - PROCESS | 9572 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:26:10 INFO - TEST-INFO | 9572: exit 0 21:26:10 INFO - Browser initialized. 21:26:10 INFO - Running cycle 1/1 for kraken test... 21:26:10 INFO - TEST-INFO | started process 9690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsx255/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:26:22 INFO - PROCESS | 9690 | RSS: Main: 168513536 21:26:22 INFO - PROCESS | 9690 | 21:26:24 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56396/tests/kraken/driver.html?testName=audio-beat-detection) 21:26:25 INFO - PROCESS | 9690 | RSS: Main: 172871680 21:26:25 INFO - PROCESS | 9690 | 21:26:28 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56396/tests/kraken/driver.html?testName=audio-dft) 21:26:29 INFO - PROCESS | 9690 | RSS: Main: 173031424 21:26:29 INFO - PROCESS | 9690 | 21:26:31 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56396/tests/kraken/driver.html?testName=audio-fft) 21:26:32 INFO - PROCESS | 9690 | RSS: Main: 167739392 21:26:32 INFO - PROCESS | 9690 | 21:26:34 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56396/tests/kraken/driver.html?testName=audio-oscillator) 21:26:35 INFO - PROCESS | 9690 | RSS: Main: 168476672 21:26:35 INFO - PROCESS | 9690 | 21:26:37 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:26:38 INFO - PROCESS | 9690 | RSS: Main: 168443904 21:26:38 INFO - PROCESS | 9690 | 21:26:41 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56396/tests/kraken/driver.html?testName=imaging-darkroom) 21:26:42 INFO - PROCESS | 9690 | RSS: Main: 168747008 21:26:42 INFO - PROCESS | 9690 | 21:26:45 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56396/tests/kraken/driver.html?testName=imaging-desaturate) 21:26:46 INFO - PROCESS | 9690 | RSS: Main: 166174720 21:26:46 INFO - PROCESS | 9690 | 21:26:49 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56396/tests/kraken/driver.html?testName=json-parse-financial) 21:26:49 INFO - PROCESS | 9690 | RSS: Main: 168296448 21:26:49 INFO - PROCESS | 9690 | 21:26:51 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:26:52 INFO - PROCESS | 9690 | RSS: Main: 168386560 21:26:52 INFO - PROCESS | 9690 | 21:26:54 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:26:54 INFO - PROCESS | 9690 | RSS: Main: 168509440 21:26:54 INFO - PROCESS | 9690 | 21:26:56 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:26:57 INFO - PROCESS | 9690 | RSS: Main: 168742912 21:26:57 INFO - PROCESS | 9690 | 21:27:00 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:27:01 INFO - PROCESS | 9690 | RSS: Main: 168677376 21:27:01 INFO - PROCESS | 9690 | 21:27:03 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:27:04 INFO - PROCESS | 9690 | RSS: Main: 168763392 21:27:04 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | Cycle 1(1): loaded http://localhost:56396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56396/tests/kraken/driver.html?testName=ai-astar) 21:27:06 INFO - PROCESS | 9690 | RSS: Main: 170029056 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | __start_tp_report 21:27:06 INFO - PROCESS | 9690 | _x_x_mozilla_page_load 21:27:06 INFO - PROCESS | 9690 | _x_x_mozilla_page_load_details 21:27:06 INFO - PROCESS | 9690 | |i|pagename|runs| 21:27:06 INFO - PROCESS | 9690 | |0;ai-astar;105;114;108;114;114;116;118;115;112;113 21:27:06 INFO - PROCESS | 9690 | |1;audio-beat-detection;151;122;152;178;126;149;143;125;187;121 21:27:06 INFO - PROCESS | 9690 | |2;audio-dft;163;164;163;164;170;167;163;165;162;162 21:27:06 INFO - PROCESS | 9690 | |3;audio-fft;76;77;77;147;78;77;76;76;173;77 21:27:06 INFO - PROCESS | 9690 | |4;audio-oscillator;84;85;143;86;84;86;142;85;85;135 21:27:06 INFO - PROCESS | 9690 | |5;imaging-gaussian-blur;119;119;117;120;117;118;117;118;117;118 21:27:06 INFO - PROCESS | 9690 | |6;imaging-darkroom;148;148;148;147;147;148;147;147;147;147 21:27:06 INFO - PROCESS | 9690 | |7;imaging-desaturate;96;96;96;96;96;97;96;96;97;95 21:27:06 INFO - PROCESS | 9690 | |8;json-parse-financial;64;64;64;65;70;63;64;64;63;64 21:27:06 INFO - PROCESS | 9690 | |9;json-stringify-tinderbox;67;67;67;66;67;66;68;67;68;71 21:27:06 INFO - PROCESS | 9690 | |10;stanford-crypto-aes;79;85;79;78;80;80;87;79;82;79 21:27:06 INFO - PROCESS | 9690 | |11;stanford-crypto-ccm;146;130;145;137;130;139;148;130;163;134 21:27:06 INFO - PROCESS | 9690 | |12;stanford-crypto-pbkdf2;163;165;164;164;166;178;166;165;164;166 21:27:06 INFO - PROCESS | 9690 | |13;stanford-crypto-sha256-iterative;72;77;71;67;68;66;67;65;67;67 21:27:06 INFO - PROCESS | 9690 | __end_tp_report 21:27:06 INFO - PROCESS | 9690 | __start_cc_report 21:27:06 INFO - PROCESS | 9690 | _x_x_mozilla_cycle_collect,1007 21:27:06 INFO - PROCESS | 9690 | __end_cc_report 21:27:06 INFO - PROCESS | 9690 | __startTimestamp1468902426649__endTimestamp 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | ------- Summary: start ------- 21:27:06 INFO - PROCESS | 9690 | Number of tests: 14 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.81 (3.3%) stddev-sans-first:2.77 21:27:06 INFO - PROCESS | 9690 | Values: 105.0 114.0 108.0 114.0 114.0 116.0 118.0 115.0 112.0 113.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:150.00 stddev:23.15 (15.4%) stddev-sans-first:24.46 21:27:06 INFO - PROCESS | 9690 | Values: 151.0 122.0 152.0 178.0 126.0 149.0 143.0 125.0 187.0 121.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.50 (1.5%) stddev-sans-first:2.60 21:27:06 INFO - PROCESS | 9690 | Values: 163.0 164.0 163.0 164.0 170.0 167.0 163.0 165.0 162.0 162.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#3] audio-fft Cycles:10 Average:93.40 Median:77.00 stddev:35.64 (46.3%) stddev-sans-first:37.24 21:27:06 INFO - PROCESS | 9690 | Values: 76.0 77.0 77.0 147.0 78.0 77.0 76.0 76.0 173.0 77.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:85.00 stddev:26.66 (31.4%) stddev-sans-first:27.51 21:27:06 INFO - PROCESS | 9690 | Values: 84.0 85.0 143.0 86.0 84.0 86.0 142.0 85.0 85.0 135.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 21:27:06 INFO - PROCESS | 9690 | Values: 119.0 119.0 117.0 120.0 117.0 118.0 117.0 118.0 117.0 118.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:27:06 INFO - PROCESS | 9690 | Values: 148.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:27:06 INFO - PROCESS | 9690 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 95.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 21:27:06 INFO - PROCESS | 9690 | Values: 64.0 64.0 64.0 65.0 70.0 63.0 64.0 64.0 63.0 64.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 21:27:06 INFO - PROCESS | 9690 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 68.0 67.0 68.0 71.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:2.97 (3.7%) stddev-sans-first:3.08 21:27:06 INFO - PROCESS | 9690 | Values: 79.0 85.0 79.0 78.0 80.0 80.0 87.0 79.0 82.0 79.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:142.00 stddev:10.54 (7.4%) stddev-sans-first:10.97 21:27:06 INFO - PROCESS | 9690 | Values: 146.0 130.0 145.0 137.0 130.0 139.0 148.0 130.0 163.0 134.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:165.50 stddev:4.31 (2.6%) stddev-sans-first:4.42 21:27:06 INFO - PROCESS | 9690 | Values: 163.0 165.0 164.0 164.0 166.0 178.0 166.0 165.0 164.0 166.0 21:27:06 INFO - PROCESS | 9690 | 21:27:06 INFO - PROCESS | 9690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:67.50 stddev:3.62 (5.4%) stddev-sans-first:3.64 21:27:06 INFO - PROCESS | 9690 | Values: 72.0 77.0 71.0 67.0 68.0 66.0 67.0 65.0 67.0 67.0 21:27:06 INFO - PROCESS | 9690 | -------- Summary: end -------- 21:27:06 INFO - PROCESS | 9690 | 21:27:07 INFO - TEST-INFO | 9690: exit 0 21:27:07 INFO - TEST-OK | kraken | took 63775ms 21:27:07 INFO - SUITE-END | took 1180s 21:27:07 INFO - Completed test suite (00:19:40) 21:27:07 INFO - javascript benchmark 21:27:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6373.17770819028, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.98695006525, 2665.8800353984075, 2668.786497080234, 2687.1132526266333, 2706.120510833978, 4786.2342025276, 4835.0571638530455, 4864.294677271793, 4866.805327786893, 4880.365552478182, 4718.598919091873, 4768.308595253686, 4876.561109500144, 4892.168331383665, 4901.3138160657445, 4369.060651959828, 4370.628496577787, 4483.237849565566, 4490.7530085845265, 4499.842505512308, 4178.749275043507, 4491.056878055596, 4495.505494395614, 4569.565891240327, 4586.8394606188795, 4321.157374312011, 4409.074094440171, 4440.622547083502, 4504.729716217037, 4514.706544074657, 4441.067375851075, 4479.865604031885, 4480.843170489017, 4497.730136191839, 4532.410786597754, 4472.262076757331, 4472.619827314682, 4481.619062379702, 4486.147631949919, 4512.187806194884, 4758.357621721093, 4867.586255168279, 4883.291922671193, 4891.364122664031, 4900.117978763821, 5201.271821944931, 5225.555827754645, 5232.73836308183, 5244.108501554745, 5272.525472707436, 5034.11902916988, 5156.716380599066, 5255.054090263751, 5261.973690131563, 5272.551833094191, 4810.110129625996, 4840.733759643183, 4848.12733707936, 4852.272159176152, 4899.681520701179, 5315.123004704258, 5327.09439395296, 5330.866728331823, 5330.9733451332495, 5386.757595908193, 4899.828506002273, 4963.478834722375, 4990.0, 5107.693538387709, 5114.43741188469, 5019.52314530119, 5075.289459475676, 5081.720505372166, 5091.821786237464, 5093.694378337312, 5106.974465127725, 5159.406668233126, 5165.0, 5173.71544565045, 5227.424983251839, 5106.080905437057, 5109.259157422227, 5115.693058416507, 5118.948810511847, 5161.767720452589, 4155.771432571238, 4216.072464057902, 4220.388043733641, 4223.028703398236, 4286.721363111388, 3744.8314825832904, 3782.8486860525272, 3785.261873934556, 3815.828287727059, 3819.52255968004, 4409.977950110293, 4430.800613972379, 4432.246518091933, 4450.688451808407, 4454.5990860822685, 4959.603231741452, 5176.456472070454, 5177.145770947752, 5180.274761533388, 5191.8182863599595, 4487.842925497592, 4505.805961420227, 4518.548145185455, 4530.682852200314, 4542.046170304273, 4674.719516829001, 4708.717476951394, 4712.505186955389, 4730.905381892343, 4764.30917516965, 4631.421072365954, 4834.854954351375, 4853.587445067067, 4882.60939124862, 4951.232558953368, 5097.158968770112, 5130.204818253177, 5150.047241260229, 5155.690658560498, 5197.064528384927, 4873.46391896884, 4874.463808980939, 4886.926696099633, 4898.681585696918, 4933.186024306093, 4931.950680493293, 4989.25161225819, 5034.0686972910125, 5046.394432667957, 5052.545270925634, 5077.949220507895, 5108.719020453911, 5115.0, 5117.488251174853, 5163.5610973066205, 4778.856634300976, 4961.181405068123, 4962.528559786814, 4981.252812078217, 4983.352164218629, 4847.563719265283, 4952.479989601185, 4976.10430122567, 4981.800727970841, 5043.949560504348, 4893.535114164149, 4915.926261106158, 4919.1883339248625, 4924.63065270099, 5018.5232402921665, 4840.128776820206, 5065.164247899055, 5074.619403544675, 5081.974590127025, 5090.440051594248, 4867.269909513459, 4906.435759887659, 4919.729414882216, 4923.950760492349, 4929.457759646508], "value": 4728.290191390799, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.802690045034, 560.4591569135781, 571.6970005896874, 576.7923547522893, 594.0465552787779, 34863.128421789435, 39493.40759888597, 39538.209235815266, 39565.20869582607, 39642.801785991105, 39993.800030999875, 40204.59795402045, 40464.0, 40577.0, 40698.796506017505, 7768.339691126247, 7921.049474063092, 7962.40281978851, 7963.641636126359, 7975.361971042303, 7852.528848269094, 7891.092524359715, 7905.288524032836, 7929.0, 7933.484323518982, 7819.9218007820045, 7906.407019473534, 7908.841823163533, 7943.523388596674, 7961.0, 7893.0922943861615, 7913.802154946115, 7936.920630793676, 7940.483868548526, 7951.642176102089, 7828.843423131506, 7900.288973992311, 7928.167542408022, 7941.722039728582, 7943.682252709885, 38023.66917157914, 38399.232015359536, 38441.80779096087, 38452.80773596114, 38528.42207366892, 2956.763458923281, 3111.424386488507, 3113.081640915935, 3143.7327827134723, 3154.7318477929402, 29645.258868528243, 29695.70304296951, 29746.553801692993, 30162.09513714592, 30316.393672126655, 3389.1357703785375, 3421.9828900855337, 3435.7423193260606, 3477.9130521736906, 3483.2336885885065, 254334.0, 254573.0, 256270.0, 256539.0, 257562.99999999814, 31401.685983139876, 31951.840240799113, 54370.72814635901, 54664.45335546673, 54715.45284547183, 33083.834580826944, 33517.49723754146, 33548.83225583905, 33563.16092097717, 33621.327573448885, 13247.536336228186, 13343.466261349631, 13408.262545560088, 13430.328483575977, 13481.797773033413, 10959.83560246597, 10975.0, 10987.736410312757, 11063.059639930696, 11111.444427778579, 7777.455578109591, 7884.093329267093, 7909.932159158555, 7945.602719863984, 7966.880496792553, 3114.408262430131, 3119.0642807158215, 3131.3424180921807, 3142.2301536123796, 3149.2441813964483, 884.4516399832145, 889.2752406788446, 929.3401684803865, 982.626601891291, 984.2224642532319, 26266.868665656548, 27219.86390068037, 27326.713008937437, 27588.586171207447, 27603.171904842486, 880.7930136417937, 938.8826396700413, 971.504532688334, 987.7579992901785, 1027.1782573940966, 14699.265036748333, 14926.179060151579, 15073.0, 15087.822334596, 15148.924255378874, 380509.0, 385309.0, 386434.0, 389181.0, 389756.0, 50368.74815625898, 50394.0, 50745.23882141771, 50773.0, 51033.74483127635, 1154.5151036564664, 1187.0147777344955, 1191.7139886427194, 1192.874748151449, 1202.8496437945432, 26047.609285860348, 27474.0, 27515.31211719723, 27574.172774816787, 27579.31051723723, 43166.352504711824, 43445.78277108721, 43690.126197475234, 43697.0, 43754.562454375045, 329640.0, 331216.0, 331459.0, 332352.0, 333148.0, 25228.62157067609, 25538.872305638353, 25816.514770505742, 25911.22266332013, 25919.0, 39174.60825391824, 41185.176296473306, 42234.57765422307, 42379.364309535995, 42677.0, 36400.0, 36609.0, 36680.633193668786, 36888.63111368852, 37006.44490332701, 35527.46708799319, 36035.63964360323, 36099.0, 36159.0, 36607.26785464329, 30055.398892022473, 34420.24638029002, 34968.65031349654, 35553.82223088972, 37476.25047499089, 31419.528707068956, 33234.0, 33367.49948750722, 33457.66542334643, 33560.83219583886, 24738.752612473643, 25480.8725956369, 25734.871325643253, 25809.0, 25824.8708756455], "value": 16490.466851446778, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.62106099126413, 365.72570572070947, 373.33918963434724, 374.1357464257567, 384.6653411531968, 15790.289436975336, 17525.29898804048, 17691.911540442314, 18147.81852181481, 18184.363547275814, 15765.290561924712, 16873.493795186132, 17909.10454477274, 18004.189811458484, 18050.27798888043, 4622.953770462294, 4788.832390866321, 4825.0, 4827.710337379768, 4836.951630483685, 3567.3757092508836, 4703.388559487279, 5294.735263236842, 5565.972170139164, 5578.888422231553, 5597.384287728347, 5633.155026746001, 5646.830595082133, 5648.209250704905, 5657.0, 5531.612787104904, 5580.107182850745, 5641.68970706611, 5650.3219613646215, 5653.010723123458, 5387.1380579107545, 5428.67427954324, 5449.373322067973, 5454.672719636835, 5464.453554644543, 12837.358132093357, 14483.0, 20284.188632454683, 20885.68671469929, 20900.790992090035, 1728.9394871179447, 1764.0738612228554, 1889.697648376267, 1890.6596812573732, 2003.8396928245852, 9108.59011344491, 9139.360244782867, 9284.118008789153, 9369.109934556207, 9587.376820506644, 1655.8592519635724, 1711.366794286122, 1724.4998950304396, 1753.1672455583623, 1755.4382597568783, 71041.64479177623, 71209.28790712079, 71428.2857171432, 73250.63374683092, 75716.62141689312, 9873.555689993967, 10083.0, 10106.140978016803, 10137.797244055226, 10322.845157322647, 13851.930740346234, 14017.929910350587, 14040.648983775283, 14156.0, 14171.503997360043, 7279.59962202084, 7366.189719130892, 7538.623068846536, 7612.657430415645, 7665.961670191725, 7175.928240717631, 7299.671514781848, 7341.045664063638, 7387.963060184665, 7429.5542267464125, 4255.127698821734, 4281.828726850891, 4363.149185908717, 4369.257226271541, 4460.553944605578, 1674.8995060296422, 1687.637158011009, 1767.3460819496868, 1873.681474149398, 1907.9904600477187, 763.6067425275987, 894.4990805149138, 936.3258453913172, 952.6951375559754, 976.1848856205006, 17184.484465466056, 17268.481945541655, 17278.30886764515, 17709.911450442665, 18018.549536261435, 856.0497847389393, 859.9570021499026, 890.3144578674385, 927.5779520318239, 939.2626787971546, 9651.806963860683, 9876.111149996535, 9897.554610042565, 9957.950210248902, 9977.800443991226, 400802.0, 402596.0, 406324.0, 420397.0, 421885.0, 79422.0, 80242.19757802464, 80727.59636201781, 80737.19262807297, 80913.0, 887.4292502270944, 889.3418870036256, 900.617237673999, 903.214203642835, 904.7511934218011, 15358.923205384348, 15491.380344786083, 15547.222638868237, 15582.298796554409, 16057.598560036093, 36888.63111368852, 37662.623373767005, 38417.0, 38909.6109038906, 39930.60069399385, 54163.0, 54401.455985439636, 54822.0, 54990.0, 55024.72487637536, 7439.8140046499275, 7465.776026719207, 7768.689252429839, 7838.80402989907, 7878.015248093989, 10304.742381440525, 11410.201285909907, 11431.828522572334, 11560.42197890119, 11893.108016898594, 10277.0, 10481.213908956706, 10706.357618542912, 10803.189760767817, 10806.513706883366, 8571.742847714579, 8690.739277821676, 10211.387316761018, 10328.845067323846, 10388.42863642507, 10353.430561318899, 10465.319754215952, 10747.838782418114, 10856.402897840695, 11305.604303849326, 6641.933580664131, 6996.720131194696, 7101.467389945671, 7108.147022357351, 7626.923730762622, 7846.568438735924, 9955.701328960144, 10632.362058276529, 10792.730181745519, 10808.675739727822], "value": 8249.942649065224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.6048176269762, 1421.4669498937897, 1519.9696006079878, 1689.9915500422496, 1717.064200010993, 6780.355866192704, 7479.0, 7604.429667774912, 7995.120536740954, 8013.799655008627, 7713.151553329143, 7931.405144614148, 7953.0, 8013.559254241014, 8021.959890200541, 2181.8799966001825, 2210.115953618549, 2212.1151539384296, 2215.1693115081844, 2220.944476388087, 2147.559750251203, 2177.7168968034134, 2217.84475086744, 2220.0342850859847, 2221.244776775896, 2162.859414138076, 2163.210428193706, 2169.652855543113, 2177.2597316912247, 2209.0832304593573, 2164.512984578465, 2173.880436575988, 2174.1086154676664, 2174.749903761072, 2175.1625624134663, 2111.4721319670084, 2168.0, 2173.71741673583, 2174.63031284682, 2175.1299480207886, 7970.601469926539, 8082.636281367352, 8092.1503242159315, 8101.837963240761, 8125.471844330159, 4443.0, 4580.061087477059, 4591.977040114812, 4609.170349337118, 4610.67725259232, 2751.697313295536, 2764.14311563416, 2825.7456828885497, 2839.105681710255, 2876.5685147227873, 855.3456605696647, 869.3436455476138, 889.1020069729619, 895.7447127568612, 897.7082448204294, 10183.134433573156, 10257.43584102874, 10261.640842570549, 10271.69184924446, 10288.022637849392, 3981.6018398159954, 4085.2442298174933, 4192.727472714264, 4201.789910504463, 4216.810243539048, 8968.955155224183, 8984.730458086267, 8997.0, 9005.324600654978, 9026.954865225633, 4572.177008138567, 4575.7483338416705, 4576.222042252825, 4578.610818080434, 4585.885352866205, 3660.194757153422, 4199.832006719758, 4207.26372884744, 4264.168487145039, 4436.979494716169, 3674.375356189454, 3732.346839303111, 3772.962270377316, 3804.771713697187, 3829.119302560371, 1178.9233699809486, 1190.4404929683035, 1213.3266037349179, 1217.896478799312, 1227.2697744841805, 771.4561234329784, 866.9293422623056, 880.2561835249204, 897.3628723606313, 912.2792993535033, 5492.642978206483, 5502.284702988586, 5502.915270440543, 5571.192177134374, 5798.797042103506, 395.8931088606118, 412.62451169435667, 417.7347384410921, 418.1511531590875, 420.487005852859, 3805.9809700951873, 3850.114473671071, 3913.373860182357, 3923.097687531884, 3938.822752976123, 9217.76955576116, 9868.963758805223, 9885.25860560461, 9909.752256193653, 10004.649837255662, 9632.47021413829, 9897.455639939872, 9900.059494348025, 9938.105570498545, 9955.203583713286, 7470.551766894004, 7518.812029699301, 7578.886316705254, 7594.354479869273, 7597.772066837893, 5208.557272631869, 5259.39516955555, 5503.7798488060025, 5543.6396634218645, 5650.0, 8961.372703910663, 9219.078092190728, 9264.72205833826, 9280.860787088064, 9282.814343713222, 8946.239569636653, 9215.86176207344, 9272.907270927204, 9447.385919915183, 9474.478903660365, 6165.691715414301, 6458.289588145206, 6655.700493477902, 6974.895376569457, 7015.193252775792, 7666.041744781903, 7689.730859419893, 7699.191584883507, 7736.071671399468, 7775.494592851446, 6647.7008534617025, 6657.900131498128, 6686.732530698718, 6714.462842972453, 6716.764913228014, 6719.092922455406, 6770.966145169243, 6828.931710682829, 6893.345132212432, 6963.512554121163, 6469.417752402118, 6472.805815825533, 6478.611283323015, 6511.088447617242, 6574.901376479261, 4601.539846015372, 4676.462206846256, 4677.602403795716, 4683.1336202802595, 4742.336072949859, 4410.647148228199, 4469.329600559942, 4583.472900616472, 4591.770411479346, 4619.053094115766], "value": 4102.543210184608, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.4253841202038, 297.3799627776087, 309.6315384692215, 310.46444882577555, 310.8461311650733, 4869.975650121744, 4925.753712314379, 5047.596192304616, 5125.513076257755, 5132.127538318486, 4946.258061290808, 4985.775640096195, 5020.322256495372, 5025.924611130836, 5047.974760126194, 3945.7632542047427, 3962.346212874872, 3964.980175099128, 3991.4853642205517, 3991.540972788123, 3875.0, 3957.1689945111416, 3969.0871099646956, 3995.1809878974886, 4007.657434759359, 3913.2956067907767, 3918.804059797013, 3931.2727145478034, 3932.154586763845, 3961.6236457536634, 3927.9214415711526, 3935.9803200983956, 3949.5063117110217, 3957.7625342479255, 3969.7419667721506, 3352.7150192233444, 3465.8440370183403, 3483.477478378238, 3502.5446691929887, 3506.0884170115955, 4837.153498137812, 4872.439669438025, 4880.365552478191, 4890.193118135503, 4891.168501354743, 4462.0, 4463.665225108098, 4485.865424037284, 4507.977460112711, 4516.525764794715, 4958.256261560795, 5223.37319521656, 5241.606879484016, 5262.921146147289, 5289.788408463657, 3853.614638536152, 3859.7298189126773, 3861.6524512793985, 3870.78710670913, 3873.1866308075337, 5510.9448905510835, 5585.664860108406, 5588.273524441796, 5591.524720398771, 5592.384837667853, 3682.410814269704, 3944.3097457944746, 3957.56466788653, 3960.2475529649273, 3961.8811435656976, 3954.4463775071513, 3968.6229808168177, 3984.362501999666, 3985.720999530005, 4013.7391069580385, 4503.594676479132, 4528.909421811545, 4533.38799262102, 4537.886552836139, 4544.613707834871, 5311.468853114658, 5312.1500559911, 5316.175992721134, 5329.387120481117, 5334.586334621328, 1340.5040135150057, 1382.8755412012968, 1383.3359987205997, 1391.1653008195, 1392.6587985943509, 877.5963056993854, 885.5129678676702, 894.1371576428647, 907.7231444409387, 916.6241840845355, 4097.221527909687, 4102.692298077656, 4130.339145736668, 4159.584041595876, 4170.666346692257, 4782.665213435026, 4819.0, 4819.674589487919, 4820.325154478376, 4856.854294371175, 4131.442255295497, 4148.771817550064, 4170.350942924941, 4171.290880550314, 4184.937225941613, 2439.7682220189054, 2547.7707006369515, 2548.949021019569, 2549.5028469448653, 2554.948901021969, 4531.410916580823, 4540.364348991144, 4540.954590454119, 4545.5908968193025, 4634.768261586907, 4799.904001919942, 4803.687760295639, 4810.470848206694, 4846.903061938741, 4859.198232291632, 4328.696991210585, 4394.572233657752, 4538.500764915857, 4542.0, 4552.385427967182, 4762.333273341805, 4770.666053376369, 4774.7851346688785, 4781.306710526885, 4826.517348265286, 4619.769011549476, 4629.0, 4650.651311119737, 4682.789274482589, 4686.203345431217, 4297.935530967101, 4544.795484203285, 4598.793054312497, 4607.769611519478, 4656.534346565317, 3576.4098923678343, 3708.610595887501, 3745.85016599333, 3871.535415750128, 3879.5344558652014, 5337.439568845371, 5410.78356865721, 5413.160960051198, 5431.5926305526455, 5444.6188766785945, 5226.398964119175, 5232.450592687713, 5239.266502689703, 5241.292425522505, 5269.314989051399, 5093.516115968977, 5108.9233661495855, 5170.3278573785165, 5212.296339994053, 5221.269022336952, 5064.404712515546, 5093.898122037464, 5137.974310128426, 5154.175331946871, 5186.455422180617, 5216.452272511484, 5283.101872681576, 5286.180642000496, 5291.814786482455, 5340.5994550408095, 5013.197888337849, 5105.744712764273, 5132.153194722829, 5145.511176438382, 5149.356330458692], "value": 3847.1671996739606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.6909614288994, 636.3382082634058, 645.303072681504, 719.8776208044632, 732.168988198395, 12107.636770896865, 12684.238945663266, 12807.743845123092, 12855.55005574805, 12862.292573908442, 12828.0, 13161.670958226048, 13162.341882905841, 13170.341482925864, 13201.0, 739.2496615934831, 756.4137793210278, 758.8216769059267, 791.5211297165218, 795.1412474527497, 783.7100272899036, 789.6604460082162, 791.2996997657058, 794.527256282511, 795.0697683710044, 823.5923218007094, 827.3794654009492, 829.1873963515758, 831.6922738586732, 833.6665333866441, 820.3929092471558, 822.6421506644568, 823.9134890836466, 825.1171246765933, 825.5748289630845, 602.1269159718382, 604.5526310530176, 605.6063558686844, 607.3046361915582, 607.3046361915626, 13040.347982600832, 13084.411201495956, 13149.737005259936, 13177.472901083946, 13226.404811783494, 12905.35473226335, 13087.672808179777, 13146.342682865818, 13374.13068150567, 13750.312484375841, 10818.22626186033, 10830.512626931728, 10849.511771970201, 10953.945230273797, 11130.220884538086, 3232.773705840592, 3287.7534184936226, 3293.7859039162618, 3311.9172020699434, 3323.5845519310087, 63391.36608633947, 64140.358596413906, 64166.358336416975, 64374.0, 64704.0, 10191.101806590843, 10380.896191037993, 10446.947765261126, 10489.685309440729, 10613.363198208132, 16560.834391655928, 16589.419370322223, 16664.666706665797, 16695.49913502597, 16707.498775036525, 6834.521583489108, 6946.235914049451, 6961.443084553223, 7055.188653304833, 7227.819304517324, 3895.6299151580556, 3952.5849785772657, 3961.445397644332, 3993.880183594497, 4040.6565441937178, 2903.129061281607, 3002.0993701889347, 3016.9849150754108, 3017.683143269925, 3025.3495498467937, 501.8068043803162, 506.98732531686267, 514.238926388939, 520.9921851172236, 523.3196844102652, 533.5918022712628, 576.7952376906222, 595.6188039654625, 631.2141383976887, 632.6330728177646, 8173.713920012771, 8274.255317021498, 8444.028936672361, 8473.3644976627, 8495.320374370036, 589.8053642298117, 596.7105953612495, 598.5540772124795, 612.5650787940523, 621.6239175298879, 3812.237552489458, 4135.31767258405, 4157.97921010393, 4256.191323648497, 4301.978490107529, 84365.57817210998, 94962.0, 96979.51510242544, 97477.5126124379, 97635.09459621678, 76401.0, 81780.0, 82491.58754206191, 82531.7620235697, 82601.0, 59495.405045949854, 62153.067703984474, 72463.27536724671, 72899.0, 75595.0, 8413.915860841558, 8589.871151932852, 8748.69379571712, 9013.549322533716, 9236.676716314896, 32103.839480802446, 34410.655893440744, 40306.193876121724, 43228.0, 45454.31818522791, 56527.434725652216, 64350.67824660847, 64907.67546162239, 65528.0, 65620.0, 11123.555057797597, 11140.33158010522, 11148.108151348035, 11285.37930413835, 11384.772304554028, 12832.358382080673, 12953.676158096123, 12972.0, 13575.592732217654, 13807.081320651121, 11464.598739044093, 11575.76848463043, 11742.471588778697, 11833.940830295793, 12254.754904901674, 12064.336461494702, 12151.210171338835, 12590.370481476073, 13025.869741302466, 13125.803112953123, 10939.179561533076, 11479.770404591694, 11694.064474842162, 11927.403629818647, 11974.700632484257, 9796.0, 9905.653302134391, 10092.646757363456, 10221.33561318512, 10607.257491975488, 9831.705048848546, 10244.385336879812, 10299.0, 10430.68707938763, 10612.469376530988], "value": 6599.44536757465, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 108.0, 114.0, 114.0, 116.0, 118.0, 115.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 152.0, 178.0, 126.0, 149.0, 143.0, 125.0, 187.0, 121.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 170.0, 167.0, 163.0, 165.0, 162.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 147.0, 78.0, 77.0, 76.0, 76.0, 173.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 143.0, 86.0, 84.0, 86.0, 142.0, 85.0, 85.0, 135.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 120.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 70.0, 63.0, 64.0, 64.0, 63.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 68.0, 67.0, 68.0, 71.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 79.0, 78.0, 80.0, 80.0, 87.0, 79.0, 82.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 130.0, 145.0, 137.0, 130.0, 139.0, 148.0, 130.0, 163.0, 134.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 164.0, 166.0, 178.0, 166.0, 165.0, 164.0, 166.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 71.0, 67.0, 68.0, 66.0, 67.0, 65.0, 67.0, 67.0], "value": 68.7, "unit": "score"}]}]} 21:27:07 INFO - Return code: 0 21:27:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:27:07 ERROR - # TBPL SUCCESS # 21:27:07 INFO - Running post-action listener: _resource_record_post_action 21:27:07 INFO - ##### 21:27:07 INFO - ##### Finished run-tests step (success) 21:27:07 INFO - ##### 21:27:07 INFO - Running post-run listener: _resource_record_post_run 21:27:08 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540233728; Read time: 8; Write time: 529276 21:27:08 INFO - TinderboxPrint: CPU usage
13.4% 21:27:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:27:08 INFO - TinderboxPrint: I/O write bytes / time
540,233,728 / 529,276 21:27:08 INFO - TinderboxPrint: CPU idle
8,271.4 (86.6%) 21:27:08 INFO - TinderboxPrint: CPU user
1,226.6 (12.8%) 21:27:08 INFO - TinderboxPrint: Swap in / out
0 / 0 21:27:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250568704; Read time: 0; Write time: 295332 21:27:08 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289345536; Read time: 8; Write time: 233904 21:27:08 INFO - Running post-run listener: _upload_blobber_files 21:27:08 INFO - Blob upload gear active. 21:27:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:27:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:27:08 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:27:08 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:27:08 INFO - (blobuploader) - INFO - Open directory for files ... 21:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:27:09 INFO - (blobuploader) - INFO - Done attempting. 21:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:27:15 INFO - (blobuploader) - INFO - Done attempting. 21:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:27:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:27:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:27:16 INFO - (blobuploader) - INFO - Done attempting. 21:27:16 INFO - (blobuploader) - INFO - Iteration through files over. 21:27:16 INFO - Return code: 0 21:27:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:27:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:27:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/583afcfff23ab7fe70eb24c789a8b11424a33852dd2ce837964625fd288e0c524217542c099941a8c84dd46a59e6355a1c481a1570fc85c89f3a1afc58895274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3777a46da25faae4e80a359e89abf4bd796a32bff69c27ecee04698e3f79ad4587b2049d181c92644a6122944223baba0c13af14c5e8b7e111a2a83b9b2503af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20b8ba4e82823f06b342740d325152b7b1fd77f7064caa6cc2dde8d893530b575a07c0ef84259f78ab3aede8a2f8f9ee37b6cc1dada4eda3c247b76ab20dbcf2"} 21:27:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:27:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:27:16 INFO - Contents: 21:27:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/583afcfff23ab7fe70eb24c789a8b11424a33852dd2ce837964625fd288e0c524217542c099941a8c84dd46a59e6355a1c481a1570fc85c89f3a1afc58895274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3777a46da25faae4e80a359e89abf4bd796a32bff69c27ecee04698e3f79ad4587b2049d181c92644a6122944223baba0c13af14c5e8b7e111a2a83b9b2503af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20b8ba4e82823f06b342740d325152b7b1fd77f7064caa6cc2dde8d893530b575a07c0ef84259f78ab3aede8a2f8f9ee37b6cc1dada4eda3c247b76ab20dbcf2"} 21:27:16 INFO - Running post-run listener: copy_logs_to_upload_dir 21:27:16 INFO - Copying logs to upload dir... 21:27:16 INFO - mkdir: /builds/slave/test/build/upload/logs 21:27:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.406156 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-18 21:27:15.856046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 21:27:15.859711) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500 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/Autoland-Non-PGO/sha512/583afcfff23ab7fe70eb24c789a8b11424a33852dd2ce837964625fd288e0c524217542c099941a8c84dd46a59e6355a1c481a1570fc85c89f3a1afc58895274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3777a46da25faae4e80a359e89abf4bd796a32bff69c27ecee04698e3f79ad4587b2049d181c92644a6122944223baba0c13af14c5e8b7e111a2a83b9b2503af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20b8ba4e82823f06b342740d325152b7b1fd77f7064caa6cc2dde8d893530b575a07c0ef84259f78ab3aede8a2f8f9ee37b6cc1dada4eda3c247b76ab20dbcf2"} build_url:https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/BOLpzaoNT1ynuF8Ug0z69g/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/Autoland-Non-PGO/sha512/583afcfff23ab7fe70eb24c789a8b11424a33852dd2ce837964625fd288e0c524217542c099941a8c84dd46a59e6355a1c481a1570fc85c89f3a1afc58895274", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3777a46da25faae4e80a359e89abf4bd796a32bff69c27ecee04698e3f79ad4587b2049d181c92644a6122944223baba0c13af14c5e8b7e111a2a83b9b2503af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/20b8ba4e82823f06b342740d325152b7b1fd77f7064caa6cc2dde8d893530b575a07c0ef84259f78ab3aede8a2f8f9ee37b6cc1dada4eda3c247b76ab20dbcf2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 21:27:15.885154) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:27:15.885510) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468901196.949785-1965949500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 21:27:15.969356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 21:27:15.969681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 21:27:15.970009) ========= ========= Total master_lag: 0.17 =========