builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1468379280.98 results: success (0) buildid: 20160712173003 builduid: 199aace65d89456ab247c0f922ecf6d6 revision: 0d7a788f1c40adf5038505e25e600d8551dbda06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:00.976179) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:00.978713) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:00.979017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:01.005201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:01.005493) ========= 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=ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 20:08:01-- 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% 69.6M=0s 2016-07-12 20:08:01 (69.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:01.153367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:01.153738) ========= 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=ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020569 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:01.213705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 20:08:01.214099) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d7a788f1c40adf5038505e25e600d8551dbda06 --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 0d7a788f1c40adf5038505e25e600d8551dbda06 --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=ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 20:08:01,432 truncating revision to first 12 chars 2016-07-12 20:08:01,432 Setting DEBUG logging. 2016-07-12 20:08:01,432 attempt 1/10 2016-07-12 20:08:01,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d7a788f1c40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 20:08:03,074 unpacking tar archive at: fx-team-0d7a788f1c40/testing/mozharness/ program finished with exit code 0 elapsedTime=2.327432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-12 20:08:03.560632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:03.561002) ========= script_repo_revision: 0d7a788f1c40adf5038505e25e600d8551dbda06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:03.561464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:03.561759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 20:08:03.571383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-12 20:08:03.571893) ========= /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=ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:08:03 INFO - MultiFileLogger online at 20160712 20:08:03 in /builds/slave/test 20:08:03 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 20:08:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:03 INFO - {'append_to_log': False, 20:08:03 INFO - 'base_work_dir': '/builds/slave/test', 20:08:03 INFO - 'blob_upload_branch': 'Fx-Team', 20:08:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:03 INFO - 'branch': 'Fx-Team', 20:08:03 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:03 INFO - 'config_files': ('talos/linux_config.py',), 20:08:03 INFO - 'default_actions': ('clobber', 20:08:03 INFO - 'read-buildbot-config', 20:08:03 INFO - 'download-and-extract', 20:08:03 INFO - 'populate-webroot', 20:08:03 INFO - 'create-virtualenv', 20:08:03 INFO - 'install', 20:08:03 INFO - 'run-tests'), 20:08:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:03 INFO - 'download_minidump_stackwalk': True, 20:08:03 INFO - 'download_symbols': 'ondemand', 20:08:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:03 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:03 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:03 INFO - 'installer_path': 'installer.exe', 20:08:03 INFO - 'log_level': 'info', 20:08:03 INFO - 'log_name': 'talos', 20:08:03 INFO - 'log_to_console': True, 20:08:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:08:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:08:03 INFO - 'opt_config_files': (), 20:08:03 INFO - 'pip_index': False, 20:08:03 INFO - 'sps_profile': False, 20:08:03 INFO - 'sps_profile_interval': 0, 20:08:03 INFO - 'suite': 'dromaeojs', 20:08:03 INFO - 'system_bits': '32', 20:08:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:03 INFO - 'title': 'talos-linux64-ix-035', 20:08:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:03 INFO - 'use_talos_json': True, 20:08:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:03 INFO - 'work_dir': 'build'} 20:08:03 INFO - ##### 20:08:03 INFO - ##### Running clobber step. 20:08:03 INFO - ##### 20:08:03 INFO - Running pre-action listener: _resource_record_pre_action 20:08:03 INFO - Running main action method: clobber 20:08:03 INFO - rmtree: /builds/slave/test/build 20:08:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:04 INFO - Running post-action listener: _resource_record_post_action 20:08:04 INFO - ##### 20:08:04 INFO - ##### Finished clobber step (success) 20:08:04 INFO - ##### 20:08:04 INFO - ##### 20:08:04 INFO - ##### Running read-buildbot-config step. 20:08:04 INFO - ##### 20:08:04 INFO - Running pre-action listener: _resource_record_pre_action 20:08:04 INFO - Running main action method: read_buildbot_config 20:08:04 INFO - Using buildbot properties: 20:08:04 INFO - { 20:08:04 INFO - "project": "", 20:08:04 INFO - "product": "firefox", 20:08:04 INFO - "script_repo_revision": "production", 20:08:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:08:04 INFO - "repository": "", 20:08:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:08:04 INFO - "buildid": "20160712173003", 20:08:04 INFO - "pgo_build": "True", 20:08:04 INFO - "basedir": "/builds/slave/test", 20:08:04 INFO - "buildnumber": 276, 20:08:04 INFO - "slavename": "talos-linux64-ix-035", 20:08:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:08:04 INFO - "platform": "ubuntu64_hw", 20:08:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:08:04 INFO - "branch": "fx-team", 20:08:04 INFO - "repo_path": "integration/fx-team", 20:08:04 INFO - "revision": "0d7a788f1c40adf5038505e25e600d8551dbda06", 20:08:04 INFO - "stage_platform": "linux64-pgo", 20:08:04 INFO - "builduid": "199aace65d89456ab247c0f922ecf6d6", 20:08:04 INFO - "slavebuilddir": "test" 20:08:04 INFO - } 20:08:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:08:04 INFO - Running post-action listener: _resource_record_post_action 20:08:04 INFO - ##### 20:08:04 INFO - ##### Finished read-buildbot-config step (success) 20:08:04 INFO - ##### 20:08:04 INFO - ##### 20:08:04 INFO - ##### Running download-and-extract step. 20:08:04 INFO - ##### 20:08:04 INFO - Running pre-action listener: _resource_record_pre_action 20:08:04 INFO - Running main action method: download_and_extract 20:08:04 INFO - mkdir: /builds/slave/test/build/tests 20:08:04 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')]} 20:08:04 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:06 INFO - Downloaded 1361 bytes. 20:08:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:08:06 INFO - Using the following test package requirements: 20:08:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:08:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:08:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'jsshell-linux-x86_64.zip'], 20:08:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:08:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:08:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:08:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:08:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:08:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:08:06 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')]} 20:08:06 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:08:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:08:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:08:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:07 INFO - Downloaded 24320640 bytes. 20:08:07 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'] 20:08:07 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 20:08:08 INFO - Return code: 0 20:08:08 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 20:08:08 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')]} 20:08:08 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:12 INFO - Downloaded 24320640 bytes. 20:08:12 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'] 20:08:12 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 20:08:13 INFO - Return code: 0 20:08: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')]} 20:08:13 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:14 INFO - Downloaded 14403317 bytes. 20:08:14 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'] 20:08:14 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 20:08:14 INFO - Return code: 0 20:08:14 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')]} 20:08:14 INFO - https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RSGi3coKSlGGB_WMpCsSxA/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 20:08:16 INFO - Downloaded 60775780 bytes. 20:08:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:08:16 INFO - mkdir: /builds/slave/test/properties 20:08:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:16 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:16 INFO - Contents: 20:08:16 INFO - build_url:https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:08:16 INFO - Running post-action listener: _resource_record_post_action 20:08:16 INFO - Running post-action listener: set_extra_try_arguments 20:08:16 INFO - ##### 20:08:16 INFO - ##### Finished download-and-extract step (success) 20:08:16 INFO - ##### 20:08:16 INFO - ##### 20:08:16 INFO - ##### Running populate-webroot step. 20:08:16 INFO - ##### 20:08:16 INFO - Running pre-action listener: _resource_record_pre_action 20:08:16 INFO - Running main action method: populate_webroot 20:08:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:16 INFO - '--tppagecycles', 20:08:16 INFO - '7'], 20:08:16 INFO - 'tests': ['tsvgm']}}, 20:08:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['damp', 'tps']}, 20:08:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'tests': ['damp', 'tps']}, 20:08:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['dromaeo_dom']}, 20:08:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['basic_compositor_video']}, 20:08:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:08:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['a11yr', 20:08:16 INFO - 'ts_paint', 20:08:16 INFO - 'tpaint', 20:08:16 INFO - 'sessionrestore', 20:08:16 INFO - 'sessionrestore_no_auto_restore', 20:08:16 INFO - 'tabpaint']}, 20:08:16 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:16 INFO - 'ts_paint', 20:08:16 INFO - 'tpaint', 20:08:16 INFO - 'sessionrestore', 20:08:16 INFO - 'sessionrestore_no_auto_restore', 20:08:16 INFO - 'tabpaint']}, 20:08:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:16 INFO - 'ts_paint', 20:08:16 INFO - 'tpaint', 20:08:16 INFO - 'sessionrestore', 20:08:16 INFO - 'sessionrestore_no_auto_restore', 20:08:16 INFO - 'tabpaint']}, 20:08:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:16 INFO - 'ts_paint', 20:08:16 INFO - 'tpaint', 20:08:16 INFO - 'sessionrestore', 20:08:16 INFO - 'sessionrestore_no_auto_restore', 20:08:16 INFO - 'tabpaint']}, 20:08:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['a11yr', 20:08:16 INFO - 'ts_paint', 20:08:16 INFO - 'tpaint', 20:08:16 INFO - 'sessionrestore', 20:08:16 INFO - 'sessionrestore_no_auto_restore', 20:08:16 INFO - 'tabpaint']}, 20:08:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['a11yr', 20:08:16 INFO - 'ts_paint', 20:08:16 INFO - 'tpaint', 20:08:16 INFO - 'sessionrestore', 20:08:16 INFO - 'sessionrestore_no_auto_restore', 20:08:16 INFO - 'tabpaint']}, 20:08:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['tsvgx', 20:08:16 INFO - 'tsvgr_opacity', 20:08:16 INFO - 'tart', 20:08:16 INFO - 'tscrollx', 20:08:16 INFO - 'cart']}, 20:08:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:16 INFO - 'tsvgr_opacity', 20:08:16 INFO - 'tart', 20:08:16 INFO - 'tscrollx', 20:08:16 INFO - 'cart']}, 20:08:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'talos_options': ['--disable-e10s'], 20:08:16 INFO - 'tests': ['tp5o']}, 20:08:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'tests': ['tp5o']}, 20:08:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'talos_options': ['--disable-e10s', 20:08:16 INFO - '--xperf_path', 20:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:16 INFO - 'tests': ['tp5n']}, 20:08:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:16 INFO - 'talos_options': ['--xperf_path', 20:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:16 INFO - 'tests': ['tp5n']}}, 20:08:16 INFO - 'talos.zip': {'path': '', 20:08:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:16 INFO - Running post-action listener: _resource_record_post_action 20:08:16 INFO - ##### 20:08:16 INFO - ##### Finished populate-webroot step (success) 20:08:16 INFO - ##### 20:08:16 INFO - ##### 20:08:16 INFO - ##### Running create-virtualenv step. 20:08:16 INFO - ##### 20:08:16 INFO - Running pre-action listener: _resource_record_pre_action 20:08:16 INFO - Running main action method: create_virtualenv 20:08:16 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:16 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 20:08:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:16 INFO - Using real prefix '/usr' 20:08:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:17 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:19 INFO - Installing pip.................done. 20:08:19 INFO - Return code: 0 20:08:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:19 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:19 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 20:08:19 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 20:08:19 INFO - Using env: {'DISPLAY': ':0', 20:08:19 INFO - 'HOME': '/home/cltbld', 20:08:19 INFO - 'LANG': 'en_US.UTF-8', 20:08:19 INFO - 'LANGUAGE': 'en_US:en', 20:08:19 INFO - 'LOGNAME': 'cltbld', 20:08:19 INFO - 'MAIL': '/var/mail/cltbld', 20:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:19 INFO - 'MOZ_NO_REMOTE': '1', 20:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:19 INFO - 'NO_EM_RESTART': '1', 20:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:19 INFO - 'PWD': '/builds/slave/test', 20:08:19 INFO - 'SHELL': '/bin/bash', 20:08:19 INFO - 'SHLVL': '1', 20:08:19 INFO - 'TERM': 'linux', 20:08:19 INFO - 'TMOUT': '86400', 20:08:19 INFO - 'USER': 'cltbld', 20:08:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:19 INFO - '_': '/tools/buildbot/bin/python'} 20:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:19 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 20:08:19 INFO - Cleaning up... 20:08:19 INFO - Return code: 0 20:08:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:19 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:19 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 20:08:19 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 20:08:19 INFO - Using env: {'DISPLAY': ':0', 20:08:19 INFO - 'HOME': '/home/cltbld', 20:08:19 INFO - 'LANG': 'en_US.UTF-8', 20:08:19 INFO - 'LANGUAGE': 'en_US:en', 20:08:19 INFO - 'LOGNAME': 'cltbld', 20:08:19 INFO - 'MAIL': '/var/mail/cltbld', 20:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:19 INFO - 'MOZ_NO_REMOTE': '1', 20:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:19 INFO - 'NO_EM_RESTART': '1', 20:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:19 INFO - 'PWD': '/builds/slave/test', 20:08:19 INFO - 'SHELL': '/bin/bash', 20:08:19 INFO - 'SHLVL': '1', 20:08:19 INFO - 'TERM': 'linux', 20:08:19 INFO - 'TMOUT': '86400', 20:08:19 INFO - 'USER': 'cltbld', 20:08:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:19 INFO - '_': '/tools/buildbot/bin/python'} 20:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:19 INFO - Downloading/unpacking psutil>=3.1.1 20:08:19 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 20:08:19 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 20:08:19 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 20:08:19 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 20:08:19 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 20:08:19 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 20:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:21 INFO - Installing collected packages: psutil 20:08:21 INFO - Running setup.py install for psutil 20:08:21 INFO - building 'psutil._psutil_linux' extension 20:08:21 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 20:08:22 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 20:08:22 INFO - building 'psutil._psutil_posix' extension 20:08:22 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 20:08:22 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 20:08:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:22 INFO - Successfully installed psutil 20:08:22 INFO - Cleaning up... 20:08:22 INFO - Return code: 0 20:08:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:22 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:22 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 20:08:22 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 20:08:22 INFO - Using env: {'DISPLAY': ':0', 20:08:22 INFO - 'HOME': '/home/cltbld', 20:08:22 INFO - 'LANG': 'en_US.UTF-8', 20:08:22 INFO - 'LANGUAGE': 'en_US:en', 20:08:22 INFO - 'LOGNAME': 'cltbld', 20:08:22 INFO - 'MAIL': '/var/mail/cltbld', 20:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:22 INFO - 'MOZ_NO_REMOTE': '1', 20:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:22 INFO - 'NO_EM_RESTART': '1', 20:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:22 INFO - 'PWD': '/builds/slave/test', 20:08:22 INFO - 'SHELL': '/bin/bash', 20:08:22 INFO - 'SHLVL': '1', 20:08:22 INFO - 'TERM': 'linux', 20:08:22 INFO - 'TMOUT': '86400', 20:08:22 INFO - 'USER': 'cltbld', 20:08:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:22 INFO - '_': '/tools/buildbot/bin/python'} 20:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:08:22 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 20:08:22 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 20:08:22 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 20:08:22 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 20:08:22 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 20:08:22 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 20:08:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:08:24 INFO - Installing collected packages: mozsystemmonitor 20:08:24 INFO - Running setup.py install for mozsystemmonitor 20:08:24 INFO - Successfully installed mozsystemmonitor 20:08:24 INFO - Cleaning up... 20:08:24 INFO - Return code: 0 20:08:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:24 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:24 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 20:08:24 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 20:08:24 INFO - Using env: {'DISPLAY': ':0', 20:08:24 INFO - 'HOME': '/home/cltbld', 20:08:24 INFO - 'LANG': 'en_US.UTF-8', 20:08:24 INFO - 'LANGUAGE': 'en_US:en', 20:08:24 INFO - 'LOGNAME': 'cltbld', 20:08:24 INFO - 'MAIL': '/var/mail/cltbld', 20:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:24 INFO - 'MOZ_NO_REMOTE': '1', 20:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:24 INFO - 'NO_EM_RESTART': '1', 20:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:24 INFO - 'PWD': '/builds/slave/test', 20:08:24 INFO - 'SHELL': '/bin/bash', 20:08:24 INFO - 'SHLVL': '1', 20:08:24 INFO - 'TERM': 'linux', 20:08:24 INFO - 'TMOUT': '86400', 20:08:24 INFO - 'USER': 'cltbld', 20:08:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:24 INFO - '_': '/tools/buildbot/bin/python'} 20:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:08:24 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 20:08:24 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 20:08:24 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 20:08:24 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 20:08:24 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 20:08:24 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 20:08:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:08:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:08:26 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 20:08:26 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 20:08:26 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 20:08:26 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 20:08:26 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 20:08:26 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 20:08:27 INFO - Downloading functools32-3.2.3-2.tar.gz 20:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:08:27 INFO - warning: no files found matching '*.txt' 20:08:27 INFO - no previously-included directories found matching 'build' 20:08:27 INFO - no previously-included directories found matching 'dist' 20:08:27 INFO - no previously-included directories found matching '.git*' 20:08:27 INFO - Installing collected packages: jsonschema, functools32 20:08:27 INFO - Running setup.py install for functools32 20:08:27 INFO - warning: no files found matching '*.txt' 20:08:27 INFO - no previously-included directories found matching 'build' 20:08:27 INFO - no previously-included directories found matching 'dist' 20:08:27 INFO - no previously-included directories found matching '.git*' 20:08:27 INFO - Successfully installed jsonschema functools32 20:08:27 INFO - Cleaning up... 20:08:27 INFO - Return code: 0 20:08:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:27 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 20:08:27 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 20:08:27 INFO - Using env: {'DISPLAY': ':0', 20:08:27 INFO - 'HOME': '/home/cltbld', 20:08:27 INFO - 'LANG': 'en_US.UTF-8', 20:08:27 INFO - 'LANGUAGE': 'en_US:en', 20:08:27 INFO - 'LOGNAME': 'cltbld', 20:08:27 INFO - 'MAIL': '/var/mail/cltbld', 20:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:27 INFO - 'MOZ_NO_REMOTE': '1', 20:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:27 INFO - 'NO_EM_RESTART': '1', 20:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:27 INFO - 'PWD': '/builds/slave/test', 20:08:27 INFO - 'SHELL': '/bin/bash', 20:08:27 INFO - 'SHLVL': '1', 20:08:27 INFO - 'TERM': 'linux', 20:08:27 INFO - 'TMOUT': '86400', 20:08:27 INFO - 'USER': 'cltbld', 20:08:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:27 INFO - '_': '/tools/buildbot/bin/python'} 20:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:27 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:08:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:30 INFO - Downloading docopt-0.6.1.tar.gz 20:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:30 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:30 INFO - Running setup.py install for blobuploader 20:08:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:08:30 INFO - Running setup.py install for requests 20:08:30 INFO - Running setup.py install for docopt 20:08:30 INFO - Successfully installed blobuploader requests docopt 20:08:30 INFO - Cleaning up... 20:08:30 INFO - Return code: 0 20:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:30 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:30 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 20:08:30 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 20:08:30 INFO - Using env: {'DISPLAY': ':0', 20:08:30 INFO - 'HOME': '/home/cltbld', 20:08:30 INFO - 'LANG': 'en_US.UTF-8', 20:08:30 INFO - 'LANGUAGE': 'en_US:en', 20:08:30 INFO - 'LOGNAME': 'cltbld', 20:08:30 INFO - 'MAIL': '/var/mail/cltbld', 20:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:30 INFO - 'MOZ_NO_REMOTE': '1', 20:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:30 INFO - 'NO_EM_RESTART': '1', 20:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:30 INFO - 'PWD': '/builds/slave/test', 20:08:30 INFO - 'SHELL': '/bin/bash', 20:08:30 INFO - 'SHLVL': '1', 20:08:30 INFO - 'TERM': 'linux', 20:08:30 INFO - 'TMOUT': '86400', 20:08:30 INFO - 'USER': 'cltbld', 20:08:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:30 INFO - '_': '/tools/buildbot/bin/python'} 20:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:31 INFO - Running setup.py (path:/tmp/pip-VarHqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:31 INFO - Running setup.py (path:/tmp/pip-GUzhGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:31 INFO - Running setup.py (path:/tmp/pip-oyfGwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:31 INFO - Running setup.py (path:/tmp/pip-Xn7R5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:31 INFO - Running setup.py (path:/tmp/pip-8QK00K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:31 INFO - Running setup.py (path:/tmp/pip-zcK3A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:31 INFO - Running setup.py (path:/tmp/pip-y1HwAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:31 INFO - Running setup.py (path:/tmp/pip-Og_irC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:31 INFO - Running setup.py (path:/tmp/pip-gmYyvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:31 INFO - Running setup.py (path:/tmp/pip-cM3q0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:31 INFO - Running setup.py (path:/tmp/pip-b0HYf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:31 INFO - Running setup.py (path:/tmp/pip-qNqHaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:31 INFO - Running setup.py (path:/tmp/pip-seTk2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:31 INFO - Running setup.py (path:/tmp/pip-Ozj9hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:32 INFO - Running setup.py (path:/tmp/pip-vV08eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:32 INFO - Running setup.py (path:/tmp/pip-mBhNYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:32 INFO - Running setup.py (path:/tmp/pip-1TvGXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:32 INFO - Running setup.py install for manifestparser 20:08:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:32 INFO - Running setup.py install for mozcrash 20:08:32 INFO - Running setup.py install for mozdebug 20:08:32 INFO - Running setup.py install for mozdevice 20:08:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:32 INFO - Running setup.py install for mozfile 20:08:32 INFO - Running setup.py install for mozhttpd 20:08:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:32 INFO - Running setup.py install for mozinfo 20:08:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:32 INFO - Running setup.py install for mozInstall 20:08:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Running setup.py install for mozleak 20:08:33 INFO - Running setup.py install for mozlog 20:08:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Running setup.py install for moznetwork 20:08:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Running setup.py install for mozprocess 20:08:33 INFO - Running setup.py install for mozprofile 20:08:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Running setup.py install for mozrunner 20:08:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Running setup.py install for mozscreenshot 20:08:33 INFO - Running setup.py install for moztest 20:08:33 INFO - Running setup.py install for mozversion 20:08:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:33 INFO - Cleaning up... 20:08:34 INFO - Return code: 0 20:08:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:34 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 20:08:34 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 20:08:34 INFO - Using env: {'DISPLAY': ':0', 20:08:34 INFO - 'HOME': '/home/cltbld', 20:08:34 INFO - 'LANG': 'en_US.UTF-8', 20:08:34 INFO - 'LANGUAGE': 'en_US:en', 20:08:34 INFO - 'LOGNAME': 'cltbld', 20:08:34 INFO - 'MAIL': '/var/mail/cltbld', 20:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:34 INFO - 'MOZ_NO_REMOTE': '1', 20:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:34 INFO - 'NO_EM_RESTART': '1', 20:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:34 INFO - 'PWD': '/builds/slave/test', 20:08:34 INFO - 'SHELL': '/bin/bash', 20:08:34 INFO - 'SHLVL': '1', 20:08:34 INFO - 'TERM': 'linux', 20:08:34 INFO - 'TMOUT': '86400', 20:08:34 INFO - 'USER': 'cltbld', 20:08:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:34 INFO - '_': '/tools/buildbot/bin/python'} 20:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:34 INFO - Running setup.py (path:/tmp/pip-Xks4lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:34 INFO - Running setup.py (path:/tmp/pip-d9_u4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:34 INFO - Running setup.py (path:/tmp/pip-e3ZQ93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:34 INFO - Running setup.py (path:/tmp/pip-z4vHHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:34 INFO - Running setup.py (path:/tmp/pip-re6lL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:34 INFO - Running setup.py (path:/tmp/pip-sNetq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:34 INFO - Running setup.py (path:/tmp/pip-3GmyWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:34 INFO - Running setup.py (path:/tmp/pip-g1bZ8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:34 INFO - Running setup.py (path:/tmp/pip-f6mSvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:34 INFO - Running setup.py (path:/tmp/pip-tHLMxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:34 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)) 20:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:34 INFO - Running setup.py (path:/tmp/pip-dwHq4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:35 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)) 20:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:35 INFO - Running setup.py (path:/tmp/pip-_2vPfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:35 INFO - Running setup.py (path:/tmp/pip-rBmgtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:35 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)) 20:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:35 INFO - Running setup.py (path:/tmp/pip-9_A5XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:35 INFO - Running setup.py (path:/tmp/pip-E60BNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:35 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)) 20:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:35 INFO - Running setup.py (path:/tmp/pip-ZrykyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:35 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)) 20:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:35 INFO - Running setup.py (path:/tmp/pip-hhAqCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:35 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)) 20:08:35 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)) 20:08:35 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)) 20:08:35 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)) 20:08:35 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)) 20:08:35 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)) 20:08:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:37 INFO - Downloading blessings-1.6.tar.gz 20:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:37 INFO - Installing collected packages: blessings 20:08:37 INFO - Running setup.py install for blessings 20:08:37 INFO - Successfully installed blessings 20:08:37 INFO - Cleaning up... 20:08:37 INFO - Return code: 0 20:08:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:08:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:37 INFO - Reading from file tmpfile_stdout 20:08:37 INFO - Current package versions: 20:08:37 INFO - argparse == 1.2.1 20:08:37 INFO - blessings == 1.6 20:08:37 INFO - blobuploader == 1.2.4 20:08:37 INFO - docopt == 0.6.1 20:08:37 INFO - functools32 == 3.2.3-2 20:08:37 INFO - jsonschema == 2.5.1 20:08:37 INFO - manifestparser == 1.1 20:08:37 INFO - mozInstall == 1.12 20:08:37 INFO - mozcrash == 0.17 20:08:37 INFO - mozdebug == 0.1 20:08:37 INFO - mozdevice == 0.48 20:08:37 INFO - mozfile == 1.2 20:08:37 INFO - mozhttpd == 0.7 20:08:37 INFO - mozinfo == 0.9 20:08:37 INFO - mozleak == 0.1 20:08:37 INFO - mozlog == 3.2 20:08:37 INFO - moznetwork == 0.27 20:08:37 INFO - mozprocess == 0.23 20:08:37 INFO - mozprofile == 0.28 20:08:37 INFO - mozrunner == 6.12 20:08:37 INFO - mozscreenshot == 0.1 20:08:37 INFO - mozsystemmonitor == 0.3 20:08:37 INFO - moztest == 0.7 20:08:37 INFO - mozversion == 1.4 20:08:37 INFO - psutil == 3.1.1 20:08:37 INFO - requests == 1.2.3 20:08:37 INFO - wsgiref == 0.1.2 20:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:37 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 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:37 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 20:08:37 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 20:08:37 INFO - Using env: {'DISPLAY': ':0', 20:08:37 INFO - 'HOME': '/home/cltbld', 20:08:37 INFO - 'LANG': 'en_US.UTF-8', 20:08:37 INFO - 'LANGUAGE': 'en_US:en', 20:08:37 INFO - 'LOGNAME': 'cltbld', 20:08:37 INFO - 'MAIL': '/var/mail/cltbld', 20:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:37 INFO - 'MOZ_NO_REMOTE': '1', 20:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:37 INFO - 'NO_EM_RESTART': '1', 20:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:37 INFO - 'PWD': '/builds/slave/test', 20:08:37 INFO - 'SHELL': '/bin/bash', 20:08:37 INFO - 'SHLVL': '1', 20:08:37 INFO - 'TERM': 'linux', 20:08:37 INFO - 'TMOUT': '86400', 20:08:37 INFO - 'USER': 'cltbld', 20:08:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:37 INFO - '_': '/tools/buildbot/bin/python'} 20:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 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)) 20:08:38 INFO - Cleaning up... 20:08:38 INFO - Return code: 0 20:08:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, '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': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', '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 20:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:08:38 INFO - Using env: {'DISPLAY': ':0', 20:08:38 INFO - 'HOME': '/home/cltbld', 20:08:38 INFO - 'LANG': 'en_US.UTF-8', 20:08:38 INFO - 'LANGUAGE': 'en_US:en', 20:08:38 INFO - 'LOGNAME': 'cltbld', 20:08:38 INFO - 'MAIL': '/var/mail/cltbld', 20:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:38 INFO - 'MOZ_NO_REMOTE': '1', 20:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:38 INFO - 'NO_EM_RESTART': '1', 20:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:38 INFO - 'PWD': '/builds/slave/test', 20:08:38 INFO - 'SHELL': '/bin/bash', 20:08:38 INFO - 'SHLVL': '1', 20:08:38 INFO - 'TERM': 'linux', 20:08:38 INFO - 'TMOUT': '86400', 20:08:38 INFO - 'USER': 'cltbld', 20:08:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:38 INFO - '_': '/tools/buildbot/bin/python'} 20:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:08:38 INFO - Cleaning up... 20:08:38 INFO - Return code: 0 20:08:38 INFO - Running post-action listener: _resource_record_post_action 20:08:38 INFO - Running post-action listener: _start_resource_monitoring 20:08:38 INFO - Starting resource monitoring. 20:08:38 INFO - ##### 20:08:38 INFO - ##### Finished create-virtualenv step (success) 20:08:38 INFO - ##### 20:08:38 INFO - ##### 20:08:38 INFO - ##### Running install step. 20:08:38 INFO - ##### 20:08:38 INFO - Running pre-action listener: _resource_record_pre_action 20:08:38 INFO - Running main action method: install 20:08:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:38 INFO - Reading from file tmpfile_stdout 20:08:38 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:38 INFO - Reading from file tmpfile_stdout 20:08:38 INFO - Output received: 20:08:38 INFO - Usage: mozinstall [options] installer 20:08:38 INFO - Options: 20:08:38 INFO - -h, --help show this help message and exit 20:08:38 INFO - -d DEST, --destination=DEST 20:08:38 INFO - Directory to install application into. [default: 20:08:38 INFO - "/builds/slave/test"] 20:08:38 INFO - --app=APP Application being installed. [default: firefox] 20:08:38 INFO - mkdir: /builds/slave/test/build/application 20:08:38 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'] 20:08:38 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 20:08:55 INFO - Reading from file tmpfile_stdout 20:08:55 INFO - Output received: 20:08:55 INFO - /builds/slave/test/build/application/firefox/firefox 20:08:55 INFO - Running post-action listener: _resource_record_post_action 20:08:55 INFO - ##### 20:08:55 INFO - ##### Finished install step (success) 20:08:55 INFO - ##### 20:08:55 INFO - ##### 20:08:55 INFO - ##### Running run-tests step. 20:08:55 INFO - ##### 20:08:55 INFO - Running pre-action listener: _resource_record_pre_action 20:08:55 INFO - Running main action method: run_tests 20:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:08:55 INFO - Python 2.7.3 20:08:55 INFO - Return code: 0 20:08:55 INFO - grabbing minidump binary from tooltool 20:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:55 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 0x181c3b0>, '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 0x181d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:08:55 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 20:08:55 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 20:08:55 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 20:08:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:08:55 INFO - Return code: 0 20:08:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:08:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:08:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:08:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:08:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:08:55 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/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:08:55 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/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 20:08:55 INFO - Using env: {'DISPLAY': ':0', 20:08:55 INFO - 'HOME': '/home/cltbld', 20:08:55 INFO - 'LANG': 'en_US.UTF-8', 20:08:55 INFO - 'LANGUAGE': 'en_US:en', 20:08:55 INFO - 'LOGNAME': 'cltbld', 20:08:55 INFO - 'MAIL': '/var/mail/cltbld', 20:08:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:08:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:55 INFO - 'MOZ_NO_REMOTE': '1', 20:08:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:55 INFO - 'NO_EM_RESTART': '1', 20:08:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:55 INFO - 'PWD': '/builds/slave/test', 20:08:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:08:55 INFO - 'SHELL': '/bin/bash', 20:08:55 INFO - 'SHLVL': '1', 20:08:55 INFO - 'TERM': 'linux', 20:08:55 INFO - 'TMOUT': '86400', 20:08:55 INFO - 'USER': 'cltbld', 20:08:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195', 20:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:55 INFO - '_': '/tools/buildbot/bin/python'} 20:08:55 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/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:08:56 INFO - mozversion application_buildid: 20160712173003 20:08:56 INFO - mozversion application_changeset: 0d7a788f1c40adf5038505e25e600d8551dbda06 20:08:56 INFO - mozversion application_display_name: Nightly 20:08:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:08:56 INFO - mozversion application_name: Firefox 20:08:56 INFO - mozversion application_remotingname: firefox 20:08:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:08:56 INFO - mozversion application_vendor: Mozilla 20:08:56 INFO - mozversion application_version: 50.0a1 20:08:56 INFO - mozversion platform_buildid: 20160712173003 20:08:56 INFO - mozversion platform_changeset: 0d7a788f1c40adf5038505e25e600d8551dbda06 20:08:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:08:56 INFO - mozversion platform_version: 50.0a1 20:08:56 INFO - using testdate: 1468379336 20:08:56 INFO - actual date: 1468379336 20:08:56 INFO - starting webserver on 'localhost:55212' 20:08:56 INFO - SUITE-START | Running 2 tests 20:08:56 INFO - TEST-START | dromaeo_css 20:08:56 INFO - operating with platform_type : linux_ 20:08:56 INFO - Initialising browser for dromaeo_css test... 20:08:56 INFO - TEST-INFO | started process 820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcG6ss/profile http://localhost:55212/getInfo.html) 20:08:59 INFO - PROCESS | 820 | __metrics Screen width/height:1600/1200 20:08:59 INFO - PROCESS | 820 | colorDepth:24 20:08:59 INFO - PROCESS | 820 | Browser inner width/height: 1024/697 20:08:59 INFO - PROCESS | 820 | __metrics 20:09:00 INFO - PROCESS | 820 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:09:00 INFO - PROCESS | 820 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:01 INFO - TEST-INFO | 820: exit 0 20:09:01 INFO - Browser initialized. 20:09:01 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:01 INFO - TEST-INFO | started process 904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcG6ss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:13 INFO - PROCESS | 904 | RSS: Main: 156934144 20:09:13 INFO - PROCESS | 904 | 20:10:04 INFO - PROCESS | 904 | 1468379404806 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] 20:12:12 INFO - PROCESS | 904 | Cycle 1(1): loaded http://localhost:55212/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55212/tests/dromaeo/cssquery-ext.html) 20:12:13 INFO - PROCESS | 904 | RSS: Main: 259567616 20:12:13 INFO - PROCESS | 904 | 20:15:15 INFO - PROCESS | 904 | Cycle 1(1): loaded http://localhost:55212/tests/dromaeo/cssquery-ext.html (next: http://localhost:55212/tests/dromaeo/cssquery-jquery.html) 20:15:16 INFO - PROCESS | 904 | RSS: Main: 241545216 20:15:16 INFO - PROCESS | 904 | 20:18:18 INFO - PROCESS | 904 | Cycle 1(1): loaded http://localhost:55212/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55212/tests/dromaeo/cssquery-mootools.html) 20:18:18 INFO - PROCESS | 904 | RSS: Main: 252145664 20:18:18 INFO - PROCESS | 904 | 20:21:20 INFO - PROCESS | 904 | Cycle 1(1): loaded http://localhost:55212/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55212/tests/dromaeo/cssquery-prototype.html) 20:21:21 INFO - PROCESS | 904 | RSS: Main: 236109824 20:21:21 INFO - PROCESS | 904 | 20:24:24 INFO - PROCESS | 904 | Cycle 1(1): loaded http://localhost:55212/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55212/tests/dromaeo/cssquery-yui.html) 20:24:24 INFO - PROCESS | 904 | RSS: Main: 226570240 20:24:24 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | Cycle 1(1): loaded http://localhost:55212/tests/dromaeo/cssquery-yui.html (next: http://localhost:55212/tests/dromaeo/cssquery-dojo.html) 20:27:27 INFO - PROCESS | 904 | RSS: Main: 325222400 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | __start_tp_report 20:27:27 INFO - PROCESS | 904 | _x_x_mozilla_page_load 20:27:27 INFO - PROCESS | 904 | _x_x_mozilla_page_load_details 20:27:27 INFO - PROCESS | 904 | |i|pagename|runs| 20:27:27 INFO - PROCESS | 904 | |0;dojo.html;3080.3993221321825;3083.5528848316994;3114.8442577871106;3118.1892707895954;3131.7181453669164;5252.868678283045;5336.439673834249;5342.839714808552;5389.24550562921;5413.160960051194;5319.148936170213;5336.279602253695;5434.565234781218;5476.04169270377;5504.146857237135;4819.204831202856;4889.29105279736;4897.142999975008;4909.263610458442;5051.141305977974;4944.604431645478;4954.777035033432;4999.050180465718;5002.449730529657;5013.3482647255805;4812.133815913135;4878.195097808857;4883.9511604883855;4884.3161957326;4929.728864912447;4874.610031197496;4885.65800393969;4956.925646115311;4958.132326842824;5008.9499105008845;4798.640101992364;4923.113839508887;4931.235658472942;4935.728534930578;4948.653594248404;5334.413214546396;5334.839954801362;5379.220013098118;5482.150266708666;5482.698451585161;5795.652260864319;5811.4479124483105;5825.242718446617;5827.417258274181;5827.766889324422;5675.886482270332;5704.543636509111;5841;5847.8538036549;5856.209411729447;5336.599755018389;5429.185622156669;5433.538149257279;5435.42927992559;5438.102713052381;5925.940740592625;5949.137375080589;5968.22413086296;5969.970150149222;5971.611845230046;5501.229827824108;5618.971905140448;5656.8868622627315;5682.488576028178;5695.373508914016;5813.563982701315;5830.591858569859;5832.154337621021;5835.387284335168;5837.795677151279;5723.255976723;5767.913481297784;5778.3643799182055;5779.508741756998;5811.738471768781;5584.636998595079;5700.828975130753;5764.048931926269;5766.740496677659;5775.653460792366;4415.977920110379;4416.31547110192;4422.889427764268;4430.5126436092005;4462.732236065846;3953.347697629859;3963.5243770747693;3976.224636195914;3985.9202815943518;4010.2581022510344;5321.308229930084;5369.597280203922;5386.892262154814;5393.892122157614;5442.673439593637;5809.157672137601;5818.836232753466;5819.970900145472;5832.125181222766;5868.295804503487;5295.417504074549;5459.235707001023;5460.208269800936;5468.535174510212;5470.152126420411;4911.484294149134;4924.359833221658;4967.031428871335;4979.925301120486;4981.153203955337;5960.523158147338;5962.761489540369;5966.134910437962;5966.910496342558;5967.433093856077;5604.019296622993;5740.856478588069;5790.1893734877995;5800.709964501673;5802.4197580241635;5937.762489500372;6005.39946005396;6024.096385542204;6029.457348838626;6077.392260773887;5688;5724.513416359656;5727.627704199213;5740.6268592541355;5742.16738572913;5609.074502707008;5764.682942438206;5778.682172480554;5844.883102338014;5857.560682948711;5725.713714314351;5729.885402292014;5731.885362292647;5735.655860648374;5773.451522105393;5626.606137570331;5672.14917762339;5676.7161641918565;5677.77288908439;5699.572532060195;5488.259085023471;5597.944020559742;5638.887222255614;5656.60403771732;5677.602567820378;5746.597738158456;5747.137929310469;5750.654960702372;5807.564432667651;5809.157672137601;5569.025420551468;5599.972000139973;5611.214429979725;5615.831525054255;5617.382087970238 20:27:27 INFO - PROCESS | 904 | |1;ext.html;586.2173997713053;624.4411251929523;626.3454689849107;635.9554831161814;638.9648569328687;43840.3423948641;44795.55204447955;44799.77600112003;44838.77580612097;48341.7582912085;44746.32880506795;45259.773701131446;45311.09377812442;45362.54637453624;45365.773171134184;9131.223845973083;9280.72157835266;9282.350235483518;9287;9289.814203715921;9101.499417532033;9121.270298376114;9184.632614695403;9193.35646504745;9194.678186263482;9248.075192480732;9272.629094836198;9277.675281365153;9281.628734850598;9285.489298088602;9167.816643667122;9175.816483670322;9224.07759224079;9229.67696130639;9231.58457869394;9000.639974401016;9067.410618309788;9073.183413492818;9075.410098343587;9078.54607269634;42827.35758963618;42960.14079718388;43072.3539146913;43239.56760432387;43274;3507.4914137450182;3582.6954708849516;3627.8004709740953;3644.963550364489;3683.1712864605515;32461;32653.673463265302;32907.6709232907;33207.66792332094;33355;4500.054988452429;4512.571305725951;4516.887077823048;4535.546445355438;4592.74739889306;380452;384686;384904.9999999972;384952;385766;53502.7324863381;57960;61426;61908.69045654743;61941.380586194464;58972.11541826876;64585;64645.67677161584;64763.67618161973;64778.352216478175;17733.7339939901;17767.644647106987;17896.55258618545;17919;17928;11686.18196726238;12241.938790306169;13565.321733913264;13688.794668079987;13690.247036412893;19281.325153619837;19720.802791971895;19796.60406791856;19866;19994.20023199056;7038.656638096965;7066.470014748915;7218.664547058811;7294.234105418961;7379;919.9310051746012;1020.2908978260039;1048.3814549415881;1088.7082690935624;1118.3569447567681;32908.50637240443;32933.3413331732;33474.16314592155;33605.83197083999;33728.831355843555;1110.7611863449397;1140.224647239885;1150.7238262817032;1154.503563467717;1163.4008485629906;17319.913400432917;17544.649107017787;17688.557786055193;17735.467935961682;17804.3768468103;612893;615450;616536;617472;618158;58282.417175828545;58329.70835145797;58437.49375037511;58968;58990.41009589935;1199.2264989081993;1301.4924179569975;1316.5457917018614;1327.9468821247235;1329.8803107720353;33331.83334083314;34626.65373346234;34766.47850282298;35253.29493410066;35358.646413535535;50969.49030509647;51102;51693.48306516887;51702.22446663228;51709.7414512925;415222;417860;417924;418005;418673;23385.532289354458;23411.648825267974;23423.94592243319;23642.64536031995;24604.50790984206;47883.28175077307;48183.518164817906;48385;48840.2673959898;49350.50649493459;40398.78803635778;42170.36744448775;42372;42498.36252456278;42549;41546.376804347354;41564.37653435261;41627;42113;42232.57767422409;41044.38433423441;41288.793556032026;42000.369994449495;42205.78897105618;42239.788801055794;36036.49543807024;36096;36314.63685363113;36992.63007369892;37106.8144659275;28188.577171342855;28385.148445546667;28471.715282846908;28566.714332856405;28836.855815720788 20:27:27 INFO - PROCESS | 904 | |2;jquery.html;383.1970578428494;391.92553414851193;396.231311256163;399.33112037337463;417.3406018490785;19139.904300478494;20579.999999999964;20608.69086963695;20658.89670551645;21413.785862141372;19655.705164422547;20043.899780501077;20283.594328113428;20320.695189572132;20511;5548.889022219553;5586.10622300432;5882.058870580708;5890.64656120632;5967.254093238345;5886.440788125121;5886.5290776737975;5891.234139561851;5894.4989675877605;5946.554008449362;6499.480041596685;6530.934690653104;6537.477001839841;6540.4440622547145;6550.050242714803;5881.617694849821;5888.941110588882;5996.640201587918;6520.0871877937125;6523.641199734013;5703.287089113861;5704.087346024658;5713.514351280104;5718.799842005551;5741.052726300156;13440.395182216824;13598.728025439435;13794.862051379458;13863.792043119362;13894.444222231099;2444.449998750267;2519.8362106463205;2677.8125531212822;2813.788965827551;2886.422715456917;9932.801343973153;9968.95015524925;10268.74328141795;10290.79418411635;10359.533820978075;1772.849307808825;1945;1947.8702352635437;2038.2662241593014;2100.1494394770143;81805;85938;86503.13496864951;87430;89193;10716.249862509705;10827.67516974492;10992.395418252074;11022.669319920415;11205.719857003478;15130.848691513163;15232.619184520254;15247.923760381127;15261.23693815327;15263.92368038175;8107.391945604103;8373.916260837314;8419.284360829399;8496.065432802387;8498.70254541088;8249.05135909366;8252.33981281496;8343.95828020868;8467.068622451525;8515.27620152294;4613.492515823256;4640.628749700016;4667.906641867144;4678.415198100238;4753.405824271966;1927.4025052233853;1936.6029963857375;1956.6184594004033;1961.8038196180553;1997.4507010572208;916.2120576304372;930.9255259579218;979.9661357268008;995.571904081252;1072.813743182746;20113.440636692976;20417;20809.271675491284;20935.68596471054;21022.2642207522;970.7621632700034;973.0755782007121;1005.8591797148405;1030.6135199300263;1064.3241541621126;10678.572857085785;11281.379524126087;11508.94245528767;11520.423978801027;11575.626996465704;477937;480494;485036;492850;493216;55909.44090559124;74939;97646;100145;100278.4986075065;985.5811280205884;996.6760802739138;1003.5132960514145;1015.7968406318765;1069.989300106989;18540.907295463436;18647.533811654816;18809.811901880807;18955.147018384483;19167.137478813765;44912.32631510595;45657.97147685372;45771.31343029924;45857.77071114623;46900.29649555191;62212.37787622247;62266.68866655638;63052.36947630465;63457.365426345146;63480.682596586725;7481.70073197066;7857.174996625501;7926.603669816602;8303;8920.464772113693;9331.626734930798;12909.483620655445;13637.386317615532;13718.24549649739;14036.157830530201;12465.937670311952;12486.438110284877;12495.93752031234;12880;12962.611121666365;11849.585264515701;12091.818622720843;12450.25298482094;12628.305443200712;12905;11755.471003804678;12037.939810300892;12041.33772642513;12244.387780610756;12455.875441245835;7897.605119743875;7942.672122680661;8226.095129535626;8248.711295104642;8256.298214651822;11449.942750286194;12457.688557786129;12581.811272831097;12687.04847136487;12888 20:27:27 INFO - PROCESS | 904 | |3;mootools.html;1350.5340657473168;1484.5026915983149;1503.2183264702355;1659.3030927010661;1831.9084045797706;8445.408821382505;8850.77873053174;8888.06675299094;9061.728148155566;9134.314926380532;8865.379423440361;9057.049009853969;9076.183143517082;9080.772980675487;9081.636734530612;1953.9902300488477;2111.9366419007456;2164.93505194844;2179.6403593407067;2200.2959053103014;2241.3051953894264;2249.887505624712;2250.729912410513;2252.245497758253;2252.6395776675736;2174.152080688533;2180.6728990651372;2207.061998650567;2208.2602328219987;2210.049678638193;1859.6652602531606;2062.391594479632;2104;2108.3780284816016;2108.947276318089;2138.6257404954226;2142.1110239250693;2144.5603651251454;2153.6661817418326;2155.902984365707;9129.497877616728;9171.954140229323;9178.908210917938;9186.219171370441;9193.402428842104;5175.45657705943;5299.49654782795;5302.814401495968;5306.575473962073;5310.362756469249;3323.551320571716;3394.389009978203;3495.24852156785;3524.1542029912894;3527.417976033951;1178.1458442629112;1181.5982565927625;2167.1223154622403;2222.6666000099954;2274.294968559752;12802.743945121045;12839.037072219528;12963.611091667264;12964.935175324157;12969.221846689134;4226.5139508956245;4333.220020396359;4464.799084041226;4469.10617876426;4503.572160644733;9870.111689947938;9971.501424928725;9996.650117245861;9996.850047249298;9997.350172238781;5253.737313134405;5260.71066091361;5264.52619264268;5265.368155821249;5268.262443257947;4337.848175313912;4656.3713898623255;4767.284907263869;4797.856064318076;4864.854054378375;3667.1932174921476;3669.688076513526;3722.758020728644;3766.453864189677;3790.6019867914024;966.0532677975623;1011.2567263061644;1049.4018409506662;1064.6167379743285;1073.2969904712427;847.4237518487364;865.2083343740533;871.8692196170625;878.9384743068051;902.2060586683807;5792.536597072224;5807.709614519257;5877.206577112035;5928.525717942554;6007.8878394978765;912.333996182777;932.5057719408588;962.2727204667639;962.5812771444444;973.2068364283086;4116.629503344713;4137.379393091061;4152.294110001307;4166.479190101238;4177.624013838769;11303;11545.826812597817;11608;11669;11731.23746956445;11476.254043487146;11592.88407115935;11597.072234221241;11608.129390295762;11610.70973225676;7982.880256796153;8278.875816862752;8307.501549907025;8348.457350272334;8420.031696354876;5879.2944846618675;6120.143179954721;6287.119803227461;6289.622622642473;6369.044643303356;10256.28206025601;10714.196435267542;10743.623973160902;10746.140308775122;10932.672019839418;10807.837882431613;10813.243072984815;10872.402017889091;10946.616868409568;10947.34315941046;7961.960190199244;8033.959830200812;8157.6329065193395;8159.46963447374;8163.959180204061;8806.031336552845;8816.382853200214;8847.911520884967;8848.513331766557;8854.114588541095;7025.712092360157;7726.5380240655395;7782.299593036654;8131.024277086787;8213.671453141807;7891.960540197492;7904.960475197588;7920;7996.24035716606;8168.183181681784;6730.495212859153;6754.527183097136;6796.694148763417;6803.353681400259;6813.1142951415995;4831.758412079453;4886.828960986349;4911.165101932608;5117.155669314521;5351.090314646442;4987.251912213197;5179.715115668524;5189.325387699575;5307.124324486416;5330.493603107699 20:27:27 INFO - PROCESS | 904 | |4;prototype.html;308.31246320704815;313.1326226353002;315;320.9534617480466;326.3098546573994;5344.808628462331;5345.973270133653;5351.384590772062;5370.3287089113865;5384.6499977501435;5079.974600127003;5162.277281180638;5214.895702085956;5228.163493840977;5287.444818294071;4018.7990600470007;4066.2274167908076;4166.291730405823;4174.874753757392;4197.4753155855515;4092.953523238381;4135.7518548887165;4140.979295103521;4153.376993450976;4158.6465150462245;4026.3356546169994;4139.81370838313;4145.502539695241;4155.314373128445;4169.353750168729;4130.235906357303;4132.669386449077;4143.627073563363;4160.958390416103;4175.916481670365;3680.2271522980204;3683.7421380503374;3685.1155722626377;3690.409534474471;3696.9260614787554;5030.798768049311;5148.588112950955;5231.790728370861;5239.240310155044;5239.423663397023;4631.397918270603;4686.906261874743;4727.267273572602;4733.692309999839;4742.312364707098;5481.205225242317;5487.79268560916;5502.257195278667;5518.061929471999;5526.4802179400585;3894.240623078501;3969.9082752243075;3971.6028397160344;3992.960070399317;3998.280309544281;5661.264035675335;5681.608006038506;5727.594410347622;5729.398413166599;5735.4551317624755;4062.695297852673;4068.5117785865295;4087.8773636790943;4127.4015267786;4139.689523285766;4090.897727556835;4179.665626749853;4184.539700632928;4187.288161012635;4191.3293872980175;4661.114388266286;4680.3447517347595;4698.248280275208;4698.483166851644;4710.034442939189;5497.202905578669;5523.143912693539;5533.6403133796175;5553.583481238923;5571.359293681278;1377.3388773388829;1391.7912313153108;1421.3106643278002;1433.677422579932;1448.6088756036022;962.4658314635444;986.7631768375538;1000.8598796168542;1001.737810358953;1013.807376598444;5281.498257665516;5305.045091883498;5318.813841515605;5329.8401047967845;5351.046867893268;5550.057479882009;5587.7485513152005;5593.244911936918;5627.099664053731;5642;5174.723121826384;5349.170878513836;5356.437574054668;5358.4373640767935;5359.330083739533;2646.5103955768245;2677.8527181004843;2685.23470810818;2694.8248363856287;2698.338906967766;5079.450767515869;5171.301874247004;5171.560417364491;5188.273641690166;5188.558972487305;4845.380345415189;5009.949900501021;5093.337866077386;5097.770600322994;5098.617603679739;5073.8731531712;5078.339815823919;5135.768890399941;5140.537351638371;5141.820036298712;4994.775235114356;5029.692280007152;5031.6917601423165;5082.898342033212;5086.456771614193;4806.279058141306;4837.298591704112;4894.1679914415345;4964.553190212898;4980.207125434768;5123.077845987758;5138.537531622172;5141.434442211279;5162.328897243335;5175.275461435327;3719.590845007101;3758.661720445173;3765.7740535567955;3774.9245015100096;3794.734368594172;4800.271902115305;5019.422766381766;5024.29659847629;5101.51535604117;5447.455254474521;5457.836264912059;5558.277423935025;5584.944150558605;5586.972065139648;5613.494785469327;5481.040817856939;5511.200875872896;5582.218489411567;5598.888022239451;5612.915806262991;5317.494837990384;5563.916541251803;5575.860603484945;5646.265985422033;5648.672561947857;5648.378678345297;5666.518345940476;5667.121596152603;5678.716064196857;5683.8010669626365;5485.75314110858;5564.860878478071;5587.44125587438;5608.887822243614;5633.6619802811965 20:27:27 INFO - PROCESS | 904 | |5;yui.html;784.3137254901961;819.9795005124872;828.44080245834;839.9370047246458;877.5085951866955;15546.45587404441;16941.237644306006;17289.394871179513;17394.565135871577;17460;16847.663046739057;16891.49325520233;16955.152242387892;17009.319627214896;17046.659066818655;662.7117204016245;783.7922950418143;800.1558355934487;801.9077806052305;821.5645707774859;821.6795449774593;822.9670813167467;827.0158511371479;828.6395417993192;829.4567058576642;853.3301358433631;855.2431098477861;857.4555157475017;857.5712143928037;858.0261403307229;691.2120182991393;845.0704225352125;855.6534603485567;873.244643383475;876.9649214031431;624.3756243756244;624.4754406298686;624.8843963866653;626.1077963901467;626.7461678020409;14223.573292801233;14434.13395196281;14505;14548.127112373291;14577.927110364486;14699.11805291686;14762.114273143538;14777.261136943218;15222.391104355924;15614.45349412765;12706.966147445562;12943.611691649265;13092.47630094795;13111.934440327832;13118.540851070262;4006.198760247933;4018.9397159042637;4092.5907409259135;4102.610252026053;4113.136241389312;80142;80932.59533702294;81189;81289.18710812935;81776.59111704463;12129.818052729217;12212.32832194238;12290.385480725929;12419.379031048411;12437.502499900083;22976;22982.195623153442;23006.654900176512;23013.7698623015;23017.769822301896;8888.466691998501;9036.367454278137;9074.137956894085;9167.17495425415;9309.813803723888;4908.9754551227015;4997.075541024922;5034.496550344937;5055.772490237948;5191.792328306901;3427.7771944824003;3553.3248682750195;3553.7690050146657;3557.3774589446743;3813.3517302058717;666.9899951500731;677.7864972533636;686.7081490366575;695.4297476069676;698.2110215456502;630.0328994992665;725.3906718356606;730.0545793197822;746.1493896957364;797.3899966525613;10368.222383321281;10606.204534659932;10757.30077544957;10805.13558915285;10969.780604387868;668.8595394967014;718.4862823081418;754.8754455514778;766.3945483068425;771.7194502983024;4847.394075740533;4989.401271847329;5033.6476446648385;5087.465816089331;5130.127878260705;69370;123253;123602;131966.76065583585;132966;108546;108899;108922.45538772256;109000.45499772609;110142;61308;86633;96308;98084.50957745308;100486.96591238689;9530.285228607743;9564.61741530331;9659.951700241454;9685.564149613425;9695.224382049279;45782.771086144356;56987;57072;57355.42644573668;59433.622655095045;50041.49958500369;62200.68899655473;65034.67482662746;70733.64633176802;72890;14036.929815350857;14197.290135492978;14470;14513.274336282933;14539.709205815612;14573.781393279321;15328.693426131638;15349.462768803038;15644.296006679955;16090.517284481484;14096.224707641179;14193.574192774233;14405.855941440452;14459.927700361852;14937.701245975237;14764.335604897591;14848;15150;15404.38382464689;16107.67784644324;14783.260836957894;15117.54647360581;15527.301271442586;16004.439844605384;16016.878818482593;11867.525298987945;12046.127782676378;12098.395080245777;12267.520753512246;12379.133460657667;11482.94258528702;11926.284422934652;12110.818337724764;12590;12695.746085078063 20:27:27 INFO - PROCESS | 904 | __end_tp_report 20:27:27 INFO - PROCESS | 904 | __start_cc_report 20:27:27 INFO - PROCESS | 904 | _x_x_mozilla_cycle_collect,834 20:27:27 INFO - PROCESS | 904 | __end_cc_report 20:27:27 INFO - PROCESS | 904 | __startTimestamp1468380447585__endTimestamp 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | ------- Summary: start ------- 20:27:27 INFO - PROCESS | 904 | Number of tests: 6 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | [#0] dojo.html Cycles:165 Average:5376.85 Median:5609.07 stddev:614.88 (11.0%) stddev-sans-first:589.79 20:27:27 INFO - PROCESS | 904 | Values: 3080.4 3083.6 3114.8 3118.2 3131.7 5252.9 5336.4 5342.8 5389.2 5413.2 5319.1 5336.3 5434.6 5476.0 5504.1 4819.2 4889.3 4897.1 4909.3 5051.1 4944.6 4954.8 4999.1 5002.4 5013.3 4812.1 4878.2 4884.0 4884.3 4929.7 4874.6 4885.7 4956.9 4958.1 5008.9 4798.6 4923.1 4931.2 4935.7 4948.7 5334.4 5334.8 5379.2 5482.2 5482.7 5795.7 5811.4 5825.2 5827.4 5827.8 5675.9 5704.5 5841.0 5847.9 5856.2 5336.6 5429.2 5433.5 5435.4 5438.1 5925.9 5949.1 5968.2 5970.0 5971.6 5501.2 5619.0 5656.9 5682.5 5695.4 5813.6 5830.6 5832.2 5835.4 5837.8 5723.3 5767.9 5778.4 5779.5 5811.7 5584.6 5700.8 5764.0 5766.7 5775.7 4416.0 4416.3 4422.9 4430.5 4462.7 3953.3 3963.5 3976.2 3985.9 4010.3 5321.3 5369.6 5386.9 5393.9 5442.7 5809.2 5818.8 5820.0 5832.1 5868.3 5295.4 5459.2 5460.2 5468.5 5470.2 4911.5 4924.4 4967.0 4979.9 4981.2 5960.5 5962.8 5966.1 5966.9 5967.4 5604.0 5740.9 5790.2 5800.7 5802.4 5937.8 6005.4 6024.1 6029.5 6077.4 5688.0 5724.5 5727.6 5740.6 5742.2 5609.1 5764.7 5778.7 5844.9 5857.6 5725.7 5729.9 5731.9 5735.7 5773.5 5626.6 5672.1 5676.7 5677.8 5699.6 5488.3 5597.9 5638.9 5656.6 5677.6 5746.6 5747.1 5750.7 5807.6 5809.2 5569.0 5600.0 5611.2 5615.8 5617.4 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | [#1] ext.html Cycles:180 Average:63377.87 Median:42305.89 stddev:128585.40 (303.9%) stddev-sans-first:128859.69 20:27:27 INFO - PROCESS | 904 | Values: 586.2 624.4 626.3 636.0 639.0 43840.3 44795.6 44799.8 44838.8 48341.8 44746.3 45259.8 45311.1 45362.5 45365.8 9131.2 9280.7 9282.4 9287.0 9289.8 9101.5 9121.3 9184.6 9193.4 9194.7 9248.1 9272.6 9277.7 9281.6 9285.5 9167.8 9175.8 9224.1 9229.7 9231.6 9000.6 9067.4 9073.2 9075.4 9078.5 42827.4 42960.1 43072.4 43239.6 43274.0 3507.5 3582.7 3627.8 3645.0 3683.2 32461.0 32653.7 32907.7 33207.7 33355.0 4500.1 4512.6 4516.9 4535.5 4592.7 380452.0 384686.0 384905.0 384952.0 385766.0 53502.7 57960.0 61426.0 61908.7 61941.4 58972.1 64585.0 64645.7 64763.7 64778.4 17733.7 17767.6 17896.6 17919.0 17928.0 11686.2 12241.9 13565.3 13688.8 13690.2 19281.3 19720.8 19796.6 19866.0 19994.2 7038.7 7066.5 7218.7 7294.2 7379.0 919.9 1020.3 1048.4 1088.7 1118.4 32908.5 32933.3 33474.2 33605.8 33728.8 1110.8 1140.2 1150.7 1154.5 1163.4 17319.9 17544.6 17688.6 17735.5 17804.4 612893.0 615450.0 616536.0 617472.0 618158.0 58282.4 58329.7 58437.5 58968.0 58990.4 1199.2 1301.5 1316.5 1327.9 1329.9 33331.8 34626.7 34766.5 35253.3 35358.6 50969.5 51102.0 51693.5 51702.2 51709.7 415222.0 417860.0 417924.0 418005.0 418673.0 23385.5 23411.6 23423.9 23642.6 24604.5 47883.3 48183.5 48385.0 48840.3 49350.5 40398.8 42170.4 42372.0 42498.4 42549.0 41546.4 41564.4 41627.0 42113.0 42232.6 41044.4 41288.8 42000.4 42205.8 42239.8 36036.5 36096.0 36314.6 36992.6 37106.8 28188.6 28385.1 28471.7 28566.7 28836.9 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | [#2] jquery.html Cycles:180 Average:29113.03 Median:1634.81 stddev:80230.87 (4907.7%) stddev-sans-first:80426.94 20:27:27 INFO - PROCESS | 904 | Values: 383.2 391.9 396.2 399.3 417.3 19139.9 20580.0 20608.7 20658.9 21413.8 19655.7 20043.9 20283.6 20320.7 20511.0 5548.9 5586.1 5882.1 5890.6 5967.3 5886.4 5886.5 5891.2 5894.5 5946.6 6499.5 6530.9 6537.5 6540.4 6550.1 5881.6 5888.9 5996.6 6520.1 6523.6 5703.3 5704.1 5713.5 5718.8 5741.1 13440.4 13598.7 13794.9 13863.8 13894.4 2444.4 2519.8 2677.8 2813.8 2886.4 9932.8 9969.0 10268.7 10290.8 10359.5 1772.8 1945.0 1947.9 2038.3 2100.1 81805.0 85938.0 86503.1 87430.0 89193.0 10716.2 10827.7 10992.4 11022.7 11205.7 15130.8 15232.6 15247.9 15261.2 15263.9 8107.4 8373.9 8419.3 8496.1 8498.7 8249.1 8252.3 8344.0 8467.1 8515.3 4613.5 4640.6 4667.9 4678.4 4753.4 1927.4 1936.6 1956.6 1961.8 1997.5 916.2 930.9 980.0 995.6 1072.8 20113.4 20417.0 20809.3 20935.7 21022.3 970.8 973.1 1005.9 1030.6 1064.3 10678.6 11281.4 11508.9 11520.4 11575.6 477937.0 480494.0 485036.0 492850.0 493216.0 55909.4 74939.0 97646.0 100145.0 100278.5 985.6 996.7 1003.5 1015.8 1070.0 18540.9 18647.5 18809.8 18955.1 19167.1 44912.3 45658.0 45771.3 45857.8 46900.3 62212.4 62266.7 63052.4 63457.4 63480.7 7481.7 7857.2 7926.6 8303.0 8920.5 9331.6 12909.5 13637.4 13718.2 14036.2 12465.9 12486.4 12495.9 12880.0 12962.6 11849.6 12091.8 12450.3 12628.3 12905.0 11755.5 12037.9 12041.3 12244.4 12455.9 7897.6 7942.7 8226.1 8248.7 8256.3 11449.9 12457.7 12581.8 12687.0 12888.0 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | [#3] mootools.html Cycles:180 Average:5906.09 Median:4899.00 stddev:3483.45 (71.1%) stddev-sans-first:3476.40 20:27:27 INFO - PROCESS | 904 | Values: 1350.5 1484.5 1503.2 1659.3 1831.9 8445.4 8850.8 8888.1 9061.7 9134.3 8865.4 9057.0 9076.2 9080.8 9081.6 1954.0 2111.9 2164.9 2179.6 2200.3 2241.3 2249.9 2250.7 2252.2 2252.6 2174.2 2180.7 2207.1 2208.3 2210.0 1859.7 2062.4 2104.0 2108.4 2108.9 2138.6 2142.1 2144.6 2153.7 2155.9 9129.5 9172.0 9178.9 9186.2 9193.4 5175.5 5299.5 5302.8 5306.6 5310.4 3323.6 3394.4 3495.2 3524.2 3527.4 1178.1 1181.6 2167.1 2222.7 2274.3 12802.7 12839.0 12963.6 12964.9 12969.2 4226.5 4333.2 4464.8 4469.1 4503.6 9870.1 9971.5 9996.7 9996.9 9997.4 5253.7 5260.7 5264.5 5265.4 5268.3 4337.8 4656.4 4767.3 4797.9 4864.9 3667.2 3669.7 3722.8 3766.5 3790.6 966.1 1011.3 1049.4 1064.6 1073.3 847.4 865.2 871.9 878.9 902.2 5792.5 5807.7 5877.2 5928.5 6007.9 912.3 932.5 962.3 962.6 973.2 4116.6 4137.4 4152.3 4166.5 4177.6 11303.0 11545.8 11608.0 11669.0 11731.2 11476.3 11592.9 11597.1 11608.1 11610.7 7982.9 8278.9 8307.5 8348.5 8420.0 5879.3 6120.1 6287.1 6289.6 6369.0 10256.3 10714.2 10743.6 10746.1 10932.7 10807.8 10813.2 10872.4 10946.6 10947.3 7962.0 8034.0 8157.6 8159.5 8164.0 8806.0 8816.4 8847.9 8848.5 8854.1 7025.7 7726.5 7782.3 8131.0 8213.7 7892.0 7905.0 7920.0 7996.2 8168.2 6730.5 6754.5 6796.7 6803.4 6813.1 4831.8 4886.8 4911.2 5117.2 5351.1 4987.3 5179.7 5189.3 5307.1 5330.5 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | [#4] prototype.html Cycles:180 Average:4530.96 Median:5081.44 stddev:1305.66 (25.7%) stddev-sans-first:1270.27 20:27:27 INFO - PROCESS | 904 | Values: 308.3 313.1 315.0 321.0 326.3 5344.8 5346.0 5351.4 5370.3 5384.6 5080.0 5162.3 5214.9 5228.2 5287.4 4018.8 4066.2 4166.3 4174.9 4197.5 4093.0 4135.8 4141.0 4153.4 4158.6 4026.3 4139.8 4145.5 4155.3 4169.4 4130.2 4132.7 4143.6 4161.0 4175.9 3680.2 3683.7 3685.1 3690.4 3696.9 5030.8 5148.6 5231.8 5239.2 5239.4 4631.4 4686.9 4727.3 4733.7 4742.3 5481.2 5487.8 5502.3 5518.1 5526.5 3894.2 3969.9 3971.6 3993.0 3998.3 5661.3 5681.6 5727.6 5729.4 5735.5 4062.7 4068.5 4087.9 4127.4 4139.7 4090.9 4179.7 4184.5 4187.3 4191.3 4661.1 4680.3 4698.2 4698.5 4710.0 5497.2 5523.1 5533.6 5553.6 5571.4 1377.3 1391.8 1421.3 1433.7 1448.6 962.5 986.8 1000.9 1001.7 1013.8 5281.5 5305.0 5318.8 5329.8 5351.0 5550.1 5587.7 5593.2 5627.1 5642.0 5174.7 5349.2 5356.4 5358.4 5359.3 2646.5 2677.9 2685.2 2694.8 2698.3 5079.5 5171.3 5171.6 5188.3 5188.6 4845.4 5009.9 5093.3 5097.8 5098.6 5073.9 5078.3 5135.8 5140.5 5141.8 4994.8 5029.7 5031.7 5082.9 5086.5 4806.3 4837.3 4894.2 4964.6 4980.2 5123.1 5138.5 5141.4 5162.3 5175.3 3719.6 3758.7 3765.8 3774.9 3794.7 4800.3 5019.4 5024.3 5101.5 5447.5 5457.8 5558.3 5584.9 5587.0 5613.5 5481.0 5511.2 5582.2 5598.9 5612.9 5317.5 5563.9 5575.9 5646.3 5648.7 5648.4 5666.5 5667.1 5678.7 5683.8 5485.8 5564.9 5587.4 5608.9 5633.7 20:27:27 INFO - PROCESS | 904 | 20:27:27 INFO - PROCESS | 904 | [#5] yui.html Cycles:180 Average:21648.05 Median:4012.57 stddev:31111.89 (775.4%) stddev-sans-first:31159.73 20:27:27 INFO - PROCESS | 904 | Values: 784.3 820.0 828.4 839.9 877.5 15546.5 16941.2 17289.4 17394.6 17460.0 16847.7 16891.5 16955.2 17009.3 17046.7 662.7 783.8 800.2 801.9 821.6 821.7 823.0 827.0 828.6 829.5 853.3 855.2 857.5 857.6 858.0 691.2 845.1 855.7 873.2 877.0 624.4 624.5 624.9 626.1 626.7 14223.6 14434.1 14505.0 14548.1 14577.9 14699.1 14762.1 14777.3 15222.4 15614.5 12707.0 12943.6 13092.5 13111.9 13118.5 4006.2 4018.9 4092.6 4102.6 4113.1 80142.0 80932.6 81189.0 81289.2 81776.6 12129.8 12212.3 12290.4 12419.4 12437.5 22976.0 22982.2 23006.7 23013.8 23017.8 8888.5 9036.4 9074.1 9167.2 9309.8 4909.0 4997.1 5034.5 5055.8 5191.8 3427.8 3553.3 3553.8 3557.4 3813.4 667.0 677.8 686.7 695.4 698.2 630.0 725.4 730.1 746.1 797.4 10368.2 10606.2 10757.3 10805.1 10969.8 668.9 718.5 754.9 766.4 771.7 4847.4 4989.4 5033.6 5087.5 5130.1 69370.0 123253.0 123602.0 131966.8 132966.0 108546.0 108899.0 108922.5 109000.5 110142.0 61308.0 86633.0 96308.0 98084.5 100487.0 9530.3 9564.6 9660.0 9685.6 9695.2 45782.8 56987.0 57072.0 57355.4 59433.6 50041.5 62200.7 65034.7 70733.6 72890.0 14036.9 14197.3 14470.0 14513.3 14539.7 14573.8 15328.7 15349.5 15644.3 16090.5 14096.2 14193.6 14405.9 14459.9 14937.7 14764.3 14848.0 15150.0 15404.4 16107.7 14783.3 15117.5 15527.3 16004.4 16016.9 11867.5 12046.1 12098.4 12267.5 12379.1 11482.9 11926.3 12110.8 12590.0 12695.7 20:27:27 INFO - PROCESS | 904 | -------- Summary: end -------- 20:27:27 INFO - PROCESS | 904 | 20:27:28 INFO - TEST-INFO | 904: exit 0 20:27:28 INFO - TEST-OK | dromaeo_css | took 1112194ms 20:27:28 INFO - TEST-START | kraken 20:27:28 INFO - operating with platform_type : linux_ 20:27:28 INFO - Initialising browser for kraken test... 20:27:28 INFO - TEST-INFO | started process 1108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuCcNMP/profile http://localhost:55212/getInfo.html) 20:27:32 INFO - PROCESS | 1108 | __metrics Screen width/height:1600/1200 20:27:32 INFO - PROCESS | 1108 | colorDepth:24 20:27:32 INFO - PROCESS | 1108 | Browser inner width/height: 1024/697 20:27:32 INFO - PROCESS | 1108 | __metrics 20:27:32 INFO - PROCESS | 1108 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:27:32 INFO - PROCESS | 1108 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:27:33 INFO - TEST-INFO | 1108: exit 0 20:27:33 INFO - Browser initialized. 20:27:33 INFO - Running cycle 1/1 for kraken test... 20:27:33 INFO - TEST-INFO | started process 1257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuCcNMP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:45 INFO - PROCESS | 1257 | RSS: Main: 157884416 20:27:45 INFO - PROCESS | 1257 | 20:27:48 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55212/tests/kraken/driver.html?testName=audio-beat-detection) 20:27:48 INFO - PROCESS | 1257 | RSS: Main: 215728128 20:27:48 INFO - PROCESS | 1257 | 20:27:51 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55212/tests/kraken/driver.html?testName=audio-dft) 20:27:52 INFO - PROCESS | 1257 | RSS: Main: 203444224 20:27:52 INFO - PROCESS | 1257 | 20:27:55 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55212/tests/kraken/driver.html?testName=audio-fft) 20:27:55 INFO - PROCESS | 1257 | RSS: Main: 269180928 20:27:55 INFO - PROCESS | 1257 | 20:27:58 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55212/tests/kraken/driver.html?testName=audio-oscillator) 20:27:58 INFO - PROCESS | 1257 | RSS: Main: 180391936 20:27:58 INFO - PROCESS | 1257 | 20:28:00 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55212/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:01 INFO - PROCESS | 1257 | RSS: Main: 183873536 20:28:01 INFO - PROCESS | 1257 | 20:28:04 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55212/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:05 INFO - PROCESS | 1257 | RSS: Main: 219394048 20:28:05 INFO - PROCESS | 1257 | 20:28:08 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55212/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:08 INFO - PROCESS | 1257 | RSS: Main: 221360128 20:28:08 INFO - PROCESS | 1257 | 20:28:11 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55212/tests/kraken/driver.html?testName=json-parse-financial) 20:28:12 INFO - PROCESS | 1257 | RSS: Main: 221458432 20:28:12 INFO - PROCESS | 1257 | 20:28:13 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55212/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:14 INFO - PROCESS | 1257 | RSS: Main: 208568320 20:28:14 INFO - PROCESS | 1257 | 20:28:16 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:16 INFO - PROCESS | 1257 | RSS: Main: 211423232 20:28:16 INFO - PROCESS | 1257 | 20:28:18 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:19 INFO - PROCESS | 1257 | RSS: Main: 211554304 20:28:19 INFO - PROCESS | 1257 | 20:28:21 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:22 INFO - PROCESS | 1257 | RSS: Main: 222425088 20:28:22 INFO - PROCESS | 1257 | 20:28:25 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:28:25 INFO - PROCESS | 1257 | RSS: Main: 223772672 20:28:25 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:55212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55212/tests/kraken/driver.html?testName=ai-astar) 20:28:27 INFO - PROCESS | 1257 | RSS: Main: 265248768 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | __start_tp_report 20:28:27 INFO - PROCESS | 1257 | _x_x_mozilla_page_load 20:28:27 INFO - PROCESS | 1257 | _x_x_mozilla_page_load_details 20:28:27 INFO - PROCESS | 1257 | |i|pagename|runs| 20:28:27 INFO - PROCESS | 1257 | |0;ai-astar;100;108;109;111;110;110;109;109;109;109 20:28:27 INFO - PROCESS | 1257 | |1;audio-beat-detection;138;120;120;171;118;124;142;118;154;117 20:28:27 INFO - PROCESS | 1257 | |2;audio-dft;161;162;160;159;161;161;161;161;161;160 20:28:27 INFO - PROCESS | 1257 | |3;audio-fft;74;75;75;118;75;76;75;74;105;74 20:28:27 INFO - PROCESS | 1257 | |4;audio-oscillator;84;83;114;84;85;84;118;84;83;126 20:28:27 INFO - PROCESS | 1257 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;116;117;117 20:28:27 INFO - PROCESS | 1257 | |6;imaging-darkroom;146;146;145;146;145;147;145;145;145;145 20:28:27 INFO - PROCESS | 1257 | |7;imaging-desaturate;95;95;95;94;95;95;94;95;96;95 20:28:27 INFO - PROCESS | 1257 | |8;json-parse-financial;53;56;53;55;53;54;54;54;55;55 20:28:27 INFO - PROCESS | 1257 | |9;json-stringify-tinderbox;60;61;60;60;59;61;61;61;61;60 20:28:27 INFO - PROCESS | 1257 | |10;stanford-crypto-aes;75;84;78;75;74;77;80;80;74;82 20:28:27 INFO - PROCESS | 1257 | |11;stanford-crypto-ccm;125;114;125;118;120;120;125;133;158;121 20:28:27 INFO - PROCESS | 1257 | |12;stanford-crypto-pbkdf2;158;160;158;163;162;162;158;158;157;156 20:28:27 INFO - PROCESS | 1257 | |13;stanford-crypto-sha256-iterative;66;64;67;64;63;62;66;69;61;62 20:28:27 INFO - PROCESS | 1257 | __end_tp_report 20:28:27 INFO - PROCESS | 1257 | __start_cc_report 20:28:27 INFO - PROCESS | 1257 | _x_x_mozilla_cycle_collect,1666 20:28:27 INFO - PROCESS | 1257 | __end_cc_report 20:28:27 INFO - PROCESS | 1257 | __startTimestamp1468380507836__endTimestamp 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | ------- Summary: start ------- 20:28:27 INFO - PROCESS | 1257 | Number of tests: 14 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:3.06 (2.8%) stddev-sans-first:0.87 20:28:27 INFO - PROCESS | 1257 | Values: 100.0 108.0 109.0 111.0 110.0 110.0 109.0 109.0 109.0 109.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:131.00 stddev:18.59 (14.2%) stddev-sans-first:19.60 20:28:27 INFO - PROCESS | 1257 | Values: 138.0 120.0 120.0 171.0 118.0 124.0 142.0 118.0 154.0 117.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 20:28:27 INFO - PROCESS | 1257 | Values: 161.0 162.0 160.0 159.0 161.0 161.0 161.0 161.0 161.0 160.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:15.81 (21.1%) stddev-sans-first:16.49 20:28:27 INFO - PROCESS | 1257 | Values: 74.0 75.0 75.0 118.0 75.0 76.0 75.0 74.0 105.0 74.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:84.00 stddev:17.39 (20.7%) stddev-sans-first:18.02 20:28:27 INFO - PROCESS | 1257 | Values: 84.0 83.0 114.0 84.0 85.0 84.0 118.0 84.0 83.0 126.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:28:27 INFO - PROCESS | 1257 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 117.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 20:28:27 INFO - PROCESS | 1257 | Values: 146.0 146.0 145.0 146.0 145.0 147.0 145.0 145.0 145.0 145.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 20:28:27 INFO - PROCESS | 1257 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 96.0 95.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.03 (1.9%) stddev-sans-first:1.00 20:28:27 INFO - PROCESS | 1257 | Values: 53.0 56.0 53.0 55.0 53.0 54.0 54.0 54.0 55.0 55.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 20:28:27 INFO - PROCESS | 1257 | Values: 60.0 61.0 60.0 60.0 59.0 61.0 61.0 61.0 61.0 60.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:79.00 stddev:3.51 (4.4%) stddev-sans-first:3.56 20:28:27 INFO - PROCESS | 1257 | Values: 75.0 84.0 78.0 75.0 74.0 77.0 80.0 80.0 74.0 82.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:125.00 stddev:12.39 (9.9%) stddev-sans-first:13.13 20:28:27 INFO - PROCESS | 1257 | Values: 125.0 114.0 125.0 118.0 120.0 120.0 125.0 133.0 158.0 121.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:2.39 (1.5%) stddev-sans-first:2.50 20:28:27 INFO - PROCESS | 1257 | Values: 158.0 160.0 158.0 163.0 162.0 162.0 158.0 158.0 157.0 156.0 20:28:27 INFO - PROCESS | 1257 | 20:28:27 INFO - PROCESS | 1257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:2.55 (3.9%) stddev-sans-first:2.64 20:28:27 INFO - PROCESS | 1257 | Values: 66.0 64.0 67.0 64.0 63.0 62.0 66.0 69.0 61.0 62.0 20:28:27 INFO - PROCESS | 1257 | -------- Summary: end -------- 20:28:27 INFO - PROCESS | 1257 | 20:28:28 INFO - TEST-INFO | 1257: exit 0 20:28:28 INFO - TEST-OK | kraken | took 60390ms 20:28:28 INFO - SUITE-END | took 1172s 20:28:29 INFO - Completed test suite (00:19:32) 20:28:29 INFO - javascript benchmark 20:28:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.3993221321825, 3083.5528848316994, 3114.8442577871106, 3118.1892707895954, 3131.7181453669164, 5252.868678283045, 5336.439673834249, 5342.839714808552, 5389.24550562921, 5413.160960051194, 5319.148936170213, 5336.279602253695, 5434.565234781218, 5476.04169270377, 5504.146857237135, 4819.204831202856, 4889.29105279736, 4897.142999975008, 4909.263610458442, 5051.141305977974, 4944.604431645478, 4954.777035033432, 4999.050180465718, 5002.449730529657, 5013.3482647255805, 4812.133815913135, 4878.195097808857, 4883.9511604883855, 4884.3161957326, 4929.728864912447, 4874.610031197496, 4885.65800393969, 4956.925646115311, 4958.132326842824, 5008.9499105008845, 4798.640101992364, 4923.113839508887, 4931.235658472942, 4935.728534930578, 4948.653594248404, 5334.413214546396, 5334.839954801362, 5379.220013098118, 5482.150266708666, 5482.698451585161, 5795.652260864319, 5811.4479124483105, 5825.242718446617, 5827.417258274181, 5827.766889324422, 5675.886482270332, 5704.543636509111, 5841.0, 5847.8538036549, 5856.209411729447, 5336.599755018389, 5429.185622156669, 5433.538149257279, 5435.42927992559, 5438.102713052381, 5925.940740592625, 5949.137375080589, 5968.22413086296, 5969.970150149222, 5971.611845230046, 5501.229827824108, 5618.971905140448, 5656.8868622627315, 5682.488576028178, 5695.373508914016, 5813.563982701315, 5830.591858569859, 5832.154337621021, 5835.387284335168, 5837.795677151279, 5723.255976723, 5767.913481297784, 5778.3643799182055, 5779.508741756998, 5811.738471768781, 5584.636998595079, 5700.828975130753, 5764.048931926269, 5766.740496677659, 5775.653460792366, 4415.977920110379, 4416.31547110192, 4422.889427764268, 4430.5126436092005, 4462.732236065846, 3953.347697629859, 3963.5243770747693, 3976.224636195914, 3985.9202815943518, 4010.2581022510344, 5321.308229930084, 5369.597280203922, 5386.892262154814, 5393.892122157614, 5442.673439593637, 5809.157672137601, 5818.836232753466, 5819.970900145472, 5832.125181222766, 5868.295804503487, 5295.417504074549, 5459.235707001023, 5460.208269800936, 5468.535174510212, 5470.152126420411, 4911.484294149134, 4924.359833221658, 4967.031428871335, 4979.925301120486, 4981.153203955337, 5960.523158147338, 5962.761489540369, 5966.134910437962, 5966.910496342558, 5967.433093856077, 5604.019296622993, 5740.856478588069, 5790.1893734877995, 5800.709964501673, 5802.4197580241635, 5937.762489500372, 6005.39946005396, 6024.096385542204, 6029.457348838626, 6077.392260773887, 5688.0, 5724.513416359656, 5727.627704199213, 5740.6268592541355, 5742.16738572913, 5609.074502707008, 5764.682942438206, 5778.682172480554, 5844.883102338014, 5857.560682948711, 5725.713714314351, 5729.885402292014, 5731.885362292647, 5735.655860648374, 5773.451522105393, 5626.606137570331, 5672.14917762339, 5676.7161641918565, 5677.77288908439, 5699.572532060195, 5488.259085023471, 5597.944020559742, 5638.887222255614, 5656.60403771732, 5677.602567820378, 5746.597738158456, 5747.137929310469, 5750.654960702372, 5807.564432667651, 5809.157672137601, 5569.025420551468, 5599.972000139973, 5611.214429979725, 5615.831525054255, 5617.382087970238], "value": 5334.948938889779, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2173997713053, 624.4411251929523, 626.3454689849107, 635.9554831161814, 638.9648569328687, 43840.3423948641, 44795.55204447955, 44799.77600112003, 44838.77580612097, 48341.7582912085, 44746.32880506795, 45259.773701131446, 45311.09377812442, 45362.54637453624, 45365.773171134184, 9131.223845973083, 9280.72157835266, 9282.350235483518, 9287.0, 9289.814203715921, 9101.499417532033, 9121.270298376114, 9184.632614695403, 9193.35646504745, 9194.678186263482, 9248.075192480732, 9272.629094836198, 9277.675281365153, 9281.628734850598, 9285.489298088602, 9167.816643667122, 9175.816483670322, 9224.07759224079, 9229.67696130639, 9231.58457869394, 9000.639974401016, 9067.410618309788, 9073.183413492818, 9075.410098343587, 9078.54607269634, 42827.35758963618, 42960.14079718388, 43072.3539146913, 43239.56760432387, 43274.0, 3507.4914137450182, 3582.6954708849516, 3627.8004709740953, 3644.963550364489, 3683.1712864605515, 32461.0, 32653.673463265302, 32907.6709232907, 33207.66792332094, 33355.0, 4500.054988452429, 4512.571305725951, 4516.887077823048, 4535.546445355438, 4592.74739889306, 380452.0, 384686.0, 384904.9999999972, 384952.0, 385766.0, 53502.7324863381, 57960.0, 61426.0, 61908.69045654743, 61941.380586194464, 58972.11541826876, 64585.0, 64645.67677161584, 64763.67618161973, 64778.352216478175, 17733.7339939901, 17767.644647106987, 17896.55258618545, 17919.0, 17928.0, 11686.18196726238, 12241.938790306169, 13565.321733913264, 13688.794668079987, 13690.247036412893, 19281.325153619837, 19720.802791971895, 19796.60406791856, 19866.0, 19994.20023199056, 7038.656638096965, 7066.470014748915, 7218.664547058811, 7294.234105418961, 7379.0, 919.9310051746012, 1020.2908978260039, 1048.3814549415881, 1088.7082690935624, 1118.3569447567681, 32908.50637240443, 32933.3413331732, 33474.16314592155, 33605.83197083999, 33728.831355843555, 1110.7611863449397, 1140.224647239885, 1150.7238262817032, 1154.503563467717, 1163.4008485629906, 17319.913400432917, 17544.649107017787, 17688.557786055193, 17735.467935961682, 17804.3768468103, 612893.0, 615450.0, 616536.0, 617472.0, 618158.0, 58282.417175828545, 58329.70835145797, 58437.49375037511, 58968.0, 58990.41009589935, 1199.2264989081993, 1301.4924179569975, 1316.5457917018614, 1327.9468821247235, 1329.8803107720353, 33331.83334083314, 34626.65373346234, 34766.47850282298, 35253.29493410066, 35358.646413535535, 50969.49030509647, 51102.0, 51693.48306516887, 51702.22446663228, 51709.7414512925, 415222.0, 417860.0, 417924.0, 418005.0, 418673.0, 23385.532289354458, 23411.648825267974, 23423.94592243319, 23642.64536031995, 24604.50790984206, 47883.28175077307, 48183.518164817906, 48385.0, 48840.2673959898, 49350.50649493459, 40398.78803635778, 42170.36744448775, 42372.0, 42498.36252456278, 42549.0, 41546.376804347354, 41564.37653435261, 41627.0, 42113.0, 42232.57767422409, 41044.38433423441, 41288.793556032026, 42000.369994449495, 42205.78897105618, 42239.788801055794, 36036.49543807024, 36096.0, 36314.63685363113, 36992.63007369892, 37106.8144659275, 28188.577171342855, 28385.148445546667, 28471.715282846908, 28566.714332856405, 28836.855815720788], "value": 20595.934802760978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.1970578428494, 391.92553414851193, 396.231311256163, 399.33112037337463, 417.3406018490785, 19139.904300478494, 20579.999999999964, 20608.69086963695, 20658.89670551645, 21413.785862141372, 19655.705164422547, 20043.899780501077, 20283.594328113428, 20320.695189572132, 20511.0, 5548.889022219553, 5586.10622300432, 5882.058870580708, 5890.64656120632, 5967.254093238345, 5886.440788125121, 5886.5290776737975, 5891.234139561851, 5894.4989675877605, 5946.554008449362, 6499.480041596685, 6530.934690653104, 6537.477001839841, 6540.4440622547145, 6550.050242714803, 5881.617694849821, 5888.941110588882, 5996.640201587918, 6520.0871877937125, 6523.641199734013, 5703.287089113861, 5704.087346024658, 5713.514351280104, 5718.799842005551, 5741.052726300156, 13440.395182216824, 13598.728025439435, 13794.862051379458, 13863.792043119362, 13894.444222231099, 2444.449998750267, 2519.8362106463205, 2677.8125531212822, 2813.788965827551, 2886.422715456917, 9932.801343973153, 9968.95015524925, 10268.74328141795, 10290.79418411635, 10359.533820978075, 1772.849307808825, 1945.0, 1947.8702352635437, 2038.2662241593014, 2100.1494394770143, 81805.0, 85938.0, 86503.13496864951, 87430.0, 89193.0, 10716.249862509705, 10827.67516974492, 10992.395418252074, 11022.669319920415, 11205.719857003478, 15130.848691513163, 15232.619184520254, 15247.923760381127, 15261.23693815327, 15263.92368038175, 8107.391945604103, 8373.916260837314, 8419.284360829399, 8496.065432802387, 8498.70254541088, 8249.05135909366, 8252.33981281496, 8343.95828020868, 8467.068622451525, 8515.27620152294, 4613.492515823256, 4640.628749700016, 4667.906641867144, 4678.415198100238, 4753.405824271966, 1927.4025052233853, 1936.6029963857375, 1956.6184594004033, 1961.8038196180553, 1997.4507010572208, 916.2120576304372, 930.9255259579218, 979.9661357268008, 995.571904081252, 1072.813743182746, 20113.440636692976, 20417.0, 20809.271675491284, 20935.68596471054, 21022.2642207522, 970.7621632700034, 973.0755782007121, 1005.8591797148405, 1030.6135199300263, 1064.3241541621126, 10678.572857085785, 11281.379524126087, 11508.94245528767, 11520.423978801027, 11575.626996465704, 477937.0, 480494.0, 485036.0, 492850.0, 493216.0, 55909.44090559124, 74939.0, 97646.0, 100145.0, 100278.4986075065, 985.5811280205884, 996.6760802739138, 1003.5132960514145, 1015.7968406318765, 1069.989300106989, 18540.907295463436, 18647.533811654816, 18809.811901880807, 18955.147018384483, 19167.137478813765, 44912.32631510595, 45657.97147685372, 45771.31343029924, 45857.77071114623, 46900.29649555191, 62212.37787622247, 62266.68866655638, 63052.36947630465, 63457.365426345146, 63480.682596586725, 7481.70073197066, 7857.174996625501, 7926.603669816602, 8303.0, 8920.464772113693, 9331.626734930798, 12909.483620655445, 13637.386317615532, 13718.24549649739, 14036.157830530201, 12465.937670311952, 12486.438110284877, 12495.93752031234, 12880.0, 12962.611121666365, 11849.585264515701, 12091.818622720843, 12450.25298482094, 12628.305443200712, 12905.0, 11755.471003804678, 12037.939810300892, 12041.33772642513, 12244.387780610756, 12455.875441245835, 7897.605119743875, 7942.672122680661, 8226.095129535626, 8248.711295104642, 8256.298214651822, 11449.942750286194, 12457.688557786129, 12581.811272831097, 12687.04847136487, 12888.0], "value": 9355.008365886959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.5340657473168, 1484.5026915983149, 1503.2183264702355, 1659.3030927010661, 1831.9084045797706, 8445.408821382505, 8850.77873053174, 8888.06675299094, 9061.728148155566, 9134.314926380532, 8865.379423440361, 9057.049009853969, 9076.183143517082, 9080.772980675487, 9081.636734530612, 1953.9902300488477, 2111.9366419007456, 2164.93505194844, 2179.6403593407067, 2200.2959053103014, 2241.3051953894264, 2249.887505624712, 2250.729912410513, 2252.245497758253, 2252.6395776675736, 2174.152080688533, 2180.6728990651372, 2207.061998650567, 2208.2602328219987, 2210.049678638193, 1859.6652602531606, 2062.391594479632, 2104.0, 2108.3780284816016, 2108.947276318089, 2138.6257404954226, 2142.1110239250693, 2144.5603651251454, 2153.6661817418326, 2155.902984365707, 9129.497877616728, 9171.954140229323, 9178.908210917938, 9186.219171370441, 9193.402428842104, 5175.45657705943, 5299.49654782795, 5302.814401495968, 5306.575473962073, 5310.362756469249, 3323.551320571716, 3394.389009978203, 3495.24852156785, 3524.1542029912894, 3527.417976033951, 1178.1458442629112, 1181.5982565927625, 2167.1223154622403, 2222.6666000099954, 2274.294968559752, 12802.743945121045, 12839.037072219528, 12963.611091667264, 12964.935175324157, 12969.221846689134, 4226.5139508956245, 4333.220020396359, 4464.799084041226, 4469.10617876426, 4503.572160644733, 9870.111689947938, 9971.501424928725, 9996.650117245861, 9996.850047249298, 9997.350172238781, 5253.737313134405, 5260.71066091361, 5264.52619264268, 5265.368155821249, 5268.262443257947, 4337.848175313912, 4656.3713898623255, 4767.284907263869, 4797.856064318076, 4864.854054378375, 3667.1932174921476, 3669.688076513526, 3722.758020728644, 3766.453864189677, 3790.6019867914024, 966.0532677975623, 1011.2567263061644, 1049.4018409506662, 1064.6167379743285, 1073.2969904712427, 847.4237518487364, 865.2083343740533, 871.8692196170625, 878.9384743068051, 902.2060586683807, 5792.536597072224, 5807.709614519257, 5877.206577112035, 5928.525717942554, 6007.8878394978765, 912.333996182777, 932.5057719408588, 962.2727204667639, 962.5812771444444, 973.2068364283086, 4116.629503344713, 4137.379393091061, 4152.294110001307, 4166.479190101238, 4177.624013838769, 11303.0, 11545.826812597817, 11608.0, 11669.0, 11731.23746956445, 11476.254043487146, 11592.88407115935, 11597.072234221241, 11608.129390295762, 11610.70973225676, 7982.880256796153, 8278.875816862752, 8307.501549907025, 8348.457350272334, 8420.031696354876, 5879.2944846618675, 6120.143179954721, 6287.119803227461, 6289.622622642473, 6369.044643303356, 10256.28206025601, 10714.196435267542, 10743.623973160902, 10746.140308775122, 10932.672019839418, 10807.837882431613, 10813.243072984815, 10872.402017889091, 10946.616868409568, 10947.34315941046, 7961.960190199244, 8033.959830200812, 8157.6329065193395, 8159.46963447374, 8163.959180204061, 8806.031336552845, 8816.382853200214, 8847.911520884967, 8848.513331766557, 8854.114588541095, 7025.712092360157, 7726.5380240655395, 7782.299593036654, 8131.024277086787, 8213.671453141807, 7891.960540197492, 7904.960475197588, 7920.0, 7996.24035716606, 8168.183181681784, 6730.495212859153, 6754.527183097136, 6796.694148763417, 6803.353681400259, 6813.1142951415995, 4831.758412079453, 4886.828960986349, 4911.165101932608, 5117.155669314521, 5351.090314646442, 4987.251912213197, 5179.715115668524, 5189.325387699575, 5307.124324486416, 5330.493603107699], "value": 4663.819456797434, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.31246320704815, 313.1326226353002, 315.0, 320.9534617480466, 326.3098546573994, 5344.808628462331, 5345.973270133653, 5351.384590772062, 5370.3287089113865, 5384.6499977501435, 5079.974600127003, 5162.277281180638, 5214.895702085956, 5228.163493840977, 5287.444818294071, 4018.7990600470007, 4066.2274167908076, 4166.291730405823, 4174.874753757392, 4197.4753155855515, 4092.953523238381, 4135.7518548887165, 4140.979295103521, 4153.376993450976, 4158.6465150462245, 4026.3356546169994, 4139.81370838313, 4145.502539695241, 4155.314373128445, 4169.353750168729, 4130.235906357303, 4132.669386449077, 4143.627073563363, 4160.958390416103, 4175.916481670365, 3680.2271522980204, 3683.7421380503374, 3685.1155722626377, 3690.409534474471, 3696.9260614787554, 5030.798768049311, 5148.588112950955, 5231.790728370861, 5239.240310155044, 5239.423663397023, 4631.397918270603, 4686.906261874743, 4727.267273572602, 4733.692309999839, 4742.312364707098, 5481.205225242317, 5487.79268560916, 5502.257195278667, 5518.061929471999, 5526.4802179400585, 3894.240623078501, 3969.9082752243075, 3971.6028397160344, 3992.960070399317, 3998.280309544281, 5661.264035675335, 5681.608006038506, 5727.594410347622, 5729.398413166599, 5735.4551317624755, 4062.695297852673, 4068.5117785865295, 4087.8773636790943, 4127.4015267786, 4139.689523285766, 4090.897727556835, 4179.665626749853, 4184.539700632928, 4187.288161012635, 4191.3293872980175, 4661.114388266286, 4680.3447517347595, 4698.248280275208, 4698.483166851644, 4710.034442939189, 5497.202905578669, 5523.143912693539, 5533.6403133796175, 5553.583481238923, 5571.359293681278, 1377.3388773388829, 1391.7912313153108, 1421.3106643278002, 1433.677422579932, 1448.6088756036022, 962.4658314635444, 986.7631768375538, 1000.8598796168542, 1001.737810358953, 1013.807376598444, 5281.498257665516, 5305.045091883498, 5318.813841515605, 5329.8401047967845, 5351.046867893268, 5550.057479882009, 5587.7485513152005, 5593.244911936918, 5627.099664053731, 5642.0, 5174.723121826384, 5349.170878513836, 5356.437574054668, 5358.4373640767935, 5359.330083739533, 2646.5103955768245, 2677.8527181004843, 2685.23470810818, 2694.8248363856287, 2698.338906967766, 5079.450767515869, 5171.301874247004, 5171.560417364491, 5188.273641690166, 5188.558972487305, 4845.380345415189, 5009.949900501021, 5093.337866077386, 5097.770600322994, 5098.617603679739, 5073.8731531712, 5078.339815823919, 5135.768890399941, 5140.537351638371, 5141.820036298712, 4994.775235114356, 5029.692280007152, 5031.6917601423165, 5082.898342033212, 5086.456771614193, 4806.279058141306, 4837.298591704112, 4894.1679914415345, 4964.553190212898, 4980.207125434768, 5123.077845987758, 5138.537531622172, 5141.434442211279, 5162.328897243335, 5175.275461435327, 3719.590845007101, 3758.661720445173, 3765.7740535567955, 3774.9245015100096, 3794.734368594172, 4800.271902115305, 5019.422766381766, 5024.29659847629, 5101.51535604117, 5447.455254474521, 5457.836264912059, 5558.277423935025, 5584.944150558605, 5586.972065139648, 5613.494785469327, 5481.040817856939, 5511.200875872896, 5582.218489411567, 5598.888022239451, 5612.915806262991, 5317.494837990384, 5563.916541251803, 5575.860603484945, 5646.265985422033, 5648.672561947857, 5648.378678345297, 5666.518345940476, 5667.121596152603, 5678.716064196857, 5683.8010669626365, 5485.75314110858, 5564.860878478071, 5587.44125587438, 5608.887822243614, 5633.6619802811965], "value": 4117.245652100214, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.3137254901961, 819.9795005124872, 828.44080245834, 839.9370047246458, 877.5085951866955, 15546.45587404441, 16941.237644306006, 17289.394871179513, 17394.565135871577, 17460.0, 16847.663046739057, 16891.49325520233, 16955.152242387892, 17009.319627214896, 17046.659066818655, 662.7117204016245, 783.7922950418143, 800.1558355934487, 801.9077806052305, 821.5645707774859, 821.6795449774593, 822.9670813167467, 827.0158511371479, 828.6395417993192, 829.4567058576642, 853.3301358433631, 855.2431098477861, 857.4555157475017, 857.5712143928037, 858.0261403307229, 691.2120182991393, 845.0704225352125, 855.6534603485567, 873.244643383475, 876.9649214031431, 624.3756243756244, 624.4754406298686, 624.8843963866653, 626.1077963901467, 626.7461678020409, 14223.573292801233, 14434.13395196281, 14505.0, 14548.127112373291, 14577.927110364486, 14699.11805291686, 14762.114273143538, 14777.261136943218, 15222.391104355924, 15614.45349412765, 12706.966147445562, 12943.611691649265, 13092.47630094795, 13111.934440327832, 13118.540851070262, 4006.198760247933, 4018.9397159042637, 4092.5907409259135, 4102.610252026053, 4113.136241389312, 80142.0, 80932.59533702294, 81189.0, 81289.18710812935, 81776.59111704463, 12129.818052729217, 12212.32832194238, 12290.385480725929, 12419.379031048411, 12437.502499900083, 22976.0, 22982.195623153442, 23006.654900176512, 23013.7698623015, 23017.769822301896, 8888.466691998501, 9036.367454278137, 9074.137956894085, 9167.17495425415, 9309.813803723888, 4908.9754551227015, 4997.075541024922, 5034.496550344937, 5055.772490237948, 5191.792328306901, 3427.7771944824003, 3553.3248682750195, 3553.7690050146657, 3557.3774589446743, 3813.3517302058717, 666.9899951500731, 677.7864972533636, 686.7081490366575, 695.4297476069676, 698.2110215456502, 630.0328994992665, 725.3906718356606, 730.0545793197822, 746.1493896957364, 797.3899966525613, 10368.222383321281, 10606.204534659932, 10757.30077544957, 10805.13558915285, 10969.780604387868, 668.8595394967014, 718.4862823081418, 754.8754455514778, 766.3945483068425, 771.7194502983024, 4847.394075740533, 4989.401271847329, 5033.6476446648385, 5087.465816089331, 5130.127878260705, 69370.0, 123253.0, 123602.0, 131966.76065583585, 132966.0, 108546.0, 108899.0, 108922.45538772256, 109000.45499772609, 110142.0, 61308.0, 86633.0, 96308.0, 98084.50957745308, 100486.96591238689, 9530.285228607743, 9564.61741530331, 9659.951700241454, 9685.564149613425, 9695.224382049279, 45782.771086144356, 56987.0, 57072.0, 57355.42644573668, 59433.622655095045, 50041.49958500369, 62200.68899655473, 65034.67482662746, 70733.64633176802, 72890.0, 14036.929815350857, 14197.290135492978, 14470.0, 14513.274336282933, 14539.709205815612, 14573.781393279321, 15328.693426131638, 15349.462768803038, 15644.296006679955, 16090.517284481484, 14096.224707641179, 14193.574192774233, 14405.855941440452, 14459.927700361852, 14937.701245975237, 14764.335604897591, 14848.0, 15150.0, 15404.38382464689, 16107.67784644324, 14783.260836957894, 15117.54647360581, 15527.301271442586, 16004.439844605384, 16016.878818482593, 11867.525298987945, 12046.127782676378, 12098.395080245777, 12267.520753512246, 12379.133460657667, 11482.94258528702, 11926.284422934652, 12110.818337724764, 12590.0, 12695.746085078063], "value": 7939.228688069778, "unit": "score"}], "name": "dromaeo_css", "value": 7342.6870298316335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 109.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 120.0, 120.0, 171.0, 118.0, 124.0, 142.0, 118.0, 154.0, 117.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 118.0, 75.0, 76.0, 75.0, 74.0, 105.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 84.0, 85.0, 84.0, 118.0, 84.0, 83.0, 126.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.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, 94.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 55.0, 53.0, 54.0, 54.0, 54.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 59.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 78.0, 75.0, 74.0, 77.0, 80.0, 80.0, 74.0, 82.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 114.0, 125.0, 118.0, 120.0, 120.0, 125.0, 133.0, 158.0, 121.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 158.0, 163.0, 162.0, 162.0, 158.0, 158.0, 157.0, 156.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 64.0, 63.0, 62.0, 66.0, 69.0, 61.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1476.9000000000003, "alertThreshold": 2.0}]} 20:28:29 INFO - Return code: 0 20:28:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:28:29 INFO - # TBPL SUCCESS # 20:28:29 INFO - Running post-action listener: _resource_record_post_action 20:28:29 INFO - ##### 20:28:29 INFO - ##### Finished run-tests step (success) 20:28:29 INFO - ##### 20:28:29 INFO - Running post-run listener: _resource_record_post_run 20:28:29 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 572968960; Read time: 120; Write time: 444424 20:28:29 INFO - TinderboxPrint: CPU usage
13.0% 20:28:29 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 120 20:28:29 INFO - TinderboxPrint: I/O write bytes / time
572,968,960 / 444,424 20:28:29 INFO - TinderboxPrint: CPU idle
8,262.7 (87.0%) 20:28:29 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 20:28:29 INFO - TinderboxPrint: Swap in / out
0 / 0 20:28:29 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 274821120; Read time: 0; Write time: 265484 20:28:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297697280; Read time: 108; Write time: 178912 20:28:29 INFO - Running post-run listener: _upload_blobber_files 20:28:29 INFO - Blob upload gear active. 20:28:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:28:29 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 20:28:29 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'] 20:28:29 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 20:28:30 INFO - (blobuploader) - INFO - Open directory for files ... 20:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:28:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:30 INFO - (blobuploader) - INFO - Done attempting. 20:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:34 INFO - (blobuploader) - INFO - Done attempting. 20:28:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:28:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:35 INFO - (blobuploader) - INFO - Done attempting. 20:28:35 INFO - (blobuploader) - INFO - Iteration through files over. 20:28:35 INFO - Return code: 0 20:28:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:28:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:28:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dea6862fe9477abf05c2d2533c9501087172c3e8ede6508956f8ee9f41c5044bffdb2aab885368175a7c9c7b9b284f609518cd09adcafb4e288b26d8d364c0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6dfab61e907cc42e7b6a831c74bf65fa71c1c48ab230cc1b9419b27533dc18fc6af36f8c5ba15800421ba6e5ba50efe056794e74833e8aa3ce35084dfbb81f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/214f20031a316d0991afc68d09fa022b0e89ebb9864fe1cc05cee67cfd1a705b947d3497291efe85be9e7c7ef53a2853bb69e8f24a396f53fbabd7ff2fce2638"} 20:28:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:28:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:28:35 INFO - Contents: 20:28:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dea6862fe9477abf05c2d2533c9501087172c3e8ede6508956f8ee9f41c5044bffdb2aab885368175a7c9c7b9b284f609518cd09adcafb4e288b26d8d364c0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6dfab61e907cc42e7b6a831c74bf65fa71c1c48ab230cc1b9419b27533dc18fc6af36f8c5ba15800421ba6e5ba50efe056794e74833e8aa3ce35084dfbb81f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/214f20031a316d0991afc68d09fa022b0e89ebb9864fe1cc05cee67cfd1a705b947d3497291efe85be9e7c7ef53a2853bb69e8f24a396f53fbabd7ff2fce2638"} 20:28:35 INFO - Running post-run listener: copy_logs_to_upload_dir 20:28:35 INFO - Copying logs to upload dir... 20:28:35 INFO - mkdir: /builds/slave/test/build/upload/logs 20:28:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.409253 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-12 20:28:34.990894) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 20:28:34.995972) ========= 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=ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195 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/dea6862fe9477abf05c2d2533c9501087172c3e8ede6508956f8ee9f41c5044bffdb2aab885368175a7c9c7b9b284f609518cd09adcafb4e288b26d8d364c0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6dfab61e907cc42e7b6a831c74bf65fa71c1c48ab230cc1b9419b27533dc18fc6af36f8c5ba15800421ba6e5ba50efe056794e74833e8aa3ce35084dfbb81f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/214f20031a316d0991afc68d09fa022b0e89ebb9864fe1cc05cee67cfd1a705b947d3497291efe85be9e7c7ef53a2853bb69e8f24a396f53fbabd7ff2fce2638"} build_url:https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/RSGi3coKSlGGB_WMpCsSxA/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/dea6862fe9477abf05c2d2533c9501087172c3e8ede6508956f8ee9f41c5044bffdb2aab885368175a7c9c7b9b284f609518cd09adcafb4e288b26d8d364c0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6dfab61e907cc42e7b6a831c74bf65fa71c1c48ab230cc1b9419b27533dc18fc6af36f8c5ba15800421ba6e5ba50efe056794e74833e8aa3ce35084dfbb81f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/214f20031a316d0991afc68d09fa022b0e89ebb9864fe1cc05cee67cfd1a705b947d3497291efe85be9e7c7ef53a2853bb69e8f24a396f53fbabd7ff2fce2638"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 20:28:35.021214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:28:35.021584) ========= 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=ed14279e38b05397cf4aa391000001a4-1468378353.747635-398690195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 20:28:35.106306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 20:28:35.106632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 20:28:35.106951) ========= ========= Total master_lag: 0.19 =========