builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1471905905.02 results: success (0) buildid: 20160822123001 builduid: ee5b62e9370140eb8db74ced8d276fdf revision: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.020463) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.020952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.021232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.036766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.037167) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 15:45:05-- 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% 36.7M=0s 2016-08-22 15:45:05 (36.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.171770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.172309) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019297 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.224249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.224852) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 279f5c243c49c8e955faf3b667e2fef92cfefbf0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 279f5c243c49c8e955faf3b667e2fef92cfefbf0 --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=9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 15:45:05,978 truncating revision to first 12 chars 2016-08-22 15:45:05,978 Setting DEBUG logging. 2016-08-22 15:45:05,978 attempt 1/10 2016-08-22 15:45:05,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/279f5c243c49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 15:45:06,250 unpacking tar archive at: autoland-279f5c243c49/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.831872) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.832205) ========= script_repo_revision: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.832599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.832882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 15:45:05.842389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-22 15:45:05.842787) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:45:06 INFO - MultiFileLogger online at 20160822 15:45:06 in /builds/slave/test 15:45:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:45:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:45:06 INFO - {'append_to_log': False, 15:45:06 INFO - 'base_work_dir': '/builds/slave/test', 15:45:06 INFO - 'blob_upload_branch': 'Autoland', 15:45:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:45:06 INFO - 'branch': 'Autoland', 15:45:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:45:06 INFO - 'config_files': ('talos/linux_config.py',), 15:45:06 INFO - 'default_actions': ('clobber', 15:45:06 INFO - 'read-buildbot-config', 15:45:06 INFO - 'download-and-extract', 15:45:06 INFO - 'populate-webroot', 15:45:06 INFO - 'create-virtualenv', 15:45:06 INFO - 'install', 15:45:06 INFO - 'run-tests'), 15:45:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:45:06 INFO - 'download_minidump_stackwalk': True, 15:45:06 INFO - 'download_symbols': 'ondemand', 15:45:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:45:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:45:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:45:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:45:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:45:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:45:06 INFO - 'installer_path': 'installer.exe', 15:45:06 INFO - 'log_level': 'info', 15:45:06 INFO - 'log_name': 'talos', 15:45:06 INFO - 'log_to_console': True, 15:45:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:45:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:45:06 INFO - 'opt_config_files': (), 15:45:06 INFO - 'pip_index': False, 15:45:06 INFO - 'sps_profile': False, 15:45:06 INFO - 'sps_profile_interval': 0, 15:45:06 INFO - 'suite': 'dromaeojs', 15:45:06 INFO - 'system_bits': '32', 15:45:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:45:06 INFO - 'title': 'talos-linux64-ix-013', 15:45:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:45:06 INFO - 'use_talos_json': True, 15:45:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:45:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:45:06 INFO - 'work_dir': 'build'} 15:45:06 INFO - [mozharness: 2016-08-22 22:45:06.697773Z] Running clobber step. 15:45:06 INFO - Running pre-action listener: _resource_record_pre_action 15:45:06 INFO - Running main action method: clobber 15:45:06 INFO - rmtree: /builds/slave/test/build 15:45:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:45:07 INFO - Running post-action listener: _resource_record_post_action 15:45:07 INFO - [mozharness: 2016-08-22 22:45:07.157431Z] Finished clobber step (success) 15:45:07 INFO - [mozharness: 2016-08-22 22:45:07.157531Z] Running read-buildbot-config step. 15:45:07 INFO - Running pre-action listener: _resource_record_pre_action 15:45:07 INFO - Running main action method: read_buildbot_config 15:45:07 INFO - Using buildbot properties: 15:45:07 INFO - { 15:45:07 INFO - "project": "", 15:45:07 INFO - "product": "firefox", 15:45:07 INFO - "script_repo_revision": "production", 15:45:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:45:07 INFO - "repository": "", 15:45:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 15:45:07 INFO - "buildid": "20160822123001", 15:45:07 INFO - "pgo_build": "True", 15:45:07 INFO - "basedir": "/builds/slave/test", 15:45:07 INFO - "buildnumber": 115, 15:45:07 INFO - "slavename": "talos-linux64-ix-013", 15:45:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:45:07 INFO - "platform": "ubuntu64_hw", 15:45:07 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:45:07 INFO - "branch": "autoland", 15:45:07 INFO - "repo_path": "integration/autoland", 15:45:07 INFO - "revision": "279f5c243c49c8e955faf3b667e2fef92cfefbf0", 15:45:07 INFO - "stage_platform": "linux64-pgo", 15:45:07 INFO - "builduid": "ee5b62e9370140eb8db74ced8d276fdf", 15:45:07 INFO - "slavebuilddir": "test" 15:45:07 INFO - } 15:45:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:45:07 INFO - Running post-action listener: _resource_record_post_action 15:45:07 INFO - [mozharness: 2016-08-22 22:45:07.159956Z] Finished read-buildbot-config step (success) 15:45:07 INFO - [mozharness: 2016-08-22 22:45:07.160045Z] Running download-and-extract step. 15:45:07 INFO - Running pre-action listener: _resource_record_pre_action 15:45:07 INFO - Running main action method: download_and_extract 15:45:07 INFO - mkdir: /builds/slave/test/build/tests 15:45:07 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:07 INFO - trying https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:45:07 INFO - Downloading https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:45:07 INFO - Downloaded 1361 bytes. 15:45:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:45:07 INFO - Using the following test package requirements: 15:45:07 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:07 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:45:07 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:45:07 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'jsshell-linux-x86_64.zip'], 15:45:07 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:45:07 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:07 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:45:07 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:45:07 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:45:07 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:45:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:45:07 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:07 INFO - trying https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:45:07 INFO - Downloading https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:45:08 INFO - Downloaded 21921235 bytes. 15:45:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:45:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:12 INFO - trying https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:45:12 INFO - Downloading https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:45:13 INFO - Downloaded 21921235 bytes. 15:45:13 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:45:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:18 INFO - trying https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:18 INFO - Downloading https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:45:19 INFO - Downloaded 14413981 bytes. 15:45:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 15:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:19 INFO - trying https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:45:19 INFO - Downloading https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:45:20 INFO - Downloaded 59687338 bytes. 15:45:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:45:20 INFO - mkdir: /builds/slave/test/properties 15:45:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:45:20 INFO - Writing to file /builds/slave/test/properties/build_url 15:45:20 INFO - Contents: 15:45:20 INFO - build_url:https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:45:21 INFO - Running post-action listener: _resource_record_post_action 15:45:21 INFO - Running post-action listener: set_extra_try_arguments 15:45:21 INFO - [mozharness: 2016-08-22 22:45:21.247437Z] Finished download-and-extract step (success) 15:45:21 INFO - [mozharness: 2016-08-22 22:45:21.247659Z] Running populate-webroot step. 15:45:21 INFO - Running pre-action listener: _resource_record_pre_action 15:45:21 INFO - Running main action method: populate_webroot 15:45:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:45:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:45:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:45:21 INFO - '--tppagecycles', 15:45:21 INFO - '7'], 15:45:21 INFO - 'tests': ['tsvgm']}}, 15:45:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:45:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:45:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:45:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:45:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['damp', 'tps']}, 15:45:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'tests': ['damp', 'tps']}, 15:45:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['dromaeo_dom']}, 15:45:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:45:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['basic_compositor_video']}, 15:45:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:45:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['a11yr', 15:45:21 INFO - 'ts_paint', 15:45:21 INFO - 'tpaint', 15:45:21 INFO - 'sessionrestore', 15:45:21 INFO - 'sessionrestore_no_auto_restore', 15:45:21 INFO - 'tabpaint']}, 15:45:21 INFO - 'other-e10s': {'tests': ['a11yr', 15:45:21 INFO - 'ts_paint', 15:45:21 INFO - 'tpaint', 15:45:21 INFO - 'sessionrestore', 15:45:21 INFO - 'sessionrestore_no_auto_restore', 15:45:21 INFO - 'tabpaint']}, 15:45:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:45:21 INFO - 'ts_paint', 15:45:21 INFO - 'tpaint', 15:45:21 INFO - 'sessionrestore', 15:45:21 INFO - 'sessionrestore_no_auto_restore', 15:45:21 INFO - 'tabpaint']}, 15:45:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:45:21 INFO - 'ts_paint', 15:45:21 INFO - 'tpaint', 15:45:21 INFO - 'sessionrestore', 15:45:21 INFO - 'sessionrestore_no_auto_restore', 15:45:21 INFO - 'tabpaint']}, 15:45:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['a11yr', 15:45:21 INFO - 'ts_paint', 15:45:21 INFO - 'tpaint', 15:45:21 INFO - 'sessionrestore', 15:45:21 INFO - 'sessionrestore_no_auto_restore', 15:45:21 INFO - 'tabpaint']}, 15:45:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['a11yr', 15:45:21 INFO - 'ts_paint', 15:45:21 INFO - 'tpaint', 15:45:21 INFO - 'sessionrestore', 15:45:21 INFO - 'sessionrestore_no_auto_restore', 15:45:21 INFO - 'tabpaint']}, 15:45:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['tsvgx', 15:45:21 INFO - 'tsvgr_opacity', 15:45:21 INFO - 'tart', 15:45:21 INFO - 'tscrollx', 15:45:21 INFO - 'cart']}, 15:45:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:45:21 INFO - 'tsvgr_opacity', 15:45:21 INFO - 'tart', 15:45:21 INFO - 'tscrollx', 15:45:21 INFO - 'cart']}, 15:45:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'talos_options': ['--disable-e10s'], 15:45:21 INFO - 'tests': ['tp5o']}, 15:45:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'tests': ['tp5o']}, 15:45:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'talos_options': ['--disable-e10s', 15:45:21 INFO - '--xperf_path', 15:45:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:21 INFO - 'tests': ['tp5n']}, 15:45:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:21 INFO - 'talos_options': ['--xperf_path', 15:45:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:21 INFO - 'tests': ['tp5n']}}, 15:45:21 INFO - 'talos.zip': {'path': '', 15:45:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:45:21 INFO - Running post-action listener: _resource_record_post_action 15:45:21 INFO - [mozharness: 2016-08-22 22:45:21.264266Z] Finished populate-webroot step (success) 15:45:21 INFO - [mozharness: 2016-08-22 22:45:21.264354Z] Running create-virtualenv step. 15:45:21 INFO - Running pre-action listener: _resource_record_pre_action 15:45:21 INFO - Running main action method: create_virtualenv 15:45:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:45:21 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 15:45:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:45:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:45:21 INFO - Using real prefix '/usr' 15:45:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:45:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:45:23 INFO - Installing pip.................done. 15:45:23 INFO - Return code: 0 15:45:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:45:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:23 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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:23 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 15:45:23 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 15:45:23 INFO - Using env: {'DISPLAY': ':0', 15:45:23 INFO - 'HOME': '/home/cltbld', 15:45:23 INFO - 'LANG': 'en_US.UTF-8', 15:45:23 INFO - 'LANGUAGE': 'en_US:en', 15:45:23 INFO - 'LOGNAME': 'cltbld', 15:45:23 INFO - 'MAIL': '/var/mail/cltbld', 15:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:23 INFO - 'MOZ_NO_REMOTE': '1', 15:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:23 INFO - 'NO_EM_RESTART': '1', 15:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:23 INFO - 'PWD': '/builds/slave/test', 15:45:23 INFO - 'SHELL': '/bin/bash', 15:45:23 INFO - 'SHLVL': '1', 15:45:23 INFO - 'TERM': 'linux', 15:45:23 INFO - 'TMOUT': '86400', 15:45:23 INFO - 'USER': 'cltbld', 15:45:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:23 INFO - '_': '/tools/buildbot/bin/python'} 15:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:24 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 15:45:24 INFO - Cleaning up... 15:45:24 INFO - Return code: 0 15:45:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45: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', '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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:45: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 psutil>=3.1.1 15:45:24 INFO - Using env: {'DISPLAY': ':0', 15:45:24 INFO - 'HOME': '/home/cltbld', 15:45:24 INFO - 'LANG': 'en_US.UTF-8', 15:45:24 INFO - 'LANGUAGE': 'en_US:en', 15:45:24 INFO - 'LOGNAME': 'cltbld', 15:45:24 INFO - 'MAIL': '/var/mail/cltbld', 15:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:24 INFO - 'MOZ_NO_REMOTE': '1', 15:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:24 INFO - 'NO_EM_RESTART': '1', 15:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:24 INFO - 'PWD': '/builds/slave/test', 15:45:24 INFO - 'SHELL': '/bin/bash', 15:45:24 INFO - 'SHLVL': '1', 15:45:24 INFO - 'TERM': 'linux', 15:45:24 INFO - 'TMOUT': '86400', 15:45:24 INFO - 'USER': 'cltbld', 15:45:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:24 INFO - '_': '/tools/buildbot/bin/python'} 15:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:24 INFO - Downloading/unpacking psutil>=3.1.1 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:26 INFO - Installing collected packages: psutil 15:45:26 INFO - Running setup.py install for psutil 15:45:26 INFO - building 'psutil._psutil_linux' extension 15:45:26 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 15:45:26 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 15:45:26 INFO - building 'psutil._psutil_posix' extension 15:45:26 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 15:45:26 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 15:45:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:26 INFO - Successfully installed psutil 15:45:26 INFO - Cleaning up... 15:45:26 INFO - Return code: 0 15:45:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:26 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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:26 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 15:45:26 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 15:45:26 INFO - Using env: {'DISPLAY': ':0', 15:45:26 INFO - 'HOME': '/home/cltbld', 15:45:26 INFO - 'LANG': 'en_US.UTF-8', 15:45:26 INFO - 'LANGUAGE': 'en_US:en', 15:45:26 INFO - 'LOGNAME': 'cltbld', 15:45:26 INFO - 'MAIL': '/var/mail/cltbld', 15:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:26 INFO - 'MOZ_NO_REMOTE': '1', 15:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:26 INFO - 'NO_EM_RESTART': '1', 15:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:26 INFO - 'PWD': '/builds/slave/test', 15:45:26 INFO - 'SHELL': '/bin/bash', 15:45:26 INFO - 'SHLVL': '1', 15:45:26 INFO - 'TERM': 'linux', 15:45:26 INFO - 'TMOUT': '86400', 15:45:26 INFO - 'USER': 'cltbld', 15:45:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:26 INFO - '_': '/tools/buildbot/bin/python'} 15:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:45:28 INFO - Installing collected packages: mozsystemmonitor 15:45:28 INFO - Running setup.py install for mozsystemmonitor 15:45:29 INFO - Successfully installed mozsystemmonitor 15:45:29 INFO - Cleaning up... 15:45:29 INFO - Return code: 0 15:45:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:29 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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:29 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 15:45:29 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 15:45:29 INFO - Using env: {'DISPLAY': ':0', 15:45:29 INFO - 'HOME': '/home/cltbld', 15:45:29 INFO - 'LANG': 'en_US.UTF-8', 15:45:29 INFO - 'LANGUAGE': 'en_US:en', 15:45:29 INFO - 'LOGNAME': 'cltbld', 15:45:29 INFO - 'MAIL': '/var/mail/cltbld', 15:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:29 INFO - 'MOZ_NO_REMOTE': '1', 15:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:29 INFO - 'NO_EM_RESTART': '1', 15:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:29 INFO - 'PWD': '/builds/slave/test', 15:45:29 INFO - 'SHELL': '/bin/bash', 15:45:29 INFO - 'SHLVL': '1', 15:45:29 INFO - 'TERM': 'linux', 15:45:29 INFO - 'TMOUT': '86400', 15:45:29 INFO - 'USER': 'cltbld', 15:45:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:29 INFO - '_': '/tools/buildbot/bin/python'} 15:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:29 INFO - Downloading/unpacking jsonschema==2.5.1 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:45:31 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 15:45:31 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 15:45:31 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 15:45:31 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 15:45:31 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 15:45:31 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 15:45:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:31 INFO - warning: no files found matching '*.txt' 15:45:31 INFO - no previously-included directories found matching 'build' 15:45:31 INFO - no previously-included directories found matching 'dist' 15:45:31 INFO - no previously-included directories found matching '.git*' 15:45:31 INFO - Installing collected packages: jsonschema, functools32 15:45:31 INFO - Running setup.py install for functools32 15:45:31 INFO - warning: no files found matching '*.txt' 15:45:31 INFO - no previously-included directories found matching 'build' 15:45:31 INFO - no previously-included directories found matching 'dist' 15:45:31 INFO - no previously-included directories found matching '.git*' 15:45:31 INFO - Successfully installed jsonschema functools32 15:45:31 INFO - Cleaning up... 15:45:31 INFO - Return code: 0 15:45:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:45:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:31 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:45:31 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 functools32==3.2.3-2 15:45:31 INFO - Using env: {'DISPLAY': ':0', 15:45:31 INFO - 'HOME': '/home/cltbld', 15:45:31 INFO - 'LANG': 'en_US.UTF-8', 15:45:31 INFO - 'LANGUAGE': 'en_US:en', 15:45:31 INFO - 'LOGNAME': 'cltbld', 15:45:31 INFO - 'MAIL': '/var/mail/cltbld', 15:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:31 INFO - 'MOZ_NO_REMOTE': '1', 15:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:31 INFO - 'NO_EM_RESTART': '1', 15:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:31 INFO - 'PWD': '/builds/slave/test', 15:45:31 INFO - 'SHELL': '/bin/bash', 15:45:31 INFO - 'SHLVL': '1', 15:45:31 INFO - 'TERM': 'linux', 15:45:31 INFO - 'TMOUT': '86400', 15:45:31 INFO - 'USER': 'cltbld', 15:45:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:31 INFO - '_': '/tools/buildbot/bin/python'} 15:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:45:31 INFO - Cleaning up... 15:45:31 INFO - Return code: 0 15:45:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:45:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:31 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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:31 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 15:45:31 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 15:45:31 INFO - Using env: {'DISPLAY': ':0', 15:45:31 INFO - 'HOME': '/home/cltbld', 15:45:31 INFO - 'LANG': 'en_US.UTF-8', 15:45:31 INFO - 'LANGUAGE': 'en_US:en', 15:45:31 INFO - 'LOGNAME': 'cltbld', 15:45:31 INFO - 'MAIL': '/var/mail/cltbld', 15:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:31 INFO - 'MOZ_NO_REMOTE': '1', 15:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:31 INFO - 'NO_EM_RESTART': '1', 15:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:31 INFO - 'PWD': '/builds/slave/test', 15:45:31 INFO - 'SHELL': '/bin/bash', 15:45:31 INFO - 'SHLVL': '1', 15:45:31 INFO - 'TERM': 'linux', 15:45:31 INFO - 'TMOUT': '86400', 15:45:31 INFO - 'USER': 'cltbld', 15:45:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:31 INFO - '_': '/tools/buildbot/bin/python'} 15:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:32 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 15:45:32 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 15:45:32 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 15:45:32 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 15:45:32 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 15:45:32 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 15:45:33 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:45:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:34 INFO - Downloading docopt-0.6.1.tar.gz 15:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:34 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:34 INFO - Running setup.py install for blobuploader 15:45:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:45:34 INFO - Running setup.py install for requests 15:45:35 INFO - Running setup.py install for docopt 15:45:35 INFO - Successfully installed blobuploader requests docopt 15:45:35 INFO - Cleaning up... 15:45:35 INFO - Return code: 0 15:45:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:35 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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:35 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 15:45:35 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 15:45:35 INFO - Using env: {'DISPLAY': ':0', 15:45:35 INFO - 'HOME': '/home/cltbld', 15:45:35 INFO - 'LANG': 'en_US.UTF-8', 15:45:35 INFO - 'LANGUAGE': 'en_US:en', 15:45:35 INFO - 'LOGNAME': 'cltbld', 15:45:35 INFO - 'MAIL': '/var/mail/cltbld', 15:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:35 INFO - 'MOZ_NO_REMOTE': '1', 15:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:35 INFO - 'NO_EM_RESTART': '1', 15:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:35 INFO - 'PWD': '/builds/slave/test', 15:45:35 INFO - 'SHELL': '/bin/bash', 15:45:35 INFO - 'SHLVL': '1', 15:45:35 INFO - 'TERM': 'linux', 15:45:35 INFO - 'TMOUT': '86400', 15:45:35 INFO - 'USER': 'cltbld', 15:45:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:35 INFO - '_': '/tools/buildbot/bin/python'} 15:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:35 INFO - Running setup.py (path:/tmp/pip-DHt0ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:35 INFO - Running setup.py (path:/tmp/pip-T7HtKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:35 INFO - Running setup.py (path:/tmp/pip-kNzBNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:35 INFO - Running setup.py (path:/tmp/pip-bCAwcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:35 INFO - Running setup.py (path:/tmp/pip-oChzM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:35 INFO - Running setup.py (path:/tmp/pip-HwT0dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:36 INFO - Running setup.py (path:/tmp/pip-Z7Dj_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:36 INFO - Running setup.py (path:/tmp/pip-50Rrsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:36 INFO - Running setup.py (path:/tmp/pip-1KozqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:36 INFO - Running setup.py (path:/tmp/pip-daeSTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:36 INFO - Running setup.py (path:/tmp/pip-H3oSbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:36 INFO - Running setup.py (path:/tmp/pip-fWpHfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:36 INFO - Running setup.py (path:/tmp/pip-BlBsL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:36 INFO - Running setup.py (path:/tmp/pip-nVfdlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:36 INFO - Running setup.py (path:/tmp/pip-t3PBKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:36 INFO - Running setup.py (path:/tmp/pip-NwoeJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:36 INFO - Running setup.py (path:/tmp/pip-j5GwJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:36 INFO - Running setup.py install for manifestparser 15:45:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:45:36 INFO - Running setup.py install for mozcrash 15:45:36 INFO - Running setup.py install for mozdebug 15:45:37 INFO - Running setup.py install for mozdevice 15:45:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Running setup.py install for mozfile 15:45:37 INFO - Running setup.py install for mozhttpd 15:45:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Running setup.py install for mozinfo 15:45:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Running setup.py install for mozInstall 15:45:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Running setup.py install for mozleak 15:45:37 INFO - Running setup.py install for mozlog 15:45:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Running setup.py install for moznetwork 15:45:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:45:37 INFO - Running setup.py install for mozprocess 15:45:38 INFO - Running setup.py install for mozprofile 15:45:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:45:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:45:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:45:38 INFO - Running setup.py install for mozrunner 15:45:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:45:38 INFO - Running setup.py install for mozscreenshot 15:45:38 INFO - Running setup.py install for moztest 15:45:38 INFO - Running setup.py install for mozversion 15:45:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:45:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:38 INFO - Cleaning up... 15:45:38 INFO - Return code: 0 15:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:38 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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:38 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 15:45:38 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 15:45:38 INFO - Using env: {'DISPLAY': ':0', 15:45:38 INFO - 'HOME': '/home/cltbld', 15:45:38 INFO - 'LANG': 'en_US.UTF-8', 15:45:38 INFO - 'LANGUAGE': 'en_US:en', 15:45:38 INFO - 'LOGNAME': 'cltbld', 15:45:38 INFO - 'MAIL': '/var/mail/cltbld', 15:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:38 INFO - 'MOZ_NO_REMOTE': '1', 15:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:38 INFO - 'NO_EM_RESTART': '1', 15:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:38 INFO - 'PWD': '/builds/slave/test', 15:45:38 INFO - 'SHELL': '/bin/bash', 15:45:38 INFO - 'SHLVL': '1', 15:45:38 INFO - 'TERM': 'linux', 15:45:38 INFO - 'TMOUT': '86400', 15:45:38 INFO - 'USER': 'cltbld', 15:45:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:38 INFO - '_': '/tools/buildbot/bin/python'} 15:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:38 INFO - Running setup.py (path:/tmp/pip-3oMd63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:38 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)) 15:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:38 INFO - Running setup.py (path:/tmp/pip-xP9dyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:38 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)) 15:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:38 INFO - Running setup.py (path:/tmp/pip-Re9I8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:39 INFO - Running setup.py (path:/tmp/pip-8efeRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:39 INFO - Running setup.py (path:/tmp/pip-F1N92k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:39 INFO - Running setup.py (path:/tmp/pip-W6m5jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:39 INFO - Running setup.py (path:/tmp/pip-QWZWoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:39 INFO - Running setup.py (path:/tmp/pip-YXF09b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:39 INFO - Running setup.py (path:/tmp/pip-XQ4iVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:39 INFO - Running setup.py (path:/tmp/pip-MuAhgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:39 INFO - Running setup.py (path:/tmp/pip-TXDnMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:39 INFO - Running setup.py (path:/tmp/pip-nTYOYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:39 INFO - Running setup.py (path:/tmp/pip-eODsBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:39 INFO - Running setup.py (path:/tmp/pip-sIY0l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:39 INFO - Running setup.py (path:/tmp/pip-R9ZFkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:39 INFO - Running setup.py (path:/tmp/pip-a7iRlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:39 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)) 15:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:39 INFO - Running setup.py (path:/tmp/pip-JFrnE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:40 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)) 15:45:40 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)) 15:45:40 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)) 15:45:40 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)) 15:45:40 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)) 15:45:40 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)) 15:45:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:41 INFO - Downloading blessings-1.6.tar.gz 15:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:41 INFO - Installing collected packages: blessings 15:45:41 INFO - Running setup.py install for blessings 15:45:42 INFO - Successfully installed blessings 15:45:42 INFO - Cleaning up... 15:45:42 INFO - Return code: 0 15:45:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:42 INFO - Reading from file tmpfile_stdout 15:45:42 INFO - Current package versions: 15:45:42 INFO - argparse == 1.2.1 15:45:42 INFO - blessings == 1.6 15:45:42 INFO - blobuploader == 1.2.4 15:45:42 INFO - docopt == 0.6.1 15:45:42 INFO - functools32 == 3.2.3-2 15:45:42 INFO - jsonschema == 2.5.1 15:45:42 INFO - manifestparser == 1.1 15:45:42 INFO - mozInstall == 1.12 15:45:42 INFO - mozcrash == 0.17 15:45:42 INFO - mozdebug == 0.1 15:45:42 INFO - mozdevice == 0.48 15:45:42 INFO - mozfile == 1.2 15:45:42 INFO - mozhttpd == 0.7 15:45:42 INFO - mozinfo == 0.9 15:45:42 INFO - mozleak == 0.1 15:45:42 INFO - mozlog == 3.3 15:45:42 INFO - moznetwork == 0.27 15:45:42 INFO - mozprocess == 0.23 15:45:42 INFO - mozprofile == 0.28 15:45:42 INFO - mozrunner == 6.12 15:45:42 INFO - mozscreenshot == 0.1 15:45:42 INFO - mozsystemmonitor == 0.3 15:45:42 INFO - moztest == 0.7 15:45:42 INFO - mozversion == 1.4 15:45:42 INFO - psutil == 3.1.1 15:45:42 INFO - requests == 1.2.3 15:45:42 INFO - wsgiref == 0.1.2 15:45:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:42 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 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:42 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 15:45:42 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 15:45:42 INFO - Using env: {'DISPLAY': ':0', 15:45:42 INFO - 'HOME': '/home/cltbld', 15:45:42 INFO - 'LANG': 'en_US.UTF-8', 15:45:42 INFO - 'LANGUAGE': 'en_US:en', 15:45:42 INFO - 'LOGNAME': 'cltbld', 15:45:42 INFO - 'MAIL': '/var/mail/cltbld', 15:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:42 INFO - 'MOZ_NO_REMOTE': '1', 15:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:42 INFO - 'NO_EM_RESTART': '1', 15:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:42 INFO - 'PWD': '/builds/slave/test', 15:45:42 INFO - 'SHELL': '/bin/bash', 15:45:42 INFO - 'SHLVL': '1', 15:45:42 INFO - 'TERM': 'linux', 15:45:42 INFO - 'TMOUT': '86400', 15:45:42 INFO - 'USER': 'cltbld', 15:45:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:42 INFO - '_': '/tools/buildbot/bin/python'} 15:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 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)) 15:45:42 INFO - Cleaning up... 15:45:42 INFO - Return code: 0 15:45:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42e848af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2868850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', '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 15:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:45:42 INFO - Using env: {'DISPLAY': ':0', 15:45:42 INFO - 'HOME': '/home/cltbld', 15:45:42 INFO - 'LANG': 'en_US.UTF-8', 15:45:42 INFO - 'LANGUAGE': 'en_US:en', 15:45:42 INFO - 'LOGNAME': 'cltbld', 15:45:42 INFO - 'MAIL': '/var/mail/cltbld', 15:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:42 INFO - 'MOZ_NO_REMOTE': '1', 15:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:42 INFO - 'NO_EM_RESTART': '1', 15:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:42 INFO - 'PWD': '/builds/slave/test', 15:45:42 INFO - 'SHELL': '/bin/bash', 15:45:42 INFO - 'SHLVL': '1', 15:45:42 INFO - 'TERM': 'linux', 15:45:42 INFO - 'TMOUT': '86400', 15:45:42 INFO - 'USER': 'cltbld', 15:45:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:42 INFO - '_': '/tools/buildbot/bin/python'} 15:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:45:42 INFO - Cleaning up... 15:45:42 INFO - Return code: 0 15:45:42 INFO - Running post-action listener: _resource_record_post_action 15:45:42 INFO - Running post-action listener: _start_resource_monitoring 15:45:42 INFO - Starting resource monitoring. 15:45:42 INFO - [mozharness: 2016-08-22 22:45:42.843482Z] Finished create-virtualenv step (success) 15:45:42 INFO - [mozharness: 2016-08-22 22:45:42.843992Z] Running install step. 15:45:42 INFO - Running pre-action listener: _resource_record_pre_action 15:45:42 INFO - Running main action method: install 15:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:43 INFO - Reading from file tmpfile_stdout 15:45:43 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:43 INFO - Reading from file tmpfile_stdout 15:45:43 INFO - Output received: 15:45:43 INFO - Usage: mozinstall [options] installer 15:45:43 INFO - Options: 15:45:43 INFO - -h, --help show this help message and exit 15:45:43 INFO - -d DEST, --destination=DEST 15:45:43 INFO - Directory to install application into. [default: 15:45:43 INFO - "/builds/slave/test"] 15:45:43 INFO - --app=APP Application being installed. [default: firefox] 15:45:43 INFO - mkdir: /builds/slave/test/build/application 15:45:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:46:00 INFO - Reading from file tmpfile_stdout 15:46:00 INFO - Output received: 15:46:00 INFO - /builds/slave/test/build/application/firefox/firefox 15:46:00 INFO - Running post-action listener: _resource_record_post_action 15:46:00 INFO - [mozharness: 2016-08-22 22:46:00.106275Z] Finished install step (success) 15:46:00 INFO - [mozharness: 2016-08-22 22:46:00.106522Z] Running run-tests step. 15:46:00 INFO - Running pre-action listener: _resource_record_pre_action 15:46:00 INFO - Running main action method: run_tests 15:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:46:00 INFO - Python 2.7.3 15:46:00 INFO - Return code: 0 15:46:00 INFO - grabbing minidump binary from tooltool 15:46:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:46:00 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 0x2863370>, '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 0x28668f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:46:00 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 15:46:00 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 15:46:00 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 15:46:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:46:00 INFO - Return code: 0 15:46:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:46:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:46:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:46:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:46:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 15:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 15:46:00 INFO - Using env: {'DISPLAY': ':0', 15:46:00 INFO - 'HOME': '/home/cltbld', 15:46:00 INFO - 'LANG': 'en_US.UTF-8', 15:46:00 INFO - 'LANGUAGE': 'en_US:en', 15:46:00 INFO - 'LOGNAME': 'cltbld', 15:46:00 INFO - 'MAIL': '/var/mail/cltbld', 15:46:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:46:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:00 INFO - 'MOZ_NO_REMOTE': '1', 15:46:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:00 INFO - 'NO_EM_RESTART': '1', 15:46:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:00 INFO - 'PWD': '/builds/slave/test', 15:46:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:46:00 INFO - 'SHELL': '/bin/bash', 15:46:00 INFO - 'SHLVL': '1', 15:46:00 INFO - 'TERM': 'linux', 15:46:00 INFO - 'TMOUT': '86400', 15:46:00 INFO - 'USER': 'cltbld', 15:46:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202', 15:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:00 INFO - '_': '/tools/buildbot/bin/python'} 15:46:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 15:46:00 INFO - mozversion application_buildid: 20160822123001 15:46:00 INFO - mozversion application_changeset: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 15:46:00 INFO - mozversion application_display_name: Nightly 15:46:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:46:00 INFO - mozversion application_name: Firefox 15:46:00 INFO - mozversion application_remotingname: firefox 15:46:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:46:00 INFO - mozversion application_vendor: Mozilla 15:46:00 INFO - mozversion application_version: 51.0a1 15:46:00 INFO - mozversion platform_buildid: 20160822123001 15:46:00 INFO - mozversion platform_changeset: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 15:46:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:46:00 INFO - mozversion platform_version: 51.0a1 15:46:00 INFO - using testdate: 1471905960 15:46:00 INFO - actual date: 1471905960 15:46:00 INFO - starting webserver on 'localhost:40404' 15:46:00 INFO - SUITE-START | Running 2 tests 15:46:00 INFO - TEST-START | dromaeo_css 15:46:00 INFO - operating with platform_type : linux_ 15:46:00 INFO - Initialising browser for dromaeo_css test... 15:46:00 INFO - TEST-INFO | started process 12135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2a8IhW/profile http://localhost:40404/getInfo.html) 15:46:04 INFO - PROCESS | 12135 | __metrics Screen width/height:1600/1200 15:46:04 INFO - PROCESS | 12135 | colorDepth:24 15:46:04 INFO - PROCESS | 12135 | Browser inner width/height: 1024/697 15:46:04 INFO - PROCESS | 12135 | __metrics 15:46:05 INFO - PROCESS | 12135 | 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" 15:46:05 INFO - PROCESS | 12135 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:46:05 INFO - PROCESS | 12135 | console.error: PushService: 15:46:05 INFO - PROCESS | 12135 | stateChangeProcessEnqueue: Error transitioning state 15:46:05 INFO - PROCESS | 12135 | UnknownError 15:46:06 INFO - TEST-INFO | 12135: exit 0 15:46:06 INFO - Browser initialized. 15:46:06 INFO - Running cycle 1/1 for dromaeo_css test... 15:46:06 INFO - TEST-INFO | started process 12216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2a8IhW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:18 INFO - PROCESS | 12216 | RSS: Main: 174673920 15:46:18 INFO - PROCESS | 12216 | 15:47:10 INFO - PROCESS | 12216 | 1471906030315 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] 15:49:19 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40404/tests/dromaeo/cssquery-ext.html) 15:49:20 INFO - PROCESS | 12216 | RSS: Main: 278532096 15:49:20 INFO - PROCESS | 12216 | 15:52:23 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-ext.html (next: http://localhost:40404/tests/dromaeo/cssquery-jquery.html) 15:52:23 INFO - PROCESS | 12216 | RSS: Main: 278462464 15:52:23 INFO - PROCESS | 12216 | 15:55:25 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40404/tests/dromaeo/cssquery-mootools.html) 15:55:26 INFO - PROCESS | 12216 | RSS: Main: 276484096 15:55:26 INFO - PROCESS | 12216 | 15:58:28 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40404/tests/dromaeo/cssquery-prototype.html) 15:58:29 INFO - PROCESS | 12216 | RSS: Main: 219136000 15:58:29 INFO - PROCESS | 12216 | 16:01:31 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40404/tests/dromaeo/cssquery-yui.html) 16:01:32 INFO - PROCESS | 12216 | RSS: Main: 223916032 16:01:32 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-yui.html (next: http://localhost:40404/tests/dromaeo/cssquery-dojo.html) 16:04:35 INFO - PROCESS | 12216 | RSS: Main: 301080576 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | __start_tp_report 16:04:35 INFO - PROCESS | 12216 | _x_x_mozilla_page_load 16:04:35 INFO - PROCESS | 12216 | _x_x_mozilla_page_load_details 16:04:35 INFO - PROCESS | 12216 | |i|pagename|runs| 16:04:35 INFO - PROCESS | 12216 | |0;dojo.html;2981.4037192561486;3030.8939187128453;3035.984820075898;3036.3168287135413;3052.2979714665626;5233.874716935858;5378.973105134473;5380.650257733245;5458.153986132151;5475.890482190353;5304.257403963448;5337.5196232339085;5347.812826551071;5379.6503227290195;5445.101558242885;4862.319275301461;4898.608111351093;4943.77753001114;5003.5997120230295;5005.424376196729;4981.053599816023;5039.899202015976;5040.747962601874;5045.64680472367;5050.545450909417;4785.497522760095;4843.4430040545085;4858.076965376567;4938.827141050064;4966.975165124151;4770.976145119287;4793.261256220154;4848.757562121879;4867.318575399447;4902.068606964665;4754.762261886926;4776.713397196145;4796.640251981115;4893.584045356149;4903.043906438246;5358.169483729989;5358.33020872391;5359.866003349908;5373.140297552372;5374.91937620936;5560.666360018412;5665.830025099253;5690.857728556778;5711.62874413166;5825.1844741736195;5746.827595172152;5773.653580785124;5795.739191736382;5826.504747096502;5842.065269556851;5176.1459359206065;5392.272043274147;5398.1362981923485;5401.189821526802;5405.4324295949145;5743.971280143573;5837.357890632027;5843.5325173985975;5897.144913987448;5906.291245050621;5630.634008789416;5639.746211420496;5643.435656434323;5645.5201307888465;5676.063449530781;5554.50009499147;5746.712664366765;5750.453706897838;5753.395893431213;5755.510781583528;5608.747606357723;5670.262865827416;5670.489655930986;5768.682722450306;5771.192033115367;5739.024365857814;5766.308043034863;5774.82675519735;5783.045797443375;5787.739551720183;4302.204092242945;4451.866444006685;4457.064016556495;4457.77711114443;4471.5081341052455;3887.1059656279213;3914.412838074312;3958.6041395860184;3974.2448934702315;3997.700172487075;5528.143137813645;5534.4742249486235;5534.584906132056;5534.944650553523;5536.390996990328;5588.804391846347;5829.795957141565;5840.386759390288;5846.532277417797;5854.121881717691;5393.973030134903;5441.646292990943;5463.836084917459;5528.612997090165;5532.2531458253425;4981.950180498148;4982.60139188864;4994.625403094782;4995.650304478651;5004.299398084198;5780.624259423124;6017.037274036134;6027.336992930686;6032.185654936615;6035.275766907999;5732;5746.281714785652;5747.8563035924435;5842.415758424124;5865.384134665969;6007.158997740407;6009.2188015557695;6011.519078473799;6018.097285407049;6030.185924900083;5459.39946605881;5693.715314234355;5710.914336285042;5739.139129130664;5747.48272655463;5681.119426488901;5694.658320500783;5732.942670573241;5791.478766910998;5801.3908539602735;5646.491815736604;5680.11958146488;5683.829485115453;5684.118961560965;5689.260396148474;5457.781688732406;5653.604247702786;5662.915056274077;5664.433556644302;5664.886702265849;5508.91736623959;5534.252875861707;5557.3331200256225;5644.745986430703;5647.774089036392;5730.770769169187;5741.052726300114;5748.396418376177;5752.424757524214;5755.827325180251;5311.840644780663;5574.470425309589;5577.749001295033;5583.106702927512;5598.524125449382 16:04:35 INFO - PROCESS | 12216 | |1;ext.html;560.9158626206068;579.6666916523001;588.7939221272554;590.3181824992135;606.2724730323613;42724.14551708964;44403.33394999074;44462.555374446245;49094.75452622741;49104.50895491044;45560.54439455605;46238.53761462384;46276.76861615687;46339.30491042637;46417.535824641745;8889.688860889853;9022.639094436248;9032.819343613124;9033.141851524128;9037.231835294007;9032.412893161956;9111.68109116181;9119.316051296146;9123;9126.863097053549;9080.455172689626;9096;9107.499087550183;9141.680041198559;9152.633894644207;8981.64073437065;9001.324900632479;9017.729468115967;9023.458592484472;9055.230305424047;8928.330375221884;9003.189712925869;9009.59456824438;9013.549322533912;9016.504092274923;43664;44352.778236108614;44384;44442.111157776664;44492;3555.520004799371;3626.075350785533;3674.8530058797614;3716.3682174030478;4013.5986401359633;32069.83965080183;32353;32419;32531.67468325334;32798.67201328004;4315.848945286932;4321.135772845412;4359.651227901761;4383.145286669101;4420.09388075447;371540;373109;373118;373969;373986.13006935065;59637;59945;60099.39900600938;60165.39834601685;60180;34271;64874;64964.67517662476;65009;65022.67488662621;16938.661226775643;17803.821961780475;17806.109694515224;17838.821611783977;17884.195211215527;13241.337933103307;13753.449862005607;13762.24307663068;13762.311884405739;13764.036517443683;19597.412077637695;19628.313009044614;19646.508837279183;19785.60428791416;19796.50508737293;7076.787696369117;7157.713691452388;7215.963920180366;7250.854982900312;7313.524620899624;955.4171955107379;1016.3546148195801;1022.3354819367322;1175.2595864605244;1180.7579446213506;33414.49878251828;33504.24451604533;33507.49738753921;33566.49650255248;34017;896.6727144592177;1063.122923588043;1133.7235389723705;1161.7095726068483;1203.560700344368;16995.575110622332;17347.566310842078;17539.912300438416;17619.207135678924;17620.559486012695;567105.7960073358;567589;572696;573624;575092;60576.09135862966;61071;61225.38774612197;61672;61720;1216.653253822674;1298.6818229533824;1300.6683295759522;1309.2471828698535;1351.4526616720243;32182.678173218905;33479.49780753242;34047;34169;34349.65650343464;51647.225291621406;52273.7386313066;52370;52392.7380363111;52453.7377313111;409505.8098837947;410122;411618;411851;412260;28245.57631635486;29204.56193157147;29601.407971840013;30613.387732245676;30874.53688194724;49806.75096624494;50047.249291259934;50055.74972125116;50614.49385506245;51205.7439712799;41251;41372.793136034124;42047;42251.57748422599;43801.56198438102;41382.37926431046;41680.58319416888;41913.58086419219;42816.357754633085;43123.56876431195;41605.37591936063;41704.791476042425;42296.365554517324;42542.574574253864;42939;33128;38001;38049.42925856059;38059.42910856395;39318.41022384724;27982.580261296505;28083.71916280811;28088.43823123567;28120.156395308175;28175.859120704266 16:04:35 INFO - PROCESS | 12216 | |2;jquery.html;376.074855854598;392.7447159346426;397.3919902549099;399.9720019598627;416.32763087613495;14174.440811510738;17250.568735781613;18092.4572262832;19362.419127426183;19375.903120484414;19126.52183695408;19239;19267;19485.805141948575;19516;5695.345035320939;5841.065429531276;5868.911966320508;5916.940830591682;5918.319393269786;5593.356763972134;5833.941660583403;5843.970780146094;5850.619709718854;5851.444112809298;5557.72211389431;5784.942150578503;5806.332271788756;5814.941850581504;5820.272465941757;5953.642781433106;6092.634441933498;6094.695265236721;6097.847553811168;6099.146119543268;5250.6324557281005;5500.779968801243;5537.36320323164;5606.915896261559;5915.408459154093;14083.436662533486;14295.213763243017;15015;18786.53033674169;19014.61970760577;2221.589006033889;2229.9219527316627;2340.379799353173;2413.71035475744;2833.4191490744347;9305.162535371848;9594.184494317991;10110.595576176944;10186.388816671024;10201.744956376077;1869.336385583112;1944.513871532117;1945.387203031055;1973.6940774180025;1991.2632326039459;75728;80456.79314810282;81688.59155704243;81713;82917;10756.139508839431;10765.461726913623;11177.552897884156;11359.261647993018;11398.829017564743;15699.450519232001;15743.212839357986;15750.527484175493;15763.211839408214;15766.842331576767;7895;8202.179782021869;8208.835823283502;8380;8455.830883382421;7772.727954521564;7888.211178882066;7948.801279967932;8291.295239904555;8312.41813073079;4751.168545504523;4790.736509491941;4797.976010119997;4825.782839772219;4935.235038569028;1920.9519762006062;2008.0080679787013;2009.8995050247722;2011.647961606713;2031.7155598216261;886.601029536711;971.4268581536927;987.521052289639;1032.5560009196117;1038.5274700011478;19768.20927162926;20042.498937526387;20083.297084601967;20219.797802022087;20371.4907127323;1005.648023191877;1018.8267994440963;1036.0571879589688;1043.7547176413536;1045.4772613693153;10559.99680030396;11175.419438101824;11219.214654974237;11309.49107290174;11390.430478476042;417399;418845;454364;471626;475606;56317;67696.32303676999;86314.56842715746;87420.1257987412;87835.12164878397;989.4656885282011;1011.8026984738052;1039.308859608352;1040.3185913226848;1049.4070849969742;16609.83390166083;16940.915295423445;17411.301248306532;17786.822131779034;17876.91061544684;42168;42731.786341068095;43404.34893476663;43633.781831090644;43664.345034825135;55783;57938.4206157933;58889.4111058901;59443.702781485816;60050.39949600448;8156.83686326282;8673.653053878026;8693.869591956;8710.12898710124;8764.21122099014;9640.276979226726;11345.773084538429;12302.876971230173;12722.427490763122;12918.354082296035;10676.199285053808;11027.44862756875;11116.555337786398;11501.82747258775;11537.250078744855;11254.549818007188;11492.770144596894;11500.8821074621;11645.41772911368;11860.584879529175;11018.283811552223;11403.372814494951;11716.765664686829;11857.229280096766;12114.273143611412;8512.829743405222;8640.611172497127;8749.212570868653;8811.206991370807;8828.911710882809;10522.159017065502;10904.236703430684;11022.724431889266;11027.44862756875;11430.371329576954 16:04:35 INFO - PROCESS | 12216 | |3;mootools.html;1355.261382546512;1446.6961937993024;1490.0835985868691;1582.5964379083332;1750.6148647297598;8373.120822313653;8647.092055334186;8780.209781119689;8975.506347150904;8993.775155621097;8815.911840881588;8913.465192088479;8926.509042002688;8930.508822014786;8937.419067760591;2051.5178932950744;2295.9770402296012;2387.04518192723;2411.6261979393134;2412.2883749294;2330.207729372013;2382.60686986647;2383.2254517281867;2383.5113801670705;2384.7138343398815;2320.5474932388192;2367.5028244068767;2379.3218932604213;2383.3207535852284;2398.3404563744934;2232.620454522735;2292.7592602776717;2302.8848557572055;2302.988485057581;2316.791488766002;2353.2822489140804;2362.2204672458047;2368.171140100968;2369.7037870266217;2372.5373552157334;8817.118288171196;8863.157999989991;8874;8874.334424918157;8877.112288771072;5142.1772516397195;5297.49673780994;5331.360236771612;5332.040232758102;5337.11937530307;3257.774346010663;3326.301476689898;3337.4826901830256;3395.9490607640905;3432.090496018557;1140.116409782417;1144.4792619358254;2200.559888022386;2224.6996655451467;2274.1352091285153;12039.39803009846;12120.939395303056;12132.939335303356;12161.027117830641;12186.57346992851;4245.639120674716;4311.525732169459;4473.552644735565;4482.731036137842;4512.729236245836;9628.951855240679;9639.855402168972;9642.325037247465;9647.421154730599;9648.372855764494;5145.331106956071;5179.585633149339;5189.481051894781;5190.8183213587345;5191.740412979411;4235.53409124996;4296.91406171881;4422.71252368595;4704.482506924235;4789.856304310876;3630.618785027587;3706.5366829146355;3819.9427008594894;3825.8660946866726;3843.7309388343106;1109.7170221593603;1115.2249186815247;1116.5757012335423;1118.7426891814766;1118.9384583847805;947.3131979314942;949.8432758594893;954.5847556312888;957.4111921168432;991.9980819372486;5630.268065151504;5972.850678733066;6032.095185722089;6034.2155519782145;6171.475424588871;462.48663982978866;466.3471140403395;467.82456578782956;469.76746510477534;470.4190324948686;3993.740406873544;4148.319930428182;4170.624643782075;4194.895127621773;4219.578042195756;10332.328398654063;10665.466726663792;10717.892821071846;10795;10801.513931873085;10615.150787936947;10622.575096996034;10640.148788096934;10649.787004259872;10678.145748340114;7770.961145194238;7939.523628582304;8047.557384343917;8102.027756669119;8103.635336409876;5943.910841337297;6045.75816967334;6065.090236464389;6138.14066030765;6150.261968563801;10112;10165.339252948535;10186.898131018595;10310.742231444274;10442.738931526772;9867.11195992364;10233.84649230277;10242.539085741011;10454.63408780689;10509.369437833755;6957.339052789976;7422.628868556659;7437.739679111205;7601.315881570686;7616.923830761843;8232.135625759449;8347.499150051017;8361.83276334482;8386;8389.119142490195;7336.339729424378;7437.442191835742;7533.698652053857;7593.848123037619;7750.302472777477;7360.77917662471;7367.705291788483;7575.848483030199;7598.430117741302;7619.314261716472;6701.0953521274005;6808.38724514796;6826.112605361272;6840.863182736218;6843.520953533205;5115.437301896863;5163.948360516347;5226.790928362823;5336.279602253646;5373.328333958255;5066.316047333563;5278.89442211146;5283.735813209248;5298.97350513245;5376 16:04:35 INFO - PROCESS | 12216 | |4;prototype.html;308.2325010723299;312.71386681186715;316.9001764444201;322.7160099112782;326.4401551339452;5229.686218826868;5243.292155558998;5247.711375874325;5258.868528286795;5309.177077552986;5184.963007398526;5194.662346947446;5214.426413094557;5225.451327610604;5230.947690523094;4133.751974881502;4138.937915931264;4139.2135494256145;4159.667226621863;4174.457320548325;3862.80685965702;4085.3871919212206;4088.4276201331836;4103.958960410388;4122.855700050499;4019.899502512446;4020.477337946063;4033.1127152026506;4034.6368826805583;4035.59644035597;3828.636279553438;3893.3186692329014;4028.5971402859773;4036.838526458953;4045.2111838191563;3522.6829585337186;3540.8760693375866;3546.8758593449106;3551.4317709166407;3556.928861422757;5090.363704536933;5102.36220472441;5102.877366979295;5116.590672746172;5135.101357262464;4375.78121093944;4385.780710964439;4637.886907142295;4645.488996210414;4645.744484053375;5388.568914486832;5406.621536492447;5428.972855135738;5451.809186678487;5454.154606036071;3868.723321303963;3877.3908827836694;3888.1251718363424;3909.648131668135;3927.3127202739693;5636.464535869086;5642.6614403135945;5676.3755986841825;5736.967345877741;5777.971110144465;3971.669490720641;3973.5827738087664;3982;3982.9246103551877;3996.7801770902297;4046;4049.635532802062;4058.3563656719075;4060.309747342959;4064.6545043671617;4556.086443693656;4658.883527911761;4669.276262179367;4670.206064968964;4681.110588988081;5469.234307196995;5470.362209130963;5488.835334939959;5503.834884953458;5573.303337082864;1355.6308128789992;1381.2265131526378;1382.156884300576;1387.7363300972784;1388.1324172392256;838.1241602525375;885.9202671759443;888.9377743558018;892.7546073227811;900.7612982559496;4700.55344742249;4705.423877852856;4708.152532544175;4725;4738.526147385234;4880.804767809319;4917.803287868517;4949.48030456804;4976.527229913152;5034.219695947134;4439.713547522963;4660.277656963109;4695.483496815347;4746.525347465225;4802.980884975209;2608.3697688944408;2618.6595742553345;2800.9859950700525;2901.7678585713093;2960.7483363914307;5745.655260684289;5763.769449222068;5775.815957728655;5790.826275211666;5791.7683292667825;5522.674558106026;5698.230738850285;5702.657840529581;5709.942900571024;5721.971390143022;5703.08750599902;5725.541956643458;5736.655800651891;5744.51171650406;5761.798337058183;5548.583856210881;5559.555235581225;5581.7209139543675;5585.3297604287745;5626.803061892814;5284.097724819139;5492.80775172883;5521.426393477839;5543.805966791143;5553.8333849984565;5708.200851880823;5710.428957104256;5715.942840571541;5738.454846789548;5749.97125014389;3909.9638595772713;3963.682905367506;3978.801059947049;3992.7205095643026;3999.3001224786126;5504.834854954198;5588.6646801192055;5596.048671725898;5615.354234263112;5669.688167150846;5426.348838139291;5426.70153141581;5434.701091439851;5445.727713614383;5450.964316779799;5303.70812207976;5359.785608575613;5368.248445217595;5435.673859568438;5473.2063850742215;5316.129290183258;5370.409254981871;5380.300560927054;5394.32570928634;5404.351477822686;5461.617686761889;5471.37079235893;5479.369872464717;5485.396606373375;5487.506124448819;5139.537441630271;5339.225812257278;5370.892582148257;5376.704281264568;5380.838574842761 16:04:35 INFO - PROCESS | 12216 | |5;yui.html;750.1261030899003;761.3034073822453;775.344833615595;812.3460614205569;878.4202426398576;14925.402983880645;15467.535973920787;15492.612684682888;15498.767518487204;15547.455839045622;15945.760813587805;16353.427630032951;16569.420070297543;16601.169941502936;16609.086500242483;789.7551758954743;815.5799763121968;819.5246756880995;820.1060843680388;820.6143112737004;667.3360006793223;780.5589841739427;808.312934006096;814.9837003259931;816.322452364536;850.7532815483534;851.059579165023;851.5444237333028;853.2491407561369;853.4793775796759;852.1861622150831;852.7569642651846;852.8081181734091;853.0275485946026;853.2150421612132;504.9772760225799;599.466474837395;614.4807637546267;615.7660089166133;617.7158507086746;15765.527034188992;15806.683866322724;15807.130607816565;15819.288132033971;15828.208589570475;13749.175049497062;13857.653558661013;14258.786118208236;14411.639709007253;14454.710905781825;13501.527446539323;13741.793873091912;13826.446942122304;14026.85973140276;14871;4459.955400446019;4505.414296141514;4540.205464043812;4665.136949664323;4757.548032936866;55276;83663;83775;83953.16046839576;84103.5794821022;10309.175265978854;10501;10980.890191098146;11173.32960022385;11491.54033838637;21304.893475532834;21325.253616123362;21326;21339.46651333729;21383.25158619441;8531.74404767858;8766.60550275239;8770.298376129895;8825.69110081157;8924.821503569892;5054.166062599704;5061.746912654353;5098.872528186825;5164.664296820694;5236.423993360727;3249.431349513826;3330.7501937354796;3359.260962588227;3360.781549199294;3378.7634865559176;563.39997902234;566.1762136091976;570.3896830391524;593.6260156101715;593.8782549577327;498.03381440006274;684.6816230452863;715.2918610575492;727.298157278229;791.2799352589117;9245.676401325922;10094.899051009395;10586.771034834295;10637.680869573926;10882.510287037103;671.8857794175002;700.3976580141075;759.8252401947583;760.0878945265704;783.3811289081675;4683.718976861399;4940.654154209171;4970.502949705001;5074.898502030012;5120.361484325054;69718;117290.41354793172;126494;126910.36544817218;130332;109595;110910;111614.95465408152;112142.43928780303;116932.41533792447;95646.52176739211;97309.5134524337;97358;98960.50519747355;102154.4892275534;9425.198858096865;9512.809743805223;9594.712158635251;9608.327417080738;9670.854937175807;46964.7651761739;52060.47939520556;52516;53431;54136.56385462743;78687;82526;87363.12636873804;87714.561427195;90270.54864725635;12318.445669944695;12775.105742597929;12777.872221277668;12802.573461674428;13031.413586388824;14262.71474570482;14361.569152925429;14606.415743370146;14645.780313295521;14759.409623615365;13085.280309583064;13304.534341298007;13437.664058398619;13543.187408755506;13734.65663358424;11984.46069926838;12279.508819647113;12425.44085516172;12516.31160286193;12892.742145157232;12558.623241302776;12752;12754.362281886055;13177.934110329386;13549.864501355254;11609.767804644029;11616.361100139573;11763.588274410355;12157.635270941886;12475.688107797378;11849.407529623657;12038.703309521974;12102.576409825613;12214.877851221729;12642.936785316382 16:04:35 INFO - PROCESS | 12216 | __end_tp_report 16:04:35 INFO - PROCESS | 12216 | __start_cc_report 16:04:35 INFO - PROCESS | 12216 | _x_x_mozilla_cycle_collect,980 16:04:35 INFO - PROCESS | 12216 | __end_cc_report 16:04:35 INFO - PROCESS | 12216 | __startTimestamp1471907075867__endTimestamp 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | ------- Summary: start ------- 16:04:35 INFO - PROCESS | 12216 | Number of tests: 6 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | [#0] dojo.html Cycles:165 Average:5353.82 Median:5560.67 stddev:617.88 (11.1%) stddev-sans-first:591.09 16:04:35 INFO - PROCESS | 12216 | Values: 2981.4 3030.9 3036.0 3036.3 3052.3 5233.9 5379.0 5380.7 5458.2 5475.9 5304.3 5337.5 5347.8 5379.7 5445.1 4862.3 4898.6 4943.8 5003.6 5005.4 4981.1 5039.9 5040.7 5045.6 5050.5 4785.5 4843.4 4858.1 4938.8 4967.0 4771.0 4793.3 4848.8 4867.3 4902.1 4754.8 4776.7 4796.6 4893.6 4903.0 5358.2 5358.3 5359.9 5373.1 5374.9 5560.7 5665.8 5690.9 5711.6 5825.2 5746.8 5773.7 5795.7 5826.5 5842.1 5176.1 5392.3 5398.1 5401.2 5405.4 5744.0 5837.4 5843.5 5897.1 5906.3 5630.6 5639.7 5643.4 5645.5 5676.1 5554.5 5746.7 5750.5 5753.4 5755.5 5608.7 5670.3 5670.5 5768.7 5771.2 5739.0 5766.3 5774.8 5783.0 5787.7 4302.2 4451.9 4457.1 4457.8 4471.5 3887.1 3914.4 3958.6 3974.2 3997.7 5528.1 5534.5 5534.6 5534.9 5536.4 5588.8 5829.8 5840.4 5846.5 5854.1 5394.0 5441.6 5463.8 5528.6 5532.3 4982.0 4982.6 4994.6 4995.7 5004.3 5780.6 6017.0 6027.3 6032.2 6035.3 5732.0 5746.3 5747.9 5842.4 5865.4 6007.2 6009.2 6011.5 6018.1 6030.2 5459.4 5693.7 5710.9 5739.1 5747.5 5681.1 5694.7 5732.9 5791.5 5801.4 5646.5 5680.1 5683.8 5684.1 5689.3 5457.8 5653.6 5662.9 5664.4 5664.9 5508.9 5534.3 5557.3 5644.7 5647.8 5730.8 5741.1 5748.4 5752.4 5755.8 5311.8 5574.5 5577.7 5583.1 5598.5 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | [#1] ext.html Cycles:180 Average:61911.28 Median:42770.25 stddev:121946.79 (285.1%) stddev-sans-first:122201.89 16:04:35 INFO - PROCESS | 12216 | Values: 560.9 579.7 588.8 590.3 606.3 42724.1 44403.3 44462.6 49094.8 49104.5 45560.5 46238.5 46276.8 46339.3 46417.5 8889.7 9022.6 9032.8 9033.1 9037.2 9032.4 9111.7 9119.3 9123.0 9126.9 9080.5 9096.0 9107.5 9141.7 9152.6 8981.6 9001.3 9017.7 9023.5 9055.2 8928.3 9003.2 9009.6 9013.5 9016.5 43664.0 44352.8 44384.0 44442.1 44492.0 3555.5 3626.1 3674.9 3716.4 4013.6 32069.8 32353.0 32419.0 32531.7 32798.7 4315.8 4321.1 4359.7 4383.1 4420.1 371540.0 373109.0 373118.0 373969.0 373986.1 59637.0 59945.0 60099.4 60165.4 60180.0 34271.0 64874.0 64964.7 65009.0 65022.7 16938.7 17803.8 17806.1 17838.8 17884.2 13241.3 13753.4 13762.2 13762.3 13764.0 19597.4 19628.3 19646.5 19785.6 19796.5 7076.8 7157.7 7216.0 7250.9 7313.5 955.4 1016.4 1022.3 1175.3 1180.8 33414.5 33504.2 33507.5 33566.5 34017.0 896.7 1063.1 1133.7 1161.7 1203.6 16995.6 17347.6 17539.9 17619.2 17620.6 567105.8 567589.0 572696.0 573624.0 575092.0 60576.1 61071.0 61225.4 61672.0 61720.0 1216.7 1298.7 1300.7 1309.2 1351.5 32182.7 33479.5 34047.0 34169.0 34349.7 51647.2 52273.7 52370.0 52392.7 52453.7 409505.8 410122.0 411618.0 411851.0 412260.0 28245.6 29204.6 29601.4 30613.4 30874.5 49806.8 50047.2 50055.7 50614.5 51205.7 41251.0 41372.8 42047.0 42251.6 43801.6 41382.4 41680.6 41913.6 42816.4 43123.6 41605.4 41704.8 42296.4 42542.6 42939.0 33128.0 38001.0 38049.4 38059.4 39318.4 27982.6 28083.7 28088.4 28120.2 28175.9 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | [#2] jquery.html Cycles:180 Average:27209.40 Median:2377.05 stddev:73910.68 (3109.4%) stddev-sans-first:74090.56 16:04:35 INFO - PROCESS | 12216 | Values: 376.1 392.7 397.4 400.0 416.3 14174.4 17250.6 18092.5 19362.4 19375.9 19126.5 19239.0 19267.0 19485.8 19516.0 5695.3 5841.1 5868.9 5916.9 5918.3 5593.4 5833.9 5844.0 5850.6 5851.4 5557.7 5784.9 5806.3 5814.9 5820.3 5953.6 6092.6 6094.7 6097.8 6099.1 5250.6 5500.8 5537.4 5606.9 5915.4 14083.4 14295.2 15015.0 18786.5 19014.6 2221.6 2229.9 2340.4 2413.7 2833.4 9305.2 9594.2 10110.6 10186.4 10201.7 1869.3 1944.5 1945.4 1973.7 1991.3 75728.0 80456.8 81688.6 81713.0 82917.0 10756.1 10765.5 11177.6 11359.3 11398.8 15699.5 15743.2 15750.5 15763.2 15766.8 7895.0 8202.2 8208.8 8380.0 8455.8 7772.7 7888.2 7948.8 8291.3 8312.4 4751.2 4790.7 4798.0 4825.8 4935.2 1921.0 2008.0 2009.9 2011.6 2031.7 886.6 971.4 987.5 1032.6 1038.5 19768.2 20042.5 20083.3 20219.8 20371.5 1005.6 1018.8 1036.1 1043.8 1045.5 10560.0 11175.4 11219.2 11309.5 11390.4 417399.0 418845.0 454364.0 471626.0 475606.0 56317.0 67696.3 86314.6 87420.1 87835.1 989.5 1011.8 1039.3 1040.3 1049.4 16609.8 16940.9 17411.3 17786.8 17876.9 42168.0 42731.8 43404.3 43633.8 43664.3 55783.0 57938.4 58889.4 59443.7 60050.4 8156.8 8673.7 8693.9 8710.1 8764.2 9640.3 11345.8 12302.9 12722.4 12918.4 10676.2 11027.4 11116.6 11501.8 11537.3 11254.5 11492.8 11500.9 11645.4 11860.6 11018.3 11403.4 11716.8 11857.2 12114.3 8512.8 8640.6 8749.2 8811.2 8828.9 10522.2 10904.2 11022.7 11027.4 11430.4 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | [#3] mootools.html Cycles:180 Average:5733.85 Median:470.09 stddev:3242.54 (689.8%) stddev-sans-first:3234.94 16:04:35 INFO - PROCESS | 12216 | Values: 1355.3 1446.7 1490.1 1582.6 1750.6 8373.1 8647.1 8780.2 8975.5 8993.8 8815.9 8913.5 8926.5 8930.5 8937.4 2051.5 2296.0 2387.0 2411.6 2412.3 2330.2 2382.6 2383.2 2383.5 2384.7 2320.5 2367.5 2379.3 2383.3 2398.3 2232.6 2292.8 2302.9 2303.0 2316.8 2353.3 2362.2 2368.2 2369.7 2372.5 8817.1 8863.2 8874.0 8874.3 8877.1 5142.2 5297.5 5331.4 5332.0 5337.1 3257.8 3326.3 3337.5 3395.9 3432.1 1140.1 1144.5 2200.6 2224.7 2274.1 12039.4 12120.9 12132.9 12161.0 12186.6 4245.6 4311.5 4473.6 4482.7 4512.7 9629.0 9639.9 9642.3 9647.4 9648.4 5145.3 5179.6 5189.5 5190.8 5191.7 4235.5 4296.9 4422.7 4704.5 4789.9 3630.6 3706.5 3819.9 3825.9 3843.7 1109.7 1115.2 1116.6 1118.7 1118.9 947.3 949.8 954.6 957.4 992.0 5630.3 5972.9 6032.1 6034.2 6171.5 462.5 466.3 467.8 469.8 470.4 3993.7 4148.3 4170.6 4194.9 4219.6 10332.3 10665.5 10717.9 10795.0 10801.5 10615.2 10622.6 10640.1 10649.8 10678.1 7771.0 7939.5 8047.6 8102.0 8103.6 5943.9 6045.8 6065.1 6138.1 6150.3 10112.0 10165.3 10186.9 10310.7 10442.7 9867.1 10233.8 10242.5 10454.6 10509.4 6957.3 7422.6 7437.7 7601.3 7616.9 8232.1 8347.5 8361.8 8386.0 8389.1 7336.3 7437.4 7533.7 7593.8 7750.3 7360.8 7367.7 7575.8 7598.4 7619.3 6701.1 6808.4 6826.1 6840.9 6843.5 5115.4 5163.9 5226.8 5336.3 5373.3 5066.3 5278.9 5283.7 5299.0 5376.0 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | [#4] prototype.html Cycles:180 Average:4535.33 Median:5162.25 stddev:1343.97 (26.0%) stddev-sans-first:1309.76 16:04:35 INFO - PROCESS | 12216 | Values: 308.2 312.7 316.9 322.7 326.4 5229.7 5243.3 5247.7 5258.9 5309.2 5185.0 5194.7 5214.4 5225.5 5230.9 4133.8 4138.9 4139.2 4159.7 4174.5 3862.8 4085.4 4088.4 4104.0 4122.9 4019.9 4020.5 4033.1 4034.6 4035.6 3828.6 3893.3 4028.6 4036.8 4045.2 3522.7 3540.9 3546.9 3551.4 3556.9 5090.4 5102.4 5102.9 5116.6 5135.1 4375.8 4385.8 4637.9 4645.5 4645.7 5388.6 5406.6 5429.0 5451.8 5454.2 3868.7 3877.4 3888.1 3909.6 3927.3 5636.5 5642.7 5676.4 5737.0 5778.0 3971.7 3973.6 3982.0 3982.9 3996.8 4046.0 4049.6 4058.4 4060.3 4064.7 4556.1 4658.9 4669.3 4670.2 4681.1 5469.2 5470.4 5488.8 5503.8 5573.3 1355.6 1381.2 1382.2 1387.7 1388.1 838.1 885.9 888.9 892.8 900.8 4700.6 4705.4 4708.2 4725.0 4738.5 4880.8 4917.8 4949.5 4976.5 5034.2 4439.7 4660.3 4695.5 4746.5 4803.0 2608.4 2618.7 2801.0 2901.8 2960.7 5745.7 5763.8 5775.8 5790.8 5791.8 5522.7 5698.2 5702.7 5709.9 5722.0 5703.1 5725.5 5736.7 5744.5 5761.8 5548.6 5559.6 5581.7 5585.3 5626.8 5284.1 5492.8 5521.4 5543.8 5553.8 5708.2 5710.4 5715.9 5738.5 5750.0 3910.0 3963.7 3978.8 3992.7 3999.3 5504.8 5588.7 5596.0 5615.4 5669.7 5426.3 5426.7 5434.7 5445.7 5451.0 5303.7 5359.8 5368.2 5435.7 5473.2 5316.1 5370.4 5380.3 5394.3 5404.4 5461.6 5471.4 5479.4 5485.4 5487.5 5139.5 5339.2 5370.9 5376.7 5380.8 16:04:35 INFO - PROCESS | 12216 | 16:04:35 INFO - PROCESS | 12216 | [#5] yui.html Cycles:180 Average:21983.16 Median:4522.81 stddev:32535.07 (719.4%) stddev-sans-first:32587.27 16:04:35 INFO - PROCESS | 12216 | Values: 750.1 761.3 775.3 812.3 878.4 14925.4 15467.5 15492.6 15498.8 15547.5 15945.8 16353.4 16569.4 16601.2 16609.1 789.8 815.6 819.5 820.1 820.6 667.3 780.6 808.3 815.0 816.3 850.8 851.1 851.5 853.2 853.5 852.2 852.8 852.8 853.0 853.2 505.0 599.5 614.5 615.8 617.7 15765.5 15806.7 15807.1 15819.3 15828.2 13749.2 13857.7 14258.8 14411.6 14454.7 13501.5 13741.8 13826.4 14026.9 14871.0 4460.0 4505.4 4540.2 4665.1 4757.5 55276.0 83663.0 83775.0 83953.2 84103.6 10309.2 10501.0 10980.9 11173.3 11491.5 21304.9 21325.3 21326.0 21339.5 21383.3 8531.7 8766.6 8770.3 8825.7 8924.8 5054.2 5061.7 5098.9 5164.7 5236.4 3249.4 3330.8 3359.3 3360.8 3378.8 563.4 566.2 570.4 593.6 593.9 498.0 684.7 715.3 727.3 791.3 9245.7 10094.9 10586.8 10637.7 10882.5 671.9 700.4 759.8 760.1 783.4 4683.7 4940.7 4970.5 5074.9 5120.4 69718.0 117290.4 126494.0 126910.4 130332.0 109595.0 110910.0 111615.0 112142.4 116932.4 95646.5 97309.5 97358.0 98960.5 102154.5 9425.2 9512.8 9594.7 9608.3 9670.9 46964.8 52060.5 52516.0 53431.0 54136.6 78687.0 82526.0 87363.1 87714.6 90270.5 12318.4 12775.1 12777.9 12802.6 13031.4 14262.7 14361.6 14606.4 14645.8 14759.4 13085.3 13304.5 13437.7 13543.2 13734.7 11984.5 12279.5 12425.4 12516.3 12892.7 12558.6 12752.0 12754.4 13177.9 13549.9 11609.8 11616.4 11763.6 12157.6 12475.7 11849.4 12038.7 12102.6 12214.9 12642.9 16:04:35 INFO - PROCESS | 12216 | -------- Summary: end -------- 16:04:35 INFO - PROCESS | 12216 | 16:04:36 INFO - TEST-INFO | 12216: exit 0 16:04:36 INFO - TEST-OK | dromaeo_css | took 1116428ms 16:04:36 INFO - TEST-START | kraken 16:04:36 INFO - operating with platform_type : linux_ 16:04:36 INFO - Initialising browser for kraken test... 16:04:36 INFO - TEST-INFO | started process 12522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8TNxLU/profile http://localhost:40404/getInfo.html) 16:04:41 INFO - PROCESS | 12522 | __metrics Screen width/height:1600/1200 16:04:41 INFO - PROCESS | 12522 | colorDepth:24 16:04:41 INFO - PROCESS | 12522 | Browser inner width/height: 1024/697 16:04:41 INFO - PROCESS | 12522 | __metrics 16:04:41 INFO - PROCESS | 12522 | 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" 16:04:41 INFO - PROCESS | 12522 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:42 INFO - PROCESS | 12522 | console.error: PushService: 16:04:42 INFO - PROCESS | 12522 | stateChangeProcessEnqueue: Error transitioning state 16:04:42 INFO - PROCESS | 12522 | UnknownError 16:04:42 INFO - TEST-INFO | 12522: exit 0 16:04:42 INFO - Browser initialized. 16:04:42 INFO - Running cycle 1/1 for kraken test... 16:04:42 INFO - TEST-INFO | started process 12603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8TNxLU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:54 INFO - PROCESS | 12603 | RSS: Main: 174170112 16:04:54 INFO - PROCESS | 12603 | 16:04:57 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:58 INFO - PROCESS | 12603 | RSS: Main: 243552256 16:04:58 INFO - PROCESS | 12603 | 16:05:01 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-dft) 16:05:01 INFO - PROCESS | 12603 | RSS: Main: 225714176 16:05:01 INFO - PROCESS | 12603 | 16:05:04 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-fft) 16:05:05 INFO - PROCESS | 12603 | RSS: Main: 303116288 16:05:05 INFO - PROCESS | 12603 | 16:05:07 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-oscillator) 16:05:08 INFO - PROCESS | 12603 | RSS: Main: 209321984 16:05:08 INFO - PROCESS | 12603 | 16:05:10 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:05:10 INFO - PROCESS | 12603 | RSS: Main: 213790720 16:05:10 INFO - PROCESS | 12603 | 16:05:14 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-darkroom) 16:05:14 INFO - PROCESS | 12603 | RSS: Main: 250400768 16:05:14 INFO - PROCESS | 12603 | 16:05:18 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-desaturate) 16:05:18 INFO - PROCESS | 12603 | RSS: Main: 248700928 16:05:18 INFO - PROCESS | 12603 | 16:05:21 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40404/tests/kraken/driver.html?testName=json-parse-financial) 16:05:22 INFO - PROCESS | 12603 | RSS: Main: 248549376 16:05:22 INFO - PROCESS | 12603 | 16:05:23 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:24 INFO - PROCESS | 12603 | RSS: Main: 211755008 16:05:24 INFO - PROCESS | 12603 | 16:05:26 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:26 INFO - PROCESS | 12603 | RSS: Main: 219648000 16:05:26 INFO - PROCESS | 12603 | 16:05:28 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:29 INFO - PROCESS | 12603 | RSS: Main: 223461376 16:05:29 INFO - PROCESS | 12603 | 16:05:32 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:32 INFO - PROCESS | 12603 | RSS: Main: 217780224 16:05:32 INFO - PROCESS | 12603 | 16:05:35 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:36 INFO - PROCESS | 12603 | RSS: Main: 222162944 16:05:36 INFO - PROCESS | 12603 | 16:05:37 INFO - PROCESS | 12603 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40404/tests/kraken/driver.html?testName=ai-astar) 16:05:38 INFO - PROCESS | 12603 | RSS: Main: 273014784 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | __start_tp_report 16:05:38 INFO - PROCESS | 12603 | _x_x_mozilla_page_load 16:05:38 INFO - PROCESS | 12603 | _x_x_mozilla_page_load_details 16:05:38 INFO - PROCESS | 12603 | |i|pagename|runs| 16:05:38 INFO - PROCESS | 12603 | |0;ai-astar;100;110;107;111;111;112;117;111;111;110 16:05:38 INFO - PROCESS | 12603 | |1;audio-beat-detection;151;119;153;202;123;144;151;120;191;117 16:05:38 INFO - PROCESS | 12603 | |2;audio-dft;162;161;161;160;161;160;162;161;163;160 16:05:38 INFO - PROCESS | 12603 | |3;audio-fft;73;77;75;170;76;76;75;77;182;75 16:05:38 INFO - PROCESS | 12603 | |4;audio-oscillator;85;85;147;86;87;86;146;85;85;137 16:05:38 INFO - PROCESS | 12603 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 16:05:38 INFO - PROCESS | 12603 | |6;imaging-darkroom;146;147;145;146;145;145;146;145;145;146 16:05:38 INFO - PROCESS | 12603 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;96 16:05:38 INFO - PROCESS | 12603 | |8;json-parse-financial;49;49;50;51;50;51;51;51;50;50 16:05:38 INFO - PROCESS | 12603 | |9;json-stringify-tinderbox;62;62;61;62;61;62;61;61;62;64 16:05:38 INFO - PROCESS | 12603 | |10;stanford-crypto-aes;82;85;79;79;88;82;85;78;78;79 16:05:38 INFO - PROCESS | 12603 | |11;stanford-crypto-ccm;133;132;127;123;122;138;123;123;155;123 16:05:38 INFO - PROCESS | 12603 | |12;stanford-crypto-pbkdf2;165;163;162;162;163;164;167;165;165;164 16:05:38 INFO - PROCESS | 12603 | |13;stanford-crypto-sha256-iterative;64;68;65;67;65;68;64;68;62;65 16:05:38 INFO - PROCESS | 12603 | __end_tp_report 16:05:38 INFO - PROCESS | 12603 | __start_cc_report 16:05:38 INFO - PROCESS | 12603 | _x_x_mozilla_cycle_collect,1693 16:05:38 INFO - PROCESS | 12603 | __end_cc_report 16:05:38 INFO - PROCESS | 12603 | __startTimestamp1471907138243__endTimestamp 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | ------- Summary: start ------- 16:05:38 INFO - PROCESS | 12603 | Number of tests: 14 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:4.29 (3.9%) stddev-sans-first:2.62 16:05:38 INFO - PROCESS | 12603 | Values: 100.0 110.0 107.0 111.0 111.0 112.0 117.0 111.0 111.0 110.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:151.00 stddev:29.86 (19.8%) stddev-sans-first:31.64 16:05:38 INFO - PROCESS | 12603 | Values: 151.0 119.0 153.0 202.0 123.0 144.0 151.0 120.0 191.0 117.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 16:05:38 INFO - PROCESS | 12603 | Values: 162.0 161.0 161.0 160.0 161.0 160.0 162.0 161.0 163.0 160.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.50 stddev:42.48 (56.3%) stddev-sans-first:44.27 16:05:38 INFO - PROCESS | 12603 | Values: 73.0 77.0 75.0 170.0 76.0 76.0 75.0 77.0 182.0 75.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:85.00 stddev:28.03 (33.0%) stddev-sans-first:28.97 16:05:38 INFO - PROCESS | 12603 | Values: 85.0 85.0 147.0 86.0 87.0 86.0 146.0 85.0 85.0 137.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:05:38 INFO - PROCESS | 12603 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:05:38 INFO - PROCESS | 12603 | Values: 146.0 147.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:05:38 INFO - PROCESS | 12603 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.50 stddev:0.79 (1.6%) stddev-sans-first:0.71 16:05:38 INFO - PROCESS | 12603 | Values: 49.0 49.0 50.0 51.0 50.0 51.0 51.0 51.0 50.0 50.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 16:05:38 INFO - PROCESS | 12603 | Values: 62.0 62.0 61.0 62.0 61.0 62.0 61.0 61.0 62.0 64.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:3.50 (4.3%) stddev-sans-first:3.71 16:05:38 INFO - PROCESS | 12603 | Values: 82.0 85.0 79.0 79.0 88.0 82.0 85.0 78.0 78.0 79.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:129.50 stddev:10.39 (8.0%) stddev-sans-first:10.96 16:05:38 INFO - PROCESS | 12603 | Values: 133.0 132.0 127.0 123.0 122.0 138.0 123.0 123.0 155.0 123.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.50 stddev:1.56 (1.0%) stddev-sans-first:1.62 16:05:38 INFO - PROCESS | 12603 | Values: 165.0 163.0 162.0 162.0 163.0 164.0 167.0 165.0 165.0 164.0 16:05:38 INFO - PROCESS | 12603 | 16:05:38 INFO - PROCESS | 12603 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.11 16:05:38 INFO - PROCESS | 12603 | Values: 64.0 68.0 65.0 67.0 65.0 68.0 64.0 68.0 62.0 65.0 16:05:38 INFO - PROCESS | 12603 | -------- Summary: end -------- 16:05:38 INFO - PROCESS | 12603 | 16:05:39 INFO - TEST-INFO | 12603: exit 0 16:05:39 INFO - TEST-OK | kraken | took 62640ms 16:05:39 INFO - SUITE-END | took 1179s 16:05:39 INFO - Completed test suite (00:19:39) 16:05:39 INFO - javascript benchmark 16:05:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2981.4037192561486, 3030.8939187128453, 3035.984820075898, 3036.3168287135413, 3052.2979714665626, 5233.874716935858, 5378.973105134473, 5380.650257733245, 5458.153986132151, 5475.890482190353, 5304.257403963448, 5337.5196232339085, 5347.812826551071, 5379.6503227290195, 5445.101558242885, 4862.319275301461, 4898.608111351093, 4943.77753001114, 5003.5997120230295, 5005.424376196729, 4981.053599816023, 5039.899202015976, 5040.747962601874, 5045.64680472367, 5050.545450909417, 4785.497522760095, 4843.4430040545085, 4858.076965376567, 4938.827141050064, 4966.975165124151, 4770.976145119287, 4793.261256220154, 4848.757562121879, 4867.318575399447, 4902.068606964665, 4754.762261886926, 4776.713397196145, 4796.640251981115, 4893.584045356149, 4903.043906438246, 5358.169483729989, 5358.33020872391, 5359.866003349908, 5373.140297552372, 5374.91937620936, 5560.666360018412, 5665.830025099253, 5690.857728556778, 5711.62874413166, 5825.1844741736195, 5746.827595172152, 5773.653580785124, 5795.739191736382, 5826.504747096502, 5842.065269556851, 5176.1459359206065, 5392.272043274147, 5398.1362981923485, 5401.189821526802, 5405.4324295949145, 5743.971280143573, 5837.357890632027, 5843.5325173985975, 5897.144913987448, 5906.291245050621, 5630.634008789416, 5639.746211420496, 5643.435656434323, 5645.5201307888465, 5676.063449530781, 5554.50009499147, 5746.712664366765, 5750.453706897838, 5753.395893431213, 5755.510781583528, 5608.747606357723, 5670.262865827416, 5670.489655930986, 5768.682722450306, 5771.192033115367, 5739.024365857814, 5766.308043034863, 5774.82675519735, 5783.045797443375, 5787.739551720183, 4302.204092242945, 4451.866444006685, 4457.064016556495, 4457.77711114443, 4471.5081341052455, 3887.1059656279213, 3914.412838074312, 3958.6041395860184, 3974.2448934702315, 3997.700172487075, 5528.143137813645, 5534.4742249486235, 5534.584906132056, 5534.944650553523, 5536.390996990328, 5588.804391846347, 5829.795957141565, 5840.386759390288, 5846.532277417797, 5854.121881717691, 5393.973030134903, 5441.646292990943, 5463.836084917459, 5528.612997090165, 5532.2531458253425, 4981.950180498148, 4982.60139188864, 4994.625403094782, 4995.650304478651, 5004.299398084198, 5780.624259423124, 6017.037274036134, 6027.336992930686, 6032.185654936615, 6035.275766907999, 5732.0, 5746.281714785652, 5747.8563035924435, 5842.415758424124, 5865.384134665969, 6007.158997740407, 6009.2188015557695, 6011.519078473799, 6018.097285407049, 6030.185924900083, 5459.39946605881, 5693.715314234355, 5710.914336285042, 5739.139129130664, 5747.48272655463, 5681.119426488901, 5694.658320500783, 5732.942670573241, 5791.478766910998, 5801.3908539602735, 5646.491815736604, 5680.11958146488, 5683.829485115453, 5684.118961560965, 5689.260396148474, 5457.781688732406, 5653.604247702786, 5662.915056274077, 5664.433556644302, 5664.886702265849, 5508.91736623959, 5534.252875861707, 5557.3331200256225, 5644.745986430703, 5647.774089036392, 5730.770769169187, 5741.052726300114, 5748.396418376177, 5752.424757524214, 5755.827325180251, 5311.840644780663, 5574.470425309589, 5577.749001295033, 5583.106702927512, 5598.524125449382], "value": 5310.928878254655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9158626206068, 579.6666916523001, 588.7939221272554, 590.3181824992135, 606.2724730323613, 42724.14551708964, 44403.33394999074, 44462.555374446245, 49094.75452622741, 49104.50895491044, 45560.54439455605, 46238.53761462384, 46276.76861615687, 46339.30491042637, 46417.535824641745, 8889.688860889853, 9022.639094436248, 9032.819343613124, 9033.141851524128, 9037.231835294007, 9032.412893161956, 9111.68109116181, 9119.316051296146, 9123.0, 9126.863097053549, 9080.455172689626, 9096.0, 9107.499087550183, 9141.680041198559, 9152.633894644207, 8981.64073437065, 9001.324900632479, 9017.729468115967, 9023.458592484472, 9055.230305424047, 8928.330375221884, 9003.189712925869, 9009.59456824438, 9013.549322533912, 9016.504092274923, 43664.0, 44352.778236108614, 44384.0, 44442.111157776664, 44492.0, 3555.520004799371, 3626.075350785533, 3674.8530058797614, 3716.3682174030478, 4013.5986401359633, 32069.83965080183, 32353.0, 32419.0, 32531.67468325334, 32798.67201328004, 4315.848945286932, 4321.135772845412, 4359.651227901761, 4383.145286669101, 4420.09388075447, 371540.0, 373109.0, 373118.0, 373969.0, 373986.13006935065, 59637.0, 59945.0, 60099.39900600938, 60165.39834601685, 60180.0, 34271.0, 64874.0, 64964.67517662476, 65009.0, 65022.67488662621, 16938.661226775643, 17803.821961780475, 17806.109694515224, 17838.821611783977, 17884.195211215527, 13241.337933103307, 13753.449862005607, 13762.24307663068, 13762.311884405739, 13764.036517443683, 19597.412077637695, 19628.313009044614, 19646.508837279183, 19785.60428791416, 19796.50508737293, 7076.787696369117, 7157.713691452388, 7215.963920180366, 7250.854982900312, 7313.524620899624, 955.4171955107379, 1016.3546148195801, 1022.3354819367322, 1175.2595864605244, 1180.7579446213506, 33414.49878251828, 33504.24451604533, 33507.49738753921, 33566.49650255248, 34017.0, 896.6727144592177, 1063.122923588043, 1133.7235389723705, 1161.7095726068483, 1203.560700344368, 16995.575110622332, 17347.566310842078, 17539.912300438416, 17619.207135678924, 17620.559486012695, 567105.7960073358, 567589.0, 572696.0, 573624.0, 575092.0, 60576.09135862966, 61071.0, 61225.38774612197, 61672.0, 61720.0, 1216.653253822674, 1298.6818229533824, 1300.6683295759522, 1309.2471828698535, 1351.4526616720243, 32182.678173218905, 33479.49780753242, 34047.0, 34169.0, 34349.65650343464, 51647.225291621406, 52273.7386313066, 52370.0, 52392.7380363111, 52453.7377313111, 409505.8098837947, 410122.0, 411618.0, 411851.0, 412260.0, 28245.57631635486, 29204.56193157147, 29601.407971840013, 30613.387732245676, 30874.53688194724, 49806.75096624494, 50047.249291259934, 50055.74972125116, 50614.49385506245, 51205.7439712799, 41251.0, 41372.793136034124, 42047.0, 42251.57748422599, 43801.56198438102, 41382.37926431046, 41680.58319416888, 41913.58086419219, 42816.357754633085, 43123.56876431195, 41605.37591936063, 41704.791476042425, 42296.365554517324, 42542.574574253864, 42939.0, 33128.0, 38001.0, 38049.42925856059, 38059.42910856395, 39318.41022384724, 27982.580261296505, 28083.71916280811, 28088.43823123567, 28120.156395308175, 28175.859120704266], "value": 20626.562942450113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.074855854598, 392.7447159346426, 397.3919902549099, 399.9720019598627, 416.32763087613495, 14174.440811510738, 17250.568735781613, 18092.4572262832, 19362.419127426183, 19375.903120484414, 19126.52183695408, 19239.0, 19267.0, 19485.805141948575, 19516.0, 5695.345035320939, 5841.065429531276, 5868.911966320508, 5916.940830591682, 5918.319393269786, 5593.356763972134, 5833.941660583403, 5843.970780146094, 5850.619709718854, 5851.444112809298, 5557.72211389431, 5784.942150578503, 5806.332271788756, 5814.941850581504, 5820.272465941757, 5953.642781433106, 6092.634441933498, 6094.695265236721, 6097.847553811168, 6099.146119543268, 5250.6324557281005, 5500.779968801243, 5537.36320323164, 5606.915896261559, 5915.408459154093, 14083.436662533486, 14295.213763243017, 15015.0, 18786.53033674169, 19014.61970760577, 2221.589006033889, 2229.9219527316627, 2340.379799353173, 2413.71035475744, 2833.4191490744347, 9305.162535371848, 9594.184494317991, 10110.595576176944, 10186.388816671024, 10201.744956376077, 1869.336385583112, 1944.513871532117, 1945.387203031055, 1973.6940774180025, 1991.2632326039459, 75728.0, 80456.79314810282, 81688.59155704243, 81713.0, 82917.0, 10756.139508839431, 10765.461726913623, 11177.552897884156, 11359.261647993018, 11398.829017564743, 15699.450519232001, 15743.212839357986, 15750.527484175493, 15763.211839408214, 15766.842331576767, 7895.0, 8202.179782021869, 8208.835823283502, 8380.0, 8455.830883382421, 7772.727954521564, 7888.211178882066, 7948.801279967932, 8291.295239904555, 8312.41813073079, 4751.168545504523, 4790.736509491941, 4797.976010119997, 4825.782839772219, 4935.235038569028, 1920.9519762006062, 2008.0080679787013, 2009.8995050247722, 2011.647961606713, 2031.7155598216261, 886.601029536711, 971.4268581536927, 987.521052289639, 1032.5560009196117, 1038.5274700011478, 19768.20927162926, 20042.498937526387, 20083.297084601967, 20219.797802022087, 20371.4907127323, 1005.648023191877, 1018.8267994440963, 1036.0571879589688, 1043.7547176413536, 1045.4772613693153, 10559.99680030396, 11175.419438101824, 11219.214654974237, 11309.49107290174, 11390.430478476042, 417399.0, 418845.0, 454364.0, 471626.0, 475606.0, 56317.0, 67696.32303676999, 86314.56842715746, 87420.1257987412, 87835.12164878397, 989.4656885282011, 1011.8026984738052, 1039.308859608352, 1040.3185913226848, 1049.4070849969742, 16609.83390166083, 16940.915295423445, 17411.301248306532, 17786.822131779034, 17876.91061544684, 42168.0, 42731.786341068095, 43404.34893476663, 43633.781831090644, 43664.345034825135, 55783.0, 57938.4206157933, 58889.4111058901, 59443.702781485816, 60050.39949600448, 8156.83686326282, 8673.653053878026, 8693.869591956, 8710.12898710124, 8764.21122099014, 9640.276979226726, 11345.773084538429, 12302.876971230173, 12722.427490763122, 12918.354082296035, 10676.199285053808, 11027.44862756875, 11116.555337786398, 11501.82747258775, 11537.250078744855, 11254.549818007188, 11492.770144596894, 11500.8821074621, 11645.41772911368, 11860.584879529175, 11018.283811552223, 11403.372814494951, 11716.765664686829, 11857.229280096766, 12114.273143611412, 8512.829743405222, 8640.611172497127, 8749.212570868653, 8811.206991370807, 8828.911710882809, 10522.159017065502, 10904.236703430684, 11022.724431889266, 11027.44862756875, 11430.371329576954], "value": 9077.411657685376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.261382546512, 1446.6961937993024, 1490.0835985868691, 1582.5964379083332, 1750.6148647297598, 8373.120822313653, 8647.092055334186, 8780.209781119689, 8975.506347150904, 8993.775155621097, 8815.911840881588, 8913.465192088479, 8926.509042002688, 8930.508822014786, 8937.419067760591, 2051.5178932950744, 2295.9770402296012, 2387.04518192723, 2411.6261979393134, 2412.2883749294, 2330.207729372013, 2382.60686986647, 2383.2254517281867, 2383.5113801670705, 2384.7138343398815, 2320.5474932388192, 2367.5028244068767, 2379.3218932604213, 2383.3207535852284, 2398.3404563744934, 2232.620454522735, 2292.7592602776717, 2302.8848557572055, 2302.988485057581, 2316.791488766002, 2353.2822489140804, 2362.2204672458047, 2368.171140100968, 2369.7037870266217, 2372.5373552157334, 8817.118288171196, 8863.157999989991, 8874.0, 8874.334424918157, 8877.112288771072, 5142.1772516397195, 5297.49673780994, 5331.360236771612, 5332.040232758102, 5337.11937530307, 3257.774346010663, 3326.301476689898, 3337.4826901830256, 3395.9490607640905, 3432.090496018557, 1140.116409782417, 1144.4792619358254, 2200.559888022386, 2224.6996655451467, 2274.1352091285153, 12039.39803009846, 12120.939395303056, 12132.939335303356, 12161.027117830641, 12186.57346992851, 4245.639120674716, 4311.525732169459, 4473.552644735565, 4482.731036137842, 4512.729236245836, 9628.951855240679, 9639.855402168972, 9642.325037247465, 9647.421154730599, 9648.372855764494, 5145.331106956071, 5179.585633149339, 5189.481051894781, 5190.8183213587345, 5191.740412979411, 4235.53409124996, 4296.91406171881, 4422.71252368595, 4704.482506924235, 4789.856304310876, 3630.618785027587, 3706.5366829146355, 3819.9427008594894, 3825.8660946866726, 3843.7309388343106, 1109.7170221593603, 1115.2249186815247, 1116.5757012335423, 1118.7426891814766, 1118.9384583847805, 947.3131979314942, 949.8432758594893, 954.5847556312888, 957.4111921168432, 991.9980819372486, 5630.268065151504, 5972.850678733066, 6032.095185722089, 6034.2155519782145, 6171.475424588871, 462.48663982978866, 466.3471140403395, 467.82456578782956, 469.76746510477534, 470.4190324948686, 3993.740406873544, 4148.319930428182, 4170.624643782075, 4194.895127621773, 4219.578042195756, 10332.328398654063, 10665.466726663792, 10717.892821071846, 10795.0, 10801.513931873085, 10615.150787936947, 10622.575096996034, 10640.148788096934, 10649.787004259872, 10678.145748340114, 7770.961145194238, 7939.523628582304, 8047.557384343917, 8102.027756669119, 8103.635336409876, 5943.910841337297, 6045.75816967334, 6065.090236464389, 6138.14066030765, 6150.261968563801, 10112.0, 10165.339252948535, 10186.898131018595, 10310.742231444274, 10442.738931526772, 9867.11195992364, 10233.84649230277, 10242.539085741011, 10454.63408780689, 10509.369437833755, 6957.339052789976, 7422.628868556659, 7437.739679111205, 7601.315881570686, 7616.923830761843, 8232.135625759449, 8347.499150051017, 8361.83276334482, 8386.0, 8389.119142490195, 7336.339729424378, 7437.442191835742, 7533.698652053857, 7593.848123037619, 7750.302472777477, 7360.77917662471, 7367.705291788483, 7575.848483030199, 7598.430117741302, 7619.314261716472, 6701.0953521274005, 6808.38724514796, 6826.112605361272, 6840.863182736218, 6843.520953533205, 5115.437301896863, 5163.948360516347, 5226.790928362823, 5336.279602253646, 5373.328333958255, 5066.316047333563, 5278.89442211146, 5283.735813209248, 5298.97350513245, 5376.0], "value": 4553.5526335781715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.2325010723299, 312.71386681186715, 316.9001764444201, 322.7160099112782, 326.4401551339452, 5229.686218826868, 5243.292155558998, 5247.711375874325, 5258.868528286795, 5309.177077552986, 5184.963007398526, 5194.662346947446, 5214.426413094557, 5225.451327610604, 5230.947690523094, 4133.751974881502, 4138.937915931264, 4139.2135494256145, 4159.667226621863, 4174.457320548325, 3862.80685965702, 4085.3871919212206, 4088.4276201331836, 4103.958960410388, 4122.855700050499, 4019.899502512446, 4020.477337946063, 4033.1127152026506, 4034.6368826805583, 4035.59644035597, 3828.636279553438, 3893.3186692329014, 4028.5971402859773, 4036.838526458953, 4045.2111838191563, 3522.6829585337186, 3540.8760693375866, 3546.8758593449106, 3551.4317709166407, 3556.928861422757, 5090.363704536933, 5102.36220472441, 5102.877366979295, 5116.590672746172, 5135.101357262464, 4375.78121093944, 4385.780710964439, 4637.886907142295, 4645.488996210414, 4645.744484053375, 5388.568914486832, 5406.621536492447, 5428.972855135738, 5451.809186678487, 5454.154606036071, 3868.723321303963, 3877.3908827836694, 3888.1251718363424, 3909.648131668135, 3927.3127202739693, 5636.464535869086, 5642.6614403135945, 5676.3755986841825, 5736.967345877741, 5777.971110144465, 3971.669490720641, 3973.5827738087664, 3982.0, 3982.9246103551877, 3996.7801770902297, 4046.0, 4049.635532802062, 4058.3563656719075, 4060.309747342959, 4064.6545043671617, 4556.086443693656, 4658.883527911761, 4669.276262179367, 4670.206064968964, 4681.110588988081, 5469.234307196995, 5470.362209130963, 5488.835334939959, 5503.834884953458, 5573.303337082864, 1355.6308128789992, 1381.2265131526378, 1382.156884300576, 1387.7363300972784, 1388.1324172392256, 838.1241602525375, 885.9202671759443, 888.9377743558018, 892.7546073227811, 900.7612982559496, 4700.55344742249, 4705.423877852856, 4708.152532544175, 4725.0, 4738.526147385234, 4880.804767809319, 4917.803287868517, 4949.48030456804, 4976.527229913152, 5034.219695947134, 4439.713547522963, 4660.277656963109, 4695.483496815347, 4746.525347465225, 4802.980884975209, 2608.3697688944408, 2618.6595742553345, 2800.9859950700525, 2901.7678585713093, 2960.7483363914307, 5745.655260684289, 5763.769449222068, 5775.815957728655, 5790.826275211666, 5791.7683292667825, 5522.674558106026, 5698.230738850285, 5702.657840529581, 5709.942900571024, 5721.971390143022, 5703.08750599902, 5725.541956643458, 5736.655800651891, 5744.51171650406, 5761.798337058183, 5548.583856210881, 5559.555235581225, 5581.7209139543675, 5585.3297604287745, 5626.803061892814, 5284.097724819139, 5492.80775172883, 5521.426393477839, 5543.805966791143, 5553.8333849984565, 5708.200851880823, 5710.428957104256, 5715.942840571541, 5738.454846789548, 5749.97125014389, 3909.9638595772713, 3963.682905367506, 3978.801059947049, 3992.7205095643026, 3999.3001224786126, 5504.834854954198, 5588.6646801192055, 5596.048671725898, 5615.354234263112, 5669.688167150846, 5426.348838139291, 5426.70153141581, 5434.701091439851, 5445.727713614383, 5450.964316779799, 5303.70812207976, 5359.785608575613, 5368.248445217595, 5435.673859568438, 5473.2063850742215, 5316.129290183258, 5370.409254981871, 5380.300560927054, 5394.32570928634, 5404.351477822686, 5461.617686761889, 5471.37079235893, 5479.369872464717, 5485.396606373375, 5487.506124448819, 5139.537441630271, 5339.225812257278, 5370.892582148257, 5376.704281264568, 5380.838574842761], "value": 4102.944370350289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.1261030899003, 761.3034073822453, 775.344833615595, 812.3460614205569, 878.4202426398576, 14925.402983880645, 15467.535973920787, 15492.612684682888, 15498.767518487204, 15547.455839045622, 15945.760813587805, 16353.427630032951, 16569.420070297543, 16601.169941502936, 16609.086500242483, 789.7551758954743, 815.5799763121968, 819.5246756880995, 820.1060843680388, 820.6143112737004, 667.3360006793223, 780.5589841739427, 808.312934006096, 814.9837003259931, 816.322452364536, 850.7532815483534, 851.059579165023, 851.5444237333028, 853.2491407561369, 853.4793775796759, 852.1861622150831, 852.7569642651846, 852.8081181734091, 853.0275485946026, 853.2150421612132, 504.9772760225799, 599.466474837395, 614.4807637546267, 615.7660089166133, 617.7158507086746, 15765.527034188992, 15806.683866322724, 15807.130607816565, 15819.288132033971, 15828.208589570475, 13749.175049497062, 13857.653558661013, 14258.786118208236, 14411.639709007253, 14454.710905781825, 13501.527446539323, 13741.793873091912, 13826.446942122304, 14026.85973140276, 14871.0, 4459.955400446019, 4505.414296141514, 4540.205464043812, 4665.136949664323, 4757.548032936866, 55276.0, 83663.0, 83775.0, 83953.16046839576, 84103.5794821022, 10309.175265978854, 10501.0, 10980.890191098146, 11173.32960022385, 11491.54033838637, 21304.893475532834, 21325.253616123362, 21326.0, 21339.46651333729, 21383.25158619441, 8531.74404767858, 8766.60550275239, 8770.298376129895, 8825.69110081157, 8924.821503569892, 5054.166062599704, 5061.746912654353, 5098.872528186825, 5164.664296820694, 5236.423993360727, 3249.431349513826, 3330.7501937354796, 3359.260962588227, 3360.781549199294, 3378.7634865559176, 563.39997902234, 566.1762136091976, 570.3896830391524, 593.6260156101715, 593.8782549577327, 498.03381440006274, 684.6816230452863, 715.2918610575492, 727.298157278229, 791.2799352589117, 9245.676401325922, 10094.899051009395, 10586.771034834295, 10637.680869573926, 10882.510287037103, 671.8857794175002, 700.3976580141075, 759.8252401947583, 760.0878945265704, 783.3811289081675, 4683.718976861399, 4940.654154209171, 4970.502949705001, 5074.898502030012, 5120.361484325054, 69718.0, 117290.41354793172, 126494.0, 126910.36544817218, 130332.0, 109595.0, 110910.0, 111614.95465408152, 112142.43928780303, 116932.41533792447, 95646.52176739211, 97309.5134524337, 97358.0, 98960.50519747355, 102154.4892275534, 9425.198858096865, 9512.809743805223, 9594.712158635251, 9608.327417080738, 9670.854937175807, 46964.7651761739, 52060.47939520556, 52516.0, 53431.0, 54136.56385462743, 78687.0, 82526.0, 87363.12636873804, 87714.561427195, 90270.54864725635, 12318.445669944695, 12775.105742597929, 12777.872221277668, 12802.573461674428, 13031.413586388824, 14262.71474570482, 14361.569152925429, 14606.415743370146, 14645.780313295521, 14759.409623615365, 13085.280309583064, 13304.534341298007, 13437.664058398619, 13543.187408755506, 13734.65663358424, 11984.46069926838, 12279.508819647113, 12425.44085516172, 12516.31160286193, 12892.742145157232, 12558.623241302776, 12752.0, 12754.362281886055, 13177.934110329386, 13549.864501355254, 11609.767804644029, 11616.361100139573, 11763.588274410355, 12157.635270941886, 12475.688107797378, 11849.407529623657, 12038.703309521974, 12102.576409825613, 12214.877851221729, 12642.936785316382], "value": 7738.720246707499, "unit": "score"}], "name": "dromaeo_css", "value": 7238.030665540867, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 107.0, 111.0, 111.0, 112.0, 117.0, 111.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 153.0, 202.0, 123.0, 144.0, 151.0, 120.0, 191.0, 117.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0, 163.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 75.0, 170.0, 76.0, 76.0, 75.0, 77.0, 182.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 86.0, 87.0, 86.0, 146.0, 85.0, 85.0, 137.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 50.0, 51.0, 50.0, 51.0, 51.0, 51.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 64.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 79.0, 79.0, 88.0, 82.0, 85.0, 78.0, 78.0, 79.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 127.0, 123.0, 122.0, 138.0, 123.0, 123.0, 155.0, 123.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 162.0, 163.0, 164.0, 167.0, 165.0, 165.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 65.0, 67.0, 65.0, 68.0, 64.0, 68.0, 62.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1527.2, "alertThreshold": 2.0}]} 16:05:39 INFO - Return code: 0 16:05:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:05:40 INFO - # TBPL SUCCESS # 16:05:40 INFO - Running post-action listener: _resource_record_post_action 16:05:40 INFO - [mozharness: 2016-08-22 23:05:40.040015Z] Finished run-tests step (success) 16:05:40 INFO - Running post-run listener: _resource_record_post_run 16:05:40 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 407519232; Read time: 344; Write time: 311144 16:05:40 INFO - TinderboxPrint: CPU usage
13.3% 16:05:40 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 344 16:05:40 INFO - TinderboxPrint: I/O write bytes / time
407,519,232 / 311,144 16:05:40 INFO - TinderboxPrint: CPU idle
8,278.9 (86.7%) 16:05:40 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 16:05:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:05:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119832576; Read time: 148; Write time: 105308 16:05:40 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287223808; Read time: 188; Write time: 205836 16:05:40 INFO - Running post-run listener: _upload_blobber_files 16:05:40 INFO - Blob upload gear active. 16:05:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:05:40 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 16:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:05:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:42 INFO - (blobuploader) - INFO - Done attempting. 16:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:45 INFO - (blobuploader) - INFO - Done attempting. 16:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:46 INFO - (blobuploader) - INFO - Done attempting. 16:05:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:46 INFO - Return code: 0 16:05:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d93d52f2020a33956952c447037a5d737651046302c83b7abefd3f1c91652a26c049ce62caa5e5ade819f0ec4776f6c74a946b7e824bc2ed0ca7b8e1e685700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6fffec43262298c3e8f458edf913e92f706ca6ee82c360ffd8a522be57eb45b3f18c483871d48246653c5e5725d8d93462ee81c212ef836ae84731d3910a4bbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/267a10d4e12bbb2483779c8744fc7a9e38e2ded5c63ef6a0793004b3bd6d4b611412940b0fc7bfd5bb4f5ca4298b62c97c449749c757dd5fde9910feaab1b487"} 16:05:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:46 INFO - Contents: 16:05:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d93d52f2020a33956952c447037a5d737651046302c83b7abefd3f1c91652a26c049ce62caa5e5ade819f0ec4776f6c74a946b7e824bc2ed0ca7b8e1e685700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6fffec43262298c3e8f458edf913e92f706ca6ee82c360ffd8a522be57eb45b3f18c483871d48246653c5e5725d8d93462ee81c212ef836ae84731d3910a4bbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/267a10d4e12bbb2483779c8744fc7a9e38e2ded5c63ef6a0793004b3bd6d4b611412940b0fc7bfd5bb4f5ca4298b62c97c449749c757dd5fde9910feaab1b487"} 16:05:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:46 INFO - Copying logs to upload dir... 16:05:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.089600 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-22 16:05:45.956136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:05:45.960563) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d93d52f2020a33956952c447037a5d737651046302c83b7abefd3f1c91652a26c049ce62caa5e5ade819f0ec4776f6c74a946b7e824bc2ed0ca7b8e1e685700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6fffec43262298c3e8f458edf913e92f706ca6ee82c360ffd8a522be57eb45b3f18c483871d48246653c5e5725d8d93462ee81c212ef836ae84731d3910a4bbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/267a10d4e12bbb2483779c8744fc7a9e38e2ded5c63ef6a0793004b3bd6d4b611412940b0fc7bfd5bb4f5ca4298b62c97c449749c757dd5fde9910feaab1b487"} build_url:https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/N1uxnPtCR0eXwHDMPfPCTw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d93d52f2020a33956952c447037a5d737651046302c83b7abefd3f1c91652a26c049ce62caa5e5ade819f0ec4776f6c74a946b7e824bc2ed0ca7b8e1e685700", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6fffec43262298c3e8f458edf913e92f706ca6ee82c360ffd8a522be57eb45b3f18c483871d48246653c5e5725d8d93462ee81c212ef836ae84731d3910a4bbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/267a10d4e12bbb2483779c8744fc7a9e38e2ded5c63ef6a0793004b3bd6d4b611412940b0fc7bfd5bb4f5ca4298b62c97c449749c757dd5fde9910feaab1b487"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:05:45.990874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:05:45.991319) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471905904.934252-1002398202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:05:46.077340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:05:46.078075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:05:46.078673) ========= ========= Total master_lag: 0.19 =========