builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1469023793.94 results: success (0) buildid: 20160720043044 builduid: d47e0a09cbe344e09f6986b39c6d9b17 revision: ed8e23b5e0c7b739e61173bb180cf3410a306679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:53.942849) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:53.943716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:53.943998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:53.980076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:53.980466) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 07:09:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-20 07:09:54 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.090065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.090388) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.140183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.140556) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ed8e23b5e0c7b739e61173bb180cf3410a306679 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ed8e23b5e0c7b739e61173bb180cf3410a306679 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 07:09:54,279 truncating revision to first 12 chars 2016-07-20 07:09:54,279 Setting DEBUG logging. 2016-07-20 07:09:54,279 attempt 1/10 2016-07-20 07:09:54,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ed8e23b5e0c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 07:09:54,580 unpacking tar archive at: mozilla-central-ed8e23b5e0c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.808596) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.808904) ========= script_repo_revision: ed8e23b5e0c7b739e61173bb180cf3410a306679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.809297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.809565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:54.819322) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-20 07:09:54.819768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:55 INFO - MultiFileLogger online at 20160720 07:09:55 in /builds/slave/test 07:09:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:09:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:55 INFO - {'append_to_log': False, 07:09:55 INFO - 'base_work_dir': '/builds/slave/test', 07:09:55 INFO - 'blob_upload_branch': 'Firefox', 07:09:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:55 INFO - 'branch': 'Firefox', 07:09:55 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:55 INFO - 'config_files': ('talos/linux_config.py',), 07:09:55 INFO - 'default_actions': ('clobber', 07:09:55 INFO - 'read-buildbot-config', 07:09:55 INFO - 'download-and-extract', 07:09:55 INFO - 'populate-webroot', 07:09:55 INFO - 'create-virtualenv', 07:09:55 INFO - 'install', 07:09:55 INFO - 'run-tests'), 07:09:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:55 INFO - 'download_minidump_stackwalk': True, 07:09:55 INFO - 'download_symbols': 'ondemand', 07:09:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:55 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:55 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:55 INFO - 'installer_path': 'installer.exe', 07:09:55 INFO - 'log_level': 'info', 07:09:55 INFO - 'log_name': 'talos', 07:09:55 INFO - 'log_to_console': True, 07:09:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:55 INFO - 'opt_config_files': (), 07:09:55 INFO - 'pip_index': False, 07:09:55 INFO - 'sps_profile': False, 07:09:55 INFO - 'sps_profile_interval': 0, 07:09:55 INFO - 'suite': 'dromaeojs', 07:09:55 INFO - 'system_bits': '32', 07:09:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:55 INFO - 'title': 'talos-linux64-ix-002', 07:09:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:55 INFO - 'use_talos_json': True, 07:09:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:55 INFO - 'work_dir': 'build'} 07:09:55 INFO - [mozharness: 2016-07-20 14:09:55.049114Z] Running clobber step. 07:09:55 INFO - Running pre-action listener: _resource_record_pre_action 07:09:55 INFO - Running main action method: clobber 07:09:55 INFO - rmtree: /builds/slave/test/build 07:09:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:55 INFO - Running post-action listener: _resource_record_post_action 07:09:55 INFO - [mozharness: 2016-07-20 14:09:55.518471Z] Finished clobber step (success) 07:09:55 INFO - [mozharness: 2016-07-20 14:09:55.518572Z] Running read-buildbot-config step. 07:09:55 INFO - Running pre-action listener: _resource_record_pre_action 07:09:55 INFO - Running main action method: read_buildbot_config 07:09:55 INFO - Using buildbot properties: 07:09:55 INFO - { 07:09:55 INFO - "project": "", 07:09:55 INFO - "product": "firefox", 07:09:55 INFO - "script_repo_revision": "production", 07:09:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:09:55 INFO - "repository": "", 07:09:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:09:55 INFO - "buildid": "20160720043044", 07:09:55 INFO - "pgo_build": "True", 07:09:55 INFO - "basedir": "/builds/slave/test", 07:09:55 INFO - "buildnumber": 402, 07:09:55 INFO - "slavename": "talos-linux64-ix-002", 07:09:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:09:55 INFO - "platform": "ubuntu64_hw", 07:09:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:09:55 INFO - "branch": "mozilla-central", 07:09:55 INFO - "repo_path": "mozilla-central", 07:09:55 INFO - "revision": "ed8e23b5e0c7b739e61173bb180cf3410a306679", 07:09:55 INFO - "stage_platform": "linux64-pgo", 07:09:55 INFO - "builduid": "d47e0a09cbe344e09f6986b39c6d9b17", 07:09:55 INFO - "slavebuilddir": "test" 07:09:55 INFO - } 07:09:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:09:55 INFO - Running post-action listener: _resource_record_post_action 07:09:55 INFO - [mozharness: 2016-07-20 14:09:55.521032Z] Finished read-buildbot-config step (success) 07:09:55 INFO - [mozharness: 2016-07-20 14:09:55.521121Z] Running download-and-extract step. 07:09:55 INFO - Running pre-action listener: _resource_record_pre_action 07:09:55 INFO - Running main action method: download_and_extract 07:09:55 INFO - mkdir: /builds/slave/test/build/tests 07:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:55 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:09:58 INFO - Downloaded 1361 bytes. 07:09:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:58 INFO - Using the following test package requirements: 07:09:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'jsshell-linux-x86_64.zip'], 07:09:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:09:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:58 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:10:02 INFO - Downloaded 24343549 bytes. 07:10:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:10:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:10:03 INFO - Return code: 0 07:10:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:03 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:10:09 INFO - Downloaded 24343549 bytes. 07:10:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:10:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:10:11 INFO - Return code: 0 07:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:11 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:10:12 INFO - Downloaded 14403317 bytes. 07:10:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:10:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:10:12 INFO - Return code: 0 07:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:12 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:10:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:10:14 INFO - Downloaded 60899593 bytes. 07:10:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:14 INFO - mkdir: /builds/slave/test/properties 07:10:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:14 INFO - Contents: 07:10:14 INFO - build_url:https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:10:15 INFO - Running post-action listener: _resource_record_post_action 07:10:15 INFO - Running post-action listener: set_extra_try_arguments 07:10:15 INFO - [mozharness: 2016-07-20 14:10:15.003406Z] Finished download-and-extract step (success) 07:10:15 INFO - [mozharness: 2016-07-20 14:10:15.003640Z] Running populate-webroot step. 07:10:15 INFO - Running pre-action listener: _resource_record_pre_action 07:10:15 INFO - Running main action method: populate_webroot 07:10:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:15 INFO - '--tppagecycles', 07:10:15 INFO - '7'], 07:10:15 INFO - 'tests': ['tsvgm']}}, 07:10:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:10:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:10:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:10:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['damp', 'tps']}, 07:10:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'tests': ['damp', 'tps']}, 07:10:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['dromaeo_dom']}, 07:10:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['basic_compositor_video']}, 07:10:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:10:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['a11yr', 07:10:15 INFO - 'ts_paint', 07:10:15 INFO - 'tpaint', 07:10:15 INFO - 'sessionrestore', 07:10:15 INFO - 'sessionrestore_no_auto_restore', 07:10:15 INFO - 'tabpaint']}, 07:10:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:10:15 INFO - 'ts_paint', 07:10:15 INFO - 'tpaint', 07:10:15 INFO - 'sessionrestore', 07:10:15 INFO - 'sessionrestore_no_auto_restore', 07:10:15 INFO - 'tabpaint']}, 07:10:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:10:15 INFO - 'ts_paint', 07:10:15 INFO - 'tpaint', 07:10:15 INFO - 'sessionrestore', 07:10:15 INFO - 'sessionrestore_no_auto_restore', 07:10:15 INFO - 'tabpaint']}, 07:10:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:10:15 INFO - 'ts_paint', 07:10:15 INFO - 'tpaint', 07:10:15 INFO - 'sessionrestore', 07:10:15 INFO - 'sessionrestore_no_auto_restore', 07:10:15 INFO - 'tabpaint']}, 07:10:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['a11yr', 07:10:15 INFO - 'ts_paint', 07:10:15 INFO - 'tpaint', 07:10:15 INFO - 'sessionrestore', 07:10:15 INFO - 'sessionrestore_no_auto_restore', 07:10:15 INFO - 'tabpaint']}, 07:10:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['a11yr', 07:10:15 INFO - 'ts_paint', 07:10:15 INFO - 'tpaint', 07:10:15 INFO - 'sessionrestore', 07:10:15 INFO - 'sessionrestore_no_auto_restore', 07:10:15 INFO - 'tabpaint']}, 07:10:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['tsvgx', 07:10:15 INFO - 'tsvgr_opacity', 07:10:15 INFO - 'tart', 07:10:15 INFO - 'tscrollx', 07:10:15 INFO - 'cart']}, 07:10:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:10:15 INFO - 'tsvgr_opacity', 07:10:15 INFO - 'tart', 07:10:15 INFO - 'tscrollx', 07:10:15 INFO - 'cart']}, 07:10:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'talos_options': ['--disable-e10s'], 07:10:15 INFO - 'tests': ['tp5o']}, 07:10:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'tests': ['tp5o']}, 07:10:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'talos_options': ['--disable-e10s', 07:10:15 INFO - '--xperf_path', 07:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:15 INFO - 'tests': ['tp5n']}, 07:10:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:15 INFO - 'talos_options': ['--xperf_path', 07:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:15 INFO - 'tests': ['tp5n']}}, 07:10:15 INFO - 'talos.zip': {'path': '', 07:10:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:15 INFO - Running post-action listener: _resource_record_post_action 07:10:15 INFO - [mozharness: 2016-07-20 14:10:15.024605Z] Finished populate-webroot step (success) 07:10:15 INFO - [mozharness: 2016-07-20 14:10:15.024694Z] Running create-virtualenv step. 07:10:15 INFO - Running pre-action listener: _resource_record_pre_action 07:10:15 INFO - Running main action method: create_virtualenv 07:10:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:15 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 07:10:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:10:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:15 INFO - Using real prefix '/usr' 07:10:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:17 INFO - Installing pip.................done. 07:10:17 INFO - Return code: 0 07:10:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:17 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:17 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 07:10:17 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 07:10:17 INFO - Using env: {'DISPLAY': ':0', 07:10:17 INFO - 'HOME': '/home/cltbld', 07:10:17 INFO - 'LANG': 'en_US.UTF-8', 07:10:17 INFO - 'LANGUAGE': 'en_US:en', 07:10:17 INFO - 'LOGNAME': 'cltbld', 07:10:17 INFO - 'MAIL': '/var/mail/cltbld', 07:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:17 INFO - 'MOZ_NO_REMOTE': '1', 07:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:17 INFO - 'NO_EM_RESTART': '1', 07:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:17 INFO - 'PWD': '/builds/slave/test', 07:10:17 INFO - 'SHELL': '/bin/bash', 07:10:17 INFO - 'SHLVL': '1', 07:10:17 INFO - 'TERM': 'linux', 07:10:17 INFO - 'TMOUT': '86400', 07:10:17 INFO - 'USER': 'cltbld', 07:10:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:17 INFO - '_': '/tools/buildbot/bin/python'} 07:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:17 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 07:10:17 INFO - Cleaning up... 07:10:17 INFO - Return code: 0 07:10:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:17 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:17 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 07:10:17 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 07:10:17 INFO - Using env: {'DISPLAY': ':0', 07:10:17 INFO - 'HOME': '/home/cltbld', 07:10:17 INFO - 'LANG': 'en_US.UTF-8', 07:10:17 INFO - 'LANGUAGE': 'en_US:en', 07:10:17 INFO - 'LOGNAME': 'cltbld', 07:10:17 INFO - 'MAIL': '/var/mail/cltbld', 07:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:17 INFO - 'MOZ_NO_REMOTE': '1', 07:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:17 INFO - 'NO_EM_RESTART': '1', 07:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:17 INFO - 'PWD': '/builds/slave/test', 07:10:17 INFO - 'SHELL': '/bin/bash', 07:10:17 INFO - 'SHLVL': '1', 07:10:17 INFO - 'TERM': 'linux', 07:10:17 INFO - 'TMOUT': '86400', 07:10:17 INFO - 'USER': 'cltbld', 07:10:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:17 INFO - '_': '/tools/buildbot/bin/python'} 07:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:18 INFO - Downloading/unpacking psutil>=3.1.1 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:18 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 07:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:20 INFO - Installing collected packages: psutil 07:10:20 INFO - Running setup.py install for psutil 07:10:20 INFO - building 'psutil._psutil_linux' extension 07:10:20 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 07:10:20 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 07:10:20 INFO - building 'psutil._psutil_posix' extension 07:10:20 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 07:10:20 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 07:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:20 INFO - Successfully installed psutil 07:10:20 INFO - Cleaning up... 07:10:20 INFO - Return code: 0 07:10:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:20 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:20 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 07:10:20 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 07:10:20 INFO - Using env: {'DISPLAY': ':0', 07:10:20 INFO - 'HOME': '/home/cltbld', 07:10:20 INFO - 'LANG': 'en_US.UTF-8', 07:10:20 INFO - 'LANGUAGE': 'en_US:en', 07:10:20 INFO - 'LOGNAME': 'cltbld', 07:10:20 INFO - 'MAIL': '/var/mail/cltbld', 07:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:20 INFO - 'MOZ_NO_REMOTE': '1', 07:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:20 INFO - 'NO_EM_RESTART': '1', 07:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:20 INFO - 'PWD': '/builds/slave/test', 07:10:20 INFO - 'SHELL': '/bin/bash', 07:10:20 INFO - 'SHLVL': '1', 07:10:20 INFO - 'TERM': 'linux', 07:10:20 INFO - 'TMOUT': '86400', 07:10:20 INFO - 'USER': 'cltbld', 07:10:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:20 INFO - '_': '/tools/buildbot/bin/python'} 07:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:10:20 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 07:10:20 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 07:10:20 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 07:10:20 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 07:10:20 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 07:10:20 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 07:10:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:10:22 INFO - Installing collected packages: mozsystemmonitor 07:10:22 INFO - Running setup.py install for mozsystemmonitor 07:10:22 INFO - Successfully installed mozsystemmonitor 07:10:22 INFO - Cleaning up... 07:10:22 INFO - Return code: 0 07:10:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:10:22 INFO - Using env: {'DISPLAY': ':0', 07:10:22 INFO - 'HOME': '/home/cltbld', 07:10:22 INFO - 'LANG': 'en_US.UTF-8', 07:10:22 INFO - 'LANGUAGE': 'en_US:en', 07:10:22 INFO - 'LOGNAME': 'cltbld', 07:10:22 INFO - 'MAIL': '/var/mail/cltbld', 07:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:22 INFO - 'MOZ_NO_REMOTE': '1', 07:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:22 INFO - 'NO_EM_RESTART': '1', 07:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:22 INFO - 'PWD': '/builds/slave/test', 07:10:22 INFO - 'SHELL': '/bin/bash', 07:10:22 INFO - 'SHLVL': '1', 07:10:22 INFO - 'TERM': 'linux', 07:10:22 INFO - 'TMOUT': '86400', 07:10:22 INFO - 'USER': 'cltbld', 07:10:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:22 INFO - '_': '/tools/buildbot/bin/python'} 07:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:10:23 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 07:10:23 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 07:10:23 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 07:10:23 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 07:10:23 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 07:10:23 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 07:10:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:25 INFO - warning: no files found matching '*.txt' 07:10:25 INFO - no previously-included directories found matching 'build' 07:10:25 INFO - no previously-included directories found matching 'dist' 07:10:25 INFO - no previously-included directories found matching '.git*' 07:10:25 INFO - Installing collected packages: jsonschema, functools32 07:10:25 INFO - Running setup.py install for functools32 07:10:25 INFO - warning: no files found matching '*.txt' 07:10:25 INFO - no previously-included directories found matching 'build' 07:10:25 INFO - no previously-included directories found matching 'dist' 07:10:25 INFO - no previously-included directories found matching '.git*' 07:10:25 INFO - Successfully installed jsonschema functools32 07:10:25 INFO - Cleaning up... 07:10:25 INFO - Return code: 0 07:10:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:25 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:25 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 07:10:25 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 07:10:25 INFO - Using env: {'DISPLAY': ':0', 07:10:25 INFO - 'HOME': '/home/cltbld', 07:10:25 INFO - 'LANG': 'en_US.UTF-8', 07:10:25 INFO - 'LANGUAGE': 'en_US:en', 07:10:25 INFO - 'LOGNAME': 'cltbld', 07:10:25 INFO - 'MAIL': '/var/mail/cltbld', 07:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:25 INFO - 'MOZ_NO_REMOTE': '1', 07:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:25 INFO - 'NO_EM_RESTART': '1', 07:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:25 INFO - 'PWD': '/builds/slave/test', 07:10:25 INFO - 'SHELL': '/bin/bash', 07:10:25 INFO - 'SHLVL': '1', 07:10:25 INFO - 'TERM': 'linux', 07:10:25 INFO - 'TMOUT': '86400', 07:10:25 INFO - 'USER': 'cltbld', 07:10:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:25 INFO - '_': '/tools/buildbot/bin/python'} 07:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:25 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:25 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 07:10:25 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 07:10:25 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 07:10:25 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 07:10:25 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 07:10:25 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 07:10:27 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:28 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 07:10:28 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 07:10:28 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 07:10:28 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 07:10:28 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 07:10:28 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 07:10:28 INFO - Downloading docopt-0.6.1.tar.gz 07:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:28 INFO - Running setup.py install for blobuploader 07:10:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:28 INFO - Running setup.py install for requests 07:10:28 INFO - Running setup.py install for docopt 07:10:28 INFO - Successfully installed blobuploader requests docopt 07:10:28 INFO - Cleaning up... 07:10:28 INFO - Return code: 0 07:10:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:28 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:28 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 07:10:28 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 07:10:28 INFO - Using env: {'DISPLAY': ':0', 07:10:28 INFO - 'HOME': '/home/cltbld', 07:10:28 INFO - 'LANG': 'en_US.UTF-8', 07:10:28 INFO - 'LANGUAGE': 'en_US:en', 07:10:28 INFO - 'LOGNAME': 'cltbld', 07:10:28 INFO - 'MAIL': '/var/mail/cltbld', 07:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:28 INFO - 'MOZ_NO_REMOTE': '1', 07:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:28 INFO - 'NO_EM_RESTART': '1', 07:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:28 INFO - 'PWD': '/builds/slave/test', 07:10:28 INFO - 'SHELL': '/bin/bash', 07:10:28 INFO - 'SHLVL': '1', 07:10:28 INFO - 'TERM': 'linux', 07:10:28 INFO - 'TMOUT': '86400', 07:10:28 INFO - 'USER': 'cltbld', 07:10:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:28 INFO - '_': '/tools/buildbot/bin/python'} 07:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:29 INFO - Running setup.py (path:/tmp/pip-K5QUPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:29 INFO - Running setup.py (path:/tmp/pip-eT9z6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:29 INFO - Running setup.py (path:/tmp/pip-bIdF7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:29 INFO - Running setup.py (path:/tmp/pip-orqLF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:29 INFO - Running setup.py (path:/tmp/pip-GNWriC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:29 INFO - Running setup.py (path:/tmp/pip-zGFDSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:29 INFO - Running setup.py (path:/tmp/pip-RrEy5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:29 INFO - Running setup.py (path:/tmp/pip-XJRZll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:29 INFO - Running setup.py (path:/tmp/pip-jeTNW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:29 INFO - Running setup.py (path:/tmp/pip-A5kSP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:29 INFO - Running setup.py (path:/tmp/pip-XwuKV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:29 INFO - Running setup.py (path:/tmp/pip-Tak97q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:30 INFO - Running setup.py (path:/tmp/pip-h4QrbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:30 INFO - Running setup.py (path:/tmp/pip-6Qe4gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:30 INFO - Running setup.py (path:/tmp/pip-NEn2_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:30 INFO - Running setup.py (path:/tmp/pip-KP9tHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:30 INFO - Running setup.py (path:/tmp/pip-UeGCdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:30 INFO - Running setup.py install for manifestparser 07:10:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:30 INFO - Running setup.py install for mozcrash 07:10:30 INFO - Running setup.py install for mozdebug 07:10:30 INFO - Running setup.py install for mozdevice 07:10:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:30 INFO - Running setup.py install for mozfile 07:10:30 INFO - Running setup.py install for mozhttpd 07:10:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:30 INFO - Running setup.py install for mozinfo 07:10:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Running setup.py install for mozInstall 07:10:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Running setup.py install for mozleak 07:10:31 INFO - Running setup.py install for mozlog 07:10:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Running setup.py install for moznetwork 07:10:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Running setup.py install for mozprocess 07:10:31 INFO - Running setup.py install for mozprofile 07:10:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Running setup.py install for mozrunner 07:10:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:31 INFO - Running setup.py install for mozscreenshot 07:10:31 INFO - Running setup.py install for moztest 07:10:32 INFO - Running setup.py install for mozversion 07:10:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:32 INFO - Cleaning up... 07:10:32 INFO - Return code: 0 07:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:32 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:32 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 07:10:32 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 07:10:32 INFO - Using env: {'DISPLAY': ':0', 07:10:32 INFO - 'HOME': '/home/cltbld', 07:10:32 INFO - 'LANG': 'en_US.UTF-8', 07:10:32 INFO - 'LANGUAGE': 'en_US:en', 07:10:32 INFO - 'LOGNAME': 'cltbld', 07:10:32 INFO - 'MAIL': '/var/mail/cltbld', 07:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:32 INFO - 'MOZ_NO_REMOTE': '1', 07:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:32 INFO - 'NO_EM_RESTART': '1', 07:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:32 INFO - 'PWD': '/builds/slave/test', 07:10:32 INFO - 'SHELL': '/bin/bash', 07:10:32 INFO - 'SHLVL': '1', 07:10:32 INFO - 'TERM': 'linux', 07:10:32 INFO - 'TMOUT': '86400', 07:10:32 INFO - 'USER': 'cltbld', 07:10:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:32 INFO - '_': '/tools/buildbot/bin/python'} 07:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:32 INFO - Running setup.py (path:/tmp/pip-8iTM5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:32 INFO - Running setup.py (path:/tmp/pip-PB8icu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:32 INFO - Running setup.py (path:/tmp/pip-LvkSkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:32 INFO - Running setup.py (path:/tmp/pip-RtpnhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:32 INFO - Running setup.py (path:/tmp/pip-mzXUFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:32 INFO - Running setup.py (path:/tmp/pip-qxH0zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:32 INFO - Running setup.py (path:/tmp/pip-_mbRnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:32 INFO - Running setup.py (path:/tmp/pip-sAcOce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:32 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)) 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:32 INFO - Running setup.py (path:/tmp/pip-uYhwsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:33 INFO - Running setup.py (path:/tmp/pip-1rP0Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:33 INFO - Running setup.py (path:/tmp/pip-QdbYnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:33 INFO - Running setup.py (path:/tmp/pip-zfWz3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:33 INFO - Running setup.py (path:/tmp/pip-fAN_Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:33 INFO - Running setup.py (path:/tmp/pip-KfxvQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:33 INFO - Running setup.py (path:/tmp/pip-n2tzS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:33 INFO - Running setup.py (path:/tmp/pip-56VcCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:33 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)) 07:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:33 INFO - Running setup.py (path:/tmp/pip-P4RoxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:33 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)) 07:10:33 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)) 07:10:33 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)) 07:10:33 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)) 07:10:33 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)) 07:10:33 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)) 07:10:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:33 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 07:10:33 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 07:10:33 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 07:10:33 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 07:10:33 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 07:10:33 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 07:10:35 INFO - Downloading blessings-1.6.tar.gz 07:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:35 INFO - Installing collected packages: blessings 07:10:35 INFO - Running setup.py install for blessings 07:10:35 INFO - Successfully installed blessings 07:10:35 INFO - Cleaning up... 07:10:35 INFO - Return code: 0 07:10:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:36 INFO - Reading from file tmpfile_stdout 07:10:36 INFO - Current package versions: 07:10:36 INFO - argparse == 1.2.1 07:10:36 INFO - blessings == 1.6 07:10:36 INFO - blobuploader == 1.2.4 07:10:36 INFO - docopt == 0.6.1 07:10:36 INFO - functools32 == 3.2.3-2 07:10:36 INFO - jsonschema == 2.5.1 07:10:36 INFO - manifestparser == 1.1 07:10:36 INFO - mozInstall == 1.12 07:10:36 INFO - mozcrash == 0.17 07:10:36 INFO - mozdebug == 0.1 07:10:36 INFO - mozdevice == 0.48 07:10:36 INFO - mozfile == 1.2 07:10:36 INFO - mozhttpd == 0.7 07:10:36 INFO - mozinfo == 0.9 07:10:36 INFO - mozleak == 0.1 07:10:36 INFO - mozlog == 3.3 07:10:36 INFO - moznetwork == 0.27 07:10:36 INFO - mozprocess == 0.23 07:10:36 INFO - mozprofile == 0.28 07:10:36 INFO - mozrunner == 6.12 07:10:36 INFO - mozscreenshot == 0.1 07:10:36 INFO - mozsystemmonitor == 0.3 07:10:36 INFO - moztest == 0.7 07:10:36 INFO - mozversion == 1.4 07:10:36 INFO - psutil == 3.1.1 07:10:36 INFO - requests == 1.2.3 07:10:36 INFO - wsgiref == 0.1.2 07:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:36 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:36 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 07:10:36 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 07:10:36 INFO - Using env: {'DISPLAY': ':0', 07:10:36 INFO - 'HOME': '/home/cltbld', 07:10:36 INFO - 'LANG': 'en_US.UTF-8', 07:10:36 INFO - 'LANGUAGE': 'en_US:en', 07:10:36 INFO - 'LOGNAME': 'cltbld', 07:10:36 INFO - 'MAIL': '/var/mail/cltbld', 07:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:36 INFO - 'MOZ_NO_REMOTE': '1', 07:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:36 INFO - 'NO_EM_RESTART': '1', 07:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:36 INFO - 'PWD': '/builds/slave/test', 07:10:36 INFO - 'SHELL': '/bin/bash', 07:10:36 INFO - 'SHLVL': '1', 07:10:36 INFO - 'TERM': 'linux', 07:10:36 INFO - 'TMOUT': '86400', 07:10:36 INFO - 'USER': 'cltbld', 07:10:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:36 INFO - '_': '/tools/buildbot/bin/python'} 07:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 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)) 07:10:36 INFO - Cleaning up... 07:10:36 INFO - Return code: 0 07:10:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:36 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 0xf42030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1203180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', '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 07:10:36 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 07:10:36 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 07:10:36 INFO - Using env: {'DISPLAY': ':0', 07:10:36 INFO - 'HOME': '/home/cltbld', 07:10:36 INFO - 'LANG': 'en_US.UTF-8', 07:10:36 INFO - 'LANGUAGE': 'en_US:en', 07:10:36 INFO - 'LOGNAME': 'cltbld', 07:10:36 INFO - 'MAIL': '/var/mail/cltbld', 07:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:36 INFO - 'MOZ_NO_REMOTE': '1', 07:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:36 INFO - 'NO_EM_RESTART': '1', 07:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:36 INFO - 'PWD': '/builds/slave/test', 07:10:36 INFO - 'SHELL': '/bin/bash', 07:10:36 INFO - 'SHLVL': '1', 07:10:36 INFO - 'TERM': 'linux', 07:10:36 INFO - 'TMOUT': '86400', 07:10:36 INFO - 'USER': 'cltbld', 07:10:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:36 INFO - '_': '/tools/buildbot/bin/python'} 07:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:10:36 INFO - Cleaning up... 07:10:36 INFO - Return code: 0 07:10:36 INFO - Running post-action listener: _resource_record_post_action 07:10:36 INFO - Running post-action listener: _start_resource_monitoring 07:10:36 INFO - Starting resource monitoring. 07:10:36 INFO - [mozharness: 2016-07-20 14:10:36.488051Z] Finished create-virtualenv step (success) 07:10:36 INFO - [mozharness: 2016-07-20 14:10:36.488524Z] Running install step. 07:10:36 INFO - Running pre-action listener: _resource_record_pre_action 07:10:36 INFO - Running main action method: install 07:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:36 INFO - Reading from file tmpfile_stdout 07:10:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:36 INFO - Reading from file tmpfile_stdout 07:10:36 INFO - Output received: 07:10:36 INFO - Usage: mozinstall [options] installer 07:10:36 INFO - Options: 07:10:36 INFO - -h, --help show this help message and exit 07:10:36 INFO - -d DEST, --destination=DEST 07:10:36 INFO - Directory to install application into. [default: 07:10:36 INFO - "/builds/slave/test"] 07:10:36 INFO - --app=APP Application being installed. [default: firefox] 07:10:36 INFO - mkdir: /builds/slave/test/build/application 07:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:10:54 INFO - Reading from file tmpfile_stdout 07:10:54 INFO - Output received: 07:10:54 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:54 INFO - Running post-action listener: _resource_record_post_action 07:10:54 INFO - [mozharness: 2016-07-20 14:10:54.017058Z] Finished install step (success) 07:10:54 INFO - [mozharness: 2016-07-20 14:10:54.017331Z] Running run-tests step. 07:10:54 INFO - Running pre-action listener: _resource_record_pre_action 07:10:54 INFO - Running main action method: run_tests 07:10:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:54 INFO - Python 2.7.3 07:10:54 INFO - Return code: 0 07:10:54 INFO - grabbing minidump binary from tooltool 07:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:54 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 0x12013b0>, '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 0x12022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1202740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:54 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 07:10:54 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 07:10:54 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 07:10:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:54 INFO - Return code: 0 07:10:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:10:54 INFO - Using env: {'DISPLAY': ':0', 07:10:54 INFO - 'HOME': '/home/cltbld', 07:10:54 INFO - 'LANG': 'en_US.UTF-8', 07:10:54 INFO - 'LANGUAGE': 'en_US:en', 07:10:54 INFO - 'LOGNAME': 'cltbld', 07:10:54 INFO - 'MAIL': '/var/mail/cltbld', 07:10:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:54 INFO - 'MOZ_NO_REMOTE': '1', 07:10:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:54 INFO - 'NO_EM_RESTART': '1', 07:10:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:54 INFO - 'PWD': '/builds/slave/test', 07:10:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:54 INFO - 'SHELL': '/bin/bash', 07:10:54 INFO - 'SHLVL': '1', 07:10:54 INFO - 'TERM': 'linux', 07:10:54 INFO - 'TMOUT': '86400', 07:10:54 INFO - 'USER': 'cltbld', 07:10:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149', 07:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:54 INFO - '_': '/tools/buildbot/bin/python'} 07:10:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:10:54 INFO - mozversion application_buildid: 20160720043044 07:10:54 INFO - mozversion application_changeset: ed8e23b5e0c7b739e61173bb180cf3410a306679 07:10:54 INFO - mozversion application_display_name: Nightly 07:10:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:54 INFO - mozversion application_name: Firefox 07:10:54 INFO - mozversion application_remotingname: firefox 07:10:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:10:54 INFO - mozversion application_vendor: Mozilla 07:10:54 INFO - mozversion application_version: 50.0a1 07:10:54 INFO - mozversion platform_buildid: 20160720043044 07:10:54 INFO - mozversion platform_changeset: ed8e23b5e0c7b739e61173bb180cf3410a306679 07:10:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:10:54 INFO - mozversion platform_version: 50.0a1 07:10:54 INFO - using testdate: 1469023854 07:10:54 INFO - actual date: 1469023854 07:10:54 INFO - starting webserver on 'localhost:51282' 07:10:54 INFO - SUITE-START | Running 2 tests 07:10:54 INFO - TEST-START | dromaeo_css 07:10:54 INFO - operating with platform_type : linux_ 07:10:54 INFO - Initialising browser for dromaeo_css test... 07:10:54 INFO - TEST-INFO | started process 8847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHFr8NB/profile http://localhost:51282/getInfo.html) 07:10:58 INFO - PROCESS | 8847 | __metrics Screen width/height:1600/1200 07:10:58 INFO - PROCESS | 8847 | colorDepth:24 07:10:58 INFO - PROCESS | 8847 | Browser inner width/height: 1024/697 07:10:58 INFO - PROCESS | 8847 | __metrics 07:10:59 INFO - PROCESS | 8847 | 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" 07:10:59 INFO - PROCESS | 8847 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:00 INFO - TEST-INFO | 8847: exit 0 07:11:00 INFO - Browser initialized. 07:11:00 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:00 INFO - TEST-INFO | started process 8928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHFr8NB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:11 INFO - PROCESS | 8928 | RSS: Main: 157364224 07:11:11 INFO - PROCESS | 8928 | 07:12:03 INFO - PROCESS | 8928 | 1469023923579 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] 07:14:11 INFO - PROCESS | 8928 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51282/tests/dromaeo/cssquery-ext.html) 07:14:12 INFO - PROCESS | 8928 | RSS: Main: 259850240 07:14:12 INFO - PROCESS | 8928 | 07:17:14 INFO - PROCESS | 8928 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-ext.html (next: http://localhost:51282/tests/dromaeo/cssquery-jquery.html) 07:17:15 INFO - PROCESS | 8928 | RSS: Main: 244293632 07:17:15 INFO - PROCESS | 8928 | 07:20:17 INFO - PROCESS | 8928 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51282/tests/dromaeo/cssquery-mootools.html) 07:20:18 INFO - PROCESS | 8928 | RSS: Main: 219385856 07:20:18 INFO - PROCESS | 8928 | 07:23:20 INFO - PROCESS | 8928 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51282/tests/dromaeo/cssquery-prototype.html) 07:23:20 INFO - PROCESS | 8928 | RSS: Main: 220659712 07:23:20 INFO - PROCESS | 8928 | 07:26:23 INFO - PROCESS | 8928 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51282/tests/dromaeo/cssquery-yui.html) 07:26:24 INFO - PROCESS | 8928 | RSS: Main: 185720832 07:26:24 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-yui.html (next: http://localhost:51282/tests/dromaeo/cssquery-dojo.html) 07:29:26 INFO - PROCESS | 8928 | RSS: Main: 274866176 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | __start_tp_report 07:29:26 INFO - PROCESS | 8928 | _x_x_mozilla_page_load 07:29:26 INFO - PROCESS | 8928 | _x_x_mozilla_page_load_details 07:29:26 INFO - PROCESS | 8928 | |i|pagename|runs| 07:29:26 INFO - PROCESS | 8928 | |0;dojo.html;3030.4090702313047;3060.602121724174;3074.108508532526;3083.306256092381;3117.7349925256353;5233.555147812431;5277.261183434318;5333.2000199970025;5369.9463005369935;5399.136138217891;5247.265382846395;5258.7633556489955;5314.07003774339;5340.813071542497;5357.678539287635;4768.356271903292;4829.613630909519;4852.514748525155;4870.634702397317;4950.6782059166035;4908.435529914052;4912.091263116317;4917.139500587383;4928.433230178522;4945.184044632631;4748.762561871928;4792.472827988919;4885.706857588556;4922.409310882681;4938.901221975559;4799.2801079837955;4803.423589169287;4814.1334559779225;4833.154198015369;4861.683990540603;4796.06476737033;4822.6624136310475;4876.853694389174;4879.926801097987;4923.163062279421;5137.922931156036;5229.37247530295;5359.464053594609;5399.784008639689;5411.431799661018;5621.578381621354;5728.513076388512;5736.397678243766;5739.454751798572;5742.454466825645;5706.3152421709665;5770.971145144289;5782.277215348082;5782.566307526952;5783.768649254067;5169.25045868347;5287.7884884604955;5303.15149576066;5371.221172929903;5372.355317361902;5880.059190529495;5880.206172166788;5920.259967504062;5933.970330148321;5935.0503919372695;5650.74571644277;5693.202951586781;5698.800541981011;5702.771889124471;5706.087026075891;5549.1676248562235;5621.241132447068;5662.320521537442;5732.398098199712;5784.797532086357;5674.404187560247;5676.574256930747;5708;5718.942810571924;5729.856753581111;5652.689102099424;5689;5693.430656934273;5695.629784064023;5700.201971723962;4271.572842715704;4306.621880998113;4330.870073897788;4351.782410879443;4397.956020439755;3855.4602355670227;3875.5155605549307;3892.1048158923604;3916.980415097906;3959.4852669152824;5443.129099344086;5443.510084092451;5449.918251226235;5451.945480545223;5452.127659574449;5519.668819870741;5659.236003139606;5726.656400615976;5745.540356771448;5803.912941305884;5410.648307859977;5427.3758517770175;5437.918431223535;5455.61810673257;5467.316585426822;4941.48114447985;4948.38145231846;4948.406191257072;4951.3810773653295;4997.450280469146;5737.971310143423;5802.013657678289;5914.112883067488;5928.67392293428;5932.614380065282;5641.351244606759;5708.942910570841;5718.313802343579;5764.452377024176;5764.913526297025;5888.352281248974;5893.116032594973;5894.174815525916;5907.3797251288;5909.143174239625;5486.588505861996;5564.304461942257;5614.382417933943;5617.213590097472;5617.32592088952;5732.828015159552;5769.3942136076785;5769.884602308014;5822.243108396051;5825.359210486928;5615.298087739033;5631.352394474688;5632.2678051853;5634.661920284796;5647.6893770843;5408.37803652585;5488.670679759227;5611.3266408031295;5634.690092044977;5639.2668953035845;5462.453754624506;5518.448155184449;5521.420250873761;5553.333599968029;5561.443855614406;5615.8876822464135;5617.691026993554;5630.5214056805635;5665.12190610456;5667.659940403589;5309.177077552986;5417.891642167056;5476.972615136899;5493.505584497414;5494.230807686847 07:29:26 INFO - PROCESS | 8928 | |1;ext.html;588.1648059755147;612.7885879371618;629.1098096193886;639.2776162935882;643.4755674125587;31188.68811311886;33489.66510334899;33501.49747753779;42374.57625423745;43618.34572481416;45544;45971.54028459715;46013.309800353025;46024.769876150574;46042.769786151104;8955.283577313816;9089.500077495735;9094.86357704635;9103.998560158378;9107.408018478778;8212.548309842956;10621.893781062168;10795.190360722938;10815.513301901434;11215.327080375204;10910.290831095994;10965;11063.557457701681;11067.391293478855;11071.944640276788;8216.917830821674;10732.248742588023;10792.622258220925;10795.784084318348;10802.13582913369;10509.421981790998;10861.07680847121;10864.348139111678;11223.66329010131;11265.211435199539;43771.34342984858;44154.55845441537;44165.337519936904;44173.55826441727;44183.77908110471;3327.3844338797157;3415.555977722905;3434.0213039283685;3449.292894956553;3522.9119272018406;34230;34237.486437703454;34591.30817383663;34862.65137348645;35731;3951.209758048402;3972.6226008529143;3983.960160398417;3995.220931918277;4000.4799376080923;370944;371814;371977;372813.99999999726;373267;59717.701411492664;60270.39729602648;60287.69856150691;60305.39694603086;60338;36673.26653466916;36868;36945;38818.417723734165;63108.36891631117;17182.484525464257;17245;17296.567585810455;17303.826961730472;17354.652906941792;11800.822987655192;12605.747885042249;13153.934230328978;13243.205407675378;13251.337433128498;19223.711644325347;19664.131907468767;19842.1071051803;19849.80901145907;20061.398158055283;7008.26413226614;7092.255313192144;7107.644617769194;7364.5581265124265;7402.483155727079;1019.938803671782;1022.4938655365642;1123.43828085957;1127.7969965406305;1133.1161693878787;33740;34136.317273654386;34228.48657270143;34268.82865585656;34809.65190348115;1100.1858624617726;1111.7887601355717;1159.1654009113424;1178.1399578307883;1186.8813118688063;16891.662166756596;17163.828361716223;17216;17287.82712172862;17341.632446084008;543307;544168;547195;548911;551156;59254.11118833221;59456.70271648701;59560;59646.40353596495;59672.403275967554;1242.2918936206277;1320.610419926124;1360.6190266725332;1371.1978492581752;1394.4910107810576;30796.384072318877;34849.65150348464;34908;35133.648663513035;35170;51004.74497627488;51340.22989655233;51348;51373;51957;427679;427710;433333;435224;436048;24807.379815504755;25454;25632.564906333868;28654.283642909093;29064.854675726485;47646.761766190946;47889.18074046012;48226;48513.757431212616;48526;40610.79694601508;40640.79679601583;40930.74880881461;41498.585014149474;42830.14339713126;40698.38952415657;41780.688961779386;41923.161536768486;42117.57882421136;42289.57710422979;40631.593684062784;41145.38281925833;41841;41895.16209675728;42076.36885446782;34454.65545344514;36775.448368275036;36924;37010.25979480449;37551;28067.157985260474;28809.56785648259;28925.56611650785;28970.42059158763;28979 07:29:26 INFO - PROCESS | 8928 | |2;jquery.html;369.14542833340795;383.1723477289056;385.864947268456;401.96382325590696;419.4588980215522;14742.11547307161;17074.829251707495;18953.52616184596;19864.70202946957;19899.801001989978;18877.905610471964;18879.43361699151;18881.622367552674;18971.62056758864;19108.713369299472;4198.580141985807;5763.711814409273;5934.643921364732;5979.760809567612;5981.043033114703;6421.261554921197;6705;6771.255161932184;6861.55399899005;6876.071730316418;6595.503429122311;6679.532432729711;6686.1642294713165;6695.598264104145;6811.591304521719;6535.379138981789;6708.932910670904;6770.052192693027;6782.491313151509;6785.72857085716;5887.205227294303;5931.881362372772;5933.732982015819;5937.643741375531;5941.792037278675;21930.342089737333;22555.887220563956;22801.201957931393;23120.306390808135;23791.76208237913;2263.6717675936898;2543.4150145466647;2549.260714392824;2842.786790990684;2963.051465097516;10507.106895913856;10684.305520141166;10701.357918524836;10711.571537138505;10825.891741082567;1873.1222842954687;1945.1125685345917;1998.6902030185345;2061.093119027638;2061.2476446097216;82347;85843.57078214569;87585;89780.10219897782;90522;10621.362718236931;10723.517441715141;10878;10972.506237219344;11081.390523521284;15210.391584336723;15227.923860380848;15260.618484537754;15271.694566108838;15275.694486110438;7823.960880195563;8228.8354232915;8264.710735124241;8383.28742056932;8384;7918.920810791934;7949.085855126619;7965.56189409588;8159.265666089962;8236.588170591447;4698.718076915396;4723.700982229846;4729.810807567727;4752;4857;1945.902704864751;1977.32770857909;1977.5945931084093;1992.0836415249148;2039.775624681284;904.6019751309403;969.5879251318303;1016.8373060310315;1062.049465728169;1070.983935240972;19931.10310036052;20388.898055509922;20405;20425.285115020903;20825.68761468579;990.8563258327503;993.4287784523927;999.3304485994402;1025.103034844511;1067.2582555124113;10348.223883208639;11253.268537545033;11317.49071291794;11333.546658133748;11365.886341136647;374747;379016;379514;484665;487002;57129.714351427974;73871;93950;98364.50817745866;99909;921.9446833189896;1021.4688362051543;1026.661201803418;1076.5424694504804;1078.0028473661832;17399.304027838745;17863.196156173264;17911.641767164325;18185.272589096287;18372.265109395474;43307;43936.780316099495;44153.55846441623;44272.335914960655;44689;61402.38597613967;61406.38593614007;62000.68999654973;62485.68757156185;64175.94064652791;8284.544350060805;8366.83266334682;8470.534120623424;8624.318043545436;8836.602352894006;9075.183233509017;9084.772880678036;9294.024127466519;9600.903990960001;9667.661631843133;8147.2139189846675;8185.4270201085355;8190.385721071063;8416.957915210385;8773.912260877565;8086.15095414973;8381.49711017341;8450.492970421794;8530.957345213234;8808.91191088081;8323;8554.486730796172;8555.058943516084;8605.311575073854;8878.11218878107;12219.26684398939;12755.744885102431;12802.935985320013;12825.679358015752;12848.678783030498;11455.885441145481;11477.36874471912;11568.595099171489;11843.644690659294;12095.818562721743 07:29:26 INFO - PROCESS | 8928 | |3;mootools.html;1464.7949287099807;1499.662575920418;1610.4765951065906;1757.1214392803597;1769.0447158534391;8234.42359034867;8672.696455624055;8674.522901240429;8675.219230269282;8680.956595217014;7221.963890180555;8266.751997440086;8503.574821258942;8549.572521373922;8664;2307.9192228272013;2323.8721870297127;2331.4521087544413;2337.5208082343165;2338.3920180752957;2280.1221529711097;2294.1740973249616;2322.651602259666;2322.8490148140318;2323.175272778165;1983.0580474274748;2282.9543409131807;2288.9885550572226;2359.292212336301;2361.586722323595;2270.103309192876;2278.3848360942534;2296.322584837477;2298.850574712647;2300.896459659311;2193.1556350804894;2258.2660635293432;2262.083856038307;2264.490489639818;2266.5806825737127;9044.77388065297;9075.773105672411;9091.545422728903;9096.727098187064;9149.359544831865;5116.718580478072;5216;5255.054090263751;5256.710880901549;5261;3284.939429618653;3294.2423242654086;3358.4962255661603;3395.6264810870784;3416.794992300445;1074.6883403812885;1075.7095584192225;1084.1326938449208;1098.3849044535086;1100.3342977498658;11963.222390544586;12054.879451205463;12055.397230138546;12058.939705301505;12075.154739168262;4447.310666846644;4587.449506059294;4663.440387153563;4674.509176536482;4678.134545109166;10249.692509224586;10323.380597164043;10324.896751032544;10332;10374.221933354878;5267.394249661262;5267.868303292448;5268.868278292996;5268.894622107613;5269.736513174403;4160.271952408377;4667.836625718083;4689.390379250675;4733.195356789285;4846.709197448094;3925.7055720821054;4006.6794656427414;4056.2090392373793;4079.918401631951;4121.216968775923;1249.9812502812283;1251.4806355362423;1261.218044812204;1261.3882267100448;1288.5103660609095;812.9674813007414;819.4919150126959;904.0552622509493;940.083418666808;1035.3270374256642;5953.940460595425;6020.187274717945;6122.663253521099;6144.126041557279;6154.78458253959;939.9671011514564;944.9149576538144;976.2531663277456;980.9509524523745;1011.1758916483043;4132.752034877857;4233.322668373107;4388.495323037828;4449.377087207794;4502.189605870974;11236.157288203418;11353.148513861493;11436.656900293005;11456.94271528637;11465.942670286762;10456.372617642966;10744.194185435967;11387.886121138683;11390.430478476042;11392.544298228144;8120.959395203105;8251.876221856677;8273.296769774517;8309.044459887069;8334.333253339719;6033.637981721111;6199.225096862892;6204.286507051566;6244.843878903063;6274.74901003973;9985.950070249894;10142.746431338981;10245.795084098127;10251.948740256252;10326.948365258426;10210.285280030326;10211.183105351405;10450.581976720847;10581.62964296246;10582.682519524427;7747.1090824555895;7917.327027202752;8012.318952888837;8035.477693949874;8038.517688938682;8503.319734421355;8541.829163416822;8582.570871456526;8595.18345757152;8598.355123365647;7559.092908850973;7673.386129109546;7679.577623230776;7687.884681729666;7806.609669516615;7595.354394876276;7626.081157747073;7680.5391676499585;7729.304362607392;7786.571738554434;7090.326418990187;7141.321574450419;7158.105236845395;7172.246914073947;7177.1746249182015;5002.924956125588;5133.204353325241;5185.948140518697;5241.9737901310245;5321.920171197357;5108.56577190943;5253.632245742761;5270.393904700855;5280.762365693477;5491.28613280271 07:29:26 INFO - PROCESS | 8928 | |4;prototype.html;322.0949132936449;327.72634849900334;332.38011109281183;332.4514550990865;337.4129015513008;5160.845174644757;5322.646732558483;5331.280277162587;5340.43925387834;5343.225232341309;5123.718195499256;5191.974040129794;5237.507310416532;5243.475652434755;5275.6043296752805;4172.603602657758;4174.163368118034;4181.163767246548;4184.748915065105;4215.178040282146;4064.695147863907;4184.623383895449;4185.707000509966;4205.981129058054;4213.841193671734;4131.6281534661875;4156.251874662559;4162.875113746592;4167.9583204167875;4177.874663760092;4139.337705967046;4148.917021659565;4155.4182414462;4160.313548264533;4170.602848045908;3692.2615476904457;3696.131409118855;3700.6484383983748;3705.74059815813;3723.4600982857605;5144.9163088949035;5244.79020839166;5260.605454590921;5289.206619007141;5298.8342564636105;4764.523547645208;4768.976155119202;4786.2581299898575;4789.928151077736;4803.423589169322;5432.13085906257;5466.606015466071;5557.527610153142;5576.442355764431;5589.888202235932;3993.2412841560013;3998.3402738548107;4000.659778974018;4005.218982298453;4022.255882661717;5830.883382332372;5874.941250587525;5882.676397810501;5890.469857712784;5891.3814049525035;4126.525449573338;4132.752034877917;4133.503979522477;4148.875533733993;4155.10665206982;4058.512978442606;4134.441850350225;4138.255114079495;4140.275451795984;4160.732400841549;4708.623310135181;4745.3593764842;4751.429828420612;4753.595944344769;4755.643326750507;5575.804846830341;5596.944030559724;5606.327240731057;5613.242212301287;5617.01702202113;1308.3523655790445;1338.7188690374935;1375.7111006688708;1410.9929450352683;1413.9536742810246;953.6042542344987;974.3910056214866;988;993.3692105513052;1000.5797565022563;5392.514673679388;5414.864628384243;5419.810306639249;5421.810236641699;5431.21247419122;5713.514351280188;5749.195112684228;5757.539396848242;5759.596828221985;5761;5258.50044245796;5281.762320695578;5287.550558202519;5399.190121481731;5459.071957767189;2648.139354709727;2693.46130773846;2698.5007773561956;2710.4443589064194;2723.237493501823;5236.162214045735;5288.576913846883;5299.4435584263865;5302.575793936476;5308.230306605597;5033.245013248042;5176.301199338116;5189.455107213764;5233.35149427929;5263.289455923478;5232.843014709565;5241.449647787003;5249.42256351801;5325.920111198335;5332.146856502941;5079.92380114306;5097.719625420637;5106.693598384109;5120.155174396183;5135.8957824068;4716.056788642217;4918.5573298403315;5024.497550244946;5034.471380505141;5076.619253555924;5208.9739551302;5267.60492963037;5291.9470805292995;5297.357819076099;5302.170751091022;3810.1330348128663;3918.490596222473;3954.149857780591;4116.279651060992;4119.608637179464;5720.3707592165665;5724.57065720081;5734.770609175586;5735.222081154855;5757.884842303214;5620.4660557247;5645.125005624135;5667.1782591524825;5679.3184817820475;5693.231413759255;5458.044842152687;5665.178549110438;5669.433056694297;5672.914906276492;5685.658860468385;5551.583631227593;5578.219049333015;5590.496855282881;5594.748236329457;5638.746256418389;5460.481254280837;5681.147827825859;5737.225474561048;5740;5740.368559458373;5558.44415558441;5573;5577.74900129487;5581.88362327528;5591.524720398812 07:29:26 INFO - PROCESS | 8928 | |5;yui.html;643.5205771700084;657.97039133239;726.5386479585462;830.5349004557445;834.1950018232412;14660.853391466095;15668.686626267468;15765.975211611267;15802.604934876634;15907.840921590781;14228.288585570732;14304.356303966346;14447.711045779079;14495;15139.77290340643;809.2797410304819;820.2125959079291;824.4846970643348;824.4888169335021;825.9504429734205;664.8138521214067;815.4251252866715;816.7386436340373;819.3117781063905;824.1634740738156;835.2148979958849;839.7732612194703;840.5293035899886;841.7769291137853;842.8988521377444;834.3158609939852;834.8789425533264;834.9874751878726;835.4110352201744;838.174398217755;518.044208435436;613.1446631948452;624.3475568031419;630.9116723658691;633.7781776378276;13283.269420181887;13292.534761283308;13304;13315.600531984055;13320.467181312735;14283.285835708173;14827;14841.999999999893;14845.777313340308;14876.256187190596;13006.674833129153;13124.86875131246;13181.736365272642;13246.66883327915;13333.266670333127;4292.828286868522;4303.935440968388;4309.729343804756;4340.197063543254;4419.535948725402;77316;77366.61316693437;77923.61038194773;78330;82486.58756706178;11372;11465.54137834494;11556.76886462266;11671.416429178676;11690.240134391237;20117.29589464391;20149.697754533692;20162.798372016387;20176.59646807085;20290.69563956542;8797.912020879838;8854.424462409923;8921.330900182382;8973.865392019125;9091.454512729257;4814.109389762905;4983.8504844854715;5010.098182327143;5051.621128415383;5132.204508301219;3448.9482657760154;3566.4828599853395;3596.532450781434;3609.4405367168133;3617.04148400674;616.7317217010525;628.5160426471591;633.7971849008273;653.4119292636665;656.4223483334634;647.8801421736994;661.7849199010244;743.18992298395;747.8616455955665;757.1028331427276;8582.570871456403;9396.906030939603;9486;9534.04659534055;9656.75858103539;640.7885397818802;683.4395795447685;683.8974153876958;688.7623769799411;701.8175274428685;4255;4541.704789188759;4589.518100599389;4603.286490593896;4662.114198302312;117558.41220794013;118542.40728796301;120401;120671.39664301623;122156.38921805334;99152.50423747835;103028.48485757523;105387.47306263419;105749;107532.46233768782;71888;91735.54132229296;91866;92396.53801731083;93132.53433732787;8590.527520986405;8820.2061814437;8838.955805220932;8865.468071915706;8878.95560522219;38349.61650383461;46140;53128.46871531235;53321.7333913328;55561.444385555624;80234;80527.59736201282;82955.58522207351;83044;84544.1545584561;11584.94207528957;11749.980131923861;11805.586804461802;11821.881781182077;11930.582429614922;12890.742185156432;13431.86568134306;13455.86544134546;13493.190408575518;13631.931840340734;9417.670381536613;11443.084553235887;11455.770884582094;11748.35384053851;11845;12973.481060757464;13381.66545836362;13682.384292706653;13790.241536715577;13860.237686927316;13059.608211753663;13268.93365533166;13269.66825829362;13300.800487992494;13390.598282051555;11269.66191014271;11303;11528.037221101747;11701.356425396685;11732.648020559396;9281.907180928105;9507.763990681167;10359.792804144026;10478.588919193375;10647.520861561094 07:29:26 INFO - PROCESS | 8928 | __end_tp_report 07:29:26 INFO - PROCESS | 8928 | __start_cc_report 07:29:26 INFO - PROCESS | 8928 | _x_x_mozilla_cycle_collect,922 07:29:26 INFO - PROCESS | 8928 | __end_cc_report 07:29:26 INFO - PROCESS | 8928 | __startTimestamp1469024966877__endTimestamp 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | ------- Summary: start ------- 07:29:26 INFO - PROCESS | 8928 | Number of tests: 6 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | [#0] dojo.html Cycles:165 Average:5308.00 Median:5493.51 stddev:607.28 (11.1%) stddev-sans-first:582.27 07:29:26 INFO - PROCESS | 8928 | Values: 3030.4 3060.6 3074.1 3083.3 3117.7 5233.6 5277.3 5333.2 5369.9 5399.1 5247.3 5258.8 5314.1 5340.8 5357.7 4768.4 4829.6 4852.5 4870.6 4950.7 4908.4 4912.1 4917.1 4928.4 4945.2 4748.8 4792.5 4885.7 4922.4 4938.9 4799.3 4803.4 4814.1 4833.2 4861.7 4796.1 4822.7 4876.9 4879.9 4923.2 5137.9 5229.4 5359.5 5399.8 5411.4 5621.6 5728.5 5736.4 5739.5 5742.5 5706.3 5771.0 5782.3 5782.6 5783.8 5169.3 5287.8 5303.2 5371.2 5372.4 5880.1 5880.2 5920.3 5934.0 5935.1 5650.7 5693.2 5698.8 5702.8 5706.1 5549.2 5621.2 5662.3 5732.4 5784.8 5674.4 5676.6 5708.0 5718.9 5729.9 5652.7 5689.0 5693.4 5695.6 5700.2 4271.6 4306.6 4330.9 4351.8 4398.0 3855.5 3875.5 3892.1 3917.0 3959.5 5443.1 5443.5 5449.9 5451.9 5452.1 5519.7 5659.2 5726.7 5745.5 5803.9 5410.6 5427.4 5437.9 5455.6 5467.3 4941.5 4948.4 4948.4 4951.4 4997.5 5738.0 5802.0 5914.1 5928.7 5932.6 5641.4 5708.9 5718.3 5764.5 5764.9 5888.4 5893.1 5894.2 5907.4 5909.1 5486.6 5564.3 5614.4 5617.2 5617.3 5732.8 5769.4 5769.9 5822.2 5825.4 5615.3 5631.4 5632.3 5634.7 5647.7 5408.4 5488.7 5611.3 5634.7 5639.3 5462.5 5518.4 5521.4 5553.3 5561.4 5615.9 5617.7 5630.5 5665.1 5667.7 5309.2 5417.9 5477.0 5493.5 5494.2 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | [#1] ext.html Cycles:180 Average:61024.00 Median:36934.50 stddev:120877.69 (327.3%) stddev-sans-first:121131.62 07:29:26 INFO - PROCESS | 8928 | Values: 588.2 612.8 629.1 639.3 643.5 31188.7 33489.7 33501.5 42374.6 43618.3 45544.0 45971.5 46013.3 46024.8 46042.8 8955.3 9089.5 9094.9 9104.0 9107.4 8212.5 10621.9 10795.2 10815.5 11215.3 10910.3 10965.0 11063.6 11067.4 11071.9 8216.9 10732.2 10792.6 10795.8 10802.1 10509.4 10861.1 10864.3 11223.7 11265.2 43771.3 44154.6 44165.3 44173.6 44183.8 3327.4 3415.6 3434.0 3449.3 3522.9 34230.0 34237.5 34591.3 34862.7 35731.0 3951.2 3972.6 3984.0 3995.2 4000.5 370944.0 371814.0 371977.0 372814.0 373267.0 59717.7 60270.4 60287.7 60305.4 60338.0 36673.3 36868.0 36945.0 38818.4 63108.4 17182.5 17245.0 17296.6 17303.8 17354.7 11800.8 12605.7 13153.9 13243.2 13251.3 19223.7 19664.1 19842.1 19849.8 20061.4 7008.3 7092.3 7107.6 7364.6 7402.5 1019.9 1022.5 1123.4 1127.8 1133.1 33740.0 34136.3 34228.5 34268.8 34809.7 1100.2 1111.8 1159.2 1178.1 1186.9 16891.7 17163.8 17216.0 17287.8 17341.6 543307.0 544168.0 547195.0 548911.0 551156.0 59254.1 59456.7 59560.0 59646.4 59672.4 1242.3 1320.6 1360.6 1371.2 1394.5 30796.4 34849.7 34908.0 35133.6 35170.0 51004.7 51340.2 51348.0 51373.0 51957.0 427679.0 427710.0 433333.0 435224.0 436048.0 24807.4 25454.0 25632.6 28654.3 29064.9 47646.8 47889.2 48226.0 48513.8 48526.0 40610.8 40640.8 40930.7 41498.6 42830.1 40698.4 41780.7 41923.2 42117.6 42289.6 40631.6 41145.4 41841.0 41895.2 42076.4 34454.7 36775.4 36924.0 37010.3 37551.0 28067.2 28809.6 28925.6 28970.4 28979.0 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | [#2] jquery.html Cycles:180 Average:27102.03 Median:44212.95 stddev:70525.27 (159.5%) stddev-sans-first:70694.54 07:29:26 INFO - PROCESS | 8928 | Values: 369.1 383.2 385.9 402.0 419.5 14742.1 17074.8 18953.5 19864.7 19899.8 18877.9 18879.4 18881.6 18971.6 19108.7 4198.6 5763.7 5934.6 5979.8 5981.0 6421.3 6705.0 6771.3 6861.6 6876.1 6595.5 6679.5 6686.2 6695.6 6811.6 6535.4 6708.9 6770.1 6782.5 6785.7 5887.2 5931.9 5933.7 5937.6 5941.8 21930.3 22555.9 22801.2 23120.3 23791.8 2263.7 2543.4 2549.3 2842.8 2963.1 10507.1 10684.3 10701.4 10711.6 10825.9 1873.1 1945.1 1998.7 2061.1 2061.2 82347.0 85843.6 87585.0 89780.1 90522.0 10621.4 10723.5 10878.0 10972.5 11081.4 15210.4 15227.9 15260.6 15271.7 15275.7 7824.0 8228.8 8264.7 8383.3 8384.0 7918.9 7949.1 7965.6 8159.3 8236.6 4698.7 4723.7 4729.8 4752.0 4857.0 1945.9 1977.3 1977.6 1992.1 2039.8 904.6 969.6 1016.8 1062.0 1071.0 19931.1 20388.9 20405.0 20425.3 20825.7 990.9 993.4 999.3 1025.1 1067.3 10348.2 11253.3 11317.5 11333.5 11365.9 374747.0 379016.0 379514.0 484665.0 487002.0 57129.7 73871.0 93950.0 98364.5 99909.0 921.9 1021.5 1026.7 1076.5 1078.0 17399.3 17863.2 17911.6 18185.3 18372.3 43307.0 43936.8 44153.6 44272.3 44689.0 61402.4 61406.4 62000.7 62485.7 64175.9 8284.5 8366.8 8470.5 8624.3 8836.6 9075.2 9084.8 9294.0 9600.9 9667.7 8147.2 8185.4 8190.4 8417.0 8773.9 8086.2 8381.5 8450.5 8531.0 8808.9 8323.0 8554.5 8555.1 8605.3 8878.1 12219.3 12755.7 12802.9 12825.7 12848.7 11455.9 11477.4 11568.6 11843.6 12095.8 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | [#3] mootools.html Cycles:180 Average:5835.52 Median:4671.17 stddev:3327.15 (71.2%) stddev-sans-first:3320.28 07:29:26 INFO - PROCESS | 8928 | Values: 1464.8 1499.7 1610.5 1757.1 1769.0 8234.4 8672.7 8674.5 8675.2 8681.0 7222.0 8266.8 8503.6 8549.6 8664.0 2307.9 2323.9 2331.5 2337.5 2338.4 2280.1 2294.2 2322.7 2322.8 2323.2 1983.1 2283.0 2289.0 2359.3 2361.6 2270.1 2278.4 2296.3 2298.9 2300.9 2193.2 2258.3 2262.1 2264.5 2266.6 9044.8 9075.8 9091.5 9096.7 9149.4 5116.7 5216.0 5255.1 5256.7 5261.0 3284.9 3294.2 3358.5 3395.6 3416.8 1074.7 1075.7 1084.1 1098.4 1100.3 11963.2 12054.9 12055.4 12058.9 12075.2 4447.3 4587.4 4663.4 4674.5 4678.1 10249.7 10323.4 10324.9 10332.0 10374.2 5267.4 5267.9 5268.9 5268.9 5269.7 4160.3 4667.8 4689.4 4733.2 4846.7 3925.7 4006.7 4056.2 4079.9 4121.2 1250.0 1251.5 1261.2 1261.4 1288.5 813.0 819.5 904.1 940.1 1035.3 5953.9 6020.2 6122.7 6144.1 6154.8 940.0 944.9 976.3 981.0 1011.2 4132.8 4233.3 4388.5 4449.4 4502.2 11236.2 11353.1 11436.7 11456.9 11465.9 10456.4 10744.2 11387.9 11390.4 11392.5 8121.0 8251.9 8273.3 8309.0 8334.3 6033.6 6199.2 6204.3 6244.8 6274.7 9986.0 10142.7 10245.8 10251.9 10326.9 10210.3 10211.2 10450.6 10581.6 10582.7 7747.1 7917.3 8012.3 8035.5 8038.5 8503.3 8541.8 8582.6 8595.2 8598.4 7559.1 7673.4 7679.6 7687.9 7806.6 7595.4 7626.1 7680.5 7729.3 7786.6 7090.3 7141.3 7158.1 7172.2 7177.2 5002.9 5133.2 5185.9 5242.0 5321.9 5108.6 5253.6 5270.4 5280.8 5491.3 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | [#4] prototype.html Cycles:180 Average:4603.81 Median:5234.76 stddev:1339.25 (25.6%) stddev-sans-first:1303.88 07:29:26 INFO - PROCESS | 8928 | Values: 322.1 327.7 332.4 332.5 337.4 5160.8 5322.6 5331.3 5340.4 5343.2 5123.7 5192.0 5237.5 5243.5 5275.6 4172.6 4174.2 4181.2 4184.7 4215.2 4064.7 4184.6 4185.7 4206.0 4213.8 4131.6 4156.3 4162.9 4168.0 4177.9 4139.3 4148.9 4155.4 4160.3 4170.6 3692.3 3696.1 3700.6 3705.7 3723.5 5144.9 5244.8 5260.6 5289.2 5298.8 4764.5 4769.0 4786.3 4789.9 4803.4 5432.1 5466.6 5557.5 5576.4 5589.9 3993.2 3998.3 4000.7 4005.2 4022.3 5830.9 5874.9 5882.7 5890.5 5891.4 4126.5 4132.8 4133.5 4148.9 4155.1 4058.5 4134.4 4138.3 4140.3 4160.7 4708.6 4745.4 4751.4 4753.6 4755.6 5575.8 5596.9 5606.3 5613.2 5617.0 1308.4 1338.7 1375.7 1411.0 1414.0 953.6 974.4 988.0 993.4 1000.6 5392.5 5414.9 5419.8 5421.8 5431.2 5713.5 5749.2 5757.5 5759.6 5761.0 5258.5 5281.8 5287.6 5399.2 5459.1 2648.1 2693.5 2698.5 2710.4 2723.2 5236.2 5288.6 5299.4 5302.6 5308.2 5033.2 5176.3 5189.5 5233.4 5263.3 5232.8 5241.4 5249.4 5325.9 5332.1 5079.9 5097.7 5106.7 5120.2 5135.9 4716.1 4918.6 5024.5 5034.5 5076.6 5209.0 5267.6 5291.9 5297.4 5302.2 3810.1 3918.5 3954.1 4116.3 4119.6 5720.4 5724.6 5734.8 5735.2 5757.9 5620.5 5645.1 5667.2 5679.3 5693.2 5458.0 5665.2 5669.4 5672.9 5685.7 5551.6 5578.2 5590.5 5594.7 5638.7 5460.5 5681.1 5737.2 5740.0 5740.4 5558.4 5573.0 5577.7 5581.9 5591.5 07:29:26 INFO - PROCESS | 8928 | 07:29:26 INFO - PROCESS | 8928 | [#5] yui.html Cycles:180 Average:21148.88 Median:25371.64 stddev:31416.78 (123.8%) stddev-sans-first:31467.18 07:29:26 INFO - PROCESS | 8928 | Values: 643.5 658.0 726.5 830.5 834.2 14660.9 15668.7 15766.0 15802.6 15907.8 14228.3 14304.4 14447.7 14495.0 15139.8 809.3 820.2 824.5 824.5 826.0 664.8 815.4 816.7 819.3 824.2 835.2 839.8 840.5 841.8 842.9 834.3 834.9 835.0 835.4 838.2 518.0 613.1 624.3 630.9 633.8 13283.3 13292.5 13304.0 13315.6 13320.5 14283.3 14827.0 14842.0 14845.8 14876.3 13006.7 13124.9 13181.7 13246.7 13333.3 4292.8 4303.9 4309.7 4340.2 4419.5 77316.0 77366.6 77923.6 78330.0 82486.6 11372.0 11465.5 11556.8 11671.4 11690.2 20117.3 20149.7 20162.8 20176.6 20290.7 8797.9 8854.4 8921.3 8973.9 9091.5 4814.1 4983.9 5010.1 5051.6 5132.2 3448.9 3566.5 3596.5 3609.4 3617.0 616.7 628.5 633.8 653.4 656.4 647.9 661.8 743.2 747.9 757.1 8582.6 9396.9 9486.0 9534.0 9656.8 640.8 683.4 683.9 688.8 701.8 4255.0 4541.7 4589.5 4603.3 4662.1 117558.4 118542.4 120401.0 120671.4 122156.4 99152.5 103028.5 105387.5 105749.0 107532.5 71888.0 91735.5 91866.0 92396.5 93132.5 8590.5 8820.2 8839.0 8865.5 8879.0 38349.6 46140.0 53128.5 53321.7 55561.4 80234.0 80527.6 82955.6 83044.0 84544.2 11584.9 11750.0 11805.6 11821.9 11930.6 12890.7 13431.9 13455.9 13493.2 13631.9 9417.7 11443.1 11455.8 11748.4 11845.0 12973.5 13381.7 13682.4 13790.2 13860.2 13059.6 13268.9 13269.7 13300.8 13390.6 11269.7 11303.0 11528.0 11701.4 11732.6 9281.9 9507.8 10359.8 10478.6 10647.5 07:29:26 INFO - PROCESS | 8928 | -------- Summary: end -------- 07:29:26 INFO - PROCESS | 8928 | 07:29:27 INFO - TEST-INFO | 8928: exit 0 07:29:27 INFO - TEST-OK | dromaeo_css | took 1113346ms 07:29:27 INFO - TEST-START | kraken 07:29:27 INFO - operating with platform_type : linux_ 07:29:27 INFO - Initialising browser for kraken test... 07:29:27 INFO - TEST-INFO | started process 9121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYUq7rU/profile http://localhost:51282/getInfo.html) 07:29:31 INFO - PROCESS | 9121 | __metrics Screen width/height:1600/1200 07:29:31 INFO - PROCESS | 9121 | colorDepth:24 07:29:31 INFO - PROCESS | 9121 | Browser inner width/height: 1024/697 07:29:31 INFO - PROCESS | 9121 | __metrics 07:29:32 INFO - PROCESS | 9121 | 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" 07:29:32 INFO - PROCESS | 9121 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:33 INFO - TEST-INFO | 9121: exit 0 07:29:33 INFO - Browser initialized. 07:29:33 INFO - Running cycle 1/1 for kraken test... 07:29:33 INFO - TEST-INFO | started process 9204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYUq7rU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:45 INFO - PROCESS | 9204 | RSS: Main: 157765632 07:29:45 INFO - PROCESS | 9204 | 07:29:47 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:48 INFO - PROCESS | 9204 | RSS: Main: 214175744 07:29:48 INFO - PROCESS | 9204 | 07:29:51 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-dft) 07:29:51 INFO - PROCESS | 9204 | RSS: Main: 193101824 07:29:51 INFO - PROCESS | 9204 | 07:29:54 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-fft) 07:29:55 INFO - PROCESS | 9204 | RSS: Main: 270295040 07:29:55 INFO - PROCESS | 9204 | 07:29:57 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-oscillator) 07:29:57 INFO - PROCESS | 9204 | RSS: Main: 180776960 07:29:57 INFO - PROCESS | 9204 | 07:29:59 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:00 INFO - PROCESS | 9204 | RSS: Main: 185159680 07:30:00 INFO - PROCESS | 9204 | 07:30:03 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51282/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:04 INFO - PROCESS | 9204 | RSS: Main: 222003200 07:30:04 INFO - PROCESS | 9204 | 07:30:07 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51282/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:08 INFO - PROCESS | 9204 | RSS: Main: 220340224 07:30:08 INFO - PROCESS | 9204 | 07:30:10 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51282/tests/kraken/driver.html?testName=json-parse-financial) 07:30:11 INFO - PROCESS | 9204 | RSS: Main: 220442624 07:30:11 INFO - PROCESS | 9204 | 07:30:12 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:13 INFO - PROCESS | 9204 | RSS: Main: 184942592 07:30:13 INFO - PROCESS | 9204 | 07:30:15 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:15 INFO - PROCESS | 9204 | RSS: Main: 190095360 07:30:15 INFO - PROCESS | 9204 | 07:30:17 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:18 INFO - PROCESS | 9204 | RSS: Main: 194928640 07:30:18 INFO - PROCESS | 9204 | 07:30:21 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:21 INFO - PROCESS | 9204 | RSS: Main: 190099456 07:30:21 INFO - PROCESS | 9204 | 07:30:24 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:24 INFO - PROCESS | 9204 | RSS: Main: 193363968 07:30:24 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51282/tests/kraken/driver.html?testName=ai-astar) 07:30:26 INFO - PROCESS | 9204 | RSS: Main: 244047872 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | __start_tp_report 07:30:26 INFO - PROCESS | 9204 | _x_x_mozilla_page_load 07:30:26 INFO - PROCESS | 9204 | _x_x_mozilla_page_load_details 07:30:26 INFO - PROCESS | 9204 | |i|pagename|runs| 07:30:26 INFO - PROCESS | 9204 | |0;ai-astar;106;112;112;113;114;111;112;110;112;112 07:30:26 INFO - PROCESS | 9204 | |1;audio-beat-detection;145;122;117;185;120;119;151;117;150;124 07:30:26 INFO - PROCESS | 9204 | |2;audio-dft;159;160;160;159;159;160;159;162;162;163 07:30:26 INFO - PROCESS | 9204 | |3;audio-fft;75;74;75;112;76;76;75;76;110;74 07:30:26 INFO - PROCESS | 9204 | |4;audio-oscillator;83;83;107;82;83;84;112;85;83;129 07:30:26 INFO - PROCESS | 9204 | |5;imaging-gaussian-blur;117;117;117;118;117;117;116;117;117;116 07:30:26 INFO - PROCESS | 9204 | |6;imaging-darkroom;145;146;146;146;146;146;145;146;145;146 07:30:26 INFO - PROCESS | 9204 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;96;95 07:30:26 INFO - PROCESS | 9204 | |8;json-parse-financial;50;50;51;51;51;51;51;50;49;50 07:30:26 INFO - PROCESS | 9204 | |9;json-stringify-tinderbox;64;63;62;62;63;62;63;62;62;63 07:30:26 INFO - PROCESS | 9204 | |10;stanford-crypto-aes;78;76;79;82;75;75;75;76;74;75 07:30:26 INFO - PROCESS | 9204 | |11;stanford-crypto-ccm;123;146;122;120;119;128;123;118;165;134 07:30:26 INFO - PROCESS | 9204 | |12;stanford-crypto-pbkdf2;155;156;155;155;156;156;155;156;153;156 07:30:26 INFO - PROCESS | 9204 | |13;stanford-crypto-sha256-iterative;64;63;63;62;62;63;63;67;63;64 07:30:26 INFO - PROCESS | 9204 | __end_tp_report 07:30:26 INFO - PROCESS | 9204 | __start_cc_report 07:30:26 INFO - PROCESS | 9204 | _x_x_mozilla_cycle_collect,1703 07:30:26 INFO - PROCESS | 9204 | __end_cc_report 07:30:26 INFO - PROCESS | 9204 | __startTimestamp1469025026903__endTimestamp 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | ------- Summary: start ------- 07:30:26 INFO - PROCESS | 9204 | Number of tests: 14 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.17 (1.9%) stddev-sans-first:1.12 07:30:26 INFO - PROCESS | 9204 | Values: 106.0 112.0 112.0 113.0 114.0 111.0 112.0 110.0 112.0 112.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:134.50 stddev:22.36 (16.6%) stddev-sans-first:23.42 07:30:26 INFO - PROCESS | 9204 | Values: 145.0 122.0 117.0 185.0 120.0 119.0 151.0 117.0 150.0 124.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.49 (0.9%) stddev-sans-first:1.51 07:30:26 INFO - PROCESS | 9204 | Values: 159.0 160.0 160.0 159.0 159.0 160.0 159.0 162.0 162.0 163.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:15.15 (20.2%) stddev-sans-first:15.84 07:30:26 INFO - PROCESS | 9204 | Values: 75.0 74.0 75.0 112.0 76.0 76.0 75.0 76.0 110.0 74.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:83.00 stddev:16.73 (20.2%) stddev-sans-first:17.34 07:30:26 INFO - PROCESS | 9204 | Values: 83.0 83.0 107.0 82.0 83.0 84.0 112.0 85.0 83.0 129.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:30:26 INFO - PROCESS | 9204 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 116.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:30:26 INFO - PROCESS | 9204 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:30:26 INFO - PROCESS | 9204 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.73 07:30:26 INFO - PROCESS | 9204 | Values: 50.0 50.0 51.0 51.0 51.0 51.0 51.0 50.0 49.0 50.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 07:30:26 INFO - PROCESS | 9204 | Values: 64.0 63.0 62.0 62.0 63.0 62.0 63.0 62.0 62.0 63.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:2.46 (3.2%) stddev-sans-first:2.55 07:30:26 INFO - PROCESS | 9204 | Values: 78.0 76.0 79.0 82.0 75.0 75.0 75.0 76.0 74.0 75.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:125.50 stddev:15.01 (12.0%) stddev-sans-first:15.72 07:30:26 INFO - PROCESS | 9204 | Values: 123.0 146.0 122.0 120.0 119.0 128.0 123.0 118.0 165.0 134.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:156.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:30:26 INFO - PROCESS | 9204 | Values: 155.0 156.0 155.0 155.0 156.0 156.0 155.0 156.0 153.0 156.0 07:30:26 INFO - PROCESS | 9204 | 07:30:26 INFO - PROCESS | 9204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.50 07:30:26 INFO - PROCESS | 9204 | Values: 64.0 63.0 63.0 62.0 62.0 63.0 63.0 67.0 63.0 64.0 07:30:26 INFO - PROCESS | 9204 | -------- Summary: end -------- 07:30:26 INFO - PROCESS | 9204 | 07:30:28 INFO - TEST-INFO | 9204: exit 0 07:30:28 INFO - TEST-OK | kraken | took 60469ms 07:30:28 INFO - SUITE-END | took 1173s 07:30:28 INFO - Completed test suite (00:19:34) 07:30:28 INFO - javascript benchmark 07:30:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.4090702313047, 3060.602121724174, 3074.108508532526, 3083.306256092381, 3117.7349925256353, 5233.555147812431, 5277.261183434318, 5333.2000199970025, 5369.9463005369935, 5399.136138217891, 5247.265382846395, 5258.7633556489955, 5314.07003774339, 5340.813071542497, 5357.678539287635, 4768.356271903292, 4829.613630909519, 4852.514748525155, 4870.634702397317, 4950.6782059166035, 4908.435529914052, 4912.091263116317, 4917.139500587383, 4928.433230178522, 4945.184044632631, 4748.762561871928, 4792.472827988919, 4885.706857588556, 4922.409310882681, 4938.901221975559, 4799.2801079837955, 4803.423589169287, 4814.1334559779225, 4833.154198015369, 4861.683990540603, 4796.06476737033, 4822.6624136310475, 4876.853694389174, 4879.926801097987, 4923.163062279421, 5137.922931156036, 5229.37247530295, 5359.464053594609, 5399.784008639689, 5411.431799661018, 5621.578381621354, 5728.513076388512, 5736.397678243766, 5739.454751798572, 5742.454466825645, 5706.3152421709665, 5770.971145144289, 5782.277215348082, 5782.566307526952, 5783.768649254067, 5169.25045868347, 5287.7884884604955, 5303.15149576066, 5371.221172929903, 5372.355317361902, 5880.059190529495, 5880.206172166788, 5920.259967504062, 5933.970330148321, 5935.0503919372695, 5650.74571644277, 5693.202951586781, 5698.800541981011, 5702.771889124471, 5706.087026075891, 5549.1676248562235, 5621.241132447068, 5662.320521537442, 5732.398098199712, 5784.797532086357, 5674.404187560247, 5676.574256930747, 5708.0, 5718.942810571924, 5729.856753581111, 5652.689102099424, 5689.0, 5693.430656934273, 5695.629784064023, 5700.201971723962, 4271.572842715704, 4306.621880998113, 4330.870073897788, 4351.782410879443, 4397.956020439755, 3855.4602355670227, 3875.5155605549307, 3892.1048158923604, 3916.980415097906, 3959.4852669152824, 5443.129099344086, 5443.510084092451, 5449.918251226235, 5451.945480545223, 5452.127659574449, 5519.668819870741, 5659.236003139606, 5726.656400615976, 5745.540356771448, 5803.912941305884, 5410.648307859977, 5427.3758517770175, 5437.918431223535, 5455.61810673257, 5467.316585426822, 4941.48114447985, 4948.38145231846, 4948.406191257072, 4951.3810773653295, 4997.450280469146, 5737.971310143423, 5802.013657678289, 5914.112883067488, 5928.67392293428, 5932.614380065282, 5641.351244606759, 5708.942910570841, 5718.313802343579, 5764.452377024176, 5764.913526297025, 5888.352281248974, 5893.116032594973, 5894.174815525916, 5907.3797251288, 5909.143174239625, 5486.588505861996, 5564.304461942257, 5614.382417933943, 5617.213590097472, 5617.32592088952, 5732.828015159552, 5769.3942136076785, 5769.884602308014, 5822.243108396051, 5825.359210486928, 5615.298087739033, 5631.352394474688, 5632.2678051853, 5634.661920284796, 5647.6893770843, 5408.37803652585, 5488.670679759227, 5611.3266408031295, 5634.690092044977, 5639.2668953035845, 5462.453754624506, 5518.448155184449, 5521.420250873761, 5553.333599968029, 5561.443855614406, 5615.8876822464135, 5617.691026993554, 5630.5214056805635, 5665.12190610456, 5667.659940403589, 5309.177077552986, 5417.891642167056, 5476.972615136899, 5493.505584497414, 5494.230807686847], "value": 5266.585120649, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.1648059755147, 612.7885879371618, 629.1098096193886, 639.2776162935882, 643.4755674125587, 31188.68811311886, 33489.66510334899, 33501.49747753779, 42374.57625423745, 43618.34572481416, 45544.0, 45971.54028459715, 46013.309800353025, 46024.769876150574, 46042.769786151104, 8955.283577313816, 9089.500077495735, 9094.86357704635, 9103.998560158378, 9107.408018478778, 8212.548309842956, 10621.893781062168, 10795.190360722938, 10815.513301901434, 11215.327080375204, 10910.290831095994, 10965.0, 11063.557457701681, 11067.391293478855, 11071.944640276788, 8216.917830821674, 10732.248742588023, 10792.622258220925, 10795.784084318348, 10802.13582913369, 10509.421981790998, 10861.07680847121, 10864.348139111678, 11223.66329010131, 11265.211435199539, 43771.34342984858, 44154.55845441537, 44165.337519936904, 44173.55826441727, 44183.77908110471, 3327.3844338797157, 3415.555977722905, 3434.0213039283685, 3449.292894956553, 3522.9119272018406, 34230.0, 34237.486437703454, 34591.30817383663, 34862.65137348645, 35731.0, 3951.209758048402, 3972.6226008529143, 3983.960160398417, 3995.220931918277, 4000.4799376080923, 370944.0, 371814.0, 371977.0, 372813.99999999726, 373267.0, 59717.701411492664, 60270.39729602648, 60287.69856150691, 60305.39694603086, 60338.0, 36673.26653466916, 36868.0, 36945.0, 38818.417723734165, 63108.36891631117, 17182.484525464257, 17245.0, 17296.567585810455, 17303.826961730472, 17354.652906941792, 11800.822987655192, 12605.747885042249, 13153.934230328978, 13243.205407675378, 13251.337433128498, 19223.711644325347, 19664.131907468767, 19842.1071051803, 19849.80901145907, 20061.398158055283, 7008.26413226614, 7092.255313192144, 7107.644617769194, 7364.5581265124265, 7402.483155727079, 1019.938803671782, 1022.4938655365642, 1123.43828085957, 1127.7969965406305, 1133.1161693878787, 33740.0, 34136.317273654386, 34228.48657270143, 34268.82865585656, 34809.65190348115, 1100.1858624617726, 1111.7887601355717, 1159.1654009113424, 1178.1399578307883, 1186.8813118688063, 16891.662166756596, 17163.828361716223, 17216.0, 17287.82712172862, 17341.632446084008, 543307.0, 544168.0, 547195.0, 548911.0, 551156.0, 59254.11118833221, 59456.70271648701, 59560.0, 59646.40353596495, 59672.403275967554, 1242.2918936206277, 1320.610419926124, 1360.6190266725332, 1371.1978492581752, 1394.4910107810576, 30796.384072318877, 34849.65150348464, 34908.0, 35133.648663513035, 35170.0, 51004.74497627488, 51340.22989655233, 51348.0, 51373.0, 51957.0, 427679.0, 427710.0, 433333.0, 435224.0, 436048.0, 24807.379815504755, 25454.0, 25632.564906333868, 28654.283642909093, 29064.854675726485, 47646.761766190946, 47889.18074046012, 48226.0, 48513.757431212616, 48526.0, 40610.79694601508, 40640.79679601583, 40930.74880881461, 41498.585014149474, 42830.14339713126, 40698.38952415657, 41780.688961779386, 41923.161536768486, 42117.57882421136, 42289.57710422979, 40631.593684062784, 41145.38281925833, 41841.0, 41895.16209675728, 42076.36885446782, 34454.65545344514, 36775.448368275036, 36924.0, 37010.25979480449, 37551.0, 28067.157985260474, 28809.56785648259, 28925.56611650785, 28970.42059158763, 28979.0], "value": 20541.215587562496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.14542833340795, 383.1723477289056, 385.864947268456, 401.96382325590696, 419.4588980215522, 14742.11547307161, 17074.829251707495, 18953.52616184596, 19864.70202946957, 19899.801001989978, 18877.905610471964, 18879.43361699151, 18881.622367552674, 18971.62056758864, 19108.713369299472, 4198.580141985807, 5763.711814409273, 5934.643921364732, 5979.760809567612, 5981.043033114703, 6421.261554921197, 6705.0, 6771.255161932184, 6861.55399899005, 6876.071730316418, 6595.503429122311, 6679.532432729711, 6686.1642294713165, 6695.598264104145, 6811.591304521719, 6535.379138981789, 6708.932910670904, 6770.052192693027, 6782.491313151509, 6785.72857085716, 5887.205227294303, 5931.881362372772, 5933.732982015819, 5937.643741375531, 5941.792037278675, 21930.342089737333, 22555.887220563956, 22801.201957931393, 23120.306390808135, 23791.76208237913, 2263.6717675936898, 2543.4150145466647, 2549.260714392824, 2842.786790990684, 2963.051465097516, 10507.106895913856, 10684.305520141166, 10701.357918524836, 10711.571537138505, 10825.891741082567, 1873.1222842954687, 1945.1125685345917, 1998.6902030185345, 2061.093119027638, 2061.2476446097216, 82347.0, 85843.57078214569, 87585.0, 89780.10219897782, 90522.0, 10621.362718236931, 10723.517441715141, 10878.0, 10972.506237219344, 11081.390523521284, 15210.391584336723, 15227.923860380848, 15260.618484537754, 15271.694566108838, 15275.694486110438, 7823.960880195563, 8228.8354232915, 8264.710735124241, 8383.28742056932, 8384.0, 7918.920810791934, 7949.085855126619, 7965.56189409588, 8159.265666089962, 8236.588170591447, 4698.718076915396, 4723.700982229846, 4729.810807567727, 4752.0, 4857.0, 1945.902704864751, 1977.32770857909, 1977.5945931084093, 1992.0836415249148, 2039.775624681284, 904.6019751309403, 969.5879251318303, 1016.8373060310315, 1062.049465728169, 1070.983935240972, 19931.10310036052, 20388.898055509922, 20405.0, 20425.285115020903, 20825.68761468579, 990.8563258327503, 993.4287784523927, 999.3304485994402, 1025.103034844511, 1067.2582555124113, 10348.223883208639, 11253.268537545033, 11317.49071291794, 11333.546658133748, 11365.886341136647, 374747.0, 379016.0, 379514.0, 484665.0, 487002.0, 57129.714351427974, 73871.0, 93950.0, 98364.50817745866, 99909.0, 921.9446833189896, 1021.4688362051543, 1026.661201803418, 1076.5424694504804, 1078.0028473661832, 17399.304027838745, 17863.196156173264, 17911.641767164325, 18185.272589096287, 18372.265109395474, 43307.0, 43936.780316099495, 44153.55846441623, 44272.335914960655, 44689.0, 61402.38597613967, 61406.38593614007, 62000.68999654973, 62485.68757156185, 64175.94064652791, 8284.544350060805, 8366.83266334682, 8470.534120623424, 8624.318043545436, 8836.602352894006, 9075.183233509017, 9084.772880678036, 9294.024127466519, 9600.903990960001, 9667.661631843133, 8147.2139189846675, 8185.4270201085355, 8190.385721071063, 8416.957915210385, 8773.912260877565, 8086.15095414973, 8381.49711017341, 8450.492970421794, 8530.957345213234, 8808.91191088081, 8323.0, 8554.486730796172, 8555.058943516084, 8605.311575073854, 8878.11218878107, 12219.26684398939, 12755.744885102431, 12802.935985320013, 12825.679358015752, 12848.678783030498, 11455.885441145481, 11477.36874471912, 11568.595099171489, 11843.644690659294, 12095.818562721743], "value": 9181.4961539558, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.7949287099807, 1499.662575920418, 1610.4765951065906, 1757.1214392803597, 1769.0447158534391, 8234.42359034867, 8672.696455624055, 8674.522901240429, 8675.219230269282, 8680.956595217014, 7221.963890180555, 8266.751997440086, 8503.574821258942, 8549.572521373922, 8664.0, 2307.9192228272013, 2323.8721870297127, 2331.4521087544413, 2337.5208082343165, 2338.3920180752957, 2280.1221529711097, 2294.1740973249616, 2322.651602259666, 2322.8490148140318, 2323.175272778165, 1983.0580474274748, 2282.9543409131807, 2288.9885550572226, 2359.292212336301, 2361.586722323595, 2270.103309192876, 2278.3848360942534, 2296.322584837477, 2298.850574712647, 2300.896459659311, 2193.1556350804894, 2258.2660635293432, 2262.083856038307, 2264.490489639818, 2266.5806825737127, 9044.77388065297, 9075.773105672411, 9091.545422728903, 9096.727098187064, 9149.359544831865, 5116.718580478072, 5216.0, 5255.054090263751, 5256.710880901549, 5261.0, 3284.939429618653, 3294.2423242654086, 3358.4962255661603, 3395.6264810870784, 3416.794992300445, 1074.6883403812885, 1075.7095584192225, 1084.1326938449208, 1098.3849044535086, 1100.3342977498658, 11963.222390544586, 12054.879451205463, 12055.397230138546, 12058.939705301505, 12075.154739168262, 4447.310666846644, 4587.449506059294, 4663.440387153563, 4674.509176536482, 4678.134545109166, 10249.692509224586, 10323.380597164043, 10324.896751032544, 10332.0, 10374.221933354878, 5267.394249661262, 5267.868303292448, 5268.868278292996, 5268.894622107613, 5269.736513174403, 4160.271952408377, 4667.836625718083, 4689.390379250675, 4733.195356789285, 4846.709197448094, 3925.7055720821054, 4006.6794656427414, 4056.2090392373793, 4079.918401631951, 4121.216968775923, 1249.9812502812283, 1251.4806355362423, 1261.218044812204, 1261.3882267100448, 1288.5103660609095, 812.9674813007414, 819.4919150126959, 904.0552622509493, 940.083418666808, 1035.3270374256642, 5953.940460595425, 6020.187274717945, 6122.663253521099, 6144.126041557279, 6154.78458253959, 939.9671011514564, 944.9149576538144, 976.2531663277456, 980.9509524523745, 1011.1758916483043, 4132.752034877857, 4233.322668373107, 4388.495323037828, 4449.377087207794, 4502.189605870974, 11236.157288203418, 11353.148513861493, 11436.656900293005, 11456.94271528637, 11465.942670286762, 10456.372617642966, 10744.194185435967, 11387.886121138683, 11390.430478476042, 11392.544298228144, 8120.959395203105, 8251.876221856677, 8273.296769774517, 8309.044459887069, 8334.333253339719, 6033.637981721111, 6199.225096862892, 6204.286507051566, 6244.843878903063, 6274.74901003973, 9985.950070249894, 10142.746431338981, 10245.795084098127, 10251.948740256252, 10326.948365258426, 10210.285280030326, 10211.183105351405, 10450.581976720847, 10581.62964296246, 10582.682519524427, 7747.1090824555895, 7917.327027202752, 8012.318952888837, 8035.477693949874, 8038.517688938682, 8503.319734421355, 8541.829163416822, 8582.570871456526, 8595.18345757152, 8598.355123365647, 7559.092908850973, 7673.386129109546, 7679.577623230776, 7687.884681729666, 7806.609669516615, 7595.354394876276, 7626.081157747073, 7680.5391676499585, 7729.304362607392, 7786.571738554434, 7090.326418990187, 7141.321574450419, 7158.105236845395, 7172.246914073947, 7177.1746249182015, 5002.924956125588, 5133.204353325241, 5185.948140518697, 5241.9737901310245, 5321.920171197357, 5108.56577190943, 5253.632245742761, 5270.393904700855, 5280.762365693477, 5491.28613280271], "value": 4653.205288981047, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.0949132936449, 327.72634849900334, 332.38011109281183, 332.4514550990865, 337.4129015513008, 5160.845174644757, 5322.646732558483, 5331.280277162587, 5340.43925387834, 5343.225232341309, 5123.718195499256, 5191.974040129794, 5237.507310416532, 5243.475652434755, 5275.6043296752805, 4172.603602657758, 4174.163368118034, 4181.163767246548, 4184.748915065105, 4215.178040282146, 4064.695147863907, 4184.623383895449, 4185.707000509966, 4205.981129058054, 4213.841193671734, 4131.6281534661875, 4156.251874662559, 4162.875113746592, 4167.9583204167875, 4177.874663760092, 4139.337705967046, 4148.917021659565, 4155.4182414462, 4160.313548264533, 4170.602848045908, 3692.2615476904457, 3696.131409118855, 3700.6484383983748, 3705.74059815813, 3723.4600982857605, 5144.9163088949035, 5244.79020839166, 5260.605454590921, 5289.206619007141, 5298.8342564636105, 4764.523547645208, 4768.976155119202, 4786.2581299898575, 4789.928151077736, 4803.423589169322, 5432.13085906257, 5466.606015466071, 5557.527610153142, 5576.442355764431, 5589.888202235932, 3993.2412841560013, 3998.3402738548107, 4000.659778974018, 4005.218982298453, 4022.255882661717, 5830.883382332372, 5874.941250587525, 5882.676397810501, 5890.469857712784, 5891.3814049525035, 4126.525449573338, 4132.752034877917, 4133.503979522477, 4148.875533733993, 4155.10665206982, 4058.512978442606, 4134.441850350225, 4138.255114079495, 4140.275451795984, 4160.732400841549, 4708.623310135181, 4745.3593764842, 4751.429828420612, 4753.595944344769, 4755.643326750507, 5575.804846830341, 5596.944030559724, 5606.327240731057, 5613.242212301287, 5617.01702202113, 1308.3523655790445, 1338.7188690374935, 1375.7111006688708, 1410.9929450352683, 1413.9536742810246, 953.6042542344987, 974.3910056214866, 988.0, 993.3692105513052, 1000.5797565022563, 5392.514673679388, 5414.864628384243, 5419.810306639249, 5421.810236641699, 5431.21247419122, 5713.514351280188, 5749.195112684228, 5757.539396848242, 5759.596828221985, 5761.0, 5258.50044245796, 5281.762320695578, 5287.550558202519, 5399.190121481731, 5459.071957767189, 2648.139354709727, 2693.46130773846, 2698.5007773561956, 2710.4443589064194, 2723.237493501823, 5236.162214045735, 5288.576913846883, 5299.4435584263865, 5302.575793936476, 5308.230306605597, 5033.245013248042, 5176.301199338116, 5189.455107213764, 5233.35149427929, 5263.289455923478, 5232.843014709565, 5241.449647787003, 5249.42256351801, 5325.920111198335, 5332.146856502941, 5079.92380114306, 5097.719625420637, 5106.693598384109, 5120.155174396183, 5135.8957824068, 4716.056788642217, 4918.5573298403315, 5024.497550244946, 5034.471380505141, 5076.619253555924, 5208.9739551302, 5267.60492963037, 5291.9470805292995, 5297.357819076099, 5302.170751091022, 3810.1330348128663, 3918.490596222473, 3954.149857780591, 4116.279651060992, 4119.608637179464, 5720.3707592165665, 5724.57065720081, 5734.770609175586, 5735.222081154855, 5757.884842303214, 5620.4660557247, 5645.125005624135, 5667.1782591524825, 5679.3184817820475, 5693.231413759255, 5458.044842152687, 5665.178549110438, 5669.433056694297, 5672.914906276492, 5685.658860468385, 5551.583631227593, 5578.219049333015, 5590.496855282881, 5594.748236329457, 5638.746256418389, 5460.481254280837, 5681.147827825859, 5737.225474561048, 5740.0, 5740.368559458373, 5558.44415558441, 5573.0, 5577.74900129487, 5581.88362327528, 5591.524720398812], "value": 4178.01184293025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.5205771700084, 657.97039133239, 726.5386479585462, 830.5349004557445, 834.1950018232412, 14660.853391466095, 15668.686626267468, 15765.975211611267, 15802.604934876634, 15907.840921590781, 14228.288585570732, 14304.356303966346, 14447.711045779079, 14495.0, 15139.77290340643, 809.2797410304819, 820.2125959079291, 824.4846970643348, 824.4888169335021, 825.9504429734205, 664.8138521214067, 815.4251252866715, 816.7386436340373, 819.3117781063905, 824.1634740738156, 835.2148979958849, 839.7732612194703, 840.5293035899886, 841.7769291137853, 842.8988521377444, 834.3158609939852, 834.8789425533264, 834.9874751878726, 835.4110352201744, 838.174398217755, 518.044208435436, 613.1446631948452, 624.3475568031419, 630.9116723658691, 633.7781776378276, 13283.269420181887, 13292.534761283308, 13304.0, 13315.600531984055, 13320.467181312735, 14283.285835708173, 14827.0, 14841.999999999893, 14845.777313340308, 14876.256187190596, 13006.674833129153, 13124.86875131246, 13181.736365272642, 13246.66883327915, 13333.266670333127, 4292.828286868522, 4303.935440968388, 4309.729343804756, 4340.197063543254, 4419.535948725402, 77316.0, 77366.61316693437, 77923.61038194773, 78330.0, 82486.58756706178, 11372.0, 11465.54137834494, 11556.76886462266, 11671.416429178676, 11690.240134391237, 20117.29589464391, 20149.697754533692, 20162.798372016387, 20176.59646807085, 20290.69563956542, 8797.912020879838, 8854.424462409923, 8921.330900182382, 8973.865392019125, 9091.454512729257, 4814.109389762905, 4983.8504844854715, 5010.098182327143, 5051.621128415383, 5132.204508301219, 3448.9482657760154, 3566.4828599853395, 3596.532450781434, 3609.4405367168133, 3617.04148400674, 616.7317217010525, 628.5160426471591, 633.7971849008273, 653.4119292636665, 656.4223483334634, 647.8801421736994, 661.7849199010244, 743.18992298395, 747.8616455955665, 757.1028331427276, 8582.570871456403, 9396.906030939603, 9486.0, 9534.04659534055, 9656.75858103539, 640.7885397818802, 683.4395795447685, 683.8974153876958, 688.7623769799411, 701.8175274428685, 4255.0, 4541.704789188759, 4589.518100599389, 4603.286490593896, 4662.114198302312, 117558.41220794013, 118542.40728796301, 120401.0, 120671.39664301623, 122156.38921805334, 99152.50423747835, 103028.48485757523, 105387.47306263419, 105749.0, 107532.46233768782, 71888.0, 91735.54132229296, 91866.0, 92396.53801731083, 93132.53433732787, 8590.527520986405, 8820.2061814437, 8838.955805220932, 8865.468071915706, 8878.95560522219, 38349.61650383461, 46140.0, 53128.46871531235, 53321.7333913328, 55561.444385555624, 80234.0, 80527.59736201282, 82955.58522207351, 83044.0, 84544.1545584561, 11584.94207528957, 11749.980131923861, 11805.586804461802, 11821.881781182077, 11930.582429614922, 12890.742185156432, 13431.86568134306, 13455.86544134546, 13493.190408575518, 13631.931840340734, 9417.670381536613, 11443.084553235887, 11455.770884582094, 11748.35384053851, 11845.0, 12973.481060757464, 13381.66545836362, 13682.384292706653, 13790.241536715577, 13860.237686927316, 13059.608211753663, 13268.93365533166, 13269.66825829362, 13300.800487992494, 13390.598282051555, 11269.66191014271, 11303.0, 11528.037221101747, 11701.356425396685, 11732.648020559396, 9281.907180928105, 9507.763990681167, 10359.792804144026, 10478.588919193375, 10647.520861561094], "value": 7476.195221170048, "unit": "score"}], "name": "dromaeo_css", "value": 7243.0189241213575, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 113.0, 114.0, 111.0, 112.0, 110.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 117.0, 185.0, 120.0, 119.0, 151.0, 117.0, 150.0, 124.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 159.0, 159.0, 160.0, 159.0, 162.0, 162.0, 163.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 112.0, 76.0, 76.0, 75.0, 76.0, 110.0, 74.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 107.0, 82.0, 83.0, 84.0, 112.0, 85.0, 83.0, 129.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 51.0, 50.0, 49.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 79.0, 82.0, 75.0, 75.0, 75.0, 76.0, 74.0, 75.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 146.0, 122.0, 120.0, 119.0, 128.0, 123.0, 118.0, 165.0, 134.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 155.0, 155.0, 156.0, 156.0, 155.0, 156.0, 153.0, 156.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 67.0, 63.0, 64.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1478.0, "alertThreshold": 2.0}]} 07:30:28 INFO - Return code: 0 07:30:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:30:28 INFO - # TBPL SUCCESS # 07:30:28 INFO - Running post-action listener: _resource_record_post_action 07:30:28 INFO - [mozharness: 2016-07-20 14:30:28.697300Z] Finished run-tests step (success) 07:30:28 INFO - Running post-run listener: _resource_record_post_run 07:30:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559165440; Read time: 176; Write time: 498460 07:30:28 INFO - TinderboxPrint: CPU usage
13.0% 07:30:28 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 07:30:28 INFO - TinderboxPrint: I/O write bytes / time
559,165,440 / 498,460 07:30:28 INFO - TinderboxPrint: CPU idle
8,272.8 (87.0%) 07:30:28 INFO - TinderboxPrint: CPU user
1,194.9 (12.6%) 07:30:28 INFO - TinderboxPrint: Swap in / out
0 / 0 07:30:28 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257273856; Read time: 0; Write time: 314848 07:30:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301666304; Read time: 168; Write time: 183588 07:30:29 INFO - Running post-run listener: _upload_blobber_files 07:30:29 INFO - Blob upload gear active. 07:30:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:30:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:30:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:30:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:30 INFO - (blobuploader) - INFO - Done attempting. 07:30:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:30:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:30:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:48 INFO - (blobuploader) - INFO - Done attempting. 07:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:30:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:49 INFO - (blobuploader) - INFO - Done attempting. 07:30:49 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:49 INFO - Return code: 0 07:30:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c4ce3e20de898fbb579dfb177c7b6ae10b28c1a00bdb0601f2829e763ae7ba2b538f06d94c88379fb5a8750fb4a7a2e4e54020d0ef9e05034e2eeba2c597406", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/486acc0a3f7e794a9d1d95f9a9a4232ffac17d6255919da8f90b227f61779809d3c98aadac5f607ad8c2682e6b6803e9c205249b8d68de928b317e153380a66e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5401b665e5123b3a4886d6c185c853530d9efb68470fae36671f4a9cd56f268d4acc4923a06250d842ddc0a039a237af21b487be09324527403a4fe3754b8"} 07:30:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:49 INFO - Contents: 07:30:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c4ce3e20de898fbb579dfb177c7b6ae10b28c1a00bdb0601f2829e763ae7ba2b538f06d94c88379fb5a8750fb4a7a2e4e54020d0ef9e05034e2eeba2c597406", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/486acc0a3f7e794a9d1d95f9a9a4232ffac17d6255919da8f90b227f61779809d3c98aadac5f607ad8c2682e6b6803e9c205249b8d68de928b317e153380a66e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5401b665e5123b3a4886d6c185c853530d9efb68470fae36671f4a9cd56f268d4acc4923a06250d842ddc0a039a237af21b487be09324527403a4fe3754b8"} 07:30:49 INFO - Running post-run listener: copy_logs_to_upload_dir 07:30:49 INFO - Copying logs to upload dir... 07:30:49 INFO - mkdir: /builds/slave/test/build/upload/logs 07:30:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.587793 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-20 07:30:49.423109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:49.426737) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c4ce3e20de898fbb579dfb177c7b6ae10b28c1a00bdb0601f2829e763ae7ba2b538f06d94c88379fb5a8750fb4a7a2e4e54020d0ef9e05034e2eeba2c597406", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/486acc0a3f7e794a9d1d95f9a9a4232ffac17d6255919da8f90b227f61779809d3c98aadac5f607ad8c2682e6b6803e9c205249b8d68de928b317e153380a66e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5401b665e5123b3a4886d6c185c853530d9efb68470fae36671f4a9cd56f268d4acc4923a06250d842ddc0a039a237af21b487be09324527403a4fe3754b8"} build_url:https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c4ce3e20de898fbb579dfb177c7b6ae10b28c1a00bdb0601f2829e763ae7ba2b538f06d94c88379fb5a8750fb4a7a2e4e54020d0ef9e05034e2eeba2c597406", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/486acc0a3f7e794a9d1d95f9a9a4232ffac17d6255919da8f90b227f61779809d3c98aadac5f607ad8c2682e6b6803e9c205249b8d68de928b317e153380a66e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5401b665e5123b3a4886d6c185c853530d9efb68470fae36671f4a9cd56f268d4acc4923a06250d842ddc0a039a237af21b487be09324527403a4fe3754b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:49.452694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:49.453057) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1469023518.579645-1614001149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004677 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:49.537594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:30:49.537913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:30:49.538233) ========= ========= Total master_lag: 0.17 =========