builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1471950291.36 results: success (0) buildid: 20160823023001 builduid: 68fe781456a845fc87fe003540f341c9 revision: e5f3c2ed25f511cb5882574c300026cb0765a697 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.355709) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.356132) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.356424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.390804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.391092) ========= 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-1471948949.755928-1059864580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 04:04:51-- 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% 46.5M=0s 2016-08-23 04:04:51 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101643 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.506144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.506428) ========= 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-1471948949.755928-1059864580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016685 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.555446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:51.555749) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e5f3c2ed25f511cb5882574c300026cb0765a697 --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 e5f3c2ed25f511cb5882574c300026cb0765a697 --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-1471948949.755928-1059864580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 04:04:51,687 truncating revision to first 12 chars 2016-08-23 04:04:51,687 Setting DEBUG logging. 2016-08-23 04:04:51,687 attempt 1/10 2016-08-23 04:04:51,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e5f3c2ed25f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 04:04:51,957 unpacking tar archive at: fx-team-e5f3c2ed25f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:52.109470) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:52.109747) ========= script_repo_revision: e5f3c2ed25f511cb5882574c300026cb0765a697 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:52.110157) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:52.110430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 04:04:52.124911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-23 04:04:52.125265) ========= /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-1471948949.755928-1059864580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:04:52 INFO - MultiFileLogger online at 20160823 04:04:52 in /builds/slave/test 04:04:52 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 04:04:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:52 INFO - {'append_to_log': False, 04:04:52 INFO - 'base_work_dir': '/builds/slave/test', 04:04:52 INFO - 'blob_upload_branch': 'Fx-Team', 04:04:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:52 INFO - 'branch': 'Fx-Team', 04:04:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:52 INFO - 'config_files': ('talos/linux_config.py',), 04:04:52 INFO - 'default_actions': ('clobber', 04:04:52 INFO - 'read-buildbot-config', 04:04:52 INFO - 'download-and-extract', 04:04:52 INFO - 'populate-webroot', 04:04:52 INFO - 'create-virtualenv', 04:04:52 INFO - 'install', 04:04:52 INFO - 'run-tests'), 04:04:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:52 INFO - 'download_minidump_stackwalk': True, 04:04:52 INFO - 'download_symbols': 'ondemand', 04:04:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:52 INFO - 'installer_path': 'installer.exe', 04:04:52 INFO - 'log_level': 'info', 04:04:52 INFO - 'log_name': 'talos', 04:04:52 INFO - 'log_to_console': True, 04:04:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:04:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:04:52 INFO - 'opt_config_files': (), 04:04:52 INFO - 'pip_index': False, 04:04:52 INFO - 'sps_profile': False, 04:04:52 INFO - 'sps_profile_interval': 0, 04:04:52 INFO - 'suite': 'dromaeojs', 04:04:52 INFO - 'system_bits': '32', 04:04:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:52 INFO - 'title': 'talos-linux64-ix-008', 04:04:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:52 INFO - 'use_talos_json': True, 04:04:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:52 INFO - 'work_dir': 'build'} 04:04:52 INFO - [mozharness: 2016-08-23 11:04:52.365658Z] Running clobber step. 04:04:52 INFO - Running pre-action listener: _resource_record_pre_action 04:04:52 INFO - Running main action method: clobber 04:04:52 INFO - rmtree: /builds/slave/test/build 04:04:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:52 INFO - Running post-action listener: _resource_record_post_action 04:04:52 INFO - [mozharness: 2016-08-23 11:04:52.813059Z] Finished clobber step (success) 04:04:52 INFO - [mozharness: 2016-08-23 11:04:52.813159Z] Running read-buildbot-config step. 04:04:52 INFO - Running pre-action listener: _resource_record_pre_action 04:04:52 INFO - Running main action method: read_buildbot_config 04:04:52 INFO - Using buildbot properties: 04:04:52 INFO - { 04:04:52 INFO - "project": "", 04:04:52 INFO - "product": "firefox", 04:04:52 INFO - "script_repo_revision": "production", 04:04:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:04:52 INFO - "repository": "", 04:04:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:04:52 INFO - "buildid": "20160823023001", 04:04:52 INFO - "pgo_build": "True", 04:04:52 INFO - "basedir": "/builds/slave/test", 04:04:52 INFO - "buildnumber": 1002, 04:04:52 INFO - "slavename": "talos-linux64-ix-008", 04:04:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:04:52 INFO - "platform": "ubuntu64_hw", 04:04:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:04:52 INFO - "branch": "fx-team", 04:04:52 INFO - "repo_path": "integration/fx-team", 04:04:52 INFO - "revision": "e5f3c2ed25f511cb5882574c300026cb0765a697", 04:04:52 INFO - "stage_platform": "linux64-pgo", 04:04:52 INFO - "builduid": "68fe781456a845fc87fe003540f341c9", 04:04:52 INFO - "slavebuilddir": "test" 04:04:52 INFO - } 04:04:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:04:52 INFO - Running post-action listener: _resource_record_post_action 04:04:52 INFO - [mozharness: 2016-08-23 11:04:52.815550Z] Finished read-buildbot-config step (success) 04:04:52 INFO - [mozharness: 2016-08-23 11:04:52.815639Z] Running download-and-extract step. 04:04:52 INFO - Running pre-action listener: _resource_record_pre_action 04:04:52 INFO - Running main action method: download_and_extract 04:04:52 INFO - mkdir: /builds/slave/test/build/tests 04:04: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')]} 04:04:52 INFO - trying https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:04:52 INFO - Downloading https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:04:53 INFO - Downloaded 1361 bytes. 04:04:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:04:53 INFO - Using the following test package requirements: 04:04:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:04:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:04:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'jsshell-linux-x86_64.zip'], 04:04:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:04:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:04:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:04:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:04:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:04:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:04:53 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')]} 04:04:53 INFO - trying https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:04:53 INFO - Downloading https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:04:54 INFO - Downloaded 21921122 bytes. 04:04:54 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 04:04:58 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 04:04: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')]} 04:04:58 INFO - trying https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:04:58 INFO - Downloading https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:05:00 INFO - Downloaded 21921122 bytes. 04:05:00 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 04:05: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')]} 04:05:05 INFO - trying https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:05 INFO - Downloading https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:05:06 INFO - Downloaded 14413981 bytes. 04:05:06 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 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:07 INFO - trying https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:05:07 INFO - Downloading https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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 04:05:09 INFO - Downloaded 59765290 bytes. 04:05:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:05:09 INFO - mkdir: /builds/slave/test/properties 04:05:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:09 INFO - Contents: 04:05:09 INFO - build_url:https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:05:09 INFO - Running post-action listener: _resource_record_post_action 04:05:09 INFO - Running post-action listener: set_extra_try_arguments 04:05:09 INFO - [mozharness: 2016-08-23 11:05:09.802578Z] Finished download-and-extract step (success) 04:05:09 INFO - [mozharness: 2016-08-23 11:05:09.802803Z] Running populate-webroot step. 04:05:09 INFO - Running pre-action listener: _resource_record_pre_action 04:05:09 INFO - Running main action method: populate_webroot 04:05:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:09 INFO - '--tppagecycles', 04:05:09 INFO - '7'], 04:05:09 INFO - 'tests': ['tsvgm']}}, 04:05:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['damp', 'tps']}, 04:05:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'tests': ['damp', 'tps']}, 04:05:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['dromaeo_dom']}, 04:05:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['basic_compositor_video']}, 04:05:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:05:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['a11yr', 04:05:09 INFO - 'ts_paint', 04:05:09 INFO - 'tpaint', 04:05:09 INFO - 'sessionrestore', 04:05:09 INFO - 'sessionrestore_no_auto_restore', 04:05:09 INFO - 'tabpaint']}, 04:05:09 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:09 INFO - 'ts_paint', 04:05:09 INFO - 'tpaint', 04:05:09 INFO - 'sessionrestore', 04:05:09 INFO - 'sessionrestore_no_auto_restore', 04:05:09 INFO - 'tabpaint']}, 04:05:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:05:09 INFO - 'ts_paint', 04:05:09 INFO - 'tpaint', 04:05:09 INFO - 'sessionrestore', 04:05:09 INFO - 'sessionrestore_no_auto_restore', 04:05:09 INFO - 'tabpaint']}, 04:05:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:05:09 INFO - 'ts_paint', 04:05:09 INFO - 'tpaint', 04:05:09 INFO - 'sessionrestore', 04:05:09 INFO - 'sessionrestore_no_auto_restore', 04:05:09 INFO - 'tabpaint']}, 04:05:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['a11yr', 04:05:09 INFO - 'ts_paint', 04:05:09 INFO - 'tpaint', 04:05:09 INFO - 'sessionrestore', 04:05:09 INFO - 'sessionrestore_no_auto_restore', 04:05:09 INFO - 'tabpaint']}, 04:05:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['a11yr', 04:05:09 INFO - 'ts_paint', 04:05:09 INFO - 'tpaint', 04:05:09 INFO - 'sessionrestore', 04:05:09 INFO - 'sessionrestore_no_auto_restore', 04:05:09 INFO - 'tabpaint']}, 04:05:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['tsvgx', 04:05:09 INFO - 'tsvgr_opacity', 04:05:09 INFO - 'tart', 04:05:09 INFO - 'tscrollx', 04:05:09 INFO - 'cart']}, 04:05:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:09 INFO - 'tsvgr_opacity', 04:05:09 INFO - 'tart', 04:05:09 INFO - 'tscrollx', 04:05:09 INFO - 'cart']}, 04:05:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'talos_options': ['--disable-e10s'], 04:05:09 INFO - 'tests': ['tp5o']}, 04:05:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'tests': ['tp5o']}, 04:05:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'talos_options': ['--disable-e10s', 04:05:09 INFO - '--xperf_path', 04:05:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:09 INFO - 'tests': ['tp5n']}, 04:05:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:09 INFO - 'talos_options': ['--xperf_path', 04:05:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:09 INFO - 'tests': ['tp5n']}}, 04:05:09 INFO - 'talos.zip': {'path': '', 04:05:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:09 INFO - Running post-action listener: _resource_record_post_action 04:05:09 INFO - [mozharness: 2016-08-23 11:05:09.822066Z] Finished populate-webroot step (success) 04:05:09 INFO - [mozharness: 2016-08-23 11:05:09.822155Z] Running create-virtualenv step. 04:05:09 INFO - Running pre-action listener: _resource_record_pre_action 04:05:09 INFO - Running main action method: create_virtualenv 04:05:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:09 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 04:05:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:09 INFO - Using real prefix '/usr' 04:05:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:12 INFO - Installing pip.................done. 04:05:12 INFO - Return code: 0 04:05:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:12 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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:12 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 04:05:12 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 04:05:12 INFO - Using env: {'DISPLAY': ':0', 04:05:12 INFO - 'HOME': '/home/cltbld', 04:05:12 INFO - 'LANG': 'en_US.UTF-8', 04:05:12 INFO - 'LANGUAGE': 'en_US:en', 04:05:12 INFO - 'LOGNAME': 'cltbld', 04:05:12 INFO - 'MAIL': '/var/mail/cltbld', 04:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:12 INFO - 'MOZ_NO_REMOTE': '1', 04:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:12 INFO - 'NO_EM_RESTART': '1', 04:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:12 INFO - 'PWD': '/builds/slave/test', 04:05:12 INFO - 'SHELL': '/bin/bash', 04:05:12 INFO - 'SHLVL': '1', 04:05:12 INFO - 'TERM': 'linux', 04:05:12 INFO - 'TMOUT': '86400', 04:05:12 INFO - 'USER': 'cltbld', 04:05:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:12 INFO - '_': '/tools/buildbot/bin/python'} 04:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:12 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 04:05:12 INFO - Cleaning up... 04:05:12 INFO - Return code: 0 04:05:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:12 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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:12 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 04:05:12 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 04:05:12 INFO - Using env: {'DISPLAY': ':0', 04:05:12 INFO - 'HOME': '/home/cltbld', 04:05:12 INFO - 'LANG': 'en_US.UTF-8', 04:05:12 INFO - 'LANGUAGE': 'en_US:en', 04:05:12 INFO - 'LOGNAME': 'cltbld', 04:05:12 INFO - 'MAIL': '/var/mail/cltbld', 04:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:12 INFO - 'MOZ_NO_REMOTE': '1', 04:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:12 INFO - 'NO_EM_RESTART': '1', 04:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:12 INFO - 'PWD': '/builds/slave/test', 04:05:12 INFO - 'SHELL': '/bin/bash', 04:05:12 INFO - 'SHLVL': '1', 04:05:12 INFO - 'TERM': 'linux', 04:05:12 INFO - 'TMOUT': '86400', 04:05:12 INFO - 'USER': 'cltbld', 04:05:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:12 INFO - '_': '/tools/buildbot/bin/python'} 04:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:12 INFO - Downloading/unpacking psutil>=3.1.1 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:14 INFO - Installing collected packages: psutil 04:05:14 INFO - Running setup.py install for psutil 04:05:14 INFO - building 'psutil._psutil_linux' extension 04:05:14 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 04:05:15 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 04:05:15 INFO - building 'psutil._psutil_posix' extension 04:05:15 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 04:05:15 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 04:05:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:15 INFO - Successfully installed psutil 04:05:15 INFO - Cleaning up... 04:05:15 INFO - Return code: 0 04:05:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:05:15 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')]} 04:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:15 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')]} 04:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:15 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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:15 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 04:05:15 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 04:05:15 INFO - Using env: {'DISPLAY': ':0', 04:05:15 INFO - 'HOME': '/home/cltbld', 04:05:15 INFO - 'LANG': 'en_US.UTF-8', 04:05:15 INFO - 'LANGUAGE': 'en_US:en', 04:05:15 INFO - 'LOGNAME': 'cltbld', 04:05:15 INFO - 'MAIL': '/var/mail/cltbld', 04:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:15 INFO - 'MOZ_NO_REMOTE': '1', 04:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:15 INFO - 'NO_EM_RESTART': '1', 04:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:15 INFO - 'PWD': '/builds/slave/test', 04:05:15 INFO - 'SHELL': '/bin/bash', 04:05:15 INFO - 'SHLVL': '1', 04:05:15 INFO - 'TERM': 'linux', 04:05:15 INFO - 'TMOUT': '86400', 04:05:15 INFO - 'USER': 'cltbld', 04:05:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:15 INFO - '_': '/tools/buildbot/bin/python'} 04:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:05:17 INFO - Installing collected packages: mozsystemmonitor 04:05:17 INFO - Running setup.py install for mozsystemmonitor 04:05:17 INFO - Successfully installed mozsystemmonitor 04:05:17 INFO - Cleaning up... 04:05:17 INFO - Return code: 0 04:05:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:05:17 INFO - Using env: {'DISPLAY': ':0', 04:05:17 INFO - 'HOME': '/home/cltbld', 04:05:17 INFO - 'LANG': 'en_US.UTF-8', 04:05:17 INFO - 'LANGUAGE': 'en_US:en', 04:05:17 INFO - 'LOGNAME': 'cltbld', 04:05:17 INFO - 'MAIL': '/var/mail/cltbld', 04:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:17 INFO - 'MOZ_NO_REMOTE': '1', 04:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:17 INFO - 'NO_EM_RESTART': '1', 04:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:17 INFO - 'PWD': '/builds/slave/test', 04:05:17 INFO - 'SHELL': '/bin/bash', 04:05:17 INFO - 'SHLVL': '1', 04:05:17 INFO - 'TERM': 'linux', 04:05:17 INFO - 'TMOUT': '86400', 04:05:17 INFO - 'USER': 'cltbld', 04:05:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:17 INFO - '_': '/tools/buildbot/bin/python'} 04:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:05:17 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 04:05:17 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 04:05:17 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 04:05:17 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 04:05:17 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 04:05:17 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 04:05:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:05:19 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 04:05:19 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 04:05:19 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 04:05:19 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 04:05:19 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 04:05:19 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 04:05:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:19 INFO - warning: no files found matching '*.txt' 04:05:19 INFO - no previously-included directories found matching 'build' 04:05:19 INFO - no previously-included directories found matching 'dist' 04:05:19 INFO - no previously-included directories found matching '.git*' 04:05:19 INFO - Installing collected packages: jsonschema, functools32 04:05:20 INFO - Running setup.py install for functools32 04:05:20 INFO - warning: no files found matching '*.txt' 04:05:20 INFO - no previously-included directories found matching 'build' 04:05:20 INFO - no previously-included directories found matching 'dist' 04:05:20 INFO - no previously-included directories found matching '.git*' 04:05:20 INFO - Successfully installed jsonschema functools32 04:05:20 INFO - Cleaning up... 04:05:20 INFO - Return code: 0 04:05:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:05:20 INFO - Using env: {'DISPLAY': ':0', 04:05:20 INFO - 'HOME': '/home/cltbld', 04:05:20 INFO - 'LANG': 'en_US.UTF-8', 04:05:20 INFO - 'LANGUAGE': 'en_US:en', 04:05:20 INFO - 'LOGNAME': 'cltbld', 04:05:20 INFO - 'MAIL': '/var/mail/cltbld', 04:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:20 INFO - 'MOZ_NO_REMOTE': '1', 04:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:20 INFO - 'NO_EM_RESTART': '1', 04:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:20 INFO - 'PWD': '/builds/slave/test', 04:05:20 INFO - 'SHELL': '/bin/bash', 04:05:20 INFO - 'SHLVL': '1', 04:05:20 INFO - 'TERM': 'linux', 04:05:20 INFO - 'TMOUT': '86400', 04:05:20 INFO - 'USER': 'cltbld', 04:05:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:20 INFO - '_': '/tools/buildbot/bin/python'} 04:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:05:20 INFO - Cleaning up... 04:05:20 INFO - Return code: 0 04:05:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:05:20 INFO - Using env: {'DISPLAY': ':0', 04:05:20 INFO - 'HOME': '/home/cltbld', 04:05:20 INFO - 'LANG': 'en_US.UTF-8', 04:05:20 INFO - 'LANGUAGE': 'en_US:en', 04:05:20 INFO - 'LOGNAME': 'cltbld', 04:05:20 INFO - 'MAIL': '/var/mail/cltbld', 04:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:20 INFO - 'MOZ_NO_REMOTE': '1', 04:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:20 INFO - 'NO_EM_RESTART': '1', 04:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:20 INFO - 'PWD': '/builds/slave/test', 04:05:20 INFO - 'SHELL': '/bin/bash', 04:05:20 INFO - 'SHLVL': '1', 04:05:20 INFO - 'TERM': 'linux', 04:05:20 INFO - 'TMOUT': '86400', 04:05:20 INFO - 'USER': 'cltbld', 04:05:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:20 INFO - '_': '/tools/buildbot/bin/python'} 04:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:22 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 04:05:22 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 04:05:22 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 04:05:22 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 04:05:22 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 04:05:22 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 04:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:05:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:23 INFO - Downloading docopt-0.6.1.tar.gz 04:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:23 INFO - Running setup.py install for blobuploader 04:05:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:05:23 INFO - Running setup.py install for requests 04:05:23 INFO - Running setup.py install for docopt 04:05:23 INFO - Successfully installed blobuploader requests docopt 04:05:23 INFO - Cleaning up... 04:05:23 INFO - Return code: 0 04:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:23 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 04:05:23 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 04:05:23 INFO - Using env: {'DISPLAY': ':0', 04:05:23 INFO - 'HOME': '/home/cltbld', 04:05:23 INFO - 'LANG': 'en_US.UTF-8', 04:05:23 INFO - 'LANGUAGE': 'en_US:en', 04:05:23 INFO - 'LOGNAME': 'cltbld', 04:05:23 INFO - 'MAIL': '/var/mail/cltbld', 04:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:23 INFO - 'MOZ_NO_REMOTE': '1', 04:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:23 INFO - 'NO_EM_RESTART': '1', 04:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:23 INFO - 'PWD': '/builds/slave/test', 04:05:23 INFO - 'SHELL': '/bin/bash', 04:05:23 INFO - 'SHLVL': '1', 04:05:23 INFO - 'TERM': 'linux', 04:05:23 INFO - 'TMOUT': '86400', 04:05:23 INFO - 'USER': 'cltbld', 04:05:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:23 INFO - '_': '/tools/buildbot/bin/python'} 04:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:24 INFO - Running setup.py (path:/tmp/pip-yIH4iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:24 INFO - Running setup.py (path:/tmp/pip-DycgLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:24 INFO - Running setup.py (path:/tmp/pip-LgcNcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:24 INFO - Running setup.py (path:/tmp/pip-V1AqN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:24 INFO - Running setup.py (path:/tmp/pip-xnBp3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:24 INFO - Running setup.py (path:/tmp/pip-jeUBqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:24 INFO - Running setup.py (path:/tmp/pip-KVhUc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:24 INFO - Running setup.py (path:/tmp/pip-2_ZFPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:24 INFO - Running setup.py (path:/tmp/pip-ItIMKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:24 INFO - Running setup.py (path:/tmp/pip-6rAxb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:24 INFO - Running setup.py (path:/tmp/pip-bsws8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:24 INFO - Running setup.py (path:/tmp/pip-4Mpwik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:25 INFO - Running setup.py (path:/tmp/pip-_3VC6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:25 INFO - Running setup.py (path:/tmp/pip-mCuBXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:25 INFO - Running setup.py (path:/tmp/pip-3MTf0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:25 INFO - Running setup.py (path:/tmp/pip-pu4oGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:25 INFO - Running setup.py (path:/tmp/pip-dKoGUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:25 INFO - Running setup.py install for manifestparser 04:05:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:05:25 INFO - Running setup.py install for mozcrash 04:05:25 INFO - Running setup.py install for mozdebug 04:05:25 INFO - Running setup.py install for mozdevice 04:05:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:05:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:05:25 INFO - Running setup.py install for mozfile 04:05:25 INFO - Running setup.py install for mozhttpd 04:05:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozinfo 04:05:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozInstall 04:05:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozleak 04:05:26 INFO - Running setup.py install for mozlog 04:05:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for moznetwork 04:05:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozprocess 04:05:26 INFO - Running setup.py install for mozprofile 04:05:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozrunner 04:05:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozscreenshot 04:05:26 INFO - Running setup.py install for moztest 04:05:27 INFO - Running setup.py install for mozversion 04:05:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:05:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:27 INFO - Cleaning up... 04:05:27 INFO - Return code: 0 04:05:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:27 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')]} 04:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:27 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')]} 04:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:27 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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:27 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 04:05:27 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 04:05:27 INFO - Using env: {'DISPLAY': ':0', 04:05:27 INFO - 'HOME': '/home/cltbld', 04:05:27 INFO - 'LANG': 'en_US.UTF-8', 04:05:27 INFO - 'LANGUAGE': 'en_US:en', 04:05:27 INFO - 'LOGNAME': 'cltbld', 04:05:27 INFO - 'MAIL': '/var/mail/cltbld', 04:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:27 INFO - 'MOZ_NO_REMOTE': '1', 04:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:27 INFO - 'NO_EM_RESTART': '1', 04:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:27 INFO - 'PWD': '/builds/slave/test', 04:05:27 INFO - 'SHELL': '/bin/bash', 04:05:27 INFO - 'SHLVL': '1', 04:05:27 INFO - 'TERM': 'linux', 04:05:27 INFO - 'TMOUT': '86400', 04:05:27 INFO - 'USER': 'cltbld', 04:05:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:27 INFO - '_': '/tools/buildbot/bin/python'} 04:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:27 INFO - Running setup.py (path:/tmp/pip-_05uXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:27 INFO - Running setup.py (path:/tmp/pip-SuDVnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:27 INFO - Running setup.py (path:/tmp/pip-Qu0YsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:27 INFO - Running setup.py (path:/tmp/pip-NXwTCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:27 INFO - Running setup.py (path:/tmp/pip-lBWBtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:27 INFO - Running setup.py (path:/tmp/pip-bSKFtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:27 INFO - Running setup.py (path:/tmp/pip-aYKQIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:27 INFO - Running setup.py (path:/tmp/pip-KlFr7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:27 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)) 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:27 INFO - Running setup.py (path:/tmp/pip-VLxFMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:28 INFO - Running setup.py (path:/tmp/pip-m941SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:28 INFO - Running setup.py (path:/tmp/pip-8ZiV_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:28 INFO - Running setup.py (path:/tmp/pip-YOquYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:28 INFO - Running setup.py (path:/tmp/pip-6DJWdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:28 INFO - Running setup.py (path:/tmp/pip-CxlR4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:28 INFO - Running setup.py (path:/tmp/pip-Eo00VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:28 INFO - Running setup.py (path:/tmp/pip-eXbQ52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:28 INFO - Running setup.py (path:/tmp/pip-h1YNt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:28 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)) 04:05:28 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)) 04:05:28 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)) 04:05:28 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)) 04:05:28 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)) 04:05:28 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)) 04:05:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:30 INFO - Downloading blessings-1.6.tar.gz 04:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:30 INFO - Installing collected packages: blessings 04:05:30 INFO - Running setup.py install for blessings 04:05:30 INFO - Successfully installed blessings 04:05:30 INFO - Cleaning up... 04:05:30 INFO - Return code: 0 04:05:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:30 INFO - Reading from file tmpfile_stdout 04:05:30 INFO - Current package versions: 04:05:30 INFO - argparse == 1.2.1 04:05:30 INFO - blessings == 1.6 04:05:30 INFO - blobuploader == 1.2.4 04:05:30 INFO - docopt == 0.6.1 04:05:30 INFO - functools32 == 3.2.3-2 04:05:30 INFO - jsonschema == 2.5.1 04:05:30 INFO - manifestparser == 1.1 04:05:30 INFO - mozInstall == 1.12 04:05:30 INFO - mozcrash == 0.17 04:05:30 INFO - mozdebug == 0.1 04:05:30 INFO - mozdevice == 0.48 04:05:30 INFO - mozfile == 1.2 04:05:30 INFO - mozhttpd == 0.7 04:05:30 INFO - mozinfo == 0.9 04:05:30 INFO - mozleak == 0.1 04:05:30 INFO - mozlog == 3.3 04:05:30 INFO - moznetwork == 0.27 04:05:30 INFO - mozprocess == 0.23 04:05:30 INFO - mozprofile == 0.28 04:05:30 INFO - mozrunner == 6.12 04:05:30 INFO - mozscreenshot == 0.1 04:05:30 INFO - mozsystemmonitor == 0.3 04:05:30 INFO - moztest == 0.7 04:05:30 INFO - mozversion == 1.4 04:05:30 INFO - psutil == 3.1.1 04:05:30 INFO - requests == 1.2.3 04:05:30 INFO - wsgiref == 0.1.2 04:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:30 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 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:30 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 04:05:30 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 04:05:30 INFO - Using env: {'DISPLAY': ':0', 04:05:30 INFO - 'HOME': '/home/cltbld', 04:05:30 INFO - 'LANG': 'en_US.UTF-8', 04:05:30 INFO - 'LANGUAGE': 'en_US:en', 04:05:30 INFO - 'LOGNAME': 'cltbld', 04:05:30 INFO - 'MAIL': '/var/mail/cltbld', 04:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:30 INFO - 'MOZ_NO_REMOTE': '1', 04:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:30 INFO - 'NO_EM_RESTART': '1', 04:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:30 INFO - 'PWD': '/builds/slave/test', 04:05:30 INFO - 'SHELL': '/bin/bash', 04:05:30 INFO - 'SHLVL': '1', 04:05:30 INFO - 'TERM': 'linux', 04:05:30 INFO - 'TMOUT': '86400', 04:05:30 INFO - 'USER': 'cltbld', 04:05:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:30 INFO - '_': '/tools/buildbot/bin/python'} 04:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 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)) 04:05:31 INFO - Cleaning up... 04:05:31 INFO - Return code: 0 04:05:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f11dcc62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2902850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, '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-1471948949.755928-1059864580', '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 04:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:05:31 INFO - Using env: {'DISPLAY': ':0', 04:05:31 INFO - 'HOME': '/home/cltbld', 04:05:31 INFO - 'LANG': 'en_US.UTF-8', 04:05:31 INFO - 'LANGUAGE': 'en_US:en', 04:05:31 INFO - 'LOGNAME': 'cltbld', 04:05:31 INFO - 'MAIL': '/var/mail/cltbld', 04:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:31 INFO - 'MOZ_NO_REMOTE': '1', 04:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:31 INFO - 'NO_EM_RESTART': '1', 04:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:31 INFO - 'PWD': '/builds/slave/test', 04:05:31 INFO - 'SHELL': '/bin/bash', 04:05:31 INFO - 'SHLVL': '1', 04:05:31 INFO - 'TERM': 'linux', 04:05:31 INFO - 'TMOUT': '86400', 04:05:31 INFO - 'USER': 'cltbld', 04:05:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:31 INFO - '_': '/tools/buildbot/bin/python'} 04:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:05:31 INFO - Cleaning up... 04:05:31 INFO - Return code: 0 04:05:31 INFO - Running post-action listener: _resource_record_post_action 04:05:31 INFO - Running post-action listener: _start_resource_monitoring 04:05:31 INFO - Starting resource monitoring. 04:05:31 INFO - [mozharness: 2016-08-23 11:05:31.510951Z] Finished create-virtualenv step (success) 04:05:31 INFO - [mozharness: 2016-08-23 11:05:31.511454Z] Running install step. 04:05:31 INFO - Running pre-action listener: _resource_record_pre_action 04:05:31 INFO - Running main action method: install 04:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:31 INFO - Reading from file tmpfile_stdout 04:05:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:05:31 INFO - Reading from file tmpfile_stdout 04:05:31 INFO - Output received: 04:05:31 INFO - Usage: mozinstall [options] installer 04:05:31 INFO - Options: 04:05:31 INFO - -h, --help show this help message and exit 04:05:31 INFO - -d DEST, --destination=DEST 04:05:31 INFO - Directory to install application into. [default: 04:05:31 INFO - "/builds/slave/test"] 04:05:31 INFO - --app=APP Application being installed. [default: firefox] 04:05:31 INFO - mkdir: /builds/slave/test/build/application 04:05:31 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'] 04:05:31 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 04:05:48 INFO - Reading from file tmpfile_stdout 04:05:48 INFO - Output received: 04:05:48 INFO - /builds/slave/test/build/application/firefox/firefox 04:05:48 INFO - Running post-action listener: _resource_record_post_action 04:05:48 INFO - [mozharness: 2016-08-23 11:05:48.778441Z] Finished install step (success) 04:05:48 INFO - [mozharness: 2016-08-23 11:05:48.778688Z] Running run-tests step. 04:05:48 INFO - Running pre-action listener: _resource_record_pre_action 04:05:48 INFO - Running main action method: run_tests 04:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:05:48 INFO - Python 2.7.3 04:05:48 INFO - Return code: 0 04:05:48 INFO - grabbing minidump binary from tooltool 04:05:48 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')]} 04:05:48 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 0x28fd370>, '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 0x29008f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2900d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:05:48 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 04:05:48 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 04:05:48 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 04:05:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:48 INFO - Return code: 0 04:05:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:05:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:05:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:05:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:05:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:05:48 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/BoU549FzQmKJv0ONbHyTlQ/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 04:05:48 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/BoU549FzQmKJv0ONbHyTlQ/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 04:05:48 INFO - Using env: {'DISPLAY': ':0', 04:05:48 INFO - 'HOME': '/home/cltbld', 04:05:48 INFO - 'LANG': 'en_US.UTF-8', 04:05:48 INFO - 'LANGUAGE': 'en_US:en', 04:05:48 INFO - 'LOGNAME': 'cltbld', 04:05:48 INFO - 'MAIL': '/var/mail/cltbld', 04:05:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:05:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:48 INFO - 'MOZ_NO_REMOTE': '1', 04:05:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:48 INFO - 'NO_EM_RESTART': '1', 04:05:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:48 INFO - 'PWD': '/builds/slave/test', 04:05:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:05:48 INFO - 'SHELL': '/bin/bash', 04:05:48 INFO - 'SHLVL': '1', 04:05:48 INFO - 'TERM': 'linux', 04:05:48 INFO - 'TMOUT': '86400', 04:05:48 INFO - 'USER': 'cltbld', 04:05:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471948949.755928-1059864580', 04:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:48 INFO - '_': '/tools/buildbot/bin/python'} 04:05:48 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/BoU549FzQmKJv0ONbHyTlQ/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 04:05:49 INFO - mozversion application_buildid: 20160823023001 04:05:49 INFO - mozversion application_changeset: e5f3c2ed25f511cb5882574c300026cb0765a697 04:05:49 INFO - mozversion application_display_name: Nightly 04:05:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:49 INFO - mozversion application_name: Firefox 04:05:49 INFO - mozversion application_remotingname: firefox 04:05:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:05:49 INFO - mozversion application_vendor: Mozilla 04:05:49 INFO - mozversion application_version: 51.0a1 04:05:49 INFO - mozversion platform_buildid: 20160823023001 04:05:49 INFO - mozversion platform_changeset: e5f3c2ed25f511cb5882574c300026cb0765a697 04:05:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:05:49 INFO - mozversion platform_version: 51.0a1 04:05:49 INFO - using testdate: 1471950349 04:05:49 INFO - actual date: 1471950349 04:05:49 INFO - starting webserver on 'localhost:39157' 04:05:49 INFO - SUITE-START | Running 2 tests 04:05:49 INFO - TEST-START | dromaeo_css 04:05:49 INFO - operating with platform_type : linux_ 04:05:49 INFO - Initialising browser for dromaeo_css test... 04:05:49 INFO - TEST-INFO | started process 5003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvNDf7/profile http://localhost:39157/getInfo.html) 04:05:54 INFO - PROCESS | 5003 | __metrics Screen width/height:1600/1200 04:05:54 INFO - PROCESS | 5003 | colorDepth:24 04:05:54 INFO - PROCESS | 5003 | Browser inner width/height: 1024/697 04:05:54 INFO - PROCESS | 5003 | __metrics 04:05:55 INFO - PROCESS | 5003 | 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" 04:05:55 INFO - PROCESS | 5003 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:55 INFO - PROCESS | 5003 | console.error: PushService: 04:05:55 INFO - PROCESS | 5003 | stateChangeProcessEnqueue: Error transitioning state 04:05:55 INFO - PROCESS | 5003 | UnknownError 04:05:56 INFO - TEST-INFO | 5003: exit 0 04:05:56 INFO - Browser initialized. 04:05:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:56 INFO - TEST-INFO | started process 5084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvNDf7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:08 INFO - PROCESS | 5084 | RSS: Main: 173903872 04:06:08 INFO - PROCESS | 5084 | 04:06:59 INFO - PROCESS | 5084 | 1471950419323 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] 04:09:09 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:39157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39157/tests/dromaeo/cssquery-ext.html) 04:09:10 INFO - PROCESS | 5084 | RSS: Main: 301162496 04:09:10 INFO - PROCESS | 5084 | 04:12:13 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:39157/tests/dromaeo/cssquery-ext.html (next: http://localhost:39157/tests/dromaeo/cssquery-jquery.html) 04:12:14 INFO - PROCESS | 5084 | RSS: Main: 270802944 04:12:14 INFO - PROCESS | 5084 | 04:15:16 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:39157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39157/tests/dromaeo/cssquery-mootools.html) 04:15:16 INFO - PROCESS | 5084 | RSS: Main: 216530944 04:15:16 INFO - PROCESS | 5084 | 04:18:18 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:39157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39157/tests/dromaeo/cssquery-prototype.html) 04:18:19 INFO - PROCESS | 5084 | RSS: Main: 262418432 04:18:19 INFO - PROCESS | 5084 | 04:21:22 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:39157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39157/tests/dromaeo/cssquery-yui.html) 04:21:23 INFO - PROCESS | 5084 | RSS: Main: 214798336 04:21:23 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | Cycle 1(1): loaded http://localhost:39157/tests/dromaeo/cssquery-yui.html (next: http://localhost:39157/tests/dromaeo/cssquery-dojo.html) 04:24:26 INFO - PROCESS | 5084 | RSS: Main: 298340352 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | __start_tp_report 04:24:26 INFO - PROCESS | 5084 | _x_x_mozilla_page_load 04:24:26 INFO - PROCESS | 5084 | _x_x_mozilla_page_load_details 04:24:26 INFO - PROCESS | 5084 | |i|pagename|runs| 04:24:26 INFO - PROCESS | 5084 | |0;dojo.html;2957.95563066554;2998.580198772174;3004.5342971839373;3007.067808979217;3027.4853274943257;5160.741962901859;5250.133727934891;5254.290670759447;5274.657147285424;5374.516293533581;5056.721880296583;5071.315372424721;5228.111221092414;5293.57651387889;5390.78436862525;4868.610511159099;4886.58464030556;4890.168671325865;4893.804247830082;4964.329815474901;4896.877578060559;4901.926471102936;4923;4952.62855285855;4978.55193032627;4703.670743047988;4762.928556071662;4781.211100168468;4792.712437253741;4821.831235906761;4792.353032340624;4844.249320550737;4878.365812444395;4878.756062196876;4879.8780030499165;4666.2533994561045;4852.9757351213375;4865.221564549655;4869.099216644932;4871.537203965618;5163.561097306733;5270.341207349082;5283.418823929364;5344.6793192408195;5350.3312085989255;5651.689157096358;5668.97165514174;5685.289338832646;5706.029974904276;5710.257666503369;5486.341639003305;5577.107662773978;5687.8293651190115;5700.287464066992;5703.144528320785;5297.655652382621;5331.721595620346;5351.1973204019705;5360.892782144335;5362.249285100089;5872.7357268923;5898.498627616615;5905.822825315247;5912.260967379078;5912.970435147797;5351.866203344947;5482.643628164236;5626.437356264422;5636.957162924872;5637.351704553947;5590.86022849432;5651.689157096399;5659.462351076641;5664.886702266014;5675.4324567543745;5651.943480565142;5656.434356564393;5660.915086273709;5664.68844213564;5668.9716551417805;5458.263134476795;5512;5656.43435656431;5661.745221465044;5668.064769313017;4348.847790327323;4369.6722745794195;4376.956230437655;4379.474463064453;4382.452193475816;3873.0511024798543;3885.572587015426;3890.7665540067687;3907.8632247871756;3936.7637941723015;5161.4322424533275;5249.317588713443;5391.191321301836;5399.946000540023;5403.4326395727885;5558.749856256478;5646.85882852932;5665.631733937364;5676.290463692038;5681.318241811009;5358.678479291255;5366.8658283542445;5369.4362091980565;5371.355437347544;5378.489043540935;4665.743384113906;4725.149473094807;4762.166620841339;4840.709557426495;4849.830255941025;5827.912581311284;5851.38560451155;5854;5854.5609079320075;5858.297004359504;5665.263515743092;5672.546196304368;5686.914696279477;5687.260656114679;5689.947359738461;5599.412061733622;5754.482096611325;5799.101139323411;5844.415558444121;5854.590178687621;5588.050031494575;5596.964561556125;5601.943980560142;5608.803691870765;5623.409541998031;5668.433156684464;5716.456936591017;5726.599138060295;5731.541476681939;5745.6552606843725;5349;5388.649737767033;5449.645773024899;5603.859903502445;5628.155776633538;5523.2819733436;5528.91706624409;5550.833474995757;5572.749226284745;5581.190727344431;5462.754176062166;5490.231367608458;5499.587530935116;5501.862453438696;5506;5384.353877534721;5480.753366098615;5536.280283563111;5586.13414920688;5595.496405323541;5495.230667706604;5498.257735205696;5500.862478438071;5503.9174412383045;5511.641743286674 04:24:26 INFO - PROCESS | 5084 | |1;ext.html;568.7148784710469;576.7923547522892;600.9729562169701;603.7283222549851;604.2175382879171;42829;43265.7836710816;43620.78189609051;43695.34456983144;47417.28874066892;43728.781356093175;44201;44256.557434425646;44300.77849610747;44363.55636443634;8941.284697224222;9101.135392137769;9105.544722763869;9149.725508234764;9154.35919485633;9008.68469603564;9100.635974561043;9112.635494580209;9123.1333023363;9126.26989840811;9152.405093668924;9178.128077832594;9185.95407022964;9188.58651360687;9192.218661413788;9118.63525458984;9157.130072643089;9157.816843663157;9161.175494205554;9169.037251088606;9008.279337652972;9077.500737459437;9078.137576930247;9080.182783549446;9081.273498120134;42556.1488770226;42804.785976070234;42870.142597148195;42945;42945.78527107376;3388.6611338865914;3576.7675101118602;3738.6448287412923;4051.898702532431;4102.384642303648;32298;32550.348993020245;33016.50475242873;33648.327033459194;33985;4318.568143185687;4383.49589797171;4451.3323001550025;4474.77626118696;4506.346579745951;352125;352704;353868;355198;355995;58637.70681146567;58939.41060589425;58942.70528647415;58991;59014;36333.091672707866;37289.81355093207;60866;61145.69427152836;61375.386246136964;14994.925025374803;15219.239038048054;15232.086074835324;15233.23833808305;15237.085774853544;11849.822252666218;11875.40622968848;11900.404979750978;11910.047196224281;11949.820752688716;19080;19090.23639054422;19174.520636983907;19194.424167275003;19311.324103656305;7067.89398159028;7304.5252058616015;7451.515651482745;7472.514286571355;7511.51175173612;963.6723514005272;1055.466989170464;1079.1939366209742;1094.0809719835377;1115.3809635652128;31636.841815790773;32212.83893580517;32269;32513.837430812695;32864.67135328664;1082.3181395720803;1087.151841868826;1089.836524521328;1097.3032124600777;1210.9757804843853;16553.337866485446;16983.575410614587;17070.829291706923;17125.314987400612;17302.653946920993;565930;566558;571043;572143;572618;59355.70322148448;60049.09926351108;60177.39822601806;60251.698741506014;60347.39652603505;1242.863285038645;1322.127395918689;1377.6831328794433;1387.2439520461373;1404.2978510744424;30723.2319192022;33249.677541919395;33294;33574.49638255379;33779.324413512084;51479.74260128675;52106.21840672317;52135;52146.21780673217;52165.7391713039;395710;399612;399926;399965;400220;25691.614625781003;27937.58093628638;28797.856010719814;28959.42081158407;29199;47759.28361074656;47996.52003479921;48327;48816.267755982975;49093;40390;41088.58911410967;41211.587884121975;41590.792046039576;43273;41511.58488415198;41537.792311038254;41625.58374416217;42055.60235888868;42143.789281053396;39778;40549;40907.795461022506;40932.59067409288;41082.38376424416;34859.825700872345;35798.28403431865;37029.25941481209;37172.86647703207;37640.43539346967;27827.833830561987;27954.16137515878;28132.890033247997;28230.794513998604;28346.149615511567 04:24:26 INFO - PROCESS | 5084 | |2;jquery.html;376.88505005973167;383.7985057844633;392.5074032089728;397.8527944660475;417.86837146298916;14475.710485790278;18474.722879156805;18486.352977645784;20284.29004984826;20307.49231269219;18258.634827303445;19547;19645.50886227845;19821.306254281102;19827.10778014989;5672.319321681393;5692.089265717486;5968.194293770351;5995.940040599604;6087.726052327655;6023.759049638009;6048.183495228154;6071.180390647272;6071.453569178773;6172.691365431733;6541.836454088662;6592.044153597725;6596.373344532286;6596.406323430891;6597.538172327939;5999.490043346277;6071.089336599502;6071.63570185788;6596.505262105337;6602.834929126762;5865.120231965197;5867.266591676041;5871.588988770788;5875.618084824473;5875.676837773964;14618.561443156615;14683.265836708122;14683.63290917725;14689.853101468956;17199.1400429978;2265.4336415896028;2308.595995700746;2490.439651078511;2922.8746932430954;2971.643402791679;10373.896261037444;10430.85260621331;10466.372017678963;10740.140788736882;10871.565137394495;1948.1915005272795;1970.4384250488542;2015.9596808063902;2020.4948762809297;2106.989465052665;76324.99999999945;82698;84148;84804.57597712033;88014.67977980399;9342.486163261086;9879.555420006118;9961.55173017216;10029.097381235724;11096.1123110151;13439.46242150303;13496.5276215332;13504.459821607223;13510.392032358568;14046.859531404556;7735.22647735222;7828.530288182727;8162.428629995843;8292.502449853027;8569;7567.508111972704;7619.352355049772;8051.4766540174705;8248.628811703487;8267.338612911073;4715.3869996900185;4767.570918617341;4823.614110871122;4925.285833554115;5015.84952451427;1966.1938605172097;2017.9899100504404;2021.181421524285;2032.1972820735728;2103.3269353806636;917.7797328641078;981.0238812381726;994.0010289658846;1018.3889666200369;1022.8158931392272;18927.90536047311;19077.2369105237;19156.425307240806;19291.324803631807;19334.80665193358;933.3373304953424;948.742915636784;964.4068897628049;975.4147511493189;985.0937137833067;8211.425200235926;10198.33710808795;10879.132380719775;10880.347179169275;10905.256213547133;462987;464727;466947;477820;479110;90372;90756.5462172685;91180;91223;92025.53987230155;959.1032384720309;971.1162841814057;987.629638885418;989.9158571521357;998.670438755209;16359.918200408922;16684.416045438353;17306.307747689953;17326.22032008588;17494.125293735517;42262.57737422586;42335;42641.36037959495;42915.356269655356;43899;54040.729796350766;59969;60907.39092609017;61543.38456615555;62198.378016219256;6748.865022699617;7706.884396734165;8869.73390798277;8888.911110888808;9054.547272636473;11690.240134391237;12603.243805371707;12620.242785432903;12631.684207894508;12735.681607959876;10817.140009965122;10852.945735271272;10880.45597720095;11036.11711063129;11193;10501.159907207559;10734.624288149877;10805.837912431478;10811.13510919109;11045.226834121535;10961.342319460859;11094.11552996243;11140.10879129684;11228.214025018171;11637.592684256011;8652.653893844175;8656.177663121993;8773.736787896374;8810.955945220232;8903;10165.491725413553;10638.255322127687;11076.501557430096;11107.333559986104;11461.942690286494 04:24:26 INFO - PROCESS | 5084 | |3;mootools.html;1351.4796803230754;1473.351725240894;1503.4286970951039;1628.4870265866252;1785.3661950007738;8431.915680843198;8905.777355566106;8913.777155571106;9107.68123115691;9122.361434699573;8889.111088891108;9028.729138125851;9053.411528250675;9054.77363065922;9075.092490750922;2057.094878253571;2321.5008773113777;2411.4212588978694;2458.91393801217;2459.053264493165;2417.576924038286;2441.5239028389383;2442.645816356627;2452.043702955849;2453.264020793764;2418.419579300964;2430.0765709030543;2451.3013791069548;2451.4851881104987;2468.1731619907355;2298.092253559851;2332.7317358503733;2339.8128149748063;2340.677517202792;2397.1729753235104;2410.9758902410927;2425.333033415825;2427.1262345555588;2428.659987601737;2430.684011078566;9229.861552076723;9286.349955503118;9294.581743821544;9299.67451139207;9304.72085837426;5384.757685904144;5408.648437851527;5450.4549545045575;5519.116941289374;5520.66875987442;3398.4732366483236;3519.366514027474;3582.0328511301805;3584.1577229351083;3628.4920111184456;1137.527925910746;1178.6699724077187;1184.1888306509982;1190.7140288488413;1203.6689910274745;11814.822777658343;11826.940865295619;11846.822297665542;11848.881511184863;11872.050235981102;4368.279233926367;4552.157850797613;4639.396878405786;4668.696534725232;4700.177468942989;9436.056394360508;9450.43297402158;9504.619815207314;9510.667126650535;9515.57179926905;5281;5284.101702710548;5288.524032837063;5288.550473209743;5326.414094449608;4322.740635561876;4807.351007613997;4844.346013288161;4986.326845875833;4988.027334669777;3753.4557489163917;3758.4362345648374;3847.2305538892333;3924.8822535323984;3940.6650434712797;1136.778328225988;1141.5890279499374;1147.449224372306;1152.0725815718426;1196.3001644038336;890.7416849113814;944.4003058058182;949.2026697573933;950.9286803489628;969.3069455339325;5858.736356863951;5967.940320596826;6049.455549000523;6056.606320589148;6362.331955144736;487.1012981049957;488.20422710980876;488.27978731370945;488.79226328810114;489.13667377079486;4270.807813648394;4298.376735373354;4303.053328267839;4309.633681137138;4318.244307246219;10969.50637221311;11328.71678208035;11385.601503947322;11388.715282117848;11403.657890263305;10183.490825458846;10638.893611063944;10647;11383.146264030065;11389.715257118638;8243.917560824435;8438.873416898752;8439.071702112762;8440.535770532557;8446.450980686235;5795.217645617788;5950.880982380241;5965.850853728692;6136.846578835565;6279.96860015697;10051.49742512886;10125.59497620087;10443.216758743276;10455.372677639367;10767.946160269148;10710.946445267724;10740;10796.784064318826;10855.945720271664;10865.619703310345;7419.07261592301;7614.543127412373;7736.961315193388;7923;8083.151269116658;8910.777230569029;8911.06433824465;8934.910650893407;8961.23829474502;8981.55092245372;7913.881291780513;7988.161243069394;8109.594520273845;8147.470414423044;8277.296429803293;7855.253750893656;7897.24976127267;7962.6814927404575;8005.479643823133;8009.639566219651;6914.688839002358;7128.251533588898;7142.428605711427;7169.7132114716915;7190.856182876418;4969.130402179532;5208.062548741112;5283.815066472809;5296.390915044819;5467.20725494809;5341.572674186134;5364.6512976656395;5399.244105825109;5418.945810542002;5529.778808847762 04:24:26 INFO - PROCESS | 5084 | |4;prototype.html;314.6480061539989;326.0381873473254;331.1935437210392;334.8359303941068;335.99160020999454;5188.48115188481;5235.397929238139;5246.7901283948595;5247.658902171361;5272.181097521358;4907.460179380265;4981.476944920785;5147.253648221005;5165.328507294046;5222;4080.1839632073556;4082.7142100053006;4092.9795351023276;4099.487564054493;4103.753774773523;4098.672106231495;4123.773192474413;4126.773027483488;4132.499837598255;4136.21411931732;3843.1737176507045;3912.4522566840665;4075.205334959684;4080.367543030835;4108.424820525129;4043;4080.775557344345;4087.4686290782306;4096.487939007609;4103.4870641169855;3665.486831843544;3665.5601327840563;3673.6142705015855;3676.6212670248656;3696.796676182809;4969.602431805447;5007.874803129915;5054.306807219586;5143.665661732013;5151.6908985461;4683;4684;4701.95298047022;4704.9059018819435;4716.457607375161;5426.158945363435;5435.592330575223;5436.755346009439;5439.422567455433;5445.37378201504;3827.483289755903;4009.9975006248437;4035.0921042765435;4042.413849991735;4054.6756259499466;5603.8879222415735;5635.380108188096;5639.661620302754;5646.774129034834;5661.801836935688;4149.937750933738;4157.708960372805;4164.646005089541;4186.162767446462;4196.454460920061;4027.4764280643913;4242.830286788494;4244.129953359554;4247.150569885974;4248.723832950848;4694.976525117421;4703.341532185496;4707.8587642370785;4732.73969931657;4750.812296925768;5479.643823151482;5481.835544933659;5495.1865884258095;5505.284313039359;5518.44815518453;1381.4803715912417;1434.2971943747489;1457.6865973815682;1458.5259790568107;1476.7489526780473;935.8970513243538;973.5035132082688;980.7302991677345;986.4278718343344;987.2250283527396;4477.3731677565165;4708.822794301424;4733.976330118397;4779.1636463619425;4796.880077998008;4902.583280421133;4947.975260123676;4948.851534453972;4974.552290293891;4979.979104283613;4684.5549672781035;4698.694584851974;4705.976470117696;4752.669252609275;4769.904601907942;2432.5499782540287;2628.8948442062488;2654.2568080937367;2673.919782406531;2692.680586512595;5031.396232452056;5068.391792984866;5083.262926875656;5120.667156634807;5127.666911555308;5011.396353167024;5032.597392208614;5036.84889453317;5037.5642941761425;5038.455579932111;4866.294387313819;4993.051320249141;5047.258695749961;5075.949240507548;5079;4922.950770492249;4928.236123400879;4937.975310123426;4951.900961980668;4955.776990035385;4839.274108883696;4854.101991131652;4865.416150062015;4870.391201099863;4943.110240156806;4716.882077948078;4945.554900059012;5001.924971125509;5040.546350828443;5109.233614957786;3786.4320351947426;3791.563970143469;3799.297130030953;3806.942895856509;3816.7137464690813;4970.900581988268;5364.678119312854;5412.566994640498;5489.094299440548;5518.668879867221;4928.827491037797;5421.9186712200135;5454.699991500505;5476.644018138968;5477.561795056466;5423.810166644149;5424.7558859850615;5434.891302174014;5435.732949634518;5439.836804895859;5238.476152384731;5289.175234544076;5297.17893726473;5373.247745315737;5385.8922821542565;5197.220416937338;5471.781128754806;5510.090835012178;5540.612157149122;5544.7227638618715;5426.755795989111;5428.430014848384;5430.755615997211;5466.453354664502;5502.504774570148 04:24:26 INFO - PROCESS | 5084 | |5;yui.html;743.7619961612282;745.701719312275;767.5164646272847;773.1611201845997;833.7373727275908;15749;17571.648567028653;17580.120993950284;17595.64808703825;17647.20587573559;15745.527634170992;15813.84186158138;15837.524874253791;15963.281652325644;15968.520944371658;636.9235691717;770.9498882572643;801.6432687454085;817.9672813087499;838.5723281126639;826.7023871406288;837.4723923927917;837.4807619276057;837.5519097282955;838.0111468467206;873.166126349338;877.5305211711735;877.9517126558069;878.1438097854605;882.660175832306;706.0644645844226;851.9318454523623;872.746903398017;873.3362644390246;873.8907636545368;633.1926793338484;633.5343522510951;634.5431289471619;634.6985182038541;634.723895105626;15231;15249.695006099815;15281.465148719853;15340.386384544716;15353.616159595987;14682.412703491847;14830.292426893277;15050.247487625684;15145.469908553257;15165;12311.138200504489;12494.312812795293;12593.244405335709;13218.272994985273;13255.602331930058;4426.55734426558;4548.249538826123;4582.747948862811;4749.335093086971;4750.12122757291;80464;83174.58412707898;83254.58372708097;83466;83734;11414.258073225214;11608.709782255512;11692;11868.821967670492;11969.700757480958;22181.889090554443;22378.888105559367;22412.77587224107;22434.77565224327;22544.32367028959;8765.342599305077;8865.423747456394;8877.289816814638;8929.151730585583;9010.27917766577;4912.582430493377;4956.638158420639;5052.418971818214;5092.26162206478;5139.074966506065;3287.342531493711;3459.7578169528397;3460.5501284832812;3467.5665541807275;3472.062543113396;591.3317950715664;598.2163365990566;598.5660396212797;599.1073300781891;601.8826328865916;546.3907742866675;630.4483576870239;661.7187695229508;667.829703425633;684.7192651013061;8928.464292142493;9698.224142068617;9883.308168428284;10059.597616095421;10179.592816287413;598.470353736946;610.1732152932801;627.6234259444296;654.6366766444669;687.3229868579446;4924.236743304794;5302.840914772563;5305.469453054741;5414.137409875823;5448.318960129984;69970.30029699739;93186;94082;105190.47404762928;124183;100576;101546.98453015376;102626;103021;104207.4789626047;93156.53421732847;93619;95097.5735363984;95687;95757.52121239349;10332;10360.481975901326;10360.689179324632;10515.789684206426;10575.576976920836;52186.47813521816;52215;53206;53367.46632533625;55613.721931390086;76732.61633691796;78561;81364;82545;83569.58215208886;13832.654183645087;13863.168209907439;13955.302234888011;14198.787018194942;14671;15529.84470155284;16152.757708634615;16225.675486489969;16317.67364652724;17067.829321706624;14174.929125354307;14423.754655202496;14955.700885982002;15081.719564493642;15245.390184392943;14166.575002749934;14289.857101428852;14446.855531444551;14468.565943021726;14785.334659940543;14309.713805723619;14649.340779664728;14690;14939.626509337353;14981.250937453302;11851.881481185077;12090.818637720266;12224.266544007032;12276.140670153003;12696.238225706487;11936.58221962227;12216.711595649214;12473.688157796129;12476.688082798002;12636.818396754757 04:24:26 INFO - PROCESS | 5084 | __end_tp_report 04:24:26 INFO - PROCESS | 5084 | __start_cc_report 04:24:26 INFO - PROCESS | 5084 | _x_x_mozilla_cycle_collect,1225 04:24:26 INFO - PROCESS | 5084 | __end_cc_report 04:24:26 INFO - PROCESS | 5084 | __startTimestamp1471951466417__endTimestamp 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | ------- Summary: start ------- 04:24:26 INFO - PROCESS | 5084 | Number of tests: 6 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | [#0] dojo.html Cycles:165 Average:5260.07 Median:5480.75 stddev:599.02 (10.9%) stddev-sans-first:572.98 04:24:26 INFO - PROCESS | 5084 | Values: 2958.0 2998.6 3004.5 3007.1 3027.5 5160.7 5250.1 5254.3 5274.7 5374.5 5056.7 5071.3 5228.1 5293.6 5390.8 4868.6 4886.6 4890.2 4893.8 4964.3 4896.9 4901.9 4923.0 4952.6 4978.6 4703.7 4762.9 4781.2 4792.7 4821.8 4792.4 4844.2 4878.4 4878.8 4879.9 4666.3 4853.0 4865.2 4869.1 4871.5 5163.6 5270.3 5283.4 5344.7 5350.3 5651.7 5669.0 5685.3 5706.0 5710.3 5486.3 5577.1 5687.8 5700.3 5703.1 5297.7 5331.7 5351.2 5360.9 5362.2 5872.7 5898.5 5905.8 5912.3 5913.0 5351.9 5482.6 5626.4 5637.0 5637.4 5590.9 5651.7 5659.5 5664.9 5675.4 5651.9 5656.4 5660.9 5664.7 5669.0 5458.3 5512.0 5656.4 5661.7 5668.1 4348.8 4369.7 4377.0 4379.5 4382.5 3873.1 3885.6 3890.8 3907.9 3936.8 5161.4 5249.3 5391.2 5399.9 5403.4 5558.7 5646.9 5665.6 5676.3 5681.3 5358.7 5366.9 5369.4 5371.4 5378.5 4665.7 4725.1 4762.2 4840.7 4849.8 5827.9 5851.4 5854.0 5854.6 5858.3 5665.3 5672.5 5686.9 5687.3 5689.9 5599.4 5754.5 5799.1 5844.4 5854.6 5588.1 5597.0 5601.9 5608.8 5623.4 5668.4 5716.5 5726.6 5731.5 5745.7 5349.0 5388.6 5449.6 5603.9 5628.2 5523.3 5528.9 5550.8 5572.7 5581.2 5462.8 5490.2 5499.6 5501.9 5506.0 5384.4 5480.8 5536.3 5586.1 5595.5 5495.2 5498.3 5500.9 5503.9 5511.6 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | [#1] ext.html Cycles:180 Average:60225.51 Median:41564.29 stddev:119585.09 (287.7%) stddev-sans-first:119836.68 04:24:26 INFO - PROCESS | 5084 | Values: 568.7 576.8 601.0 603.7 604.2 42829.0 43265.8 43620.8 43695.3 47417.3 43728.8 44201.0 44256.6 44300.8 44363.6 8941.3 9101.1 9105.5 9149.7 9154.4 9008.7 9100.6 9112.6 9123.1 9126.3 9152.4 9178.1 9186.0 9188.6 9192.2 9118.6 9157.1 9157.8 9161.2 9169.0 9008.3 9077.5 9078.1 9080.2 9081.3 42556.1 42804.8 42870.1 42945.0 42945.8 3388.7 3576.8 3738.6 4051.9 4102.4 32298.0 32550.3 33016.5 33648.3 33985.0 4318.6 4383.5 4451.3 4474.8 4506.3 352125.0 352704.0 353868.0 355198.0 355995.0 58637.7 58939.4 58942.7 58991.0 59014.0 36333.1 37289.8 60866.0 61145.7 61375.4 14994.9 15219.2 15232.1 15233.2 15237.1 11849.8 11875.4 11900.4 11910.0 11949.8 19080.0 19090.2 19174.5 19194.4 19311.3 7067.9 7304.5 7451.5 7472.5 7511.5 963.7 1055.5 1079.2 1094.1 1115.4 31636.8 32212.8 32269.0 32513.8 32864.7 1082.3 1087.2 1089.8 1097.3 1211.0 16553.3 16983.6 17070.8 17125.3 17302.7 565930.0 566558.0 571043.0 572143.0 572618.0 59355.7 60049.1 60177.4 60251.7 60347.4 1242.9 1322.1 1377.7 1387.2 1404.3 30723.2 33249.7 33294.0 33574.5 33779.3 51479.7 52106.2 52135.0 52146.2 52165.7 395710.0 399612.0 399926.0 399965.0 400220.0 25691.6 27937.6 28797.9 28959.4 29199.0 47759.3 47996.5 48327.0 48816.3 49093.0 40390.0 41088.6 41211.6 41590.8 43273.0 41511.6 41537.8 41625.6 42055.6 42143.8 39778.0 40549.0 40907.8 40932.6 41082.4 34859.8 35798.3 37029.3 37172.9 37640.4 27827.8 27954.2 28132.9 28230.8 28346.1 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | [#2] jquery.html Cycles:180 Average:28213.35 Median:42778.36 stddev:77764.18 (181.8%) stddev-sans-first:77954.24 04:24:26 INFO - PROCESS | 5084 | Values: 376.9 383.8 392.5 397.9 417.9 14475.7 18474.7 18486.4 20284.3 20307.5 18258.6 19547.0 19645.5 19821.3 19827.1 5672.3 5692.1 5968.2 5995.9 6087.7 6023.8 6048.2 6071.2 6071.5 6172.7 6541.8 6592.0 6596.4 6596.4 6597.5 5999.5 6071.1 6071.6 6596.5 6602.8 5865.1 5867.3 5871.6 5875.6 5875.7 14618.6 14683.3 14683.6 14689.9 17199.1 2265.4 2308.6 2490.4 2922.9 2971.6 10373.9 10430.9 10466.4 10740.1 10871.6 1948.2 1970.4 2016.0 2020.5 2107.0 76325.0 82698.0 84148.0 84804.6 88014.7 9342.5 9879.6 9961.6 10029.1 11096.1 13439.5 13496.5 13504.5 13510.4 14046.9 7735.2 7828.5 8162.4 8292.5 8569.0 7567.5 7619.4 8051.5 8248.6 8267.3 4715.4 4767.6 4823.6 4925.3 5015.8 1966.2 2018.0 2021.2 2032.2 2103.3 917.8 981.0 994.0 1018.4 1022.8 18927.9 19077.2 19156.4 19291.3 19334.8 933.3 948.7 964.4 975.4 985.1 8211.4 10198.3 10879.1 10880.3 10905.3 462987.0 464727.0 466947.0 477820.0 479110.0 90372.0 90756.5 91180.0 91223.0 92025.5 959.1 971.1 987.6 989.9 998.7 16359.9 16684.4 17306.3 17326.2 17494.1 42262.6 42335.0 42641.4 42915.4 43899.0 54040.7 59969.0 60907.4 61543.4 62198.4 6748.9 7706.9 8869.7 8888.9 9054.5 11690.2 12603.2 12620.2 12631.7 12735.7 10817.1 10852.9 10880.5 11036.1 11193.0 10501.2 10734.6 10805.8 10811.1 11045.2 10961.3 11094.1 11140.1 11228.2 11637.6 8652.7 8656.2 8773.7 8811.0 8903.0 10165.5 10638.3 11076.5 11107.3 11461.9 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | [#3] mootools.html Cycles:180 Average:5886.92 Median:488.54 stddev:3348.46 (685.4%) stddev-sans-first:3340.50 04:24:26 INFO - PROCESS | 5084 | Values: 1351.5 1473.4 1503.4 1628.5 1785.4 8431.9 8905.8 8913.8 9107.7 9122.4 8889.1 9028.7 9053.4 9054.8 9075.1 2057.1 2321.5 2411.4 2458.9 2459.1 2417.6 2441.5 2442.6 2452.0 2453.3 2418.4 2430.1 2451.3 2451.5 2468.2 2298.1 2332.7 2339.8 2340.7 2397.2 2411.0 2425.3 2427.1 2428.7 2430.7 9229.9 9286.3 9294.6 9299.7 9304.7 5384.8 5408.6 5450.5 5519.1 5520.7 3398.5 3519.4 3582.0 3584.2 3628.5 1137.5 1178.7 1184.2 1190.7 1203.7 11814.8 11826.9 11846.8 11848.9 11872.1 4368.3 4552.2 4639.4 4668.7 4700.2 9436.1 9450.4 9504.6 9510.7 9515.6 5281.0 5284.1 5288.5 5288.6 5326.4 4322.7 4807.4 4844.3 4986.3 4988.0 3753.5 3758.4 3847.2 3924.9 3940.7 1136.8 1141.6 1147.4 1152.1 1196.3 890.7 944.4 949.2 950.9 969.3 5858.7 5967.9 6049.5 6056.6 6362.3 487.1 488.2 488.3 488.8 489.1 4270.8 4298.4 4303.1 4309.6 4318.2 10969.5 11328.7 11385.6 11388.7 11403.7 10183.5 10638.9 10647.0 11383.1 11389.7 8243.9 8438.9 8439.1 8440.5 8446.5 5795.2 5950.9 5965.9 6136.8 6280.0 10051.5 10125.6 10443.2 10455.4 10767.9 10710.9 10740.0 10796.8 10855.9 10865.6 7419.1 7614.5 7737.0 7923.0 8083.2 8910.8 8911.1 8934.9 8961.2 8981.6 7913.9 7988.2 8109.6 8147.5 8277.3 7855.3 7897.2 7962.7 8005.5 8009.6 6914.7 7128.3 7142.4 7169.7 7190.9 4969.1 5208.1 5283.8 5296.4 5467.2 5341.6 5364.7 5399.2 5418.9 5529.8 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | [#4] prototype.html Cycles:180 Average:4430.91 Median:4933.40 stddev:1251.95 (25.4%) stddev-sans-first:1216.74 04:24:26 INFO - PROCESS | 5084 | Values: 314.6 326.0 331.2 334.8 336.0 5188.5 5235.4 5246.8 5247.7 5272.2 4907.5 4981.5 5147.3 5165.3 5222.0 4080.2 4082.7 4093.0 4099.5 4103.8 4098.7 4123.8 4126.8 4132.5 4136.2 3843.2 3912.5 4075.2 4080.4 4108.4 4043.0 4080.8 4087.5 4096.5 4103.5 3665.5 3665.6 3673.6 3676.6 3696.8 4969.6 5007.9 5054.3 5143.7 5151.7 4683.0 4684.0 4702.0 4704.9 4716.5 5426.2 5435.6 5436.8 5439.4 5445.4 3827.5 4010.0 4035.1 4042.4 4054.7 5603.9 5635.4 5639.7 5646.8 5661.8 4149.9 4157.7 4164.6 4186.2 4196.5 4027.5 4242.8 4244.1 4247.2 4248.7 4695.0 4703.3 4707.9 4732.7 4750.8 5479.6 5481.8 5495.2 5505.3 5518.4 1381.5 1434.3 1457.7 1458.5 1476.7 935.9 973.5 980.7 986.4 987.2 4477.4 4708.8 4734.0 4779.2 4796.9 4902.6 4948.0 4948.9 4974.6 4980.0 4684.6 4698.7 4706.0 4752.7 4769.9 2432.5 2628.9 2654.3 2673.9 2692.7 5031.4 5068.4 5083.3 5120.7 5127.7 5011.4 5032.6 5036.8 5037.6 5038.5 4866.3 4993.1 5047.3 5075.9 5079.0 4923.0 4928.2 4938.0 4951.9 4955.8 4839.3 4854.1 4865.4 4870.4 4943.1 4716.9 4945.6 5001.9 5040.5 5109.2 3786.4 3791.6 3799.3 3806.9 3816.7 4970.9 5364.7 5412.6 5489.1 5518.7 4928.8 5421.9 5454.7 5476.6 5477.6 5423.8 5424.8 5434.9 5435.7 5439.8 5238.5 5289.2 5297.2 5373.2 5385.9 5197.2 5471.8 5510.1 5540.6 5544.7 5426.8 5428.4 5430.8 5466.5 5502.5 04:24:26 INFO - PROCESS | 5084 | 04:24:26 INFO - PROCESS | 5084 | [#5] yui.html Cycles:180 Average:21505.23 Median:4565.50 stddev:30072.41 (658.7%) stddev-sans-first:30116.36 04:24:26 INFO - PROCESS | 5084 | Values: 743.8 745.7 767.5 773.2 833.7 15749.0 17571.6 17580.1 17595.6 17647.2 15745.5 15813.8 15837.5 15963.3 15968.5 636.9 770.9 801.6 818.0 838.6 826.7 837.5 837.5 837.6 838.0 873.2 877.5 878.0 878.1 882.7 706.1 851.9 872.7 873.3 873.9 633.2 633.5 634.5 634.7 634.7 15231.0 15249.7 15281.5 15340.4 15353.6 14682.4 14830.3 15050.2 15145.5 15165.0 12311.1 12494.3 12593.2 13218.3 13255.6 4426.6 4548.2 4582.7 4749.3 4750.1 80464.0 83174.6 83254.6 83466.0 83734.0 11414.3 11608.7 11692.0 11868.8 11969.7 22181.9 22378.9 22412.8 22434.8 22544.3 8765.3 8865.4 8877.3 8929.2 9010.3 4912.6 4956.6 5052.4 5092.3 5139.1 3287.3 3459.8 3460.6 3467.6 3472.1 591.3 598.2 598.6 599.1 601.9 546.4 630.4 661.7 667.8 684.7 8928.5 9698.2 9883.3 10059.6 10179.6 598.5 610.2 627.6 654.6 687.3 4924.2 5302.8 5305.5 5414.1 5448.3 69970.3 93186.0 94082.0 105190.5 124183.0 100576.0 101547.0 102626.0 103021.0 104207.5 93156.5 93619.0 95097.6 95687.0 95757.5 10332.0 10360.5 10360.7 10515.8 10575.6 52186.5 52215.0 53206.0 53367.5 55613.7 76732.6 78561.0 81364.0 82545.0 83569.6 13832.7 13863.2 13955.3 14198.8 14671.0 15529.8 16152.8 16225.7 16317.7 17067.8 14174.9 14423.8 14955.7 15081.7 15245.4 14166.6 14289.9 14446.9 14468.6 14785.3 14309.7 14649.3 14690.0 14939.6 14981.3 11851.9 12090.8 12224.3 12276.1 12696.2 11936.6 12216.7 12473.7 12476.7 12636.8 04:24:26 INFO - PROCESS | 5084 | -------- Summary: end -------- 04:24:26 INFO - PROCESS | 5084 | 04:24:27 INFO - TEST-INFO | 5084: exit 0 04:24:27 INFO - TEST-OK | dromaeo_css | took 1118259ms 04:24:27 INFO - TEST-START | kraken 04:24:27 INFO - operating with platform_type : linux_ 04:24:27 INFO - Initialising browser for kraken test... 04:24:27 INFO - TEST-INFO | started process 5394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_zgelN/profile http://localhost:39157/getInfo.html) 04:24:31 INFO - PROCESS | 5394 | __metrics Screen width/height:1600/1200 04:24:31 INFO - PROCESS | 5394 | colorDepth:24 04:24:31 INFO - PROCESS | 5394 | Browser inner width/height: 1024/697 04:24:31 INFO - PROCESS | 5394 | __metrics 04:24:32 INFO - PROCESS | 5394 | 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" 04:24:32 INFO - PROCESS | 5394 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:33 INFO - TEST-INFO | 5394: exit 0 04:24:33 INFO - Browser initialized. 04:24:33 INFO - Running cycle 1/1 for kraken test... 04:24:33 INFO - TEST-INFO | started process 5473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_zgelN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:45 INFO - PROCESS | 5473 | RSS: Main: 174096384 04:24:45 INFO - PROCESS | 5473 | 04:24:47 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39157/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:48 INFO - PROCESS | 5473 | RSS: Main: 234807296 04:24:48 INFO - PROCESS | 5473 | 04:24:51 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39157/tests/kraken/driver.html?testName=audio-dft) 04:24:51 INFO - PROCESS | 5473 | RSS: Main: 225656832 04:24:51 INFO - PROCESS | 5473 | 04:24:55 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39157/tests/kraken/driver.html?testName=audio-fft) 04:24:55 INFO - PROCESS | 5473 | RSS: Main: 301957120 04:24:55 INFO - PROCESS | 5473 | 04:24:57 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39157/tests/kraken/driver.html?testName=audio-oscillator) 04:24:58 INFO - PROCESS | 5473 | RSS: Main: 209432576 04:24:58 INFO - PROCESS | 5473 | 04:25:00 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:01 INFO - PROCESS | 5473 | RSS: Main: 213491712 04:25:01 INFO - PROCESS | 5473 | 04:25:04 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39157/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:04 INFO - PROCESS | 5473 | RSS: Main: 249528320 04:25:04 INFO - PROCESS | 5473 | 04:25:08 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39157/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:08 INFO - PROCESS | 5473 | RSS: Main: 248168448 04:25:08 INFO - PROCESS | 5473 | 04:25:11 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39157/tests/kraken/driver.html?testName=json-parse-financial) 04:25:12 INFO - PROCESS | 5473 | RSS: Main: 248152064 04:25:12 INFO - PROCESS | 5473 | 04:25:14 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:14 INFO - PROCESS | 5473 | RSS: Main: 211005440 04:25:14 INFO - PROCESS | 5473 | 04:25:16 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:17 INFO - PROCESS | 5473 | RSS: Main: 219525120 04:25:17 INFO - PROCESS | 5473 | 04:25:19 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:19 INFO - PROCESS | 5473 | RSS: Main: 223604736 04:25:19 INFO - PROCESS | 5473 | 04:25:22 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:23 INFO - PROCESS | 5473 | RSS: Main: 218505216 04:25:23 INFO - PROCESS | 5473 | 04:25:25 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:26 INFO - PROCESS | 5473 | RSS: Main: 221757440 04:25:26 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | Cycle 1(1): loaded http://localhost:39157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39157/tests/kraken/driver.html?testName=ai-astar) 04:25:28 INFO - PROCESS | 5473 | RSS: Main: 272166912 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | __start_tp_report 04:25:28 INFO - PROCESS | 5473 | _x_x_mozilla_page_load 04:25:28 INFO - PROCESS | 5473 | _x_x_mozilla_page_load_details 04:25:28 INFO - PROCESS | 5473 | |i|pagename|runs| 04:25:28 INFO - PROCESS | 5473 | |0;ai-astar;103;114;110;111;113;113;118;112;113;110 04:25:28 INFO - PROCESS | 5473 | |1;audio-beat-detection;144;117;147;187;121;142;151;120;177;121 04:25:28 INFO - PROCESS | 5473 | |2;audio-dft;161;161;159;160;160;161;161;162;161;163 04:25:28 INFO - PROCESS | 5473 | |3;audio-fft;75;75;75;162;75;79;75;76;162;76 04:25:28 INFO - PROCESS | 5473 | |4;audio-oscillator;85;84;153;85;86;86;136;85;85;158 04:25:28 INFO - PROCESS | 5473 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 04:25:28 INFO - PROCESS | 5473 | |6;imaging-darkroom;146;146;146;146;147;147;146;147;146;146 04:25:28 INFO - PROCESS | 5473 | |7;imaging-desaturate;95;95;95;95;95;96;96;95;95;95 04:25:28 INFO - PROCESS | 5473 | |8;json-parse-financial;50;52;53;56;54;51;51;51;51;51 04:25:28 INFO - PROCESS | 5473 | |9;json-stringify-tinderbox;61;62;62;62;63;61;63;62;63;63 04:25:28 INFO - PROCESS | 5473 | |10;stanford-crypto-aes;84;79;77;78;82;78;78;78;79;79 04:25:28 INFO - PROCESS | 5473 | |11;stanford-crypto-ccm;124;125;122;122;121;124;126;124;146;135 04:25:28 INFO - PROCESS | 5473 | |12;stanford-crypto-pbkdf2;164;166;164;161;162;165;163;165;163;168 04:25:28 INFO - PROCESS | 5473 | |13;stanford-crypto-sha256-iterative;65;65;67;65;64;66;69;64;68;64 04:25:28 INFO - PROCESS | 5473 | __end_tp_report 04:25:28 INFO - PROCESS | 5473 | __start_cc_report 04:25:28 INFO - PROCESS | 5473 | _x_x_mozilla_cycle_collect,1756 04:25:28 INFO - PROCESS | 5473 | __end_cc_report 04:25:28 INFO - PROCESS | 5473 | __startTimestamp1471951528482__endTimestamp 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | ------- Summary: start ------- 04:25:28 INFO - PROCESS | 5473 | Number of tests: 14 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.83 (3.4%) stddev-sans-first:2.45 04:25:28 INFO - PROCESS | 5473 | Values: 103.0 114.0 110.0 111.0 113.0 113.0 118.0 112.0 113.0 110.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:145.50 stddev:24.37 (16.8%) stddev-sans-first:25.85 04:25:28 INFO - PROCESS | 5473 | Values: 144.0 117.0 147.0 187.0 121.0 142.0 151.0 120.0 177.0 121.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 04:25:28 INFO - PROCESS | 5473 | Values: 161.0 161.0 159.0 160.0 160.0 161.0 161.0 162.0 161.0 163.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:36.39 (48.5%) stddev-sans-first:38.01 04:25:28 INFO - PROCESS | 5473 | Values: 75.0 75.0 75.0 162.0 75.0 79.0 75.0 76.0 162.0 76.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:85.00 stddev:31.33 (36.9%) stddev-sans-first:32.44 04:25:28 INFO - PROCESS | 5473 | Values: 85.0 84.0 153.0 85.0 86.0 86.0 136.0 85.0 85.0 158.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:25:28 INFO - PROCESS | 5473 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:25:28 INFO - PROCESS | 5473 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:25:28 INFO - PROCESS | 5473 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:51.50 stddev:1.83 (3.5%) stddev-sans-first:1.79 04:25:28 INFO - PROCESS | 5473 | Values: 50.0 52.0 53.0 56.0 54.0 51.0 51.0 51.0 51.0 51.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 04:25:28 INFO - PROCESS | 5473 | Values: 61.0 62.0 62.0 62.0 63.0 61.0 63.0 62.0 63.0 63.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:2.15 (2.7%) stddev-sans-first:1.41 04:25:28 INFO - PROCESS | 5473 | Values: 84.0 79.0 77.0 78.0 82.0 78.0 78.0 78.0 79.0 79.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:124.50 stddev:7.77 (6.2%) stddev-sans-first:8.17 04:25:28 INFO - PROCESS | 5473 | Values: 124.0 125.0 122.0 122.0 121.0 124.0 126.0 124.0 146.0 135.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:2.02 (1.2%) stddev-sans-first:2.15 04:25:28 INFO - PROCESS | 5473 | Values: 164.0 166.0 164.0 161.0 162.0 165.0 163.0 165.0 163.0 168.0 04:25:28 INFO - PROCESS | 5473 | 04:25:28 INFO - PROCESS | 5473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:1.77 (2.7%) stddev-sans-first:1.86 04:25:28 INFO - PROCESS | 5473 | Values: 65.0 65.0 67.0 65.0 64.0 66.0 69.0 64.0 68.0 64.0 04:25:28 INFO - PROCESS | 5473 | -------- Summary: end -------- 04:25:28 INFO - PROCESS | 5473 | 04:25:29 INFO - TEST-INFO | 5473: exit 0 04:25:29 INFO - TEST-OK | kraken | took 62422ms 04:25:29 INFO - SUITE-END | took 1180s 04:25:30 INFO - Completed test suite (00:19:41) 04:25:30 INFO - javascript benchmark 04:25:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2957.95563066554, 2998.580198772174, 3004.5342971839373, 3007.067808979217, 3027.4853274943257, 5160.741962901859, 5250.133727934891, 5254.290670759447, 5274.657147285424, 5374.516293533581, 5056.721880296583, 5071.315372424721, 5228.111221092414, 5293.57651387889, 5390.78436862525, 4868.610511159099, 4886.58464030556, 4890.168671325865, 4893.804247830082, 4964.329815474901, 4896.877578060559, 4901.926471102936, 4923.0, 4952.62855285855, 4978.55193032627, 4703.670743047988, 4762.928556071662, 4781.211100168468, 4792.712437253741, 4821.831235906761, 4792.353032340624, 4844.249320550737, 4878.365812444395, 4878.756062196876, 4879.8780030499165, 4666.2533994561045, 4852.9757351213375, 4865.221564549655, 4869.099216644932, 4871.537203965618, 5163.561097306733, 5270.341207349082, 5283.418823929364, 5344.6793192408195, 5350.3312085989255, 5651.689157096358, 5668.97165514174, 5685.289338832646, 5706.029974904276, 5710.257666503369, 5486.341639003305, 5577.107662773978, 5687.8293651190115, 5700.287464066992, 5703.144528320785, 5297.655652382621, 5331.721595620346, 5351.1973204019705, 5360.892782144335, 5362.249285100089, 5872.7357268923, 5898.498627616615, 5905.822825315247, 5912.260967379078, 5912.970435147797, 5351.866203344947, 5482.643628164236, 5626.437356264422, 5636.957162924872, 5637.351704553947, 5590.86022849432, 5651.689157096399, 5659.462351076641, 5664.886702266014, 5675.4324567543745, 5651.943480565142, 5656.434356564393, 5660.915086273709, 5664.68844213564, 5668.9716551417805, 5458.263134476795, 5512.0, 5656.43435656431, 5661.745221465044, 5668.064769313017, 4348.847790327323, 4369.6722745794195, 4376.956230437655, 4379.474463064453, 4382.452193475816, 3873.0511024798543, 3885.572587015426, 3890.7665540067687, 3907.8632247871756, 3936.7637941723015, 5161.4322424533275, 5249.317588713443, 5391.191321301836, 5399.946000540023, 5403.4326395727885, 5558.749856256478, 5646.85882852932, 5665.631733937364, 5676.290463692038, 5681.318241811009, 5358.678479291255, 5366.8658283542445, 5369.4362091980565, 5371.355437347544, 5378.489043540935, 4665.743384113906, 4725.149473094807, 4762.166620841339, 4840.709557426495, 4849.830255941025, 5827.912581311284, 5851.38560451155, 5854.0, 5854.5609079320075, 5858.297004359504, 5665.263515743092, 5672.546196304368, 5686.914696279477, 5687.260656114679, 5689.947359738461, 5599.412061733622, 5754.482096611325, 5799.101139323411, 5844.415558444121, 5854.590178687621, 5588.050031494575, 5596.964561556125, 5601.943980560142, 5608.803691870765, 5623.409541998031, 5668.433156684464, 5716.456936591017, 5726.599138060295, 5731.541476681939, 5745.6552606843725, 5349.0, 5388.649737767033, 5449.645773024899, 5603.859903502445, 5628.155776633538, 5523.2819733436, 5528.91706624409, 5550.833474995757, 5572.749226284745, 5581.190727344431, 5462.754176062166, 5490.231367608458, 5499.587530935116, 5501.862453438696, 5506.0, 5384.353877534721, 5480.753366098615, 5536.280283563111, 5586.13414920688, 5595.496405323541, 5495.230667706604, 5498.257735205696, 5500.862478438071, 5503.9174412383045, 5511.641743286674], "value": 5219.164033027561, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7148784710469, 576.7923547522892, 600.9729562169701, 603.7283222549851, 604.2175382879171, 42829.0, 43265.7836710816, 43620.78189609051, 43695.34456983144, 47417.28874066892, 43728.781356093175, 44201.0, 44256.557434425646, 44300.77849610747, 44363.55636443634, 8941.284697224222, 9101.135392137769, 9105.544722763869, 9149.725508234764, 9154.35919485633, 9008.68469603564, 9100.635974561043, 9112.635494580209, 9123.1333023363, 9126.26989840811, 9152.405093668924, 9178.128077832594, 9185.95407022964, 9188.58651360687, 9192.218661413788, 9118.63525458984, 9157.130072643089, 9157.816843663157, 9161.175494205554, 9169.037251088606, 9008.279337652972, 9077.500737459437, 9078.137576930247, 9080.182783549446, 9081.273498120134, 42556.1488770226, 42804.785976070234, 42870.142597148195, 42945.0, 42945.78527107376, 3388.6611338865914, 3576.7675101118602, 3738.6448287412923, 4051.898702532431, 4102.384642303648, 32298.0, 32550.348993020245, 33016.50475242873, 33648.327033459194, 33985.0, 4318.568143185687, 4383.49589797171, 4451.3323001550025, 4474.77626118696, 4506.346579745951, 352125.0, 352704.0, 353868.0, 355198.0, 355995.0, 58637.70681146567, 58939.41060589425, 58942.70528647415, 58991.0, 59014.0, 36333.091672707866, 37289.81355093207, 60866.0, 61145.69427152836, 61375.386246136964, 14994.925025374803, 15219.239038048054, 15232.086074835324, 15233.23833808305, 15237.085774853544, 11849.822252666218, 11875.40622968848, 11900.404979750978, 11910.047196224281, 11949.820752688716, 19080.0, 19090.23639054422, 19174.520636983907, 19194.424167275003, 19311.324103656305, 7067.89398159028, 7304.5252058616015, 7451.515651482745, 7472.514286571355, 7511.51175173612, 963.6723514005272, 1055.466989170464, 1079.1939366209742, 1094.0809719835377, 1115.3809635652128, 31636.841815790773, 32212.83893580517, 32269.0, 32513.837430812695, 32864.67135328664, 1082.3181395720803, 1087.151841868826, 1089.836524521328, 1097.3032124600777, 1210.9757804843853, 16553.337866485446, 16983.575410614587, 17070.829291706923, 17125.314987400612, 17302.653946920993, 565930.0, 566558.0, 571043.0, 572143.0, 572618.0, 59355.70322148448, 60049.09926351108, 60177.39822601806, 60251.698741506014, 60347.39652603505, 1242.863285038645, 1322.127395918689, 1377.6831328794433, 1387.2439520461373, 1404.2978510744424, 30723.2319192022, 33249.677541919395, 33294.0, 33574.49638255379, 33779.324413512084, 51479.74260128675, 52106.21840672317, 52135.0, 52146.21780673217, 52165.7391713039, 395710.0, 399612.0, 399926.0, 399965.0, 400220.0, 25691.614625781003, 27937.58093628638, 28797.856010719814, 28959.42081158407, 29199.0, 47759.28361074656, 47996.52003479921, 48327.0, 48816.267755982975, 49093.0, 40390.0, 41088.58911410967, 41211.587884121975, 41590.792046039576, 43273.0, 41511.58488415198, 41537.792311038254, 41625.58374416217, 42055.60235888868, 42143.789281053396, 39778.0, 40549.0, 40907.795461022506, 40932.59067409288, 41082.38376424416, 34859.825700872345, 35798.28403431865, 37029.25941481209, 37172.86647703207, 37640.43539346967, 27827.833830561987, 27954.16137515878, 28132.890033247997, 28230.794513998604, 28346.149615511567], "value": 20179.4374822834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.88505005973167, 383.7985057844633, 392.5074032089728, 397.8527944660475, 417.86837146298916, 14475.710485790278, 18474.722879156805, 18486.352977645784, 20284.29004984826, 20307.49231269219, 18258.634827303445, 19547.0, 19645.50886227845, 19821.306254281102, 19827.10778014989, 5672.319321681393, 5692.089265717486, 5968.194293770351, 5995.940040599604, 6087.726052327655, 6023.759049638009, 6048.183495228154, 6071.180390647272, 6071.453569178773, 6172.691365431733, 6541.836454088662, 6592.044153597725, 6596.373344532286, 6596.406323430891, 6597.538172327939, 5999.490043346277, 6071.089336599502, 6071.63570185788, 6596.505262105337, 6602.834929126762, 5865.120231965197, 5867.266591676041, 5871.588988770788, 5875.618084824473, 5875.676837773964, 14618.561443156615, 14683.265836708122, 14683.63290917725, 14689.853101468956, 17199.1400429978, 2265.4336415896028, 2308.595995700746, 2490.439651078511, 2922.8746932430954, 2971.643402791679, 10373.896261037444, 10430.85260621331, 10466.372017678963, 10740.140788736882, 10871.565137394495, 1948.1915005272795, 1970.4384250488542, 2015.9596808063902, 2020.4948762809297, 2106.989465052665, 76324.99999999945, 82698.0, 84148.0, 84804.57597712033, 88014.67977980399, 9342.486163261086, 9879.555420006118, 9961.55173017216, 10029.097381235724, 11096.1123110151, 13439.46242150303, 13496.5276215332, 13504.459821607223, 13510.392032358568, 14046.859531404556, 7735.22647735222, 7828.530288182727, 8162.428629995843, 8292.502449853027, 8569.0, 7567.508111972704, 7619.352355049772, 8051.4766540174705, 8248.628811703487, 8267.338612911073, 4715.3869996900185, 4767.570918617341, 4823.614110871122, 4925.285833554115, 5015.84952451427, 1966.1938605172097, 2017.9899100504404, 2021.181421524285, 2032.1972820735728, 2103.3269353806636, 917.7797328641078, 981.0238812381726, 994.0010289658846, 1018.3889666200369, 1022.8158931392272, 18927.90536047311, 19077.2369105237, 19156.425307240806, 19291.324803631807, 19334.80665193358, 933.3373304953424, 948.742915636784, 964.4068897628049, 975.4147511493189, 985.0937137833067, 8211.425200235926, 10198.33710808795, 10879.132380719775, 10880.347179169275, 10905.256213547133, 462987.0, 464727.0, 466947.0, 477820.0, 479110.0, 90372.0, 90756.5462172685, 91180.0, 91223.0, 92025.53987230155, 959.1032384720309, 971.1162841814057, 987.629638885418, 989.9158571521357, 998.670438755209, 16359.918200408922, 16684.416045438353, 17306.307747689953, 17326.22032008588, 17494.125293735517, 42262.57737422586, 42335.0, 42641.36037959495, 42915.356269655356, 43899.0, 54040.729796350766, 59969.0, 60907.39092609017, 61543.38456615555, 62198.378016219256, 6748.865022699617, 7706.884396734165, 8869.73390798277, 8888.911110888808, 9054.547272636473, 11690.240134391237, 12603.243805371707, 12620.242785432903, 12631.684207894508, 12735.681607959876, 10817.140009965122, 10852.945735271272, 10880.45597720095, 11036.11711063129, 11193.0, 10501.159907207559, 10734.624288149877, 10805.837912431478, 10811.13510919109, 11045.226834121535, 10961.342319460859, 11094.11552996243, 11140.10879129684, 11228.214025018171, 11637.592684256011, 8652.653893844175, 8656.177663121993, 8773.736787896374, 8810.955945220232, 8903.0, 10165.491725413553, 10638.255322127687, 11076.501557430096, 11107.333559986104, 11461.942690286494], "value": 9094.157888587953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.4796803230754, 1473.351725240894, 1503.4286970951039, 1628.4870265866252, 1785.3661950007738, 8431.915680843198, 8905.777355566106, 8913.777155571106, 9107.68123115691, 9122.361434699573, 8889.111088891108, 9028.729138125851, 9053.411528250675, 9054.77363065922, 9075.092490750922, 2057.094878253571, 2321.5008773113777, 2411.4212588978694, 2458.91393801217, 2459.053264493165, 2417.576924038286, 2441.5239028389383, 2442.645816356627, 2452.043702955849, 2453.264020793764, 2418.419579300964, 2430.0765709030543, 2451.3013791069548, 2451.4851881104987, 2468.1731619907355, 2298.092253559851, 2332.7317358503733, 2339.8128149748063, 2340.677517202792, 2397.1729753235104, 2410.9758902410927, 2425.333033415825, 2427.1262345555588, 2428.659987601737, 2430.684011078566, 9229.861552076723, 9286.349955503118, 9294.581743821544, 9299.67451139207, 9304.72085837426, 5384.757685904144, 5408.648437851527, 5450.4549545045575, 5519.116941289374, 5520.66875987442, 3398.4732366483236, 3519.366514027474, 3582.0328511301805, 3584.1577229351083, 3628.4920111184456, 1137.527925910746, 1178.6699724077187, 1184.1888306509982, 1190.7140288488413, 1203.6689910274745, 11814.822777658343, 11826.940865295619, 11846.822297665542, 11848.881511184863, 11872.050235981102, 4368.279233926367, 4552.157850797613, 4639.396878405786, 4668.696534725232, 4700.177468942989, 9436.056394360508, 9450.43297402158, 9504.619815207314, 9510.667126650535, 9515.57179926905, 5281.0, 5284.101702710548, 5288.524032837063, 5288.550473209743, 5326.414094449608, 4322.740635561876, 4807.351007613997, 4844.346013288161, 4986.326845875833, 4988.027334669777, 3753.4557489163917, 3758.4362345648374, 3847.2305538892333, 3924.8822535323984, 3940.6650434712797, 1136.778328225988, 1141.5890279499374, 1147.449224372306, 1152.0725815718426, 1196.3001644038336, 890.7416849113814, 944.4003058058182, 949.2026697573933, 950.9286803489628, 969.3069455339325, 5858.736356863951, 5967.940320596826, 6049.455549000523, 6056.606320589148, 6362.331955144736, 487.1012981049957, 488.20422710980876, 488.27978731370945, 488.79226328810114, 489.13667377079486, 4270.807813648394, 4298.376735373354, 4303.053328267839, 4309.633681137138, 4318.244307246219, 10969.50637221311, 11328.71678208035, 11385.601503947322, 11388.715282117848, 11403.657890263305, 10183.490825458846, 10638.893611063944, 10647.0, 11383.146264030065, 11389.715257118638, 8243.917560824435, 8438.873416898752, 8439.071702112762, 8440.535770532557, 8446.450980686235, 5795.217645617788, 5950.880982380241, 5965.850853728692, 6136.846578835565, 6279.96860015697, 10051.49742512886, 10125.59497620087, 10443.216758743276, 10455.372677639367, 10767.946160269148, 10710.946445267724, 10740.0, 10796.784064318826, 10855.945720271664, 10865.619703310345, 7419.07261592301, 7614.543127412373, 7736.961315193388, 7923.0, 8083.151269116658, 8910.777230569029, 8911.06433824465, 8934.910650893407, 8961.23829474502, 8981.55092245372, 7913.881291780513, 7988.161243069394, 8109.594520273845, 8147.470414423044, 8277.296429803293, 7855.253750893656, 7897.24976127267, 7962.6814927404575, 8005.479643823133, 8009.639566219651, 6914.688839002358, 7128.251533588898, 7142.428605711427, 7169.7132114716915, 7190.856182876418, 4969.130402179532, 5208.062548741112, 5283.815066472809, 5296.390915044819, 5467.20725494809, 5341.572674186134, 5364.6512976656395, 5399.244105825109, 5418.945810542002, 5529.778808847762], "value": 4628.960285280913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.6480061539989, 326.0381873473254, 331.1935437210392, 334.8359303941068, 335.99160020999454, 5188.48115188481, 5235.397929238139, 5246.7901283948595, 5247.658902171361, 5272.181097521358, 4907.460179380265, 4981.476944920785, 5147.253648221005, 5165.328507294046, 5222.0, 4080.1839632073556, 4082.7142100053006, 4092.9795351023276, 4099.487564054493, 4103.753774773523, 4098.672106231495, 4123.773192474413, 4126.773027483488, 4132.499837598255, 4136.21411931732, 3843.1737176507045, 3912.4522566840665, 4075.205334959684, 4080.367543030835, 4108.424820525129, 4043.0, 4080.775557344345, 4087.4686290782306, 4096.487939007609, 4103.4870641169855, 3665.486831843544, 3665.5601327840563, 3673.6142705015855, 3676.6212670248656, 3696.796676182809, 4969.602431805447, 5007.874803129915, 5054.306807219586, 5143.665661732013, 5151.6908985461, 4683.0, 4684.0, 4701.95298047022, 4704.9059018819435, 4716.457607375161, 5426.158945363435, 5435.592330575223, 5436.755346009439, 5439.422567455433, 5445.37378201504, 3827.483289755903, 4009.9975006248437, 4035.0921042765435, 4042.413849991735, 4054.6756259499466, 5603.8879222415735, 5635.380108188096, 5639.661620302754, 5646.774129034834, 5661.801836935688, 4149.937750933738, 4157.708960372805, 4164.646005089541, 4186.162767446462, 4196.454460920061, 4027.4764280643913, 4242.830286788494, 4244.129953359554, 4247.150569885974, 4248.723832950848, 4694.976525117421, 4703.341532185496, 4707.8587642370785, 4732.73969931657, 4750.812296925768, 5479.643823151482, 5481.835544933659, 5495.1865884258095, 5505.284313039359, 5518.44815518453, 1381.4803715912417, 1434.2971943747489, 1457.6865973815682, 1458.5259790568107, 1476.7489526780473, 935.8970513243538, 973.5035132082688, 980.7302991677345, 986.4278718343344, 987.2250283527396, 4477.3731677565165, 4708.822794301424, 4733.976330118397, 4779.1636463619425, 4796.880077998008, 4902.583280421133, 4947.975260123676, 4948.851534453972, 4974.552290293891, 4979.979104283613, 4684.5549672781035, 4698.694584851974, 4705.976470117696, 4752.669252609275, 4769.904601907942, 2432.5499782540287, 2628.8948442062488, 2654.2568080937367, 2673.919782406531, 2692.680586512595, 5031.396232452056, 5068.391792984866, 5083.262926875656, 5120.667156634807, 5127.666911555308, 5011.396353167024, 5032.597392208614, 5036.84889453317, 5037.5642941761425, 5038.455579932111, 4866.294387313819, 4993.051320249141, 5047.258695749961, 5075.949240507548, 5079.0, 4922.950770492249, 4928.236123400879, 4937.975310123426, 4951.900961980668, 4955.776990035385, 4839.274108883696, 4854.101991131652, 4865.416150062015, 4870.391201099863, 4943.110240156806, 4716.882077948078, 4945.554900059012, 5001.924971125509, 5040.546350828443, 5109.233614957786, 3786.4320351947426, 3791.563970143469, 3799.297130030953, 3806.942895856509, 3816.7137464690813, 4970.900581988268, 5364.678119312854, 5412.566994640498, 5489.094299440548, 5518.668879867221, 4928.827491037797, 5421.9186712200135, 5454.699991500505, 5476.644018138968, 5477.561795056466, 5423.810166644149, 5424.7558859850615, 5434.891302174014, 5435.732949634518, 5439.836804895859, 5238.476152384731, 5289.175234544076, 5297.17893726473, 5373.247745315737, 5385.8922821542565, 5197.220416937338, 5471.781128754806, 5510.090835012178, 5540.612157149122, 5544.7227638618715, 5426.755795989111, 5428.430014848384, 5430.755615997211, 5466.453354664502, 5502.504774570148], "value": 4040.70855263096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.7619961612282, 745.701719312275, 767.5164646272847, 773.1611201845997, 833.7373727275908, 15749.0, 17571.648567028653, 17580.120993950284, 17595.64808703825, 17647.20587573559, 15745.527634170992, 15813.84186158138, 15837.524874253791, 15963.281652325644, 15968.520944371658, 636.9235691717, 770.9498882572643, 801.6432687454085, 817.9672813087499, 838.5723281126639, 826.7023871406288, 837.4723923927917, 837.4807619276057, 837.5519097282955, 838.0111468467206, 873.166126349338, 877.5305211711735, 877.9517126558069, 878.1438097854605, 882.660175832306, 706.0644645844226, 851.9318454523623, 872.746903398017, 873.3362644390246, 873.8907636545368, 633.1926793338484, 633.5343522510951, 634.5431289471619, 634.6985182038541, 634.723895105626, 15231.0, 15249.695006099815, 15281.465148719853, 15340.386384544716, 15353.616159595987, 14682.412703491847, 14830.292426893277, 15050.247487625684, 15145.469908553257, 15165.0, 12311.138200504489, 12494.312812795293, 12593.244405335709, 13218.272994985273, 13255.602331930058, 4426.55734426558, 4548.249538826123, 4582.747948862811, 4749.335093086971, 4750.12122757291, 80464.0, 83174.58412707898, 83254.58372708097, 83466.0, 83734.0, 11414.258073225214, 11608.709782255512, 11692.0, 11868.821967670492, 11969.700757480958, 22181.889090554443, 22378.888105559367, 22412.77587224107, 22434.77565224327, 22544.32367028959, 8765.342599305077, 8865.423747456394, 8877.289816814638, 8929.151730585583, 9010.27917766577, 4912.582430493377, 4956.638158420639, 5052.418971818214, 5092.26162206478, 5139.074966506065, 3287.342531493711, 3459.7578169528397, 3460.5501284832812, 3467.5665541807275, 3472.062543113396, 591.3317950715664, 598.2163365990566, 598.5660396212797, 599.1073300781891, 601.8826328865916, 546.3907742866675, 630.4483576870239, 661.7187695229508, 667.829703425633, 684.7192651013061, 8928.464292142493, 9698.224142068617, 9883.308168428284, 10059.597616095421, 10179.592816287413, 598.470353736946, 610.1732152932801, 627.6234259444296, 654.6366766444669, 687.3229868579446, 4924.236743304794, 5302.840914772563, 5305.469453054741, 5414.137409875823, 5448.318960129984, 69970.30029699739, 93186.0, 94082.0, 105190.47404762928, 124183.0, 100576.0, 101546.98453015376, 102626.0, 103021.0, 104207.4789626047, 93156.53421732847, 93619.0, 95097.5735363984, 95687.0, 95757.52121239349, 10332.0, 10360.481975901326, 10360.689179324632, 10515.789684206426, 10575.576976920836, 52186.47813521816, 52215.0, 53206.0, 53367.46632533625, 55613.721931390086, 76732.61633691796, 78561.0, 81364.0, 82545.0, 83569.58215208886, 13832.654183645087, 13863.168209907439, 13955.302234888011, 14198.787018194942, 14671.0, 15529.84470155284, 16152.757708634615, 16225.675486489969, 16317.67364652724, 17067.829321706624, 14174.929125354307, 14423.754655202496, 14955.700885982002, 15081.719564493642, 15245.390184392943, 14166.575002749934, 14289.857101428852, 14446.855531444551, 14468.565943021726, 14785.334659940543, 14309.713805723619, 14649.340779664728, 14690.0, 14939.626509337353, 14981.250937453302, 11851.881481185077, 12090.818637720266, 12224.266544007032, 12276.140670153003, 12696.238225706487, 11936.58221962227, 12216.711595649214, 12473.688157796129, 12476.688082798002, 12636.818396754757], "value": 7851.182615793271, "unit": "score"}], "name": "dromaeo_css", "value": 7211.618087835911, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 110.0, 111.0, 113.0, 113.0, 118.0, 112.0, 113.0, 110.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 147.0, 187.0, 121.0, 142.0, 151.0, 120.0, 177.0, 121.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 162.0, 75.0, 79.0, 75.0, 76.0, 162.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 153.0, 85.0, 86.0, 86.0, 136.0, 85.0, 85.0, 158.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 53.0, 56.0, 54.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 61.0, 63.0, 62.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 77.0, 78.0, 82.0, 78.0, 78.0, 78.0, 79.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 122.0, 122.0, 121.0, 124.0, 126.0, 124.0, 146.0, 135.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 161.0, 162.0, 165.0, 163.0, 165.0, 163.0, 168.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 65.0, 64.0, 66.0, 69.0, 64.0, 68.0, 64.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1521.0, "alertThreshold": 2.0}]} 04:25:30 INFO - Return code: 0 04:25:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:25:30 INFO - # TBPL SUCCESS # 04:25:30 INFO - Running post-action listener: _resource_record_post_action 04:25:30 INFO - [mozharness: 2016-08-23 11:25:30.299659Z] Finished run-tests step (success) 04:25:30 INFO - Running post-run listener: _resource_record_post_run 04:25:30 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 774144; Write bytes: 407662592; Read time: 552; Write time: 436708 04:25:30 INFO - TinderboxPrint: CPU usage
13.4% 04:25:30 INFO - TinderboxPrint: I/O read bytes / time
774,144 / 552 04:25:30 INFO - TinderboxPrint: I/O write bytes / time
407,662,592 / 436,708 04:25:30 INFO - TinderboxPrint: CPU idle
8,279.6 (86.6%) 04:25:30 INFO - TinderboxPrint: CPU user
1,208.4 (12.6%) 04:25:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:25:30 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 32768; Write bytes: 118386688; Read time: 176; Write time: 113984 04:25:30 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 737280; Write bytes: 289271808; Read time: 376; Write time: 322724 04:25:30 INFO - Running post-run listener: _upload_blobber_files 04:25:30 INFO - Blob upload gear active. 04:25:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:25:30 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 04:25:30 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'] 04:25:30 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 04:25:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:35 INFO - (blobuploader) - INFO - Done attempting. 04:25:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:25:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:35 INFO - (blobuploader) - INFO - Done attempting. 04:25:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:25:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:36 INFO - (blobuploader) - INFO - Done attempting. 04:25:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:25:36 INFO - Return code: 0 04:25:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:25:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:25:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9584fec43426bbf306ed5c3bfd788285c3d3a8b8837f1a878ca6e3d815d297d40e3f4c773ef745cc7d6efb168d540a4e27fc6d6d20070e0c2e3a860b695763c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4966eebc4a00926eeb8b51e2bea021d77decf0039ff6cb8a41a720acdc46cba8c00071d93c9052b6c113e9c131cf04fcc47c8592204b3350e194a89f80be6dab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5600444b30a4e27f1aeb86b1b95a98f7db80c542efbad13bdca647d465ada46ed61c79f79489e99de50454dbbf8dfb936a53955e134884bfa4c9b845aba1e30"} 04:25:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:25:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:25:36 INFO - Contents: 04:25:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9584fec43426bbf306ed5c3bfd788285c3d3a8b8837f1a878ca6e3d815d297d40e3f4c773ef745cc7d6efb168d540a4e27fc6d6d20070e0c2e3a860b695763c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4966eebc4a00926eeb8b51e2bea021d77decf0039ff6cb8a41a720acdc46cba8c00071d93c9052b6c113e9c131cf04fcc47c8592204b3350e194a89f80be6dab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5600444b30a4e27f1aeb86b1b95a98f7db80c542efbad13bdca647d465ada46ed61c79f79489e99de50454dbbf8dfb936a53955e134884bfa4c9b845aba1e30"} 04:25:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:25:36 INFO - Copying logs to upload dir... 04:25:36 INFO - mkdir: /builds/slave/test/build/upload/logs 04:25:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.402411 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-23 04:25:36.552931) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 04:25:36.556373) ========= 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-1471948949.755928-1059864580 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/9584fec43426bbf306ed5c3bfd788285c3d3a8b8837f1a878ca6e3d815d297d40e3f4c773ef745cc7d6efb168d540a4e27fc6d6d20070e0c2e3a860b695763c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4966eebc4a00926eeb8b51e2bea021d77decf0039ff6cb8a41a720acdc46cba8c00071d93c9052b6c113e9c131cf04fcc47c8592204b3350e194a89f80be6dab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5600444b30a4e27f1aeb86b1b95a98f7db80c542efbad13bdca647d465ada46ed61c79f79489e99de50454dbbf8dfb936a53955e134884bfa4c9b845aba1e30"} build_url:https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/BoU549FzQmKJv0ONbHyTlQ/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/9584fec43426bbf306ed5c3bfd788285c3d3a8b8837f1a878ca6e3d815d297d40e3f4c773ef745cc7d6efb168d540a4e27fc6d6d20070e0c2e3a860b695763c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4966eebc4a00926eeb8b51e2bea021d77decf0039ff6cb8a41a720acdc46cba8c00071d93c9052b6c113e9c131cf04fcc47c8592204b3350e194a89f80be6dab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5600444b30a4e27f1aeb86b1b95a98f7db80c542efbad13bdca647d465ada46ed61c79f79489e99de50454dbbf8dfb936a53955e134884bfa4c9b845aba1e30"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 04:25:36.581023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:25:36.581321) ========= 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-1471948949.755928-1059864580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 04:25:36.664371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 04:25:36.664676) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 04:25:36.664942) ========= ========= Total master_lag: 0.18 =========