builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1470661526.37 results: success (0) buildid: 20160808023008 builduid: 42f102f16a6c4fb7ae212d49f58fed10 revision: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.366132) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.366711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.367063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.382044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.382356) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 06:05:28-- 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% 38.2M=0s 2016-08-08 06:05:28 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118890 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.515419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.515755) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:26.565721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 06:05:26.566126) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46dede080ba1b6bcaaf5af7b00fc5e356c66faac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46dede080ba1b6bcaaf5af7b00fc5e356c66faac --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=a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 06:05:28,245 truncating revision to first 12 chars 2016-08-08 06:05:28,245 Setting DEBUG logging. 2016-08-08 06:05:28,245 attempt 1/10 2016-08-08 06:05:28,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46dede080ba1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 06:05:28,565 unpacking tar archive at: fx-team-46dede080ba1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649946 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 06:05:27.650446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:27.650828) ========= script_repo_revision: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:27.651313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:27.651763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 06:05:27.662781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-08 06:05:27.663092) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:05:29 INFO - MultiFileLogger online at 20160808 06:05:29 in /builds/slave/test 06:05:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:05:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:05:29 INFO - {'append_to_log': False, 06:05:29 INFO - 'base_work_dir': '/builds/slave/test', 06:05:29 INFO - 'blob_upload_branch': 'Fx-Team', 06:05:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:05:29 INFO - 'branch': 'Fx-Team', 06:05:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:05:29 INFO - 'config_files': ('talos/linux_config.py',), 06:05:29 INFO - 'default_actions': ('clobber', 06:05:29 INFO - 'read-buildbot-config', 06:05:29 INFO - 'download-and-extract', 06:05:29 INFO - 'populate-webroot', 06:05:29 INFO - 'create-virtualenv', 06:05:29 INFO - 'install', 06:05:29 INFO - 'run-tests'), 06:05:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:05:29 INFO - 'download_minidump_stackwalk': True, 06:05:29 INFO - 'download_symbols': 'ondemand', 06:05:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:05:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:05:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:05:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:05:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:05:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:05:29 INFO - 'installer_path': 'installer.exe', 06:05:29 INFO - 'log_level': 'info', 06:05:29 INFO - 'log_name': 'talos', 06:05:29 INFO - 'log_to_console': True, 06:05:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:05:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:05:29 INFO - 'opt_config_files': (), 06:05:29 INFO - 'pip_index': False, 06:05:29 INFO - 'sps_profile': False, 06:05:29 INFO - 'sps_profile_interval': 0, 06:05:29 INFO - 'suite': 'dromaeojs', 06:05:29 INFO - 'system_bits': '32', 06:05:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:05:29 INFO - 'title': 'talos-linux64-ix-062', 06:05:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:05:29 INFO - 'use_talos_json': True, 06:05:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:05:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:05:29 INFO - 'work_dir': 'build'} 06:05:29 INFO - [mozharness: 2016-08-08 13:05:29.445626Z] Running clobber step. 06:05:29 INFO - Running pre-action listener: _resource_record_pre_action 06:05:29 INFO - Running main action method: clobber 06:05:29 INFO - rmtree: /builds/slave/test/build 06:05:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:05:30 INFO - Running post-action listener: _resource_record_post_action 06:05:30 INFO - [mozharness: 2016-08-08 13:05:30.433720Z] Finished clobber step (success) 06:05:30 INFO - [mozharness: 2016-08-08 13:05:30.433820Z] Running read-buildbot-config step. 06:05:30 INFO - Running pre-action listener: _resource_record_pre_action 06:05:30 INFO - Running main action method: read_buildbot_config 06:05:30 INFO - Using buildbot properties: 06:05:30 INFO - { 06:05:30 INFO - "project": "", 06:05:30 INFO - "product": "firefox", 06:05:30 INFO - "script_repo_revision": "production", 06:05:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:05:30 INFO - "repository": "", 06:05:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:05:30 INFO - "buildid": "20160808023008", 06:05:30 INFO - "pgo_build": "True", 06:05:30 INFO - "basedir": "/builds/slave/test", 06:05:30 INFO - "buildnumber": 1440, 06:05:30 INFO - "slavename": "talos-linux64-ix-062", 06:05:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:05:30 INFO - "platform": "ubuntu64_hw", 06:05:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:05:30 INFO - "branch": "fx-team", 06:05:30 INFO - "repo_path": "integration/fx-team", 06:05:30 INFO - "revision": "46dede080ba1b6bcaaf5af7b00fc5e356c66faac", 06:05:30 INFO - "stage_platform": "linux64-pgo", 06:05:30 INFO - "builduid": "42f102f16a6c4fb7ae212d49f58fed10", 06:05:30 INFO - "slavebuilddir": "test" 06:05:30 INFO - } 06:05:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:05:30 INFO - Running post-action listener: _resource_record_post_action 06:05:30 INFO - [mozharness: 2016-08-08 13:05:30.436255Z] Finished read-buildbot-config step (success) 06:05:30 INFO - [mozharness: 2016-08-08 13:05:30.436345Z] Running download-and-extract step. 06:05:30 INFO - Running pre-action listener: _resource_record_pre_action 06:05:30 INFO - Running main action method: download_and_extract 06:05:30 INFO - mkdir: /builds/slave/test/build/tests 06:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:30 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:05:30 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:05:30 INFO - Downloaded 1361 bytes. 06:05:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:05:30 INFO - Using the following test package requirements: 06:05:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:05:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:05:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:05:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:30 INFO - u'jsshell-linux-x86_64.zip'], 06:05:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:05:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:05:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:05:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:05:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:05:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:05:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:31 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:05:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:05:31 INFO - Downloaded 21828583 bytes. 06:05:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:05:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:05:33 INFO - Return code: 0 06:05:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:33 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:05:33 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:05:34 INFO - Downloaded 21828583 bytes. 06:05:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:05:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:05:35 INFO - Return code: 0 06:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:35 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:05:37 INFO - Downloaded 14413723 bytes. 06:05:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:05:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:05:37 INFO - Return code: 0 06:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:37 INFO - trying https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:05:37 INFO - Downloading https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:05:39 INFO - Downloaded 59960069 bytes. 06:05:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:05:39 INFO - mkdir: /builds/slave/test/properties 06:05:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:05:39 INFO - Writing to file /builds/slave/test/properties/build_url 06:05:39 INFO - Contents: 06:05:39 INFO - build_url:https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:05:40 INFO - Running post-action listener: _resource_record_post_action 06:05:40 INFO - Running post-action listener: set_extra_try_arguments 06:05:40 INFO - [mozharness: 2016-08-08 13:05:40.017955Z] Finished download-and-extract step (success) 06:05:40 INFO - [mozharness: 2016-08-08 13:05:40.018188Z] Running populate-webroot step. 06:05:40 INFO - Running pre-action listener: _resource_record_pre_action 06:05:40 INFO - Running main action method: populate_webroot 06:05:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:05:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:05:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:05:40 INFO - '--tppagecycles', 06:05:40 INFO - '7'], 06:05:40 INFO - 'tests': ['tsvgm']}}, 06:05:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:05:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:05:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:05:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:05:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['damp', 'tps']}, 06:05:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'tests': ['damp', 'tps']}, 06:05:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['dromaeo_dom']}, 06:05:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:05:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['basic_compositor_video']}, 06:05:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:05:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['a11yr', 06:05:40 INFO - 'ts_paint', 06:05:40 INFO - 'tpaint', 06:05:40 INFO - 'sessionrestore', 06:05:40 INFO - 'sessionrestore_no_auto_restore', 06:05:40 INFO - 'tabpaint']}, 06:05:40 INFO - 'other-e10s': {'tests': ['a11yr', 06:05:40 INFO - 'ts_paint', 06:05:40 INFO - 'tpaint', 06:05:40 INFO - 'sessionrestore', 06:05:40 INFO - 'sessionrestore_no_auto_restore', 06:05:40 INFO - 'tabpaint']}, 06:05:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:05:40 INFO - 'ts_paint', 06:05:40 INFO - 'tpaint', 06:05:40 INFO - 'sessionrestore', 06:05:40 INFO - 'sessionrestore_no_auto_restore', 06:05:40 INFO - 'tabpaint']}, 06:05:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:05:40 INFO - 'ts_paint', 06:05:40 INFO - 'tpaint', 06:05:40 INFO - 'sessionrestore', 06:05:40 INFO - 'sessionrestore_no_auto_restore', 06:05:40 INFO - 'tabpaint']}, 06:05:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['a11yr', 06:05:40 INFO - 'ts_paint', 06:05:40 INFO - 'tpaint', 06:05:40 INFO - 'sessionrestore', 06:05:40 INFO - 'sessionrestore_no_auto_restore', 06:05:40 INFO - 'tabpaint']}, 06:05:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['a11yr', 06:05:40 INFO - 'ts_paint', 06:05:40 INFO - 'tpaint', 06:05:40 INFO - 'sessionrestore', 06:05:40 INFO - 'sessionrestore_no_auto_restore', 06:05:40 INFO - 'tabpaint']}, 06:05:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['tsvgx', 06:05:40 INFO - 'tsvgr_opacity', 06:05:40 INFO - 'tart', 06:05:40 INFO - 'tscrollx', 06:05:40 INFO - 'cart']}, 06:05:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:05:40 INFO - 'tsvgr_opacity', 06:05:40 INFO - 'tart', 06:05:40 INFO - 'tscrollx', 06:05:40 INFO - 'cart']}, 06:05:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'talos_options': ['--disable-e10s'], 06:05:40 INFO - 'tests': ['tp5o']}, 06:05:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'tests': ['tp5o']}, 06:05:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'talos_options': ['--disable-e10s', 06:05:40 INFO - '--xperf_path', 06:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:40 INFO - 'tests': ['tp5n']}, 06:05:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:40 INFO - 'talos_options': ['--xperf_path', 06:05:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:40 INFO - 'tests': ['tp5n']}}, 06:05:40 INFO - 'talos.zip': {'path': '', 06:05:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:05:40 INFO - Running post-action listener: _resource_record_post_action 06:05:40 INFO - [mozharness: 2016-08-08 13:05:40.038270Z] Finished populate-webroot step (success) 06:05:40 INFO - [mozharness: 2016-08-08 13:05:40.038360Z] Running create-virtualenv step. 06:05:40 INFO - Running pre-action listener: _resource_record_pre_action 06:05:40 INFO - Running main action method: create_virtualenv 06:05:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:05:40 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 06:05:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:05:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:05:40 INFO - Using real prefix '/usr' 06:05:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:05:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:42 INFO - Installing pip.................done. 06:05:42 INFO - Return code: 0 06:05:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:05:42 INFO - Using env: {'DISPLAY': ':0', 06:05:42 INFO - 'HOME': '/home/cltbld', 06:05:42 INFO - 'LANG': 'en_US.UTF-8', 06:05:42 INFO - 'LANGUAGE': 'en_US:en', 06:05:42 INFO - 'LOGNAME': 'cltbld', 06:05:42 INFO - 'MAIL': '/var/mail/cltbld', 06:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:42 INFO - 'MOZ_NO_REMOTE': '1', 06:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:42 INFO - 'NO_EM_RESTART': '1', 06:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:42 INFO - 'PWD': '/builds/slave/test', 06:05:42 INFO - 'SHELL': '/bin/bash', 06:05:42 INFO - 'SHLVL': '1', 06:05:42 INFO - 'TERM': 'linux', 06:05:42 INFO - 'TMOUT': '86400', 06:05:42 INFO - 'USER': 'cltbld', 06:05:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:42 INFO - '_': '/tools/buildbot/bin/python'} 06:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:42 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 06:05:42 INFO - Cleaning up... 06:05:42 INFO - Return code: 0 06:05:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:05:42 INFO - Using env: {'DISPLAY': ':0', 06:05:42 INFO - 'HOME': '/home/cltbld', 06:05:42 INFO - 'LANG': 'en_US.UTF-8', 06:05:42 INFO - 'LANGUAGE': 'en_US:en', 06:05:42 INFO - 'LOGNAME': 'cltbld', 06:05:42 INFO - 'MAIL': '/var/mail/cltbld', 06:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:42 INFO - 'MOZ_NO_REMOTE': '1', 06:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:42 INFO - 'NO_EM_RESTART': '1', 06:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:42 INFO - 'PWD': '/builds/slave/test', 06:05:42 INFO - 'SHELL': '/bin/bash', 06:05:42 INFO - 'SHLVL': '1', 06:05:42 INFO - 'TERM': 'linux', 06:05:42 INFO - 'TMOUT': '86400', 06:05:42 INFO - 'USER': 'cltbld', 06:05:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:42 INFO - '_': '/tools/buildbot/bin/python'} 06:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:43 INFO - Downloading/unpacking psutil>=3.1.1 06:05:43 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 06:05:43 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 06:05:43 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 06:05:43 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 06:05:43 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 06:05:43 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 06:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:45 INFO - Installing collected packages: psutil 06:05:45 INFO - Running setup.py install for psutil 06:05:45 INFO - building 'psutil._psutil_linux' extension 06:05:45 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 06:05:45 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 06:05:45 INFO - building 'psutil._psutil_posix' extension 06:05:45 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 06:05:45 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 06:05:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:45 INFO - Successfully installed psutil 06:05:45 INFO - Cleaning up... 06:05:45 INFO - Return code: 0 06:05:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:45 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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:45 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 06:05:45 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 06:05:45 INFO - Using env: {'DISPLAY': ':0', 06:05:45 INFO - 'HOME': '/home/cltbld', 06:05:45 INFO - 'LANG': 'en_US.UTF-8', 06:05:45 INFO - 'LANGUAGE': 'en_US:en', 06:05:45 INFO - 'LOGNAME': 'cltbld', 06:05:45 INFO - 'MAIL': '/var/mail/cltbld', 06:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:45 INFO - 'MOZ_NO_REMOTE': '1', 06:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:45 INFO - 'NO_EM_RESTART': '1', 06:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:45 INFO - 'PWD': '/builds/slave/test', 06:05:45 INFO - 'SHELL': '/bin/bash', 06:05:45 INFO - 'SHLVL': '1', 06:05:45 INFO - 'TERM': 'linux', 06:05:45 INFO - 'TMOUT': '86400', 06:05:45 INFO - 'USER': 'cltbld', 06:05:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:45 INFO - '_': '/tools/buildbot/bin/python'} 06:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:05:45 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 06:05:45 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 06:05:45 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 06:05:45 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 06:05:45 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 06:05:45 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 06:05:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:05:47 INFO - Installing collected packages: mozsystemmonitor 06:05:47 INFO - Running setup.py install for mozsystemmonitor 06:05:47 INFO - Successfully installed mozsystemmonitor 06:05:47 INFO - Cleaning up... 06:05:47 INFO - Return code: 0 06:05:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:47 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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:47 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 06:05:47 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 06:05:47 INFO - Using env: {'DISPLAY': ':0', 06:05:47 INFO - 'HOME': '/home/cltbld', 06:05:47 INFO - 'LANG': 'en_US.UTF-8', 06:05:47 INFO - 'LANGUAGE': 'en_US:en', 06:05:47 INFO - 'LOGNAME': 'cltbld', 06:05:47 INFO - 'MAIL': '/var/mail/cltbld', 06:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:47 INFO - 'MOZ_NO_REMOTE': '1', 06:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:47 INFO - 'NO_EM_RESTART': '1', 06:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:47 INFO - 'PWD': '/builds/slave/test', 06:05:47 INFO - 'SHELL': '/bin/bash', 06:05:47 INFO - 'SHLVL': '1', 06:05:47 INFO - 'TERM': 'linux', 06:05:47 INFO - 'TMOUT': '86400', 06:05:47 INFO - 'USER': 'cltbld', 06:05:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:47 INFO - '_': '/tools/buildbot/bin/python'} 06:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:48 INFO - Downloading/unpacking jsonschema==2.5.1 06:05:48 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 06:05:48 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 06:05:48 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 06:05:48 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 06:05:48 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 06:05:48 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 06:05:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:50 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:50 INFO - warning: no files found matching '*.txt' 06:05:50 INFO - no previously-included directories found matching 'build' 06:05:50 INFO - no previously-included directories found matching 'dist' 06:05:50 INFO - no previously-included directories found matching '.git*' 06:05:50 INFO - Installing collected packages: jsonschema, functools32 06:05:50 INFO - Running setup.py install for functools32 06:05:50 INFO - warning: no files found matching '*.txt' 06:05:50 INFO - no previously-included directories found matching 'build' 06:05:50 INFO - no previously-included directories found matching 'dist' 06:05:50 INFO - no previously-included directories found matching '.git*' 06:05:50 INFO - Successfully installed jsonschema functools32 06:05:50 INFO - Cleaning up... 06:05:50 INFO - Return code: 0 06:05:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:05:50 INFO - Using env: {'DISPLAY': ':0', 06:05:50 INFO - 'HOME': '/home/cltbld', 06:05:50 INFO - 'LANG': 'en_US.UTF-8', 06:05:50 INFO - 'LANGUAGE': 'en_US:en', 06:05:50 INFO - 'LOGNAME': 'cltbld', 06:05:50 INFO - 'MAIL': '/var/mail/cltbld', 06:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:50 INFO - 'MOZ_NO_REMOTE': '1', 06:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:50 INFO - 'NO_EM_RESTART': '1', 06:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:50 INFO - 'PWD': '/builds/slave/test', 06:05:50 INFO - 'SHELL': '/bin/bash', 06:05:50 INFO - 'SHLVL': '1', 06:05:50 INFO - 'TERM': 'linux', 06:05:50 INFO - 'TMOUT': '86400', 06:05:50 INFO - 'USER': 'cltbld', 06:05:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:50 INFO - '_': '/tools/buildbot/bin/python'} 06:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:05:50 INFO - Cleaning up... 06:05:50 INFO - Return code: 0 06:05:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:05:50 INFO - Using env: {'DISPLAY': ':0', 06:05:50 INFO - 'HOME': '/home/cltbld', 06:05:50 INFO - 'LANG': 'en_US.UTF-8', 06:05:50 INFO - 'LANGUAGE': 'en_US:en', 06:05:50 INFO - 'LOGNAME': 'cltbld', 06:05:50 INFO - 'MAIL': '/var/mail/cltbld', 06:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:50 INFO - 'MOZ_NO_REMOTE': '1', 06:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:50 INFO - 'NO_EM_RESTART': '1', 06:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:50 INFO - 'PWD': '/builds/slave/test', 06:05:50 INFO - 'SHELL': '/bin/bash', 06:05:50 INFO - 'SHLVL': '1', 06:05:50 INFO - 'TERM': 'linux', 06:05:50 INFO - 'TMOUT': '86400', 06:05:50 INFO - 'USER': 'cltbld', 06:05:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:50 INFO - '_': '/tools/buildbot/bin/python'} 06:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05:52 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 06:05:52 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 06:05:52 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 06:05:52 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 06:05:52 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 06:05:52 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 06:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05:53 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 06:05:53 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 06:05:53 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 06:05:53 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 06:05:53 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 06:05:53 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 06:05:53 INFO - Downloading docopt-0.6.1.tar.gz 06:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:53 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:53 INFO - Running setup.py install for blobuploader 06:05:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:53 INFO - Running setup.py install for requests 06:05:54 INFO - Running setup.py install for docopt 06:05:54 INFO - Successfully installed blobuploader requests docopt 06:05:54 INFO - Cleaning up... 06:05:54 INFO - Return code: 0 06:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:54 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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:54 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 06:05:54 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 06:05:54 INFO - Using env: {'DISPLAY': ':0', 06:05:54 INFO - 'HOME': '/home/cltbld', 06:05:54 INFO - 'LANG': 'en_US.UTF-8', 06:05:54 INFO - 'LANGUAGE': 'en_US:en', 06:05:54 INFO - 'LOGNAME': 'cltbld', 06:05:54 INFO - 'MAIL': '/var/mail/cltbld', 06:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:54 INFO - 'MOZ_NO_REMOTE': '1', 06:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:54 INFO - 'NO_EM_RESTART': '1', 06:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:54 INFO - 'PWD': '/builds/slave/test', 06:05:54 INFO - 'SHELL': '/bin/bash', 06:05:54 INFO - 'SHLVL': '1', 06:05:54 INFO - 'TERM': 'linux', 06:05:54 INFO - 'TMOUT': '86400', 06:05:54 INFO - 'USER': 'cltbld', 06:05:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:54 INFO - '_': '/tools/buildbot/bin/python'} 06:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:54 INFO - Running setup.py (path:/tmp/pip-MSkwwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:54 INFO - Running setup.py (path:/tmp/pip-YejrH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:54 INFO - Running setup.py (path:/tmp/pip-9PI9jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:54 INFO - Running setup.py (path:/tmp/pip-ie1njn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:54 INFO - Running setup.py (path:/tmp/pip-Kx6rc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:54 INFO - Running setup.py (path:/tmp/pip-65rthP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:54 INFO - Running setup.py (path:/tmp/pip-DOs_BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:54 INFO - Running setup.py (path:/tmp/pip-WCxh9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:55 INFO - Running setup.py (path:/tmp/pip-KHfyfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:55 INFO - Running setup.py (path:/tmp/pip-cTGTyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:55 INFO - Running setup.py (path:/tmp/pip-QFlQ6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:55 INFO - Running setup.py (path:/tmp/pip-bty98D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:55 INFO - Running setup.py (path:/tmp/pip-_FSYi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:55 INFO - Running setup.py (path:/tmp/pip-ZnajOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:55 INFO - Running setup.py (path:/tmp/pip-zxyTtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:55 INFO - Running setup.py (path:/tmp/pip-DWvo4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:55 INFO - Running setup.py (path:/tmp/pip-GA5WVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:55 INFO - Running setup.py install for manifestparser 06:05:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Running setup.py install for mozcrash 06:05:55 INFO - Running setup.py install for mozdebug 06:05:56 INFO - Running setup.py install for mozdevice 06:05:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Running setup.py install for mozfile 06:05:56 INFO - Running setup.py install for mozhttpd 06:05:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Running setup.py install for mozinfo 06:05:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Running setup.py install for mozInstall 06:05:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Running setup.py install for mozleak 06:05:56 INFO - Running setup.py install for mozlog 06:05:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Running setup.py install for moznetwork 06:05:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Running setup.py install for mozprocess 06:05:56 INFO - Running setup.py install for mozprofile 06:05:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:57 INFO - Running setup.py install for mozrunner 06:05:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:57 INFO - Running setup.py install for mozscreenshot 06:05:57 INFO - Running setup.py install for moztest 06:05:57 INFO - Running setup.py install for mozversion 06:05:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:57 INFO - Cleaning up... 06:05:57 INFO - Return code: 0 06:05:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:57 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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:05:57 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 06:05:57 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 06:05:57 INFO - Using env: {'DISPLAY': ':0', 06:05:57 INFO - 'HOME': '/home/cltbld', 06:05:57 INFO - 'LANG': 'en_US.UTF-8', 06:05:57 INFO - 'LANGUAGE': 'en_US:en', 06:05:57 INFO - 'LOGNAME': 'cltbld', 06:05:57 INFO - 'MAIL': '/var/mail/cltbld', 06:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:57 INFO - 'MOZ_NO_REMOTE': '1', 06:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:57 INFO - 'NO_EM_RESTART': '1', 06:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:57 INFO - 'PWD': '/builds/slave/test', 06:05:57 INFO - 'SHELL': '/bin/bash', 06:05:57 INFO - 'SHLVL': '1', 06:05:57 INFO - 'TERM': 'linux', 06:05:57 INFO - 'TMOUT': '86400', 06:05:57 INFO - 'USER': 'cltbld', 06:05:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:57 INFO - '_': '/tools/buildbot/bin/python'} 06:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:57 INFO - Running setup.py (path:/tmp/pip-rSPPBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:57 INFO - Running setup.py (path:/tmp/pip-os36qF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:57 INFO - Running setup.py (path:/tmp/pip-E6HS0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:57 INFO - Running setup.py (path:/tmp/pip-gzKCNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:58 INFO - Running setup.py (path:/tmp/pip-CfpgGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:58 INFO - Running setup.py (path:/tmp/pip-iNRBaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:58 INFO - Running setup.py (path:/tmp/pip-ScYIXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:58 INFO - Running setup.py (path:/tmp/pip-Zf62_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:58 INFO - Running setup.py (path:/tmp/pip-xdlt8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:58 INFO - Running setup.py (path:/tmp/pip-VQywJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:58 INFO - Running setup.py (path:/tmp/pip-bsc3DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:58 INFO - Running setup.py (path:/tmp/pip-DiKGAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:58 INFO - Running setup.py (path:/tmp/pip-UmI_J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:58 INFO - Running setup.py (path:/tmp/pip-3AvZpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:58 INFO - Running setup.py (path:/tmp/pip-TWmkEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:58 INFO - Running setup.py (path:/tmp/pip-Q7W5_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:58 INFO - Running setup.py (path:/tmp/pip-IUxELG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:59 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)) 06:05:59 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)) 06:05:59 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)) 06:05:59 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)) 06:05:59 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)) 06:05:59 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)) 06:05:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:00 INFO - Downloading blessings-1.6.tar.gz 06:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:06:01 INFO - Installing collected packages: blessings 06:06:01 INFO - Running setup.py install for blessings 06:06:01 INFO - Successfully installed blessings 06:06:01 INFO - Cleaning up... 06:06:01 INFO - Return code: 0 06:06:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:01 INFO - Reading from file tmpfile_stdout 06:06:01 INFO - Current package versions: 06:06:01 INFO - argparse == 1.2.1 06:06:01 INFO - blessings == 1.6 06:06:01 INFO - blobuploader == 1.2.4 06:06:01 INFO - docopt == 0.6.1 06:06:01 INFO - functools32 == 3.2.3-2 06:06:01 INFO - jsonschema == 2.5.1 06:06:01 INFO - manifestparser == 1.1 06:06:01 INFO - mozInstall == 1.12 06:06:01 INFO - mozcrash == 0.17 06:06:01 INFO - mozdebug == 0.1 06:06:01 INFO - mozdevice == 0.48 06:06:01 INFO - mozfile == 1.2 06:06:01 INFO - mozhttpd == 0.7 06:06:01 INFO - mozinfo == 0.9 06:06:01 INFO - mozleak == 0.1 06:06:01 INFO - mozlog == 3.3 06:06:01 INFO - moznetwork == 0.27 06:06:01 INFO - mozprocess == 0.23 06:06:01 INFO - mozprofile == 0.28 06:06:01 INFO - mozrunner == 6.12 06:06:01 INFO - mozscreenshot == 0.1 06:06:01 INFO - mozsystemmonitor == 0.3 06:06:01 INFO - moztest == 0.7 06:06:01 INFO - mozversion == 1.4 06:06:01 INFO - psutil == 3.1.1 06:06:01 INFO - requests == 1.2.3 06:06:01 INFO - wsgiref == 0.1.2 06:06:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:01 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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:06:01 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 06:06:01 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 06:06:01 INFO - Using env: {'DISPLAY': ':0', 06:06:01 INFO - 'HOME': '/home/cltbld', 06:06:01 INFO - 'LANG': 'en_US.UTF-8', 06:06:01 INFO - 'LANGUAGE': 'en_US:en', 06:06:01 INFO - 'LOGNAME': 'cltbld', 06:06:01 INFO - 'MAIL': '/var/mail/cltbld', 06:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:01 INFO - 'MOZ_NO_REMOTE': '1', 06:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:01 INFO - 'NO_EM_RESTART': '1', 06:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:01 INFO - 'PWD': '/builds/slave/test', 06:06:01 INFO - 'SHELL': '/bin/bash', 06:06:01 INFO - 'SHLVL': '1', 06:06:01 INFO - 'TERM': 'linux', 06:06:01 INFO - 'TMOUT': '86400', 06:06:01 INFO - 'USER': 'cltbld', 06:06:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:01 INFO - '_': '/tools/buildbot/bin/python'} 06:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 INFO - Cleaning up... 06:06:01 INFO - Return code: 0 06:06:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:01 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 0x29f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', '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 06:06:01 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 06:06:01 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 06:06:01 INFO - Using env: {'DISPLAY': ':0', 06:06:01 INFO - 'HOME': '/home/cltbld', 06:06:01 INFO - 'LANG': 'en_US.UTF-8', 06:06:01 INFO - 'LANGUAGE': 'en_US:en', 06:06:01 INFO - 'LOGNAME': 'cltbld', 06:06:01 INFO - 'MAIL': '/var/mail/cltbld', 06:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:01 INFO - 'MOZ_NO_REMOTE': '1', 06:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:01 INFO - 'NO_EM_RESTART': '1', 06:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:01 INFO - 'PWD': '/builds/slave/test', 06:06:01 INFO - 'SHELL': '/bin/bash', 06:06:01 INFO - 'SHLVL': '1', 06:06:01 INFO - 'TERM': 'linux', 06:06:01 INFO - 'TMOUT': '86400', 06:06:01 INFO - 'USER': 'cltbld', 06:06:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:01 INFO - '_': '/tools/buildbot/bin/python'} 06:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:06:01 INFO - Cleaning up... 06:06:01 INFO - Return code: 0 06:06:01 INFO - Running post-action listener: _resource_record_post_action 06:06:01 INFO - Running post-action listener: _start_resource_monitoring 06:06:01 INFO - Starting resource monitoring. 06:06:01 INFO - [mozharness: 2016-08-08 13:06:01.907867Z] Finished create-virtualenv step (success) 06:06:01 INFO - [mozharness: 2016-08-08 13:06:01.908299Z] Running install step. 06:06:01 INFO - Running pre-action listener: _resource_record_pre_action 06:06:01 INFO - Running main action method: install 06:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:02 INFO - Reading from file tmpfile_stdout 06:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 06:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:06:02 INFO - Reading from file tmpfile_stdout 06:06:02 INFO - Output received: 06:06:02 INFO - Usage: mozinstall [options] installer 06:06:02 INFO - Options: 06:06:02 INFO - -h, --help show this help message and exit 06:06:02 INFO - -d DEST, --destination=DEST 06:06:02 INFO - Directory to install application into. [default: 06:06:02 INFO - "/builds/slave/test"] 06:06:02 INFO - --app=APP Application being installed. [default: firefox] 06:06:02 INFO - mkdir: /builds/slave/test/build/application 06:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:06:19 INFO - Reading from file tmpfile_stdout 06:06:19 INFO - Output received: 06:06:19 INFO - /builds/slave/test/build/application/firefox/firefox 06:06:19 INFO - Running post-action listener: _resource_record_post_action 06:06:19 INFO - [mozharness: 2016-08-08 13:06:19.325142Z] Finished install step (success) 06:06:19 INFO - [mozharness: 2016-08-08 13:06:19.325390Z] Running run-tests step. 06:06:19 INFO - Running pre-action listener: _resource_record_pre_action 06:06:19 INFO - Running main action method: run_tests 06:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:06:19 INFO - Python 2.7.3 06:06:19 INFO - Return code: 0 06:06:19 INFO - grabbing minidump binary from tooltool 06:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:19 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 0x2cb63b0>, '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 0x2cb72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:06:19 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 06:06:19 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 06:06:19 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 06:06:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:06:19 INFO - Return code: 0 06:06:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:06:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:06:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:06:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:06:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 06:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 06:06:19 INFO - Using env: {'DISPLAY': ':0', 06:06:19 INFO - 'HOME': '/home/cltbld', 06:06:19 INFO - 'LANG': 'en_US.UTF-8', 06:06:19 INFO - 'LANGUAGE': 'en_US:en', 06:06:19 INFO - 'LOGNAME': 'cltbld', 06:06:19 INFO - 'MAIL': '/var/mail/cltbld', 06:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:19 INFO - 'MOZ_NO_REMOTE': '1', 06:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:19 INFO - 'NO_EM_RESTART': '1', 06:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:19 INFO - 'PWD': '/builds/slave/test', 06:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:06:19 INFO - 'SHELL': '/bin/bash', 06:06:19 INFO - 'SHLVL': '1', 06:06:19 INFO - 'TERM': 'linux', 06:06:19 INFO - 'TMOUT': '86400', 06:06:19 INFO - 'USER': 'cltbld', 06:06:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632', 06:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:19 INFO - '_': '/tools/buildbot/bin/python'} 06:06:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 06:06:19 INFO - mozversion application_buildid: 20160808023008 06:06:19 INFO - mozversion application_changeset: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac 06:06:19 INFO - mozversion application_display_name: Nightly 06:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:06:19 INFO - mozversion application_name: Firefox 06:06:19 INFO - mozversion application_remotingname: firefox 06:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:06:19 INFO - mozversion application_vendor: Mozilla 06:06:19 INFO - mozversion application_version: 51.0a1 06:06:19 INFO - mozversion platform_buildid: 20160808023008 06:06:19 INFO - mozversion platform_changeset: 46dede080ba1b6bcaaf5af7b00fc5e356c66faac 06:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:06:19 INFO - mozversion platform_version: 51.0a1 06:06:19 INFO - using testdate: 1470661579 06:06:19 INFO - actual date: 1470661579 06:06:19 INFO - starting webserver on 'localhost:44680' 06:06:19 INFO - SUITE-START | Running 2 tests 06:06:19 INFO - TEST-START | dromaeo_css 06:06:19 INFO - operating with platform_type : linux_ 06:06:19 INFO - Initialising browser for dromaeo_css test... 06:06:19 INFO - TEST-INFO | started process 4962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKXiMX/profile http://localhost:44680/getInfo.html) 06:06:23 INFO - PROCESS | 4962 | __metrics Screen width/height:1600/1200 06:06:23 INFO - PROCESS | 4962 | colorDepth:24 06:06:23 INFO - PROCESS | 4962 | Browser inner width/height: 1024/697 06:06:23 INFO - PROCESS | 4962 | __metrics 06:06:24 INFO - PROCESS | 4962 | 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" 06:06:24 INFO - PROCESS | 4962 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:25 INFO - TEST-INFO | 4962: exit 0 06:06:25 INFO - Browser initialized. 06:06:25 INFO - Running cycle 1/1 for dromaeo_css test... 06:06:25 INFO - TEST-INFO | started process 5046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKXiMX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:37 INFO - PROCESS | 5046 | RSS: Main: 156422144 06:06:37 INFO - PROCESS | 5046 | 06:07:28 INFO - PROCESS | 5046 | 1470661648712 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] 06:09:37 INFO - PROCESS | 5046 | Cycle 1(1): loaded http://localhost:44680/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44680/tests/dromaeo/cssquery-ext.html) 06:09:39 INFO - PROCESS | 5046 | RSS: Main: 268828672 06:09:39 INFO - PROCESS | 5046 | 06:12:41 INFO - PROCESS | 5046 | Cycle 1(1): loaded http://localhost:44680/tests/dromaeo/cssquery-ext.html (next: http://localhost:44680/tests/dromaeo/cssquery-jquery.html) 06:12:42 INFO - PROCESS | 5046 | RSS: Main: 240365568 06:12:42 INFO - PROCESS | 5046 | 06:15:44 INFO - PROCESS | 5046 | Cycle 1(1): loaded http://localhost:44680/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44680/tests/dromaeo/cssquery-mootools.html) 06:15:44 INFO - PROCESS | 5046 | RSS: Main: 229593088 06:15:44 INFO - PROCESS | 5046 | 06:18:46 INFO - PROCESS | 5046 | Cycle 1(1): loaded http://localhost:44680/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44680/tests/dromaeo/cssquery-prototype.html) 06:18:47 INFO - PROCESS | 5046 | RSS: Main: 220405760 06:18:47 INFO - PROCESS | 5046 | 06:21:49 INFO - PROCESS | 5046 | Cycle 1(1): loaded http://localhost:44680/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44680/tests/dromaeo/cssquery-yui.html) 06:21:50 INFO - PROCESS | 5046 | RSS: Main: 186691584 06:21:50 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | Cycle 1(1): loaded http://localhost:44680/tests/dromaeo/cssquery-yui.html (next: http://localhost:44680/tests/dromaeo/cssquery-dojo.html) 06:24:53 INFO - PROCESS | 5046 | RSS: Main: 277151744 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | __start_tp_report 06:24:53 INFO - PROCESS | 5046 | _x_x_mozilla_page_load 06:24:53 INFO - PROCESS | 5046 | _x_x_mozilla_page_load_details 06:24:53 INFO - PROCESS | 5046 | |i|pagename|runs| 06:24:53 INFO - PROCESS | 5046 | |0;dojo.html;3070.940525518696;3088.598482197314;3105.937881242375;3109.533569964505;3127.5152351385545;5231.973840130794;5255;5314.707691076994;5418.133098704203;5429.049916264657;5343.679379237248;5372.435894231108;5395.406505284425;5415.702136382497;5467.808626698066;4789.736564488943;4886.389201349832;4889.511048895118;4893.657443978923;5069.695818250917;4955.950440495585;4988.451270360258;5017.64876458648;5036.169032109698;5046.646734728571;4801.207800712861;4811.663183577151;4823.300621409911;4875.951240487585;4954.009198160383;4833;4838.903221935577;4841.176999910023;4846.709197448129;4938.950610493885;4847.733374664392;4856.465788763233;4863.927041094386;4881.8779530511665;4887.0714564232685;5175.068487672217;5228.607854410934;5314.521693047605;5357.383900851413;5386.218998245272;5771.105478650816;5819.214406055213;5820.679862607555;5824.621399609055;5831.096180092092;5821.417858214187;5845.006348920694;5860.384659610722;5866.384029676908;5870;5232.816851410221;5307.203919412119;5338.492843179892;5344.144936810092;5451.373092094381;5925.318588362307;5988.071848863433;5988.580799344004;5989.341172471025;5990.371011043778;5670.291213598301;5673.858153546112;5717.914231286534;5721.084626459829;5724.341700704389;5568.164775283659;5678.3186017678145;5710.2862142232225;5731.8853622928145;5794.188813566104;5732.426757324234;5733.569982251348;5739.713014349266;5741.167530708024;5748.878968601166;5674.432556744293;5693.402192769782;5739.799107031234;5740.282464691913;5743.368229494752;4333.9133217335475;4341.544137865479;4344.022594916119;4349.021470169187;4355.7822108894425;3910.0420397002918;3922.4508568800393;3953.090789118519;3954.9011274717786;3975.284448799244;5362.249285100011;5366.892662146735;5367.033933891859;5375.5162035416215;5407.567394608422;5648.209250704905;5716.885662286814;5744.798932037442;5753.05074662676;5760.135979603093;5387.919181212285;5391.4608539145775;5393.487618676219;5415.512603865593;5429.782808687608;4918.975405123023;4937.136001199776;4955.281484184773;4969.006198760262;4996.625253106032;5725.599208055396;5922.674252916131;5948.434898684618;5961.463468287701;5990.460858522754;5793.710314484343;5794.652320860761;5794.82615521535;5836.649801011953;5849.473547380586;5950.732217050157;5987.101934709828;6000.21997140369;6000.849978750566;6004.969975150097;5540.473655002768;5638.689872057076;5660.773569057192;5697.914531282117;5703.201551782837;5802.5357971361345;5804.622699524686;5809.970950145223;5841.766329346949;5861.882762344814;5610.803621873215;5649.971750141387;5656.915146272727;5661.773529058956;5664.348599910898;5479.232907393048;5574;5589.888202235851;5643.66138031703;5647.0964645656495;5652.378238393856;5658.519025882846;5661.943380566307;5695.686737229492;5700.429957004432;5676.290463692038;5685.658860468385;5707.400722924033;5721.599488035798;5740.1102829061565;5347.068192982723;5433.918491222714;5485.286912701324;5520.365158006881;5534.612577119563 06:24:53 INFO - PROCESS | 5046 | |1;ext.html;563.6866101982379;590.1325052173306;612.9754809807606;629.8393909553066;638.6966191059245;29172.70827291729;41224.58775412245;43528.91177720555;43547.56452435483;43573.34639980403;45797.31304030442;46093.30860037102;46330.53669463305;46500.53499465004;46504.53495465053;8922.509261990605;9014.414063085878;9065.41074830134;9084.8637270441;9092.681756138536;8913.331500137483;8934.776630584221;8993.415427997159;9004.469240229177;9017.549122543847;9030.27757779376;9057.95471022644;9059.728208153732;9074.909250907505;9080.727578172633;8987.595558199864;9033.23217526511;9040.547972601344;9051.049639787827;9051.954740226256;8893.73318800437;8973.775655608597;8975.326850486173;8995.190432861074;9002.324825638103;43291.35062974058;43776.343354849705;43776.56223437757;43780.3432948506;43794.781026094664;3472.808995505246;3499.737519686034;3724.1062145085257;3731.4962480065387;4053.858114965962;32838.179045523815;32893;32894.0946803318;32906;33160.50777715009;4306.7631280279575;4342.869713908556;4397.318415645548;4439.511653718088;4471.597556219924;369486;370274;371719;372432;373040;60396.69801650964;60770.392296076476;60772;60926.39073609296;61035.38964610386;36493.635063649024;37689.24621507609;37816.243675126345;39438.60561394407;63663.36336636667;17157.313707451813;17651.411372976236;17726.91136544335;17902.731459028124;17919.73120403195;13491.797623035662;13653.522126725715;13723.862761372258;13724.588262352145;13729.382177802023;19429.841390066846;19507.387200828278;19522.305369829854;19644.312449064215;19789.802101978796;6989.650517474106;7053.506254562131;7104.751333703295;7229.313215244543;7434.25657434263;977.413551868873;1100.801855665988;1131.3777422417802;1144.3877525523806;1195.635331223985;32139.03582892517;32315.19212019718;32555.837220813744;32778.344433111204;33053;1114.2534501883758;1149.6148790155225;1150.263831148066;1202.068396992338;1206.457094307565;17026.31894724222;17062.914685426495;17167.141642917803;17207.483775486755;17374.13129343528;566136;572436;575678;575815;579474;60239.698801505714;60867;61006.69496652488;61018.69490652518;61067.38932610617;1199.9320604661857;1279.526575167194;1308.8363954505687;1352.0805852020721;1377.937992790327;24533.38666533351;33451.33097337991;33902.491462627586;35707.46438803472;35890.820545897106;56996;57234;57520.4247957515;57619.71190144023;57680.42319576751;469905;475310;475465;475546;476160;23688.526229475658;28012.159635210977;29173;29852.70147298499;30331.241718957204;47187.292190616485;47552.524474756196;47568;48129;48390.516094838604;40757.1848563033;41741;41942;42081.57918420777;43647.78176109099;41563.7921810389;42213.57786422219;42323;43142.78428607962;43644;41618;41739.58260417357;42666;43154.136917262105;44884.77557612191;33718.66281337253;37927.24145517129;37960.81019594884;38189.4271585932;38500.42249366318;28562.85718571394;28610.427791444472;28640.57039144373;28743.85628071846;28961.275968100967 06:24:53 INFO - PROCESS | 5046 | |2;jquery.html;379.3550963362285;382.8564288391853;405.4060800926642;407.5842640506683;415.8773161917234;12930.74138517229;19038;20471.48821279467;20631.896840515794;21148.365549033555;20162.19351225949;20307.289244876396;20805.479863003395;21013.789862101374;21071.2625058123;5764.827055188341;5943.970280148593;5954.583179177459;5955.553333499983;5960.761569537235;5841.941580584183;5950.613210141349;5951.940480595182;5954.404559544054;5964.821055368346;5707.571932105088;5938.9703051484685;5985.850353741148;6013.128096426016;6037.516998640121;5839.153322768218;5921.259842519685;5968.820935371946;5991.910121348184;5999;5785.247917770705;5798.942010579883;5802.941970580325;5802.97098514509;5802.97098514509;13280.535181268706;17868.55328616782;23115.422114447105;23803.523929521485;24241.151559695503;2246.382244882654;2275.260540324401;2386.343755467243;2727.2500062482777;2743.492453896036;10022.849657255147;10229.18166546682;10299;10718.35689858611;10802.783944321149;1933.2943475631434;1972.7040943858392;1975.6246313200445;1985.4143027806688;2018.7375641166702;61473;82271.588642057;82367;88145;92136;8840.911590884138;9356.766080848034;9447.291453141042;10466.162706983423;11370.54517819278;13708.24604646734;13765.655858603415;13784.793228101587;13800.240986745825;13809.51666691661;7910.762677119696;8253.669853205925;8294;8407.747767566983;8408.41141120128;8310.875336869953;8324.750257492286;8334.874976875351;8525.147485251426;8554.401191916631;4211.684123690736;4255.914881702349;4278.4160339996515;4292.334688123284;4381.364702118175;2014.587009663045;2081.55246621977;2090.351990882831;2111.841611879115;2167.934961951144;994.6071301835879;1025.5743866295552;1040.6877936618985;1058.9046985771317;1072.2364500602785;20691.689624655643;20715.4821129473;20967.056482458327;21074.57850843005;21163.15347386087;1012.367270455965;1029.6859457865273;1038.8493668418037;1045.4041196517912;1116.6650004998469;11264;11410.771784564262;11813.586524471602;11843.28940263587;11965.581204657969;378969;383604.49186524446;496935;501672;502542;102182;105238.47380763048;105300;110238;112550.43724781324;993.6373223773271;1006.2352612014921;1039.1686650679578;1048.8688913885765;1049.5014867937668;18368.540786480444;18745.250189992246;19196.232150713815;19438.514037149183;19565.510862227988;43016.354754678076;43067.78466107775;43558.56441435545;47169.76415117903;48302;60198.39801601928;60656;61298.387016131055;62451.375486246376;63040.68479657756;5408.72956352173;6561.442277406474;7505.549667019996;8567.871481927652;9349.57926893305;12313;13428.798568021683;13847.482071832328;13875.028747987948;14180.220087894852;11767.529298828293;11969.341686207343;11988;12223.69440763988;12392.194507356993;11568.074554035826;11586.073114151017;11892.615037488838;11919.52321907114;12386.256824590553;12025.699357516132;12076.33580153065;12287.385630718607;12330.32183229895;12331.630051098482;7716.5755883426955;7992.320652744582;8005.279524842792;8177.141400153137;8326.000879894451;10164.390136591828;11966.820497692715;12064.215825971283;12251.448684809384;12467.376631168225 06:24:53 INFO - PROCESS | 5046 | |3;mootools.html;1314.940827662755;1480.4374337751656;1504.4433559582953;1654.5532706169336;1797.7662903822509;8503.702370417037;8857.734267971962;8990.235829954461;9185.862212066824;9230.123138301868;9042.773930651738;9123.77190570236;9147.725568232963;9165.495897725623;9209.171174594285;2434.0750514804395;2466.4203912080648;2475.517274131545;2478.2317481580676;2478.7025556933195;2350.0129945422877;2442.8167887408426;2446.9143579974702;2447.4615584571366;2450.7304196538366;2390.6533552634946;2418.637204419342;2428.18655750323;2443.780059794618;2453.129139155601;2366.6095094309417;2371.5968285391523;2377.679013333204;2400.1839374612628;2433.987830060856;2327.44141406063;2345.343303874901;2354.5290941811536;2358.3396648938324;2359.445530300378;9019.143181397756;9098.181163695299;9104.044075372123;9178.265738740885;9190.632374705005;5410.83767486976;5654.858628534278;5656.830295091154;5663.377028526858;5665.3768085510565;3477.791332520057;3515;3517.1558825881602;3534.8762793302367;3585.982070089633;1135.6536256441864;1165.161084019513;1176.4764679717443;1179.1745777955466;1196.7905616517075;12716.300603466805;12831.101822872402;12861.67845803853;12880.549180778627;12912.806307905388;4516.932246016312;4649.395578574831;4816.277558366203;4840.15297322967;4842.878928026827;10149.238807089498;10153.746156346002;10157.339772914886;10161.949190254001;10163.7459063524;5461.1262198048125;5466.453354664582;5474.835754927359;5487.039768040577;5499.862503437366;4463.86608401742;4891.241857512091;5044.571211446994;5082.949170508322;5118.795248190105;3969.6030396960073;4023.6177563131455;4108.4453598764385;4126.711130220916;4130.112025914443;1234.740704452075;1253.11029169289;1255.2844878419214;1266.265565971734;1269.8349214602226;980.8822941247096;981.7692842182081;985.8866230383454;1006.4866917871938;1011.8330475471465;6033;6094.268687757498;6123.050927106306;6200.56596038273;6260.499160067184;938.5260443476001;943.8725772020827;984.1339621133357;994.8408254679216;995.1193194023341;4041.777702226406;4115.300398932189;4178.540360560336;4375.584319489643;4386.2762644163995;11056.778864422828;11483.598074067368;11484.827727584094;11543.249688770204;11593.768124637629;10609.9469502652;11076.280041797258;11136.832947505794;11478.540858365572;11506.137039722054;8440.873386899202;8635.87046194295;8638.654453821777;8641.351898607629;8660.48037117775;5958.880822383441;6041.909371359346;6043.36544662804;6102.4507794298725;6319.304876463677;10328.328658637465;10417.270791044553;10428.739281518023;10523.526441310007;10536.15710743154;10345.410435889182;10485.580576777149;10818.783624327312;10823.729406764578;10956.616518421817;7355.926440735524;7686.346660533917;7908.209179082046;8146.796330091558;8351.331893448389;9112.863307050533;9148.405353652257;9168.120535290116;9169.77075573116;9175.495347755937;8062.234087761653;8116.675332986614;8283.668653253802;8361.247487726134;8384.203500667427;7608.087029556488;7617.466777325534;7688.384929205538;7724.7682569523;7816.4137689674635;6996.405305549085;7121.82195445118;7125.893111603226;7141.285871412817;7145.249748776304;5060.418051924076;5267.104592219409;5292.5501332387175;5365.356157261153;5396.1366181410785;5020.698758074527;5093.261477085876;5128.461511541234;5131.923021154611;5513.972430137984 06:24:53 INFO - PROCESS | 5046 | |4;prototype.html;330.6871911894104;335.5905794930185;344.7224983887969;345.5162772119034;345.7372396978296;5101.7194054327;5227.236389799348;5276.076686579848;5310.362756469224;5310.840674779758;5212;5248.349583460347;5253.921191182136;5275.472452754722;5280.392754833195;4161.729487583305;4164.687648426365;4167.187398457302;4179.352200408942;4197.895052623679;3958.8614398496056;4113.835446582133;4178.373244013392;4190.141021090669;4195.580441955795;4030.576789437096;4074.8777536673797;4086.6730661547003;4106.342985122381;4121.5878412158845;4046.5953404659444;4058.5040200276912;4060.2285565742413;4083.7958102094926;4085.6935729820384;3627.673509384168;3633.6184700606586;3639.1448009717697;3649.6897763690117;3650.6349365063547;4981.875453113665;5042.294078828967;5053.1157047516535;5095.719735414551;5103.668261562986;4649.279361698942;4655.348251244828;4658.208104622188;4658.813647454098;4699.412573428322;5423.376311724123;5437.184422336682;5447;5478.890422191574;5503.257060296849;3814.179951310454;3918.45141680165;3942.4086387041884;3946.782926939017;3947.8156553034264;5549.861253468655;5606.299212598426;5611.326640803089;5630.634008789416;5640.943590564124;4008.4588580541836;4017.457643218128;4038.1318016626565;4038.374052021941;4042.1511482588985;3990.8004599769897;4068.7355321903983;4074.9388759168637;4077.7145599807727;4088.264112459726;4597.057603191404;4607.308903664477;4618.261078227468;4626.676132670681;4640.559146881041;5464.360691792446;5469.429368196941;5471.316085489314;5508;5520.779168833282;1326.389860664086;1340.9463621455227;1381.4336122189854;1389.1526169036879;1397.168684632642;927.972160835176;954.6610953111684;964.7569401142372;976.6923419122953;985.3250523391499;5155.633757054384;5167.560757335594;5176.456472070454;5177.559907407913;5190.662606930613;5514.834554963358;5529.917051244234;5534.4742249486235;5537.944620553743;5561.499465048165;5024.371953505812;5210.456889315302;5230.692326918271;5235.869103272448;5261.210818377274;2953.7341639252572;2958.6301712285963;2962.5408061750463;2967.8516074196637;2984.2091845660916;5788.971055144697;5796.884062318814;5845.298564172242;5871.794487193013;5895.64626122434;5643.294588176478;5669.461401166883;5684.403137670568;5723.399043100498;5733.71331433435;5777.855553611109;5779.190913272145;5794.507466865363;5795.536357091339;5798.391168927286;5373.140297552372;5529.198266251291;5609.242752228397;5652.491275785034;5652.491275785199;5484.698341591251;5508.20131080983;5525.944740552543;5527.894421115712;5532.778688852562;5802.303723553201;5814.883702326015;5851.561132915133;5865.208196893364;5872.442117998783;3814.351560234822;4046.2918989177365;4069.2268468990796;4072.735272207297;4075.1645912587255;5364.544013758874;5618.39875635442;5632.2678051853;5642.746076426489;5646.576506762091;5340.626156169186;5509.47659972302;5518.613697041329;5524.198991146181;5538.16927460868;5451.37309209446;5460.290162278879;5483.479069488392;5507.678157242313;5517.779288828402;5239.26650268955;5391.353037635509;5463.918041229305;5476.6166368355425;5488.4785945335125;5457.672539647634;5472.398036215934;5489.972550137383;5513.283273174462;5516.200150978166;5379.784808607612;5418.918716219338;5466.316710411199;5476.753546090516;5499.725013749377 06:24:53 INFO - PROCESS | 5046 | |5;yui.html;786.1862971824162;797.7766225456872;806.753940048285;854.9230569248766;869.2455941666167;15509.379624815008;16781.496555103335;16824.07467589282;16828.32686692531;17140.74288885666;13669.589912302621;13733.381997810098;13762.655933601665;13879.097858639181;13907.791383129235;656.2813718977711;778.0935210479785;789.2975252025687;793.5595744361876;812.297362781196;788.5071830106184;796.8764841449585;803.0724513187278;803.1566854802434;804.4368941740776;861.9698310559131;862.65062649627;863.2274114667368;863.7279257034046;864.1013346120028;693.8334799648098;835.2524490580956;857.6055014693218;858.3476557816074;858.8368210040072;622.1880446017944;624.5659266809569;624.6408315218767;625.2840497630233;625.8748250349948;14910.850891491054;15061.246937653073;15082.321295541728;15091.924540377338;15107.32017059235;13692.931535342359;14084.436622535086;14449.133052016807;14898.851011489854;15042.247887605576;13139.934300328438;13170.67073323165;13206.207627542379;13560.796588051187;14051.086679365808;4384.16700826845;4391.6486681065435;4481.126180394825;4607.953920460786;4636.559526844944;81565.18434815695;81568.59215703943;81647.95880102986;82213.17786822114;83263.58368208242;11236.775264494665;11521.711957200969;11619.767604648028;11686.415679216005;11782.057435405148;22144.66782998256;22168.445788855086;22172.778272217394;22279.331620051424;22336.329910102722;8262.17378262169;8276;8353.958230208931;8539.14608539141;8703.303735701129;4284.571542845752;4431.268840641323;4466.285394336891;4492.663050271242;4642.814287428465;3218.951715724266;3316.5522654441343;3331.850066747002;3343.966560334414;3345.0968238575447;596.1117934277895;601.8375038739516;604.2959951656359;604.7157835817159;619.5105866365611;571.5958539453501;599.1791245993018;600.8137477382026;698.6332175607745;706.4313227851629;8751.212390884852;9043.231325337289;9323.20752736025;9353.672621458216;9856.764984778103;623.9906401403982;633.822529691687;734.8162959260185;772.7527191298843;775.5153029356652;4459.687821852504;4488.4165058542185;4868.7331844698365;4999.005370996647;5152.510511501401;126511;132562;132915.33542332228;133015;135444;109225.45387273013;110876.4456177714;111787.44106279417;113732;113752;98079.50960245296;99640;99918.5004074975;101995.4900225494;102931;8934.061923498199;9008.549572521479;9188.816223675623;9219.539023048686;9236.353455258068;55268.44731552794;56215.71892140677;56731.43268567426;57051;57394.426055738906;85571.57214213889;88954.55522722345;90477.54761226152;92395;92553.5372323134;11982.64052078439;13122.475100996235;13349.933250333686;13426.932865335611;14011.43954241819;13527.188368697909;13827.930860345634;13907.37416816266;14394.856051439352;14600.12399256048;13208.735825283633;13577.932110339385;13710.862891371358;13824.930875345559;14300;13230.470781168646;13769.242691651654;13811;13860.861391386361;13867.237301948086;12134.211276267015;12365.876341236473;12386;12558.623241302776;12599.4171194903;10604.946975265075;10891.18316126278;10943.398113103538;11131.165162612675;11144.2199046066;11107.555697772323;11235.438228088726;11356.488957996744;11419.37193454368;11455.656330310105 06:24:53 INFO - PROCESS | 5046 | __end_tp_report 06:24:53 INFO - PROCESS | 5046 | __start_cc_report 06:24:53 INFO - PROCESS | 5046 | _x_x_mozilla_cycle_collect,1026 06:24:53 INFO - PROCESS | 5046 | __end_cc_report 06:24:53 INFO - PROCESS | 5046 | __startTimestamp1470662693824__endTimestamp 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | ------- Summary: start ------- 06:24:53 INFO - PROCESS | 5046 | Number of tests: 6 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | [#0] dojo.html Cycles:165 Average:5347.32 Median:5568.16 stddev:617.08 (11.1%) stddev-sans-first:592.57 06:24:53 INFO - PROCESS | 5046 | Values: 3070.9 3088.6 3105.9 3109.5 3127.5 5232.0 5255.0 5314.7 5418.1 5429.0 5343.7 5372.4 5395.4 5415.7 5467.8 4789.7 4886.4 4889.5 4893.7 5069.7 4956.0 4988.5 5017.6 5036.2 5046.6 4801.2 4811.7 4823.3 4876.0 4954.0 4833.0 4838.9 4841.2 4846.7 4939.0 4847.7 4856.5 4863.9 4881.9 4887.1 5175.1 5228.6 5314.5 5357.4 5386.2 5771.1 5819.2 5820.7 5824.6 5831.1 5821.4 5845.0 5860.4 5866.4 5870.0 5232.8 5307.2 5338.5 5344.1 5451.4 5925.3 5988.1 5988.6 5989.3 5990.4 5670.3 5673.9 5717.9 5721.1 5724.3 5568.2 5678.3 5710.3 5731.9 5794.2 5732.4 5733.6 5739.7 5741.2 5748.9 5674.4 5693.4 5739.8 5740.3 5743.4 4333.9 4341.5 4344.0 4349.0 4355.8 3910.0 3922.5 3953.1 3954.9 3975.3 5362.2 5366.9 5367.0 5375.5 5407.6 5648.2 5716.9 5744.8 5753.1 5760.1 5387.9 5391.5 5393.5 5415.5 5429.8 4919.0 4937.1 4955.3 4969.0 4996.6 5725.6 5922.7 5948.4 5961.5 5990.5 5793.7 5794.7 5794.8 5836.6 5849.5 5950.7 5987.1 6000.2 6000.8 6005.0 5540.5 5638.7 5660.8 5697.9 5703.2 5802.5 5804.6 5810.0 5841.8 5861.9 5610.8 5650.0 5656.9 5661.8 5664.3 5479.2 5574.0 5589.9 5643.7 5647.1 5652.4 5658.5 5661.9 5695.7 5700.4 5676.3 5685.7 5707.4 5721.6 5740.1 5347.1 5433.9 5485.3 5520.4 5534.6 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | [#1] ext.html Cycles:180 Average:63114.45 Median:23724.77 stddev:127614.23 (537.9%) stddev-sans-first:127885.80 06:24:53 INFO - PROCESS | 5046 | Values: 563.7 590.1 613.0 629.8 638.7 29172.7 41224.6 43528.9 43547.6 43573.3 45797.3 46093.3 46330.5 46500.5 46504.5 8922.5 9014.4 9065.4 9084.9 9092.7 8913.3 8934.8 8993.4 9004.5 9017.5 9030.3 9058.0 9059.7 9074.9 9080.7 8987.6 9033.2 9040.5 9051.0 9052.0 8893.7 8973.8 8975.3 8995.2 9002.3 43291.4 43776.3 43776.6 43780.3 43794.8 3472.8 3499.7 3724.1 3731.5 4053.9 32838.2 32893.0 32894.1 32906.0 33160.5 4306.8 4342.9 4397.3 4439.5 4471.6 369486.0 370274.0 371719.0 372432.0 373040.0 60396.7 60770.4 60772.0 60926.4 61035.4 36493.6 37689.2 37816.2 39438.6 63663.4 17157.3 17651.4 17726.9 17902.7 17919.7 13491.8 13653.5 13723.9 13724.6 13729.4 19429.8 19507.4 19522.3 19644.3 19789.8 6989.7 7053.5 7104.8 7229.3 7434.3 977.4 1100.8 1131.4 1144.4 1195.6 32139.0 32315.2 32555.8 32778.3 33053.0 1114.3 1149.6 1150.3 1202.1 1206.5 17026.3 17062.9 17167.1 17207.5 17374.1 566136.0 572436.0 575678.0 575815.0 579474.0 60239.7 60867.0 61006.7 61018.7 61067.4 1199.9 1279.5 1308.8 1352.1 1377.9 24533.4 33451.3 33902.5 35707.5 35890.8 56996.0 57234.0 57520.4 57619.7 57680.4 469905.0 475310.0 475465.0 475546.0 476160.0 23688.5 28012.2 29173.0 29852.7 30331.2 47187.3 47552.5 47568.0 48129.0 48390.5 40757.2 41741.0 41942.0 42081.6 43647.8 41563.8 42213.6 42323.0 43142.8 43644.0 41618.0 41739.6 42666.0 43154.1 44884.8 33718.7 37927.2 37960.8 38189.4 38500.4 28562.9 28610.4 28640.6 28743.9 28961.3 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | [#2] jquery.html Cycles:180 Average:28636.17 Median:11665.54 stddev:75981.93 (651.3%) stddev-sans-first:76165.46 06:24:53 INFO - PROCESS | 5046 | Values: 379.4 382.9 405.4 407.6 415.9 12930.7 19038.0 20471.5 20631.9 21148.4 20162.2 20307.3 20805.5 21013.8 21071.3 5764.8 5944.0 5954.6 5955.6 5960.8 5841.9 5950.6 5951.9 5954.4 5964.8 5707.6 5939.0 5985.9 6013.1 6037.5 5839.2 5921.3 5968.8 5991.9 5999.0 5785.2 5798.9 5802.9 5803.0 5803.0 13280.5 17868.6 23115.4 23803.5 24241.2 2246.4 2275.3 2386.3 2727.3 2743.5 10022.8 10229.2 10299.0 10718.4 10802.8 1933.3 1972.7 1975.6 1985.4 2018.7 61473.0 82271.6 82367.0 88145.0 92136.0 8840.9 9356.8 9447.3 10466.2 11370.5 13708.2 13765.7 13784.8 13800.2 13809.5 7910.8 8253.7 8294.0 8407.7 8408.4 8310.9 8324.8 8334.9 8525.1 8554.4 4211.7 4255.9 4278.4 4292.3 4381.4 2014.6 2081.6 2090.4 2111.8 2167.9 994.6 1025.6 1040.7 1058.9 1072.2 20691.7 20715.5 20967.1 21074.6 21163.2 1012.4 1029.7 1038.8 1045.4 1116.7 11264.0 11410.8 11813.6 11843.3 11965.6 378969.0 383604.5 496935.0 501672.0 502542.0 102182.0 105238.5 105300.0 110238.0 112550.4 993.6 1006.2 1039.2 1048.9 1049.5 18368.5 18745.3 19196.2 19438.5 19565.5 43016.4 43067.8 43558.6 47169.8 48302.0 60198.4 60656.0 61298.4 62451.4 63040.7 5408.7 6561.4 7505.5 8567.9 9349.6 12313.0 13428.8 13847.5 13875.0 14180.2 11767.5 11969.3 11988.0 12223.7 12392.2 11568.1 11586.1 11892.6 11919.5 12386.3 12025.7 12076.3 12287.4 12330.3 12331.6 7716.6 7992.3 8005.3 8177.1 8326.0 10164.4 11966.8 12064.2 12251.4 12467.4 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | [#3] mootools.html Cycles:180 Average:5996.41 Median:4828.22 stddev:3417.40 (70.8%) stddev-sans-first:3408.88 06:24:53 INFO - PROCESS | 5046 | Values: 1314.9 1480.4 1504.4 1654.6 1797.8 8503.7 8857.7 8990.2 9185.9 9230.1 9042.8 9123.8 9147.7 9165.5 9209.2 2434.1 2466.4 2475.5 2478.2 2478.7 2350.0 2442.8 2446.9 2447.5 2450.7 2390.7 2418.6 2428.2 2443.8 2453.1 2366.6 2371.6 2377.7 2400.2 2434.0 2327.4 2345.3 2354.5 2358.3 2359.4 9019.1 9098.2 9104.0 9178.3 9190.6 5410.8 5654.9 5656.8 5663.4 5665.4 3477.8 3515.0 3517.2 3534.9 3586.0 1135.7 1165.2 1176.5 1179.2 1196.8 12716.3 12831.1 12861.7 12880.5 12912.8 4516.9 4649.4 4816.3 4840.2 4842.9 10149.2 10153.7 10157.3 10161.9 10163.7 5461.1 5466.5 5474.8 5487.0 5499.9 4463.9 4891.2 5044.6 5082.9 5118.8 3969.6 4023.6 4108.4 4126.7 4130.1 1234.7 1253.1 1255.3 1266.3 1269.8 980.9 981.8 985.9 1006.5 1011.8 6033.0 6094.3 6123.1 6200.6 6260.5 938.5 943.9 984.1 994.8 995.1 4041.8 4115.3 4178.5 4375.6 4386.3 11056.8 11483.6 11484.8 11543.2 11593.8 10609.9 11076.3 11136.8 11478.5 11506.1 8440.9 8635.9 8638.7 8641.4 8660.5 5958.9 6041.9 6043.4 6102.5 6319.3 10328.3 10417.3 10428.7 10523.5 10536.2 10345.4 10485.6 10818.8 10823.7 10956.6 7355.9 7686.3 7908.2 8146.8 8351.3 9112.9 9148.4 9168.1 9169.8 9175.5 8062.2 8116.7 8283.7 8361.2 8384.2 7608.1 7617.5 7688.4 7724.8 7816.4 6996.4 7121.8 7125.9 7141.3 7145.2 5060.4 5267.1 5292.6 5365.4 5396.1 5020.7 5093.3 5128.5 5131.9 5514.0 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | [#4] prototype.html Cycles:180 Average:4616.07 Median:5268.34 stddev:1349.39 (25.6%) stddev-sans-first:1314.29 06:24:53 INFO - PROCESS | 5046 | Values: 330.7 335.6 344.7 345.5 345.7 5101.7 5227.2 5276.1 5310.4 5310.8 5212.0 5248.3 5253.9 5275.5 5280.4 4161.7 4164.7 4167.2 4179.4 4197.9 3958.9 4113.8 4178.4 4190.1 4195.6 4030.6 4074.9 4086.7 4106.3 4121.6 4046.6 4058.5 4060.2 4083.8 4085.7 3627.7 3633.6 3639.1 3649.7 3650.6 4981.9 5042.3 5053.1 5095.7 5103.7 4649.3 4655.3 4658.2 4658.8 4699.4 5423.4 5437.2 5447.0 5478.9 5503.3 3814.2 3918.5 3942.4 3946.8 3947.8 5549.9 5606.3 5611.3 5630.6 5640.9 4008.5 4017.5 4038.1 4038.4 4042.2 3990.8 4068.7 4074.9 4077.7 4088.3 4597.1 4607.3 4618.3 4626.7 4640.6 5464.4 5469.4 5471.3 5508.0 5520.8 1326.4 1340.9 1381.4 1389.2 1397.2 928.0 954.7 964.8 976.7 985.3 5155.6 5167.6 5176.5 5177.6 5190.7 5514.8 5529.9 5534.5 5537.9 5561.5 5024.4 5210.5 5230.7 5235.9 5261.2 2953.7 2958.6 2962.5 2967.9 2984.2 5789.0 5796.9 5845.3 5871.8 5895.6 5643.3 5669.5 5684.4 5723.4 5733.7 5777.9 5779.2 5794.5 5795.5 5798.4 5373.1 5529.2 5609.2 5652.5 5652.5 5484.7 5508.2 5525.9 5527.9 5532.8 5802.3 5814.9 5851.6 5865.2 5872.4 3814.4 4046.3 4069.2 4072.7 4075.2 5364.5 5618.4 5632.3 5642.7 5646.6 5340.6 5509.5 5518.6 5524.2 5538.2 5451.4 5460.3 5483.5 5507.7 5517.8 5239.3 5391.4 5463.9 5476.6 5488.5 5457.7 5472.4 5490.0 5513.3 5516.2 5379.8 5418.9 5466.3 5476.8 5499.7 06:24:53 INFO - PROCESS | 5046 | 06:24:53 INFO - PROCESS | 5046 | [#5] yui.html Cycles:180 Average:22778.10 Median:4445.48 stddev:34502.19 (776.1%) stddev-sans-first:34559.46 06:24:53 INFO - PROCESS | 5046 | Values: 786.2 797.8 806.8 854.9 869.2 15509.4 16781.5 16824.1 16828.3 17140.7 13669.6 13733.4 13762.7 13879.1 13907.8 656.3 778.1 789.3 793.6 812.3 788.5 796.9 803.1 803.2 804.4 862.0 862.7 863.2 863.7 864.1 693.8 835.3 857.6 858.3 858.8 622.2 624.6 624.6 625.3 625.9 14910.9 15061.2 15082.3 15091.9 15107.3 13692.9 14084.4 14449.1 14898.9 15042.2 13139.9 13170.7 13206.2 13560.8 14051.1 4384.2 4391.6 4481.1 4608.0 4636.6 81565.2 81568.6 81648.0 82213.2 83263.6 11236.8 11521.7 11619.8 11686.4 11782.1 22144.7 22168.4 22172.8 22279.3 22336.3 8262.2 8276.0 8354.0 8539.1 8703.3 4284.6 4431.3 4466.3 4492.7 4642.8 3219.0 3316.6 3331.9 3344.0 3345.1 596.1 601.8 604.3 604.7 619.5 571.6 599.2 600.8 698.6 706.4 8751.2 9043.2 9323.2 9353.7 9856.8 624.0 633.8 734.8 772.8 775.5 4459.7 4488.4 4868.7 4999.0 5152.5 126511.0 132562.0 132915.3 133015.0 135444.0 109225.5 110876.4 111787.4 113732.0 113752.0 98079.5 99640.0 99918.5 101995.5 102931.0 8934.1 9008.5 9188.8 9219.5 9236.4 55268.4 56215.7 56731.4 57051.0 57394.4 85571.6 88954.6 90477.5 92395.0 92553.5 11982.6 13122.5 13349.9 13426.9 14011.4 13527.2 13827.9 13907.4 14394.9 14600.1 13208.7 13577.9 13710.9 13824.9 14300.0 13230.5 13769.2 13811.0 13860.9 13867.2 12134.2 12365.9 12386.0 12558.6 12599.4 10604.9 10891.2 10943.4 11131.2 11144.2 11107.6 11235.4 11356.5 11419.4 11455.7 06:24:53 INFO - PROCESS | 5046 | -------- Summary: end -------- 06:24:53 INFO - PROCESS | 5046 | 06:24:54 INFO - TEST-INFO | 5046: exit 0 06:24:54 INFO - TEST-OK | dromaeo_css | took 1114999ms 06:24:54 INFO - TEST-START | kraken 06:24:54 INFO - operating with platform_type : linux_ 06:24:54 INFO - Initialising browser for kraken test... 06:24:54 INFO - TEST-INFO | started process 5245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNeqhns/profile http://localhost:44680/getInfo.html) 06:24:58 INFO - PROCESS | 5245 | __metrics Screen width/height:1600/1200 06:24:58 INFO - PROCESS | 5245 | colorDepth:24 06:24:58 INFO - PROCESS | 5245 | Browser inner width/height: 1024/697 06:24:58 INFO - PROCESS | 5245 | __metrics 06:24:58 INFO - PROCESS | 5245 | 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" 06:24:58 INFO - PROCESS | 5245 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:24:59 INFO - TEST-INFO | 5245: exit 0 06:24:59 INFO - Browser initialized. 06:24:59 INFO - Running cycle 1/1 for kraken test... 06:24:59 INFO - TEST-INFO | started process 5328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNeqhns/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:11 INFO - PROCESS | 5328 | RSS: Main: 155951104 06:25:11 INFO - PROCESS | 5328 | 06:25:14 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44680/tests/kraken/driver.html?testName=audio-beat-detection) 06:25:14 INFO - PROCESS | 5328 | RSS: Main: 212779008 06:25:14 INFO - PROCESS | 5328 | 06:25:17 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44680/tests/kraken/driver.html?testName=audio-dft) 06:25:18 INFO - PROCESS | 5328 | RSS: Main: 192196608 06:25:18 INFO - PROCESS | 5328 | 06:25:21 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44680/tests/kraken/driver.html?testName=audio-fft) 06:25:21 INFO - PROCESS | 5328 | RSS: Main: 269520896 06:25:21 INFO - PROCESS | 5328 | 06:25:24 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44680/tests/kraken/driver.html?testName=audio-oscillator) 06:25:24 INFO - PROCESS | 5328 | RSS: Main: 179830784 06:25:24 INFO - PROCESS | 5328 | 06:25:26 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44680/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:25:27 INFO - PROCESS | 5328 | RSS: Main: 184451072 06:25:27 INFO - PROCESS | 5328 | 06:25:30 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44680/tests/kraken/driver.html?testName=imaging-darkroom) 06:25:31 INFO - PROCESS | 5328 | RSS: Main: 219152384 06:25:31 INFO - PROCESS | 5328 | 06:25:34 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44680/tests/kraken/driver.html?testName=imaging-desaturate) 06:25:34 INFO - PROCESS | 5328 | RSS: Main: 219648000 06:25:34 INFO - PROCESS | 5328 | 06:25:37 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44680/tests/kraken/driver.html?testName=json-parse-financial) 06:25:38 INFO - PROCESS | 5328 | RSS: Main: 220037120 06:25:38 INFO - PROCESS | 5328 | 06:25:39 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44680/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:25:40 INFO - PROCESS | 5328 | RSS: Main: 183738368 06:25:40 INFO - PROCESS | 5328 | 06:25:42 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:25:42 INFO - PROCESS | 5328 | RSS: Main: 189874176 06:25:42 INFO - PROCESS | 5328 | 06:25:44 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:25:45 INFO - PROCESS | 5328 | RSS: Main: 194695168 06:25:45 INFO - PROCESS | 5328 | 06:25:48 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:48 INFO - PROCESS | 5328 | RSS: Main: 187752448 06:25:48 INFO - PROCESS | 5328 | 06:25:51 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:51 INFO - PROCESS | 5328 | RSS: Main: 192966656 06:25:51 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | Cycle 1(1): loaded http://localhost:44680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44680/tests/kraken/driver.html?testName=ai-astar) 06:25:53 INFO - PROCESS | 5328 | RSS: Main: 243126272 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | __start_tp_report 06:25:53 INFO - PROCESS | 5328 | _x_x_mozilla_page_load 06:25:53 INFO - PROCESS | 5328 | _x_x_mozilla_page_load_details 06:25:53 INFO - PROCESS | 5328 | |i|pagename|runs| 06:25:53 INFO - PROCESS | 5328 | |0;ai-astar;105;113;111;111;113;112;110;112;110;110 06:25:53 INFO - PROCESS | 5328 | |1;audio-beat-detection;144;119;120;199;119;120;155;120;155;118 06:25:53 INFO - PROCESS | 5328 | |2;audio-dft;161;161;162;162;161;160;164;161;160;162 06:25:53 INFO - PROCESS | 5328 | |3;audio-fft;75;75;75;122;77;76;74;75;101;76 06:25:53 INFO - PROCESS | 5328 | |4;audio-oscillator;84;84;128;85;83;84;111;85;85;135 06:25:53 INFO - PROCESS | 5328 | |5;imaging-gaussian-blur;117;117;116;118;118;116;117;116;117;116 06:25:53 INFO - PROCESS | 5328 | |6;imaging-darkroom;145;147;146;146;146;145;145;145;145;146 06:25:53 INFO - PROCESS | 5328 | |7;imaging-desaturate;96;94;95;95;95;94;95;95;95;94 06:25:53 INFO - PROCESS | 5328 | |8;json-parse-financial;53;51;51;51;50;51;51;50;50;50 06:25:53 INFO - PROCESS | 5328 | |9;json-stringify-tinderbox;61;61;61;61;63;61;62;63;61;63 06:25:53 INFO - PROCESS | 5328 | |10;stanford-crypto-aes;76;76;75;75;76;85;77;77;76;75 06:25:53 INFO - PROCESS | 5328 | |11;stanford-crypto-ccm;125;119;132;121;133;132;124;121;151;124 06:25:53 INFO - PROCESS | 5328 | |12;stanford-crypto-pbkdf2;159;156;159;158;157;160;156;156;157;162 06:25:53 INFO - PROCESS | 5328 | |13;stanford-crypto-sha256-iterative;64;63;63;66;67;62;65;63;61;63 06:25:53 INFO - PROCESS | 5328 | __end_tp_report 06:25:53 INFO - PROCESS | 5328 | __start_cc_report 06:25:53 INFO - PROCESS | 5328 | _x_x_mozilla_cycle_collect,1647 06:25:53 INFO - PROCESS | 5328 | __end_cc_report 06:25:53 INFO - PROCESS | 5328 | __startTimestamp1470662753883__endTimestamp 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | ------- Summary: start ------- 06:25:53 INFO - PROCESS | 5328 | Number of tests: 14 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.31 (2.1%) stddev-sans-first:1.22 06:25:53 INFO - PROCESS | 5328 | Values: 105.0 113.0 111.0 111.0 113.0 112.0 110.0 112.0 110.0 110.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:132.00 stddev:26.70 (20.2%) stddev-sans-first:28.20 06:25:53 INFO - PROCESS | 5328 | Values: 144.0 119.0 120.0 199.0 119.0 120.0 155.0 120.0 155.0 118.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 06:25:53 INFO - PROCESS | 5328 | Values: 161.0 161.0 162.0 162.0 161.0 160.0 164.0 161.0 160.0 162.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:16.04 (21.4%) stddev-sans-first:16.77 06:25:53 INFO - PROCESS | 5328 | Values: 75.0 75.0 75.0 122.0 77.0 76.0 74.0 75.0 101.0 76.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.00 stddev:20.36 (24.2%) stddev-sans-first:21.10 06:25:53 INFO - PROCESS | 5328 | Values: 84.0 84.0 128.0 85.0 83.0 84.0 111.0 85.0 85.0 135.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 06:25:53 INFO - PROCESS | 5328 | Values: 117.0 117.0 116.0 118.0 118.0 116.0 117.0 116.0 117.0 116.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:25:53 INFO - PROCESS | 5328 | Values: 145.0 147.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 06:25:53 INFO - PROCESS | 5328 | Values: 96.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.92 (1.8%) stddev-sans-first:0.53 06:25:53 INFO - PROCESS | 5328 | Values: 53.0 51.0 51.0 51.0 50.0 51.0 51.0 50.0 50.0 50.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 06:25:53 INFO - PROCESS | 5328 | Values: 61.0 61.0 61.0 61.0 63.0 61.0 62.0 63.0 61.0 63.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.97 (3.9%) stddev-sans-first:3.14 06:25:53 INFO - PROCESS | 5328 | Values: 76.0 76.0 75.0 75.0 76.0 85.0 77.0 77.0 76.0 75.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.50 stddev:9.46 (7.4%) stddev-sans-first:9.96 06:25:53 INFO - PROCESS | 5328 | Values: 125.0 119.0 132.0 121.0 133.0 132.0 124.0 121.0 151.0 124.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.50 stddev:2.00 (1.3%) stddev-sans-first:2.09 06:25:53 INFO - PROCESS | 5328 | Values: 159.0 156.0 159.0 158.0 157.0 160.0 156.0 156.0 157.0 162.0 06:25:53 INFO - PROCESS | 5328 | 06:25:53 INFO - PROCESS | 5328 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.83 (2.9%) stddev-sans-first:1.94 06:25:53 INFO - PROCESS | 5328 | Values: 64.0 63.0 63.0 66.0 67.0 62.0 65.0 63.0 61.0 63.0 06:25:53 INFO - PROCESS | 5328 | -------- Summary: end -------- 06:25:53 INFO - PROCESS | 5328 | 06:25:54 INFO - TEST-INFO | 5328: exit 0 06:25:54 INFO - TEST-OK | kraken | took 60321ms 06:25:54 INFO - SUITE-END | took 1175s 06:25:55 INFO - Completed test suite (00:19:35) 06:25:55 INFO - javascript benchmark 06:25:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.940525518696, 3088.598482197314, 3105.937881242375, 3109.533569964505, 3127.5152351385545, 5231.973840130794, 5255.0, 5314.707691076994, 5418.133098704203, 5429.049916264657, 5343.679379237248, 5372.435894231108, 5395.406505284425, 5415.702136382497, 5467.808626698066, 4789.736564488943, 4886.389201349832, 4889.511048895118, 4893.657443978923, 5069.695818250917, 4955.950440495585, 4988.451270360258, 5017.64876458648, 5036.169032109698, 5046.646734728571, 4801.207800712861, 4811.663183577151, 4823.300621409911, 4875.951240487585, 4954.009198160383, 4833.0, 4838.903221935577, 4841.176999910023, 4846.709197448129, 4938.950610493885, 4847.733374664392, 4856.465788763233, 4863.927041094386, 4881.8779530511665, 4887.0714564232685, 5175.068487672217, 5228.607854410934, 5314.521693047605, 5357.383900851413, 5386.218998245272, 5771.105478650816, 5819.214406055213, 5820.679862607555, 5824.621399609055, 5831.096180092092, 5821.417858214187, 5845.006348920694, 5860.384659610722, 5866.384029676908, 5870.0, 5232.816851410221, 5307.203919412119, 5338.492843179892, 5344.144936810092, 5451.373092094381, 5925.318588362307, 5988.071848863433, 5988.580799344004, 5989.341172471025, 5990.371011043778, 5670.291213598301, 5673.858153546112, 5717.914231286534, 5721.084626459829, 5724.341700704389, 5568.164775283659, 5678.3186017678145, 5710.2862142232225, 5731.8853622928145, 5794.188813566104, 5732.426757324234, 5733.569982251348, 5739.713014349266, 5741.167530708024, 5748.878968601166, 5674.432556744293, 5693.402192769782, 5739.799107031234, 5740.282464691913, 5743.368229494752, 4333.9133217335475, 4341.544137865479, 4344.022594916119, 4349.021470169187, 4355.7822108894425, 3910.0420397002918, 3922.4508568800393, 3953.090789118519, 3954.9011274717786, 3975.284448799244, 5362.249285100011, 5366.892662146735, 5367.033933891859, 5375.5162035416215, 5407.567394608422, 5648.209250704905, 5716.885662286814, 5744.798932037442, 5753.05074662676, 5760.135979603093, 5387.919181212285, 5391.4608539145775, 5393.487618676219, 5415.512603865593, 5429.782808687608, 4918.975405123023, 4937.136001199776, 4955.281484184773, 4969.006198760262, 4996.625253106032, 5725.599208055396, 5922.674252916131, 5948.434898684618, 5961.463468287701, 5990.460858522754, 5793.710314484343, 5794.652320860761, 5794.82615521535, 5836.649801011953, 5849.473547380586, 5950.732217050157, 5987.101934709828, 6000.21997140369, 6000.849978750566, 6004.969975150097, 5540.473655002768, 5638.689872057076, 5660.773569057192, 5697.914531282117, 5703.201551782837, 5802.5357971361345, 5804.622699524686, 5809.970950145223, 5841.766329346949, 5861.882762344814, 5610.803621873215, 5649.971750141387, 5656.915146272727, 5661.773529058956, 5664.348599910898, 5479.232907393048, 5574.0, 5589.888202235851, 5643.66138031703, 5647.0964645656495, 5652.378238393856, 5658.519025882846, 5661.943380566307, 5695.686737229492, 5700.429957004432, 5676.290463692038, 5685.658860468385, 5707.400722924033, 5721.599488035798, 5740.1102829061565, 5347.068192982723, 5433.918491222714, 5485.286912701324, 5520.365158006881, 5534.612577119563], "value": 5305.043467490535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6866101982379, 590.1325052173306, 612.9754809807606, 629.8393909553066, 638.6966191059245, 29172.70827291729, 41224.58775412245, 43528.91177720555, 43547.56452435483, 43573.34639980403, 45797.31304030442, 46093.30860037102, 46330.53669463305, 46500.53499465004, 46504.53495465053, 8922.509261990605, 9014.414063085878, 9065.41074830134, 9084.8637270441, 9092.681756138536, 8913.331500137483, 8934.776630584221, 8993.415427997159, 9004.469240229177, 9017.549122543847, 9030.27757779376, 9057.95471022644, 9059.728208153732, 9074.909250907505, 9080.727578172633, 8987.595558199864, 9033.23217526511, 9040.547972601344, 9051.049639787827, 9051.954740226256, 8893.73318800437, 8973.775655608597, 8975.326850486173, 8995.190432861074, 9002.324825638103, 43291.35062974058, 43776.343354849705, 43776.56223437757, 43780.3432948506, 43794.781026094664, 3472.808995505246, 3499.737519686034, 3724.1062145085257, 3731.4962480065387, 4053.858114965962, 32838.179045523815, 32893.0, 32894.0946803318, 32906.0, 33160.50777715009, 4306.7631280279575, 4342.869713908556, 4397.318415645548, 4439.511653718088, 4471.597556219924, 369486.0, 370274.0, 371719.0, 372432.0, 373040.0, 60396.69801650964, 60770.392296076476, 60772.0, 60926.39073609296, 61035.38964610386, 36493.635063649024, 37689.24621507609, 37816.243675126345, 39438.60561394407, 63663.36336636667, 17157.313707451813, 17651.411372976236, 17726.91136544335, 17902.731459028124, 17919.73120403195, 13491.797623035662, 13653.522126725715, 13723.862761372258, 13724.588262352145, 13729.382177802023, 19429.841390066846, 19507.387200828278, 19522.305369829854, 19644.312449064215, 19789.802101978796, 6989.650517474106, 7053.506254562131, 7104.751333703295, 7229.313215244543, 7434.25657434263, 977.413551868873, 1100.801855665988, 1131.3777422417802, 1144.3877525523806, 1195.635331223985, 32139.03582892517, 32315.19212019718, 32555.837220813744, 32778.344433111204, 33053.0, 1114.2534501883758, 1149.6148790155225, 1150.263831148066, 1202.068396992338, 1206.457094307565, 17026.31894724222, 17062.914685426495, 17167.141642917803, 17207.483775486755, 17374.13129343528, 566136.0, 572436.0, 575678.0, 575815.0, 579474.0, 60239.698801505714, 60867.0, 61006.69496652488, 61018.69490652518, 61067.38932610617, 1199.9320604661857, 1279.526575167194, 1308.8363954505687, 1352.0805852020721, 1377.937992790327, 24533.38666533351, 33451.33097337991, 33902.491462627586, 35707.46438803472, 35890.820545897106, 56996.0, 57234.0, 57520.4247957515, 57619.71190144023, 57680.42319576751, 469905.0, 475310.0, 475465.0, 475546.0, 476160.0, 23688.526229475658, 28012.159635210977, 29173.0, 29852.70147298499, 30331.241718957204, 47187.292190616485, 47552.524474756196, 47568.0, 48129.0, 48390.516094838604, 40757.1848563033, 41741.0, 41942.0, 42081.57918420777, 43647.78176109099, 41563.7921810389, 42213.57786422219, 42323.0, 43142.78428607962, 43644.0, 41618.0, 41739.58260417357, 42666.0, 43154.136917262105, 44884.77557612191, 33718.66281337253, 37927.24145517129, 37960.81019594884, 38189.4271585932, 38500.42249366318, 28562.85718571394, 28610.427791444472, 28640.57039144373, 28743.85628071846, 28961.275968100967], "value": 20501.652125931603, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3550963362285, 382.8564288391853, 405.4060800926642, 407.5842640506683, 415.8773161917234, 12930.74138517229, 19038.0, 20471.48821279467, 20631.896840515794, 21148.365549033555, 20162.19351225949, 20307.289244876396, 20805.479863003395, 21013.789862101374, 21071.2625058123, 5764.827055188341, 5943.970280148593, 5954.583179177459, 5955.553333499983, 5960.761569537235, 5841.941580584183, 5950.613210141349, 5951.940480595182, 5954.404559544054, 5964.821055368346, 5707.571932105088, 5938.9703051484685, 5985.850353741148, 6013.128096426016, 6037.516998640121, 5839.153322768218, 5921.259842519685, 5968.820935371946, 5991.910121348184, 5999.0, 5785.247917770705, 5798.942010579883, 5802.941970580325, 5802.97098514509, 5802.97098514509, 13280.535181268706, 17868.55328616782, 23115.422114447105, 23803.523929521485, 24241.151559695503, 2246.382244882654, 2275.260540324401, 2386.343755467243, 2727.2500062482777, 2743.492453896036, 10022.849657255147, 10229.18166546682, 10299.0, 10718.35689858611, 10802.783944321149, 1933.2943475631434, 1972.7040943858392, 1975.6246313200445, 1985.4143027806688, 2018.7375641166702, 61473.0, 82271.588642057, 82367.0, 88145.0, 92136.0, 8840.911590884138, 9356.766080848034, 9447.291453141042, 10466.162706983423, 11370.54517819278, 13708.24604646734, 13765.655858603415, 13784.793228101587, 13800.240986745825, 13809.51666691661, 7910.762677119696, 8253.669853205925, 8294.0, 8407.747767566983, 8408.41141120128, 8310.875336869953, 8324.750257492286, 8334.874976875351, 8525.147485251426, 8554.401191916631, 4211.684123690736, 4255.914881702349, 4278.4160339996515, 4292.334688123284, 4381.364702118175, 2014.587009663045, 2081.55246621977, 2090.351990882831, 2111.841611879115, 2167.934961951144, 994.6071301835879, 1025.5743866295552, 1040.6877936618985, 1058.9046985771317, 1072.2364500602785, 20691.689624655643, 20715.4821129473, 20967.056482458327, 21074.57850843005, 21163.15347386087, 1012.367270455965, 1029.6859457865273, 1038.8493668418037, 1045.4041196517912, 1116.6650004998469, 11264.0, 11410.771784564262, 11813.586524471602, 11843.28940263587, 11965.581204657969, 378969.0, 383604.49186524446, 496935.0, 501672.0, 502542.0, 102182.0, 105238.47380763048, 105300.0, 110238.0, 112550.43724781324, 993.6373223773271, 1006.2352612014921, 1039.1686650679578, 1048.8688913885765, 1049.5014867937668, 18368.540786480444, 18745.250189992246, 19196.232150713815, 19438.514037149183, 19565.510862227988, 43016.354754678076, 43067.78466107775, 43558.56441435545, 47169.76415117903, 48302.0, 60198.39801601928, 60656.0, 61298.387016131055, 62451.375486246376, 63040.68479657756, 5408.72956352173, 6561.442277406474, 7505.549667019996, 8567.871481927652, 9349.57926893305, 12313.0, 13428.798568021683, 13847.482071832328, 13875.028747987948, 14180.220087894852, 11767.529298828293, 11969.341686207343, 11988.0, 12223.69440763988, 12392.194507356993, 11568.074554035826, 11586.073114151017, 11892.615037488838, 11919.52321907114, 12386.256824590553, 12025.699357516132, 12076.33580153065, 12287.385630718607, 12330.32183229895, 12331.630051098482, 7716.5755883426955, 7992.320652744582, 8005.279524842792, 8177.141400153137, 8326.000879894451, 10164.390136591828, 11966.820497692715, 12064.215825971283, 12251.448684809384, 12467.376631168225], "value": 9365.62987939669, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.940827662755, 1480.4374337751656, 1504.4433559582953, 1654.5532706169336, 1797.7662903822509, 8503.702370417037, 8857.734267971962, 8990.235829954461, 9185.862212066824, 9230.123138301868, 9042.773930651738, 9123.77190570236, 9147.725568232963, 9165.495897725623, 9209.171174594285, 2434.0750514804395, 2466.4203912080648, 2475.517274131545, 2478.2317481580676, 2478.7025556933195, 2350.0129945422877, 2442.8167887408426, 2446.9143579974702, 2447.4615584571366, 2450.7304196538366, 2390.6533552634946, 2418.637204419342, 2428.18655750323, 2443.780059794618, 2453.129139155601, 2366.6095094309417, 2371.5968285391523, 2377.679013333204, 2400.1839374612628, 2433.987830060856, 2327.44141406063, 2345.343303874901, 2354.5290941811536, 2358.3396648938324, 2359.445530300378, 9019.143181397756, 9098.181163695299, 9104.044075372123, 9178.265738740885, 9190.632374705005, 5410.83767486976, 5654.858628534278, 5656.830295091154, 5663.377028526858, 5665.3768085510565, 3477.791332520057, 3515.0, 3517.1558825881602, 3534.8762793302367, 3585.982070089633, 1135.6536256441864, 1165.161084019513, 1176.4764679717443, 1179.1745777955466, 1196.7905616517075, 12716.300603466805, 12831.101822872402, 12861.67845803853, 12880.549180778627, 12912.806307905388, 4516.932246016312, 4649.395578574831, 4816.277558366203, 4840.15297322967, 4842.878928026827, 10149.238807089498, 10153.746156346002, 10157.339772914886, 10161.949190254001, 10163.7459063524, 5461.1262198048125, 5466.453354664582, 5474.835754927359, 5487.039768040577, 5499.862503437366, 4463.86608401742, 4891.241857512091, 5044.571211446994, 5082.949170508322, 5118.795248190105, 3969.6030396960073, 4023.6177563131455, 4108.4453598764385, 4126.711130220916, 4130.112025914443, 1234.740704452075, 1253.11029169289, 1255.2844878419214, 1266.265565971734, 1269.8349214602226, 980.8822941247096, 981.7692842182081, 985.8866230383454, 1006.4866917871938, 1011.8330475471465, 6033.0, 6094.268687757498, 6123.050927106306, 6200.56596038273, 6260.499160067184, 938.5260443476001, 943.8725772020827, 984.1339621133357, 994.8408254679216, 995.1193194023341, 4041.777702226406, 4115.300398932189, 4178.540360560336, 4375.584319489643, 4386.2762644163995, 11056.778864422828, 11483.598074067368, 11484.827727584094, 11543.249688770204, 11593.768124637629, 10609.9469502652, 11076.280041797258, 11136.832947505794, 11478.540858365572, 11506.137039722054, 8440.873386899202, 8635.87046194295, 8638.654453821777, 8641.351898607629, 8660.48037117775, 5958.880822383441, 6041.909371359346, 6043.36544662804, 6102.4507794298725, 6319.304876463677, 10328.328658637465, 10417.270791044553, 10428.739281518023, 10523.526441310007, 10536.15710743154, 10345.410435889182, 10485.580576777149, 10818.783624327312, 10823.729406764578, 10956.616518421817, 7355.926440735524, 7686.346660533917, 7908.209179082046, 8146.796330091558, 8351.331893448389, 9112.863307050533, 9148.405353652257, 9168.120535290116, 9169.77075573116, 9175.495347755937, 8062.234087761653, 8116.675332986614, 8283.668653253802, 8361.247487726134, 8384.203500667427, 7608.087029556488, 7617.466777325534, 7688.384929205538, 7724.7682569523, 7816.4137689674635, 6996.405305549085, 7121.82195445118, 7125.893111603226, 7141.285871412817, 7145.249748776304, 5060.418051924076, 5267.104592219409, 5292.5501332387175, 5365.356157261153, 5396.1366181410785, 5020.698758074527, 5093.261477085876, 5128.461511541234, 5131.923021154611, 5513.972430137984], "value": 4789.5368987614165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.6871911894104, 335.5905794930185, 344.7224983887969, 345.5162772119034, 345.7372396978296, 5101.7194054327, 5227.236389799348, 5276.076686579848, 5310.362756469224, 5310.840674779758, 5212.0, 5248.349583460347, 5253.921191182136, 5275.472452754722, 5280.392754833195, 4161.729487583305, 4164.687648426365, 4167.187398457302, 4179.352200408942, 4197.895052623679, 3958.8614398496056, 4113.835446582133, 4178.373244013392, 4190.141021090669, 4195.580441955795, 4030.576789437096, 4074.8777536673797, 4086.6730661547003, 4106.342985122381, 4121.5878412158845, 4046.5953404659444, 4058.5040200276912, 4060.2285565742413, 4083.7958102094926, 4085.6935729820384, 3627.673509384168, 3633.6184700606586, 3639.1448009717697, 3649.6897763690117, 3650.6349365063547, 4981.875453113665, 5042.294078828967, 5053.1157047516535, 5095.719735414551, 5103.668261562986, 4649.279361698942, 4655.348251244828, 4658.208104622188, 4658.813647454098, 4699.412573428322, 5423.376311724123, 5437.184422336682, 5447.0, 5478.890422191574, 5503.257060296849, 3814.179951310454, 3918.45141680165, 3942.4086387041884, 3946.782926939017, 3947.8156553034264, 5549.861253468655, 5606.299212598426, 5611.326640803089, 5630.634008789416, 5640.943590564124, 4008.4588580541836, 4017.457643218128, 4038.1318016626565, 4038.374052021941, 4042.1511482588985, 3990.8004599769897, 4068.7355321903983, 4074.9388759168637, 4077.7145599807727, 4088.264112459726, 4597.057603191404, 4607.308903664477, 4618.261078227468, 4626.676132670681, 4640.559146881041, 5464.360691792446, 5469.429368196941, 5471.316085489314, 5508.0, 5520.779168833282, 1326.389860664086, 1340.9463621455227, 1381.4336122189854, 1389.1526169036879, 1397.168684632642, 927.972160835176, 954.6610953111684, 964.7569401142372, 976.6923419122953, 985.3250523391499, 5155.633757054384, 5167.560757335594, 5176.456472070454, 5177.559907407913, 5190.662606930613, 5514.834554963358, 5529.917051244234, 5534.4742249486235, 5537.944620553743, 5561.499465048165, 5024.371953505812, 5210.456889315302, 5230.692326918271, 5235.869103272448, 5261.210818377274, 2953.7341639252572, 2958.6301712285963, 2962.5408061750463, 2967.8516074196637, 2984.2091845660916, 5788.971055144697, 5796.884062318814, 5845.298564172242, 5871.794487193013, 5895.64626122434, 5643.294588176478, 5669.461401166883, 5684.403137670568, 5723.399043100498, 5733.71331433435, 5777.855553611109, 5779.190913272145, 5794.507466865363, 5795.536357091339, 5798.391168927286, 5373.140297552372, 5529.198266251291, 5609.242752228397, 5652.491275785034, 5652.491275785199, 5484.698341591251, 5508.20131080983, 5525.944740552543, 5527.894421115712, 5532.778688852562, 5802.303723553201, 5814.883702326015, 5851.561132915133, 5865.208196893364, 5872.442117998783, 3814.351560234822, 4046.2918989177365, 4069.2268468990796, 4072.735272207297, 4075.1645912587255, 5364.544013758874, 5618.39875635442, 5632.2678051853, 5642.746076426489, 5646.576506762091, 5340.626156169186, 5509.47659972302, 5518.613697041329, 5524.198991146181, 5538.16927460868, 5451.37309209446, 5460.290162278879, 5483.479069488392, 5507.678157242313, 5517.779288828402, 5239.26650268955, 5391.353037635509, 5463.918041229305, 5476.6166368355425, 5488.4785945335125, 5457.672539647634, 5472.398036215934, 5489.972550137383, 5513.283273174462, 5516.200150978166, 5379.784808607612, 5418.918716219338, 5466.316710411199, 5476.753546090516, 5499.725013749377], "value": 4189.742005734882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.1862971824162, 797.7766225456872, 806.753940048285, 854.9230569248766, 869.2455941666167, 15509.379624815008, 16781.496555103335, 16824.07467589282, 16828.32686692531, 17140.74288885666, 13669.589912302621, 13733.381997810098, 13762.655933601665, 13879.097858639181, 13907.791383129235, 656.2813718977711, 778.0935210479785, 789.2975252025687, 793.5595744361876, 812.297362781196, 788.5071830106184, 796.8764841449585, 803.0724513187278, 803.1566854802434, 804.4368941740776, 861.9698310559131, 862.65062649627, 863.2274114667368, 863.7279257034046, 864.1013346120028, 693.8334799648098, 835.2524490580956, 857.6055014693218, 858.3476557816074, 858.8368210040072, 622.1880446017944, 624.5659266809569, 624.6408315218767, 625.2840497630233, 625.8748250349948, 14910.850891491054, 15061.246937653073, 15082.321295541728, 15091.924540377338, 15107.32017059235, 13692.931535342359, 14084.436622535086, 14449.133052016807, 14898.851011489854, 15042.247887605576, 13139.934300328438, 13170.67073323165, 13206.207627542379, 13560.796588051187, 14051.086679365808, 4384.16700826845, 4391.6486681065435, 4481.126180394825, 4607.953920460786, 4636.559526844944, 81565.18434815695, 81568.59215703943, 81647.95880102986, 82213.17786822114, 83263.58368208242, 11236.775264494665, 11521.711957200969, 11619.767604648028, 11686.415679216005, 11782.057435405148, 22144.66782998256, 22168.445788855086, 22172.778272217394, 22279.331620051424, 22336.329910102722, 8262.17378262169, 8276.0, 8353.958230208931, 8539.14608539141, 8703.303735701129, 4284.571542845752, 4431.268840641323, 4466.285394336891, 4492.663050271242, 4642.814287428465, 3218.951715724266, 3316.5522654441343, 3331.850066747002, 3343.966560334414, 3345.0968238575447, 596.1117934277895, 601.8375038739516, 604.2959951656359, 604.7157835817159, 619.5105866365611, 571.5958539453501, 599.1791245993018, 600.8137477382026, 698.6332175607745, 706.4313227851629, 8751.212390884852, 9043.231325337289, 9323.20752736025, 9353.672621458216, 9856.764984778103, 623.9906401403982, 633.822529691687, 734.8162959260185, 772.7527191298843, 775.5153029356652, 4459.687821852504, 4488.4165058542185, 4868.7331844698365, 4999.005370996647, 5152.510511501401, 126511.0, 132562.0, 132915.33542332228, 133015.0, 135444.0, 109225.45387273013, 110876.4456177714, 111787.44106279417, 113732.0, 113752.0, 98079.50960245296, 99640.0, 99918.5004074975, 101995.4900225494, 102931.0, 8934.061923498199, 9008.549572521479, 9188.816223675623, 9219.539023048686, 9236.353455258068, 55268.44731552794, 56215.71892140677, 56731.43268567426, 57051.0, 57394.426055738906, 85571.57214213889, 88954.55522722345, 90477.54761226152, 92395.0, 92553.5372323134, 11982.64052078439, 13122.475100996235, 13349.933250333686, 13426.932865335611, 14011.43954241819, 13527.188368697909, 13827.930860345634, 13907.37416816266, 14394.856051439352, 14600.12399256048, 13208.735825283633, 13577.932110339385, 13710.862891371358, 13824.930875345559, 14300.0, 13230.470781168646, 13769.242691651654, 13811.0, 13860.861391386361, 13867.237301948086, 12134.211276267015, 12365.876341236473, 12386.0, 12558.623241302776, 12599.4171194903, 10604.946975265075, 10891.18316126278, 10943.398113103538, 11131.165162612675, 11144.2199046066, 11107.555697772323, 11235.438228088726, 11356.488957996744, 11419.37193454368, 11455.656330310105], "value": 7693.070151518853, "unit": "score"}], "name": "dromaeo_css", "value": 7346.945228395623, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 111.0, 113.0, 112.0, 110.0, 112.0, 110.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 120.0, 199.0, 119.0, 120.0, 155.0, 120.0, 155.0, 118.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 164.0, 161.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 122.0, 77.0, 76.0, 74.0, 75.0, 101.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 128.0, 85.0, 83.0, 84.0, 111.0, 85.0, 85.0, 135.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 118.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 50.0, 51.0, 51.0, 50.0, 50.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 62.0, 63.0, 61.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 76.0, 85.0, 77.0, 77.0, 76.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 119.0, 132.0, 121.0, 133.0, 132.0, 124.0, 121.0, 151.0, 124.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 159.0, 158.0, 157.0, 160.0, 156.0, 156.0, 157.0, 162.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 66.0, 67.0, 62.0, 65.0, 63.0, 61.0, 63.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1484.3999999999999, "alertThreshold": 2.0}]} 06:25:55 INFO - Return code: 0 06:25:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:25:55 INFO - # TBPL SUCCESS # 06:25:55 INFO - Running post-action listener: _resource_record_post_action 06:25:55 INFO - [mozharness: 2016-08-08 13:25:55.174241Z] Finished run-tests step (success) 06:25:55 INFO - Running post-run listener: _resource_record_post_run 06:25:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545869824; Read time: 8; Write time: 476668 06:25:55 INFO - TinderboxPrint: CPU usage
13.0% 06:25:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:25:55 INFO - TinderboxPrint: I/O write bytes / time
545,869,824 / 476,668 06:25:55 INFO - TinderboxPrint: CPU idle
8,280.3 (87.0%) 06:25:55 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 06:25:55 INFO - TinderboxPrint: Swap in / out
0 / 0 06:25:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248635392; Read time: 0; Write time: 301456 06:25:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 297234432; Read time: 0; Write time: 175212 06:25:55 INFO - Running post-run listener: _upload_blobber_files 06:25:55 INFO - Blob upload gear active. 06:25:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:55 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 06:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:25:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:25:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:59 INFO - (blobuploader) - INFO - Done attempting. 06:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:00 INFO - (blobuploader) - INFO - Done attempting. 06:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:01 INFO - (blobuploader) - INFO - Done attempting. 06:26:01 INFO - (blobuploader) - INFO - Iteration through files over. 06:26:01 INFO - Return code: 0 06:26:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:26:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:26:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e1614d3f7843ad63d64959c7d483f9b3211cce3c708c2fb5971780c2965e63a7be216b60c0fb87300f8fb175baf7c1ee64ca69cf2d33f9b0a0cf8a558ed420", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04465cb26580c29c923bec77605eb5c8990576359a07e0d78962cdb63c997b1ceaa4c060371698e42c6c4c76274440ee83c06e4b01428a5f458a09413423663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56bd974444c37f236f8f87c2816a5c868f4bee8d015f5081c4354421b4e865880f943e2205322f3e59b337d0f7706275beeaaacbc934bc96ff76ee4b70e80a42"} 06:26:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:26:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:26:01 INFO - Contents: 06:26:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e1614d3f7843ad63d64959c7d483f9b3211cce3c708c2fb5971780c2965e63a7be216b60c0fb87300f8fb175baf7c1ee64ca69cf2d33f9b0a0cf8a558ed420", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04465cb26580c29c923bec77605eb5c8990576359a07e0d78962cdb63c997b1ceaa4c060371698e42c6c4c76274440ee83c06e4b01428a5f458a09413423663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56bd974444c37f236f8f87c2816a5c868f4bee8d015f5081c4354421b4e865880f943e2205322f3e59b337d0f7706275beeaaacbc934bc96ff76ee4b70e80a42"} 06:26:01 INFO - Running post-run listener: copy_logs_to_upload_dir 06:26:01 INFO - Copying logs to upload dir... 06:26:01 INFO - mkdir: /builds/slave/test/build/upload/logs 06:26:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.035949 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-08 06:25:59.717159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:25:59.720755) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e1614d3f7843ad63d64959c7d483f9b3211cce3c708c2fb5971780c2965e63a7be216b60c0fb87300f8fb175baf7c1ee64ca69cf2d33f9b0a0cf8a558ed420", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04465cb26580c29c923bec77605eb5c8990576359a07e0d78962cdb63c997b1ceaa4c060371698e42c6c4c76274440ee83c06e4b01428a5f458a09413423663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56bd974444c37f236f8f87c2816a5c868f4bee8d015f5081c4354421b4e865880f943e2205322f3e59b337d0f7706275beeaaacbc934bc96ff76ee4b70e80a42"} build_url:https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/GOo6I0U1SzOjkhN69Nl-Mg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e1614d3f7843ad63d64959c7d483f9b3211cce3c708c2fb5971780c2965e63a7be216b60c0fb87300f8fb175baf7c1ee64ca69cf2d33f9b0a0cf8a558ed420", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04465cb26580c29c923bec77605eb5c8990576359a07e0d78962cdb63c997b1ceaa4c060371698e42c6c4c76274440ee83c06e4b01428a5f458a09413423663", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56bd974444c37f236f8f87c2816a5c868f4bee8d015f5081c4354421b4e865880f943e2205322f3e59b337d0f7706275beeaaacbc934bc96ff76ee4b70e80a42"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:25:59.751130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:25:59.751567) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1470661526.719523-1787873632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:25:59.831302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:25:59.831630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:25:59.831983) ========= ========= Total master_lag: 0.59 =========