builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1467331931.27 results: success (0) buildid: 20160630143034 builduid: bb118edfcbed47d494165ef6f749edcf revision: 2139ee8230e33662c71179c54502652373d72415 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.271927) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.272427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.272741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.287347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.287643) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 17:12:11-- 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% 42.6M=0s 2016-06-30 17:12:11 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.373180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.373496) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016038 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.422341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:11.422703) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2139ee8230e33662c71179c54502652373d72415 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2139ee8230e33662c71179c54502652373d72415 --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=5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 17:12:11,533 truncating revision to first 12 chars 2016-06-30 17:12:11,533 Setting DEBUG logging. 2016-06-30 17:12:11,533 attempt 1/10 2016-06-30 17:12:11,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2139ee8230e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 17:12:11,873 unpacking tar archive at: fx-team-2139ee8230e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:12.112661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:12.112985) ========= script_repo_revision: 2139ee8230e33662c71179c54502652373d72415 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:12.113425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:12.113702) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 17:12:12.123693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-30 17:12:12.123959) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:12 INFO - MultiFileLogger online at 20160630 17:12:12 in /builds/slave/test 17:12:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:12:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:12 INFO - {'append_to_log': False, 17:12:12 INFO - 'base_work_dir': '/builds/slave/test', 17:12:12 INFO - 'blob_upload_branch': 'Fx-Team', 17:12:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:12 INFO - 'branch': 'Fx-Team', 17:12:12 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:12 INFO - 'config_files': ('talos/linux_config.py',), 17:12:12 INFO - 'default_actions': ('clobber', 17:12:12 INFO - 'read-buildbot-config', 17:12:12 INFO - 'download-and-extract', 17:12:12 INFO - 'populate-webroot', 17:12:12 INFO - 'create-virtualenv', 17:12:12 INFO - 'install', 17:12:12 INFO - 'run-tests'), 17:12:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:12 INFO - 'download_minidump_stackwalk': True, 17:12:12 INFO - 'download_symbols': 'ondemand', 17:12:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:12 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:12 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:12 INFO - 'installer_path': 'installer.exe', 17:12:12 INFO - 'log_level': 'info', 17:12:12 INFO - 'log_name': 'talos', 17:12:12 INFO - 'log_to_console': True, 17:12:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:12 INFO - 'opt_config_files': (), 17:12:12 INFO - 'pip_index': False, 17:12:12 INFO - 'sps_profile': False, 17:12:12 INFO - 'sps_profile_interval': 0, 17:12:12 INFO - 'suite': 'dromaeojs', 17:12:12 INFO - 'system_bits': '32', 17:12:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:12 INFO - 'title': 'talos-linux64-ix-039', 17:12:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:12 INFO - 'use_talos_json': True, 17:12:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:12 INFO - 'work_dir': 'build'} 17:12:12 INFO - ##### 17:12:12 INFO - ##### Running clobber step. 17:12:12 INFO - ##### 17:12:12 INFO - Running pre-action listener: _resource_record_pre_action 17:12:12 INFO - Running main action method: clobber 17:12:12 INFO - rmtree: /builds/slave/test/build 17:12:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:13 INFO - Running post-action listener: _resource_record_post_action 17:12:13 INFO - ##### 17:12:13 INFO - ##### Finished clobber step (success) 17:12:13 INFO - ##### 17:12:13 INFO - ##### 17:12:13 INFO - ##### Running read-buildbot-config step. 17:12:13 INFO - ##### 17:12:13 INFO - Running pre-action listener: _resource_record_pre_action 17:12:13 INFO - Running main action method: read_buildbot_config 17:12:13 INFO - Using buildbot properties: 17:12:13 INFO - { 17:12:13 INFO - "project": "", 17:12:13 INFO - "product": "firefox", 17:12:13 INFO - "script_repo_revision": "production", 17:12:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:12:13 INFO - "repository": "", 17:12:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:12:13 INFO - "buildid": "20160630143034", 17:12:13 INFO - "pgo_build": "True", 17:12:13 INFO - "basedir": "/builds/slave/test", 17:12:13 INFO - "buildnumber": 237, 17:12:13 INFO - "slavename": "talos-linux64-ix-039", 17:12:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:12:13 INFO - "platform": "ubuntu64_hw", 17:12:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:12:13 INFO - "branch": "fx-team", 17:12:13 INFO - "repo_path": "integration/fx-team", 17:12:13 INFO - "revision": "2139ee8230e33662c71179c54502652373d72415", 17:12:13 INFO - "stage_platform": "linux64-pgo", 17:12:13 INFO - "builduid": "bb118edfcbed47d494165ef6f749edcf", 17:12:13 INFO - "slavebuilddir": "test" 17:12:13 INFO - } 17:12:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:12:13 INFO - Running post-action listener: _resource_record_post_action 17:12:13 INFO - ##### 17:12:13 INFO - ##### Finished read-buildbot-config step (success) 17:12:13 INFO - ##### 17:12:13 INFO - ##### 17:12:13 INFO - ##### Running download-and-extract step. 17:12:13 INFO - ##### 17:12:13 INFO - Running pre-action listener: _resource_record_pre_action 17:12:13 INFO - Running main action method: download_and_extract 17:12:13 INFO - mkdir: /builds/slave/test/build/tests 17:12:13 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')]} 17:12:13 INFO - https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:13 INFO - Downloaded 1361 bytes. 17:12:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:12:13 INFO - Using the following test package requirements: 17:12:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:12:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:12:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'jsshell-linux-x86_64.zip'], 17:12:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:12:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:12:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:12:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:12:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:12:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:12:13 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')]} 17:12:13 INFO - https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:20 INFO - Downloaded 24267617 bytes. 17:12:20 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'] 17:12:20 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 17:12:21 INFO - Return code: 0 17:12:21 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 17:12:21 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')]} 17:12:21 INFO - https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:27 INFO - Downloaded 24267617 bytes. 17:12:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:12:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:12:28 INFO - Return code: 0 17:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:28 INFO - https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:29 INFO - Downloaded 14405242 bytes. 17:12:29 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'] 17:12:29 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 17:12:29 INFO - Return code: 0 17:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:29 INFO - https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/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 17:12:31 INFO - Downloaded 60326673 bytes. 17:12:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:31 INFO - mkdir: /builds/slave/test/properties 17:12:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:31 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:31 INFO - Contents: 17:12:31 INFO - build_url:https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:31 INFO - Running post-action listener: _resource_record_post_action 17:12:31 INFO - Running post-action listener: set_extra_try_arguments 17:12:31 INFO - ##### 17:12:31 INFO - ##### Finished download-and-extract step (success) 17:12:31 INFO - ##### 17:12:31 INFO - ##### 17:12:31 INFO - ##### Running populate-webroot step. 17:12:31 INFO - ##### 17:12:31 INFO - Running pre-action listener: _resource_record_pre_action 17:12:31 INFO - Running main action method: populate_webroot 17:12:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:32 INFO - '--tppagecycles', 17:12:32 INFO - '7'], 17:12:32 INFO - 'tests': ['tsvgm']}}, 17:12:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['damp', 'tps']}, 17:12:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'tests': ['damp', 'tps']}, 17:12:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['dromaeo_dom']}, 17:12:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['basic_compositor_video']}, 17:12:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:12:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['a11yr', 17:12:32 INFO - 'ts_paint', 17:12:32 INFO - 'tpaint', 17:12:32 INFO - 'sessionrestore', 17:12:32 INFO - 'sessionrestore_no_auto_restore', 17:12:32 INFO - 'tabpaint']}, 17:12:32 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:32 INFO - 'ts_paint', 17:12:32 INFO - 'tpaint', 17:12:32 INFO - 'sessionrestore', 17:12:32 INFO - 'sessionrestore_no_auto_restore', 17:12:32 INFO - 'tabpaint']}, 17:12:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:32 INFO - 'ts_paint', 17:12:32 INFO - 'tpaint', 17:12:32 INFO - 'sessionrestore', 17:12:32 INFO - 'sessionrestore_no_auto_restore', 17:12:32 INFO - 'tabpaint']}, 17:12:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:32 INFO - 'ts_paint', 17:12:32 INFO - 'tpaint', 17:12:32 INFO - 'sessionrestore', 17:12:32 INFO - 'sessionrestore_no_auto_restore', 17:12:32 INFO - 'tabpaint']}, 17:12:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['a11yr', 17:12:32 INFO - 'ts_paint', 17:12:32 INFO - 'tpaint', 17:12:32 INFO - 'sessionrestore', 17:12:32 INFO - 'sessionrestore_no_auto_restore', 17:12:32 INFO - 'tabpaint']}, 17:12:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['a11yr', 17:12:32 INFO - 'ts_paint', 17:12:32 INFO - 'tpaint', 17:12:32 INFO - 'sessionrestore', 17:12:32 INFO - 'sessionrestore_no_auto_restore', 17:12:32 INFO - 'tabpaint']}, 17:12:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['tsvgx', 17:12:32 INFO - 'tsvgr_opacity', 17:12:32 INFO - 'tart', 17:12:32 INFO - 'tscrollx', 17:12:32 INFO - 'cart']}, 17:12:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:32 INFO - 'tsvgr_opacity', 17:12:32 INFO - 'tart', 17:12:32 INFO - 'tscrollx', 17:12:32 INFO - 'cart']}, 17:12:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'talos_options': ['--disable-e10s'], 17:12:32 INFO - 'tests': ['tp5o']}, 17:12:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'tests': ['tp5o']}, 17:12:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'talos_options': ['--disable-e10s', 17:12:32 INFO - '--xperf_path', 17:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:32 INFO - 'tests': ['tp5n']}, 17:12:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:32 INFO - 'talos_options': ['--xperf_path', 17:12:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:32 INFO - 'tests': ['tp5n']}}, 17:12:32 INFO - 'talos.zip': {'path': '', 17:12:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:32 INFO - Running post-action listener: _resource_record_post_action 17:12:32 INFO - ##### 17:12:32 INFO - ##### Finished populate-webroot step (success) 17:12:32 INFO - ##### 17:12:32 INFO - ##### 17:12:32 INFO - ##### Running create-virtualenv step. 17:12:32 INFO - ##### 17:12:32 INFO - Running pre-action listener: _resource_record_pre_action 17:12:32 INFO - Running main action method: create_virtualenv 17:12:32 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:12:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:32 INFO - Using real prefix '/usr' 17:12:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:34 INFO - Installing pip.................done. 17:12:34 INFO - Return code: 0 17:12:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:12:34 INFO - Using env: {'DISPLAY': ':0', 17:12:34 INFO - 'HOME': '/home/cltbld', 17:12:34 INFO - 'LANG': 'en_US.UTF-8', 17:12:34 INFO - 'LANGUAGE': 'en_US:en', 17:12:34 INFO - 'LOGNAME': 'cltbld', 17:12:34 INFO - 'MAIL': '/var/mail/cltbld', 17:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:34 INFO - 'MOZ_NO_REMOTE': '1', 17:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:34 INFO - 'NO_EM_RESTART': '1', 17:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:34 INFO - 'PWD': '/builds/slave/test', 17:12:34 INFO - 'SHELL': '/bin/bash', 17:12:34 INFO - 'SHLVL': '1', 17:12:34 INFO - 'TERM': 'linux', 17:12:34 INFO - 'TMOUT': '86400', 17:12:34 INFO - 'USER': 'cltbld', 17:12:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:34 INFO - '_': '/tools/buildbot/bin/python'} 17:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:12:34 INFO - Cleaning up... 17:12:34 INFO - Return code: 0 17:12:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:12:34 INFO - Using env: {'DISPLAY': ':0', 17:12:34 INFO - 'HOME': '/home/cltbld', 17:12:34 INFO - 'LANG': 'en_US.UTF-8', 17:12:34 INFO - 'LANGUAGE': 'en_US:en', 17:12:34 INFO - 'LOGNAME': 'cltbld', 17:12:34 INFO - 'MAIL': '/var/mail/cltbld', 17:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:34 INFO - 'MOZ_NO_REMOTE': '1', 17:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:34 INFO - 'NO_EM_RESTART': '1', 17:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:34 INFO - 'PWD': '/builds/slave/test', 17:12:34 INFO - 'SHELL': '/bin/bash', 17:12:34 INFO - 'SHLVL': '1', 17:12:34 INFO - 'TERM': 'linux', 17:12:34 INFO - 'TMOUT': '86400', 17:12:34 INFO - 'USER': 'cltbld', 17:12:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:34 INFO - '_': '/tools/buildbot/bin/python'} 17:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:35 INFO - Downloading/unpacking psutil>=3.1.1 17:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:37 INFO - Installing collected packages: psutil 17:12:37 INFO - Running setup.py install for psutil 17:12:37 INFO - building 'psutil._psutil_linux' extension 17:12:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:12:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:12:37 INFO - building 'psutil._psutil_posix' extension 17:12:37 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 17:12:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:12:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:37 INFO - Successfully installed psutil 17:12:37 INFO - Cleaning up... 17:12:37 INFO - Return code: 0 17:12:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12:37 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')]} 17:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:37 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')]} 17:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:37 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 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:37 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 17:12:37 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 17:12:37 INFO - Using env: {'DISPLAY': ':0', 17:12:37 INFO - 'HOME': '/home/cltbld', 17:12:37 INFO - 'LANG': 'en_US.UTF-8', 17:12:37 INFO - 'LANGUAGE': 'en_US:en', 17:12:37 INFO - 'LOGNAME': 'cltbld', 17:12:37 INFO - 'MAIL': '/var/mail/cltbld', 17:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:37 INFO - 'MOZ_NO_REMOTE': '1', 17:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:37 INFO - 'NO_EM_RESTART': '1', 17:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:37 INFO - 'PWD': '/builds/slave/test', 17:12:37 INFO - 'SHELL': '/bin/bash', 17:12:37 INFO - 'SHLVL': '1', 17:12:37 INFO - 'TERM': 'linux', 17:12:37 INFO - 'TMOUT': '86400', 17:12:37 INFO - 'USER': 'cltbld', 17:12:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:37 INFO - '_': '/tools/buildbot/bin/python'} 17:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:39 INFO - Installing collected packages: mozsystemmonitor 17:12:39 INFO - Running setup.py install for mozsystemmonitor 17:12:39 INFO - Successfully installed mozsystemmonitor 17:12:39 INFO - Cleaning up... 17:12:39 INFO - Return code: 0 17:12:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:12:39 INFO - Using env: {'DISPLAY': ':0', 17:12:39 INFO - 'HOME': '/home/cltbld', 17:12:39 INFO - 'LANG': 'en_US.UTF-8', 17:12:39 INFO - 'LANGUAGE': 'en_US:en', 17:12:39 INFO - 'LOGNAME': 'cltbld', 17:12:39 INFO - 'MAIL': '/var/mail/cltbld', 17:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:39 INFO - 'MOZ_NO_REMOTE': '1', 17:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:39 INFO - 'NO_EM_RESTART': '1', 17:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:39 INFO - 'PWD': '/builds/slave/test', 17:12:39 INFO - 'SHELL': '/bin/bash', 17:12:39 INFO - 'SHLVL': '1', 17:12:39 INFO - 'TERM': 'linux', 17:12:39 INFO - 'TMOUT': '86400', 17:12:39 INFO - 'USER': 'cltbld', 17:12:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:39 INFO - '_': '/tools/buildbot/bin/python'} 17:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:40 INFO - Downloading/unpacking jsonschema==2.5.1 17:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:42 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:42 INFO - warning: no files found matching '*.txt' 17:12:42 INFO - no previously-included directories found matching 'build' 17:12:42 INFO - no previously-included directories found matching 'dist' 17:12:42 INFO - no previously-included directories found matching '.git*' 17:12:42 INFO - Installing collected packages: jsonschema, functools32 17:12:42 INFO - Running setup.py install for functools32 17:12:42 INFO - warning: no files found matching '*.txt' 17:12:42 INFO - no previously-included directories found matching 'build' 17:12:42 INFO - no previously-included directories found matching 'dist' 17:12:42 INFO - no previously-included directories found matching '.git*' 17:12:42 INFO - Successfully installed jsonschema functools32 17:12:42 INFO - Cleaning up... 17:12:42 INFO - Return code: 0 17:12:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:42 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 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:42 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 17:12:42 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 17:12:42 INFO - Using env: {'DISPLAY': ':0', 17:12:42 INFO - 'HOME': '/home/cltbld', 17:12:42 INFO - 'LANG': 'en_US.UTF-8', 17:12:42 INFO - 'LANGUAGE': 'en_US:en', 17:12:42 INFO - 'LOGNAME': 'cltbld', 17:12:42 INFO - 'MAIL': '/var/mail/cltbld', 17:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:42 INFO - 'MOZ_NO_REMOTE': '1', 17:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:42 INFO - 'NO_EM_RESTART': '1', 17:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:42 INFO - 'PWD': '/builds/slave/test', 17:12:42 INFO - 'SHELL': '/bin/bash', 17:12:42 INFO - 'SHLVL': '1', 17:12:42 INFO - 'TERM': 'linux', 17:12:42 INFO - 'TMOUT': '86400', 17:12:42 INFO - 'USER': 'cltbld', 17:12:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:42 INFO - '_': '/tools/buildbot/bin/python'} 17:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:45 INFO - Downloading docopt-0.6.1.tar.gz 17:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:45 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:45 INFO - Running setup.py install for blobuploader 17:12:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:45 INFO - Running setup.py install for requests 17:12:45 INFO - Running setup.py install for docopt 17:12:45 INFO - Successfully installed blobuploader requests docopt 17:12:45 INFO - Cleaning up... 17:12:45 INFO - Return code: 0 17:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:45 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')]} 17:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:45 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')]} 17:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:45 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 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:45 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 17:12:45 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 17:12:45 INFO - Using env: {'DISPLAY': ':0', 17:12:45 INFO - 'HOME': '/home/cltbld', 17:12:45 INFO - 'LANG': 'en_US.UTF-8', 17:12:45 INFO - 'LANGUAGE': 'en_US:en', 17:12:45 INFO - 'LOGNAME': 'cltbld', 17:12:45 INFO - 'MAIL': '/var/mail/cltbld', 17:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:45 INFO - 'MOZ_NO_REMOTE': '1', 17:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:45 INFO - 'NO_EM_RESTART': '1', 17:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:45 INFO - 'PWD': '/builds/slave/test', 17:12:45 INFO - 'SHELL': '/bin/bash', 17:12:45 INFO - 'SHLVL': '1', 17:12:45 INFO - 'TERM': 'linux', 17:12:45 INFO - 'TMOUT': '86400', 17:12:45 INFO - 'USER': 'cltbld', 17:12:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:45 INFO - '_': '/tools/buildbot/bin/python'} 17:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:46 INFO - Running setup.py (path:/tmp/pip-UI4_sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:46 INFO - Running setup.py (path:/tmp/pip-z5y9SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:46 INFO - Running setup.py (path:/tmp/pip-wljt5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:46 INFO - Running setup.py (path:/tmp/pip-vaYsDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:46 INFO - Running setup.py (path:/tmp/pip-kqngZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:46 INFO - Running setup.py (path:/tmp/pip-EI2VO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:46 INFO - Running setup.py (path:/tmp/pip-Y6lOuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:46 INFO - Running setup.py (path:/tmp/pip-gho1CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:46 INFO - Running setup.py (path:/tmp/pip-4Eu9AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:46 INFO - Running setup.py (path:/tmp/pip-rP9g1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:46 INFO - Running setup.py (path:/tmp/pip-5vGFpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:46 INFO - Running setup.py (path:/tmp/pip-PDOQ9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:47 INFO - Running setup.py (path:/tmp/pip-Y_gWMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:47 INFO - Running setup.py (path:/tmp/pip-MKROg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:47 INFO - Running setup.py (path:/tmp/pip-oiQAXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:47 INFO - Running setup.py (path:/tmp/pip-7OpQ14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:47 INFO - Running setup.py (path:/tmp/pip-DUmfMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:47 INFO - Running setup.py install for manifestparser 17:12:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozcrash 17:12:47 INFO - Running setup.py install for mozdebug 17:12:47 INFO - Running setup.py install for mozdevice 17:12:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozfile 17:12:47 INFO - Running setup.py install for mozhttpd 17:12:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozinfo 17:12:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozInstall 17:12:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozleak 17:12:48 INFO - Running setup.py install for mozlog 17:12:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for moznetwork 17:12:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozprocess 17:12:48 INFO - Running setup.py install for mozprofile 17:12:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozrunner 17:12:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozscreenshot 17:12:48 INFO - Running setup.py install for moztest 17:12:49 INFO - Running setup.py install for mozversion 17:12:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:49 INFO - Cleaning up... 17:12:49 INFO - Return code: 0 17:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:49 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')]} 17:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:49 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')]} 17:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:49 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 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:49 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 17:12:49 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 17:12:49 INFO - Using env: {'DISPLAY': ':0', 17:12:49 INFO - 'HOME': '/home/cltbld', 17:12:49 INFO - 'LANG': 'en_US.UTF-8', 17:12:49 INFO - 'LANGUAGE': 'en_US:en', 17:12:49 INFO - 'LOGNAME': 'cltbld', 17:12:49 INFO - 'MAIL': '/var/mail/cltbld', 17:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:49 INFO - 'MOZ_NO_REMOTE': '1', 17:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:49 INFO - 'NO_EM_RESTART': '1', 17:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:49 INFO - 'PWD': '/builds/slave/test', 17:12:49 INFO - 'SHELL': '/bin/bash', 17:12:49 INFO - 'SHLVL': '1', 17:12:49 INFO - 'TERM': 'linux', 17:12:49 INFO - 'TMOUT': '86400', 17:12:49 INFO - 'USER': 'cltbld', 17:12:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:49 INFO - '_': '/tools/buildbot/bin/python'} 17:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:49 INFO - Running setup.py (path:/tmp/pip-U0jwo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:49 INFO - Running setup.py (path:/tmp/pip-PGrdHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:49 INFO - Running setup.py (path:/tmp/pip-dv7omB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:49 INFO - Running setup.py (path:/tmp/pip-ZVQs0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:49 INFO - Running setup.py (path:/tmp/pip-qFr0Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:49 INFO - Running setup.py (path:/tmp/pip-pzkKlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:49 INFO - Running setup.py (path:/tmp/pip-AzvSwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:49 INFO - Running setup.py (path:/tmp/pip-lacZ_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:49 INFO - Running setup.py (path:/tmp/pip-o4Vtr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:50 INFO - Running setup.py (path:/tmp/pip-ELfDjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:50 INFO - Running setup.py (path:/tmp/pip-KGlP52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:50 INFO - Running setup.py (path:/tmp/pip-mUhHKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:50 INFO - Running setup.py (path:/tmp/pip-0zA1Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:50 INFO - Running setup.py (path:/tmp/pip-FUNELr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:50 INFO - Running setup.py (path:/tmp/pip-9uFi0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:50 INFO - Running setup.py (path:/tmp/pip-eSAJ2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:50 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)) 17:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:50 INFO - Running setup.py (path:/tmp/pip-y0aCJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:50 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)) 17:12:50 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)) 17:12:50 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)) 17:12:50 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)) 17:12:50 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)) 17:12:50 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)) 17:12:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:50 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 17:12:50 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 17:12:50 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 17:12:50 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 17:12:50 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 17:12:50 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 17:12:52 INFO - Downloading blessings-1.6.tar.gz 17:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:52 INFO - Installing collected packages: blessings 17:12:52 INFO - Running setup.py install for blessings 17:12:52 INFO - Successfully installed blessings 17:12:52 INFO - Cleaning up... 17:12:52 INFO - Return code: 0 17:12:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:52 INFO - Reading from file tmpfile_stdout 17:12:52 INFO - Current package versions: 17:12:52 INFO - argparse == 1.2.1 17:12:52 INFO - blessings == 1.6 17:12:52 INFO - blobuploader == 1.2.4 17:12:52 INFO - docopt == 0.6.1 17:12:52 INFO - functools32 == 3.2.3-2 17:12:52 INFO - jsonschema == 2.5.1 17:12:52 INFO - manifestparser == 1.1 17:12:52 INFO - mozInstall == 1.12 17:12:52 INFO - mozcrash == 0.17 17:12:52 INFO - mozdebug == 0.1 17:12:52 INFO - mozdevice == 0.48 17:12:52 INFO - mozfile == 1.2 17:12:52 INFO - mozhttpd == 0.7 17:12:52 INFO - mozinfo == 0.9 17:12:52 INFO - mozleak == 0.1 17:12:52 INFO - mozlog == 3.2 17:12:52 INFO - moznetwork == 0.27 17:12:52 INFO - mozprocess == 0.22 17:12:52 INFO - mozprofile == 0.28 17:12:52 INFO - mozrunner == 6.11 17:12:52 INFO - mozscreenshot == 0.1 17:12:52 INFO - mozsystemmonitor == 0.3 17:12:52 INFO - moztest == 0.7 17:12:52 INFO - mozversion == 1.4 17:12:52 INFO - psutil == 3.1.1 17:12:52 INFO - requests == 1.2.3 17:12:52 INFO - wsgiref == 0.1.2 17:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:12:52 INFO - Using env: {'DISPLAY': ':0', 17:12:52 INFO - 'HOME': '/home/cltbld', 17:12:52 INFO - 'LANG': 'en_US.UTF-8', 17:12:52 INFO - 'LANGUAGE': 'en_US:en', 17:12:52 INFO - 'LOGNAME': 'cltbld', 17:12:52 INFO - 'MAIL': '/var/mail/cltbld', 17:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:52 INFO - 'MOZ_NO_REMOTE': '1', 17:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:52 INFO - 'NO_EM_RESTART': '1', 17:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:52 INFO - 'PWD': '/builds/slave/test', 17:12:52 INFO - 'SHELL': '/bin/bash', 17:12:52 INFO - 'SHLVL': '1', 17:12:52 INFO - 'TERM': 'linux', 17:12:52 INFO - 'TMOUT': '86400', 17:12:52 INFO - 'USER': 'cltbld', 17:12:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:52 INFO - '_': '/tools/buildbot/bin/python'} 17:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 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)) 17:12:53 INFO - Cleaning up... 17:12:53 INFO - Return code: 0 17:12:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, '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': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', '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 17:12: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', 'jsonschema'] in /builds/slave/test/build 17:12: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 jsonschema 17:12:53 INFO - Using env: {'DISPLAY': ':0', 17:12:53 INFO - 'HOME': '/home/cltbld', 17:12:53 INFO - 'LANG': 'en_US.UTF-8', 17:12:53 INFO - 'LANGUAGE': 'en_US:en', 17:12:53 INFO - 'LOGNAME': 'cltbld', 17:12:53 INFO - 'MAIL': '/var/mail/cltbld', 17:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:53 INFO - 'MOZ_NO_REMOTE': '1', 17:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:53 INFO - 'NO_EM_RESTART': '1', 17:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:53 INFO - 'PWD': '/builds/slave/test', 17:12:53 INFO - 'SHELL': '/bin/bash', 17:12:53 INFO - 'SHLVL': '1', 17:12:53 INFO - 'TERM': 'linux', 17:12:53 INFO - 'TMOUT': '86400', 17:12:53 INFO - 'USER': 'cltbld', 17:12:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:53 INFO - '_': '/tools/buildbot/bin/python'} 17:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:12:53 INFO - Cleaning up... 17:12:53 INFO - Return code: 0 17:12:53 INFO - Running post-action listener: _resource_record_post_action 17:12:53 INFO - Running post-action listener: _start_resource_monitoring 17:12:53 INFO - Starting resource monitoring. 17:12:53 INFO - ##### 17:12:53 INFO - ##### Finished create-virtualenv step (success) 17:12:53 INFO - ##### 17:12:53 INFO - ##### 17:12:53 INFO - ##### Running install step. 17:12:53 INFO - ##### 17:12:53 INFO - Running pre-action listener: _resource_record_pre_action 17:12:53 INFO - Running main action method: install 17:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:53 INFO - Reading from file tmpfile_stdout 17:12:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:53 INFO - Reading from file tmpfile_stdout 17:12:53 INFO - Output received: 17:12:53 INFO - Usage: mozinstall [options] installer 17:12:53 INFO - Options: 17:12:53 INFO - -h, --help show this help message and exit 17:12:53 INFO - -d DEST, --destination=DEST 17:12:53 INFO - Directory to install application into. [default: 17:12:53 INFO - "/builds/slave/test"] 17:12:53 INFO - --app=APP Application being installed. [default: firefox] 17:12:53 INFO - mkdir: /builds/slave/test/build/application 17:12:53 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'] 17:12:53 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 17:13:10 INFO - Reading from file tmpfile_stdout 17:13:10 INFO - Output received: 17:13:10 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:10 INFO - Running post-action listener: _resource_record_post_action 17:13:10 INFO - ##### 17:13:10 INFO - ##### Finished install step (success) 17:13:10 INFO - ##### 17:13:10 INFO - ##### 17:13:10 INFO - ##### Running run-tests step. 17:13:10 INFO - ##### 17:13:10 INFO - Running pre-action listener: _resource_record_pre_action 17:13:10 INFO - Running main action method: run_tests 17:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:10 INFO - Python 2.7.3 17:13:10 INFO - Return code: 0 17:13:10 INFO - grabbing minidump binary from tooltool 17:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b3b0>, '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 0x1e7c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:13:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:13:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:13:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:10 INFO - Return code: 0 17:13:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:13:10 INFO - Using env: {'DISPLAY': ':0', 17:13:10 INFO - 'HOME': '/home/cltbld', 17:13:10 INFO - 'LANG': 'en_US.UTF-8', 17:13:10 INFO - 'LANGUAGE': 'en_US:en', 17:13:10 INFO - 'LOGNAME': 'cltbld', 17:13:10 INFO - 'MAIL': '/var/mail/cltbld', 17:13:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:10 INFO - 'MOZ_NO_REMOTE': '1', 17:13:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:10 INFO - 'NO_EM_RESTART': '1', 17:13:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:10 INFO - 'PWD': '/builds/slave/test', 17:13:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:10 INFO - 'SHELL': '/bin/bash', 17:13:10 INFO - 'SHLVL': '1', 17:13:10 INFO - 'TERM': 'linux', 17:13:10 INFO - 'TMOUT': '86400', 17:13:10 INFO - 'USER': 'cltbld', 17:13:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386', 17:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:10 INFO - '_': '/tools/buildbot/bin/python'} 17:13:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:13:11 INFO - mozversion application_buildid: 20160630143034 17:13:11 INFO - mozversion application_changeset: 2139ee8230e33662c71179c54502652373d72415 17:13:11 INFO - mozversion application_display_name: Nightly 17:13:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:11 INFO - mozversion application_name: Firefox 17:13:11 INFO - mozversion application_remotingname: firefox 17:13:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:13:11 INFO - mozversion application_vendor: Mozilla 17:13:11 INFO - mozversion application_version: 50.0a1 17:13:11 INFO - mozversion platform_buildid: 20160630143034 17:13:11 INFO - mozversion platform_changeset: 2139ee8230e33662c71179c54502652373d72415 17:13:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:13:11 INFO - mozversion platform_version: 50.0a1 17:13:11 INFO - using testdate: 1467331991 17:13:11 INFO - actual date: 1467331991 17:13:11 INFO - starting webserver on 'localhost:42487' 17:13:11 INFO - SUITE-START | Running 2 tests 17:13:11 INFO - TEST-START | dromaeo_css 17:13:11 INFO - operating with platform_type : linux_ 17:13:11 INFO - Initialising browser for dromaeo_css test... 17:13:11 INFO - TEST-INFO | started process 12714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiY4NNb/profile http://localhost:42487/getInfo.html) 17:13:15 INFO - PROCESS | 12714 | __metrics Screen width/height:1600/1200 17:13:15 INFO - PROCESS | 12714 | colorDepth:24 17:13:15 INFO - PROCESS | 12714 | Browser inner width/height: 1024/697 17:13:15 INFO - PROCESS | 12714 | __metrics 17:13:16 INFO - PROCESS | 12714 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:16 INFO - PROCESS | 12714 | console.error: PushService: 17:13:16 INFO - PROCESS | 12714 | stateChangeProcessEnqueue: Error transitioning state 17:13:16 INFO - PROCESS | 12714 | UnknownError 17:13:17 INFO - TEST-INFO | 12714: exit 0 17:13:17 INFO - Browser initialized. 17:13:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:17 INFO - TEST-INFO | started process 12799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiY4NNb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:28 INFO - PROCESS | 12799 | RSS: Main: 157241344 17:13:28 INFO - PROCESS | 12799 | 17:14:20 INFO - PROCESS | 12799 | 1467332060481 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] 17:16:28 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42487/tests/dromaeo/cssquery-ext.html) 17:16:29 INFO - PROCESS | 12799 | RSS: Main: 253247488 17:16:29 INFO - PROCESS | 12799 | 17:19:31 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-ext.html (next: http://localhost:42487/tests/dromaeo/cssquery-jquery.html) 17:19:32 INFO - PROCESS | 12799 | RSS: Main: 242176000 17:19:32 INFO - PROCESS | 12799 | 17:22:34 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42487/tests/dromaeo/cssquery-mootools.html) 17:22:34 INFO - PROCESS | 12799 | RSS: Main: 244961280 17:22:34 INFO - PROCESS | 12799 | 17:25:36 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42487/tests/dromaeo/cssquery-prototype.html) 17:25:37 INFO - PROCESS | 12799 | RSS: Main: 240398336 17:25:37 INFO - PROCESS | 12799 | 17:28:40 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42487/tests/dromaeo/cssquery-yui.html) 17:28:40 INFO - PROCESS | 12799 | RSS: Main: 202059776 17:28:40 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-yui.html (next: http://localhost:42487/tests/dromaeo/cssquery-dojo.html) 17:31:43 INFO - PROCESS | 12799 | RSS: Main: 291221504 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | __start_tp_report 17:31:43 INFO - PROCESS | 12799 | _x_x_mozilla_page_load 17:31:43 INFO - PROCESS | 12799 | _x_x_mozilla_page_load_details 17:31:43 INFO - PROCESS | 12799 | |i|pagename|runs| 17:31:43 INFO - PROCESS | 12799 | |0;dojo.html;3089.335792804547;3108.8756449742014;3118.5010398336262;3137.701918317759;3172.1118086935667;5209.296744939432;5244.79020839166;5276.4987326204;5365.302510673612;5378.112611419111;5340.652857564256;5356.4107948125775;5372.113601255788;5373.489518495747;5430.239766432703;4795.568398844103;4830.3237546743485;4870.4885986971385;4887.755612219393;4988.87527811804;4893.804247830082;4901.06879692859;4937.076476282679;4953.4303555091265;4956.231784073474;4749.501302363254;4795.6403269754555;4796.856094317176;4818.9036219275595;4840.540148685869;4784.449788274358;4804.6876952997945;4871.342368780241;4871.707697538159;4914.754262286907;4686.859394218145;4828.251620998751;4839.491853355417;4858.562729354375;4882.609391248691;5269.973650131763;5369.167778994223;5375;5452.672839629635;5475.479829416199;5791.971040144815;5810.82567522975;5831.970840145815;5836.649801011953;5837.795677151322;5582.692951887645;5706.4864162225595;5813.593048486608;5834.474897259224;5842.3573406925625;5347.25138480613;5468.835934921959;5469.0155771960635;5470.425605311465;5471.288732464834;5960.254968128984;5963.403659634088;5970.373110823388;5971.880562388815;5973.970130149321;5477.068898287301;5519.724013799294;5578;5725.51333136688;5743.798967036134;5758.510526605285;5767.682777447197;5769.653820770767;5769.798057067983;5769.798057067983;5646.632968857011;5697.971510142423;5698.686572238566;5700.25896633435;5743.741531631086;5575.776968921279;5642.6614403135945;5689.715514224272;5693.060644993529;5702.971485142548;4350.303951367766;4350.695451318377;4366.301391777364;4371.584699453547;4396.428464299621;3905.2970465316516;3921.392184211452;3928.3125453045604;3960.0693836948294;3971.940420893689;5159.380874295109;5196.064708352533;5278.2346559749385;5326.760295786699;5343.198520221998;5762.74067666956;5775;5792.131180322901;5799.739011744482;5838.766449342063;5412.485813847678;5423.566114710814;5423.701696406735;5434.429384914606;5438.45615438453;4655.348251244828;4718.245080787057;4744.525547445228;4780.330753694486;4838.854834354905;5890.6171098879295;5890.9410905891245;5895.056790913433;5899.174115623816;5905.704714764331;5732.914006289992;5748.367679555329;5749.425057494217;5760.049591817303;5762.423757624204;5723.912456633227;5850.882982340415;5904.202932604044;5911.379305172895;5964.105384192232;5640.830775076754;5674.460926212003;5682.829515114553;5690.943090569207;5696.572757043155;5521.365043020104;5750.539956803529;5752.13717942312;5753.654780713171;5764.106563482667;5548.195511650707;5565.777368905198;5593.468620481048;5639.097744360883;5658.321001479849;5610.747516361856;5614.522765564972;5619.690916999441;5622.156676498558;5622.662640241599;5371.677699338053;5446.101393270066;5533.059379905506;5541.695206763506;5558.972205138948;5605.887882242414;5663.631863928831;5713.8285851424525;5714.314282286152;5716.914246286392;5553.750081246434;5555.22226888244;5561.138023606348;5561.972190139023;5562.805301814417 17:31:43 INFO - PROCESS | 12799 | |1;ext.html;598.389642564584;606.4602503771641;621.8662987457697;622.8785386849563;627.2222444169231;32884.50673239903;36149.819250903776;36159.4576081359;41920.16159676805;42935.57064429355;45817.31274030884;46157.53842461583;46289.537104628944;46327;46471.53528464714;8968.730938071853;9107.453552786854;9110.86333704995;9112.817743645122;9121.635134594608;8258.587070646474;8977.730668079968;10628.94685526575;10866.293690910066;10876.836847447295;11080.279781814197;11153.442327883615;11153.665390038312;11172.329660220372;11172.385518796464;11034.337939723602;11042.613508527204;11066.612668556643;11092.889071109266;11097.1677124216;8162.551059691774;10287.691369258859;10666.14670826332;10668.839967400496;11082.445877706163;44469.77765111154;44675;44789.55210447919;44793.104137917384;44849;3560.412531932228;3587.6053634100226;3847.2882516734494;4171.728837625575;4202.537720850704;33971.32057358864;34023.6597634023;34296.48555271673;34674.30651386984;35920.82039589812;4420.7126536775;4441.977790111029;4512.932306015412;4518.593326600621;4524.47968483622;330350;331238;331704;331739;332631;54822.451775482536;54986.45013549813;55052.72473637606;55064;55080.449195508336;63839.68080159662;64313.67843160754;64383.35616643867;64420;64448.677756610916;15956.920215398848;16619.252133654016;16623.6675266494;16625.66748665044;16628;11079;12794.872051279368;12864.099513034185;12872;12892.419841107172;18098.63802723938;18433.354832581063;18513;19199.32802351939;19199.712004319666;6127.080937859357;6133.975787989953;6213.502919766408;6214.25428948529;6241.625502469867;908.246155690775;956.2445667922402;1074.9197056957707;1083.7886612110563;1095.430376204385;32124.83937580344;32404.675953240636;32557.348853022806;32605.510917336258;32728.836355818068;1134.9659510214706;1142.6971852459105;1150.453534571072;1151.8848115188414;1154.0208542349742;16668.249928753234;16969.745453818203;17055.914720426317;17136.657266854843;17410.912945435193;509792;511419;512432;513750;514388;60238.69880650657;60350;60470.697646512366;60603;60638;1246.875312468746;1328.0769864943964;1363.3455941148106;1375.8211432513708;1377.6762460821499;32947.835260824504;34197.48703769396;34405.655943440244;34522;34529.82735086309;49808.750956244985;50029;50478.24282635837;50505.49494505008;50536.24195636995;388726;392529.4482330955;392532;393442;393494;25954.35114122162;29221.561676575293;29873.402531948803;29887.850560747058;31424.685753142177;48881.26678099902;49132;49413.50586494089;50115;50585.24122138244;40897;42168.578314217695;42506.78746606247;43129.784351078044;43776;41765.58234417738;41810.790946045076;43200.35199471947;43708.34437483377;44168.33747493726;41348.37977430401;41547.16905661931;42324.57675423206;42709.14581708411;42722.78638606787;34913.8254308737;37277.25445491129;37851.24297514089;38254.808725956194;38455.2308953825;27834.86082569574;28328;28444.57333139963;28471.857640711663;28622.57066144051 17:31:43 INFO - PROCESS | 12799 | |2;jquery.html;410.9547949725531;414.9917001659967;417.99164016719664;422.87304333950027;437.2850389612982;18559;19575.21699132033;19904.609226418666;20253.69619455706;20344.08451619677;19012.334568290113;19230.230790768353;20205.696914546294;20226.696599551018;20230.797692023076;5324.866878328034;5693.715314234271;5696.629719068268;5696.829095127153;5698.629589076718;5547.389787123413;5571.052921003439;5678.829635110953;5680.9715951420185;5685.516731077863;5725.513331366818;5779.942200578003;5781.277340332458;5783.855403614923;5785.305763308409;5447.972760136174;5631.887362252732;5741.511971482429;5746.454086861762;5748.45389687979;5016.724080175589;5044.571211447032;5044.697318160922;5065.1895696688725;5065.46812584677;23281.06875724969;23387;24185.758142418526;24327.391815204584;24420.877895610585;2314.745378008418;2437.9878100609562;2444.3889027743066;2455.656208130863;2905.9829059829103;14671;14880.702385952329;14900.180490073042;15091.622709432242;15620.375184992587;1895.6303520813447;1910.0927059646694;1951.541387773872;1955.247229816531;2049.25202301159;79711.601441993;80241.59879200625;80879;81755;83121.58439207826;10845.783084338427;10966.561337546409;11054.778904422028;11275.928786765244;11320.490577924013;15631;15682.76475852863;15717.685646287238;15797.131157786433;15822.367105315889;7960.960195198987;8110.756677299691;8149.674013039412;8157.714479993172;8224.876626850602;7692.269234422721;7707.344875685518;7708.884366734504;7873.960630196812;7877.172896845863;6512.283648798629;6894.13823272091;6896.241413444517;6970.721171153097;7120.92879071213;2033.2070492507933;2043.3550991451727;2053.178728508579;2071.6271071207025;2088.3421722157473;862.2067697717989;908.7818923458323;936.3913456253354;952.4237836109193;1050.138886113395;18575.431528773537;19101.2359505621;20362.77823330605;20462;20871.37385878426;973;1019.592163134752;1028.7016765138176;1029.4801125431609;1048.192891473561;10795.568177272979;11678.357690326944;11741;11753.764924701458;11755.588554400554;379630;449567;471308;472572;474872;90701.09298907059;93935.53032234932;95135;95659;95768.52115739377;1038.896110388955;1047.9790404191874;1083.4745148602922;1118.139032944628;1120.4845770945294;18028.188731506852;18075.54811129732;18263.269469221614;18388.448346549623;18423.815761842747;41599.58400416078;41827.37258941179;42024.789876050425;42920.570794291656;42925.78537107295;61983;62560.687196563726;63503.6824815873;63523.364766353596;64202.67898660477;8524.957375213084;8781.077986811293;8854.955725221333;8877.644894204159;8899.644014239359;12897.161684490478;13819.170849749047;13900.860991390362;13959.651008724863;14024.859751402764;11485.598004069818;11918.52325906954;12154.574589889311;12292.692682683004;12420.689482763004;12294.508219671114;12350.197237179555;12511.749765004832;12535.310557919402;12933.353332333534;12170.756584868075;12233.388330583613;12398.07014473936;12504.937080348273;12725.93637031809;8743.562821859008;8756;8798.34012449056;8883.722322559932;9027.638894444148;8919.671176127926;12013.038956883604;12206.450709717907;12354.876451235732;12479.438425271066 17:31:43 INFO - PROCESS | 12799 | |3;mootools.html;1342.7981956149254;1456.3519233940897;1516.3631274864558;1643.268745408293;1818.66354724376;8563.78590535237;8956.373053886231;8974.596143173556;9273.582688779004;9274.860877086849;8634.136586341378;8846.20384165425;8862.556872156398;8886.42238254513;8888.06675299094;2150.5268840854988;2374.620060790274;2399.7120345558515;2421.878906054699;2449.289705985262;2444.6577479152934;2451;2451.472933319336;2452.877356132195;2455.815813813962;2354.705661792276;2372.2171683344454;2394.473215892501;2395.317334559651;2395.8921848516857;2089.5298557824444;2301.137073597401;2349.2717257650097;2363.8108951283857;2370.01644317608;2342.543204075189;2356.5640356533922;2357.7760112789256;2360.7875291223872;2367.869767162805;8996.595153218055;9041.593128309241;9045.638174473013;9049.049849765812;9053;5278.47215278473;5456.836294911159;5463.672179669233;5468.398476167618;5470.8085217017215;3493.0917961329983;3614.8011859347725;3649.069487280753;3656.926861462756;3664.486971823947;1210.3645586067298;1213.9028877689764;1240.5844042245858;1270.9237445753283;1272.8281681972908;12405.751884962341;12417.93791031048;12435.44040518179;12475.625731227987;12725.61823145307;4736.621070314435;4804.495527969582;4886.3403440535785;4958.528939750718;4982.900341993212;10631.043206111488;10782;10796.460176991119;10800.621978230723;10810.243282970274;5488.341399032141;5491.093969495068;5491.917621235684;5497.780088796403;5498.890022199614;4422.425084738963;4890.462049174588;5030.421501527371;5044.848654540369;5126.512981266774;4057.1885622875543;4155.854545090907;4172.582741725803;4178.247915375262;4201.390798334224;1250.5373011985441;1321.0224433918831;1341.5774031180342;1378.2626294932163;1388.0838646493266;812.0942623559642;864.2955990867423;889;984.8522721591676;1007.1338648762058;5802.216700745345;6313.873722525524;6373;6459.903101453482;6624.735010599522;983.2134292565919;996.6163027234567;1003.4380746781679;1011.7318910488726;1024.2983556263982;4259.169461954951;4454.309582014728;4504.144212599595;4524.479684836286;4544.636429085665;11063.059639930536;11075.778484430266;11156.163287753288;11161.944190278997;11433.485493152828;10998.615048473264;11050.226484146193;11051.005409513022;11082.944585277184;11087.889121108847;7928.6035698214855;8496.872546911802;8503.872441913376;8694.956525217334;8711.08533603975;5652.152177173457;6005.729742161526;6039;6205.565610407228;6294.559380843297;9905.257105716955;10516.15870730355;10719.356838589709;10728.141748659933;10738.087262582769;10079.445630490394;10400.479976001321;10401.53193106297;10628.04347608688;10638.8936110641;7179.748708795167;7718.961405192938;7838.059432868093;7960.124386317616;7971.12317645047;8748.212660860552;8769.736907892773;8835.20483156519;8836.91163088361;8840.204381605687;7609.376086805429;7896.368290536858;7906.367490600853;7985.680572777024;8077.151899050515;7809.219078092373;7878.881816772639;7913.406494512819;7973.692981975935;8073.555954422563;7197.244289349543;7198.460115491254;7306.525075870051;7312.268773122858;7316.780496585111;5357.892842143213;5509.063459212024;5520.392756796829;5569.10894256917;5616.466435688603;5187.403448603459;5286.101362768261;5318.335208098988;5350.919736203882;5543.113101903838 17:31:43 INFO - PROCESS | 12799 | |4;prototype.html;336.8282176090194;346.95663042119736;351.2956522173043;355.04138825172026;355.14587417261464;5348.572114230862;5384.515393614579;5392.56859451244;5407.972960135199;5435.646682965605;5312.150055991042;5334.946650533493;5350.3515759699;5360.142377219646;5370.91943620846;3824.9043773905737;3988.680905527558;4005.1989602079557;4049;4192.182524407742;4106.548279689232;4154.584541545852;4155.9817844628105;4159.126583417486;4162.354835000579;4132.938005929914;4133.979330103345;4156.293430116887;4162.271602469571;4170.91658166838;3972.145988612462;4062.5531191568903;4123.60825721556;4149.6265336119895;4155.62599366057;3657.2685462907257;3677.9816100919593;3699.574548926881;3708.592054873962;3708.629137086297;5176.559992400613;5176.844694659167;5185.781341384772;5195.454477279869;5219.947800521984;4463.33050042493;4714.077272091291;4780.617550595944;4781.282807578857;4796.9760151199025;5598.412166722476;5604.131359639263;5610.831675049755;5612.85967850807;5627.971860140673;4023.2556976959063;4029.3351596986754;4032.334664780308;4037.6164264394833;4045.5145382553987;5484.369297530755;5695.857603559903;5703.4011428799795;5798.681072541009;5816.447437493432;4031.5565287818317;4033.9511726951205;4034.9798251008556;4065.4918135233097;4067.0645751476736;4118.279301122292;4127.555355625507;4131;4157.8960525987095;4174.979125104416;4576.58810707038;4763.166445871959;4767.641222251711;4776.71339719611;4781.880452988634;5519.199716041152;5588.357338905997;5589.636673616202;5594.412586678422;5605.1872478491205;1402.3128666953119;1415.6673181802269;1418.489343836218;1423.6440889777555;1425.201886943315;875.934304927133;921.9308551858637;926.4533924984157;936.7189843047058;940.8682784410188;4752;4777.546133117348;4780.4941443445205;4798.448178459452;4811.615070794328;4985.252212168131;5058.519440653132;5074.416442109131;5094.452773613193;5103.617228707862;4768.833090841804;4805.927911081337;4816;4840.2575072973705;5079.263506791494;3008.6840881707108;3025.5764193012997;3036.2257624306103;3049.16148059281;3050.7864449488325;5856.472917437451;5880.764769409176;5900.5543641808035;5907.61600495975;5916.881662366729;5575.386707462176;5603.93525230205;5712.200291959129;5844.620099693507;5912.645241285537;5865.648061116347;5900.616459930091;5930.28836539618;5937.970310148508;5943.732532036069;5751.884962300647;5767.971160144172;5778.451047150514;5787.305523337226;5791.507721843522;5457.290552228185;5614.747336369955;5641.153826925994;5655.971720141373;5691.2032315475035;5876.471117599436;5880.353161152184;5898.2573103507075;5914.290285165807;5953.434423729739;4022.0091054928;4224.38746381779;4236.195122926634;4242.17277630859;4266.5946735060115;5687.744051517609;5702.429757024264;5783.508401785895;5794.1308803679785;5794.681292528951;5630.943690563206;5633.6619802811965;5670.291213598301;5676.68778217202;5696.943030569641;5375.946240537544;5642.435756424489;5650.429054780147;5657.462541058758;5667.914981275367;5573;5573.972130139324;5599.216109744558;5610.382857885547;5611.410801865909;5663.150527420919;5683.715814209356;5702.914456283242;5715.599908006399;5751.4536119068625;5305.814296499604;5534.557235421076;5563.304586926634;5599.188117722826;5615.5507559395965 17:31:43 INFO - PROCESS | 12799 | |5;yui.html;722.4906440959124;754.253289243649;776.7106304799174;821.6877586517122;842.6418772021891;14974.700505989887;15969.520914372559;15984.84015159848;15987.840121598765;16017.919910400446;14224.217668028254;14567.417303307882;15680.843191568109;15682.84317156828;15683;671.4997326991374;777.1606664802;806.637013343996;814.9103598604179;817.5176645778989;809.0695699945081;821.7493664432345;822.5722624235394;822.6380392627254;823.3331001888489;853.8463076646201;853.9786505337354;857.0743596915347;857.2970164465141;857.8370109679172;697.1599222936375;826.68999125328;843.9282660973763;851.8381507513584;852.9445586036887;624.3444383397415;624.3943374926314;624.6252248650818;624.6470744029609;624.7313655128293;14801.851981480155;14819.110853348833;14841.628959275997;14848;14851.2574371281;14370.20963846988;14563;14646.41414343425;14859.777103343458;14885.404583816635;12245.816312755316;12472.251664900135;12495.312757798318;12733.936330318382;13318.600441986757;4557.134144512532;4588.4723256825555;4598.770061496912;4628.120657075145;4670.392848929618;76951;77060.61469692616;77102.61448692776;77310.22689773087;77335;11422.485988130555;11528.563565772254;11682.182247242612;11768.235064720766;12064.517419303305;21997.450063748533;22002.119915203533;22008.229711960324;22008.88995555012;22035.00842462093;8322;8533.957330213434;8852.513111778786;8889.955550222208;8998.685046023358;4757.9286310705365;4939.756043027863;5037.4458809530925;5063.215201643678;5136.43499215086;3567.3578755823683;3704;3704.7962362069807;3722.8883133506038;3723.422869455239;624.6252248650864;631.8262477818545;636.4081404294051;642.3095172689284;651.4560342114388;657.6810247030187;668.7358493395081;675.0717763075771;691.094665987558;705.9294070592899;9338.299627527827;9355.719328420158;9792.412455252565;9986.700398988041;10078.949605252074;560.5487582496048;583.6235628019904;592.1798309341593;657.447852882413;658.3449467779494;4368.847090351823;4581.2440947243995;4587.311903214544;4588.151192029485;4666.1916354927835;111989;117638.41180794213;118829.4058529719;119533.40233298951;119967;101608.49195754122;102557;103180.48409758053;103806.48096759467;105182;88681.55659221663;88770.55614721886;89558;90939;92567.5371623151;8593.570321484025;8758.255548278468;8865.778355541162;8967.551622418723;9161.496117713323;53635;53863.922721546136;54411.18383224334;54771.17843232275;56026.71986640041;68983;70834.64582677053;78909.21090789018;80047.59976200081;80266;11085.778284434105;11203.943980280046;11498.25261358009;11608.361540115375;11927.82108268394;13263.469461221828;13415.932920335335;13530.729385412433;14119.717605647624;14179.503717369842;12785.232886026868;12831.422585983466;12936.417861196456;13202.405891734703;13282.203067815963;11767.969485312262;11906.642800715992;12002.479479309093;12446.190997585129;12480.5007799687;12258.570950016707;12533.997280217378;12669.683257918627;12823.487060517475;12841.807372889602;10049.748756281151;10157.593696252066;10161.898381016392;10420.947895260779;10469.26715129964;10221.897781022095;10222.437765922648;10225.130863876653;10267.7433064174;10285.897141028494 17:31:43 INFO - PROCESS | 12799 | __end_tp_report 17:31:43 INFO - PROCESS | 12799 | __start_cc_report 17:31:43 INFO - PROCESS | 12799 | _x_x_mozilla_cycle_collect,819 17:31:43 INFO - PROCESS | 12799 | __end_cc_report 17:31:43 INFO - PROCESS | 12799 | __startTimestamp1467333103910__endTimestamp 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | ------- Summary: start ------- 17:31:43 INFO - PROCESS | 12799 | Number of tests: 6 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | [#0] dojo.html Cycles:165 Average:5320.23 Median:5548.20 stddev:612.31 (11.0%) stddev-sans-first:588.64 17:31:43 INFO - PROCESS | 12799 | Values: 3089.3 3108.9 3118.5 3137.7 3172.1 5209.3 5244.8 5276.5 5365.3 5378.1 5340.7 5356.4 5372.1 5373.5 5430.2 4795.6 4830.3 4870.5 4887.8 4988.9 4893.8 4901.1 4937.1 4953.4 4956.2 4749.5 4795.6 4796.9 4818.9 4840.5 4784.4 4804.7 4871.3 4871.7 4914.8 4686.9 4828.3 4839.5 4858.6 4882.6 5270.0 5369.2 5375.0 5452.7 5475.5 5792.0 5810.8 5832.0 5836.6 5837.8 5582.7 5706.5 5813.6 5834.5 5842.4 5347.3 5468.8 5469.0 5470.4 5471.3 5960.3 5963.4 5970.4 5971.9 5974.0 5477.1 5519.7 5578.0 5725.5 5743.8 5758.5 5767.7 5769.7 5769.8 5769.8 5646.6 5698.0 5698.7 5700.3 5743.7 5575.8 5642.7 5689.7 5693.1 5703.0 4350.3 4350.7 4366.3 4371.6 4396.4 3905.3 3921.4 3928.3 3960.1 3971.9 5159.4 5196.1 5278.2 5326.8 5343.2 5762.7 5775.0 5792.1 5799.7 5838.8 5412.5 5423.6 5423.7 5434.4 5438.5 4655.3 4718.2 4744.5 4780.3 4838.9 5890.6 5890.9 5895.1 5899.2 5905.7 5732.9 5748.4 5749.4 5760.0 5762.4 5723.9 5850.9 5904.2 5911.4 5964.1 5640.8 5674.5 5682.8 5690.9 5696.6 5521.4 5750.5 5752.1 5753.7 5764.1 5548.2 5565.8 5593.5 5639.1 5658.3 5610.7 5614.5 5619.7 5622.2 5622.7 5371.7 5446.1 5533.1 5541.7 5559.0 5605.9 5663.6 5713.8 5714.3 5716.9 5553.8 5555.2 5561.1 5562.0 5562.8 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | [#1] ext.html Cycles:180 Average:58419.48 Median:196286.64 stddev:110651.25 (56.4%) stddev-sans-first:110876.49 17:31:43 INFO - PROCESS | 12799 | Values: 598.4 606.5 621.9 622.9 627.2 32884.5 36149.8 36159.5 41920.2 42935.6 45817.3 46157.5 46289.5 46327.0 46471.5 8968.7 9107.5 9110.9 9112.8 9121.6 8258.6 8977.7 10628.9 10866.3 10876.8 11080.3 11153.4 11153.7 11172.3 11172.4 11034.3 11042.6 11066.6 11092.9 11097.2 8162.6 10287.7 10666.1 10668.8 11082.4 44469.8 44675.0 44789.6 44793.1 44849.0 3560.4 3587.6 3847.3 4171.7 4202.5 33971.3 34023.7 34296.5 34674.3 35920.8 4420.7 4442.0 4512.9 4518.6 4524.5 330350.0 331238.0 331704.0 331739.0 332631.0 54822.5 54986.5 55052.7 55064.0 55080.4 63839.7 64313.7 64383.4 64420.0 64448.7 15956.9 16619.3 16623.7 16625.7 16628.0 11079.0 12794.9 12864.1 12872.0 12892.4 18098.6 18433.4 18513.0 19199.3 19199.7 6127.1 6134.0 6213.5 6214.3 6241.6 908.2 956.2 1074.9 1083.8 1095.4 32124.8 32404.7 32557.3 32605.5 32728.8 1135.0 1142.7 1150.5 1151.9 1154.0 16668.2 16969.7 17055.9 17136.7 17410.9 509792.0 511419.0 512432.0 513750.0 514388.0 60238.7 60350.0 60470.7 60603.0 60638.0 1246.9 1328.1 1363.3 1375.8 1377.7 32947.8 34197.5 34405.7 34522.0 34529.8 49808.8 50029.0 50478.2 50505.5 50536.2 388726.0 392529.4 392532.0 393442.0 393494.0 25954.4 29221.6 29873.4 29887.9 31424.7 48881.3 49132.0 49413.5 50115.0 50585.2 40897.0 42168.6 42506.8 43129.8 43776.0 41765.6 41810.8 43200.4 43708.3 44168.3 41348.4 41547.2 42324.6 42709.1 42722.8 34913.8 37277.3 37851.2 38254.8 38455.2 27834.9 28328.0 28444.6 28471.9 28622.6 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | [#2] jquery.html Cycles:180 Average:28493.08 Median:13432.63 stddev:74659.44 (555.8%) stddev-sans-first:74839.10 17:31:43 INFO - PROCESS | 12799 | Values: 411.0 415.0 418.0 422.9 437.3 18559.0 19575.2 19904.6 20253.7 20344.1 19012.3 19230.2 20205.7 20226.7 20230.8 5324.9 5693.7 5696.6 5696.8 5698.6 5547.4 5571.1 5678.8 5681.0 5685.5 5725.5 5779.9 5781.3 5783.9 5785.3 5448.0 5631.9 5741.5 5746.5 5748.5 5016.7 5044.6 5044.7 5065.2 5065.5 23281.1 23387.0 24185.8 24327.4 24420.9 2314.7 2438.0 2444.4 2455.7 2906.0 14671.0 14880.7 14900.2 15091.6 15620.4 1895.6 1910.1 1951.5 1955.2 2049.3 79711.6 80241.6 80879.0 81755.0 83121.6 10845.8 10966.6 11054.8 11275.9 11320.5 15631.0 15682.8 15717.7 15797.1 15822.4 7961.0 8110.8 8149.7 8157.7 8224.9 7692.3 7707.3 7708.9 7874.0 7877.2 6512.3 6894.1 6896.2 6970.7 7120.9 2033.2 2043.4 2053.2 2071.6 2088.3 862.2 908.8 936.4 952.4 1050.1 18575.4 19101.2 20362.8 20462.0 20871.4 973.0 1019.6 1028.7 1029.5 1048.2 10795.6 11678.4 11741.0 11753.8 11755.6 379630.0 449567.0 471308.0 472572.0 474872.0 90701.1 93935.5 95135.0 95659.0 95768.5 1038.9 1048.0 1083.5 1118.1 1120.5 18028.2 18075.5 18263.3 18388.4 18423.8 41599.6 41827.4 42024.8 42920.6 42925.8 61983.0 62560.7 63503.7 63523.4 64202.7 8525.0 8781.1 8855.0 8877.6 8899.6 12897.2 13819.2 13900.9 13959.7 14024.9 11485.6 11918.5 12154.6 12292.7 12420.7 12294.5 12350.2 12511.7 12535.3 12933.4 12170.8 12233.4 12398.1 12504.9 12725.9 8743.6 8756.0 8798.3 8883.7 9027.6 8919.7 12013.0 12206.5 12354.9 12479.4 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | [#3] mootools.html Cycles:180 Average:5984.16 Median:4845.42 stddev:3369.25 (69.5%) stddev-sans-first:3360.65 17:31:43 INFO - PROCESS | 12799 | Values: 1342.8 1456.4 1516.4 1643.3 1818.7 8563.8 8956.4 8974.6 9273.6 9274.9 8634.1 8846.2 8862.6 8886.4 8888.1 2150.5 2374.6 2399.7 2421.9 2449.3 2444.7 2451.0 2451.5 2452.9 2455.8 2354.7 2372.2 2394.5 2395.3 2395.9 2089.5 2301.1 2349.3 2363.8 2370.0 2342.5 2356.6 2357.8 2360.8 2367.9 8996.6 9041.6 9045.6 9049.0 9053.0 5278.5 5456.8 5463.7 5468.4 5470.8 3493.1 3614.8 3649.1 3656.9 3664.5 1210.4 1213.9 1240.6 1270.9 1272.8 12405.8 12417.9 12435.4 12475.6 12725.6 4736.6 4804.5 4886.3 4958.5 4982.9 10631.0 10782.0 10796.5 10800.6 10810.2 5488.3 5491.1 5491.9 5497.8 5498.9 4422.4 4890.5 5030.4 5044.8 5126.5 4057.2 4155.9 4172.6 4178.2 4201.4 1250.5 1321.0 1341.6 1378.3 1388.1 812.1 864.3 889.0 984.9 1007.1 5802.2 6313.9 6373.0 6459.9 6624.7 983.2 996.6 1003.4 1011.7 1024.3 4259.2 4454.3 4504.1 4524.5 4544.6 11063.1 11075.8 11156.2 11161.9 11433.5 10998.6 11050.2 11051.0 11082.9 11087.9 7928.6 8496.9 8503.9 8695.0 8711.1 5652.2 6005.7 6039.0 6205.6 6294.6 9905.3 10516.2 10719.4 10728.1 10738.1 10079.4 10400.5 10401.5 10628.0 10638.9 7179.7 7719.0 7838.1 7960.1 7971.1 8748.2 8769.7 8835.2 8836.9 8840.2 7609.4 7896.4 7906.4 7985.7 8077.2 7809.2 7878.9 7913.4 7973.7 8073.6 7197.2 7198.5 7306.5 7312.3 7316.8 5357.9 5509.1 5520.4 5569.1 5616.5 5187.4 5286.1 5318.3 5350.9 5543.1 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | [#4] prototype.html Cycles:180 Average:4663.03 Median:5308.98 stddev:1372.02 (25.8%) stddev-sans-first:1336.89 17:31:43 INFO - PROCESS | 12799 | Values: 336.8 347.0 351.3 355.0 355.1 5348.6 5384.5 5392.6 5408.0 5435.6 5312.2 5334.9 5350.4 5360.1 5370.9 3824.9 3988.7 4005.2 4049.0 4192.2 4106.5 4154.6 4156.0 4159.1 4162.4 4132.9 4134.0 4156.3 4162.3 4170.9 3972.1 4062.6 4123.6 4149.6 4155.6 3657.3 3678.0 3699.6 3708.6 3708.6 5176.6 5176.8 5185.8 5195.5 5219.9 4463.3 4714.1 4780.6 4781.3 4797.0 5598.4 5604.1 5610.8 5612.9 5628.0 4023.3 4029.3 4032.3 4037.6 4045.5 5484.4 5695.9 5703.4 5798.7 5816.4 4031.6 4034.0 4035.0 4065.5 4067.1 4118.3 4127.6 4131.0 4157.9 4175.0 4576.6 4763.2 4767.6 4776.7 4781.9 5519.2 5588.4 5589.6 5594.4 5605.2 1402.3 1415.7 1418.5 1423.6 1425.2 875.9 921.9 926.5 936.7 940.9 4752.0 4777.5 4780.5 4798.4 4811.6 4985.3 5058.5 5074.4 5094.5 5103.6 4768.8 4805.9 4816.0 4840.3 5079.3 3008.7 3025.6 3036.2 3049.2 3050.8 5856.5 5880.8 5900.6 5907.6 5916.9 5575.4 5603.9 5712.2 5844.6 5912.6 5865.6 5900.6 5930.3 5938.0 5943.7 5751.9 5768.0 5778.5 5787.3 5791.5 5457.3 5614.7 5641.2 5656.0 5691.2 5876.5 5880.4 5898.3 5914.3 5953.4 4022.0 4224.4 4236.2 4242.2 4266.6 5687.7 5702.4 5783.5 5794.1 5794.7 5630.9 5633.7 5670.3 5676.7 5696.9 5375.9 5642.4 5650.4 5657.5 5667.9 5573.0 5574.0 5599.2 5610.4 5611.4 5663.2 5683.7 5702.9 5715.6 5751.5 5305.8 5534.6 5563.3 5599.2 5615.6 17:31:43 INFO - PROCESS | 12799 | 17:31:43 INFO - PROCESS | 12799 | [#5] yui.html Cycles:180 Average:21123.06 Median:4588.31 stddev:30950.79 (674.6%) stddev-sans-first:30999.71 17:31:43 INFO - PROCESS | 12799 | Values: 722.5 754.3 776.7 821.7 842.6 14974.7 15969.5 15984.8 15987.8 16017.9 14224.2 14567.4 15680.8 15682.8 15683.0 671.5 777.2 806.6 814.9 817.5 809.1 821.7 822.6 822.6 823.3 853.8 854.0 857.1 857.3 857.8 697.2 826.7 843.9 851.8 852.9 624.3 624.4 624.6 624.6 624.7 14801.9 14819.1 14841.6 14848.0 14851.3 14370.2 14563.0 14646.4 14859.8 14885.4 12245.8 12472.3 12495.3 12733.9 13318.6 4557.1 4588.5 4598.8 4628.1 4670.4 76951.0 77060.6 77102.6 77310.2 77335.0 11422.5 11528.6 11682.2 11768.2 12064.5 21997.5 22002.1 22008.2 22008.9 22035.0 8322.0 8534.0 8852.5 8890.0 8998.7 4757.9 4939.8 5037.4 5063.2 5136.4 3567.4 3704.0 3704.8 3722.9 3723.4 624.6 631.8 636.4 642.3 651.5 657.7 668.7 675.1 691.1 705.9 9338.3 9355.7 9792.4 9986.7 10078.9 560.5 583.6 592.2 657.4 658.3 4368.8 4581.2 4587.3 4588.2 4666.2 111989.0 117638.4 118829.4 119533.4 119967.0 101608.5 102557.0 103180.5 103806.5 105182.0 88681.6 88770.6 89558.0 90939.0 92567.5 8593.6 8758.3 8865.8 8967.6 9161.5 53635.0 53863.9 54411.2 54771.2 56026.7 68983.0 70834.6 78909.2 80047.6 80266.0 11085.8 11203.9 11498.3 11608.4 11927.8 13263.5 13415.9 13530.7 14119.7 14179.5 12785.2 12831.4 12936.4 13202.4 13282.2 11768.0 11906.6 12002.5 12446.2 12480.5 12258.6 12534.0 12669.7 12823.5 12841.8 10049.7 10157.6 10161.9 10420.9 10469.3 10221.9 10222.4 10225.1 10267.7 10285.9 17:31:43 INFO - PROCESS | 12799 | -------- Summary: end -------- 17:31:43 INFO - PROCESS | 12799 | 17:31:44 INFO - TEST-INFO | 12799: exit 0 17:31:44 INFO - TEST-OK | dromaeo_css | took 1113502ms 17:31:44 INFO - TEST-START | kraken 17:31:44 INFO - operating with platform_type : linux_ 17:31:44 INFO - Initialising browser for kraken test... 17:31:44 INFO - TEST-INFO | started process 12990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKYQ76d/profile http://localhost:42487/getInfo.html) 17:31:48 INFO - PROCESS | 12990 | __metrics Screen width/height:1600/1200 17:31:48 INFO - PROCESS | 12990 | colorDepth:24 17:31:48 INFO - PROCESS | 12990 | Browser inner width/height: 1024/697 17:31:48 INFO - PROCESS | 12990 | __metrics 17:31:49 INFO - PROCESS | 12990 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:31:50 INFO - TEST-INFO | 12990: exit 0 17:31:50 INFO - Browser initialized. 17:31:50 INFO - Running cycle 1/1 for kraken test... 17:31:50 INFO - TEST-INFO | started process 13070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKYQ76d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:02 INFO - PROCESS | 13070 | RSS: Main: 157683712 17:32:02 INFO - PROCESS | 13070 | 17:32:04 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:05 INFO - PROCESS | 13070 | RSS: Main: 215293952 17:32:05 INFO - PROCESS | 13070 | 17:32:08 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-dft) 17:32:08 INFO - PROCESS | 13070 | RSS: Main: 203137024 17:32:08 INFO - PROCESS | 13070 | 17:32:11 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-fft) 17:32:12 INFO - PROCESS | 13070 | RSS: Main: 268193792 17:32:12 INFO - PROCESS | 13070 | 17:32:14 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-oscillator) 17:32:15 INFO - PROCESS | 13070 | RSS: Main: 180256768 17:32:15 INFO - PROCESS | 13070 | 17:32:17 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:17 INFO - PROCESS | 13070 | RSS: Main: 184692736 17:32:17 INFO - PROCESS | 13070 | 17:32:20 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42487/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:21 INFO - PROCESS | 13070 | RSS: Main: 218857472 17:32:21 INFO - PROCESS | 13070 | 17:32:24 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42487/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:25 INFO - PROCESS | 13070 | RSS: Main: 220622848 17:32:25 INFO - PROCESS | 13070 | 17:32:28 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42487/tests/kraken/driver.html?testName=json-parse-financial) 17:32:28 INFO - PROCESS | 13070 | RSS: Main: 221417472 17:32:28 INFO - PROCESS | 13070 | 17:32:30 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:31 INFO - PROCESS | 13070 | RSS: Main: 207978496 17:32:31 INFO - PROCESS | 13070 | 17:32:32 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:33 INFO - PROCESS | 13070 | RSS: Main: 212246528 17:32:33 INFO - PROCESS | 13070 | 17:32:35 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:36 INFO - PROCESS | 13070 | RSS: Main: 210153472 17:32:36 INFO - PROCESS | 13070 | 17:32:38 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:39 INFO - PROCESS | 13070 | RSS: Main: 224960512 17:32:39 INFO - PROCESS | 13070 | 17:32:41 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:42 INFO - PROCESS | 13070 | RSS: Main: 224833536 17:32:42 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42487/tests/kraken/driver.html?testName=ai-astar) 17:32:44 INFO - PROCESS | 13070 | RSS: Main: 267485184 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | __start_tp_report 17:32:44 INFO - PROCESS | 13070 | _x_x_mozilla_page_load 17:32:44 INFO - PROCESS | 13070 | _x_x_mozilla_page_load_details 17:32:44 INFO - PROCESS | 13070 | |i|pagename|runs| 17:32:44 INFO - PROCESS | 13070 | |0;ai-astar;101;111;111;111;113;110;110;112;110;113 17:32:44 INFO - PROCESS | 13070 | |1;audio-beat-detection;145;116;120;169;116;118;145;122;164;120 17:32:44 INFO - PROCESS | 13070 | |2;audio-dft;160;161;159;160;159;161;162;161;162;162 17:32:44 INFO - PROCESS | 13070 | |3;audio-fft;75;76;77;110;74;75;75;76;97;74 17:32:44 INFO - PROCESS | 13070 | |4;audio-oscillator;82;83;114;84;84;83;120;82;82;124 17:32:44 INFO - PROCESS | 13070 | |5;imaging-gaussian-blur;118;118;116;117;117;117;117;117;116;117 17:32:44 INFO - PROCESS | 13070 | |6;imaging-darkroom;146;146;145;146;146;145;145;145;146;145 17:32:44 INFO - PROCESS | 13070 | |7;imaging-desaturate;95;95;95;94;95;95;95;94;95;95 17:32:44 INFO - PROCESS | 13070 | |8;json-parse-financial;53;53;55;53;53;55;54;54;53;54 17:32:44 INFO - PROCESS | 13070 | |9;json-stringify-tinderbox;59;59;59;59;60;59;59;64;60;59 17:32:44 INFO - PROCESS | 13070 | |10;stanford-crypto-aes;77;81;74;75;83;77;75;74;74;80 17:32:44 INFO - PROCESS | 13070 | |11;stanford-crypto-ccm;122;117;121;117;119;119;118;119;155;132 17:32:44 INFO - PROCESS | 13070 | |12;stanford-crypto-pbkdf2;153;153;154;158;152;156;156;155;158;154 17:32:44 INFO - PROCESS | 13070 | |13;stanford-crypto-sha256-iterative;62;62;62;61;61;62;61;62;64;64 17:32:44 INFO - PROCESS | 13070 | __end_tp_report 17:32:44 INFO - PROCESS | 13070 | __start_cc_report 17:32:44 INFO - PROCESS | 13070 | _x_x_mozilla_cycle_collect,1602 17:32:44 INFO - PROCESS | 13070 | __end_cc_report 17:32:44 INFO - PROCESS | 13070 | __startTimestamp1467333164292__endTimestamp 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | ------- Summary: start ------- 17:32:44 INFO - PROCESS | 13070 | Number of tests: 14 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:1.20 17:32:44 INFO - PROCESS | 13070 | Values: 101.0 111.0 111.0 111.0 113.0 110.0 110.0 112.0 110.0 113.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:133.50 stddev:20.56 (15.4%) stddev-sans-first:21.38 17:32:44 INFO - PROCESS | 13070 | Values: 145.0 116.0 120.0 169.0 116.0 118.0 145.0 122.0 164.0 120.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 17:32:44 INFO - PROCESS | 13070 | Values: 160.0 161.0 159.0 160.0 159.0 161.0 162.0 161.0 162.0 162.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:12.33 (16.3%) stddev-sans-first:12.89 17:32:44 INFO - PROCESS | 13070 | Values: 75.0 76.0 77.0 110.0 74.0 75.0 75.0 76.0 97.0 74.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:82.50 stddev:17.79 (21.6%) stddev-sans-first:18.35 17:32:44 INFO - PROCESS | 13070 | Values: 82.0 83.0 114.0 84.0 84.0 83.0 120.0 82.0 82.0 124.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 17:32:44 INFO - PROCESS | 13070 | Values: 118.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:32:44 INFO - PROCESS | 13070 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:32:44 INFO - PROCESS | 13070 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 17:32:44 INFO - PROCESS | 13070 | Values: 53.0 53.0 55.0 53.0 53.0 55.0 54.0 54.0 53.0 54.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:1.57 (2.7%) stddev-sans-first:1.64 17:32:44 INFO - PROCESS | 13070 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 59.0 64.0 60.0 59.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.00 stddev:3.27 (4.2%) stddev-sans-first:3.46 17:32:44 INFO - PROCESS | 13070 | Values: 77.0 81.0 74.0 75.0 83.0 77.0 75.0 74.0 74.0 80.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:120.00 stddev:11.77 (9.8%) stddev-sans-first:12.46 17:32:44 INFO - PROCESS | 13070 | Values: 122.0 117.0 121.0 117.0 119.0 119.0 118.0 119.0 155.0 132.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.50 stddev:2.08 (1.3%) stddev-sans-first:2.09 17:32:44 INFO - PROCESS | 13070 | Values: 153.0 153.0 154.0 158.0 152.0 156.0 156.0 155.0 158.0 154.0 17:32:44 INFO - PROCESS | 13070 | 17:32:44 INFO - PROCESS | 13070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 17:32:44 INFO - PROCESS | 13070 | Values: 62.0 62.0 62.0 61.0 61.0 62.0 61.0 62.0 64.0 64.0 17:32:44 INFO - PROCESS | 13070 | -------- Summary: end -------- 17:32:44 INFO - PROCESS | 13070 | 17:32:45 INFO - TEST-INFO | 13070: exit 0 17:32:45 INFO - TEST-OK | kraken | took 60671ms 17:32:45 INFO - SUITE-END | took 1174s 17:32:45 INFO - Completed test suite (00:19:34) 17:32:45 INFO - javascript benchmark 17:32:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.335792804547, 3108.8756449742014, 3118.5010398336262, 3137.701918317759, 3172.1118086935667, 5209.296744939432, 5244.79020839166, 5276.4987326204, 5365.302510673612, 5378.112611419111, 5340.652857564256, 5356.4107948125775, 5372.113601255788, 5373.489518495747, 5430.239766432703, 4795.568398844103, 4830.3237546743485, 4870.4885986971385, 4887.755612219393, 4988.87527811804, 4893.804247830082, 4901.06879692859, 4937.076476282679, 4953.4303555091265, 4956.231784073474, 4749.501302363254, 4795.6403269754555, 4796.856094317176, 4818.9036219275595, 4840.540148685869, 4784.449788274358, 4804.6876952997945, 4871.342368780241, 4871.707697538159, 4914.754262286907, 4686.859394218145, 4828.251620998751, 4839.491853355417, 4858.562729354375, 4882.609391248691, 5269.973650131763, 5369.167778994223, 5375.0, 5452.672839629635, 5475.479829416199, 5791.971040144815, 5810.82567522975, 5831.970840145815, 5836.649801011953, 5837.795677151322, 5582.692951887645, 5706.4864162225595, 5813.593048486608, 5834.474897259224, 5842.3573406925625, 5347.25138480613, 5468.835934921959, 5469.0155771960635, 5470.425605311465, 5471.288732464834, 5960.254968128984, 5963.403659634088, 5970.373110823388, 5971.880562388815, 5973.970130149321, 5477.068898287301, 5519.724013799294, 5578.0, 5725.51333136688, 5743.798967036134, 5758.510526605285, 5767.682777447197, 5769.653820770767, 5769.798057067983, 5769.798057067983, 5646.632968857011, 5697.971510142423, 5698.686572238566, 5700.25896633435, 5743.741531631086, 5575.776968921279, 5642.6614403135945, 5689.715514224272, 5693.060644993529, 5702.971485142548, 4350.303951367766, 4350.695451318377, 4366.301391777364, 4371.584699453547, 4396.428464299621, 3905.2970465316516, 3921.392184211452, 3928.3125453045604, 3960.0693836948294, 3971.940420893689, 5159.380874295109, 5196.064708352533, 5278.2346559749385, 5326.760295786699, 5343.198520221998, 5762.74067666956, 5775.0, 5792.131180322901, 5799.739011744482, 5838.766449342063, 5412.485813847678, 5423.566114710814, 5423.701696406735, 5434.429384914606, 5438.45615438453, 4655.348251244828, 4718.245080787057, 4744.525547445228, 4780.330753694486, 4838.854834354905, 5890.6171098879295, 5890.9410905891245, 5895.056790913433, 5899.174115623816, 5905.704714764331, 5732.914006289992, 5748.367679555329, 5749.425057494217, 5760.049591817303, 5762.423757624204, 5723.912456633227, 5850.882982340415, 5904.202932604044, 5911.379305172895, 5964.105384192232, 5640.830775076754, 5674.460926212003, 5682.829515114553, 5690.943090569207, 5696.572757043155, 5521.365043020104, 5750.539956803529, 5752.13717942312, 5753.654780713171, 5764.106563482667, 5548.195511650707, 5565.777368905198, 5593.468620481048, 5639.097744360883, 5658.321001479849, 5610.747516361856, 5614.522765564972, 5619.690916999441, 5622.156676498558, 5622.662640241599, 5371.677699338053, 5446.101393270066, 5533.059379905506, 5541.695206763506, 5558.972205138948, 5605.887882242414, 5663.631863928831, 5713.8285851424525, 5714.314282286152, 5716.914246286392, 5553.750081246434, 5555.22226888244, 5561.138023606348, 5561.972190139023, 5562.805301814417], "value": 5278.772250840598, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.389642564584, 606.4602503771641, 621.8662987457697, 622.8785386849563, 627.2222444169231, 32884.50673239903, 36149.819250903776, 36159.4576081359, 41920.16159676805, 42935.57064429355, 45817.31274030884, 46157.53842461583, 46289.537104628944, 46327.0, 46471.53528464714, 8968.730938071853, 9107.453552786854, 9110.86333704995, 9112.817743645122, 9121.635134594608, 8258.587070646474, 8977.730668079968, 10628.94685526575, 10866.293690910066, 10876.836847447295, 11080.279781814197, 11153.442327883615, 11153.665390038312, 11172.329660220372, 11172.385518796464, 11034.337939723602, 11042.613508527204, 11066.612668556643, 11092.889071109266, 11097.1677124216, 8162.551059691774, 10287.691369258859, 10666.14670826332, 10668.839967400496, 11082.445877706163, 44469.77765111154, 44675.0, 44789.55210447919, 44793.104137917384, 44849.0, 3560.412531932228, 3587.6053634100226, 3847.2882516734494, 4171.728837625575, 4202.537720850704, 33971.32057358864, 34023.6597634023, 34296.48555271673, 34674.30651386984, 35920.82039589812, 4420.7126536775, 4441.977790111029, 4512.932306015412, 4518.593326600621, 4524.47968483622, 330350.0, 331238.0, 331704.0, 331739.0, 332631.0, 54822.451775482536, 54986.45013549813, 55052.72473637606, 55064.0, 55080.449195508336, 63839.68080159662, 64313.67843160754, 64383.35616643867, 64420.0, 64448.677756610916, 15956.920215398848, 16619.252133654016, 16623.6675266494, 16625.66748665044, 16628.0, 11079.0, 12794.872051279368, 12864.099513034185, 12872.0, 12892.419841107172, 18098.63802723938, 18433.354832581063, 18513.0, 19199.32802351939, 19199.712004319666, 6127.080937859357, 6133.975787989953, 6213.502919766408, 6214.25428948529, 6241.625502469867, 908.246155690775, 956.2445667922402, 1074.9197056957707, 1083.7886612110563, 1095.430376204385, 32124.83937580344, 32404.675953240636, 32557.348853022806, 32605.510917336258, 32728.836355818068, 1134.9659510214706, 1142.6971852459105, 1150.453534571072, 1151.8848115188414, 1154.0208542349742, 16668.249928753234, 16969.745453818203, 17055.914720426317, 17136.657266854843, 17410.912945435193, 509792.0, 511419.0, 512432.0, 513750.0, 514388.0, 60238.69880650657, 60350.0, 60470.697646512366, 60603.0, 60638.0, 1246.875312468746, 1328.0769864943964, 1363.3455941148106, 1375.8211432513708, 1377.6762460821499, 32947.835260824504, 34197.48703769396, 34405.655943440244, 34522.0, 34529.82735086309, 49808.750956244985, 50029.0, 50478.24282635837, 50505.49494505008, 50536.24195636995, 388726.0, 392529.4482330955, 392532.0, 393442.0, 393494.0, 25954.35114122162, 29221.561676575293, 29873.402531948803, 29887.850560747058, 31424.685753142177, 48881.26678099902, 49132.0, 49413.50586494089, 50115.0, 50585.24122138244, 40897.0, 42168.578314217695, 42506.78746606247, 43129.784351078044, 43776.0, 41765.58234417738, 41810.790946045076, 43200.35199471947, 43708.34437483377, 44168.33747493726, 41348.37977430401, 41547.16905661931, 42324.57675423206, 42709.14581708411, 42722.78638606787, 34913.8254308737, 37277.25445491129, 37851.24297514089, 38254.808725956194, 38455.2308953825, 27834.86082569574, 28328.0, 28444.57333139963, 28471.857640711663, 28622.57066144051], "value": 20594.873949821304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.9547949725531, 414.9917001659967, 417.99164016719664, 422.87304333950027, 437.2850389612982, 18559.0, 19575.21699132033, 19904.609226418666, 20253.69619455706, 20344.08451619677, 19012.334568290113, 19230.230790768353, 20205.696914546294, 20226.696599551018, 20230.797692023076, 5324.866878328034, 5693.715314234271, 5696.629719068268, 5696.829095127153, 5698.629589076718, 5547.389787123413, 5571.052921003439, 5678.829635110953, 5680.9715951420185, 5685.516731077863, 5725.513331366818, 5779.942200578003, 5781.277340332458, 5783.855403614923, 5785.305763308409, 5447.972760136174, 5631.887362252732, 5741.511971482429, 5746.454086861762, 5748.45389687979, 5016.724080175589, 5044.571211447032, 5044.697318160922, 5065.1895696688725, 5065.46812584677, 23281.06875724969, 23387.0, 24185.758142418526, 24327.391815204584, 24420.877895610585, 2314.745378008418, 2437.9878100609562, 2444.3889027743066, 2455.656208130863, 2905.9829059829103, 14671.0, 14880.702385952329, 14900.180490073042, 15091.622709432242, 15620.375184992587, 1895.6303520813447, 1910.0927059646694, 1951.541387773872, 1955.247229816531, 2049.25202301159, 79711.601441993, 80241.59879200625, 80879.0, 81755.0, 83121.58439207826, 10845.783084338427, 10966.561337546409, 11054.778904422028, 11275.928786765244, 11320.490577924013, 15631.0, 15682.76475852863, 15717.685646287238, 15797.131157786433, 15822.367105315889, 7960.960195198987, 8110.756677299691, 8149.674013039412, 8157.714479993172, 8224.876626850602, 7692.269234422721, 7707.344875685518, 7708.884366734504, 7873.960630196812, 7877.172896845863, 6512.283648798629, 6894.13823272091, 6896.241413444517, 6970.721171153097, 7120.92879071213, 2033.2070492507933, 2043.3550991451727, 2053.178728508579, 2071.6271071207025, 2088.3421722157473, 862.2067697717989, 908.7818923458323, 936.3913456253354, 952.4237836109193, 1050.138886113395, 18575.431528773537, 19101.2359505621, 20362.77823330605, 20462.0, 20871.37385878426, 973.0, 1019.592163134752, 1028.7016765138176, 1029.4801125431609, 1048.192891473561, 10795.568177272979, 11678.357690326944, 11741.0, 11753.764924701458, 11755.588554400554, 379630.0, 449567.0, 471308.0, 472572.0, 474872.0, 90701.09298907059, 93935.53032234932, 95135.0, 95659.0, 95768.52115739377, 1038.896110388955, 1047.9790404191874, 1083.4745148602922, 1118.139032944628, 1120.4845770945294, 18028.188731506852, 18075.54811129732, 18263.269469221614, 18388.448346549623, 18423.815761842747, 41599.58400416078, 41827.37258941179, 42024.789876050425, 42920.570794291656, 42925.78537107295, 61983.0, 62560.687196563726, 63503.6824815873, 63523.364766353596, 64202.67898660477, 8524.957375213084, 8781.077986811293, 8854.955725221333, 8877.644894204159, 8899.644014239359, 12897.161684490478, 13819.170849749047, 13900.860991390362, 13959.651008724863, 14024.859751402764, 11485.598004069818, 11918.52325906954, 12154.574589889311, 12292.692682683004, 12420.689482763004, 12294.508219671114, 12350.197237179555, 12511.749765004832, 12535.310557919402, 12933.353332333534, 12170.756584868075, 12233.388330583613, 12398.07014473936, 12504.937080348273, 12725.93637031809, 8743.562821859008, 8756.0, 8798.34012449056, 8883.722322559932, 9027.638894444148, 8919.671176127926, 12013.038956883604, 12206.450709717907, 12354.876451235732, 12479.438425271066], "value": 9587.002701463192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.7981956149254, 1456.3519233940897, 1516.3631274864558, 1643.268745408293, 1818.66354724376, 8563.78590535237, 8956.373053886231, 8974.596143173556, 9273.582688779004, 9274.860877086849, 8634.136586341378, 8846.20384165425, 8862.556872156398, 8886.42238254513, 8888.06675299094, 2150.5268840854988, 2374.620060790274, 2399.7120345558515, 2421.878906054699, 2449.289705985262, 2444.6577479152934, 2451.0, 2451.472933319336, 2452.877356132195, 2455.815813813962, 2354.705661792276, 2372.2171683344454, 2394.473215892501, 2395.317334559651, 2395.8921848516857, 2089.5298557824444, 2301.137073597401, 2349.2717257650097, 2363.8108951283857, 2370.01644317608, 2342.543204075189, 2356.5640356533922, 2357.7760112789256, 2360.7875291223872, 2367.869767162805, 8996.595153218055, 9041.593128309241, 9045.638174473013, 9049.049849765812, 9053.0, 5278.47215278473, 5456.836294911159, 5463.672179669233, 5468.398476167618, 5470.8085217017215, 3493.0917961329983, 3614.8011859347725, 3649.069487280753, 3656.926861462756, 3664.486971823947, 1210.3645586067298, 1213.9028877689764, 1240.5844042245858, 1270.9237445753283, 1272.8281681972908, 12405.751884962341, 12417.93791031048, 12435.44040518179, 12475.625731227987, 12725.61823145307, 4736.621070314435, 4804.495527969582, 4886.3403440535785, 4958.528939750718, 4982.900341993212, 10631.043206111488, 10782.0, 10796.460176991119, 10800.621978230723, 10810.243282970274, 5488.341399032141, 5491.093969495068, 5491.917621235684, 5497.780088796403, 5498.890022199614, 4422.425084738963, 4890.462049174588, 5030.421501527371, 5044.848654540369, 5126.512981266774, 4057.1885622875543, 4155.854545090907, 4172.582741725803, 4178.247915375262, 4201.390798334224, 1250.5373011985441, 1321.0224433918831, 1341.5774031180342, 1378.2626294932163, 1388.0838646493266, 812.0942623559642, 864.2955990867423, 889.0, 984.8522721591676, 1007.1338648762058, 5802.216700745345, 6313.873722525524, 6373.0, 6459.903101453482, 6624.735010599522, 983.2134292565919, 996.6163027234567, 1003.4380746781679, 1011.7318910488726, 1024.2983556263982, 4259.169461954951, 4454.309582014728, 4504.144212599595, 4524.479684836286, 4544.636429085665, 11063.059639930536, 11075.778484430266, 11156.163287753288, 11161.944190278997, 11433.485493152828, 10998.615048473264, 11050.226484146193, 11051.005409513022, 11082.944585277184, 11087.889121108847, 7928.6035698214855, 8496.872546911802, 8503.872441913376, 8694.956525217334, 8711.08533603975, 5652.152177173457, 6005.729742161526, 6039.0, 6205.565610407228, 6294.559380843297, 9905.257105716955, 10516.15870730355, 10719.356838589709, 10728.141748659933, 10738.087262582769, 10079.445630490394, 10400.479976001321, 10401.53193106297, 10628.04347608688, 10638.8936110641, 7179.748708795167, 7718.961405192938, 7838.059432868093, 7960.124386317616, 7971.12317645047, 8748.212660860552, 8769.736907892773, 8835.20483156519, 8836.91163088361, 8840.204381605687, 7609.376086805429, 7896.368290536858, 7906.367490600853, 7985.680572777024, 8077.151899050515, 7809.219078092373, 7878.881816772639, 7913.406494512819, 7973.692981975935, 8073.555954422563, 7197.244289349543, 7198.460115491254, 7306.525075870051, 7312.268773122858, 7316.780496585111, 5357.892842143213, 5509.063459212024, 5520.392756796829, 5569.10894256917, 5616.466435688603, 5187.403448603459, 5286.101362768261, 5318.335208098988, 5350.919736203882, 5543.113101903838], "value": 4795.848011888383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.8282176090194, 346.95663042119736, 351.2956522173043, 355.04138825172026, 355.14587417261464, 5348.572114230862, 5384.515393614579, 5392.56859451244, 5407.972960135199, 5435.646682965605, 5312.150055991042, 5334.946650533493, 5350.3515759699, 5360.142377219646, 5370.91943620846, 3824.9043773905737, 3988.680905527558, 4005.1989602079557, 4049.0, 4192.182524407742, 4106.548279689232, 4154.584541545852, 4155.9817844628105, 4159.126583417486, 4162.354835000579, 4132.938005929914, 4133.979330103345, 4156.293430116887, 4162.271602469571, 4170.91658166838, 3972.145988612462, 4062.5531191568903, 4123.60825721556, 4149.6265336119895, 4155.62599366057, 3657.2685462907257, 3677.9816100919593, 3699.574548926881, 3708.592054873962, 3708.629137086297, 5176.559992400613, 5176.844694659167, 5185.781341384772, 5195.454477279869, 5219.947800521984, 4463.33050042493, 4714.077272091291, 4780.617550595944, 4781.282807578857, 4796.9760151199025, 5598.412166722476, 5604.131359639263, 5610.831675049755, 5612.85967850807, 5627.971860140673, 4023.2556976959063, 4029.3351596986754, 4032.334664780308, 4037.6164264394833, 4045.5145382553987, 5484.369297530755, 5695.857603559903, 5703.4011428799795, 5798.681072541009, 5816.447437493432, 4031.5565287818317, 4033.9511726951205, 4034.9798251008556, 4065.4918135233097, 4067.0645751476736, 4118.279301122292, 4127.555355625507, 4131.0, 4157.8960525987095, 4174.979125104416, 4576.58810707038, 4763.166445871959, 4767.641222251711, 4776.71339719611, 4781.880452988634, 5519.199716041152, 5588.357338905997, 5589.636673616202, 5594.412586678422, 5605.1872478491205, 1402.3128666953119, 1415.6673181802269, 1418.489343836218, 1423.6440889777555, 1425.201886943315, 875.934304927133, 921.9308551858637, 926.4533924984157, 936.7189843047058, 940.8682784410188, 4752.0, 4777.546133117348, 4780.4941443445205, 4798.448178459452, 4811.615070794328, 4985.252212168131, 5058.519440653132, 5074.416442109131, 5094.452773613193, 5103.617228707862, 4768.833090841804, 4805.927911081337, 4816.0, 4840.2575072973705, 5079.263506791494, 3008.6840881707108, 3025.5764193012997, 3036.2257624306103, 3049.16148059281, 3050.7864449488325, 5856.472917437451, 5880.764769409176, 5900.5543641808035, 5907.61600495975, 5916.881662366729, 5575.386707462176, 5603.93525230205, 5712.200291959129, 5844.620099693507, 5912.645241285537, 5865.648061116347, 5900.616459930091, 5930.28836539618, 5937.970310148508, 5943.732532036069, 5751.884962300647, 5767.971160144172, 5778.451047150514, 5787.305523337226, 5791.507721843522, 5457.290552228185, 5614.747336369955, 5641.153826925994, 5655.971720141373, 5691.2032315475035, 5876.471117599436, 5880.353161152184, 5898.2573103507075, 5914.290285165807, 5953.434423729739, 4022.0091054928, 4224.38746381779, 4236.195122926634, 4242.17277630859, 4266.5946735060115, 5687.744051517609, 5702.429757024264, 5783.508401785895, 5794.1308803679785, 5794.681292528951, 5630.943690563206, 5633.6619802811965, 5670.291213598301, 5676.68778217202, 5696.943030569641, 5375.946240537544, 5642.435756424489, 5650.429054780147, 5657.462541058758, 5667.914981275367, 5573.0, 5573.972130139324, 5599.216109744558, 5610.382857885547, 5611.410801865909, 5663.150527420919, 5683.715814209356, 5702.914456283242, 5715.599908006399, 5751.4536119068625, 5305.814296499604, 5534.557235421076, 5563.304586926634, 5599.188117722826, 5615.5507559395965], "value": 4229.906776834509, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.4906440959124, 754.253289243649, 776.7106304799174, 821.6877586517122, 842.6418772021891, 14974.700505989887, 15969.520914372559, 15984.84015159848, 15987.840121598765, 16017.919910400446, 14224.217668028254, 14567.417303307882, 15680.843191568109, 15682.84317156828, 15683.0, 671.4997326991374, 777.1606664802, 806.637013343996, 814.9103598604179, 817.5176645778989, 809.0695699945081, 821.7493664432345, 822.5722624235394, 822.6380392627254, 823.3331001888489, 853.8463076646201, 853.9786505337354, 857.0743596915347, 857.2970164465141, 857.8370109679172, 697.1599222936375, 826.68999125328, 843.9282660973763, 851.8381507513584, 852.9445586036887, 624.3444383397415, 624.3943374926314, 624.6252248650818, 624.6470744029609, 624.7313655128293, 14801.851981480155, 14819.110853348833, 14841.628959275997, 14848.0, 14851.2574371281, 14370.20963846988, 14563.0, 14646.41414343425, 14859.777103343458, 14885.404583816635, 12245.816312755316, 12472.251664900135, 12495.312757798318, 12733.936330318382, 13318.600441986757, 4557.134144512532, 4588.4723256825555, 4598.770061496912, 4628.120657075145, 4670.392848929618, 76951.0, 77060.61469692616, 77102.61448692776, 77310.22689773087, 77335.0, 11422.485988130555, 11528.563565772254, 11682.182247242612, 11768.235064720766, 12064.517419303305, 21997.450063748533, 22002.119915203533, 22008.229711960324, 22008.88995555012, 22035.00842462093, 8322.0, 8533.957330213434, 8852.513111778786, 8889.955550222208, 8998.685046023358, 4757.9286310705365, 4939.756043027863, 5037.4458809530925, 5063.215201643678, 5136.43499215086, 3567.3578755823683, 3704.0, 3704.7962362069807, 3722.8883133506038, 3723.422869455239, 624.6252248650864, 631.8262477818545, 636.4081404294051, 642.3095172689284, 651.4560342114388, 657.6810247030187, 668.7358493395081, 675.0717763075771, 691.094665987558, 705.9294070592899, 9338.299627527827, 9355.719328420158, 9792.412455252565, 9986.700398988041, 10078.949605252074, 560.5487582496048, 583.6235628019904, 592.1798309341593, 657.447852882413, 658.3449467779494, 4368.847090351823, 4581.2440947243995, 4587.311903214544, 4588.151192029485, 4666.1916354927835, 111989.0, 117638.41180794213, 118829.4058529719, 119533.40233298951, 119967.0, 101608.49195754122, 102557.0, 103180.48409758053, 103806.48096759467, 105182.0, 88681.55659221663, 88770.55614721886, 89558.0, 90939.0, 92567.5371623151, 8593.570321484025, 8758.255548278468, 8865.778355541162, 8967.551622418723, 9161.496117713323, 53635.0, 53863.922721546136, 54411.18383224334, 54771.17843232275, 56026.71986640041, 68983.0, 70834.64582677053, 78909.21090789018, 80047.59976200081, 80266.0, 11085.778284434105, 11203.943980280046, 11498.25261358009, 11608.361540115375, 11927.82108268394, 13263.469461221828, 13415.932920335335, 13530.729385412433, 14119.717605647624, 14179.503717369842, 12785.232886026868, 12831.422585983466, 12936.417861196456, 13202.405891734703, 13282.203067815963, 11767.969485312262, 11906.642800715992, 12002.479479309093, 12446.190997585129, 12480.5007799687, 12258.570950016707, 12533.997280217378, 12669.683257918627, 12823.487060517475, 12841.807372889602, 10049.748756281151, 10157.593696252066, 10161.898381016392, 10420.947895260779, 10469.26715129964, 10221.897781022095, 10222.437765922648, 10225.130863876653, 10267.7433064174, 10285.897141028494], "value": 7506.196653294748, "unit": "score"}], "name": "dromaeo_css", "value": 7358.220147246785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 111.0, 113.0, 110.0, 110.0, 112.0, 110.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 120.0, 169.0, 116.0, 118.0, 145.0, 122.0, 164.0, 120.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 159.0, 161.0, 162.0, 161.0, 162.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 110.0, 74.0, 75.0, 75.0, 76.0, 97.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 84.0, 84.0, 83.0, 120.0, 82.0, 82.0, 124.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 53.0, 53.0, 55.0, 54.0, 54.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 64.0, 60.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 74.0, 75.0, 83.0, 77.0, 75.0, 74.0, 74.0, 80.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 121.0, 117.0, 119.0, 119.0, 118.0, 119.0, 155.0, 132.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 154.0, 158.0, 152.0, 156.0, 156.0, 155.0, 158.0, 154.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 64.0, 64.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1467.7, "alertThreshold": 2.0}]} 17:32:45 INFO - Return code: 0 17:32:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:32:45 INFO - # TBPL SUCCESS # 17:32:45 INFO - Running post-action listener: _resource_record_post_action 17:32:45 INFO - ##### 17:32:45 INFO - ##### Finished run-tests step (success) 17:32:45 INFO - ##### 17:32:45 INFO - Running post-run listener: _resource_record_post_run 17:32:45 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 553082880; Read time: 272; Write time: 548656 17:32:45 INFO - TinderboxPrint: CPU usage
13.0% 17:32:45 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 272 17:32:45 INFO - TinderboxPrint: I/O write bytes / time
553,082,880 / 548,656 17:32:45 INFO - TinderboxPrint: CPU idle
8,279.8 (87.0%) 17:32:45 INFO - TinderboxPrint: CPU user
1,191.0 (12.5%) 17:32:45 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256290816; Read time: 0; Write time: 345816 17:32:45 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296439808; Read time: 264; Write time: 202816 17:32:46 INFO - Running post-run listener: _upload_blobber_files 17:32:46 INFO - Blob upload gear active. 17:32:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:46 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 17:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:32:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:50 INFO - (blobuploader) - INFO - Done attempting. 17:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:51 INFO - (blobuploader) - INFO - Done attempting. 17:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:52 INFO - (blobuploader) - INFO - Done attempting. 17:32:52 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:52 INFO - Return code: 0 17:32:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e0e6e78fb5f3743782d512394e545196a36e8bfa2a40fa0c73e6522ebabc2cbe877e02242dcef2a35179de79f78e3f12d00ed3a289e294a4e139fca7c7d8fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ccef7574edaacc30315517e9424b68430b0d2351ebedff3a9d7766d9c00ff0ca5ec31bcfd265177adf32abe44bdc9ecc308005de9bba020a6e276e015ef90ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a50b6faf3eab2e5d7b12071361b790c9a0510622940c33921cff18f35094c177168404b9915064a5f5fe05b832e78b2d0dc06d1eeede26634839787f534f92f"} 17:32:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:52 INFO - Contents: 17:32:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e0e6e78fb5f3743782d512394e545196a36e8bfa2a40fa0c73e6522ebabc2cbe877e02242dcef2a35179de79f78e3f12d00ed3a289e294a4e139fca7c7d8fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ccef7574edaacc30315517e9424b68430b0d2351ebedff3a9d7766d9c00ff0ca5ec31bcfd265177adf32abe44bdc9ecc308005de9bba020a6e276e015ef90ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a50b6faf3eab2e5d7b12071361b790c9a0510622940c33921cff18f35094c177168404b9915064a5f5fe05b832e78b2d0dc06d1eeede26634839787f534f92f"} 17:32:52 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:52 INFO - Copying logs to upload dir... 17:32:52 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.397392 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-30 17:32:52.541912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 17:32:52.546143) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e0e6e78fb5f3743782d512394e545196a36e8bfa2a40fa0c73e6522ebabc2cbe877e02242dcef2a35179de79f78e3f12d00ed3a289e294a4e139fca7c7d8fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ccef7574edaacc30315517e9424b68430b0d2351ebedff3a9d7766d9c00ff0ca5ec31bcfd265177adf32abe44bdc9ecc308005de9bba020a6e276e015ef90ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a50b6faf3eab2e5d7b12071361b790c9a0510622940c33921cff18f35094c177168404b9915064a5f5fe05b832e78b2d0dc06d1eeede26634839787f534f92f"} build_url:https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/DDvCCBdySJ6PS2UcGBVfsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e0e6e78fb5f3743782d512394e545196a36e8bfa2a40fa0c73e6522ebabc2cbe877e02242dcef2a35179de79f78e3f12d00ed3a289e294a4e139fca7c7d8fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ccef7574edaacc30315517e9424b68430b0d2351ebedff3a9d7766d9c00ff0ca5ec31bcfd265177adf32abe44bdc9ecc308005de9bba020a6e276e015ef90ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a50b6faf3eab2e5d7b12071361b790c9a0510622940c33921cff18f35094c177168404b9915064a5f5fe05b832e78b2d0dc06d1eeede26634839787f534f92f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 17:32:52.574131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:32:52.574687) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467331930.525220-479013386 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 17:32:52.658495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 17:32:52.658817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 17:32:52.659116) ========= ========= Total master_lag: 0.18 =========