builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1472862388.07 results: success (0) buildid: 20160902143001 builduid: 90c82e2b2f25485e8621580f6d31fbeb revision: 969397f22187cfd25fca153f0d1624dde9490589 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.075128) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.075687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.076180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.100379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.100742) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 17:26: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-09-02 17:26:28 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.246966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.247313) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015987 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:28.309242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 17:26:28.309601) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 969397f22187cfd25fca153f0d1624dde9490589 --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 969397f22187cfd25fca153f0d1624dde9490589 --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=78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 17:26:28,794 truncating revision to first 12 chars 2016-09-02 17:26:28,794 Setting DEBUG logging. 2016-09-02 17:26:28,794 attempt 1/10 2016-09-02 17:26:28,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/969397f22187?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 17:26:30,282 unpacking tar archive at: fx-team-969397f22187/testing/mozharness/ program finished with exit code 0 elapsedTime=1.801483 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 17:26:30.125155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:30.125530) ========= script_repo_revision: 969397f22187cfd25fca153f0d1624dde9490589 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:30.126001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:30.126322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 17:26:30.135486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-02 17:26:30.135883) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:26:30 INFO - MultiFileLogger online at 20160902 17:26:30 in /builds/slave/test 17:26:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:26:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:26:30 INFO - {'append_to_log': False, 17:26:30 INFO - 'base_work_dir': '/builds/slave/test', 17:26:30 INFO - 'blob_upload_branch': 'Fx-Team', 17:26:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:26:30 INFO - 'branch': 'Fx-Team', 17:26:30 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:30 INFO - 'config_files': ('talos/linux_config.py',), 17:26:30 INFO - 'default_actions': ('clobber', 17:26:30 INFO - 'read-buildbot-config', 17:26:30 INFO - 'download-and-extract', 17:26:30 INFO - 'populate-webroot', 17:26:30 INFO - 'create-virtualenv', 17:26:30 INFO - 'install', 17:26:30 INFO - 'run-tests'), 17:26:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:30 INFO - 'download_minidump_stackwalk': True, 17:26:30 INFO - 'download_symbols': 'ondemand', 17:26:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:26:30 INFO - 'tooltool.py': '/tools/tooltool.py', 17:26:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:26:30 INFO - '/tools/misc-python/virtualenv.py')}, 17:26:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:30 INFO - 'installer_path': 'installer.exe', 17:26:30 INFO - 'log_level': 'info', 17:26:30 INFO - 'log_name': 'talos', 17:26:30 INFO - 'log_to_console': True, 17:26:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:26:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:26:30 INFO - 'opt_config_files': (), 17:26:30 INFO - 'pip_index': False, 17:26:30 INFO - 'sps_profile': False, 17:26:30 INFO - 'sps_profile_interval': 0, 17:26:30 INFO - 'suite': 'dromaeojs', 17:26:30 INFO - 'system_bits': '32', 17:26:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:30 INFO - 'title': 'talos-linux64-ix-019', 17:26:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:30 INFO - 'use_talos_json': True, 17:26:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:26:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:30 INFO - 'work_dir': 'build'} 17:26:30 INFO - [mozharness: 2016-09-03 00:26:30.707437Z] Running clobber step. 17:26:30 INFO - Running pre-action listener: _resource_record_pre_action 17:26:30 INFO - Running main action method: clobber 17:26:30 INFO - rmtree: /builds/slave/test/build 17:26:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:26:31 INFO - Running post-action listener: _resource_record_post_action 17:26:31 INFO - [mozharness: 2016-09-03 00:26:31.169644Z] Finished clobber step (success) 17:26:31 INFO - [mozharness: 2016-09-03 00:26:31.169746Z] Running read-buildbot-config step. 17:26:31 INFO - Running pre-action listener: _resource_record_pre_action 17:26:31 INFO - Running main action method: read_buildbot_config 17:26:31 INFO - Using buildbot properties: 17:26:31 INFO - { 17:26:31 INFO - "project": "", 17:26:31 INFO - "product": "firefox", 17:26:31 INFO - "script_repo_revision": "production", 17:26:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:26:31 INFO - "repository": "", 17:26:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:26:31 INFO - "buildid": "20160902143001", 17:26:31 INFO - "pgo_build": "True", 17:26:31 INFO - "basedir": "/builds/slave/test", 17:26:31 INFO - "buildnumber": 1525, 17:26:31 INFO - "slavename": "talos-linux64-ix-019", 17:26:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:26:31 INFO - "platform": "ubuntu64_hw", 17:26:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:26:31 INFO - "branch": "fx-team", 17:26:31 INFO - "repo_path": "integration/fx-team", 17:26:31 INFO - "revision": "969397f22187cfd25fca153f0d1624dde9490589", 17:26:31 INFO - "stage_platform": "linux64-pgo", 17:26:31 INFO - "builduid": "90c82e2b2f25485e8621580f6d31fbeb", 17:26:31 INFO - "slavebuilddir": "test" 17:26:31 INFO - } 17:26:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:26:31 INFO - Running post-action listener: _resource_record_post_action 17:26:31 INFO - [mozharness: 2016-09-03 00:26:31.172209Z] Finished read-buildbot-config step (success) 17:26:31 INFO - [mozharness: 2016-09-03 00:26:31.172300Z] Running download-and-extract step. 17:26:31 INFO - Running pre-action listener: _resource_record_pre_action 17:26:31 INFO - Running main action method: download_and_extract 17:26:31 INFO - mkdir: /builds/slave/test/build/tests 17:26: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')]} 17:26:31 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:26:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:31 INFO - Downloaded 1361 bytes. 17:26:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:26:31 INFO - Using the following test package requirements: 17:26:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:26:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:26:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:26:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'jsshell-linux-x86_64.zip'], 17:26:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:26:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:26:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:26:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:26:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:26:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:26:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:26: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')]} 17:26:31 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:26:31 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:32 INFO - Downloaded 21906324 bytes. 17:26:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:26:36 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 17:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:36 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:26:36 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:37 INFO - Downloaded 21906324 bytes. 17:26:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:26: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')]} 17:26:42 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:26:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:43 INFO - Downloaded 14413998 bytes. 17:26:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 17:26:43 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')]} 17:26:43 INFO - trying https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:26:43 INFO - Downloading https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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 17:26:44 INFO - Downloaded 59699629 bytes. 17:26:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:26:44 INFO - mkdir: /builds/slave/test/properties 17:26:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:44 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:44 INFO - Contents: 17:26:44 INFO - build_url:https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:26:45 INFO - Running post-action listener: _resource_record_post_action 17:26:45 INFO - Running post-action listener: set_extra_try_arguments 17:26:45 INFO - [mozharness: 2016-09-03 00:26:45.115829Z] Finished download-and-extract step (success) 17:26:45 INFO - [mozharness: 2016-09-03 00:26:45.116058Z] Running populate-webroot step. 17:26:45 INFO - Running pre-action listener: _resource_record_pre_action 17:26:45 INFO - Running main action method: populate_webroot 17:26:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:45 INFO - '--tppagecycles', 17:26:45 INFO - '7'], 17:26:45 INFO - 'tests': ['tsvgm']}}, 17:26:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:26:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:26:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:26:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['damp', 'tps']}, 17:26:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'tests': ['damp', 'tps']}, 17:26:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['dromaeo_dom']}, 17:26:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['basic_compositor_video']}, 17:26:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:26:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['a11yr', 17:26:45 INFO - 'ts_paint', 17:26:45 INFO - 'tpaint', 17:26:45 INFO - 'sessionrestore', 17:26:45 INFO - 'sessionrestore_no_auto_restore', 17:26:45 INFO - 'tabpaint']}, 17:26:45 INFO - 'other-e10s': {'tests': ['a11yr', 17:26:45 INFO - 'ts_paint', 17:26:45 INFO - 'tpaint', 17:26:45 INFO - 'sessionrestore', 17:26:45 INFO - 'sessionrestore_no_auto_restore', 17:26:45 INFO - 'tabpaint']}, 17:26:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:26:45 INFO - 'ts_paint', 17:26:45 INFO - 'tpaint', 17:26:45 INFO - 'sessionrestore', 17:26:45 INFO - 'sessionrestore_no_auto_restore', 17:26:45 INFO - 'tabpaint']}, 17:26:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:26:45 INFO - 'ts_paint', 17:26:45 INFO - 'tpaint', 17:26:45 INFO - 'sessionrestore', 17:26:45 INFO - 'sessionrestore_no_auto_restore', 17:26:45 INFO - 'tabpaint']}, 17:26:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['a11yr', 17:26:45 INFO - 'ts_paint', 17:26:45 INFO - 'tpaint', 17:26:45 INFO - 'sessionrestore', 17:26:45 INFO - 'sessionrestore_no_auto_restore', 17:26:45 INFO - 'tabpaint']}, 17:26:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['a11yr', 17:26:45 INFO - 'ts_paint', 17:26:45 INFO - 'tpaint', 17:26:45 INFO - 'sessionrestore', 17:26:45 INFO - 'sessionrestore_no_auto_restore', 17:26:45 INFO - 'tabpaint']}, 17:26:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['tsvgx', 17:26:45 INFO - 'tsvgr_opacity', 17:26:45 INFO - 'tart', 17:26:45 INFO - 'tscrollx', 17:26:45 INFO - 'cart']}, 17:26:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:26:45 INFO - 'tsvgr_opacity', 17:26:45 INFO - 'tart', 17:26:45 INFO - 'tscrollx', 17:26:45 INFO - 'cart']}, 17:26:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'talos_options': ['--disable-e10s'], 17:26:45 INFO - 'tests': ['tp5o']}, 17:26:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'tests': ['tp5o']}, 17:26:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'talos_options': ['--disable-e10s', 17:26:45 INFO - '--xperf_path', 17:26:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:45 INFO - 'tests': ['tp5n']}, 17:26:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:45 INFO - 'talos_options': ['--xperf_path', 17:26:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:45 INFO - 'tests': ['tp5n']}}, 17:26:45 INFO - 'talos.zip': {'path': '', 17:26:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:45 INFO - Running post-action listener: _resource_record_post_action 17:26:45 INFO - [mozharness: 2016-09-03 00:26:45.137818Z] Finished populate-webroot step (success) 17:26:45 INFO - [mozharness: 2016-09-03 00:26:45.137908Z] Running create-virtualenv step. 17:26:45 INFO - Running pre-action listener: _resource_record_pre_action 17:26:45 INFO - Running main action method: create_virtualenv 17:26:45 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:26:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:26:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:45 INFO - Using real prefix '/usr' 17:26:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:47 INFO - Installing pip.................done. 17:26:47 INFO - Return code: 0 17:26:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26: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', 'pip>=1.5'] in /builds/slave/test/build 17:26: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 pip>=1.5 17:26:47 INFO - Using env: {'DISPLAY': ':0', 17:26:47 INFO - 'HOME': '/home/cltbld', 17:26:47 INFO - 'LANG': 'en_US.UTF-8', 17:26:47 INFO - 'LANGUAGE': 'en_US:en', 17:26:47 INFO - 'LOGNAME': 'cltbld', 17:26:47 INFO - 'MAIL': '/var/mail/cltbld', 17:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:47 INFO - 'MOZ_NO_REMOTE': '1', 17:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:47 INFO - 'NO_EM_RESTART': '1', 17:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:47 INFO - 'PWD': '/builds/slave/test', 17:26:47 INFO - 'SHELL': '/bin/bash', 17:26:47 INFO - 'SHLVL': '1', 17:26:47 INFO - 'TERM': 'linux', 17:26:47 INFO - 'TMOUT': '86400', 17:26:47 INFO - 'USER': 'cltbld', 17:26:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:47 INFO - '_': '/tools/buildbot/bin/python'} 17:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:26:47 INFO - Cleaning up... 17:26:47 INFO - Return code: 0 17:26:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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', '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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:26: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 psutil>=3.1.1 17:26:47 INFO - Using env: {'DISPLAY': ':0', 17:26:47 INFO - 'HOME': '/home/cltbld', 17:26:47 INFO - 'LANG': 'en_US.UTF-8', 17:26:47 INFO - 'LANGUAGE': 'en_US:en', 17:26:47 INFO - 'LOGNAME': 'cltbld', 17:26:47 INFO - 'MAIL': '/var/mail/cltbld', 17:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:47 INFO - 'MOZ_NO_REMOTE': '1', 17:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:47 INFO - 'NO_EM_RESTART': '1', 17:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:47 INFO - 'PWD': '/builds/slave/test', 17:26:47 INFO - 'SHELL': '/bin/bash', 17:26:47 INFO - 'SHLVL': '1', 17:26:47 INFO - 'TERM': 'linux', 17:26:47 INFO - 'TMOUT': '86400', 17:26:47 INFO - 'USER': 'cltbld', 17:26:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:47 INFO - '_': '/tools/buildbot/bin/python'} 17:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:48 INFO - Downloading/unpacking psutil>=3.1.1 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:50 INFO - Installing collected packages: psutil 17:26:50 INFO - Running setup.py install for psutil 17:26:50 INFO - building 'psutil._psutil_linux' extension 17:26:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:26:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:26:50 INFO - building 'psutil._psutil_posix' extension 17:26:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:26:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:26:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:50 INFO - Successfully installed psutil 17:26:50 INFO - Cleaning up... 17:26:50 INFO - Return code: 0 17:26:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:26: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 mozsystemmonitor==0.3 17:26:50 INFO - Using env: {'DISPLAY': ':0', 17:26:50 INFO - 'HOME': '/home/cltbld', 17:26:50 INFO - 'LANG': 'en_US.UTF-8', 17:26:50 INFO - 'LANGUAGE': 'en_US:en', 17:26:50 INFO - 'LOGNAME': 'cltbld', 17:26:50 INFO - 'MAIL': '/var/mail/cltbld', 17:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:50 INFO - 'MOZ_NO_REMOTE': '1', 17:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:50 INFO - 'NO_EM_RESTART': '1', 17:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:50 INFO - 'PWD': '/builds/slave/test', 17:26:50 INFO - 'SHELL': '/bin/bash', 17:26:50 INFO - 'SHLVL': '1', 17:26:50 INFO - 'TERM': 'linux', 17:26:50 INFO - 'TMOUT': '86400', 17:26:50 INFO - 'USER': 'cltbld', 17:26:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:50 INFO - '_': '/tools/buildbot/bin/python'} 17:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:26:52 INFO - Installing collected packages: mozsystemmonitor 17:26:52 INFO - Running setup.py install for mozsystemmonitor 17:26:52 INFO - Successfully installed mozsystemmonitor 17:26:52 INFO - Cleaning up... 17:26:52 INFO - Return code: 0 17:26:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:52 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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:26:52 INFO - Using env: {'DISPLAY': ':0', 17:26:52 INFO - 'HOME': '/home/cltbld', 17:26:52 INFO - 'LANG': 'en_US.UTF-8', 17:26:52 INFO - 'LANGUAGE': 'en_US:en', 17:26:52 INFO - 'LOGNAME': 'cltbld', 17:26:52 INFO - 'MAIL': '/var/mail/cltbld', 17:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:52 INFO - 'MOZ_NO_REMOTE': '1', 17:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:52 INFO - 'NO_EM_RESTART': '1', 17:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:52 INFO - 'PWD': '/builds/slave/test', 17:26:52 INFO - 'SHELL': '/bin/bash', 17:26:52 INFO - 'SHLVL': '1', 17:26:52 INFO - 'TERM': 'linux', 17:26:52 INFO - 'TMOUT': '86400', 17:26:52 INFO - 'USER': 'cltbld', 17:26:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:52 INFO - '_': '/tools/buildbot/bin/python'} 17:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:53 INFO - Downloading/unpacking jsonschema==2.5.1 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:55 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:55 INFO - warning: no files found matching '*.txt' 17:26:55 INFO - no previously-included directories found matching 'build' 17:26:55 INFO - no previously-included directories found matching 'dist' 17:26:55 INFO - no previously-included directories found matching '.git*' 17:26:55 INFO - Installing collected packages: jsonschema, functools32 17:26:55 INFO - Running setup.py install for functools32 17:26:55 INFO - warning: no files found matching '*.txt' 17:26:55 INFO - no previously-included directories found matching 'build' 17:26:55 INFO - no previously-included directories found matching 'dist' 17:26:55 INFO - no previously-included directories found matching '.git*' 17:26:55 INFO - Successfully installed jsonschema functools32 17:26:55 INFO - Cleaning up... 17:26:55 INFO - Return code: 0 17:26:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:55 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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:55 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 17:26:55 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 17:26:55 INFO - Using env: {'DISPLAY': ':0', 17:26:55 INFO - 'HOME': '/home/cltbld', 17:26:55 INFO - 'LANG': 'en_US.UTF-8', 17:26:55 INFO - 'LANGUAGE': 'en_US:en', 17:26:55 INFO - 'LOGNAME': 'cltbld', 17:26:55 INFO - 'MAIL': '/var/mail/cltbld', 17:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:55 INFO - 'MOZ_NO_REMOTE': '1', 17:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:55 INFO - 'NO_EM_RESTART': '1', 17:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:55 INFO - 'PWD': '/builds/slave/test', 17:26:55 INFO - 'SHELL': '/bin/bash', 17:26:55 INFO - 'SHLVL': '1', 17:26:55 INFO - 'TERM': 'linux', 17:26:55 INFO - 'TMOUT': '86400', 17:26:55 INFO - 'USER': 'cltbld', 17:26:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:55 INFO - '_': '/tools/buildbot/bin/python'} 17:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:26:55 INFO - Cleaning up... 17:26:55 INFO - Return code: 0 17:26:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:55 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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:26:55 INFO - Using env: {'DISPLAY': ':0', 17:26:55 INFO - 'HOME': '/home/cltbld', 17:26:55 INFO - 'LANG': 'en_US.UTF-8', 17:26:55 INFO - 'LANGUAGE': 'en_US:en', 17:26:55 INFO - 'LOGNAME': 'cltbld', 17:26:55 INFO - 'MAIL': '/var/mail/cltbld', 17:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:55 INFO - 'MOZ_NO_REMOTE': '1', 17:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:55 INFO - 'NO_EM_RESTART': '1', 17:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:55 INFO - 'PWD': '/builds/slave/test', 17:26:55 INFO - 'SHELL': '/bin/bash', 17:26:55 INFO - 'SHLVL': '1', 17:26:55 INFO - 'TERM': 'linux', 17:26:55 INFO - 'TMOUT': '86400', 17:26:55 INFO - 'USER': 'cltbld', 17:26:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:55 INFO - '_': '/tools/buildbot/bin/python'} 17:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 INFO - Downloading docopt-0.6.1.tar.gz 17:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:58 INFO - Running setup.py install for blobuploader 17:26:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:58 INFO - Running setup.py install for requests 17:26:59 INFO - Running setup.py install for docopt 17:26:59 INFO - Successfully installed blobuploader requests docopt 17:26:59 INFO - Cleaning up... 17:26:59 INFO - Return code: 0 17:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:59 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')]} 17:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:59 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')]} 17:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:59 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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:59 INFO - Using env: {'DISPLAY': ':0', 17:26:59 INFO - 'HOME': '/home/cltbld', 17:26:59 INFO - 'LANG': 'en_US.UTF-8', 17:26:59 INFO - 'LANGUAGE': 'en_US:en', 17:26:59 INFO - 'LOGNAME': 'cltbld', 17:26:59 INFO - 'MAIL': '/var/mail/cltbld', 17:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:59 INFO - 'MOZ_NO_REMOTE': '1', 17:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:59 INFO - 'NO_EM_RESTART': '1', 17:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:59 INFO - 'PWD': '/builds/slave/test', 17:26:59 INFO - 'SHELL': '/bin/bash', 17:26:59 INFO - 'SHLVL': '1', 17:26:59 INFO - 'TERM': 'linux', 17:26:59 INFO - 'TMOUT': '86400', 17:26:59 INFO - 'USER': 'cltbld', 17:26:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:59 INFO - '_': '/tools/buildbot/bin/python'} 17:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:59 INFO - Running setup.py (path:/tmp/pip-E1jDIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:59 INFO - Running setup.py (path:/tmp/pip-CDqPmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:59 INFO - Running setup.py (path:/tmp/pip-tfkNzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:59 INFO - Running setup.py (path:/tmp/pip-0YJsZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:59 INFO - Running setup.py (path:/tmp/pip-boiHJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:59 INFO - Running setup.py (path:/tmp/pip-5wB4SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:59 INFO - Running setup.py (path:/tmp/pip-DvlNXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:59 INFO - Running setup.py (path:/tmp/pip-ZNgvI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:00 INFO - Running setup.py (path:/tmp/pip-5jtb8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:00 INFO - Running setup.py (path:/tmp/pip-GCBx4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:00 INFO - Running setup.py (path:/tmp/pip-rnw9wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:00 INFO - Running setup.py (path:/tmp/pip-0hNdaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:00 INFO - Running setup.py (path:/tmp/pip-vLMUhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:00 INFO - Running setup.py (path:/tmp/pip-TJgtp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:00 INFO - Running setup.py (path:/tmp/pip-JkJXMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:00 INFO - Running setup.py (path:/tmp/pip-HFQJrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:00 INFO - Running setup.py (path:/tmp/pip-44dMEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:27:00 INFO - Running setup.py install for manifestparser 17:27:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:27:00 INFO - Running setup.py install for mozcrash 17:27:00 INFO - Running setup.py install for mozdebug 17:27:00 INFO - Running setup.py install for mozdevice 17:27:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozfile 17:27:01 INFO - Running setup.py install for mozhttpd 17:27:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozinfo 17:27:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozInstall 17:27:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozleak 17:27:01 INFO - Running setup.py install for mozlog 17:27:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for moznetwork 17:27:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:27:01 INFO - Running setup.py install for mozprocess 17:27:01 INFO - Running setup.py install for mozprofile 17:27:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Running setup.py install for mozrunner 17:27:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Running setup.py install for mozscreenshot 17:27:02 INFO - Running setup.py install for moztest 17:27:02 INFO - Running setup.py install for mozversion 17:27:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:27:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:27:02 INFO - Cleaning up... 17:27:02 INFO - Return code: 0 17:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:02 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')]} 17:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:02 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')]} 17:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:02 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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:27:02 INFO - Using env: {'DISPLAY': ':0', 17:27:02 INFO - 'HOME': '/home/cltbld', 17:27:02 INFO - 'LANG': 'en_US.UTF-8', 17:27:02 INFO - 'LANGUAGE': 'en_US:en', 17:27:02 INFO - 'LOGNAME': 'cltbld', 17:27:02 INFO - 'MAIL': '/var/mail/cltbld', 17:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:02 INFO - 'MOZ_NO_REMOTE': '1', 17:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:02 INFO - 'NO_EM_RESTART': '1', 17:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:02 INFO - 'PWD': '/builds/slave/test', 17:27:02 INFO - 'SHELL': '/bin/bash', 17:27:02 INFO - 'SHLVL': '1', 17:27:02 INFO - 'TERM': 'linux', 17:27:02 INFO - 'TMOUT': '86400', 17:27:02 INFO - 'USER': 'cltbld', 17:27:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:02 INFO - '_': '/tools/buildbot/bin/python'} 17:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:02 INFO - Running setup.py (path:/tmp/pip-tNjHWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:02 INFO - Running setup.py (path:/tmp/pip-d7CW07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:02 INFO - Running setup.py (path:/tmp/pip-Slvg2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:02 INFO - Running setup.py (path:/tmp/pip-2d7htk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:02 INFO - Running setup.py (path:/tmp/pip-Yu8LKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:03 INFO - Running setup.py (path:/tmp/pip-BU_K2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:03 INFO - Running setup.py (path:/tmp/pip-_DGDjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:03 INFO - Running setup.py (path:/tmp/pip-My2X_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:03 INFO - Running setup.py (path:/tmp/pip-IysyqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:03 INFO - Running setup.py (path:/tmp/pip-rwIKUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:03 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)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:03 INFO - Running setup.py (path:/tmp/pip-5dgvbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:03 INFO - Running setup.py (path:/tmp/pip-rfJQOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:03 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)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:03 INFO - Running setup.py (path:/tmp/pip-eW__ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:03 INFO - Running setup.py (path:/tmp/pip-YyvsL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:03 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)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:03 INFO - Running setup.py (path:/tmp/pip-WRh5j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:03 INFO - Running setup.py (path:/tmp/pip-dJx8QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:03 INFO - Running setup.py (path:/tmp/pip-kwlJMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:07 INFO - Downloading blessings-1.6.tar.gz 17:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:07 INFO - Installing collected packages: blessings 17:27:07 INFO - Running setup.py install for blessings 17:27:07 INFO - Successfully installed blessings 17:27:07 INFO - Cleaning up... 17:27:07 INFO - Return code: 0 17:27:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:07 INFO - Reading from file tmpfile_stdout 17:27:07 INFO - Current package versions: 17:27:07 INFO - argparse == 1.2.1 17:27:07 INFO - blessings == 1.6 17:27:07 INFO - blobuploader == 1.2.4 17:27:07 INFO - docopt == 0.6.1 17:27:07 INFO - functools32 == 3.2.3-2 17:27:07 INFO - jsonschema == 2.5.1 17:27:07 INFO - manifestparser == 1.1 17:27:07 INFO - mozInstall == 1.12 17:27:07 INFO - mozcrash == 0.17 17:27:07 INFO - mozdebug == 0.1 17:27:07 INFO - mozdevice == 0.48 17:27:07 INFO - mozfile == 1.2 17:27:07 INFO - mozhttpd == 0.7 17:27:07 INFO - mozinfo == 0.9 17:27:07 INFO - mozleak == 0.1 17:27:07 INFO - mozlog == 3.3 17:27:07 INFO - moznetwork == 0.27 17:27:07 INFO - mozprocess == 0.23 17:27:07 INFO - mozprofile == 0.28 17:27:07 INFO - mozrunner == 6.12 17:27:07 INFO - mozscreenshot == 0.1 17:27:07 INFO - mozsystemmonitor == 0.3 17:27:07 INFO - moztest == 0.7 17:27:07 INFO - mozversion == 1.4 17:27:07 INFO - psutil == 3.1.1 17:27:07 INFO - requests == 1.2.3 17:27:07 INFO - wsgiref == 0.1.2 17:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:07 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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:27:07 INFO - Using env: {'DISPLAY': ':0', 17:27:07 INFO - 'HOME': '/home/cltbld', 17:27:07 INFO - 'LANG': 'en_US.UTF-8', 17:27:07 INFO - 'LANGUAGE': 'en_US:en', 17:27:07 INFO - 'LOGNAME': 'cltbld', 17:27:07 INFO - 'MAIL': '/var/mail/cltbld', 17:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:07 INFO - 'MOZ_NO_REMOTE': '1', 17:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:07 INFO - 'NO_EM_RESTART': '1', 17:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:07 INFO - 'PWD': '/builds/slave/test', 17:27:07 INFO - 'SHELL': '/bin/bash', 17:27:07 INFO - 'SHLVL': '1', 17:27:07 INFO - 'TERM': 'linux', 17:27:07 INFO - 'TMOUT': '86400', 17:27:07 INFO - 'USER': 'cltbld', 17:27:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:07 INFO - '_': '/tools/buildbot/bin/python'} 17:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:27:07 INFO - Cleaning up... 17:27:07 INFO - Return code: 0 17:27:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:07 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 0x7f2dae357f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd05850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:27:07 INFO - Using env: {'DISPLAY': ':0', 17:27:07 INFO - 'HOME': '/home/cltbld', 17:27:07 INFO - 'LANG': 'en_US.UTF-8', 17:27:07 INFO - 'LANGUAGE': 'en_US:en', 17:27:07 INFO - 'LOGNAME': 'cltbld', 17:27:07 INFO - 'MAIL': '/var/mail/cltbld', 17:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:07 INFO - 'MOZ_NO_REMOTE': '1', 17:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:07 INFO - 'NO_EM_RESTART': '1', 17:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:07 INFO - 'PWD': '/builds/slave/test', 17:27:07 INFO - 'SHELL': '/bin/bash', 17:27:07 INFO - 'SHLVL': '1', 17:27:07 INFO - 'TERM': 'linux', 17:27:07 INFO - 'TMOUT': '86400', 17:27:07 INFO - 'USER': 'cltbld', 17:27:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:07 INFO - '_': '/tools/buildbot/bin/python'} 17:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:27:07 INFO - Cleaning up... 17:27:07 INFO - Return code: 0 17:27:07 INFO - Running post-action listener: _resource_record_post_action 17:27:07 INFO - Running post-action listener: _start_resource_monitoring 17:27:07 INFO - Starting resource monitoring. 17:27:07 INFO - [mozharness: 2016-09-03 00:27:07.970822Z] Finished create-virtualenv step (success) 17:27:07 INFO - [mozharness: 2016-09-03 00:27:07.971284Z] Running install step. 17:27:07 INFO - Running pre-action listener: _resource_record_pre_action 17:27:07 INFO - Running main action method: install 17:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:08 INFO - Reading from file tmpfile_stdout 17:27:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:08 INFO - Reading from file tmpfile_stdout 17:27:08 INFO - Output received: 17:27:08 INFO - Usage: mozinstall [options] installer 17:27:08 INFO - Options: 17:27:08 INFO - -h, --help show this help message and exit 17:27:08 INFO - -d DEST, --destination=DEST 17:27:08 INFO - Directory to install application into. [default: 17:27:08 INFO - "/builds/slave/test"] 17:27:08 INFO - --app=APP Application being installed. [default: firefox] 17:27:08 INFO - mkdir: /builds/slave/test/build/application 17:27:08 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'] 17:27:08 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 17:27:25 INFO - Reading from file tmpfile_stdout 17:27:25 INFO - Output received: 17:27:25 INFO - /builds/slave/test/build/application/firefox/firefox 17:27:25 INFO - Running post-action listener: _resource_record_post_action 17:27:25 INFO - [mozharness: 2016-09-03 00:27:25.811142Z] Finished install step (success) 17:27:25 INFO - [mozharness: 2016-09-03 00:27:25.811422Z] Running run-tests step. 17:27:25 INFO - Running pre-action listener: _resource_record_pre_action 17:27:25 INFO - Running main action method: run_tests 17:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:25 INFO - Python 2.7.3 17:27:25 INFO - Return code: 0 17:27:25 INFO - grabbing minidump binary from tooltool 17:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:25 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 0xd00370>, '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 0xd038f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd03d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:27:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:27:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:27:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:25 INFO - Return code: 0 17:27:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:27:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:27:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:25 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/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:27:25 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/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:27:25 INFO - Using env: {'DISPLAY': ':0', 17:27:25 INFO - 'HOME': '/home/cltbld', 17:27:25 INFO - 'LANG': 'en_US.UTF-8', 17:27:25 INFO - 'LANGUAGE': 'en_US:en', 17:27:25 INFO - 'LOGNAME': 'cltbld', 17:27:25 INFO - 'MAIL': '/var/mail/cltbld', 17:27:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:25 INFO - 'MOZ_NO_REMOTE': '1', 17:27:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:25 INFO - 'NO_EM_RESTART': '1', 17:27:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:25 INFO - 'PWD': '/builds/slave/test', 17:27:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:25 INFO - 'SHELL': '/bin/bash', 17:27:25 INFO - 'SHLVL': '1', 17:27:25 INFO - 'TERM': 'linux', 17:27:25 INFO - 'TMOUT': '86400', 17:27:25 INFO - 'USER': 'cltbld', 17:27:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709', 17:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:25 INFO - '_': '/tools/buildbot/bin/python'} 17:27:25 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/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:27:26 INFO - mozversion application_buildid: 20160902143001 17:27:26 INFO - mozversion application_changeset: 969397f22187cfd25fca153f0d1624dde9490589 17:27:26 INFO - mozversion application_display_name: Nightly 17:27:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:26 INFO - mozversion application_name: Firefox 17:27:26 INFO - mozversion application_remotingname: firefox 17:27:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:27:26 INFO - mozversion application_vendor: Mozilla 17:27:26 INFO - mozversion application_version: 51.0a1 17:27:26 INFO - mozversion platform_buildid: 20160902143001 17:27:26 INFO - mozversion platform_changeset: 969397f22187cfd25fca153f0d1624dde9490589 17:27:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:27:26 INFO - mozversion platform_version: 51.0a1 17:27:26 INFO - using testdate: 1472862446 17:27:26 INFO - actual date: 1472862446 17:27:26 INFO - starting webserver on 'localhost:59949' 17:27:26 INFO - SUITE-START | Running 2 tests 17:27:26 INFO - TEST-START | dromaeo_css 17:27:26 INFO - operating with platform_type : linux_ 17:27:26 INFO - Initialising browser for dromaeo_css test... 17:27:26 INFO - TEST-INFO | started process 16204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcAO55s/profile http://localhost:59949/getInfo.html) 17:27:30 INFO - PROCESS | 16204 | __metrics Screen width/height:1600/1200 17:27:30 INFO - PROCESS | 16204 | colorDepth:24 17:27:30 INFO - PROCESS | 16204 | Browser inner width/height: 1024/697 17:27:30 INFO - PROCESS | 16204 | __metrics 17:27:31 INFO - PROCESS | 16204 | 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" 17:27:31 INFO - PROCESS | 16204 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:32 INFO - PROCESS | 16204 | console.error: PushService: 17:27:32 INFO - PROCESS | 16204 | stateChangeProcessEnqueue: Error transitioning state 17:27:32 INFO - PROCESS | 16204 | UnknownError 17:27:32 INFO - TEST-INFO | 16204: exit 0 17:27:32 INFO - Browser initialized. 17:27:32 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:32 INFO - TEST-INFO | started process 16283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcAO55s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:44 INFO - PROCESS | 16283 | RSS: Main: 178884608 17:27:44 INFO - PROCESS | 16283 | 17:28:36 INFO - PROCESS | 16283 | 1472862516061 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:30:45 INFO - PROCESS | 16283 | Cycle 1(1): loaded http://localhost:59949/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59949/tests/dromaeo/cssquery-ext.html) 17:30:46 INFO - PROCESS | 16283 | RSS: Main: 282361856 17:30:46 INFO - PROCESS | 16283 | 17:33:49 INFO - PROCESS | 16283 | Cycle 1(1): loaded http://localhost:59949/tests/dromaeo/cssquery-ext.html (next: http://localhost:59949/tests/dromaeo/cssquery-jquery.html) 17:33:49 INFO - PROCESS | 16283 | RSS: Main: 274878464 17:33:49 INFO - PROCESS | 16283 | 17:36:51 INFO - PROCESS | 16283 | Cycle 1(1): loaded http://localhost:59949/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59949/tests/dromaeo/cssquery-mootools.html) 17:36:52 INFO - PROCESS | 16283 | RSS: Main: 268836864 17:36:52 INFO - PROCESS | 16283 | 17:39:54 INFO - PROCESS | 16283 | Cycle 1(1): loaded http://localhost:59949/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59949/tests/dromaeo/cssquery-prototype.html) 17:39:55 INFO - PROCESS | 16283 | RSS: Main: 263630848 17:39:55 INFO - PROCESS | 16283 | 17:42:57 INFO - PROCESS | 16283 | Cycle 1(1): loaded http://localhost:59949/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59949/tests/dromaeo/cssquery-yui.html) 17:42:58 INFO - PROCESS | 16283 | RSS: Main: 216305664 17:42:58 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | Cycle 1(1): loaded http://localhost:59949/tests/dromaeo/cssquery-yui.html (next: http://localhost:59949/tests/dromaeo/cssquery-dojo.html) 17:46:01 INFO - PROCESS | 16283 | RSS: Main: 295313408 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | __start_tp_report 17:46:01 INFO - PROCESS | 16283 | _x_x_mozilla_page_load 17:46:01 INFO - PROCESS | 16283 | _x_x_mozilla_page_load_details 17:46:01 INFO - PROCESS | 16283 | |i|pagename|runs| 17:46:01 INFO - PROCESS | 16283 | |0;dojo.html;2979.3147576057504;2980.5231163013914;3001.6247969003875;3037.6810434904346;3058.9847050764743;5130.153524668434;5226.451222621627;5237.895242095161;5282.154855223161;5322.654027488211;5233.319668443107;5275.024120537693;5297.761600727967;5310.07073762092;5344.251804747329;4747.1692453820615;4775.594074503671;4806.879828004293;4825.396825396825;4891.339669144655;4805.135075686375;4885.755712214375;4933.235348520985;4953.628477864157;4956.628252881031;4890.119778439879;4894.3147959285725;4898.877528061791;4906.411230652309;4937.654364194508;4725.8582242532775;4747.7626118693925;4755.904881902377;4795.064962332347;4811.975940120312;4708.317293992352;4725.692829966041;4745.620350371996;4850.442199147073;4851.151048566522;5219.347581552306;5238.842834714965;5268.947310526923;5273.129933560957;5336.825898302367;5444.210589464506;5447.101228297326;5585.664860108366;5591.832245032656;5595.076812326002;5546.278983732089;5555.055640541118;5555.694436805974;5583.860403489945;5637.689927054011;5144.845654630367;5204.635675502755;5207.739613019334;5213.6089793265655;5215;5528.44715528444;5628.465295796893;5695.914561281584;5702.344230413472;5704.914426283609;5460.535854452337;5475.6440831345835;5479.068558345091;5507.284053073075;5550.944490555124;5555.027870122713;5564.221009058735;5566.2207290979295;5571.275734154534;5575.470330318613;5449.536789372948;5508.091164957817;5557.472040156179;5599.916001259984;5621.831345059655;5572.888542229132;5578;5579.721013949286;5627.831165065055;5645.379008309083;4345.869623911288;4349.826006959749;4350.630196433275;4357.67317451186;4403.383526306319;3822.2928758179823;3839.404892241707;3847.153626202231;3890.0663840678035;3913.1391093959282;5308.46915308466;5309.41596424393;5310.097283461821;5367.651102678392;5368.489993450616;5576.804811831566;5600.439956004367;5607.299087614048;5607.43925607436;5612.410696876851;5195.974020129951;5229.633925625246;5266.710330931835;5296.682199068068;5372;4829.348038014823;4832.4684284728655;4834.105690447279;4868.78090485929;4891.6575839691595;5784.074548072288;5791.044477661138;5801.129830525455;5804.82585522435;5865.237519122486;5477.616566840283;5516.393196748435;5517.834464966058;5604.271444712162;5610;5722.656640601577;5737.885242295214;5745.052066408995;5803;5812.709364531841;5404.729888476283;5456.7544460498575;5459.071957767269;5465.69938653362;5470.699111548903;5468.945310547003;5504.91742623869;5523.392426833126;5549.7780088796;5560.9337418537625;5452.2094296327605;5454.945450545444;5457.126859702428;5499.3675727291875;5531.612787104864;5419.214213938878;5419.729013549386;5422.349318081855;5428.348598168245;5492.3409190895745;5187.974060129675;5389.461053894579;5401.594880383908;5426.186072089218;5427.6472029317965;5600.467955544217;5602.13166959122;5606.691631960118;5635.380108188178;5659.151127330933;5376.919346209888;5415.187721841755;5423.62034657586;5426.348838139448;5434.701091439851 17:46:01 INFO - PROCESS | 16283 | |1;ext.html;563.3577721397605;591.7544219149054;614.9883441738343;622.7477871462058;629.719774700258;35354.292914141704;43375.78312108439;44581.7770911145;44683.77658111713;48171.759141204246;45892.08215835681;46264.30603540949;46300.53699463004;46368.53631463684;46408;8097.797555061112;8890.42212256203;9026.86459703105;9043.050479699636;9050;10584.312019718695;10891.400972946485;10893.945530272376;11253.324800511955;11257.493412796402;10999.120070394389;11093.33439993599;11102.944485277561;11104.888951110506;11105.611303604375;10886.346819190834;10903.727406814814;10940.781184376348;10944.537479067225;10950.34297942122;10734.946325268324;10778.568857245778;10800.027997480185;10804.351738895613;10809.513571889283;42911.35632965508;42967.78516107431;43307.56692433098;43340.56659433428;43371.56628433707;3468.6011108722314;3510.350585141757;3691.7136917136704;3897.629725176132;4230.640395566381;32177.83911080453;32520.512192317135;32988;33019.504707429405;33119.83440082784;4166.604172603597;4246.129543443618;4257.169851878885;4310.741355518648;4444.177827101964;256275;256819;257254;258683;258947;58218;59387.109193362136;59658.70170649119;59680.40319596748;59813;62730.68634656798;62998.68500657559;63063.369366306666;63145.36854631395;63186;17235;17555;17558;17560.736588951175;17566.12169391551;11637.185397022296;12589.87410125887;13491.730165396637;13683;13695.178289302674;16655.83344166567;17158.142092895556;17203.311867525408;17411.56471088233;17437;6015.789447369321;6048.524092171761;6050.30421501533;6085.695715214221;6194.38056194386;967.8403063494444;1023.3501726403787;1039.5270152080784;1088.211046990941;1112.8775834658181;31371.686283137333;32704.672953270638;33070.17324566905;33502.12700015494;33755.49366759501;1105.309181761399;1122.747381839096;1148.3798748675788;1154.2151337090859;1154.9711257218637;16309.184540772914;17046.74429883553;17107.572310692332;17181.7422738659;17188.570285742706;532915;535860;536987;537422;538569;58046;58184.41815581875;58267.4173258262;58331.4166858326;58341;1232.624049664843;1308.463529952715;1338.143588103595;1349.5006847466304;1366.4875671623142;31704.682953170173;32886.34227315488;33642.831785840914;33904.152271561004;34401.65598344085;50749.74625126851;51464;51465.485345146066;51470.48529514657;51491.74254128705;388727;389194;389990;390546;390810;27641.54480689914;28860.855695721388;28864.711352886203;29621.25946851346;29698.257543560718;47301;48109.5189048105;48429;48733.756331219534;49887.75056124696;40376.596234037286;40677.186456270116;41655.143598978124;41722.58277417187;42870.35694464648;40523.59476405198;41088.79455602703;41225.175496489304;41839.02529259716;42993.355099674154;40490.59509404868;41609.79195104005;41820.372694410216;42408.36387454253;42579;32373;36785.81607091947;37570.624293756715;43775.56224437715;46080;33195.66804331926;33991.830040849636;36592.0851978692;36923.63076369202;37120.628793711716 17:46:01 INFO - PROCESS | 16283 | |2;jquery.html;372.18677190339093;392.56229304325683;403.826354667493;404.629763766154;414.1695899721059;16062.51812445627;19040.90479547604;19264.711029334572;20135.59728805423;20195.59608807823;19609.705854412194;19797.50506237345;19847.404577862686;20037.799622003775;20074.899625501854;5251.763670634811;5714.485696287344;5899.557533185007;5929.436703513159;5958.463738263556;5826.126081087849;5901.409859014086;5910.172575839386;5912.9704351478185;5916.290045194562;5790.218320526738;6034;6344.365563443642;6344.382182543445;6467.902981455259;6258.311585725566;6361.459275961549;6455.741770329181;6485.319041500646;6489.772857949973;5713.5714821388565;5714.79998200061;5719.342275638313;5721.4850663440075;5726.656400615976;14043.578692639237;14060.859391406057;14075.85924140766;14182.361793719307;14305.356258968372;2226.2208227120377;2240.7199100112484;2257.1535674122206;2266.875321857297;2793.27374882532;10081.344712593658;10252.077313041862;10675.519601617869;10678;11182.888171118348;1884.387574038443;1898.648749981244;1948.39599724086;1953.5116220944765;1979.70304454333;78726;83546.58226708828;83655.16344836535;84705;85510;9317.254619630414;9564.856527152098;9743.220542356594;9870.802583948282;9980.852201996864;12963.935180324226;13002.869971300355;13004.154729942524;13054.34728263602;13065.477380904656;7423.888641670379;7739.651715672809;8001.919980800234;8278.668853245803;8311.33509319253;8125.4718443301;8232.8353432931;8256.1331060239;8316.972158526036;8426.69386245133;4116.938245926313;4118.464599602033;4121.155163191538;4187.43469631602;4280.101178752435;1780.866435017379;1872.5505878589313;1899.629572233429;1907.3801014670287;1954.3257576136211;939.5818860606964;941.6657086734248;995.0447570332417;997.491279447487;1073.822819234833;19555.608887822164;19927.60144797096;19966;20005.499862503555;20143.597128057358;950.8336041192764;990.5146478225618;1002.4486532407146;1004.708634495988;1018.6791160784329;10302.124319432933;10527.526261318259;11137.498812553455;11169.329840209452;11206.49570769301;367033;368526;370422;456656;496618;54603.72698136563;56289.7185514078;59260.40739592635;93885.53057234807;101465;972.8394814855469;1020.5917632946732;1044.6082718980383;1052.5263631365915;1067.4769363012224;11678.824817627572;16383.771217158523;17469.65060698804;18466.722999155292;18726.15732292023;37517;42007.15985680208;42719.57280427156;43107.568924310355;43693;46869.29696054494;55250.72374638101;56031;56630.433695664164;56649.71675141598;5524.33707955048;8275.751727448187;8472.703455379033;8647.26498247656;8915.37592368528;10969.945150274198;12762.744745104861;12989.805152922525;13033.15284506504;13082.215067096005;11611.709707257387;11677.416129193676;11834.408279586158;11995.580154694544;12038.532100919465;11531.192816502764;11798.882011179778;11907.106966977684;11916.165868389477;12105.878941210827;11192.272502287326;11452.312861228353;11986.280823150639;12464.626061218178;12518.12373133872;7286;7564.281393267631;7600.923990760243;7724.227577242231;7841.607919604111;9826.213902887608;10881.347119172875;11352.489137988645;11478.794255143763;11703.180777345504 17:46:01 INFO - PROCESS | 16283 | |3;mootools.html;1502.9473968411105;1524.7484165112758;1694.9661006779866;1750.5186073829702;1846.8984205868671;8195.836083278331;8474.95762521188;8686.47881127132;9395.154436100749;9404.905950940489;8612.56937153143;8950.328725345593;8963.731088067369;8971.685990990316;8995.415298005624;2391.8445301055417;2414.987925060372;2417.8791060446997;2419.068658566447;2419.9395015124587;2097.4966008158085;2176.9129234830666;2338.5907466193435;2381.3451300892307;2398.436367453647;2224.733032036158;2296.781805728453;2365.5860224460653;2381.5475059738683;2402.8318017738766;2348.1546643208517;2353.0587764894008;2359.6460530920326;2359.7050368703913;2360.2093298745026;2333.56828986638;2372.454335502827;2373.41851246444;2373.727021392545;2378.2389635316704;9320.533973301375;9353.204977576914;9382.85925711115;9399.859002114974;9400.106989835955;5357.598180136505;5575.330960284751;5581.358143813432;5596.384397716248;5631.465010823965;3239.1902024493875;3300.5709257796334;3406.880759173417;3453.533772940646;3473.8263086845554;1128.8193888977723;1130.9943450282778;1137.4824454873096;1141.5490881102;1167.6438686200706;13130.606081817465;13175.86824131756;13199.340032998312;13215.20708757468;13215.537456188988;4755.006896688125;4758.95241047592;4773.164696178155;4881.95118048822;4914.385701787277;11038.11695064393;11041.944790275997;11048.558057677603;11053.115750739922;11054.944725276322;5554.361248456479;5557.166425036277;5561;5565.332160140809;5570.610057296031;5039.21892106724;5078.923816142761;5107.668001579959;5158.767855446514;5191.61062920275;4029.5567487576345;4132.690048246393;4172.937405938914;4185.707000509935;4248.320268756984;1312.2192295584111;1318.6176008957295;1322.2198902647485;1331.084924016401;1361.1356788439412;724.9818754531179;837.2799392522426;964.7588102974256;985.1970643925322;1026.3277553202665;6007.669578173155;6179.219351291847;6300.936990630126;6412.134361861183;6520.315366886503;906.1029580715044;907.686848037426;909.0364213933252;961.1109723505868;970.5244430229137;4019.9196016079513;4291.270484017725;4315.6763242756915;4379.1241751649795;4440.62254708347;11426.88573114275;11905.880941190651;11924.224925379822;11931.224470409568;11935.641930742091;11340.206185567096;11594.942025289989;11732.648020559396;11792.705182370339;11850.703732406759;8614.39699221061;8630.870536942077;8721.738347849574;8728.956355218183;8739.257163141205;6049.334573197033;6128.233970753656;6145.84635384119;6236.781712640036;6266.530010249158;10097.747556311151;10181.440020798927;10258.585415024198;10538.631147910093;10592.841107383549;10324.328918620266;10517.316374435637;10634.30876992993;10791.784164316512;10799.460026998462;7867.921320786719;8057.637406316612;8113.716019939274;8124.471909325875;8129.593520324079;8615.009273933578;8617.138286171332;8687.782805429915;8693.39146259781;9000.684976025808;6815.284395138439;7930.405219608668;7996.600169991593;8116.513009219466;8166;7677.961610191914;7853.37173026168;7887.329576986021;7991.120976692443;8059.073206581318;7239.8914016288745;7388.81778915371;7390.593517356597;7391.004428804085;7392.667329970272;4940.209566469348;5260.079486089995;5342.545883599782;5405.351357837085;5549.1676248563035;5266.368035835571;5275.683458992473;5323.840284791462;5380.838574842761;5502.174673798962 17:46:01 INFO - PROCESS | 16283 | |4;prototype.html;319.2768379620159;332.6108453109861;339.86654507218424;341.55768280077297;344.89308314422544;5068.341115654965;5236.397814251358;5276.393214780302;5281.445448227933;5321.308229930104;5165.8303512524735;5177.818776342829;5194.480551944804;5203.739813009353;5246.1606143017125;4060.776657283848;4090.89772755682;4102.282100632392;4104.897377565555;4129.421880936671;3961.3463778476516;4075.4090656854737;4125.649319807805;4136.358864376011;4148.730332528391;4086.8773936781945;4094.222097801423;4103.671706263507;4110.794460276974;4112.773797441139;4091.7340372875815;4113.670906327517;4124.278251306025;4125;4128.142335948835;3619.1314084619767;3689.4834723138515;3692.5568931728094;3695.1870588470492;3695.815209239527;5008.8998220035755;5022.146235140035;5046.772895219724;5054.873628159326;5074.416442109168;4674.532546745332;4677.4620918594455;4689.155951928651;4693.624510039189;4700.412448443944;5225.843224703227;5261.5790736741355;5327.973360133214;5331.493508116722;5355.357357117132;3991.501062367204;4021.5978402159844;4023.637872591481;4024.2756303865294;4057.1277175407135;5320.76056577455;5390.865228369283;5609.569559762275;5632.493075623213;5634.549236061146;4063.715539912237;4079.265732168238;4100.7334523255895;4116.423700681907;4117.794110294533;4110;4116.444280022159;4129.091599848029;4135.669146468275;4151.564085771011;4491.618212451913;4718.764061796896;4727.338172655831;4749.810007599657;4751.4535828379485;5463.644863083887;5465.262189604432;5466.180072989084;5476.91784623231;5493.340799104053;1426.9215193164475;1449.7752848308528;1455.0905683947533;1455.1123814473162;1459.6350912271932;910.7450494570362;938.1603464898877;949.0556895888635;952.8046750416148;966.7873067925045;4634.930476042795;4643.2802915548145;4718.664261190733;4721.1672996202005;4721.3390125382475;4877.365942427533;4901.975490122527;4906.239532872339;4952.6227410842275;4961.70229786214;4706.388169538007;4720.8433933686465;4736.005438857878;4737.905241895142;4891.853244402673;2920.7225313595172;2971.762259019273;2976.749765098664;2980.925476863096;2986.4176485585535;5797.304323481209;5817;5820.380828627135;5853.268341457318;5869.677167755729;5580.972095139579;5744.942550574524;5746.683932383759;5784.768609255667;5800.404888655654;5764.625299355528;5778.451047150514;5784.623999440023;5804.912926306109;5819.359870414336;5335.932813437251;5575.832725018094;5594.9720251398485;5617.8033768817895;5618.494335509824;5513.173024046425;5574.442555744556;5580.414056524007;5588.441155884379;5596.664200148004;5539.473749993744;5620.634658747168;5762.135679648086;5802.419758024333;5816.331121921034;4025.376066709665;4048.554658987568;4056.269871423172;4074.4703188585295;4116;5593.496585307342;5624;5676;5689.516391106802;5730.3410107838135;5240.528352448298;5482;5485.75314110858;5496;5510.724463776875;5446.564274858081;5455.645383050089;5458.590605704668;5459.890802184013;5498.477644623755;5282.339707536558;5450.247624949375;5473.945260547503;5499.50504454601;5522.530584900168;5531.834044978657;5534.7786088556;5544.251526044094;5553.333599968029;5553.694546799803;5422.972885135549;5426.782928682808;5452.337037203691;5454.672719636835;5462.617616766788 17:46:01 INFO - PROCESS | 16283 | |5;yui.html;752.4732687119016;760.9048868891389;769.7729169894881;787.3937068457292;819.6352623082729;13281.335933203338;13710.17738935662;13728.862711372896;13735.107218030846;14340.641483962892;13239.80140297894;13334.266615336153;13337.866621333784;13375.464981400732;13379.732405351911;653.3597074866634;780.6096951524238;782.917793631669;802.6428239433454;806.9233422824823;801.4470015689185;813.2639960835423;813.4956327077191;814.1085511365046;819.2831272636444;849.4096602861014;855.7646647172046;861.2808305065247;862.9482231066156;863.4560227056945;851.0085750101125;851.8977722673256;851.9744407667749;852.0669866496207;852.1691350932853;501.45551700761564;597.357840321656;613.3498491598875;619.6313193649771;620.7734177025353;13001.284929328884;13037;13069.607911762663;13075.803862942064;13085.738285234338;13742.725145497034;14724;14745.336459859225;14750.188739619316;14799.112053276838;12161.756764864653;12232.388380581024;12330.884039042547;12335.629931102081;12352.135350525466;4169.624733773944;4207.91584168318;4235.555266697014;4243.130158317537;4378.6934914555995;79748.60125699392;79924.20075799225;81630.18369816286;84461;84465;10074.244431667654;10221.284510084222;10632.46837658114;10761.461926903623;11306.038986686059;20841.79158208429;20899.68650470244;20963.79036209649;20974.47563810917;21081.262155824472;7956.363490920712;8177.79555511117;8213.34293256538;8284.751457456287;8398.17400697944;4391.253486907233;4392.341148827638;4455;4560.4071470708595;4716.551927566876;3566.233259849145;3710.870119545803;3711.31340701971;3712.276106159273;3714.1643130295465;613.9815805525841;623.544812287033;630.2468550082699;636.2047440699126;665.4011389749168;522.1488972974028;625.8216408323697;632.4560877645222;675.4596322941627;683.0744341417408;8093.433459657767;8593.613287402082;8843;8856.468611883307;8887.511186884654;508.8956763863399;518.9584833213333;532.0688794609433;647.9115086654372;709.6948312225793;3869.6710779583486;4093;4170.541240463546;4212.262854000538;4238.23711731885;130164;132105;132597;132823;134516;110797;112647;113568.43215783869;117707;119233.09586301712;99479;100655;100914.49542752386;102722.48638756758;106015;7805.921940780519;7891;7935.6032198391;8144.592770361577;8227.71203007892;43280;45700.771496142304;49883.75058124686;51339.743301283255;51450.74274628753;73982;75470;76869;78095.60952195202;79967.60016199882;13234.735305293647;13471.191728496322;13774.173549587056;13829.51596694111;14054.367553460323;14150.43398264058;14359.425622974964;14556.49052283165;15028.248587570797;15131.167785771888;13171.736565268833;13247.20516768997;13449;13824.93087534596;14252.358643860844;10199.898001019896;12116.515339386326;12227.205231659913;12456.501739930301;13123.146995445266;12457.501699931901;12733;12897.161684490478;12962.787094194613;13158;10221;10232.334898231591;10348.172146228133;10380.948095259475;10917.39954302521;10545.31455455393;10563.313384629975;10754.784904301714;10775.946120269662;10926.125909927028 17:46:01 INFO - PROCESS | 16283 | __end_tp_report 17:46:01 INFO - PROCESS | 16283 | __start_cc_report 17:46:01 INFO - PROCESS | 16283 | _x_x_mozilla_cycle_collect,888 17:46:01 INFO - PROCESS | 16283 | __end_cc_report 17:46:01 INFO - PROCESS | 16283 | __startTimestamp1472863561678__endTimestamp 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | ------- Summary: start ------- 17:46:01 INFO - PROCESS | 16283 | Number of tests: 6 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | [#0] dojo.html Cycles:165 Average:5207.09 Median:5419.73 stddev:570.38 (10.5%) stddev-sans-first:544.70 17:46:01 INFO - PROCESS | 16283 | Values: 2979.3 2980.5 3001.6 3037.7 3059.0 5130.2 5226.5 5237.9 5282.2 5322.7 5233.3 5275.0 5297.8 5310.1 5344.3 4747.2 4775.6 4806.9 4825.4 4891.3 4805.1 4885.8 4933.2 4953.6 4956.6 4890.1 4894.3 4898.9 4906.4 4937.7 4725.9 4747.8 4755.9 4795.1 4812.0 4708.3 4725.7 4745.6 4850.4 4851.2 5219.3 5238.8 5268.9 5273.1 5336.8 5444.2 5447.1 5585.7 5591.8 5595.1 5546.3 5555.1 5555.7 5583.9 5637.7 5144.8 5204.6 5207.7 5213.6 5215.0 5528.4 5628.5 5695.9 5702.3 5704.9 5460.5 5475.6 5479.1 5507.3 5550.9 5555.0 5564.2 5566.2 5571.3 5575.5 5449.5 5508.1 5557.5 5599.9 5621.8 5572.9 5578.0 5579.7 5627.8 5645.4 4345.9 4349.8 4350.6 4357.7 4403.4 3822.3 3839.4 3847.2 3890.1 3913.1 5308.5 5309.4 5310.1 5367.7 5368.5 5576.8 5600.4 5607.3 5607.4 5612.4 5196.0 5229.6 5266.7 5296.7 5372.0 4829.3 4832.5 4834.1 4868.8 4891.7 5784.1 5791.0 5801.1 5804.8 5865.2 5477.6 5516.4 5517.8 5604.3 5610.0 5722.7 5737.9 5745.1 5803.0 5812.7 5404.7 5456.8 5459.1 5465.7 5470.7 5468.9 5504.9 5523.4 5549.8 5560.9 5452.2 5454.9 5457.1 5499.4 5531.6 5419.2 5419.7 5422.3 5428.3 5492.3 5188.0 5389.5 5401.6 5426.2 5427.6 5600.5 5602.1 5606.7 5635.4 5659.2 5376.9 5415.2 5423.6 5426.3 5434.7 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | [#1] ext.html Cycles:180 Average:57219.83 Median:213148.81 stddev:108794.58 (51.0%) stddev-sans-first:109016.61 17:46:01 INFO - PROCESS | 16283 | Values: 563.4 591.8 615.0 622.7 629.7 35354.3 43375.8 44581.8 44683.8 48171.8 45892.1 46264.3 46300.5 46368.5 46408.0 8097.8 8890.4 9026.9 9043.1 9050.0 10584.3 10891.4 10893.9 11253.3 11257.5 10999.1 11093.3 11102.9 11104.9 11105.6 10886.3 10903.7 10940.8 10944.5 10950.3 10734.9 10778.6 10800.0 10804.4 10809.5 42911.4 42967.8 43307.6 43340.6 43371.6 3468.6 3510.4 3691.7 3897.6 4230.6 32177.8 32520.5 32988.0 33019.5 33119.8 4166.6 4246.1 4257.2 4310.7 4444.2 256275.0 256819.0 257254.0 258683.0 258947.0 58218.0 59387.1 59658.7 59680.4 59813.0 62730.7 62998.7 63063.4 63145.4 63186.0 17235.0 17555.0 17558.0 17560.7 17566.1 11637.2 12589.9 13491.7 13683.0 13695.2 16655.8 17158.1 17203.3 17411.6 17437.0 6015.8 6048.5 6050.3 6085.7 6194.4 967.8 1023.4 1039.5 1088.2 1112.9 31371.7 32704.7 33070.2 33502.1 33755.5 1105.3 1122.7 1148.4 1154.2 1155.0 16309.2 17046.7 17107.6 17181.7 17188.6 532915.0 535860.0 536987.0 537422.0 538569.0 58046.0 58184.4 58267.4 58331.4 58341.0 1232.6 1308.5 1338.1 1349.5 1366.5 31704.7 32886.3 33642.8 33904.2 34401.7 50749.7 51464.0 51465.5 51470.5 51491.7 388727.0 389194.0 389990.0 390546.0 390810.0 27641.5 28860.9 28864.7 29621.3 29698.3 47301.0 48109.5 48429.0 48733.8 49887.8 40376.6 40677.2 41655.1 41722.6 42870.4 40523.6 41088.8 41225.2 41839.0 42993.4 40490.6 41609.8 41820.4 42408.4 42579.0 32373.0 36785.8 37570.6 43775.6 46080.0 33195.7 33991.8 36592.1 36923.6 37120.6 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | [#2] jquery.html Cycles:180 Average:25904.94 Median:185397.09 stddev:68731.84 (37.1%) stddev-sans-first:68897.92 17:46:01 INFO - PROCESS | 16283 | Values: 372.2 392.6 403.8 404.6 414.2 16062.5 19040.9 19264.7 20135.6 20195.6 19609.7 19797.5 19847.4 20037.8 20074.9 5251.8 5714.5 5899.6 5929.4 5958.5 5826.1 5901.4 5910.2 5913.0 5916.3 5790.2 6034.0 6344.4 6344.4 6467.9 6258.3 6361.5 6455.7 6485.3 6489.8 5713.6 5714.8 5719.3 5721.5 5726.7 14043.6 14060.9 14075.9 14182.4 14305.4 2226.2 2240.7 2257.2 2266.9 2793.3 10081.3 10252.1 10675.5 10678.0 11182.9 1884.4 1898.6 1948.4 1953.5 1979.7 78726.0 83546.6 83655.2 84705.0 85510.0 9317.3 9564.9 9743.2 9870.8 9980.9 12963.9 13002.9 13004.2 13054.3 13065.5 7423.9 7739.7 8001.9 8278.7 8311.3 8125.5 8232.8 8256.1 8317.0 8426.7 4116.9 4118.5 4121.2 4187.4 4280.1 1780.9 1872.6 1899.6 1907.4 1954.3 939.6 941.7 995.0 997.5 1073.8 19555.6 19927.6 19966.0 20005.5 20143.6 950.8 990.5 1002.4 1004.7 1018.7 10302.1 10527.5 11137.5 11169.3 11206.5 367033.0 368526.0 370422.0 456656.0 496618.0 54603.7 56289.7 59260.4 93885.5 101465.0 972.8 1020.6 1044.6 1052.5 1067.5 11678.8 16383.8 17469.7 18466.7 18726.2 37517.0 42007.2 42719.6 43107.6 43693.0 46869.3 55250.7 56031.0 56630.4 56649.7 5524.3 8275.8 8472.7 8647.3 8915.4 10969.9 12762.7 12989.8 13033.2 13082.2 11611.7 11677.4 11834.4 11995.6 12038.5 11531.2 11798.9 11907.1 11916.2 12105.9 11192.3 11452.3 11986.3 12464.6 12518.1 7286.0 7564.3 7600.9 7724.2 7841.6 9826.2 10881.3 11352.5 11478.8 11703.2 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | [#3] mootools.html Cycles:180 Average:6054.94 Median:4927.30 stddev:3500.39 (71.0%) stddev-sans-first:3493.50 17:46:01 INFO - PROCESS | 16283 | Values: 1502.9 1524.7 1695.0 1750.5 1846.9 8195.8 8475.0 8686.5 9395.2 9404.9 8612.6 8950.3 8963.7 8971.7 8995.4 2391.8 2415.0 2417.9 2419.1 2419.9 2097.5 2176.9 2338.6 2381.3 2398.4 2224.7 2296.8 2365.6 2381.5 2402.8 2348.2 2353.1 2359.6 2359.7 2360.2 2333.6 2372.5 2373.4 2373.7 2378.2 9320.5 9353.2 9382.9 9399.9 9400.1 5357.6 5575.3 5581.4 5596.4 5631.5 3239.2 3300.6 3406.9 3453.5 3473.8 1128.8 1131.0 1137.5 1141.5 1167.6 13130.6 13175.9 13199.3 13215.2 13215.5 4755.0 4759.0 4773.2 4882.0 4914.4 11038.1 11041.9 11048.6 11053.1 11054.9 5554.4 5557.2 5561.0 5565.3 5570.6 5039.2 5078.9 5107.7 5158.8 5191.6 4029.6 4132.7 4172.9 4185.7 4248.3 1312.2 1318.6 1322.2 1331.1 1361.1 725.0 837.3 964.8 985.2 1026.3 6007.7 6179.2 6300.9 6412.1 6520.3 906.1 907.7 909.0 961.1 970.5 4019.9 4291.3 4315.7 4379.1 4440.6 11426.9 11905.9 11924.2 11931.2 11935.6 11340.2 11594.9 11732.6 11792.7 11850.7 8614.4 8630.9 8721.7 8729.0 8739.3 6049.3 6128.2 6145.8 6236.8 6266.5 10097.7 10181.4 10258.6 10538.6 10592.8 10324.3 10517.3 10634.3 10791.8 10799.5 7867.9 8057.6 8113.7 8124.5 8129.6 8615.0 8617.1 8687.8 8693.4 9000.7 6815.3 7930.4 7996.6 8116.5 8166.0 7678.0 7853.4 7887.3 7991.1 8059.1 7239.9 7388.8 7390.6 7391.0 7392.7 4940.2 5260.1 5342.5 5405.4 5549.2 5266.4 5275.7 5323.8 5380.8 5502.2 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | [#4] prototype.html Cycles:180 Average:4577.32 Median:5120.12 stddev:1322.01 (25.8%) stddev-sans-first:1286.51 17:46:01 INFO - PROCESS | 16283 | Values: 319.3 332.6 339.9 341.6 344.9 5068.3 5236.4 5276.4 5281.4 5321.3 5165.8 5177.8 5194.5 5203.7 5246.2 4060.8 4090.9 4102.3 4104.9 4129.4 3961.3 4075.4 4125.6 4136.4 4148.7 4086.9 4094.2 4103.7 4110.8 4112.8 4091.7 4113.7 4124.3 4125.0 4128.1 3619.1 3689.5 3692.6 3695.2 3695.8 5008.9 5022.1 5046.8 5054.9 5074.4 4674.5 4677.5 4689.2 4693.6 4700.4 5225.8 5261.6 5328.0 5331.5 5355.4 3991.5 4021.6 4023.6 4024.3 4057.1 5320.8 5390.9 5609.6 5632.5 5634.5 4063.7 4079.3 4100.7 4116.4 4117.8 4110.0 4116.4 4129.1 4135.7 4151.6 4491.6 4718.8 4727.3 4749.8 4751.5 5463.6 5465.3 5466.2 5476.9 5493.3 1426.9 1449.8 1455.1 1455.1 1459.6 910.7 938.2 949.1 952.8 966.8 4634.9 4643.3 4718.7 4721.2 4721.3 4877.4 4902.0 4906.2 4952.6 4961.7 4706.4 4720.8 4736.0 4737.9 4891.9 2920.7 2971.8 2976.7 2980.9 2986.4 5797.3 5817.0 5820.4 5853.3 5869.7 5581.0 5744.9 5746.7 5784.8 5800.4 5764.6 5778.5 5784.6 5804.9 5819.4 5335.9 5575.8 5595.0 5617.8 5618.5 5513.2 5574.4 5580.4 5588.4 5596.7 5539.5 5620.6 5762.1 5802.4 5816.3 4025.4 4048.6 4056.3 4074.5 4116.0 5593.5 5624.0 5676.0 5689.5 5730.3 5240.5 5482.0 5485.8 5496.0 5510.7 5446.6 5455.6 5458.6 5459.9 5498.5 5282.3 5450.2 5473.9 5499.5 5522.5 5531.8 5534.8 5544.3 5553.3 5553.7 5423.0 5426.8 5452.3 5454.7 5462.6 17:46:01 INFO - PROCESS | 16283 | 17:46:01 INFO - PROCESS | 16283 | [#5] yui.html Cycles:180 Average:21966.52 Median:4131.31 stddev:34091.63 (825.2%) stddev-sans-first:34150.06 17:46:01 INFO - PROCESS | 16283 | Values: 752.5 760.9 769.8 787.4 819.6 13281.3 13710.2 13728.9 13735.1 14340.6 13239.8 13334.3 13337.9 13375.5 13379.7 653.4 780.6 782.9 802.6 806.9 801.4 813.3 813.5 814.1 819.3 849.4 855.8 861.3 862.9 863.5 851.0 851.9 852.0 852.1 852.2 501.5 597.4 613.3 619.6 620.8 13001.3 13037.0 13069.6 13075.8 13085.7 13742.7 14724.0 14745.3 14750.2 14799.1 12161.8 12232.4 12330.9 12335.6 12352.1 4169.6 4207.9 4235.6 4243.1 4378.7 79748.6 79924.2 81630.2 84461.0 84465.0 10074.2 10221.3 10632.5 10761.5 11306.0 20841.8 20899.7 20963.8 20974.5 21081.3 7956.4 8177.8 8213.3 8284.8 8398.2 4391.3 4392.3 4455.0 4560.4 4716.6 3566.2 3710.9 3711.3 3712.3 3714.2 614.0 623.5 630.2 636.2 665.4 522.1 625.8 632.5 675.5 683.1 8093.4 8593.6 8843.0 8856.5 8887.5 508.9 519.0 532.1 647.9 709.7 3869.7 4093.0 4170.5 4212.3 4238.2 130164.0 132105.0 132597.0 132823.0 134516.0 110797.0 112647.0 113568.4 117707.0 119233.1 99479.0 100655.0 100914.5 102722.5 106015.0 7805.9 7891.0 7935.6 8144.6 8227.7 43280.0 45700.8 49883.8 51339.7 51450.7 73982.0 75470.0 76869.0 78095.6 79967.6 13234.7 13471.2 13774.2 13829.5 14054.4 14150.4 14359.4 14556.5 15028.2 15131.2 13171.7 13247.2 13449.0 13824.9 14252.4 10199.9 12116.5 12227.2 12456.5 13123.1 12457.5 12733.0 12897.2 12962.8 13158.0 10221.0 10232.3 10348.2 10380.9 10917.4 10545.3 10563.3 10754.8 10775.9 10926.1 17:46:01 INFO - PROCESS | 16283 | -------- Summary: end -------- 17:46:01 INFO - PROCESS | 16283 | 17:46:02 INFO - TEST-INFO | 16283: exit 0 17:46:02 INFO - TEST-OK | dromaeo_css | took 1116500ms 17:46:02 INFO - TEST-START | kraken 17:46:02 INFO - operating with platform_type : linux_ 17:46:02 INFO - Initialising browser for kraken test... 17:46:02 INFO - TEST-INFO | started process 16586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlNF6A/profile http://localhost:59949/getInfo.html) 17:46:07 INFO - PROCESS | 16586 | __metrics Screen width/height:1600/1200 17:46:07 INFO - PROCESS | 16586 | colorDepth:24 17:46:07 INFO - PROCESS | 16586 | Browser inner width/height: 1024/697 17:46:07 INFO - PROCESS | 16586 | __metrics 17:46:07 INFO - PROCESS | 16586 | 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" 17:46:07 INFO - PROCESS | 16586 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:08 INFO - PROCESS | 16586 | console.error: PushService: 17:46:08 INFO - PROCESS | 16586 | stateChangeProcessEnqueue: Error transitioning state 17:46:08 INFO - PROCESS | 16586 | UnknownError 17:46:09 INFO - TEST-INFO | 16586: exit 0 17:46:09 INFO - Browser initialized. 17:46:09 INFO - Running cycle 1/1 for kraken test... 17:46:09 INFO - TEST-INFO | started process 16666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlNF6A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:21 INFO - PROCESS | 16666 | RSS: Main: 179228672 17:46:21 INFO - PROCESS | 16666 | 17:46:23 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59949/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:24 INFO - PROCESS | 16666 | RSS: Main: 233381888 17:46:24 INFO - PROCESS | 16666 | 17:46:27 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59949/tests/kraken/driver.html?testName=audio-dft) 17:46:27 INFO - PROCESS | 16666 | RSS: Main: 223588352 17:46:27 INFO - PROCESS | 16666 | 17:46:30 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59949/tests/kraken/driver.html?testName=audio-fft) 17:46:31 INFO - PROCESS | 16666 | RSS: Main: 300523520 17:46:31 INFO - PROCESS | 16666 | 17:46:33 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59949/tests/kraken/driver.html?testName=audio-oscillator) 17:46:34 INFO - PROCESS | 16666 | RSS: Main: 210911232 17:46:34 INFO - PROCESS | 16666 | 17:46:36 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59949/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:36 INFO - PROCESS | 16666 | RSS: Main: 213819392 17:46:36 INFO - PROCESS | 16666 | 17:46:39 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59949/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:40 INFO - PROCESS | 16666 | RSS: Main: 252112896 17:46:40 INFO - PROCESS | 16666 | 17:46:43 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59949/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:44 INFO - PROCESS | 16666 | RSS: Main: 251699200 17:46:44 INFO - PROCESS | 16666 | 17:46:47 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59949/tests/kraken/driver.html?testName=json-parse-financial) 17:46:47 INFO - PROCESS | 16666 | RSS: Main: 251723776 17:46:47 INFO - PROCESS | 16666 | 17:46:49 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59949/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:49 INFO - PROCESS | 16666 | RSS: Main: 213626880 17:46:49 INFO - PROCESS | 16666 | 17:46:51 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:52 INFO - PROCESS | 16666 | RSS: Main: 221192192 17:46:52 INFO - PROCESS | 16666 | 17:46:54 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:55 INFO - PROCESS | 16666 | RSS: Main: 222892032 17:46:55 INFO - PROCESS | 16666 | 17:46:57 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:58 INFO - PROCESS | 16666 | RSS: Main: 217333760 17:46:58 INFO - PROCESS | 16666 | 17:47:01 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:01 INFO - PROCESS | 16666 | RSS: Main: 221097984 17:47:01 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | Cycle 1(1): loaded http://localhost:59949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59949/tests/kraken/driver.html?testName=ai-astar) 17:47:03 INFO - PROCESS | 16666 | RSS: Main: 271708160 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | __start_tp_report 17:47:03 INFO - PROCESS | 16666 | _x_x_mozilla_page_load 17:47:03 INFO - PROCESS | 16666 | _x_x_mozilla_page_load_details 17:47:03 INFO - PROCESS | 16666 | |i|pagename|runs| 17:47:03 INFO - PROCESS | 16666 | |0;ai-astar;112;112;117;110;113;114;111;111;112;128 17:47:03 INFO - PROCESS | 16666 | |1;audio-beat-detection;149;116;142;181;121;151;146;124;181;121 17:47:03 INFO - PROCESS | 16666 | |2;audio-dft;161;162;160;160;162;162;161;160;161;161 17:47:03 INFO - PROCESS | 16666 | |3;audio-fft;75;75;74;190;77;76;74;75;160;80 17:47:03 INFO - PROCESS | 16666 | |4;audio-oscillator;83;82;146;82;83;82;133;83;83;143 17:47:03 INFO - PROCESS | 16666 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;118;118 17:47:03 INFO - PROCESS | 16666 | |6;imaging-darkroom;146;145;146;145;146;145;146;145;145;146 17:47:03 INFO - PROCESS | 16666 | |7;imaging-desaturate;96;95;95;96;96;96;95;95;95;95 17:47:03 INFO - PROCESS | 16666 | |8;json-parse-financial;51;51;52;52;52;52;52;52;52;52 17:47:03 INFO - PROCESS | 16666 | |9;json-stringify-tinderbox;61;62;62;61;61;62;60;60;61;61 17:47:03 INFO - PROCESS | 16666 | |10;stanford-crypto-aes;80;78;79;79;79;87;81;87;84;79 17:47:03 INFO - PROCESS | 16666 | |11;stanford-crypto-ccm;125;127;132;132;138;125;123;131;212;123 17:47:03 INFO - PROCESS | 16666 | |12;stanford-crypto-pbkdf2;164;162;170;165;162;165;164;164;163;167 17:47:03 INFO - PROCESS | 16666 | |13;stanford-crypto-sha256-iterative;69;70;65;64;67;66;67;69;68;66 17:47:03 INFO - PROCESS | 16666 | __end_tp_report 17:47:03 INFO - PROCESS | 16666 | __start_cc_report 17:47:03 INFO - PROCESS | 16666 | _x_x_mozilla_cycle_collect,1704 17:47:03 INFO - PROCESS | 16666 | __end_cc_report 17:47:03 INFO - PROCESS | 16666 | __startTimestamp1472863623720__endTimestamp 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | ------- Summary: start ------- 17:47:03 INFO - PROCESS | 16666 | Number of tests: 14 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#0] ai-astar Cycles:10 Average:114.00 Median:112.50 stddev:5.29 (4.7%) stddev-sans-first:5.56 17:47:03 INFO - PROCESS | 16666 | Values: 112.0 112.0 117.0 110.0 113.0 114.0 111.0 111.0 112.0 128.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:147.50 stddev:23.70 (16.1%) stddev-sans-first:25.05 17:47:03 INFO - PROCESS | 16666 | Values: 149.0 116.0 142.0 181.0 121.0 151.0 146.0 124.0 181.0 121.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 17:47:03 INFO - PROCESS | 16666 | Values: 161.0 162.0 160.0 160.0 162.0 162.0 161.0 160.0 161.0 161.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.00 stddev:42.48 (56.6%) stddev-sans-first:44.39 17:47:03 INFO - PROCESS | 16666 | Values: 75.0 75.0 74.0 190.0 77.0 76.0 74.0 75.0 160.0 80.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:82.50 stddev:28.25 (34.2%) stddev-sans-first:29.28 17:47:03 INFO - PROCESS | 16666 | Values: 83.0 82.0 146.0 82.0 83.0 82.0 133.0 83.0 83.0 143.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:47:03 INFO - PROCESS | 16666 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 118.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:47:03 INFO - PROCESS | 16666 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:47:03 INFO - PROCESS | 16666 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 17:47:03 INFO - PROCESS | 16666 | Values: 51.0 51.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 17:47:03 INFO - PROCESS | 16666 | Values: 61.0 62.0 62.0 61.0 61.0 62.0 60.0 60.0 61.0 61.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:3.43 (4.3%) stddev-sans-first:3.61 17:47:03 INFO - PROCESS | 16666 | Values: 80.0 78.0 79.0 79.0 79.0 87.0 81.0 87.0 84.0 79.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:131.50 stddev:26.86 (20.4%) stddev-sans-first:28.14 17:47:03 INFO - PROCESS | 16666 | Values: 125.0 127.0 132.0 132.0 138.0 125.0 123.0 131.0 212.0 123.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:2.41 (1.5%) stddev-sans-first:2.55 17:47:03 INFO - PROCESS | 16666 | Values: 164.0 162.0 170.0 165.0 162.0 165.0 164.0 164.0 163.0 167.0 17:47:03 INFO - PROCESS | 16666 | 17:47:03 INFO - PROCESS | 16666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.91 (2.8%) stddev-sans-first:1.90 17:47:03 INFO - PROCESS | 16666 | Values: 69.0 70.0 65.0 64.0 67.0 66.0 67.0 69.0 68.0 66.0 17:47:03 INFO - PROCESS | 16666 | -------- Summary: end -------- 17:47:03 INFO - PROCESS | 16666 | 17:47:04 INFO - TEST-INFO | 16666: exit 0 17:47:04 INFO - TEST-OK | kraken | took 62388ms 17:47:04 INFO - SUITE-END | took 1178s 17:47:05 INFO - Completed test suite (00:19:39) 17:47:05 INFO - javascript benchmark 17:47:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.3147576057504, 2980.5231163013914, 3001.6247969003875, 3037.6810434904346, 3058.9847050764743, 5130.153524668434, 5226.451222621627, 5237.895242095161, 5282.154855223161, 5322.654027488211, 5233.319668443107, 5275.024120537693, 5297.761600727967, 5310.07073762092, 5344.251804747329, 4747.1692453820615, 4775.594074503671, 4806.879828004293, 4825.396825396825, 4891.339669144655, 4805.135075686375, 4885.755712214375, 4933.235348520985, 4953.628477864157, 4956.628252881031, 4890.119778439879, 4894.3147959285725, 4898.877528061791, 4906.411230652309, 4937.654364194508, 4725.8582242532775, 4747.7626118693925, 4755.904881902377, 4795.064962332347, 4811.975940120312, 4708.317293992352, 4725.692829966041, 4745.620350371996, 4850.442199147073, 4851.151048566522, 5219.347581552306, 5238.842834714965, 5268.947310526923, 5273.129933560957, 5336.825898302367, 5444.210589464506, 5447.101228297326, 5585.664860108366, 5591.832245032656, 5595.076812326002, 5546.278983732089, 5555.055640541118, 5555.694436805974, 5583.860403489945, 5637.689927054011, 5144.845654630367, 5204.635675502755, 5207.739613019334, 5213.6089793265655, 5215.0, 5528.44715528444, 5628.465295796893, 5695.914561281584, 5702.344230413472, 5704.914426283609, 5460.535854452337, 5475.6440831345835, 5479.068558345091, 5507.284053073075, 5550.944490555124, 5555.027870122713, 5564.221009058735, 5566.2207290979295, 5571.275734154534, 5575.470330318613, 5449.536789372948, 5508.091164957817, 5557.472040156179, 5599.916001259984, 5621.831345059655, 5572.888542229132, 5578.0, 5579.721013949286, 5627.831165065055, 5645.379008309083, 4345.869623911288, 4349.826006959749, 4350.630196433275, 4357.67317451186, 4403.383526306319, 3822.2928758179823, 3839.404892241707, 3847.153626202231, 3890.0663840678035, 3913.1391093959282, 5308.46915308466, 5309.41596424393, 5310.097283461821, 5367.651102678392, 5368.489993450616, 5576.804811831566, 5600.439956004367, 5607.299087614048, 5607.43925607436, 5612.410696876851, 5195.974020129951, 5229.633925625246, 5266.710330931835, 5296.682199068068, 5372.0, 4829.348038014823, 4832.4684284728655, 4834.105690447279, 4868.78090485929, 4891.6575839691595, 5784.074548072288, 5791.044477661138, 5801.129830525455, 5804.82585522435, 5865.237519122486, 5477.616566840283, 5516.393196748435, 5517.834464966058, 5604.271444712162, 5610.0, 5722.656640601577, 5737.885242295214, 5745.052066408995, 5803.0, 5812.709364531841, 5404.729888476283, 5456.7544460498575, 5459.071957767269, 5465.69938653362, 5470.699111548903, 5468.945310547003, 5504.91742623869, 5523.392426833126, 5549.7780088796, 5560.9337418537625, 5452.2094296327605, 5454.945450545444, 5457.126859702428, 5499.3675727291875, 5531.612787104864, 5419.214213938878, 5419.729013549386, 5422.349318081855, 5428.348598168245, 5492.3409190895745, 5187.974060129675, 5389.461053894579, 5401.594880383908, 5426.186072089218, 5427.6472029317965, 5600.467955544217, 5602.13166959122, 5606.691631960118, 5635.380108188178, 5659.151127330933, 5376.919346209888, 5415.187721841755, 5423.62034657586, 5426.348838139448, 5434.701091439851], "value": 5169.359085782393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3577721397605, 591.7544219149054, 614.9883441738343, 622.7477871462058, 629.719774700258, 35354.292914141704, 43375.78312108439, 44581.7770911145, 44683.77658111713, 48171.759141204246, 45892.08215835681, 46264.30603540949, 46300.53699463004, 46368.53631463684, 46408.0, 8097.797555061112, 8890.42212256203, 9026.86459703105, 9043.050479699636, 9050.0, 10584.312019718695, 10891.400972946485, 10893.945530272376, 11253.324800511955, 11257.493412796402, 10999.120070394389, 11093.33439993599, 11102.944485277561, 11104.888951110506, 11105.611303604375, 10886.346819190834, 10903.727406814814, 10940.781184376348, 10944.537479067225, 10950.34297942122, 10734.946325268324, 10778.568857245778, 10800.027997480185, 10804.351738895613, 10809.513571889283, 42911.35632965508, 42967.78516107431, 43307.56692433098, 43340.56659433428, 43371.56628433707, 3468.6011108722314, 3510.350585141757, 3691.7136917136704, 3897.629725176132, 4230.640395566381, 32177.83911080453, 32520.512192317135, 32988.0, 33019.504707429405, 33119.83440082784, 4166.604172603597, 4246.129543443618, 4257.169851878885, 4310.741355518648, 4444.177827101964, 256275.0, 256819.0, 257254.0, 258683.0, 258947.0, 58218.0, 59387.109193362136, 59658.70170649119, 59680.40319596748, 59813.0, 62730.68634656798, 62998.68500657559, 63063.369366306666, 63145.36854631395, 63186.0, 17235.0, 17555.0, 17558.0, 17560.736588951175, 17566.12169391551, 11637.185397022296, 12589.87410125887, 13491.730165396637, 13683.0, 13695.178289302674, 16655.83344166567, 17158.142092895556, 17203.311867525408, 17411.56471088233, 17437.0, 6015.789447369321, 6048.524092171761, 6050.30421501533, 6085.695715214221, 6194.38056194386, 967.8403063494444, 1023.3501726403787, 1039.5270152080784, 1088.211046990941, 1112.8775834658181, 31371.686283137333, 32704.672953270638, 33070.17324566905, 33502.12700015494, 33755.49366759501, 1105.309181761399, 1122.747381839096, 1148.3798748675788, 1154.2151337090859, 1154.9711257218637, 16309.184540772914, 17046.74429883553, 17107.572310692332, 17181.7422738659, 17188.570285742706, 532915.0, 535860.0, 536987.0, 537422.0, 538569.0, 58046.0, 58184.41815581875, 58267.4173258262, 58331.4166858326, 58341.0, 1232.624049664843, 1308.463529952715, 1338.143588103595, 1349.5006847466304, 1366.4875671623142, 31704.682953170173, 32886.34227315488, 33642.831785840914, 33904.152271561004, 34401.65598344085, 50749.74625126851, 51464.0, 51465.485345146066, 51470.48529514657, 51491.74254128705, 388727.0, 389194.0, 389990.0, 390546.0, 390810.0, 27641.54480689914, 28860.855695721388, 28864.711352886203, 29621.25946851346, 29698.257543560718, 47301.0, 48109.5189048105, 48429.0, 48733.756331219534, 49887.75056124696, 40376.596234037286, 40677.186456270116, 41655.143598978124, 41722.58277417187, 42870.35694464648, 40523.59476405198, 41088.79455602703, 41225.175496489304, 41839.02529259716, 42993.355099674154, 40490.59509404868, 41609.79195104005, 41820.372694410216, 42408.36387454253, 42579.0, 32373.0, 36785.81607091947, 37570.624293756715, 43775.56224437715, 46080.0, 33195.66804331926, 33991.830040849636, 36592.0851978692, 36923.63076369202, 37120.628793711716], "value": 20619.97105009193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.18677190339093, 392.56229304325683, 403.826354667493, 404.629763766154, 414.1695899721059, 16062.51812445627, 19040.90479547604, 19264.711029334572, 20135.59728805423, 20195.59608807823, 19609.705854412194, 19797.50506237345, 19847.404577862686, 20037.799622003775, 20074.899625501854, 5251.763670634811, 5714.485696287344, 5899.557533185007, 5929.436703513159, 5958.463738263556, 5826.126081087849, 5901.409859014086, 5910.172575839386, 5912.9704351478185, 5916.290045194562, 5790.218320526738, 6034.0, 6344.365563443642, 6344.382182543445, 6467.902981455259, 6258.311585725566, 6361.459275961549, 6455.741770329181, 6485.319041500646, 6489.772857949973, 5713.5714821388565, 5714.79998200061, 5719.342275638313, 5721.4850663440075, 5726.656400615976, 14043.578692639237, 14060.859391406057, 14075.85924140766, 14182.361793719307, 14305.356258968372, 2226.2208227120377, 2240.7199100112484, 2257.1535674122206, 2266.875321857297, 2793.27374882532, 10081.344712593658, 10252.077313041862, 10675.519601617869, 10678.0, 11182.888171118348, 1884.387574038443, 1898.648749981244, 1948.39599724086, 1953.5116220944765, 1979.70304454333, 78726.0, 83546.58226708828, 83655.16344836535, 84705.0, 85510.0, 9317.254619630414, 9564.856527152098, 9743.220542356594, 9870.802583948282, 9980.852201996864, 12963.935180324226, 13002.869971300355, 13004.154729942524, 13054.34728263602, 13065.477380904656, 7423.888641670379, 7739.651715672809, 8001.919980800234, 8278.668853245803, 8311.33509319253, 8125.4718443301, 8232.8353432931, 8256.1331060239, 8316.972158526036, 8426.69386245133, 4116.938245926313, 4118.464599602033, 4121.155163191538, 4187.43469631602, 4280.101178752435, 1780.866435017379, 1872.5505878589313, 1899.629572233429, 1907.3801014670287, 1954.3257576136211, 939.5818860606964, 941.6657086734248, 995.0447570332417, 997.491279447487, 1073.822819234833, 19555.608887822164, 19927.60144797096, 19966.0, 20005.499862503555, 20143.597128057358, 950.8336041192764, 990.5146478225618, 1002.4486532407146, 1004.708634495988, 1018.6791160784329, 10302.124319432933, 10527.526261318259, 11137.498812553455, 11169.329840209452, 11206.49570769301, 367033.0, 368526.0, 370422.0, 456656.0, 496618.0, 54603.72698136563, 56289.7185514078, 59260.40739592635, 93885.53057234807, 101465.0, 972.8394814855469, 1020.5917632946732, 1044.6082718980383, 1052.5263631365915, 1067.4769363012224, 11678.824817627572, 16383.771217158523, 17469.65060698804, 18466.722999155292, 18726.15732292023, 37517.0, 42007.15985680208, 42719.57280427156, 43107.568924310355, 43693.0, 46869.29696054494, 55250.72374638101, 56031.0, 56630.433695664164, 56649.71675141598, 5524.33707955048, 8275.751727448187, 8472.703455379033, 8647.26498247656, 8915.37592368528, 10969.945150274198, 12762.744745104861, 12989.805152922525, 13033.15284506504, 13082.215067096005, 11611.709707257387, 11677.416129193676, 11834.408279586158, 11995.580154694544, 12038.532100919465, 11531.192816502764, 11798.882011179778, 11907.106966977684, 11916.165868389477, 12105.878941210827, 11192.272502287326, 11452.312861228353, 11986.280823150639, 12464.626061218178, 12518.12373133872, 7286.0, 7564.281393267631, 7600.923990760243, 7724.227577242231, 7841.607919604111, 9826.213902887608, 10881.347119172875, 11352.489137988645, 11478.794255143763, 11703.180777345504], "value": 8897.466399009503, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.9473968411105, 1524.7484165112758, 1694.9661006779866, 1750.5186073829702, 1846.8984205868671, 8195.836083278331, 8474.95762521188, 8686.47881127132, 9395.154436100749, 9404.905950940489, 8612.56937153143, 8950.328725345593, 8963.731088067369, 8971.685990990316, 8995.415298005624, 2391.8445301055417, 2414.987925060372, 2417.8791060446997, 2419.068658566447, 2419.9395015124587, 2097.4966008158085, 2176.9129234830666, 2338.5907466193435, 2381.3451300892307, 2398.436367453647, 2224.733032036158, 2296.781805728453, 2365.5860224460653, 2381.5475059738683, 2402.8318017738766, 2348.1546643208517, 2353.0587764894008, 2359.6460530920326, 2359.7050368703913, 2360.2093298745026, 2333.56828986638, 2372.454335502827, 2373.41851246444, 2373.727021392545, 2378.2389635316704, 9320.533973301375, 9353.204977576914, 9382.85925711115, 9399.859002114974, 9400.106989835955, 5357.598180136505, 5575.330960284751, 5581.358143813432, 5596.384397716248, 5631.465010823965, 3239.1902024493875, 3300.5709257796334, 3406.880759173417, 3453.533772940646, 3473.8263086845554, 1128.8193888977723, 1130.9943450282778, 1137.4824454873096, 1141.5490881102, 1167.6438686200706, 13130.606081817465, 13175.86824131756, 13199.340032998312, 13215.20708757468, 13215.537456188988, 4755.006896688125, 4758.95241047592, 4773.164696178155, 4881.95118048822, 4914.385701787277, 11038.11695064393, 11041.944790275997, 11048.558057677603, 11053.115750739922, 11054.944725276322, 5554.361248456479, 5557.166425036277, 5561.0, 5565.332160140809, 5570.610057296031, 5039.21892106724, 5078.923816142761, 5107.668001579959, 5158.767855446514, 5191.61062920275, 4029.5567487576345, 4132.690048246393, 4172.937405938914, 4185.707000509935, 4248.320268756984, 1312.2192295584111, 1318.6176008957295, 1322.2198902647485, 1331.084924016401, 1361.1356788439412, 724.9818754531179, 837.2799392522426, 964.7588102974256, 985.1970643925322, 1026.3277553202665, 6007.669578173155, 6179.219351291847, 6300.936990630126, 6412.134361861183, 6520.315366886503, 906.1029580715044, 907.686848037426, 909.0364213933252, 961.1109723505868, 970.5244430229137, 4019.9196016079513, 4291.270484017725, 4315.6763242756915, 4379.1241751649795, 4440.62254708347, 11426.88573114275, 11905.880941190651, 11924.224925379822, 11931.224470409568, 11935.641930742091, 11340.206185567096, 11594.942025289989, 11732.648020559396, 11792.705182370339, 11850.703732406759, 8614.39699221061, 8630.870536942077, 8721.738347849574, 8728.956355218183, 8739.257163141205, 6049.334573197033, 6128.233970753656, 6145.84635384119, 6236.781712640036, 6266.530010249158, 10097.747556311151, 10181.440020798927, 10258.585415024198, 10538.631147910093, 10592.841107383549, 10324.328918620266, 10517.316374435637, 10634.30876992993, 10791.784164316512, 10799.460026998462, 7867.921320786719, 8057.637406316612, 8113.716019939274, 8124.471909325875, 8129.593520324079, 8615.009273933578, 8617.138286171332, 8687.782805429915, 8693.39146259781, 9000.684976025808, 6815.284395138439, 7930.405219608668, 7996.600169991593, 8116.513009219466, 8166.0, 7677.961610191914, 7853.37173026168, 7887.329576986021, 7991.120976692443, 8059.073206581318, 7239.8914016288745, 7388.81778915371, 7390.593517356597, 7391.004428804085, 7392.667329970272, 4940.209566469348, 5260.079486089995, 5342.545883599782, 5405.351357837085, 5549.1676248563035, 5266.368035835571, 5275.683458992473, 5323.840284791462, 5380.838574842761, 5502.174673798962], "value": 4804.170731380754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.2768379620159, 332.6108453109861, 339.86654507218424, 341.55768280077297, 344.89308314422544, 5068.341115654965, 5236.397814251358, 5276.393214780302, 5281.445448227933, 5321.308229930104, 5165.8303512524735, 5177.818776342829, 5194.480551944804, 5203.739813009353, 5246.1606143017125, 4060.776657283848, 4090.89772755682, 4102.282100632392, 4104.897377565555, 4129.421880936671, 3961.3463778476516, 4075.4090656854737, 4125.649319807805, 4136.358864376011, 4148.730332528391, 4086.8773936781945, 4094.222097801423, 4103.671706263507, 4110.794460276974, 4112.773797441139, 4091.7340372875815, 4113.670906327517, 4124.278251306025, 4125.0, 4128.142335948835, 3619.1314084619767, 3689.4834723138515, 3692.5568931728094, 3695.1870588470492, 3695.815209239527, 5008.8998220035755, 5022.146235140035, 5046.772895219724, 5054.873628159326, 5074.416442109168, 4674.532546745332, 4677.4620918594455, 4689.155951928651, 4693.624510039189, 4700.412448443944, 5225.843224703227, 5261.5790736741355, 5327.973360133214, 5331.493508116722, 5355.357357117132, 3991.501062367204, 4021.5978402159844, 4023.637872591481, 4024.2756303865294, 4057.1277175407135, 5320.76056577455, 5390.865228369283, 5609.569559762275, 5632.493075623213, 5634.549236061146, 4063.715539912237, 4079.265732168238, 4100.7334523255895, 4116.423700681907, 4117.794110294533, 4110.0, 4116.444280022159, 4129.091599848029, 4135.669146468275, 4151.564085771011, 4491.618212451913, 4718.764061796896, 4727.338172655831, 4749.810007599657, 4751.4535828379485, 5463.644863083887, 5465.262189604432, 5466.180072989084, 5476.91784623231, 5493.340799104053, 1426.9215193164475, 1449.7752848308528, 1455.0905683947533, 1455.1123814473162, 1459.6350912271932, 910.7450494570362, 938.1603464898877, 949.0556895888635, 952.8046750416148, 966.7873067925045, 4634.930476042795, 4643.2802915548145, 4718.664261190733, 4721.1672996202005, 4721.3390125382475, 4877.365942427533, 4901.975490122527, 4906.239532872339, 4952.6227410842275, 4961.70229786214, 4706.388169538007, 4720.8433933686465, 4736.005438857878, 4737.905241895142, 4891.853244402673, 2920.7225313595172, 2971.762259019273, 2976.749765098664, 2980.925476863096, 2986.4176485585535, 5797.304323481209, 5817.0, 5820.380828627135, 5853.268341457318, 5869.677167755729, 5580.972095139579, 5744.942550574524, 5746.683932383759, 5784.768609255667, 5800.404888655654, 5764.625299355528, 5778.451047150514, 5784.623999440023, 5804.912926306109, 5819.359870414336, 5335.932813437251, 5575.832725018094, 5594.9720251398485, 5617.8033768817895, 5618.494335509824, 5513.173024046425, 5574.442555744556, 5580.414056524007, 5588.441155884379, 5596.664200148004, 5539.473749993744, 5620.634658747168, 5762.135679648086, 5802.419758024333, 5816.331121921034, 4025.376066709665, 4048.554658987568, 4056.269871423172, 4074.4703188585295, 4116.0, 5593.496585307342, 5624.0, 5676.0, 5689.516391106802, 5730.3410107838135, 5240.528352448298, 5482.0, 5485.75314110858, 5496.0, 5510.724463776875, 5446.564274858081, 5455.645383050089, 5458.590605704668, 5459.890802184013, 5498.477644623755, 5282.339707536558, 5450.247624949375, 5473.945260547503, 5499.50504454601, 5522.530584900168, 5531.834044978657, 5534.7786088556, 5544.251526044094, 5553.333599968029, 5553.694546799803, 5422.972885135549, 5426.782928682808, 5452.337037203691, 5454.672719636835, 5462.617616766788], "value": 4161.757785682844, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.4732687119016, 760.9048868891389, 769.7729169894881, 787.3937068457292, 819.6352623082729, 13281.335933203338, 13710.17738935662, 13728.862711372896, 13735.107218030846, 14340.641483962892, 13239.80140297894, 13334.266615336153, 13337.866621333784, 13375.464981400732, 13379.732405351911, 653.3597074866634, 780.6096951524238, 782.917793631669, 802.6428239433454, 806.9233422824823, 801.4470015689185, 813.2639960835423, 813.4956327077191, 814.1085511365046, 819.2831272636444, 849.4096602861014, 855.7646647172046, 861.2808305065247, 862.9482231066156, 863.4560227056945, 851.0085750101125, 851.8977722673256, 851.9744407667749, 852.0669866496207, 852.1691350932853, 501.45551700761564, 597.357840321656, 613.3498491598875, 619.6313193649771, 620.7734177025353, 13001.284929328884, 13037.0, 13069.607911762663, 13075.803862942064, 13085.738285234338, 13742.725145497034, 14724.0, 14745.336459859225, 14750.188739619316, 14799.112053276838, 12161.756764864653, 12232.388380581024, 12330.884039042547, 12335.629931102081, 12352.135350525466, 4169.624733773944, 4207.91584168318, 4235.555266697014, 4243.130158317537, 4378.6934914555995, 79748.60125699392, 79924.20075799225, 81630.18369816286, 84461.0, 84465.0, 10074.244431667654, 10221.284510084222, 10632.46837658114, 10761.461926903623, 11306.038986686059, 20841.79158208429, 20899.68650470244, 20963.79036209649, 20974.47563810917, 21081.262155824472, 7956.363490920712, 8177.79555511117, 8213.34293256538, 8284.751457456287, 8398.17400697944, 4391.253486907233, 4392.341148827638, 4455.0, 4560.4071470708595, 4716.551927566876, 3566.233259849145, 3710.870119545803, 3711.31340701971, 3712.276106159273, 3714.1643130295465, 613.9815805525841, 623.544812287033, 630.2468550082699, 636.2047440699126, 665.4011389749168, 522.1488972974028, 625.8216408323697, 632.4560877645222, 675.4596322941627, 683.0744341417408, 8093.433459657767, 8593.613287402082, 8843.0, 8856.468611883307, 8887.511186884654, 508.8956763863399, 518.9584833213333, 532.0688794609433, 647.9115086654372, 709.6948312225793, 3869.6710779583486, 4093.0, 4170.541240463546, 4212.262854000538, 4238.23711731885, 130164.0, 132105.0, 132597.0, 132823.0, 134516.0, 110797.0, 112647.0, 113568.43215783869, 117707.0, 119233.09586301712, 99479.0, 100655.0, 100914.49542752386, 102722.48638756758, 106015.0, 7805.921940780519, 7891.0, 7935.6032198391, 8144.592770361577, 8227.71203007892, 43280.0, 45700.771496142304, 49883.75058124686, 51339.743301283255, 51450.74274628753, 73982.0, 75470.0, 76869.0, 78095.60952195202, 79967.60016199882, 13234.735305293647, 13471.191728496322, 13774.173549587056, 13829.51596694111, 14054.367553460323, 14150.43398264058, 14359.425622974964, 14556.49052283165, 15028.248587570797, 15131.167785771888, 13171.736565268833, 13247.20516768997, 13449.0, 13824.93087534596, 14252.358643860844, 10199.898001019896, 12116.515339386326, 12227.205231659913, 12456.501739930301, 13123.146995445266, 12457.501699931901, 12733.0, 12897.161684490478, 12962.787094194613, 13158.0, 10221.0, 10232.334898231591, 10348.172146228133, 10380.948095259475, 10917.39954302521, 10545.31455455393, 10563.313384629975, 10754.784904301714, 10775.946120269662, 10926.125909927028], "value": 7370.918606343015, "unit": "score"}], "name": "dromaeo_css", "value": 7204.031988920489, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 117.0, 110.0, 113.0, 114.0, 111.0, 111.0, 112.0, 128.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 142.0, 181.0, 121.0, 151.0, 146.0, 124.0, 181.0, 121.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 162.0, 162.0, 161.0, 160.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 190.0, 77.0, 76.0, 74.0, 75.0, 160.0, 80.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 146.0, 82.0, 83.0, 82.0, 133.0, 83.0, 83.0, 143.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 60.0, 60.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 79.0, 79.0, 87.0, 81.0, 87.0, 84.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 132.0, 132.0, 138.0, 125.0, 123.0, 131.0, 212.0, 123.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 170.0, 165.0, 162.0, 165.0, 164.0, 164.0, 163.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 65.0, 64.0, 67.0, 66.0, 67.0, 69.0, 68.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1534.3999999999996, "alertThreshold": 2.0}]} 17:47:05 INFO - Return code: 0 17:47:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:47:05 INFO - # TBPL SUCCESS # 17:47:05 INFO - Running post-action listener: _resource_record_post_action 17:47:05 INFO - [mozharness: 2016-09-03 00:47:05.502531Z] Finished run-tests step (success) 17:47:05 INFO - Running post-run listener: _resource_record_post_run 17:47:05 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418177024; Read time: 12; Write time: 226544 17:47:05 INFO - TinderboxPrint: CPU usage
13.1% 17:47:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:47:05 INFO - TinderboxPrint: I/O write bytes / time
418,177,024 / 226,544 17:47:05 INFO - TinderboxPrint: CPU idle
8,301.2 (86.9%) 17:47:05 INFO - TinderboxPrint: CPU user
1,197.9 (12.5%) 17:47:05 INFO - TinderboxPrint: Swap in / out
0 / 0 17:47:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118358016; Read time: 0; Write time: 63064 17:47:05 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288456704; Read time: 12; Write time: 161296 17:47:06 INFO - Running post-run listener: _upload_blobber_files 17:47:06 INFO - Blob upload gear active. 17:47:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:47:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:47:06 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:07 INFO - (blobuploader) - INFO - Done attempting. 17:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:08 INFO - (blobuploader) - INFO - Done attempting. 17:47:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:47:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:47:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:12 INFO - (blobuploader) - INFO - Done attempting. 17:47:12 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:12 INFO - Return code: 0 17:47:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:47:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f55a4130b50a5477ef77bf9a450f74c19701accd9062a4ef8239e4bc2aba41a0c4a183b35deb94cc482ab4622a98b7a3bcce2588d18c1fbee4435c533f762d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584099c84540fa0522faf6d1b140962f2777acd9552ce0d13f1b23a835df5d84c7aa1b15d32eca3d29fe470735c3a06fbd9c15d3a7b70a54ae2cabbf68f6440f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c883ddc4a976acf3257e698443a367748dba62a29b5584a61f9c45eb795d191222457e182f6e750e13ed44eff514452d3b5d87705c46d9e1ffb8e19e3430e32f"} 17:47:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:47:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:47:12 INFO - Contents: 17:47:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f55a4130b50a5477ef77bf9a450f74c19701accd9062a4ef8239e4bc2aba41a0c4a183b35deb94cc482ab4622a98b7a3bcce2588d18c1fbee4435c533f762d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584099c84540fa0522faf6d1b140962f2777acd9552ce0d13f1b23a835df5d84c7aa1b15d32eca3d29fe470735c3a06fbd9c15d3a7b70a54ae2cabbf68f6440f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c883ddc4a976acf3257e698443a367748dba62a29b5584a61f9c45eb795d191222457e182f6e750e13ed44eff514452d3b5d87705c46d9e1ffb8e19e3430e32f"} 17:47:12 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:12 INFO - Copying logs to upload dir... 17:47:12 INFO - mkdir: /builds/slave/test/build/upload/logs 17:47:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.036641 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-02 17:47:12.193226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 17:47:12.197217) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709 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/f6f55a4130b50a5477ef77bf9a450f74c19701accd9062a4ef8239e4bc2aba41a0c4a183b35deb94cc482ab4622a98b7a3bcce2588d18c1fbee4435c533f762d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584099c84540fa0522faf6d1b140962f2777acd9552ce0d13f1b23a835df5d84c7aa1b15d32eca3d29fe470735c3a06fbd9c15d3a7b70a54ae2cabbf68f6440f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c883ddc4a976acf3257e698443a367748dba62a29b5584a61f9c45eb795d191222457e182f6e750e13ed44eff514452d3b5d87705c46d9e1ffb8e19e3430e32f"} build_url:https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/GvUst_GCR9SGBgOhmkDbow/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/f6f55a4130b50a5477ef77bf9a450f74c19701accd9062a4ef8239e4bc2aba41a0c4a183b35deb94cc482ab4622a98b7a3bcce2588d18c1fbee4435c533f762d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584099c84540fa0522faf6d1b140962f2777acd9552ce0d13f1b23a835df5d84c7aa1b15d32eca3d29fe470735c3a06fbd9c15d3a7b70a54ae2cabbf68f6440f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c883ddc4a976acf3257e698443a367748dba62a29b5584a61f9c45eb795d191222457e182f6e750e13ed44eff514452d3b5d87705c46d9e1ffb8e19e3430e32f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 17:47:12.224201) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:47:12.224720) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1472861468.529267-997913709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 17:47:12.308793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 17:47:12.309274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 17:47:12.309663) ========= ========= Total master_lag: 0.20 =========