builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1472807803.45 results: success (0) buildid: 20160901233010 builduid: a804e9edc6874333a03b4e8ccfc0e751 revision: 4c4ce191fc9b444f1f47272293e001707538c105 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.448139) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.448513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.448778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.492666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.496189) ========= 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=32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 02:16:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-09-02 02:16:44 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103150 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.797776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.798096) ========= 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=32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021463 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.880745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:43.884063) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c4ce191fc9b444f1f47272293e001707538c105 --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 4c4ce191fc9b444f1f47272293e001707538c105 --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=32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 02:16:44,631 truncating revision to first 12 chars 2016-09-02 02:16:44,631 Setting DEBUG logging. 2016-09-02 02:16:44,631 attempt 1/10 2016-09-02 02:16:44,631 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c4ce191fc9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 02:16:45,226 unpacking tar archive at: fx-team-4c4ce191fc9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921776 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:44.829787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:44.830062) ========= script_repo_revision: 4c4ce191fc9b444f1f47272293e001707538c105 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:44.830414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:44.830671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 02:16:44.840156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-02 02:16:44.840433) ========= /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=32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:16:45 INFO - MultiFileLogger online at 20160902 02:16:45 in /builds/slave/test 02:16:45 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 02:16:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:16:45 INFO - {'append_to_log': False, 02:16:45 INFO - 'base_work_dir': '/builds/slave/test', 02:16:45 INFO - 'blob_upload_branch': 'Fx-Team', 02:16:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:16:45 INFO - 'branch': 'Fx-Team', 02:16:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:16:45 INFO - 'config_files': ('talos/linux_config.py',), 02:16:45 INFO - 'default_actions': ('clobber', 02:16:45 INFO - 'read-buildbot-config', 02:16:45 INFO - 'download-and-extract', 02:16:45 INFO - 'populate-webroot', 02:16:45 INFO - 'create-virtualenv', 02:16:45 INFO - 'install', 02:16:45 INFO - 'run-tests'), 02:16:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:16:45 INFO - 'download_minidump_stackwalk': True, 02:16:45 INFO - 'download_symbols': 'ondemand', 02:16:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:16:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:16:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:16:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:16:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:16:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:16:45 INFO - 'installer_path': 'installer.exe', 02:16:45 INFO - 'log_level': 'info', 02:16:45 INFO - 'log_name': 'talos', 02:16:45 INFO - 'log_to_console': True, 02:16:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:16:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:16:45 INFO - 'opt_config_files': (), 02:16:45 INFO - 'pip_index': False, 02:16:45 INFO - 'sps_profile': False, 02:16:45 INFO - 'sps_profile_interval': 0, 02:16:45 INFO - 'suite': 'dromaeojs', 02:16:45 INFO - 'system_bits': '32', 02:16:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:16:45 INFO - 'title': 'talos-linux64-ix-008', 02:16:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:16:45 INFO - 'use_talos_json': True, 02:16:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:16:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:16:45 INFO - 'work_dir': 'build'} 02:16:45 INFO - [mozharness: 2016-09-02 09:16:45.676648Z] Running clobber step. 02:16:45 INFO - Running pre-action listener: _resource_record_pre_action 02:16:45 INFO - Running main action method: clobber 02:16:45 INFO - rmtree: /builds/slave/test/build 02:16:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:16:46 INFO - Running post-action listener: _resource_record_post_action 02:16:46 INFO - [mozharness: 2016-09-02 09:16:46.139172Z] Finished clobber step (success) 02:16:46 INFO - [mozharness: 2016-09-02 09:16:46.139273Z] Running read-buildbot-config step. 02:16:46 INFO - Running pre-action listener: _resource_record_pre_action 02:16:46 INFO - Running main action method: read_buildbot_config 02:16:46 INFO - Using buildbot properties: 02:16:46 INFO - { 02:16:46 INFO - "project": "", 02:16:46 INFO - "product": "firefox", 02:16:46 INFO - "script_repo_revision": "production", 02:16:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:16:46 INFO - "repository": "", 02:16:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:16:46 INFO - "buildid": "20160901233010", 02:16:46 INFO - "pgo_build": "True", 02:16:46 INFO - "basedir": "/builds/slave/test", 02:16:46 INFO - "buildnumber": 1026, 02:16:46 INFO - "slavename": "talos-linux64-ix-008", 02:16:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:16:46 INFO - "platform": "ubuntu64_hw", 02:16:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:16:46 INFO - "branch": "fx-team", 02:16:46 INFO - "repo_path": "integration/fx-team", 02:16:46 INFO - "revision": "4c4ce191fc9b444f1f47272293e001707538c105", 02:16:46 INFO - "stage_platform": "linux64-pgo", 02:16:46 INFO - "builduid": "a804e9edc6874333a03b4e8ccfc0e751", 02:16:46 INFO - "slavebuilddir": "test" 02:16:46 INFO - } 02:16:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:16:46 INFO - Running post-action listener: _resource_record_post_action 02:16:46 INFO - [mozharness: 2016-09-02 09:16:46.141968Z] Finished read-buildbot-config step (success) 02:16:46 INFO - [mozharness: 2016-09-02 09:16:46.142058Z] Running download-and-extract step. 02:16:46 INFO - Running pre-action listener: _resource_record_pre_action 02:16:46 INFO - Running main action method: download_and_extract 02:16:46 INFO - mkdir: /builds/slave/test/build/tests 02:16:46 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')]} 02:16:46 INFO - trying https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:16:46 INFO - Downloading https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:46 INFO - Downloaded 1361 bytes. 02:16:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:16:46 INFO - Using the following test package requirements: 02:16:46 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:16:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:16:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:16:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'jsshell-linux-x86_64.zip'], 02:16:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:16:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:16:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:16:46 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:16:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:16:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:16:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:16:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:16:46 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')]} 02:16:46 INFO - trying https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:16:46 INFO - Downloading https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:48 INFO - Downloaded 21905652 bytes. 02:16:48 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 02:16:52 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 02:16: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')]} 02:16:52 INFO - trying https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:16:52 INFO - Downloading https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:53 INFO - Downloaded 21905652 bytes. 02:16:53 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 02:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:58 INFO - trying https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:16:58 INFO - Downloading https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:59 INFO - Downloaded 14413998 bytes. 02:16:59 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 02:16: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')]} 02:16:59 INFO - trying https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:16:59 INFO - Downloading https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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 02:17:02 INFO - Downloaded 59734816 bytes. 02:17:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:17:02 INFO - mkdir: /builds/slave/test/properties 02:17:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:17:02 INFO - Writing to file /builds/slave/test/properties/build_url 02:17:02 INFO - Contents: 02:17:02 INFO - build_url:https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:17:02 INFO - Running post-action listener: _resource_record_post_action 02:17:02 INFO - Running post-action listener: set_extra_try_arguments 02:17:02 INFO - [mozharness: 2016-09-02 09:17:02.933118Z] Finished download-and-extract step (success) 02:17:02 INFO - [mozharness: 2016-09-02 09:17:02.933348Z] Running populate-webroot step. 02:17:02 INFO - Running pre-action listener: _resource_record_pre_action 02:17:02 INFO - Running main action method: populate_webroot 02:17:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:17:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:17:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:17:02 INFO - '--tppagecycles', 02:17:02 INFO - '7'], 02:17:02 INFO - 'tests': ['tsvgm']}}, 02:17:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:17:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:17:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:17:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:17:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['damp', 'tps']}, 02:17:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'tests': ['damp', 'tps']}, 02:17:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['dromaeo_dom']}, 02:17:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:17:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['basic_compositor_video']}, 02:17:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:17:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['a11yr', 02:17:02 INFO - 'ts_paint', 02:17:02 INFO - 'tpaint', 02:17:02 INFO - 'sessionrestore', 02:17:02 INFO - 'sessionrestore_no_auto_restore', 02:17:02 INFO - 'tabpaint']}, 02:17:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:17:02 INFO - 'ts_paint', 02:17:02 INFO - 'tpaint', 02:17:02 INFO - 'sessionrestore', 02:17:02 INFO - 'sessionrestore_no_auto_restore', 02:17:02 INFO - 'tabpaint']}, 02:17:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:17:02 INFO - 'ts_paint', 02:17:02 INFO - 'tpaint', 02:17:02 INFO - 'sessionrestore', 02:17:02 INFO - 'sessionrestore_no_auto_restore', 02:17:02 INFO - 'tabpaint']}, 02:17:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:17:02 INFO - 'ts_paint', 02:17:02 INFO - 'tpaint', 02:17:02 INFO - 'sessionrestore', 02:17:02 INFO - 'sessionrestore_no_auto_restore', 02:17:02 INFO - 'tabpaint']}, 02:17:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['a11yr', 02:17:02 INFO - 'ts_paint', 02:17:02 INFO - 'tpaint', 02:17:02 INFO - 'sessionrestore', 02:17:02 INFO - 'sessionrestore_no_auto_restore', 02:17:02 INFO - 'tabpaint']}, 02:17:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['a11yr', 02:17:02 INFO - 'ts_paint', 02:17:02 INFO - 'tpaint', 02:17:02 INFO - 'sessionrestore', 02:17:02 INFO - 'sessionrestore_no_auto_restore', 02:17:02 INFO - 'tabpaint']}, 02:17:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['tsvgx', 02:17:02 INFO - 'tsvgr_opacity', 02:17:02 INFO - 'tart', 02:17:02 INFO - 'tscrollx', 02:17:02 INFO - 'cart']}, 02:17:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:17:02 INFO - 'tsvgr_opacity', 02:17:02 INFO - 'tart', 02:17:02 INFO - 'tscrollx', 02:17:02 INFO - 'cart']}, 02:17:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'talos_options': ['--disable-e10s'], 02:17:02 INFO - 'tests': ['tp5o']}, 02:17:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'tests': ['tp5o']}, 02:17:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'talos_options': ['--disable-e10s', 02:17:02 INFO - '--xperf_path', 02:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:02 INFO - 'tests': ['tp5n']}, 02:17:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:02 INFO - 'talos_options': ['--xperf_path', 02:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:02 INFO - 'tests': ['tp5n']}}, 02:17:02 INFO - 'talos.zip': {'path': '', 02:17:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:17:02 INFO - Running post-action listener: _resource_record_post_action 02:17:02 INFO - [mozharness: 2016-09-02 09:17:02.953414Z] Finished populate-webroot step (success) 02:17:02 INFO - [mozharness: 2016-09-02 09:17:02.953503Z] Running create-virtualenv step. 02:17:02 INFO - Running pre-action listener: _resource_record_pre_action 02:17:02 INFO - Running main action method: create_virtualenv 02:17:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:17:02 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 02:17:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:17:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:17:03 INFO - Using real prefix '/usr' 02:17:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:17:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:17:05 INFO - Installing pip.................done. 02:17:05 INFO - Return code: 0 02:17:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:17:05 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')]} 02:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:05 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')]} 02:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:05 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:05 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 02:17:05 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 02:17:05 INFO - Using env: {'DISPLAY': ':0', 02:17:05 INFO - 'HOME': '/home/cltbld', 02:17:05 INFO - 'LANG': 'en_US.UTF-8', 02:17:05 INFO - 'LANGUAGE': 'en_US:en', 02:17:05 INFO - 'LOGNAME': 'cltbld', 02:17:05 INFO - 'MAIL': '/var/mail/cltbld', 02:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:05 INFO - 'MOZ_NO_REMOTE': '1', 02:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:05 INFO - 'NO_EM_RESTART': '1', 02:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:05 INFO - 'PWD': '/builds/slave/test', 02:17:05 INFO - 'SHELL': '/bin/bash', 02:17:05 INFO - 'SHLVL': '1', 02:17:05 INFO - 'TERM': 'linux', 02:17:05 INFO - 'TMOUT': '86400', 02:17:05 INFO - 'USER': 'cltbld', 02:17:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:05 INFO - '_': '/tools/buildbot/bin/python'} 02:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:05 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 02:17:05 INFO - Cleaning up... 02:17:05 INFO - Return code: 0 02:17:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:17:05 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')]} 02:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:05 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')]} 02:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:05 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:05 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 02:17:05 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 02:17:05 INFO - Using env: {'DISPLAY': ':0', 02:17:05 INFO - 'HOME': '/home/cltbld', 02:17:05 INFO - 'LANG': 'en_US.UTF-8', 02:17:05 INFO - 'LANGUAGE': 'en_US:en', 02:17:05 INFO - 'LOGNAME': 'cltbld', 02:17:05 INFO - 'MAIL': '/var/mail/cltbld', 02:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:05 INFO - 'MOZ_NO_REMOTE': '1', 02:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:05 INFO - 'NO_EM_RESTART': '1', 02:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:05 INFO - 'PWD': '/builds/slave/test', 02:17:05 INFO - 'SHELL': '/bin/bash', 02:17:05 INFO - 'SHLVL': '1', 02:17:05 INFO - 'TERM': 'linux', 02:17:05 INFO - 'TMOUT': '86400', 02:17:05 INFO - 'USER': 'cltbld', 02:17:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:05 INFO - '_': '/tools/buildbot/bin/python'} 02:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:05 INFO - Downloading/unpacking psutil>=3.1.1 02:17:05 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 02:17:05 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 02:17:05 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 02:17:05 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 02:17:05 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 02:17:05 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 02:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:07 INFO - Installing collected packages: psutil 02:17:07 INFO - Running setup.py install for psutil 02:17:08 INFO - building 'psutil._psutil_linux' extension 02:17:08 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 02:17:08 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 02:17:08 INFO - building 'psutil._psutil_posix' extension 02:17:08 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 02:17:08 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 02:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:08 INFO - Successfully installed psutil 02:17:08 INFO - Cleaning up... 02:17:08 INFO - Return code: 0 02:17:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:08 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:08 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 02:17:08 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 02:17:08 INFO - Using env: {'DISPLAY': ':0', 02:17:08 INFO - 'HOME': '/home/cltbld', 02:17:08 INFO - 'LANG': 'en_US.UTF-8', 02:17:08 INFO - 'LANGUAGE': 'en_US:en', 02:17:08 INFO - 'LOGNAME': 'cltbld', 02:17:08 INFO - 'MAIL': '/var/mail/cltbld', 02:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:08 INFO - 'MOZ_NO_REMOTE': '1', 02:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:08 INFO - 'NO_EM_RESTART': '1', 02:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:08 INFO - 'PWD': '/builds/slave/test', 02:17:08 INFO - 'SHELL': '/bin/bash', 02:17:08 INFO - 'SHLVL': '1', 02:17:08 INFO - 'TERM': 'linux', 02:17:08 INFO - 'TMOUT': '86400', 02:17:08 INFO - 'USER': 'cltbld', 02:17:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:08 INFO - '_': '/tools/buildbot/bin/python'} 02:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:17:08 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 02:17:08 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 02:17:08 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 02:17:08 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 02:17:08 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 02:17:08 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 02:17:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:17:10 INFO - Installing collected packages: mozsystemmonitor 02:17:10 INFO - Running setup.py install for mozsystemmonitor 02:17:10 INFO - Successfully installed mozsystemmonitor 02:17:10 INFO - Cleaning up... 02:17:10 INFO - Return code: 0 02:17:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:17:10 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')]} 02:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:10 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')]} 02:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:10 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:10 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 02:17:10 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 02:17:10 INFO - Using env: {'DISPLAY': ':0', 02:17:10 INFO - 'HOME': '/home/cltbld', 02:17:10 INFO - 'LANG': 'en_US.UTF-8', 02:17:10 INFO - 'LANGUAGE': 'en_US:en', 02:17:10 INFO - 'LOGNAME': 'cltbld', 02:17:10 INFO - 'MAIL': '/var/mail/cltbld', 02:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:10 INFO - 'MOZ_NO_REMOTE': '1', 02:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:10 INFO - 'NO_EM_RESTART': '1', 02:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:10 INFO - 'PWD': '/builds/slave/test', 02:17:10 INFO - 'SHELL': '/bin/bash', 02:17:10 INFO - 'SHLVL': '1', 02:17:10 INFO - 'TERM': 'linux', 02:17:10 INFO - 'TMOUT': '86400', 02:17:10 INFO - 'USER': 'cltbld', 02:17:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:10 INFO - '_': '/tools/buildbot/bin/python'} 02:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:11 INFO - Downloading/unpacking jsonschema==2.5.1 02:17:11 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 02:17:11 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 02:17:11 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 02:17:11 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 02:17:11 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 02:17:11 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 02:17:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:17:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:17:12 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 02:17:12 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 02:17:12 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 02:17:12 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 02:17:12 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 02:17:12 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 02:17:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:17:13 INFO - warning: no files found matching '*.txt' 02:17:13 INFO - no previously-included directories found matching 'build' 02:17:13 INFO - no previously-included directories found matching 'dist' 02:17:13 INFO - no previously-included directories found matching '.git*' 02:17:13 INFO - Installing collected packages: jsonschema, functools32 02:17:13 INFO - Running setup.py install for functools32 02:17:13 INFO - warning: no files found matching '*.txt' 02:17:13 INFO - no previously-included directories found matching 'build' 02:17:13 INFO - no previously-included directories found matching 'dist' 02:17:13 INFO - no previously-included directories found matching '.git*' 02:17:13 INFO - Successfully installed jsonschema functools32 02:17:13 INFO - Cleaning up... 02:17:13 INFO - Return code: 0 02:17:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:13 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:13 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 02:17:13 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 02:17:13 INFO - Using env: {'DISPLAY': ':0', 02:17:13 INFO - 'HOME': '/home/cltbld', 02:17:13 INFO - 'LANG': 'en_US.UTF-8', 02:17:13 INFO - 'LANGUAGE': 'en_US:en', 02:17:13 INFO - 'LOGNAME': 'cltbld', 02:17:13 INFO - 'MAIL': '/var/mail/cltbld', 02:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:13 INFO - 'MOZ_NO_REMOTE': '1', 02:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:13 INFO - 'NO_EM_RESTART': '1', 02:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:13 INFO - 'PWD': '/builds/slave/test', 02:17:13 INFO - 'SHELL': '/bin/bash', 02:17:13 INFO - 'SHLVL': '1', 02:17:13 INFO - 'TERM': 'linux', 02:17:13 INFO - 'TMOUT': '86400', 02:17:13 INFO - 'USER': 'cltbld', 02:17:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:13 INFO - '_': '/tools/buildbot/bin/python'} 02:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:17:13 INFO - Cleaning up... 02:17:13 INFO - Return code: 0 02:17:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:13 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:13 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 02:17:13 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 02:17:13 INFO - Using env: {'DISPLAY': ':0', 02:17:13 INFO - 'HOME': '/home/cltbld', 02:17:13 INFO - 'LANG': 'en_US.UTF-8', 02:17:13 INFO - 'LANGUAGE': 'en_US:en', 02:17:13 INFO - 'LOGNAME': 'cltbld', 02:17:13 INFO - 'MAIL': '/var/mail/cltbld', 02:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:13 INFO - 'MOZ_NO_REMOTE': '1', 02:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:13 INFO - 'NO_EM_RESTART': '1', 02:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:13 INFO - 'PWD': '/builds/slave/test', 02:17:13 INFO - 'SHELL': '/bin/bash', 02:17:13 INFO - 'SHLVL': '1', 02:17:13 INFO - 'TERM': 'linux', 02:17:13 INFO - 'TMOUT': '86400', 02:17:13 INFO - 'USER': 'cltbld', 02:17:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:13 INFO - '_': '/tools/buildbot/bin/python'} 02:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:13 INFO - Downloading/unpacking blobuploader==1.2.4 02:17:13 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 02:17:13 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 02:17:13 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 02:17:13 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 02:17:13 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 02:17:13 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 02:17:15 INFO - Downloading blobuploader-1.2.4.tar.gz 02:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:17:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:17:15 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 02:17:15 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 02:17:15 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 02:17:15 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 02:17:15 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 02:17:15 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 02:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:17:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:17:16 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 02:17:16 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 02:17:16 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 02:17:16 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 02:17:16 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 02:17:16 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 02:17:16 INFO - Downloading docopt-0.6.1.tar.gz 02:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:17:16 INFO - Installing collected packages: blobuploader, requests, docopt 02:17:16 INFO - Running setup.py install for blobuploader 02:17:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:17:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:17:16 INFO - Running setup.py install for requests 02:17:16 INFO - Running setup.py install for docopt 02:17:17 INFO - Successfully installed blobuploader requests docopt 02:17:17 INFO - Cleaning up... 02:17:17 INFO - Return code: 0 02:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:17 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:17 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 02:17:17 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 02:17:17 INFO - Using env: {'DISPLAY': ':0', 02:17:17 INFO - 'HOME': '/home/cltbld', 02:17:17 INFO - 'LANG': 'en_US.UTF-8', 02:17:17 INFO - 'LANGUAGE': 'en_US:en', 02:17:17 INFO - 'LOGNAME': 'cltbld', 02:17:17 INFO - 'MAIL': '/var/mail/cltbld', 02:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:17 INFO - 'MOZ_NO_REMOTE': '1', 02:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:17 INFO - 'NO_EM_RESTART': '1', 02:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:17 INFO - 'PWD': '/builds/slave/test', 02:17:17 INFO - 'SHELL': '/bin/bash', 02:17:17 INFO - 'SHLVL': '1', 02:17:17 INFO - 'TERM': 'linux', 02:17:17 INFO - 'TMOUT': '86400', 02:17:17 INFO - 'USER': 'cltbld', 02:17:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:17 INFO - '_': '/tools/buildbot/bin/python'} 02:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:17:17 INFO - Running setup.py (path:/tmp/pip-moqy1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:17:17 INFO - Running setup.py (path:/tmp/pip-wj13GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:17:17 INFO - Running setup.py (path:/tmp/pip-59dWei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:17:17 INFO - Running setup.py (path:/tmp/pip-YioJ1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:17:17 INFO - Running setup.py (path:/tmp/pip-cxj1NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:17:17 INFO - Running setup.py (path:/tmp/pip-Qdnsjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:17:17 INFO - Running setup.py (path:/tmp/pip-GBMnQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:17:17 INFO - Running setup.py (path:/tmp/pip-bEDGyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:17:17 INFO - Running setup.py (path:/tmp/pip-BfQuBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:17:17 INFO - Running setup.py (path:/tmp/pip-X8o1a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:17:18 INFO - Running setup.py (path:/tmp/pip-YEllVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:17:18 INFO - Running setup.py (path:/tmp/pip-JP2pry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:17:18 INFO - Running setup.py (path:/tmp/pip-PENptx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:17:18 INFO - Running setup.py (path:/tmp/pip-yvayD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:18 INFO - Running setup.py (path:/tmp/pip-q1lzsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:17:18 INFO - Running setup.py (path:/tmp/pip-F469PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:17:18 INFO - Running setup.py (path:/tmp/pip-ypOxbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:17:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:17:18 INFO - Running setup.py install for manifestparser 02:17:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:17:18 INFO - Running setup.py install for mozcrash 02:17:18 INFO - Running setup.py install for mozdebug 02:17:18 INFO - Running setup.py install for mozdevice 02:17:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:17:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:17:18 INFO - Running setup.py install for mozfile 02:17:19 INFO - Running setup.py install for mozhttpd 02:17:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Running setup.py install for mozinfo 02:17:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Running setup.py install for mozInstall 02:17:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Running setup.py install for mozleak 02:17:19 INFO - Running setup.py install for mozlog 02:17:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Running setup.py install for moznetwork 02:17:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Running setup.py install for mozprocess 02:17:19 INFO - Running setup.py install for mozprofile 02:17:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Running setup.py install for mozrunner 02:17:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:17:19 INFO - Running setup.py install for mozscreenshot 02:17:20 INFO - Running setup.py install for moztest 02:17:20 INFO - Running setup.py install for mozversion 02:17:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:17:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:17:20 INFO - Cleaning up... 02:17:20 INFO - Return code: 0 02:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:20 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:20 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 02:17:20 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 02:17:20 INFO - Using env: {'DISPLAY': ':0', 02:17:20 INFO - 'HOME': '/home/cltbld', 02:17:20 INFO - 'LANG': 'en_US.UTF-8', 02:17:20 INFO - 'LANGUAGE': 'en_US:en', 02:17:20 INFO - 'LOGNAME': 'cltbld', 02:17:20 INFO - 'MAIL': '/var/mail/cltbld', 02:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:20 INFO - 'MOZ_NO_REMOTE': '1', 02:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:20 INFO - 'NO_EM_RESTART': '1', 02:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:20 INFO - 'PWD': '/builds/slave/test', 02:17:20 INFO - 'SHELL': '/bin/bash', 02:17:20 INFO - 'SHLVL': '1', 02:17:20 INFO - 'TERM': 'linux', 02:17:20 INFO - 'TMOUT': '86400', 02:17:20 INFO - 'USER': 'cltbld', 02:17:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:20 INFO - '_': '/tools/buildbot/bin/python'} 02:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:17:20 INFO - Running setup.py (path:/tmp/pip-0qUxSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:17:20 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)) 02:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:17:20 INFO - Running setup.py (path:/tmp/pip-ev030k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:17:20 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)) 02:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:17:20 INFO - Running setup.py (path:/tmp/pip-KjCQCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:17:20 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)) 02:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:17:20 INFO - Running setup.py (path:/tmp/pip-yLIzx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:17:20 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)) 02:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:17:20 INFO - Running setup.py (path:/tmp/pip-38J1qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:17:20 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)) 02:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:17:20 INFO - Running setup.py (path:/tmp/pip-8WSHcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:17:20 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)) 02:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:17:20 INFO - Running setup.py (path:/tmp/pip-pL_bbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:17:21 INFO - Running setup.py (path:/tmp/pip-smRmx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:17:21 INFO - Running setup.py (path:/tmp/pip-yOFsC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:17:21 INFO - Running setup.py (path:/tmp/pip-PbnGB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:17:21 INFO - Running setup.py (path:/tmp/pip-K_glcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:17:21 INFO - Running setup.py (path:/tmp/pip-IwMLG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:17:21 INFO - Running setup.py (path:/tmp/pip-_8Ad15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:17:21 INFO - Running setup.py (path:/tmp/pip-XG6gST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:21 INFO - Running setup.py (path:/tmp/pip-nUXF1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:17:21 INFO - Running setup.py (path:/tmp/pip-aZ6gGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:17:21 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)) 02:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:17:21 INFO - Running setup.py (path:/tmp/pip-hnOiJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:17:21 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)) 02:17:21 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)) 02:17:21 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)) 02:17:21 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)) 02:17:21 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)) 02:17:21 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)) 02:17:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:17:21 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 02:17:21 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 02:17:21 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 02:17:21 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 02:17:21 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 02:17:21 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 02:17:23 INFO - Downloading blessings-1.6.tar.gz 02:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:17:23 INFO - Installing collected packages: blessings 02:17:23 INFO - Running setup.py install for blessings 02:17:23 INFO - Successfully installed blessings 02:17:23 INFO - Cleaning up... 02:17:23 INFO - Return code: 0 02:17:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:17:24 INFO - Reading from file tmpfile_stdout 02:17:24 INFO - Current package versions: 02:17:24 INFO - argparse == 1.2.1 02:17:24 INFO - blessings == 1.6 02:17:24 INFO - blobuploader == 1.2.4 02:17:24 INFO - docopt == 0.6.1 02:17:24 INFO - functools32 == 3.2.3-2 02:17:24 INFO - jsonschema == 2.5.1 02:17:24 INFO - manifestparser == 1.1 02:17:24 INFO - mozInstall == 1.12 02:17:24 INFO - mozcrash == 0.17 02:17:24 INFO - mozdebug == 0.1 02:17:24 INFO - mozdevice == 0.48 02:17:24 INFO - mozfile == 1.2 02:17:24 INFO - mozhttpd == 0.7 02:17:24 INFO - mozinfo == 0.9 02:17:24 INFO - mozleak == 0.1 02:17:24 INFO - mozlog == 3.3 02:17:24 INFO - moznetwork == 0.27 02:17:24 INFO - mozprocess == 0.23 02:17:24 INFO - mozprofile == 0.28 02:17:24 INFO - mozrunner == 6.12 02:17:24 INFO - mozscreenshot == 0.1 02:17:24 INFO - mozsystemmonitor == 0.3 02:17:24 INFO - moztest == 0.7 02:17:24 INFO - mozversion == 1.4 02:17:24 INFO - psutil == 3.1.1 02:17:24 INFO - requests == 1.2.3 02:17:24 INFO - wsgiref == 0.1.2 02:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:24 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 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:24 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 02:17:24 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 02:17:24 INFO - Using env: {'DISPLAY': ':0', 02:17:24 INFO - 'HOME': '/home/cltbld', 02:17:24 INFO - 'LANG': 'en_US.UTF-8', 02:17:24 INFO - 'LANGUAGE': 'en_US:en', 02:17:24 INFO - 'LOGNAME': 'cltbld', 02:17:24 INFO - 'MAIL': '/var/mail/cltbld', 02:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:24 INFO - 'MOZ_NO_REMOTE': '1', 02:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:24 INFO - 'NO_EM_RESTART': '1', 02:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:24 INFO - 'PWD': '/builds/slave/test', 02:17:24 INFO - 'SHELL': '/bin/bash', 02:17:24 INFO - 'SHLVL': '1', 02:17:24 INFO - 'TERM': 'linux', 02:17:24 INFO - 'TMOUT': '86400', 02:17:24 INFO - 'USER': 'cltbld', 02:17:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:24 INFO - '_': '/tools/buildbot/bin/python'} 02:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 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)) 02:17:24 INFO - Cleaning up... 02:17:24 INFO - Return code: 0 02:17:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f956c9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, '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': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', '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 02:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:17:24 INFO - Using env: {'DISPLAY': ':0', 02:17:24 INFO - 'HOME': '/home/cltbld', 02:17:24 INFO - 'LANG': 'en_US.UTF-8', 02:17:24 INFO - 'LANGUAGE': 'en_US:en', 02:17:24 INFO - 'LOGNAME': 'cltbld', 02:17:24 INFO - 'MAIL': '/var/mail/cltbld', 02:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:24 INFO - 'MOZ_NO_REMOTE': '1', 02:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:24 INFO - 'NO_EM_RESTART': '1', 02:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:24 INFO - 'PWD': '/builds/slave/test', 02:17:24 INFO - 'SHELL': '/bin/bash', 02:17:24 INFO - 'SHLVL': '1', 02:17:24 INFO - 'TERM': 'linux', 02:17:24 INFO - 'TMOUT': '86400', 02:17:24 INFO - 'USER': 'cltbld', 02:17:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:24 INFO - '_': '/tools/buildbot/bin/python'} 02:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:17:24 INFO - Cleaning up... 02:17:24 INFO - Return code: 0 02:17:24 INFO - Running post-action listener: _resource_record_post_action 02:17:24 INFO - Running post-action listener: _start_resource_monitoring 02:17:24 INFO - Starting resource monitoring. 02:17:24 INFO - [mozharness: 2016-09-02 09:17:24.550433Z] Finished create-virtualenv step (success) 02:17:24 INFO - [mozharness: 2016-09-02 09:17:24.550933Z] Running install step. 02:17:24 INFO - Running pre-action listener: _resource_record_pre_action 02:17:24 INFO - Running main action method: install 02:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:17:24 INFO - Reading from file tmpfile_stdout 02:17:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:17:24 INFO - Reading from file tmpfile_stdout 02:17:24 INFO - Output received: 02:17:24 INFO - Usage: mozinstall [options] installer 02:17:24 INFO - Options: 02:17:24 INFO - -h, --help show this help message and exit 02:17:24 INFO - -d DEST, --destination=DEST 02:17:24 INFO - Directory to install application into. [default: 02:17:24 INFO - "/builds/slave/test"] 02:17:24 INFO - --app=APP Application being installed. [default: firefox] 02:17:24 INFO - mkdir: /builds/slave/test/build/application 02:17:24 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'] 02:17:24 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 02:17:41 INFO - Reading from file tmpfile_stdout 02:17:41 INFO - Output received: 02:17:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:17:41 INFO - Running post-action listener: _resource_record_post_action 02:17:41 INFO - [mozharness: 2016-09-02 09:17:41.847182Z] Finished install step (success) 02:17:41 INFO - [mozharness: 2016-09-02 09:17:41.847522Z] Running run-tests step. 02:17:41 INFO - Running pre-action listener: _resource_record_pre_action 02:17:41 INFO - Running main action method: run_tests 02:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:17:41 INFO - Python 2.7.3 02:17:41 INFO - Return code: 0 02:17:41 INFO - grabbing minidump binary from tooltool 02:17:41 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')]} 02:17:41 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 0x22ca370>, '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 0x22cd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:17:41 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 02:17:41 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 02:17:41 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 02:17:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:17:41 INFO - Return code: 0 02:17:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:17:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:17:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:17:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:17:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:17:41 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/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:17:41 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/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 02:17:41 INFO - Using env: {'DISPLAY': ':0', 02:17:41 INFO - 'HOME': '/home/cltbld', 02:17:41 INFO - 'LANG': 'en_US.UTF-8', 02:17:41 INFO - 'LANGUAGE': 'en_US:en', 02:17:41 INFO - 'LOGNAME': 'cltbld', 02:17:41 INFO - 'MAIL': '/var/mail/cltbld', 02:17:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:17:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:41 INFO - 'MOZ_NO_REMOTE': '1', 02:17:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:41 INFO - 'NO_EM_RESTART': '1', 02:17:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:41 INFO - 'PWD': '/builds/slave/test', 02:17:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:17:41 INFO - 'SHELL': '/bin/bash', 02:17:41 INFO - 'SHLVL': '1', 02:17:41 INFO - 'TERM': 'linux', 02:17:41 INFO - 'TMOUT': '86400', 02:17:41 INFO - 'USER': 'cltbld', 02:17:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516', 02:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:41 INFO - '_': '/tools/buildbot/bin/python'} 02:17:41 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/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:17:42 INFO - mozversion application_buildid: 20160901233010 02:17:42 INFO - mozversion application_changeset: 4c4ce191fc9b444f1f47272293e001707538c105 02:17:42 INFO - mozversion application_display_name: Nightly 02:17:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:17:42 INFO - mozversion application_name: Firefox 02:17:42 INFO - mozversion application_remotingname: firefox 02:17:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:17:42 INFO - mozversion application_vendor: Mozilla 02:17:42 INFO - mozversion application_version: 51.0a1 02:17:42 INFO - mozversion platform_buildid: 20160901233010 02:17:42 INFO - mozversion platform_changeset: 4c4ce191fc9b444f1f47272293e001707538c105 02:17:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:17:42 INFO - mozversion platform_version: 51.0a1 02:17:42 INFO - using testdate: 1472807862 02:17:42 INFO - actual date: 1472807862 02:17:42 INFO - starting webserver on 'localhost:43515' 02:17:42 INFO - SUITE-START | Running 2 tests 02:17:42 INFO - TEST-START | dromaeo_css 02:17:42 INFO - operating with platform_type : linux_ 02:17:42 INFO - Initialising browser for dromaeo_css test... 02:17:42 INFO - TEST-INFO | started process 32435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYboL4q/profile http://localhost:43515/getInfo.html) 02:17:46 INFO - PROCESS | 32435 | __metrics Screen width/height:1600/1200 02:17:46 INFO - PROCESS | 32435 | colorDepth:24 02:17:46 INFO - PROCESS | 32435 | Browser inner width/height: 1024/697 02:17:46 INFO - PROCESS | 32435 | __metrics 02:17:47 INFO - PROCESS | 32435 | 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" 02:17:47 INFO - PROCESS | 32435 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:17:47 INFO - PROCESS | 32435 | console.error: PushService: 02:17:47 INFO - PROCESS | 32435 | stateChangeProcessEnqueue: Error transitioning state 02:17:47 INFO - PROCESS | 32435 | UnknownError 02:17:48 INFO - TEST-INFO | 32435: exit 0 02:17:48 INFO - Browser initialized. 02:17:48 INFO - Running cycle 1/1 for dromaeo_css test... 02:17:48 INFO - TEST-INFO | started process 32517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYboL4q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:00 INFO - PROCESS | 32517 | RSS: Main: 178397184 02:18:00 INFO - PROCESS | 32517 | 02:18:52 INFO - PROCESS | 32517 | 1472807932086 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] 02:21:01 INFO - PROCESS | 32517 | Cycle 1(1): loaded http://localhost:43515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43515/tests/dromaeo/cssquery-ext.html) 02:21:02 INFO - PROCESS | 32517 | RSS: Main: 289325056 02:21:02 INFO - PROCESS | 32517 | 02:24:04 INFO - PROCESS | 32517 | Cycle 1(1): loaded http://localhost:43515/tests/dromaeo/cssquery-ext.html (next: http://localhost:43515/tests/dromaeo/cssquery-jquery.html) 02:24:05 INFO - PROCESS | 32517 | RSS: Main: 273649664 02:24:05 INFO - PROCESS | 32517 | 02:27:07 INFO - PROCESS | 32517 | Cycle 1(1): loaded http://localhost:43515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43515/tests/dromaeo/cssquery-mootools.html) 02:27:08 INFO - PROCESS | 32517 | RSS: Main: 213827584 02:27:08 INFO - PROCESS | 32517 | 02:30:10 INFO - PROCESS | 32517 | Cycle 1(1): loaded http://localhost:43515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43515/tests/dromaeo/cssquery-prototype.html) 02:30:10 INFO - PROCESS | 32517 | RSS: Main: 251834368 02:30:10 INFO - PROCESS | 32517 | 02:33:13 INFO - PROCESS | 32517 | Cycle 1(1): loaded http://localhost:43515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43515/tests/dromaeo/cssquery-yui.html) 02:33:14 INFO - PROCESS | 32517 | RSS: Main: 217300992 02:33:14 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | Cycle 1(1): loaded http://localhost:43515/tests/dromaeo/cssquery-yui.html (next: http://localhost:43515/tests/dromaeo/cssquery-dojo.html) 02:36:17 INFO - PROCESS | 32517 | RSS: Main: 298688512 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | __start_tp_report 02:36:17 INFO - PROCESS | 32517 | _x_x_mozilla_page_load 02:36:17 INFO - PROCESS | 32517 | _x_x_mozilla_page_load_details 02:36:17 INFO - PROCESS | 32517 | |i|pagename|runs| 02:36:17 INFO - PROCESS | 32517 | |0;dojo.html;2982.224621598385;2983.8209707417554;3006.6993300669924;3020.229841390445;3057.0828751374597;5076.593872490201;5152.484751524846;5224.89550208996;5298.0728372534795;5334.51989320961;5266.289050978116;5275.868103297419;5319.308489896318;5321.946780532194;5359.196120581914;4718.97640511797;4769.213079841822;4811.374521312225;4815.614750819926;4818.469968303484;4747.169245382044;4772.212584923501;4792.952070479303;4795.2807078938085;4825.131476334259;4631.814727410916;4685.718856868565;4710.576048155683;4743.383360163174;4745.6440766942615;4666.673332866701;4677.812887484497;4677.836275730333;4688.46082700487;4804.711717296974;4701.083288758693;4713.693609915379;4724.95275047252;4726.149293127236;4740.07568524138;5070.08738427083;5130.51260130287;5203.661761985459;5214.582833373359;5215.348081489814;5533.806316778893;5576;5579.7489112990015;5581.023320918864;5587.55299576037;5582.302212223472;5582.692951887645;5596.972015139898;5601.523870471015;5608.158776183564;5059.569936555397;5227.895442091175;5285.656432331886;5298.099323115041;5344.866378340573;5812.389699081536;5814.825555233349;5815.389384114692;5868.501177399883;5882.176495290662;5583.581231407661;5583.776648933997;5588.720563971785;5589.245451864028;5590.161475778585;5462.535684466785;5544.1960915667805;5605.0751625982075;5607.299087614048;5694.402087780723;5588.636738611977;5603.047481928082;5606.299212598426;5608.943910560843;5609.354924183689;5592.916106258409;5606.243157173811;5607.046802043662;5607.523360514402;5626.24045753818;4249.383839343278;4341.45731783527;4387.14450682114;4397.714148580332;4437.334399839985;3866.8259928303296;3868.1490072184074;3872.7482713623526;3915.1973845362204;3939.625735555118;5341.813036543703;5386.165144402624;5387.515123638891;5388.164834450667;5447.264619276347;5448.155535891943;5532.2531458253425;5568.248286481355;5574.247476590689;5692.686902220335;5238.371395432572;5284.233786100994;5287.762050707727;5288.312519372457;5315.3621565412395;4864.318995340655;4868.707877527359;4871;4871.780769865364;4923.335349727741;5597.412271711493;5730.36965933747;5735.512481439125;5776.277965254343;5780.381493181916;5592.273004509388;5649.6327738696855;5657.15142728594;5660.54715622741;5662.66024038559;5770.711464426846;5774.769009239583;5776.075827867521;5777.942220577908;5778.075507918713;5435.456454354533;5466.453354664502;5515.917261241005;5522;5525.060739674184;5501.174823776466;5574.888502230014;5583.134614134816;5648.971755141198;5715.971420142872;5522.447755224445;5525.198846167364;5528.723563821713;5530.364008139116;5533.667979921218;5380.3274590676165;5508.256385387921;5512.145617429305;5517.117261238182;5583.469570390806;5371.167469042305;5428.7285635718845;5439.619226654097;5451.809186678447;5513.917291240555;5525.0883604204855;5534.557235421237;5536.114221724505;5542.889142217053;5546;5213.739313034257;5215.37415510126;5274.156135018378;5388.515033646991;5424.511793938406 02:36:17 INFO - PROCESS | 32517 | |1;ext.html;572.9942700572993;595.818275425995;605.2404232687978;610.3012051201378;613.3651670521011;31844.20389490264;43543.78228108859;43784;44637.55362446375;44754;41797;45788.77105614467;45829.770851145695;45898.770506147506;45938.54061459385;7985.880211796828;8897.288216942645;9053.818923621524;9054.818903621923;10563.366198028105;10348.172146228284;10746.731331716692;10749.355038697704;10760.569577216902;10761.246712730112;10813.026827585516;10872.782544349107;10875.673729788079;10882.2926509777;10887.510062047228;10737.731556711067;10765.677029689123;10800.459977001197;10802.243842930919;10803.675889723321;10645.722513298453;10727.409992450412;10730.624428145056;10734.624288149877;10734.677959661223;42444.363334550006;42701.35947960783;42789.35815962763;42805.78597106995;42831.1433771326;3375.578052743407;3378.814165220912;3379.3579219948133;3419.23909186769;3578.6421357864006;31965;32484.18789530257;32494;33250.50124248138;33381.83309083463;4296.849610263625;4298.774849167972;4348.543402942677;4443.2224360736745;4502.572255635742;269657;270076;273090;273886;275907;57222;57222.14166787502;57314.7134264326;57336.71331643398;57507.424925751046;60430;60438.39561604416;60542.697286513285;60546.394536054955;60599;17141.657166856843;17416.912915435343;17419.56451088733;17422.041787701546;17428.302867885144;13668.794968075486;13726.588202353945;13734.381952811947;13735.519256825963;13738.175709457464;14657.706845863024;15870.682586348208;15905.363785448684;15915.761263581055;15949.521514354588;5811.912821307684;5847.298324201038;5849.88300233993;5851.970740146272;5880.676562789087;884.5886662701874;1023.4217667018111;1067.2955849139687;1089.128697042363;1094.7208461842338;30312.84843575768;31496.527552086736;31613;31803.20491987719;32266.516002259985;972.1687956796978;972.3686881439354;1084.062286122514;1084.5228099636292;1132.9689982116236;15596.220188990505;16275.91862040706;16290.266937987819;16358.918205408896;16628.6674266514;533994;537230;538576;539200;539307;57383.713081434325;57625.71187144121;57687;57741;57775.711121444125;1240.1690867119053;1318.7098838255567;1352.4387379237703;1379.2069560003038;1380.7238552289582;30942.53586196254;32491.35017299688;33017.17457063593;33021.009369718944;33202.667973319956;48484.51515484941;48899.755501222266;49104.75447622739;49118;49164.50835491599;401709;402900;402962;403769;404308;24884.62673059942;25065;25187.370315742253;25198.370040749127;40236.59763402329;45410;45942.31086533771;46377.53622463732;47140.528594713614;47348.7632561835;39408.80295598504;39585;40769.05465802707;41444;41498.585014149474;39590.802045990735;39596.010099746585;40166.79916600515;40330.596694033855;40672.59327406688;39910.40134398045;40162.598374015884;40277.597224027384;41027.17945641011;41183.382249265684;33517.83241083779;36124.27751445009;36397.45403818998;37176.25647487089;37186;27251.046213382437;27858.721412786424;27936;28119;28172.85913570419 02:36:17 INFO - PROCESS | 32517 | |2;jquery.html;363.99636003639955;392.21165457430556;394.6290486942275;404.971651984361;420.0554115649297;15978.2010899455;19073.664843460945;19273.325433609825;19423.514412139702;19895.602087958232;18756.718649220238;18968;18977.620447591038;19256;19279.518012049706;5420.783168673248;5536.2249285100115;5612.07400778873;5742.052561327376;5742.971285143569;5606.103023516238;5623.297087864017;5661.2357331760095;5663.490285874271;5674.035413979613;5422.8915421691545;5612.69130197839;5650.406707295737;5653.632513886584;5667.234923285345;5637.661740295595;5647.802326918559;5678.091505359164;5686.914696279559;5688.800891968782;4912.9508704913205;5050.974745126287;5085.110105731519;5088.542031217171;5092.032513822399;22588.66117008246;22652.77347226523;22845.42886427836;22857;22868.65697014546;2330.7552706965694;2509.1719732488236;2543.5421624107653;2840.8011439199263;2880.884764609413;13800.654983625389;14060.086094403934;14070.015098943079;14252.287385630782;14512.637184070378;1756.9385071522563;1761.3483011285778;1817.7000794868832;1843.824836640517;1950.317388913883;79132;82547;83270.16729832685;83463.58268208681;83640;9150.81698366029;9702.320837541305;9804.264680148875;9839.704808855746;9843.346976985005;13412.329383530785;13479.528216512375;13496;13497.515273319927;13501.054926155075;7806.41451891099;7980.521168729895;8120.106788253287;8213.34293256538;8253.669853205925;8044.678212871419;8086.676532938734;8181.6318265677;8407;8410.411271211078;3953.644172024474;4107.938380924288;4134.73124246923;4192.182524407772;4201.054762678373;1963.1165975311167;2021.1915233906261;2030.380733876182;2032.7662318833227;2049.3646969439524;845.6067928413195;878.6309749905055;921.6681994481982;986.8667729856521;1010.3634710132569;17479.77981359674;18905.338313158973;19100.522486937938;19177.32879349216;19316.70033737047;971.4365667912735;988.3180605382263;988.6045581767207;1025.041586116983;1092.0280949954388;10002.699919002442;10521.789564208673;10567.788644227227;10568.735781605521;10592.311499752492;449322;452606.73696631304;454382;455543;464970.25446183345;52809.73595132076;70652.646736766;91941;92721;92939;959.0840747086515;978.5841017567506;1009.3741880034426;1010.8129995950773;1010.95450704717;16334.673306533565;16443.506694799176;16800;16878.493645190665;16960.23678934426;41797.79101104475;42445.57554424416;42599;42636.57363426326;45035.54964450314;57276.140857886334;58058;58803.4119658815;59420;60023.099653506106;8357.26025227232;8424.957875210584;8626.439281446686;8638.956805215934;8815.603297851483;11682;12676.619701408972;12853.228806271654;12898.871011289766;13107.803382949454;11167.106631469625;11172;11297.096232301561;11370.772584548427;11701.590444334408;10702.785944281226;11360.943195283971;11384.089272858317;11516.481758321062;12128;11114.333140011626;11479.426028698364;11547.884521154681;11623.244489108181;12074.335911524598;8563.95718021406;8595.613197406257;8702.56487175626;8800.515971621366;8908.821823563621;8296;8405.453645513022;8547.316214702685;8652.048274689652;8749.387542871938 02:36:17 INFO - PROCESS | 32517 | |3;mootools.html;1340.0887396570329;1491.1276903011737;1492.246415560142;1653.9503814885559;1767.142935676196;8571.100034496374;8944.329175311854;8976.192142707163;9191;9205.447673139617;8980.8652870207;8997.190252877239;9009.459432434058;9099.636014559426;9100.544972751353;1934.177974360891;2325.581395348845;2358.492924021335;2381.20229723043;2382.7855493005627;2298.0577963035157;2322.744498105207;2325.9069637214493;2327.1273272522803;2328.196772113618;2281.977180228201;2289.942751431211;2290.484640955788;2345.835791494596;2354.6585745066955;2253.864768113918;2309.711286089239;2313.4910319729634;2327.4530485336018;2328.8951997160084;2298.218605674079;2323.314622186442;2335.1593426366494;2338.4972230970425;2346.296111166643;8941.195292423714;9037.909620903773;9308.255339572817;9366.95316523413;9377.906220937772;5131.717755523445;5207.297014902978;5231.816886408996;5262.868428289324;5275.683458992473;3161.367726454718;3320.750943679234;3339.6493368196234;3390.1863552747163;3424.7260219182403;1009.7172791618359;1043.3218408034763;1052.542144167282;1064.909482693972;1074.3875990685312;12823.807642885271;12896.161749486348;12946.87053129466;12951.028672849574;12997.935010324887;4310.50429200646;4377.693561450668;4504.414426124648;4516.029053753458;4532.9320060199125;10091.344062635904;10099.545520451597;10101.797964040677;10105.9494702526;10112.949435252924;5276.129438642658;5283.682979021271;5288.418273989858;5289.973550132225;5297.5232229099565;4217.810198541073;4692;4816.494268101869;4856.514348565115;4959.652824302337;3814.828332725034;3917.941230881539;3946.5856085111222;4001.3397789365013;4027.2549578328103;1188.5661733467223;1190.7201807575213;1193.1886317304316;1203.296071798008;1209.770143672717;972.4311277902365;985.1724551376877;986.7977064701862;987.827130252203;1001.1840350114634;6007.909881351783;6055.1220073090035;6100.298465676416;6128.938710612926;6144.8771024580155;430.71572761976944;433.7375887588027;440.11976047904193;441.9292913133883;442.35195438682484;3990.1620659661216;4111.506619205655;4156.231097247019;4302.935455968163;4575.313702944585;11217.439128043565;11419.885801142049;11513.827292590619;11538.942305288589;11550.88449115515;11233.775324493465;11310.943445282886;11478.655640330804;11493.367864767351;11501.07991360689;8181.263686268146;8354.832903342021;8361.205685459994;8366.623501942428;8383.077861435237;6277.905831412441;6278.4035516625845;6304.211973503312;6343.809685709436;6350.618962862243;10327.793444131226;10400.687979360631;10562.471876406302;10571.94714026425;10643.254972151875;10407.427591482237;10454.843177352497;10626.309289896131;10780.622678206226;10791.946040269748;6912.4815638826285;7093.255208203064;7095.290470952863;7925.0489941207425;8116.797080073045;7870.881936770838;8206.097329293892;8422.663093476438;8464.534450605275;8643.524606146722;7542.434317426325;7679.884801728091;7772.261635144652;7816.179301173295;7853.960730196312;7459.216782238004;7520.360769334668;7601.885971710318;7703.922960770321;7727.536347819148;7003.194632617314;7106.928930710834;7112.57324560528;7114.573125612273;7120.323569260912;5229.764660590358;5248.921266181087;5255.684658920477;5330.280412144466;5572.080606700011;5287;5353;5403.675779453245;5434.510894019557;5549.611527193058 02:36:17 INFO - PROCESS | 32517 | |4;prototype.html;321.6751081407778;325.9152620318718;326.15363132670717;335.31428229271137;345.3921098865995;5159.767810448529;5217.791288348461;5379.919301210485;5413.539849112825;5414.891702165959;5197.194434862593;5236.717004333934;5258.211268309756;5274.393444753854;5333.839984800453;4113.609207125318;4120.958790412103;4121.938170927424;4123.876283711478;4131.876043718686;3999.1801680655394;4128.89426392539;4128.938065929014;4139.482564679415;4158.334666453368;4130.814113364906;4131.29767939451;4146.460960075186;4151.066010147722;4157.812898419578;4133.545310015896;4134.710570260083;4156.526866514419;4157.210130075307;4177.770222637754;3682.4476328550663;3721.813909304551;3727.38498147808;3729.664330210267;3733.9626603733886;5072.188449848043;5154;5176.870578235536;5216.478352164791;5237.895242095136;4754.429468463772;4764.785584648699;4769.880752981203;4770.212914869043;4777;5370.677759334413;5529.944700552983;5531.723413829292;5597.63615365;5611.663300202001;4017.6183262590007;4020.618041286102;4039.6970227233073;4070.409790580349;4076.184763047402;5723.771049158028;5746.856328591819;5753.88492230153;5771.971140144273;5775.3935836736955;4059.4519739834745;4065.9390109148385;4083.387491876242;4092.1815636872743;4098.303288440972;4005.5393629732953;4068.2270368629866;4082.6733861291027;4120.670346372283;4133.359329303963;4682.41469816273;4698.647601429838;4733.290006499053;4739.810407583727;4758.595519380891;5562.833115006556;5575.048732943437;5591.427943146117;5626.718664066781;5640.85897852557;1354.9796753048713;1360.7142500074897;1426.187073368191;1428.6928310413311;1429.1139493514088;967.949774494667;986.4475893499663;996.6710985374809;1002.2282842211602;1006.3157053203745;5255.316808814906;5277.498637629419;5287.867803304948;5303.416624171338;5314.70769107695;5608.80298230005;5610.579206559524;5620.18507316445;5624.521915637135;5625.156226565966;5192.3769147702515;5282.524572788468;5319.547838433777;5330.546903513167;5360.597955153301;2666.4667816005485;2686.8656567171565;2690.448458066092;2693.151657227967;2697.029069534966;5007.223880298559;5134.690653883235;5138.434772175057;5151.871203219875;5163.66436181647;4825.469198388175;4982.6512144149565;5061.519155680205;5096.426304716095;5137.794488220429;5031.723255220998;5033.3574873191865;5038.682206185196;5100.846974590768;5112.897742045213;4947.293183851565;4949.505049495022;4958.950410495849;4988.054658683044;4998.875028124326;4461.821527139008;4830.2513110467935;4868.391451068616;4880.853574392774;4907.214845624683;4951.3810773653295;5030.773615187399;5040.243963405518;5041.294218809443;5055.797768089235;3742.831572579186;3751.3622684143215;3762.6425489578446;3767.9058023549633;3769.3968964965475;5041.1430056889685;5086.21163719624;5362;5789.507891829242;5798.333191682842;5676.347220069745;5685.175649530877;5697.316322041382;5698.6580805151825;5704.1443783432815;5556.38864729224;5691.288588926384;5697.430256974435;5715.399883012224;5720.3707592165665;5544.168374743821;5568.220449137205;5580.776768929198;5583.1904373864745;5615.326160860723;5649.6327738696855;5666.526703057152;5673.886522269614;5702.975443717421;5719.39767405821;5420.566354691694;5482.369527504228;5514.862128446821;5525.834224973257;5607.41122182165 02:36:17 INFO - PROCESS | 32517 | |5;yui.html;722.2163952111958;733.4169335378374;738.4535443771609;824.6660102658418;852.5822347049948;16874.915625421872;17486.21312040958;17612.20745066472;17681.115944202786;17807.999999999985;15259.847401525982;15620.375184992587;15680;15682.294296756645;16742;805.138501803071;824.9257566818985;827.3629305434812;828.0973738624898;828.1676914700747;662.645484665704;795.5465384730705;800.9839803203932;811.350919264586;819.115355416152;860.7761981884693;863.1454859688894;863.4128792421151;864.5461132905243;869.2524428991063;858.1975852577859;859.2524503681774;859.9785005374885;860.9311255099608;861.3109512390063;506.3695698854949;608.6743592178208;611.8011646214998;613.5061275673081;626.1203009771278;15140.091594504365;15164.848351516564;15196.088234705843;15210.771838422432;15212.923935380251;12936;13552.593422197251;13694.178349299074;13787.379567919368;13865.168089914638;13014.934925325313;13225.470981160743;13336.799948000787;13348.93325533366;13511.527096551672;4386.210482113218;4415.20526305265;4427.4908385535755;4503.977480112611;4617.930731039037;80997.59501202515;81685.18314816835;81712.59143704243;82438.58780706118;85073.57463212706;10621.840672389766;10953.288036277616;11202.215844890943;11269.09847212221;11395.430228488709;19949.800501995083;19952.401427957186;19953.800461995485;19959.50303727226;19961.700574491395;8497.575121243914;8596.355273354524;8788.824223515494;8808.779780505538;8926.018138004814;4898.951010489849;4954.433711603912;4956.900861982812;5020.523050310215;5215.869603259873;3396.3546926083964;3501.492283618861;3502.2295095079044;3502.7022703070525;3502.8949131526097;600.7807150390164;600.8317671052113;601.6390165900425;602.6594973839766;604.157200705014;539.7274376439873;547.622140722908;558.935722391922;637.353086617084;680.897865320196;9234.261259099256;9903.60385584583;10016.54925528353;10104.494775261355;10106.160078223122;636.726207730671;662.8044726805604;714.5177005521252;718.2279050021248;720.4740539406263;4814.807407703653;4888.437829649636;4916.680415773035;4942.135126352874;4957.355543779286;73537.6323118381;73551.63224183845;73608.26391736121;74447;134756;62570.05584469468;66329.66835165794;80736;87164.1283587156;105000.47499762452;54563.727181363836;82810.17189828024;90537.9147747995;93203.53398232965;93873.06126938779;8785.824283514421;8882.733517994471;9185.219256363283;9326.249433603389;9372.859407109036;54931;55496.44503554913;55663;56288.437115628316;56979.86040279254;49997.00029996971;65810.67094664495;67584;77081;84702.57648711963;12280.26318420862;13518.864811351761;13648.863511365156;13781.173129612256;13802.792958105436;15530.378784848479;15743.685126297181;16186.919065404598;16461.83538164651;16558.337666493204;13520.323983800967;13629.454821807016;14074.859251407355;14244;14533.27333633293;13297.867021329663;13620.318984050957;13935.790963135358;14246.572602821932;14264.786028209794;13220.933895330847;13943.886180479474;14089.295535223402;14096.36566354537;14342.354594043501;11303.696278910415;11807.73301663195;12016.459259333526;12076.577319793765;12219.87780122223;10439.321444106108;10635.468226588795;11240.887591123985;11446.828297575377;12346.567870124503 02:36:17 INFO - PROCESS | 32517 | __end_tp_report 02:36:17 INFO - PROCESS | 32517 | __start_cc_report 02:36:17 INFO - PROCESS | 32517 | _x_x_mozilla_cycle_collect,929 02:36:17 INFO - PROCESS | 32517 | __end_cc_report 02:36:17 INFO - PROCESS | 32517 | __startTimestamp1472808977361__endTimestamp 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | ------- Summary: start ------- 02:36:17 INFO - PROCESS | 32517 | Number of tests: 6 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | [#0] dojo.html Cycles:165 Average:5210.76 Median:5435.46 stddev:589.48 (10.8%) stddev-sans-first:564.76 02:36:17 INFO - PROCESS | 32517 | Values: 2982.2 2983.8 3006.7 3020.2 3057.1 5076.6 5152.5 5224.9 5298.1 5334.5 5266.3 5275.9 5319.3 5321.9 5359.2 4719.0 4769.2 4811.4 4815.6 4818.5 4747.2 4772.2 4793.0 4795.3 4825.1 4631.8 4685.7 4710.6 4743.4 4745.6 4666.7 4677.8 4677.8 4688.5 4804.7 4701.1 4713.7 4725.0 4726.1 4740.1 5070.1 5130.5 5203.7 5214.6 5215.3 5533.8 5576.0 5579.7 5581.0 5587.6 5582.3 5582.7 5597.0 5601.5 5608.2 5059.6 5227.9 5285.7 5298.1 5344.9 5812.4 5814.8 5815.4 5868.5 5882.2 5583.6 5583.8 5588.7 5589.2 5590.2 5462.5 5544.2 5605.1 5607.3 5694.4 5588.6 5603.0 5606.3 5608.9 5609.4 5592.9 5606.2 5607.0 5607.5 5626.2 4249.4 4341.5 4387.1 4397.7 4437.3 3866.8 3868.1 3872.7 3915.2 3939.6 5341.8 5386.2 5387.5 5388.2 5447.3 5448.2 5532.3 5568.2 5574.2 5692.7 5238.4 5284.2 5287.8 5288.3 5315.4 4864.3 4868.7 4871.0 4871.8 4923.3 5597.4 5730.4 5735.5 5776.3 5780.4 5592.3 5649.6 5657.2 5660.5 5662.7 5770.7 5774.8 5776.1 5777.9 5778.1 5435.5 5466.5 5515.9 5522.0 5525.1 5501.2 5574.9 5583.1 5649.0 5716.0 5522.4 5525.2 5528.7 5530.4 5533.7 5380.3 5508.3 5512.1 5517.1 5583.5 5371.2 5428.7 5439.6 5451.8 5513.9 5525.1 5534.6 5536.1 5542.9 5546.0 5213.7 5215.4 5274.2 5388.5 5424.5 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | [#1] ext.html Cycles:180 Average:57121.97 Median:36786.86 stddev:111037.43 (301.8%) stddev-sans-first:111267.75 02:36:17 INFO - PROCESS | 32517 | Values: 573.0 595.8 605.2 610.3 613.4 31844.2 43543.8 43784.0 44637.6 44754.0 41797.0 45788.8 45829.8 45898.8 45938.5 7985.9 8897.3 9053.8 9054.8 10563.4 10348.2 10746.7 10749.4 10760.6 10761.2 10813.0 10872.8 10875.7 10882.3 10887.5 10737.7 10765.7 10800.5 10802.2 10803.7 10645.7 10727.4 10730.6 10734.6 10734.7 42444.4 42701.4 42789.4 42805.8 42831.1 3375.6 3378.8 3379.4 3419.2 3578.6 31965.0 32484.2 32494.0 33250.5 33381.8 4296.8 4298.8 4348.5 4443.2 4502.6 269657.0 270076.0 273090.0 273886.0 275907.0 57222.0 57222.1 57314.7 57336.7 57507.4 60430.0 60438.4 60542.7 60546.4 60599.0 17141.7 17416.9 17419.6 17422.0 17428.3 13668.8 13726.6 13734.4 13735.5 13738.2 14657.7 15870.7 15905.4 15915.8 15949.5 5811.9 5847.3 5849.9 5852.0 5880.7 884.6 1023.4 1067.3 1089.1 1094.7 30312.8 31496.5 31613.0 31803.2 32266.5 972.2 972.4 1084.1 1084.5 1133.0 15596.2 16275.9 16290.3 16358.9 16628.7 533994.0 537230.0 538576.0 539200.0 539307.0 57383.7 57625.7 57687.0 57741.0 57775.7 1240.2 1318.7 1352.4 1379.2 1380.7 30942.5 32491.4 33017.2 33021.0 33202.7 48484.5 48899.8 49104.8 49118.0 49164.5 401709.0 402900.0 402962.0 403769.0 404308.0 24884.6 25065.0 25187.4 25198.4 40236.6 45410.0 45942.3 46377.5 47140.5 47348.8 39408.8 39585.0 40769.1 41444.0 41498.6 39590.8 39596.0 40166.8 40330.6 40672.6 39910.4 40162.6 40277.6 41027.2 41183.4 33517.8 36124.3 36397.5 37176.3 37186.0 27251.0 27858.7 27936.0 28119.0 28172.9 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | [#2] jquery.html Cycles:180 Average:27609.35 Median:2310.56 stddev:75165.84 (3253.2%) stddev-sans-first:75348.86 02:36:17 INFO - PROCESS | 32517 | Values: 364.0 392.2 394.6 405.0 420.1 15978.2 19073.7 19273.3 19423.5 19895.6 18756.7 18968.0 18977.6 19256.0 19279.5 5420.8 5536.2 5612.1 5742.1 5743.0 5606.1 5623.3 5661.2 5663.5 5674.0 5422.9 5612.7 5650.4 5653.6 5667.2 5637.7 5647.8 5678.1 5686.9 5688.8 4913.0 5051.0 5085.1 5088.5 5092.0 22588.7 22652.8 22845.4 22857.0 22868.7 2330.8 2509.2 2543.5 2840.8 2880.9 13800.7 14060.1 14070.0 14252.3 14512.6 1756.9 1761.3 1817.7 1843.8 1950.3 79132.0 82547.0 83270.2 83463.6 83640.0 9150.8 9702.3 9804.3 9839.7 9843.3 13412.3 13479.5 13496.0 13497.5 13501.1 7806.4 7980.5 8120.1 8213.3 8253.7 8044.7 8086.7 8181.6 8407.0 8410.4 3953.6 4107.9 4134.7 4192.2 4201.1 1963.1 2021.2 2030.4 2032.8 2049.4 845.6 878.6 921.7 986.9 1010.4 17479.8 18905.3 19100.5 19177.3 19316.7 971.4 988.3 988.6 1025.0 1092.0 10002.7 10521.8 10567.8 10568.7 10592.3 449322.0 452606.7 454382.0 455543.0 464970.3 52809.7 70652.6 91941.0 92721.0 92939.0 959.1 978.6 1009.4 1010.8 1011.0 16334.7 16443.5 16800.0 16878.5 16960.2 41797.8 42445.6 42599.0 42636.6 45035.5 57276.1 58058.0 58803.4 59420.0 60023.1 8357.3 8425.0 8626.4 8639.0 8815.6 11682.0 12676.6 12853.2 12898.9 13107.8 11167.1 11172.0 11297.1 11370.8 11701.6 10702.8 11360.9 11384.1 11516.5 12128.0 11114.3 11479.4 11547.9 11623.2 12074.3 8564.0 8595.6 8702.6 8800.5 8908.8 8296.0 8405.5 8547.3 8652.0 8749.4 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | [#3] mootools.html Cycles:180 Average:5882.67 Median:441.02 stddev:3447.93 (781.8%) stddev-sans-first:3440.70 02:36:17 INFO - PROCESS | 32517 | Values: 1340.1 1491.1 1492.2 1654.0 1767.1 8571.1 8944.3 8976.2 9191.0 9205.4 8980.9 8997.2 9009.5 9099.6 9100.5 1934.2 2325.6 2358.5 2381.2 2382.8 2298.1 2322.7 2325.9 2327.1 2328.2 2282.0 2289.9 2290.5 2345.8 2354.7 2253.9 2309.7 2313.5 2327.5 2328.9 2298.2 2323.3 2335.2 2338.5 2346.3 8941.2 9037.9 9308.3 9367.0 9377.9 5131.7 5207.3 5231.8 5262.9 5275.7 3161.4 3320.8 3339.6 3390.2 3424.7 1009.7 1043.3 1052.5 1064.9 1074.4 12823.8 12896.2 12946.9 12951.0 12997.9 4310.5 4377.7 4504.4 4516.0 4532.9 10091.3 10099.5 10101.8 10105.9 10112.9 5276.1 5283.7 5288.4 5290.0 5297.5 4217.8 4692.0 4816.5 4856.5 4959.7 3814.8 3917.9 3946.6 4001.3 4027.3 1188.6 1190.7 1193.2 1203.3 1209.8 972.4 985.2 986.8 987.8 1001.2 6007.9 6055.1 6100.3 6128.9 6144.9 430.7 433.7 440.1 441.9 442.4 3990.2 4111.5 4156.2 4302.9 4575.3 11217.4 11419.9 11513.8 11538.9 11550.9 11233.8 11310.9 11478.7 11493.4 11501.1 8181.3 8354.8 8361.2 8366.6 8383.1 6277.9 6278.4 6304.2 6343.8 6350.6 10327.8 10400.7 10562.5 10571.9 10643.3 10407.4 10454.8 10626.3 10780.6 10791.9 6912.5 7093.3 7095.3 7925.0 8116.8 7870.9 8206.1 8422.7 8464.5 8643.5 7542.4 7679.9 7772.3 7816.2 7854.0 7459.2 7520.4 7601.9 7703.9 7727.5 7003.2 7106.9 7112.6 7114.6 7120.3 5229.8 5248.9 5255.7 5330.3 5572.1 5287.0 5353.0 5403.7 5434.5 5549.6 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | [#4] prototype.html Cycles:180 Average:4541.31 Median:5040.69 stddev:1315.17 (26.1%) stddev-sans-first:1280.16 02:36:17 INFO - PROCESS | 32517 | Values: 321.7 325.9 326.2 335.3 345.4 5159.8 5217.8 5379.9 5413.5 5414.9 5197.2 5236.7 5258.2 5274.4 5333.8 4113.6 4121.0 4121.9 4123.9 4131.9 3999.2 4128.9 4128.9 4139.5 4158.3 4130.8 4131.3 4146.5 4151.1 4157.8 4133.5 4134.7 4156.5 4157.2 4177.8 3682.4 3721.8 3727.4 3729.7 3734.0 5072.2 5154.0 5176.9 5216.5 5237.9 4754.4 4764.8 4769.9 4770.2 4777.0 5370.7 5529.9 5531.7 5597.6 5611.7 4017.6 4020.6 4039.7 4070.4 4076.2 5723.8 5746.9 5753.9 5772.0 5775.4 4059.5 4065.9 4083.4 4092.2 4098.3 4005.5 4068.2 4082.7 4120.7 4133.4 4682.4 4698.6 4733.3 4739.8 4758.6 5562.8 5575.0 5591.4 5626.7 5640.9 1355.0 1360.7 1426.2 1428.7 1429.1 967.9 986.4 996.7 1002.2 1006.3 5255.3 5277.5 5287.9 5303.4 5314.7 5608.8 5610.6 5620.2 5624.5 5625.2 5192.4 5282.5 5319.5 5330.5 5360.6 2666.5 2686.9 2690.4 2693.2 2697.0 5007.2 5134.7 5138.4 5151.9 5163.7 4825.5 4982.7 5061.5 5096.4 5137.8 5031.7 5033.4 5038.7 5100.8 5112.9 4947.3 4949.5 4959.0 4988.1 4998.9 4461.8 4830.3 4868.4 4880.9 4907.2 4951.4 5030.8 5040.2 5041.3 5055.8 3742.8 3751.4 3762.6 3767.9 3769.4 5041.1 5086.2 5362.0 5789.5 5798.3 5676.3 5685.2 5697.3 5698.7 5704.1 5556.4 5691.3 5697.4 5715.4 5720.4 5544.2 5568.2 5580.8 5583.2 5615.3 5649.6 5666.5 5673.9 5703.0 5719.4 5420.6 5482.4 5514.9 5525.8 5607.4 02:36:17 INFO - PROCESS | 32517 | 02:36:17 INFO - PROCESS | 32517 | [#5] yui.html Cycles:180 Average:19710.27 Median:4955.67 stddev:26904.74 (542.9%) stddev-sans-first:26942.43 02:36:17 INFO - PROCESS | 32517 | Values: 722.2 733.4 738.5 824.7 852.6 16874.9 17486.2 17612.2 17681.1 17808.0 15259.8 15620.4 15680.0 15682.3 16742.0 805.1 824.9 827.4 828.1 828.2 662.6 795.5 801.0 811.4 819.1 860.8 863.1 863.4 864.5 869.3 858.2 859.3 860.0 860.9 861.3 506.4 608.7 611.8 613.5 626.1 15140.1 15164.8 15196.1 15210.8 15212.9 12936.0 13552.6 13694.2 13787.4 13865.2 13014.9 13225.5 13336.8 13348.9 13511.5 4386.2 4415.2 4427.5 4504.0 4617.9 80997.6 81685.2 81712.6 82438.6 85073.6 10621.8 10953.3 11202.2 11269.1 11395.4 19949.8 19952.4 19953.8 19959.5 19961.7 8497.6 8596.4 8788.8 8808.8 8926.0 4899.0 4954.4 4956.9 5020.5 5215.9 3396.4 3501.5 3502.2 3502.7 3502.9 600.8 600.8 601.6 602.7 604.2 539.7 547.6 558.9 637.4 680.9 9234.3 9903.6 10016.5 10104.5 10106.2 636.7 662.8 714.5 718.2 720.5 4814.8 4888.4 4916.7 4942.1 4957.4 73537.6 73551.6 73608.3 74447.0 134756.0 62570.1 66329.7 80736.0 87164.1 105000.5 54563.7 82810.2 90537.9 93203.5 93873.1 8785.8 8882.7 9185.2 9326.2 9372.9 54931.0 55496.4 55663.0 56288.4 56979.9 49997.0 65810.7 67584.0 77081.0 84702.6 12280.3 13518.9 13648.9 13781.2 13802.8 15530.4 15743.7 16186.9 16461.8 16558.3 13520.3 13629.5 14074.9 14244.0 14533.3 13297.9 13620.3 13935.8 14246.6 14264.8 13220.9 13943.9 14089.3 14096.4 14342.4 11303.7 11807.7 12016.5 12076.6 12219.9 10439.3 10635.5 11240.9 11446.8 12346.6 02:36:17 INFO - PROCESS | 32517 | -------- Summary: end -------- 02:36:17 INFO - PROCESS | 32517 | 02:36:18 INFO - TEST-INFO | 32517: exit 0 02:36:18 INFO - TEST-OK | dromaeo_css | took 1116162ms 02:36:18 INFO - TEST-START | kraken 02:36:18 INFO - operating with platform_type : linux_ 02:36:18 INFO - Initialising browser for kraken test... 02:36:18 INFO - TEST-INFO | started process 355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNPNhWF/profile http://localhost:43515/getInfo.html) 02:36:22 INFO - PROCESS | 355 | __metrics Screen width/height:1600/1200 02:36:22 INFO - PROCESS | 355 | colorDepth:24 02:36:22 INFO - PROCESS | 355 | Browser inner width/height: 1024/697 02:36:22 INFO - PROCESS | 355 | __metrics 02:36:22 INFO - PROCESS | 355 | 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" 02:36:22 INFO - PROCESS | 355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:36:23 INFO - PROCESS | 355 | console.error: PushService: 02:36:23 INFO - PROCESS | 355 | stateChangeProcessEnqueue: Error transitioning state 02:36:23 INFO - PROCESS | 355 | UnknownError 02:36:24 INFO - TEST-INFO | 355: exit 0 02:36:24 INFO - Browser initialized. 02:36:24 INFO - Running cycle 1/1 for kraken test... 02:36:24 INFO - TEST-INFO | started process 441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNPNhWF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:36 INFO - PROCESS | 441 | RSS: Main: 179060736 02:36:36 INFO - PROCESS | 441 | 02:36:38 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43515/tests/kraken/driver.html?testName=audio-beat-detection) 02:36:39 INFO - PROCESS | 441 | RSS: Main: 234545152 02:36:39 INFO - PROCESS | 441 | 02:36:42 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43515/tests/kraken/driver.html?testName=audio-dft) 02:36:42 INFO - PROCESS | 441 | RSS: Main: 223883264 02:36:42 INFO - PROCESS | 441 | 02:36:46 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43515/tests/kraken/driver.html?testName=audio-fft) 02:36:46 INFO - PROCESS | 441 | RSS: Main: 302010368 02:36:46 INFO - PROCESS | 441 | 02:36:48 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43515/tests/kraken/driver.html?testName=audio-oscillator) 02:36:49 INFO - PROCESS | 441 | RSS: Main: 212303872 02:36:49 INFO - PROCESS | 441 | 02:36:51 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:36:51 INFO - PROCESS | 441 | RSS: Main: 213901312 02:36:51 INFO - PROCESS | 441 | 02:36:55 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43515/tests/kraken/driver.html?testName=imaging-darkroom) 02:36:55 INFO - PROCESS | 441 | RSS: Main: 252604416 02:36:55 INFO - PROCESS | 441 | 02:36:58 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43515/tests/kraken/driver.html?testName=imaging-desaturate) 02:36:59 INFO - PROCESS | 441 | RSS: Main: 250994688 02:36:59 INFO - PROCESS | 441 | 02:37:02 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43515/tests/kraken/driver.html?testName=json-parse-financial) 02:37:02 INFO - PROCESS | 441 | RSS: Main: 252256256 02:37:02 INFO - PROCESS | 441 | 02:37:04 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:37:05 INFO - PROCESS | 441 | RSS: Main: 213925888 02:37:05 INFO - PROCESS | 441 | 02:37:06 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:37:07 INFO - PROCESS | 441 | RSS: Main: 220712960 02:37:07 INFO - PROCESS | 441 | 02:37:09 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:37:10 INFO - PROCESS | 441 | RSS: Main: 222584832 02:37:10 INFO - PROCESS | 441 | 02:37:12 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:37:13 INFO - PROCESS | 441 | RSS: Main: 224436224 02:37:13 INFO - PROCESS | 441 | 02:37:16 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:37:16 INFO - PROCESS | 441 | RSS: Main: 222060544 02:37:16 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | Cycle 1(1): loaded http://localhost:43515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43515/tests/kraken/driver.html?testName=ai-astar) 02:37:18 INFO - PROCESS | 441 | RSS: Main: 272891904 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | __start_tp_report 02:37:18 INFO - PROCESS | 441 | _x_x_mozilla_page_load 02:37:18 INFO - PROCESS | 441 | _x_x_mozilla_page_load_details 02:37:18 INFO - PROCESS | 441 | |i|pagename|runs| 02:37:18 INFO - PROCESS | 441 | |0;ai-astar;111;112;117;111;114;113;111;112;112;126 02:37:18 INFO - PROCESS | 441 | |1;audio-beat-detection;150;116;152;191;121;154;149;128;187;118 02:37:18 INFO - PROCESS | 441 | |2;audio-dft;163;162;159;163;161;162;161;160;160;161 02:37:18 INFO - PROCESS | 441 | |3;audio-fft;76;75;76;171;77;75;74;75;179;76 02:37:18 INFO - PROCESS | 441 | |4;audio-oscillator;81;82;148;83;81;81;140;81;81;146 02:37:18 INFO - PROCESS | 441 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;117;117 02:37:18 INFO - PROCESS | 441 | |6;imaging-darkroom;145;146;145;146;146;145;145;146;147;145 02:37:18 INFO - PROCESS | 441 | |7;imaging-desaturate;95;95;95;95;99;95;95;94;95;95 02:37:18 INFO - PROCESS | 441 | |8;json-parse-financial;52;51;54;52;53;53;53;53;53;53 02:37:18 INFO - PROCESS | 441 | |9;json-stringify-tinderbox;61;62;62;62;62;62;61;62;62;62 02:37:18 INFO - PROCESS | 441 | |10;stanford-crypto-aes;79;82;77;78;77;79;80;84;78;78 02:37:18 INFO - PROCESS | 441 | |11;stanford-crypto-ccm;125;122;122;126;123;120;131;132;165;127 02:37:18 INFO - PROCESS | 441 | |12;stanford-crypto-pbkdf2;165;162;168;164;164;163;164;166;161;161 02:37:18 INFO - PROCESS | 441 | |13;stanford-crypto-sha256-iterative;73;68;65;64;64;64;63;65;62;63 02:37:18 INFO - PROCESS | 441 | __end_tp_report 02:37:18 INFO - PROCESS | 441 | __start_cc_report 02:37:18 INFO - PROCESS | 441 | _x_x_mozilla_cycle_collect,1738 02:37:18 INFO - PROCESS | 441 | __end_cc_report 02:37:18 INFO - PROCESS | 441 | __startTimestamp1472809038707__endTimestamp 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | ------- Summary: start ------- 02:37:18 INFO - PROCESS | 441 | Number of tests: 14 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#0] ai-astar Cycles:10 Average:113.90 Median:112.50 stddev:4.63 (4.1%) stddev-sans-first:4.79 02:37:18 INFO - PROCESS | 441 | Values: 111.0 112.0 117.0 111.0 114.0 113.0 111.0 112.0 112.0 126.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:151.00 stddev:26.79 (17.7%) stddev-sans-first:28.39 02:37:18 INFO - PROCESS | 441 | Values: 150.0 116.0 152.0 191.0 121.0 154.0 149.0 128.0 187.0 118.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.22 02:37:18 INFO - PROCESS | 441 | Values: 163.0 162.0 159.0 163.0 161.0 162.0 161.0 160.0 160.0 161.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:42.00 (55.6%) stddev-sans-first:43.96 02:37:18 INFO - PROCESS | 441 | Values: 76.0 75.0 76.0 171.0 77.0 75.0 74.0 75.0 179.0 76.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#4] audio-oscillator Cycles:10 Average:100.40 Median:81.00 stddev:30.62 (37.8%) stddev-sans-first:31.66 02:37:18 INFO - PROCESS | 441 | Values: 81.0 82.0 148.0 83.0 81.0 81.0 140.0 81.0 81.0 146.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:37:18 INFO - PROCESS | 441 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:37:18 INFO - PROCESS | 441 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 147.0 145.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.34 (1.4%) stddev-sans-first:1.41 02:37:18 INFO - PROCESS | 441 | Values: 95.0 95.0 95.0 95.0 99.0 95.0 95.0 94.0 95.0 95.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 02:37:18 INFO - PROCESS | 441 | Values: 52.0 51.0 54.0 52.0 53.0 53.0 53.0 53.0 53.0 53.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 02:37:18 INFO - PROCESS | 441 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:2.25 (2.8%) stddev-sans-first:2.39 02:37:18 INFO - PROCESS | 441 | Values: 79.0 82.0 77.0 78.0 77.0 79.0 80.0 84.0 78.0 78.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:126.50 stddev:13.13 (10.4%) stddev-sans-first:13.84 02:37:18 INFO - PROCESS | 441 | Values: 125.0 122.0 122.0 126.0 123.0 120.0 131.0 132.0 165.0 127.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.00 stddev:2.20 (1.3%) stddev-sans-first:2.29 02:37:18 INFO - PROCESS | 441 | Values: 165.0 162.0 168.0 164.0 164.0 163.0 164.0 166.0 161.0 161.0 02:37:18 INFO - PROCESS | 441 | 02:37:18 INFO - PROCESS | 441 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:64.50 stddev:3.21 (5.0%) stddev-sans-first:1.72 02:37:18 INFO - PROCESS | 441 | Values: 73.0 68.0 65.0 64.0 64.0 64.0 63.0 65.0 62.0 63.0 02:37:18 INFO - PROCESS | 441 | -------- Summary: end -------- 02:37:18 INFO - PROCESS | 441 | 02:37:19 INFO - TEST-INFO | 441: exit 0 02:37:19 INFO - TEST-OK | kraken | took 61643ms 02:37:19 INFO - SUITE-END | took 1177s 02:37:20 INFO - Completed test suite (00:19:38) 02:37:20 INFO - javascript benchmark 02:37:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2982.224621598385, 2983.8209707417554, 3006.6993300669924, 3020.229841390445, 3057.0828751374597, 5076.593872490201, 5152.484751524846, 5224.89550208996, 5298.0728372534795, 5334.51989320961, 5266.289050978116, 5275.868103297419, 5319.308489896318, 5321.946780532194, 5359.196120581914, 4718.97640511797, 4769.213079841822, 4811.374521312225, 4815.614750819926, 4818.469968303484, 4747.169245382044, 4772.212584923501, 4792.952070479303, 4795.2807078938085, 4825.131476334259, 4631.814727410916, 4685.718856868565, 4710.576048155683, 4743.383360163174, 4745.6440766942615, 4666.673332866701, 4677.812887484497, 4677.836275730333, 4688.46082700487, 4804.711717296974, 4701.083288758693, 4713.693609915379, 4724.95275047252, 4726.149293127236, 4740.07568524138, 5070.08738427083, 5130.51260130287, 5203.661761985459, 5214.582833373359, 5215.348081489814, 5533.806316778893, 5576.0, 5579.7489112990015, 5581.023320918864, 5587.55299576037, 5582.302212223472, 5582.692951887645, 5596.972015139898, 5601.523870471015, 5608.158776183564, 5059.569936555397, 5227.895442091175, 5285.656432331886, 5298.099323115041, 5344.866378340573, 5812.389699081536, 5814.825555233349, 5815.389384114692, 5868.501177399883, 5882.176495290662, 5583.581231407661, 5583.776648933997, 5588.720563971785, 5589.245451864028, 5590.161475778585, 5462.535684466785, 5544.1960915667805, 5605.0751625982075, 5607.299087614048, 5694.402087780723, 5588.636738611977, 5603.047481928082, 5606.299212598426, 5608.943910560843, 5609.354924183689, 5592.916106258409, 5606.243157173811, 5607.046802043662, 5607.523360514402, 5626.24045753818, 4249.383839343278, 4341.45731783527, 4387.14450682114, 4397.714148580332, 4437.334399839985, 3866.8259928303296, 3868.1490072184074, 3872.7482713623526, 3915.1973845362204, 3939.625735555118, 5341.813036543703, 5386.165144402624, 5387.515123638891, 5388.164834450667, 5447.264619276347, 5448.155535891943, 5532.2531458253425, 5568.248286481355, 5574.247476590689, 5692.686902220335, 5238.371395432572, 5284.233786100994, 5287.762050707727, 5288.312519372457, 5315.3621565412395, 4864.318995340655, 4868.707877527359, 4871.0, 4871.780769865364, 4923.335349727741, 5597.412271711493, 5730.36965933747, 5735.512481439125, 5776.277965254343, 5780.381493181916, 5592.273004509388, 5649.6327738696855, 5657.15142728594, 5660.54715622741, 5662.66024038559, 5770.711464426846, 5774.769009239583, 5776.075827867521, 5777.942220577908, 5778.075507918713, 5435.456454354533, 5466.453354664502, 5515.917261241005, 5522.0, 5525.060739674184, 5501.174823776466, 5574.888502230014, 5583.134614134816, 5648.971755141198, 5715.971420142872, 5522.447755224445, 5525.198846167364, 5528.723563821713, 5530.364008139116, 5533.667979921218, 5380.3274590676165, 5508.256385387921, 5512.145617429305, 5517.117261238182, 5583.469570390806, 5371.167469042305, 5428.7285635718845, 5439.619226654097, 5451.809186678447, 5513.917291240555, 5525.0883604204855, 5534.557235421237, 5536.114221724505, 5542.889142217053, 5546.0, 5213.739313034257, 5215.37415510126, 5274.156135018378, 5388.515033646991, 5424.511793938406], "value": 5171.004445286272, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.9942700572993, 595.818275425995, 605.2404232687978, 610.3012051201378, 613.3651670521011, 31844.20389490264, 43543.78228108859, 43784.0, 44637.55362446375, 44754.0, 41797.0, 45788.77105614467, 45829.770851145695, 45898.770506147506, 45938.54061459385, 7985.880211796828, 8897.288216942645, 9053.818923621524, 9054.818903621923, 10563.366198028105, 10348.172146228284, 10746.731331716692, 10749.355038697704, 10760.569577216902, 10761.246712730112, 10813.026827585516, 10872.782544349107, 10875.673729788079, 10882.2926509777, 10887.510062047228, 10737.731556711067, 10765.677029689123, 10800.459977001197, 10802.243842930919, 10803.675889723321, 10645.722513298453, 10727.409992450412, 10730.624428145056, 10734.624288149877, 10734.677959661223, 42444.363334550006, 42701.35947960783, 42789.35815962763, 42805.78597106995, 42831.1433771326, 3375.578052743407, 3378.814165220912, 3379.3579219948133, 3419.23909186769, 3578.6421357864006, 31965.0, 32484.18789530257, 32494.0, 33250.50124248138, 33381.83309083463, 4296.849610263625, 4298.774849167972, 4348.543402942677, 4443.2224360736745, 4502.572255635742, 269657.0, 270076.0, 273090.0, 273886.0, 275907.0, 57222.0, 57222.14166787502, 57314.7134264326, 57336.71331643398, 57507.424925751046, 60430.0, 60438.39561604416, 60542.697286513285, 60546.394536054955, 60599.0, 17141.657166856843, 17416.912915435343, 17419.56451088733, 17422.041787701546, 17428.302867885144, 13668.794968075486, 13726.588202353945, 13734.381952811947, 13735.519256825963, 13738.175709457464, 14657.706845863024, 15870.682586348208, 15905.363785448684, 15915.761263581055, 15949.521514354588, 5811.912821307684, 5847.298324201038, 5849.88300233993, 5851.970740146272, 5880.676562789087, 884.5886662701874, 1023.4217667018111, 1067.2955849139687, 1089.128697042363, 1094.7208461842338, 30312.84843575768, 31496.527552086736, 31613.0, 31803.20491987719, 32266.516002259985, 972.1687956796978, 972.3686881439354, 1084.062286122514, 1084.5228099636292, 1132.9689982116236, 15596.220188990505, 16275.91862040706, 16290.266937987819, 16358.918205408896, 16628.6674266514, 533994.0, 537230.0, 538576.0, 539200.0, 539307.0, 57383.713081434325, 57625.71187144121, 57687.0, 57741.0, 57775.711121444125, 1240.1690867119053, 1318.7098838255567, 1352.4387379237703, 1379.2069560003038, 1380.7238552289582, 30942.53586196254, 32491.35017299688, 33017.17457063593, 33021.009369718944, 33202.667973319956, 48484.51515484941, 48899.755501222266, 49104.75447622739, 49118.0, 49164.50835491599, 401709.0, 402900.0, 402962.0, 403769.0, 404308.0, 24884.62673059942, 25065.0, 25187.370315742253, 25198.370040749127, 40236.59763402329, 45410.0, 45942.31086533771, 46377.53622463732, 47140.528594713614, 47348.7632561835, 39408.80295598504, 39585.0, 40769.05465802707, 41444.0, 41498.585014149474, 39590.802045990735, 39596.010099746585, 40166.79916600515, 40330.596694033855, 40672.59327406688, 39910.40134398045, 40162.598374015884, 40277.597224027384, 41027.17945641011, 41183.382249265684, 33517.83241083779, 36124.27751445009, 36397.45403818998, 37176.25647487089, 37186.0, 27251.046213382437, 27858.721412786424, 27936.0, 28119.0, 28172.85913570419], "value": 20054.83168239954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.99636003639955, 392.21165457430556, 394.6290486942275, 404.971651984361, 420.0554115649297, 15978.2010899455, 19073.664843460945, 19273.325433609825, 19423.514412139702, 19895.602087958232, 18756.718649220238, 18968.0, 18977.620447591038, 19256.0, 19279.518012049706, 5420.783168673248, 5536.2249285100115, 5612.07400778873, 5742.052561327376, 5742.971285143569, 5606.103023516238, 5623.297087864017, 5661.2357331760095, 5663.490285874271, 5674.035413979613, 5422.8915421691545, 5612.69130197839, 5650.406707295737, 5653.632513886584, 5667.234923285345, 5637.661740295595, 5647.802326918559, 5678.091505359164, 5686.914696279559, 5688.800891968782, 4912.9508704913205, 5050.974745126287, 5085.110105731519, 5088.542031217171, 5092.032513822399, 22588.66117008246, 22652.77347226523, 22845.42886427836, 22857.0, 22868.65697014546, 2330.7552706965694, 2509.1719732488236, 2543.5421624107653, 2840.8011439199263, 2880.884764609413, 13800.654983625389, 14060.086094403934, 14070.015098943079, 14252.287385630782, 14512.637184070378, 1756.9385071522563, 1761.3483011285778, 1817.7000794868832, 1843.824836640517, 1950.317388913883, 79132.0, 82547.0, 83270.16729832685, 83463.58268208681, 83640.0, 9150.81698366029, 9702.320837541305, 9804.264680148875, 9839.704808855746, 9843.346976985005, 13412.329383530785, 13479.528216512375, 13496.0, 13497.515273319927, 13501.054926155075, 7806.41451891099, 7980.521168729895, 8120.106788253287, 8213.34293256538, 8253.669853205925, 8044.678212871419, 8086.676532938734, 8181.6318265677, 8407.0, 8410.411271211078, 3953.644172024474, 4107.938380924288, 4134.73124246923, 4192.182524407772, 4201.054762678373, 1963.1165975311167, 2021.1915233906261, 2030.380733876182, 2032.7662318833227, 2049.3646969439524, 845.6067928413195, 878.6309749905055, 921.6681994481982, 986.8667729856521, 1010.3634710132569, 17479.77981359674, 18905.338313158973, 19100.522486937938, 19177.32879349216, 19316.70033737047, 971.4365667912735, 988.3180605382263, 988.6045581767207, 1025.041586116983, 1092.0280949954388, 10002.699919002442, 10521.789564208673, 10567.788644227227, 10568.735781605521, 10592.311499752492, 449322.0, 452606.73696631304, 454382.0, 455543.0, 464970.25446183345, 52809.73595132076, 70652.646736766, 91941.0, 92721.0, 92939.0, 959.0840747086515, 978.5841017567506, 1009.3741880034426, 1010.8129995950773, 1010.95450704717, 16334.673306533565, 16443.506694799176, 16800.0, 16878.493645190665, 16960.23678934426, 41797.79101104475, 42445.57554424416, 42599.0, 42636.57363426326, 45035.54964450314, 57276.140857886334, 58058.0, 58803.4119658815, 59420.0, 60023.099653506106, 8357.26025227232, 8424.957875210584, 8626.439281446686, 8638.956805215934, 8815.603297851483, 11682.0, 12676.619701408972, 12853.228806271654, 12898.871011289766, 13107.803382949454, 11167.106631469625, 11172.0, 11297.096232301561, 11370.772584548427, 11701.590444334408, 10702.785944281226, 11360.943195283971, 11384.089272858317, 11516.481758321062, 12128.0, 11114.333140011626, 11479.426028698364, 11547.884521154681, 11623.244489108181, 12074.335911524598, 8563.95718021406, 8595.613197406257, 8702.56487175626, 8800.515971621366, 8908.821823563621, 8296.0, 8405.453645513022, 8547.316214702685, 8652.048274689652, 8749.387542871938], "value": 8998.21272075423, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.0887396570329, 1491.1276903011737, 1492.246415560142, 1653.9503814885559, 1767.142935676196, 8571.100034496374, 8944.329175311854, 8976.192142707163, 9191.0, 9205.447673139617, 8980.8652870207, 8997.190252877239, 9009.459432434058, 9099.636014559426, 9100.544972751353, 1934.177974360891, 2325.581395348845, 2358.492924021335, 2381.20229723043, 2382.7855493005627, 2298.0577963035157, 2322.744498105207, 2325.9069637214493, 2327.1273272522803, 2328.196772113618, 2281.977180228201, 2289.942751431211, 2290.484640955788, 2345.835791494596, 2354.6585745066955, 2253.864768113918, 2309.711286089239, 2313.4910319729634, 2327.4530485336018, 2328.8951997160084, 2298.218605674079, 2323.314622186442, 2335.1593426366494, 2338.4972230970425, 2346.296111166643, 8941.195292423714, 9037.909620903773, 9308.255339572817, 9366.95316523413, 9377.906220937772, 5131.717755523445, 5207.297014902978, 5231.816886408996, 5262.868428289324, 5275.683458992473, 3161.367726454718, 3320.750943679234, 3339.6493368196234, 3390.1863552747163, 3424.7260219182403, 1009.7172791618359, 1043.3218408034763, 1052.542144167282, 1064.909482693972, 1074.3875990685312, 12823.807642885271, 12896.161749486348, 12946.87053129466, 12951.028672849574, 12997.935010324887, 4310.50429200646, 4377.693561450668, 4504.414426124648, 4516.029053753458, 4532.9320060199125, 10091.344062635904, 10099.545520451597, 10101.797964040677, 10105.9494702526, 10112.949435252924, 5276.129438642658, 5283.682979021271, 5288.418273989858, 5289.973550132225, 5297.5232229099565, 4217.810198541073, 4692.0, 4816.494268101869, 4856.514348565115, 4959.652824302337, 3814.828332725034, 3917.941230881539, 3946.5856085111222, 4001.3397789365013, 4027.2549578328103, 1188.5661733467223, 1190.7201807575213, 1193.1886317304316, 1203.296071798008, 1209.770143672717, 972.4311277902365, 985.1724551376877, 986.7977064701862, 987.827130252203, 1001.1840350114634, 6007.909881351783, 6055.1220073090035, 6100.298465676416, 6128.938710612926, 6144.8771024580155, 430.71572761976944, 433.7375887588027, 440.11976047904193, 441.9292913133883, 442.35195438682484, 3990.1620659661216, 4111.506619205655, 4156.231097247019, 4302.935455968163, 4575.313702944585, 11217.439128043565, 11419.885801142049, 11513.827292590619, 11538.942305288589, 11550.88449115515, 11233.775324493465, 11310.943445282886, 11478.655640330804, 11493.367864767351, 11501.07991360689, 8181.263686268146, 8354.832903342021, 8361.205685459994, 8366.623501942428, 8383.077861435237, 6277.905831412441, 6278.4035516625845, 6304.211973503312, 6343.809685709436, 6350.618962862243, 10327.793444131226, 10400.687979360631, 10562.471876406302, 10571.94714026425, 10643.254972151875, 10407.427591482237, 10454.843177352497, 10626.309289896131, 10780.622678206226, 10791.946040269748, 6912.4815638826285, 7093.255208203064, 7095.290470952863, 7925.0489941207425, 8116.797080073045, 7870.881936770838, 8206.097329293892, 8422.663093476438, 8464.534450605275, 8643.524606146722, 7542.434317426325, 7679.884801728091, 7772.261635144652, 7816.179301173295, 7853.960730196312, 7459.216782238004, 7520.360769334668, 7601.885971710318, 7703.922960770321, 7727.536347819148, 7003.194632617314, 7106.928930710834, 7112.57324560528, 7114.573125612273, 7120.323569260912, 5229.764660590358, 5248.921266181087, 5255.684658920477, 5330.280412144466, 5572.080606700011, 5287.0, 5353.0, 5403.675779453245, 5434.510894019557, 5549.611527193058], "value": 4575.72015181743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.6751081407778, 325.9152620318718, 326.15363132670717, 335.31428229271137, 345.3921098865995, 5159.767810448529, 5217.791288348461, 5379.919301210485, 5413.539849112825, 5414.891702165959, 5197.194434862593, 5236.717004333934, 5258.211268309756, 5274.393444753854, 5333.839984800453, 4113.609207125318, 4120.958790412103, 4121.938170927424, 4123.876283711478, 4131.876043718686, 3999.1801680655394, 4128.89426392539, 4128.938065929014, 4139.482564679415, 4158.334666453368, 4130.814113364906, 4131.29767939451, 4146.460960075186, 4151.066010147722, 4157.812898419578, 4133.545310015896, 4134.710570260083, 4156.526866514419, 4157.210130075307, 4177.770222637754, 3682.4476328550663, 3721.813909304551, 3727.38498147808, 3729.664330210267, 3733.9626603733886, 5072.188449848043, 5154.0, 5176.870578235536, 5216.478352164791, 5237.895242095136, 4754.429468463772, 4764.785584648699, 4769.880752981203, 4770.212914869043, 4777.0, 5370.677759334413, 5529.944700552983, 5531.723413829292, 5597.63615365, 5611.663300202001, 4017.6183262590007, 4020.618041286102, 4039.6970227233073, 4070.409790580349, 4076.184763047402, 5723.771049158028, 5746.856328591819, 5753.88492230153, 5771.971140144273, 5775.3935836736955, 4059.4519739834745, 4065.9390109148385, 4083.387491876242, 4092.1815636872743, 4098.303288440972, 4005.5393629732953, 4068.2270368629866, 4082.6733861291027, 4120.670346372283, 4133.359329303963, 4682.41469816273, 4698.647601429838, 4733.290006499053, 4739.810407583727, 4758.595519380891, 5562.833115006556, 5575.048732943437, 5591.427943146117, 5626.718664066781, 5640.85897852557, 1354.9796753048713, 1360.7142500074897, 1426.187073368191, 1428.6928310413311, 1429.1139493514088, 967.949774494667, 986.4475893499663, 996.6710985374809, 1002.2282842211602, 1006.3157053203745, 5255.316808814906, 5277.498637629419, 5287.867803304948, 5303.416624171338, 5314.70769107695, 5608.80298230005, 5610.579206559524, 5620.18507316445, 5624.521915637135, 5625.156226565966, 5192.3769147702515, 5282.524572788468, 5319.547838433777, 5330.546903513167, 5360.597955153301, 2666.4667816005485, 2686.8656567171565, 2690.448458066092, 2693.151657227967, 2697.029069534966, 5007.223880298559, 5134.690653883235, 5138.434772175057, 5151.871203219875, 5163.66436181647, 4825.469198388175, 4982.6512144149565, 5061.519155680205, 5096.426304716095, 5137.794488220429, 5031.723255220998, 5033.3574873191865, 5038.682206185196, 5100.846974590768, 5112.897742045213, 4947.293183851565, 4949.505049495022, 4958.950410495849, 4988.054658683044, 4998.875028124326, 4461.821527139008, 4830.2513110467935, 4868.391451068616, 4880.853574392774, 4907.214845624683, 4951.3810773653295, 5030.773615187399, 5040.243963405518, 5041.294218809443, 5055.797768089235, 3742.831572579186, 3751.3622684143215, 3762.6425489578446, 3767.9058023549633, 3769.3968964965475, 5041.1430056889685, 5086.21163719624, 5362.0, 5789.507891829242, 5798.333191682842, 5676.347220069745, 5685.175649530877, 5697.316322041382, 5698.6580805151825, 5704.1443783432815, 5556.38864729224, 5691.288588926384, 5697.430256974435, 5715.399883012224, 5720.3707592165665, 5544.168374743821, 5568.220449137205, 5580.776768929198, 5583.1904373864745, 5615.326160860723, 5649.6327738696855, 5666.526703057152, 5673.886522269614, 5702.975443717421, 5719.39767405821, 5420.566354691694, 5482.369527504228, 5514.862128446821, 5525.834224973257, 5607.41122182165], "value": 4128.620635591064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.2163952111958, 733.4169335378374, 738.4535443771609, 824.6660102658418, 852.5822347049948, 16874.915625421872, 17486.21312040958, 17612.20745066472, 17681.115944202786, 17807.999999999985, 15259.847401525982, 15620.375184992587, 15680.0, 15682.294296756645, 16742.0, 805.138501803071, 824.9257566818985, 827.3629305434812, 828.0973738624898, 828.1676914700747, 662.645484665704, 795.5465384730705, 800.9839803203932, 811.350919264586, 819.115355416152, 860.7761981884693, 863.1454859688894, 863.4128792421151, 864.5461132905243, 869.2524428991063, 858.1975852577859, 859.2524503681774, 859.9785005374885, 860.9311255099608, 861.3109512390063, 506.3695698854949, 608.6743592178208, 611.8011646214998, 613.5061275673081, 626.1203009771278, 15140.091594504365, 15164.848351516564, 15196.088234705843, 15210.771838422432, 15212.923935380251, 12936.0, 13552.593422197251, 13694.178349299074, 13787.379567919368, 13865.168089914638, 13014.934925325313, 13225.470981160743, 13336.799948000787, 13348.93325533366, 13511.527096551672, 4386.210482113218, 4415.20526305265, 4427.4908385535755, 4503.977480112611, 4617.930731039037, 80997.59501202515, 81685.18314816835, 81712.59143704243, 82438.58780706118, 85073.57463212706, 10621.840672389766, 10953.288036277616, 11202.215844890943, 11269.09847212221, 11395.430228488709, 19949.800501995083, 19952.401427957186, 19953.800461995485, 19959.50303727226, 19961.700574491395, 8497.575121243914, 8596.355273354524, 8788.824223515494, 8808.779780505538, 8926.018138004814, 4898.951010489849, 4954.433711603912, 4956.900861982812, 5020.523050310215, 5215.869603259873, 3396.3546926083964, 3501.492283618861, 3502.2295095079044, 3502.7022703070525, 3502.8949131526097, 600.7807150390164, 600.8317671052113, 601.6390165900425, 602.6594973839766, 604.157200705014, 539.7274376439873, 547.622140722908, 558.935722391922, 637.353086617084, 680.897865320196, 9234.261259099256, 9903.60385584583, 10016.54925528353, 10104.494775261355, 10106.160078223122, 636.726207730671, 662.8044726805604, 714.5177005521252, 718.2279050021248, 720.4740539406263, 4814.807407703653, 4888.437829649636, 4916.680415773035, 4942.135126352874, 4957.355543779286, 73537.6323118381, 73551.63224183845, 73608.26391736121, 74447.0, 134756.0, 62570.05584469468, 66329.66835165794, 80736.0, 87164.1283587156, 105000.47499762452, 54563.727181363836, 82810.17189828024, 90537.9147747995, 93203.53398232965, 93873.06126938779, 8785.824283514421, 8882.733517994471, 9185.219256363283, 9326.249433603389, 9372.859407109036, 54931.0, 55496.44503554913, 55663.0, 56288.437115628316, 56979.86040279254, 49997.00029996971, 65810.67094664495, 67584.0, 77081.0, 84702.57648711963, 12280.26318420862, 13518.864811351761, 13648.863511365156, 13781.173129612256, 13802.792958105436, 15530.378784848479, 15743.685126297181, 16186.919065404598, 16461.83538164651, 16558.337666493204, 13520.323983800967, 13629.454821807016, 14074.859251407355, 14244.0, 14533.27333633293, 13297.867021329663, 13620.318984050957, 13935.790963135358, 14246.572602821932, 14264.786028209794, 13220.933895330847, 13943.886180479474, 14089.295535223402, 14096.36566354537, 14342.354594043501, 11303.696278910415, 11807.73301663195, 12016.459259333526, 12076.577319793765, 12219.87780122223, 10439.321444106108, 10635.468226588795, 11240.887591123985, 11446.828297575377, 12346.567870124503], "value": 7541.564311407795, "unit": "score"}], "name": "dromaeo_css", "value": 7144.203518259834, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 117.0, 111.0, 114.0, 113.0, 111.0, 112.0, 112.0, 126.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 152.0, 191.0, 121.0, 154.0, 149.0, 128.0, 187.0, 118.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 159.0, 163.0, 161.0, 162.0, 161.0, 160.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 171.0, 77.0, 75.0, 74.0, 75.0, 179.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 148.0, 83.0, 81.0, 81.0, 140.0, 81.0, 81.0, 146.0], "value": 100.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 99.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 54.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 77.0, 78.0, 77.0, 79.0, 80.0, 84.0, 78.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 122.0, 126.0, 123.0, 120.0, 131.0, 132.0, 165.0, 127.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 168.0, 164.0, 164.0, 163.0, 164.0, 166.0, 161.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 65.0, 64.0, 64.0, 64.0, 63.0, 65.0, 62.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1527.4999999999998, "alertThreshold": 2.0}]} 02:37:20 INFO - Return code: 0 02:37:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:37:20 INFO - # TBPL SUCCESS # 02:37:20 INFO - Running post-action listener: _resource_record_post_action 02:37:20 INFO - [mozharness: 2016-09-02 09:37:20.528664Z] Finished run-tests step (success) 02:37:20 INFO - Running post-run listener: _resource_record_post_run 02:37:20 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 407805952; Read time: 0; Write time: 411712 02:37:20 INFO - TinderboxPrint: CPU usage
13.1% 02:37:20 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:37:20 INFO - TinderboxPrint: I/O write bytes / time
407,805,952 / 411,712 02:37:20 INFO - TinderboxPrint: CPU idle
8,283.2 (86.9%) 02:37:20 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 02:37:20 INFO - TinderboxPrint: Swap in / out
0 / 0 02:37:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118288384; Read time: 0; Write time: 130584 02:37:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289517568; Read time: 0; Write time: 281128 02:37:21 INFO - Running post-run listener: _upload_blobber_files 02:37:21 INFO - Blob upload gear active. 02:37:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:37:21 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 02:37:21 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'] 02:37:21 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 02:37:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:24 INFO - (blobuploader) - INFO - Done attempting. 02:37:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:37:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:25 INFO - (blobuploader) - INFO - Done attempting. 02:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:37:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:26 INFO - (blobuploader) - INFO - Done attempting. 02:37:26 INFO - (blobuploader) - INFO - Iteration through files over. 02:37:26 INFO - Return code: 0 02:37:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:37:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:37:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97269532d08d985b7489f124537553b9090527ce4c37b15b68c51f1a4df1f209a8ae01769126207e5bde03cbe48683a87958eccc62abdfd0f11077d4aefb03d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d4a057f8e47c6e337ce288326996425f20b623890f216c170295a16b45acf203fe5e9272192a4d18129a892b38d233d77dfecd90cd2aab5a79fde02242281f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e1b774066ba3b83ef9047c26b3afdbad1d7b46fac4c23f22d94f12c10a3db4e731b4c7c211c921287f92eea1d817f13f80158b9d03b371c70478d9830fce25f"} 02:37:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:37:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:37:26 INFO - Contents: 02:37:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97269532d08d985b7489f124537553b9090527ce4c37b15b68c51f1a4df1f209a8ae01769126207e5bde03cbe48683a87958eccc62abdfd0f11077d4aefb03d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d4a057f8e47c6e337ce288326996425f20b623890f216c170295a16b45acf203fe5e9272192a4d18129a892b38d233d77dfecd90cd2aab5a79fde02242281f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e1b774066ba3b83ef9047c26b3afdbad1d7b46fac4c23f22d94f12c10a3db4e731b4c7c211c921287f92eea1d817f13f80158b9d03b371c70478d9830fce25f"} 02:37:26 INFO - Running post-run listener: copy_logs_to_upload_dir 02:37:26 INFO - Copying logs to upload dir... 02:37:26 INFO - mkdir: /builds/slave/test/build/upload/logs 02:37:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.804180 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-02 02:37:25.738015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 02:37:25.745400) ========= 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=32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516 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/97269532d08d985b7489f124537553b9090527ce4c37b15b68c51f1a4df1f209a8ae01769126207e5bde03cbe48683a87958eccc62abdfd0f11077d4aefb03d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d4a057f8e47c6e337ce288326996425f20b623890f216c170295a16b45acf203fe5e9272192a4d18129a892b38d233d77dfecd90cd2aab5a79fde02242281f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e1b774066ba3b83ef9047c26b3afdbad1d7b46fac4c23f22d94f12c10a3db4e731b4c7c211c921287f92eea1d817f13f80158b9d03b371c70478d9830fce25f"} build_url:https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/H-NueZRfTdW09l66SdINzQ/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/97269532d08d985b7489f124537553b9090527ce4c37b15b68c51f1a4df1f209a8ae01769126207e5bde03cbe48683a87958eccc62abdfd0f11077d4aefb03d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d4a057f8e47c6e337ce288326996425f20b623890f216c170295a16b45acf203fe5e9272192a4d18129a892b38d233d77dfecd90cd2aab5a79fde02242281f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e1b774066ba3b83ef9047c26b3afdbad1d7b46fac4c23f22d94f12c10a3db4e731b4c7c211c921287f92eea1d817f13f80158b9d03b371c70478d9830fce25f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 02:37:25.773098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:37:25.773427) ========= 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=32c5991c409366f7fec8a718000001d2-1472807445.533051-394511516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 02:37:25.822834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 02:37:25.826190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 02:37:25.826518) ========= ========= Total master_lag: 0.44 =========