builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1470881524.24 results: success (0) buildid: 20160810171422 builduid: c4ac5f5cc280400ab411f15a960b6741 revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.236515) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.237005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.237288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.303741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.304050) ========= 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=62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 19:12:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-08-10 19:12:04 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174720 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.519515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.519858) ========= 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=62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.065669 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.598830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:04.599173) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a79e57209adab8f38ca9ea9da8317bf748235a --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 c4a79e57209adab8f38ca9ea9da8317bf748235a --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=62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 19:12:04,681 truncating revision to first 12 chars 2016-08-10 19:12:04,682 Setting DEBUG logging. 2016-08-10 19:12:04,682 attempt 1/10 2016-08-10 19:12:04,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a79e57209a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 19:12:04,978 unpacking tar archive at: fx-team-c4a79e57209a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:05.271103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:05.271440) ========= script_repo_revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:05.271835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:05.272105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 19:12:05.287173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-10 19:12:05.287571) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:12:05 INFO - MultiFileLogger online at 20160810 19:12:05 in /builds/slave/test 19:12:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:12:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:12:05 INFO - {'append_to_log': False, 19:12:05 INFO - 'base_work_dir': '/builds/slave/test', 19:12:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:12:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:12:05 INFO - 'branch': 'Fx-Team-Non-PGO', 19:12:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:12:05 INFO - 'config_files': ('talos/linux_config.py',), 19:12:05 INFO - 'default_actions': ('clobber', 19:12:05 INFO - 'read-buildbot-config', 19:12:05 INFO - 'download-and-extract', 19:12:05 INFO - 'populate-webroot', 19:12:05 INFO - 'create-virtualenv', 19:12:05 INFO - 'install', 19:12:05 INFO - 'run-tests'), 19:12:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:12:05 INFO - 'download_minidump_stackwalk': True, 19:12:05 INFO - 'download_symbols': 'ondemand', 19:12:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:12:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:12:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:12:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:12:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:12:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:12:05 INFO - 'installer_path': 'installer.exe', 19:12:05 INFO - 'log_level': 'info', 19:12:05 INFO - 'log_name': 'talos', 19:12:05 INFO - 'log_to_console': True, 19:12:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:12:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:12:05 INFO - 'opt_config_files': (), 19:12:05 INFO - 'pip_index': False, 19:12:05 INFO - 'sps_profile': False, 19:12:05 INFO - 'sps_profile_interval': 0, 19:12:05 INFO - 'suite': 'dromaeojs-e10s', 19:12:05 INFO - 'system_bits': '32', 19:12:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:12:05 INFO - 'title': 'talos-linux64-ix-018', 19:12:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:12:05 INFO - 'use_talos_json': True, 19:12:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:12:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:12:05 INFO - 'work_dir': 'build'} 19:12:05 INFO - [mozharness: 2016-08-11 02:12:05.562692Z] Running clobber step. 19:12:05 INFO - Running pre-action listener: _resource_record_pre_action 19:12:05 INFO - Running main action method: clobber 19:12:05 INFO - rmtree: /builds/slave/test/build 19:12:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:09 INFO - Running post-action listener: _resource_record_post_action 19:12:09 INFO - [mozharness: 2016-08-11 02:12:09.973096Z] Finished clobber step (success) 19:12:09 INFO - [mozharness: 2016-08-11 02:12:09.973196Z] Running read-buildbot-config step. 19:12:09 INFO - Running pre-action listener: _resource_record_pre_action 19:12:09 INFO - Running main action method: read_buildbot_config 19:12:09 INFO - Using buildbot properties: 19:12:09 INFO - { 19:12:09 INFO - "project": "", 19:12:09 INFO - "product": "firefox", 19:12:09 INFO - "script_repo_revision": "production", 19:12:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:12:09 INFO - "repository": "", 19:12:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:12:09 INFO - "buildid": "20160810171422", 19:12:09 INFO - "pgo_build": "False", 19:12:09 INFO - "basedir": "/builds/slave/test", 19:12:09 INFO - "buildnumber": 1745, 19:12:09 INFO - "slavename": "talos-linux64-ix-018", 19:12:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:12:09 INFO - "platform": "ubuntu64_hw", 19:12:09 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 19:12:09 INFO - "branch": "fx-team", 19:12:09 INFO - "repo_path": "integration/fx-team", 19:12:09 INFO - "revision": "c4a79e57209adab8f38ca9ea9da8317bf748235a", 19:12:09 INFO - "stage_platform": "linux64", 19:12:09 INFO - "builduid": "c4ac5f5cc280400ab411f15a960b6741", 19:12:09 INFO - "slavebuilddir": "test" 19:12:09 INFO - } 19:12:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:12:09 INFO - Running post-action listener: _resource_record_post_action 19:12:09 INFO - [mozharness: 2016-08-11 02:12:09.975644Z] Finished read-buildbot-config step (success) 19:12:09 INFO - [mozharness: 2016-08-11 02:12:09.975733Z] Running download-and-extract step. 19:12:09 INFO - Running pre-action listener: _resource_record_pre_action 19:12:09 INFO - Running main action method: download_and_extract 19:12:09 INFO - mkdir: /builds/slave/test/build/tests 19:12:09 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')]} 19:12:09 INFO - trying https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:12:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:10 INFO - Downloaded 1361 bytes. 19:12:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:12:10 INFO - Using the following test package requirements: 19:12:10 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:10 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:12:10 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:12:10 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'jsshell-linux-x86_64.zip'], 19:12:10 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:12:10 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:10 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:12:10 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:12:10 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:12:10 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:10 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:12:10 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:10 INFO - trying https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:12:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:11 INFO - Downloaded 20262322 bytes. 19:12:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:12:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:12:12 INFO - Return code: 0 19:12:12 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 19:12: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')]} 19:12:12 INFO - trying https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:12:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:14 INFO - Downloaded 20262322 bytes. 19:12:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:12:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:12:16 INFO - Return code: 0 19:12:16 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')]} 19:12:16 INFO - trying https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:12:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:19 INFO - Downloaded 14413719 bytes. 19:12:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:12:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:12:19 INFO - Return code: 0 19:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:19 INFO - trying https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:12:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/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 19:12:20 INFO - Downloaded 55624728 bytes. 19:12:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:12:20 INFO - mkdir: /builds/slave/test/properties 19:12:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:12:20 INFO - Writing to file /builds/slave/test/properties/build_url 19:12:20 INFO - Contents: 19:12:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:12:21 INFO - Running post-action listener: _resource_record_post_action 19:12:21 INFO - Running post-action listener: set_extra_try_arguments 19:12:21 INFO - [mozharness: 2016-08-11 02:12:21.375777Z] Finished download-and-extract step (success) 19:12:21 INFO - [mozharness: 2016-08-11 02:12:21.376010Z] Running populate-webroot step. 19:12:21 INFO - Running pre-action listener: _resource_record_pre_action 19:12:21 INFO - Running main action method: populate_webroot 19:12:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:12:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:12:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:12:21 INFO - '--tppagecycles', 19:12:21 INFO - '7'], 19:12:21 INFO - 'tests': ['tsvgm']}}, 19:12:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:12:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:12:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:12:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:12:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['damp', 'tps']}, 19:12:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'tests': ['damp', 'tps']}, 19:12:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['dromaeo_dom']}, 19:12:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:12:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['basic_compositor_video']}, 19:12:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:12:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['a11yr', 19:12:21 INFO - 'ts_paint', 19:12:21 INFO - 'tpaint', 19:12:21 INFO - 'sessionrestore', 19:12:21 INFO - 'sessionrestore_no_auto_restore', 19:12:21 INFO - 'tabpaint']}, 19:12:21 INFO - 'other-e10s': {'tests': ['a11yr', 19:12:21 INFO - 'ts_paint', 19:12:21 INFO - 'tpaint', 19:12:21 INFO - 'sessionrestore', 19:12:21 INFO - 'sessionrestore_no_auto_restore', 19:12:21 INFO - 'tabpaint']}, 19:12:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:12:21 INFO - 'ts_paint', 19:12:21 INFO - 'tpaint', 19:12:21 INFO - 'sessionrestore', 19:12:21 INFO - 'sessionrestore_no_auto_restore', 19:12:21 INFO - 'tabpaint']}, 19:12:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:12:21 INFO - 'ts_paint', 19:12:21 INFO - 'tpaint', 19:12:21 INFO - 'sessionrestore', 19:12:21 INFO - 'sessionrestore_no_auto_restore', 19:12:21 INFO - 'tabpaint']}, 19:12:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['a11yr', 19:12:21 INFO - 'ts_paint', 19:12:21 INFO - 'tpaint', 19:12:21 INFO - 'sessionrestore', 19:12:21 INFO - 'sessionrestore_no_auto_restore', 19:12:21 INFO - 'tabpaint']}, 19:12:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['a11yr', 19:12:21 INFO - 'ts_paint', 19:12:21 INFO - 'tpaint', 19:12:21 INFO - 'sessionrestore', 19:12:21 INFO - 'sessionrestore_no_auto_restore', 19:12:21 INFO - 'tabpaint']}, 19:12:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['tsvgx', 19:12:21 INFO - 'tsvgr_opacity', 19:12:21 INFO - 'tart', 19:12:21 INFO - 'tscrollx', 19:12:21 INFO - 'cart']}, 19:12:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:12:21 INFO - 'tsvgr_opacity', 19:12:21 INFO - 'tart', 19:12:21 INFO - 'tscrollx', 19:12:21 INFO - 'cart']}, 19:12:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'talos_options': ['--disable-e10s'], 19:12:21 INFO - 'tests': ['tp5o']}, 19:12:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'tests': ['tp5o']}, 19:12:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'talos_options': ['--disable-e10s', 19:12:21 INFO - '--xperf_path', 19:12:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:21 INFO - 'tests': ['tp5n']}, 19:12:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:12:21 INFO - 'talos_options': ['--xperf_path', 19:12:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:21 INFO - 'tests': ['tp5n']}}, 19:12:21 INFO - 'talos.zip': {'path': '', 19:12:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:12:21 INFO - Running post-action listener: _resource_record_post_action 19:12:21 INFO - [mozharness: 2016-08-11 02:12:21.397874Z] Finished populate-webroot step (success) 19:12:21 INFO - [mozharness: 2016-08-11 02:12:21.397961Z] Running create-virtualenv step. 19:12:21 INFO - Running pre-action listener: _resource_record_pre_action 19:12:21 INFO - Running main action method: create_virtualenv 19:12:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:12:21 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 19:12:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:12:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:12:21 INFO - Using real prefix '/usr' 19:12:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:12:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:12:24 INFO - Installing pip.................done. 19:12:24 INFO - Return code: 0 19:12:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:12:24 INFO - Using env: {'DISPLAY': ':0', 19:12:24 INFO - 'HOME': '/home/cltbld', 19:12:24 INFO - 'LANG': 'en_US.UTF-8', 19:12:24 INFO - 'LANGUAGE': 'en_US:en', 19:12:24 INFO - 'LOGNAME': 'cltbld', 19:12:24 INFO - 'MAIL': '/var/mail/cltbld', 19:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:24 INFO - 'MOZ_NO_REMOTE': '1', 19:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:24 INFO - 'NO_EM_RESTART': '1', 19:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:24 INFO - 'PWD': '/builds/slave/test', 19:12:24 INFO - 'SHELL': '/bin/bash', 19:12:24 INFO - 'SHLVL': '1', 19:12:24 INFO - 'TERM': 'linux', 19:12:24 INFO - 'TMOUT': '86400', 19:12:24 INFO - 'USER': 'cltbld', 19:12:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:24 INFO - '_': '/tools/buildbot/bin/python'} 19:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:24 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 19:12:24 INFO - Cleaning up... 19:12:24 INFO - Return code: 0 19:12:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:12:24 INFO - Using env: {'DISPLAY': ':0', 19:12:24 INFO - 'HOME': '/home/cltbld', 19:12:24 INFO - 'LANG': 'en_US.UTF-8', 19:12:24 INFO - 'LANGUAGE': 'en_US:en', 19:12:24 INFO - 'LOGNAME': 'cltbld', 19:12:24 INFO - 'MAIL': '/var/mail/cltbld', 19:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:24 INFO - 'MOZ_NO_REMOTE': '1', 19:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:24 INFO - 'NO_EM_RESTART': '1', 19:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:24 INFO - 'PWD': '/builds/slave/test', 19:12:24 INFO - 'SHELL': '/bin/bash', 19:12:24 INFO - 'SHLVL': '1', 19:12:24 INFO - 'TERM': 'linux', 19:12:24 INFO - 'TMOUT': '86400', 19:12:24 INFO - 'USER': 'cltbld', 19:12:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:24 INFO - '_': '/tools/buildbot/bin/python'} 19:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:25 INFO - Downloading/unpacking psutil>=3.1.1 19:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:12:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:27 INFO - Installing collected packages: psutil 19:12:27 INFO - Running setup.py install for psutil 19:12:27 INFO - building 'psutil._psutil_linux' extension 19:12:27 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 19:12:28 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 19:12:28 INFO - building 'psutil._psutil_posix' extension 19:12:28 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 19:12:28 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 19:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:28 INFO - Successfully installed psutil 19:12:28 INFO - Cleaning up... 19:12:28 INFO - Return code: 0 19:12:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:28 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:28 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 19:12:28 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 19:12:28 INFO - Using env: {'DISPLAY': ':0', 19:12:28 INFO - 'HOME': '/home/cltbld', 19:12:28 INFO - 'LANG': 'en_US.UTF-8', 19:12:28 INFO - 'LANGUAGE': 'en_US:en', 19:12:28 INFO - 'LOGNAME': 'cltbld', 19:12:28 INFO - 'MAIL': '/var/mail/cltbld', 19:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:28 INFO - 'MOZ_NO_REMOTE': '1', 19:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:28 INFO - 'NO_EM_RESTART': '1', 19:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:28 INFO - 'PWD': '/builds/slave/test', 19:12:28 INFO - 'SHELL': '/bin/bash', 19:12:28 INFO - 'SHLVL': '1', 19:12:28 INFO - 'TERM': 'linux', 19:12:28 INFO - 'TMOUT': '86400', 19:12:28 INFO - 'USER': 'cltbld', 19:12:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:28 INFO - '_': '/tools/buildbot/bin/python'} 19:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:12:30 INFO - Installing collected packages: mozsystemmonitor 19:12:30 INFO - Running setup.py install for mozsystemmonitor 19:12:30 INFO - Successfully installed mozsystemmonitor 19:12:30 INFO - Cleaning up... 19:12:30 INFO - Return code: 0 19:12:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12: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')]} 19:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:30 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:30 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 19:12:30 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 19:12:30 INFO - Using env: {'DISPLAY': ':0', 19:12:30 INFO - 'HOME': '/home/cltbld', 19:12:30 INFO - 'LANG': 'en_US.UTF-8', 19:12:30 INFO - 'LANGUAGE': 'en_US:en', 19:12:30 INFO - 'LOGNAME': 'cltbld', 19:12:30 INFO - 'MAIL': '/var/mail/cltbld', 19:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:30 INFO - 'MOZ_NO_REMOTE': '1', 19:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:30 INFO - 'NO_EM_RESTART': '1', 19:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:30 INFO - 'PWD': '/builds/slave/test', 19:12:30 INFO - 'SHELL': '/bin/bash', 19:12:30 INFO - 'SHLVL': '1', 19:12:30 INFO - 'TERM': 'linux', 19:12:30 INFO - 'TMOUT': '86400', 19:12:30 INFO - 'USER': 'cltbld', 19:12:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:30 INFO - '_': '/tools/buildbot/bin/python'} 19:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:12:30 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 19:12:30 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 19:12:30 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 19:12:30 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 19:12:30 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 19:12:30 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 19:12:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:12:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:12:32 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 19:12:32 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 19:12:32 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 19:12:32 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 19:12:32 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 19:12:32 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 19:12:33 INFO - Downloading functools32-3.2.3-2.tar.gz 19:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:12:33 INFO - warning: no files found matching '*.txt' 19:12:33 INFO - no previously-included directories found matching 'build' 19:12:33 INFO - no previously-included directories found matching 'dist' 19:12:33 INFO - no previously-included directories found matching '.git*' 19:12:33 INFO - Installing collected packages: jsonschema, functools32 19:12:33 INFO - Running setup.py install for functools32 19:12:33 INFO - warning: no files found matching '*.txt' 19:12:33 INFO - no previously-included directories found matching 'build' 19:12:33 INFO - no previously-included directories found matching 'dist' 19:12:33 INFO - no previously-included directories found matching '.git*' 19:12:33 INFO - Successfully installed jsonschema functools32 19:12:33 INFO - Cleaning up... 19:12:33 INFO - Return code: 0 19:12:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:33 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 19:12:33 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 19:12:33 INFO - Using env: {'DISPLAY': ':0', 19:12:33 INFO - 'HOME': '/home/cltbld', 19:12:33 INFO - 'LANG': 'en_US.UTF-8', 19:12:33 INFO - 'LANGUAGE': 'en_US:en', 19:12:33 INFO - 'LOGNAME': 'cltbld', 19:12:33 INFO - 'MAIL': '/var/mail/cltbld', 19:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:33 INFO - 'MOZ_NO_REMOTE': '1', 19:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:33 INFO - 'NO_EM_RESTART': '1', 19:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:33 INFO - 'PWD': '/builds/slave/test', 19:12:33 INFO - 'SHELL': '/bin/bash', 19:12:33 INFO - 'SHLVL': '1', 19:12:33 INFO - 'TERM': 'linux', 19:12:33 INFO - 'TMOUT': '86400', 19:12:33 INFO - 'USER': 'cltbld', 19:12:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:33 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:12:33 INFO - Cleaning up... 19:12:33 INFO - Return code: 0 19:12:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:33 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 19:12:33 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 19:12:33 INFO - Using env: {'DISPLAY': ':0', 19:12:33 INFO - 'HOME': '/home/cltbld', 19:12:33 INFO - 'LANG': 'en_US.UTF-8', 19:12:33 INFO - 'LANGUAGE': 'en_US:en', 19:12:33 INFO - 'LOGNAME': 'cltbld', 19:12:33 INFO - 'MAIL': '/var/mail/cltbld', 19:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:33 INFO - 'MOZ_NO_REMOTE': '1', 19:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:33 INFO - 'NO_EM_RESTART': '1', 19:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:33 INFO - 'PWD': '/builds/slave/test', 19:12:33 INFO - 'SHELL': '/bin/bash', 19:12:33 INFO - 'SHLVL': '1', 19:12:33 INFO - 'TERM': 'linux', 19:12:33 INFO - 'TMOUT': '86400', 19:12:33 INFO - 'USER': 'cltbld', 19:12:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:33 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:12:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:12:35 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 19:12:35 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 19:12:35 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 19:12:35 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 19:12:35 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 19:12:35 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 19:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:12:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 INFO - Downloading docopt-0.6.1.tar.gz 19:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 19:12:36 INFO - Running setup.py install for blobuploader 19:12:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:12:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:12:36 INFO - Running setup.py install for requests 19:12:36 INFO - Running setup.py install for docopt 19:12:36 INFO - Successfully installed blobuploader requests docopt 19:12:36 INFO - Cleaning up... 19:12:37 INFO - Return code: 0 19:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:37 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:37 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 19:12:37 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 19:12:37 INFO - Using env: {'DISPLAY': ':0', 19:12:37 INFO - 'HOME': '/home/cltbld', 19:12:37 INFO - 'LANG': 'en_US.UTF-8', 19:12:37 INFO - 'LANGUAGE': 'en_US:en', 19:12:37 INFO - 'LOGNAME': 'cltbld', 19:12:37 INFO - 'MAIL': '/var/mail/cltbld', 19:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:37 INFO - 'MOZ_NO_REMOTE': '1', 19:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:37 INFO - 'NO_EM_RESTART': '1', 19:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:37 INFO - 'PWD': '/builds/slave/test', 19:12:37 INFO - 'SHELL': '/bin/bash', 19:12:37 INFO - 'SHLVL': '1', 19:12:37 INFO - 'TERM': 'linux', 19:12:37 INFO - 'TMOUT': '86400', 19:12:37 INFO - 'USER': 'cltbld', 19:12:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:37 INFO - '_': '/tools/buildbot/bin/python'} 19:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:37 INFO - Running setup.py (path:/tmp/pip-Q59sEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:37 INFO - Running setup.py (path:/tmp/pip-yWJCcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:37 INFO - Running setup.py (path:/tmp/pip-w4UtWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:37 INFO - Running setup.py (path:/tmp/pip-9inIKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:37 INFO - Running setup.py (path:/tmp/pip-jGJwKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:37 INFO - Running setup.py (path:/tmp/pip-U3IlZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:37 INFO - Running setup.py (path:/tmp/pip-OrVIea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:37 INFO - Running setup.py (path:/tmp/pip-cKRTzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:37 INFO - Running setup.py (path:/tmp/pip-xrmfn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:37 INFO - Running setup.py (path:/tmp/pip-vPsu9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:37 INFO - Running setup.py (path:/tmp/pip-imBB4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:38 INFO - Running setup.py (path:/tmp/pip-5EqjyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:38 INFO - Running setup.py (path:/tmp/pip-Aqv4MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:38 INFO - Running setup.py (path:/tmp/pip-c6Uf2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:38 INFO - Running setup.py (path:/tmp/pip-M3QPYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:38 INFO - Running setup.py (path:/tmp/pip-H_fJQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:38 INFO - Running setup.py (path:/tmp/pip-D0o_1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:12:38 INFO - Running setup.py install for manifestparser 19:12:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:12:38 INFO - Running setup.py install for mozcrash 19:12:38 INFO - Running setup.py install for mozdebug 19:12:38 INFO - Running setup.py install for mozdevice 19:12:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:12:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:12:38 INFO - Running setup.py install for mozfile 19:12:38 INFO - Running setup.py install for mozhttpd 19:12:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Running setup.py install for mozinfo 19:12:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Running setup.py install for mozInstall 19:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Running setup.py install for mozleak 19:12:39 INFO - Running setup.py install for mozlog 19:12:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Running setup.py install for moznetwork 19:12:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Running setup.py install for mozprocess 19:12:39 INFO - Running setup.py install for mozprofile 19:12:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Running setup.py install for mozrunner 19:12:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:12:39 INFO - Running setup.py install for mozscreenshot 19:12:40 INFO - Running setup.py install for moztest 19:12:40 INFO - Running setup.py install for mozversion 19:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:12:40 INFO - Cleaning up... 19:12:40 INFO - Return code: 0 19:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:40 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')]} 19:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:40 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')]} 19:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:40 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:40 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 19:12:40 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 19:12:40 INFO - Using env: {'DISPLAY': ':0', 19:12:40 INFO - 'HOME': '/home/cltbld', 19:12:40 INFO - 'LANG': 'en_US.UTF-8', 19:12:40 INFO - 'LANGUAGE': 'en_US:en', 19:12:40 INFO - 'LOGNAME': 'cltbld', 19:12:40 INFO - 'MAIL': '/var/mail/cltbld', 19:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:40 INFO - 'MOZ_NO_REMOTE': '1', 19:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:40 INFO - 'NO_EM_RESTART': '1', 19:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:40 INFO - 'PWD': '/builds/slave/test', 19:12:40 INFO - 'SHELL': '/bin/bash', 19:12:40 INFO - 'SHLVL': '1', 19:12:40 INFO - 'TERM': 'linux', 19:12:40 INFO - 'TMOUT': '86400', 19:12:40 INFO - 'USER': 'cltbld', 19:12:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:40 INFO - '_': '/tools/buildbot/bin/python'} 19:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:40 INFO - Running setup.py (path:/tmp/pip-svshdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:40 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)) 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:40 INFO - Running setup.py (path:/tmp/pip-6bqje_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:40 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)) 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:40 INFO - Running setup.py (path:/tmp/pip-a0T79U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:40 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)) 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:40 INFO - Running setup.py (path:/tmp/pip-QnT6e0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:40 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)) 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:40 INFO - Running setup.py (path:/tmp/pip-4ukijq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:40 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)) 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:40 INFO - Running setup.py (path:/tmp/pip-nUWBsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:40 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)) 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:40 INFO - Running setup.py (path:/tmp/pip-fhVkKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:40 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)) 19:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:40 INFO - Running setup.py (path:/tmp/pip-l4548d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:41 INFO - Running setup.py (path:/tmp/pip-1rXg1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:41 INFO - Running setup.py (path:/tmp/pip-x6y_6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:41 INFO - Running setup.py (path:/tmp/pip-gfqVex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:41 INFO - Running setup.py (path:/tmp/pip-yUwvfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:41 INFO - Running setup.py (path:/tmp/pip-OnG_3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:41 INFO - Running setup.py (path:/tmp/pip-vjTDo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:41 INFO - Running setup.py (path:/tmp/pip-gv0oy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:41 INFO - Running setup.py (path:/tmp/pip-3lve7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:41 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)) 19:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:41 INFO - Running setup.py (path:/tmp/pip-lHmKoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:41 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)) 19:12:41 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)) 19:12:41 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)) 19:12:41 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)) 19:12:41 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)) 19:12:41 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)) 19:12:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12:41 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 19:12:41 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 19:12:41 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 19:12:41 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 19:12:41 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 19:12:41 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 19:12:43 INFO - Downloading blessings-1.6.tar.gz 19:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:12:43 INFO - Installing collected packages: blessings 19:12:43 INFO - Running setup.py install for blessings 19:12:43 INFO - Successfully installed blessings 19:12:43 INFO - Cleaning up... 19:12:43 INFO - Return code: 0 19:12:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:12:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:44 INFO - Reading from file tmpfile_stdout 19:12:44 INFO - Current package versions: 19:12:44 INFO - argparse == 1.2.1 19:12:44 INFO - blessings == 1.6 19:12:44 INFO - blobuploader == 1.2.4 19:12:44 INFO - docopt == 0.6.1 19:12:44 INFO - functools32 == 3.2.3-2 19:12:44 INFO - jsonschema == 2.5.1 19:12:44 INFO - manifestparser == 1.1 19:12:44 INFO - mozInstall == 1.12 19:12:44 INFO - mozcrash == 0.17 19:12:44 INFO - mozdebug == 0.1 19:12:44 INFO - mozdevice == 0.48 19:12:44 INFO - mozfile == 1.2 19:12:44 INFO - mozhttpd == 0.7 19:12:44 INFO - mozinfo == 0.9 19:12:44 INFO - mozleak == 0.1 19:12:44 INFO - mozlog == 3.3 19:12:44 INFO - moznetwork == 0.27 19:12:44 INFO - mozprocess == 0.23 19:12:44 INFO - mozprofile == 0.28 19:12:44 INFO - mozrunner == 6.12 19:12:44 INFO - mozscreenshot == 0.1 19:12:44 INFO - mozsystemmonitor == 0.3 19:12:44 INFO - moztest == 0.7 19:12:44 INFO - mozversion == 1.4 19:12:44 INFO - psutil == 3.1.1 19:12:44 INFO - requests == 1.2.3 19:12:44 INFO - wsgiref == 0.1.2 19:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:44 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')]} 19:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:44 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')]} 19:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:44 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:44 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 19:12:44 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 19:12:44 INFO - Using env: {'DISPLAY': ':0', 19:12:44 INFO - 'HOME': '/home/cltbld', 19:12:44 INFO - 'LANG': 'en_US.UTF-8', 19:12:44 INFO - 'LANGUAGE': 'en_US:en', 19:12:44 INFO - 'LOGNAME': 'cltbld', 19:12:44 INFO - 'MAIL': '/var/mail/cltbld', 19:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:44 INFO - 'MOZ_NO_REMOTE': '1', 19:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:44 INFO - 'NO_EM_RESTART': '1', 19:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:44 INFO - 'PWD': '/builds/slave/test', 19:12:44 INFO - 'SHELL': '/bin/bash', 19:12:44 INFO - 'SHLVL': '1', 19:12:44 INFO - 'TERM': 'linux', 19:12:44 INFO - 'TMOUT': '86400', 19:12:44 INFO - 'USER': 'cltbld', 19:12:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:44 INFO - '_': '/tools/buildbot/bin/python'} 19:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 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)) 19:12:44 INFO - Cleaning up... 19:12:44 INFO - Return code: 0 19:12:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:12:44 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')]} 19:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:44 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')]} 19:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:44 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 0x1695030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, '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': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', '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 19:12:44 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 19:12:44 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 19:12:44 INFO - Using env: {'DISPLAY': ':0', 19:12:44 INFO - 'HOME': '/home/cltbld', 19:12:44 INFO - 'LANG': 'en_US.UTF-8', 19:12:44 INFO - 'LANGUAGE': 'en_US:en', 19:12:44 INFO - 'LOGNAME': 'cltbld', 19:12:44 INFO - 'MAIL': '/var/mail/cltbld', 19:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:44 INFO - 'MOZ_NO_REMOTE': '1', 19:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:44 INFO - 'NO_EM_RESTART': '1', 19:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:44 INFO - 'PWD': '/builds/slave/test', 19:12:44 INFO - 'SHELL': '/bin/bash', 19:12:44 INFO - 'SHLVL': '1', 19:12:44 INFO - 'TERM': 'linux', 19:12:44 INFO - 'TMOUT': '86400', 19:12:44 INFO - 'USER': 'cltbld', 19:12:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:44 INFO - '_': '/tools/buildbot/bin/python'} 19:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:12:44 INFO - Cleaning up... 19:12:44 INFO - Return code: 0 19:12:44 INFO - Running post-action listener: _resource_record_post_action 19:12:44 INFO - Running post-action listener: _start_resource_monitoring 19:12:44 INFO - Starting resource monitoring. 19:12:44 INFO - [mozharness: 2016-08-11 02:12:44.541916Z] Finished create-virtualenv step (success) 19:12:44 INFO - [mozharness: 2016-08-11 02:12:44.542869Z] Running install step. 19:12:44 INFO - Running pre-action listener: _resource_record_pre_action 19:12:44 INFO - Running main action method: install 19:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:44 INFO - Reading from file tmpfile_stdout 19:12:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:44 INFO - Reading from file tmpfile_stdout 19:12:44 INFO - Output received: 19:12:44 INFO - Usage: mozinstall [options] installer 19:12:44 INFO - Options: 19:12:44 INFO - -h, --help show this help message and exit 19:12:44 INFO - -d DEST, --destination=DEST 19:12:44 INFO - Directory to install application into. [default: 19:12:44 INFO - "/builds/slave/test"] 19:12:44 INFO - --app=APP Application being installed. [default: firefox] 19:12:44 INFO - mkdir: /builds/slave/test/build/application 19:12:44 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'] 19:12:44 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 19:13:00 INFO - Reading from file tmpfile_stdout 19:13:00 INFO - Output received: 19:13:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:13:00 INFO - Running post-action listener: _resource_record_post_action 19:13:00 INFO - [mozharness: 2016-08-11 02:13:00.881290Z] Finished install step (success) 19:13:00 INFO - [mozharness: 2016-08-11 02:13:00.881579Z] Running run-tests step. 19:13:00 INFO - Running pre-action listener: _resource_record_pre_action 19:13:00 INFO - Running main action method: run_tests 19:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:13:00 INFO - Python 2.7.3 19:13:00 INFO - Return code: 0 19:13:00 INFO - grabbing minidump binary from tooltool 19:13:00 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')]} 19:13:00 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 0x1953570>, '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 0x1954470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1954900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:13:00 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 19:13:00 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 19:13:00 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 19:13:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:13:01 INFO - Return code: 0 19:13:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:13:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:13:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:13:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:13:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:13:01 INFO - Using env: {'DISPLAY': ':0', 19:13:01 INFO - 'HOME': '/home/cltbld', 19:13:01 INFO - 'LANG': 'en_US.UTF-8', 19:13:01 INFO - 'LANGUAGE': 'en_US:en', 19:13:01 INFO - 'LOGNAME': 'cltbld', 19:13:01 INFO - 'MAIL': '/var/mail/cltbld', 19:13:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:13:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:01 INFO - 'MOZ_NO_REMOTE': '1', 19:13:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:01 INFO - 'NO_EM_RESTART': '1', 19:13:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:01 INFO - 'PWD': '/builds/slave/test', 19:13:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:13:01 INFO - 'SHELL': '/bin/bash', 19:13:01 INFO - 'SHLVL': '1', 19:13:01 INFO - 'TERM': 'linux', 19:13:01 INFO - 'TMOUT': '86400', 19:13:01 INFO - 'USER': 'cltbld', 19:13:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015', 19:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:01 INFO - '_': '/tools/buildbot/bin/python'} 19:13:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:13:01 INFO - mozversion application_buildid: 20160810171422 19:13:01 INFO - mozversion application_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 19:13:01 INFO - mozversion application_display_name: Nightly 19:13:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:13:01 INFO - mozversion application_name: Firefox 19:13:01 INFO - mozversion application_remotingname: firefox 19:13:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:13:01 INFO - mozversion application_vendor: Mozilla 19:13:01 INFO - mozversion application_version: 51.0a1 19:13:01 INFO - mozversion platform_buildid: 20160810171422 19:13:01 INFO - mozversion platform_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 19:13:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:13:01 INFO - mozversion platform_version: 51.0a1 19:13:01 INFO - using testdate: 1470881581 19:13:01 INFO - actual date: 1470881581 19:13:01 INFO - starting webserver on 'localhost:52017' 19:13:01 INFO - SUITE-START | Running 2 tests 19:13:01 INFO - TEST-START | dromaeo_css 19:13:01 INFO - operating with platform_type : linux_ 19:13:01 INFO - Initialising browser for dromaeo_css test... 19:13:01 INFO - TEST-INFO | started process 3359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1wlevg/profile http://localhost:52017/getInfo.html) 19:13:08 INFO - PROCESS | 3359 | __metrics Screen width/height:1600/1200 19:13:08 INFO - PROCESS | 3359 | colorDepth:24 19:13:08 INFO - PROCESS | 3359 | Browser inner width/height: 1024/697 19:13:08 INFO - PROCESS | 3359 | __metrics 19:13:08 ERROR - PROCESS | 3359 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:13:09 INFO - TEST-INFO | 3359: exit 0 19:13:09 INFO - Browser initialized. 19:13:09 INFO - Running cycle 1/1 for dromaeo_css test... 19:13:09 INFO - TEST-INFO | started process 3476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1wlevg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:21 INFO - PROCESS | 3476 | RSS: Main: 163971072 19:13:21 INFO - PROCESS | 3476 | 19:14:11 INFO - PROCESS | 3476 | 1470881651399 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] 19:16:24 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:52017/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52017/tests/dromaeo/cssquery-ext.html) 19:16:25 INFO - PROCESS | 3476 | RSS: Main: 166424576 19:16:25 INFO - PROCESS | 3476 | 19:19:27 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:52017/tests/dromaeo/cssquery-ext.html (next: http://localhost:52017/tests/dromaeo/cssquery-jquery.html) 19:19:28 INFO - PROCESS | 3476 | RSS: Main: 166178816 19:19:28 INFO - PROCESS | 3476 | 19:22:30 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:52017/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52017/tests/dromaeo/cssquery-mootools.html) 19:22:30 INFO - PROCESS | 3476 | RSS: Main: 168919040 19:22:30 INFO - PROCESS | 3476 | 19:25:32 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:52017/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52017/tests/dromaeo/cssquery-prototype.html) 19:25:33 INFO - PROCESS | 3476 | RSS: Main: 163581952 19:25:33 INFO - PROCESS | 3476 | 19:28:36 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:52017/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52017/tests/dromaeo/cssquery-yui.html) 19:28:36 INFO - PROCESS | 3476 | RSS: Main: 165609472 19:28:36 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | Cycle 1(1): loaded http://localhost:52017/tests/dromaeo/cssquery-yui.html (next: http://localhost:52017/tests/dromaeo/cssquery-dojo.html) 19:31:39 INFO - PROCESS | 3476 | RSS: Main: 169607168 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | __start_tp_report 19:31:39 INFO - PROCESS | 3476 | _x_x_mozilla_page_load 19:31:39 INFO - PROCESS | 3476 | _x_x_mozilla_page_load_details 19:31:39 INFO - PROCESS | 3476 | |i|pagename|runs| 19:31:39 INFO - PROCESS | 3476 | |0;dojo.html;2698.8245764025337;2714.8099633025695;2734.3710946482315;2737.5893615957602;2752.215618548714;4741.170295198343;4942.036302920932;4947.505249475055;4990.326305948696;5007.248912663103;4804.951950480494;4850.757462126897;4872.147374209508;4879.316895634614;4880.365552478182;4445.466544014715;4495.100979804036;4549.385832912564;4571.3600095986585;4601.470830854444;4497.370368148446;4522.977385113087;4538.568835960578;4564.748938808364;4595.58639722425;493.0021881490081;4417.3815665806815;4581.1753884300815;4596;4603.838865639704;4408.250597398418;4416.55834416559;4507.842225522124;4523.796429160696;4524.9321260180795;4435.911281774346;4448.1770872388715;4458.420405347317;4464;4490.236659767847;4824.035192961422;4829.613630909519;4831.1062453445875;4834.806607735686;4836.177849765549;5223.138182199932;5278.577713782888;5280.419153893069;5300.522952934216;5330.147176451749;5288.550473209743;5290.656107353048;5317.494837990384;5318.282031925679;5341.03861304965;4665.113628410591;4909.877253068702;4932.482089380635;4961.5286547777905;4964.255361695702;5415.512603865671;5439.156930675752;5450.672959622356;5473.31583552056;5504.284443022381;5211.114110601206;5220.634555581073;5221.947780522222;5222.451642577551;5271.736413179326;5021.397432308147;5222.190560463135;5226.555742761831;5308.575313974873;5309.33633295838;5230.058589453859;5260.263563101169;5260.92108618371;5306.628536002443;5306.62853600252;5228.346456692913;5242.816501422432;5257.290265814143;5266.34170728659;5303.920441193385;4250.128723611652;4361.367601697736;4397.868063958086;4412.2499175139665;4419.425474688334;3854.2291541691775;3858.961410385916;3888.3972984187494;3901.453796468497;3907.199024200032;4474.977814559616;4565.041341318294;4570.3829982951875;4576.702514336557;4614.884627884263;5053.46938571452;5233.39815921174;5253.711045892513;5291.1798671206025;5362.383325917569;4553.362529245908;4570.565796249351;4596.954030459719;4612.5156858530045;4613;4691.132140554008;4697.412823397075;4698.835540756126;4705.929411058837;4729.290606409066;4739.834105806281;4905.779239934212;4922.360093187863;4945.233488809312;4973.428055773632;5289.18017707256;5309.946900530946;5310.628256022196;5346.599005074713;5352.732363381738;4965.776540055634;4990.625703072212;4997.800087996439;5000.67495612784;5042.672226305279;4904.779284932258;5135.075686376488;5197.376314842243;5216;5242.135047717084;5284.656497327662;5291.206319052173;5307.256984022317;5340.626156169031;5343.572514198932;5090.974545127251;5127.179651255781;5133.794648214179;5136.845894623168;5160;4880.438749543848;5058.31712718793;5065.493450654905;5124.077666020152;5132.461091585479;5009.223570346602;5028;5033.094043072282;5061.493850614909;5073.568746656428;5124.6412751108555;5152.716600586854;5167.560757335668;5169;5222.033923724123;4787.186178349759;4991.351124353956;5034.647574669738;5043.344365232496;5051.722155281494 19:31:39 INFO - PROCESS | 3476 | |1;ext.html;556.1546449396915;556.6826908662063;569.1832220763205;576.0380165124241;593.7713980117653;34902.47646285305;38276.80861595695;38290.23419531611;38357;38545.61454385462;38212.23575528488;38669.99999999993;38672.61327386725;38680;38809.22381552374;7660.885086723718;7765.339946104588;7804.882926756103;7810.258025487598;7830.882536761953;7747.573883436408;7788.299053085221;7792.727254546092;7815.765527034198;7826.569538675399;7857.449978501507;7864.960675196616;7879.3302569281395;7880.960595197016;7934.7222847200355;7805.219478052178;7815.140334563193;7823.882641760378;7824.139344672081;7846.568438735867;7716.498427602188;7804.531728096275;7811.804704882366;7825.765227043141;7845.137034926153;37092.847107995854;37200.62799371999;37448.81275593632;37483.625163748286;37511.43732844009;2430.90276388946;2641.590553464216;3083.367909578531;3166.3508980658908;3232.563603913465;27721.86139069312;27788.30529236765;28081;28343.291417714518;29131.563026554617;3211.132994091582;3230.854611542486;3302.554155189043;3339.1985923378456;3379.5437615921783;225705;228160;228476;228970;229695;31578.36843263168;31923.201919952186;32046.198845028593;32046.67953320437;32121.51817722736;31365.52951705726;33316;33459;33650.663493365246;33663.82176623806;13428.060035797596;13512.932435337956;13520.729585408433;13539.729205416033;13570.932145339408;11117.110631149488;11146;11202.831957520644;11219.439028048564;11236.438178091063;7753.875688025205;7763.301302882654;7766.145723970359;7812.960935195288;7903.881441778378;3089.274020605156;3092.721655051056;3092.876284948622;3099.8450077496036;3149.811011339327;844.5692696724715;907.3915220873027;938.8826396700413;946.1673727120091;992.4591097851688;26793.732062679515;26944.461110777676;27198;27419.17742467729;27522.311942201206;965.946872921996;982.2633025231077;991.7421470417744;1046.8063408269495;1088.2708585247904;14569.635759105895;14754;15200.391984320724;15416.691666166615;15427;388572;391105;391843;394192;394200;48509.5149048505;48917.755411222715;49093;49240.52278431653;49268.75365623149;1121.1087185687397;1159.5072094359864;1168.6435637130758;1191.2316555821446;1191.803352446854;25408;27211.72788272092;27915.302117447227;28074.719252808027;28347.858260708563;42489.36265956075;42656.78671606622;42832.78583607062;42835.143297134506;42872.35691464568;306365;306655;307425;308978;310247;25059.87470062638;25361.49277014486;25670.87164564165;25680.486390272465;25719.742802571735;38672.22655546929;41642.58357416387;42282.36576451294;42832.57167428286;43274.567254327056;36010.819945900104;36368.27263454769;36398.454023189144;37271.068223294635;37457.43813842849;34144.65855341415;36591.08522286964;36808.631913681595;36839.263214735016;36850.63149368579;35873.28253434865;36395.45406818847;36588.81705591455;36939.26121477609;37068.629313706515;31225.8438707805;33439;33532.48506361984;33634.49548256729;33770;25546.872265638554;25597.87201063983;25729.613946708094;25834.87082564575;26188.8690556546 19:31:39 INFO - PROCESS | 3476 | |2;jquery.html;356.5845789655052;358.6216541548665;360.5979333043657;375.5437143870197;376.69299520890473;15923.68152636948;17113.743293850588;17707.1146442678;17877.374291899785;17907.91046044771;16692.83307166928;16996.150192490357;17256;17564.297428102862;17610.735838962424;5141.82003629873;5357.08929481989;5363.329583802025;5364.7317634118135;5365.624406291561;3673.871414500493;5278.313819203518;5917.792877249297;6193.473554747852;6250.218722659668;6213.7514499420195;6284.402981716752;6290.64751078518;6300.495960323186;6314.336994615545;6072.301685306202;6193.938060619404;6196;6223.595466294676;6226.128342032096;4464.575865292792;4751.1922973094315;5413.431589683105;5422.728863556807;5425.565954723652;11769.293842369485;11933.462994165284;12010.339431331273;12050.337231452266;15580.454684086002;1817.690992531273;1825.069214700499;1866.75732154819;1871.391797665764;1906.9892956732954;8748.256398206096;8881.600327985256;8977.236934860544;9271.490068046254;13161.144525605805;1680.7226807576735;1698.4819630012842;1731.8874273172203;1749.3614830586744;1760.3926645307477;68567.31432685709;68677.65661171712;69399;69703;70053.99999999949;9822.165115965223;9894.208463322917;10084.294099412971;10149.579058931755;10308.278420510493;13782.724345513034;13822.792658110136;13868.029237953246;13868.167909925436;13883.37524811386;6833.350831670983;7097.89353159703;7260.854782904313;7448.292412220831;7452.441066920002;6551.967240163769;6603.70283337251;6812;7058.223595404502;7082.575045497287;4108.77401742901;4219.198352313051;4228.788560571959;4270.893227669271;4420.226460369422;1633.616100216448;1668.8247733987998;1706.1554530507478;1733.679269335177;1787.2493552707895;798.2616080125861;887.2458410351279;901.4185850126631;959.2565761534867;980.3186785184229;16660.41688540895;17421.912890435466;17639.382621608183;17775.46673599794;17829.46511604654;859.2266959736287;879.336101243557;882.8322618702426;897.0804924951846;944.0983860413289;9588;9647.517624118766;10034.548445319979;10116.59533618647;10157.542910569042;373918;387201;387405;389473;391102;74446.25553744502;74657.25342746612;74720;76270.61864690641;77737.222627773;901.4140808474544;901.4501154295874;907.7503686486269;909.5815924674723;917.064594114;15100.546983590071;15245.542633721006;15875.682486350439;15944.282507286967;16220.67558648844;36658.45012324764;37292.627073728916;37556.81221593874;37816.43275350927;37840.24319513649;47189.29216061693;50382;50975.23537146871;51753.7412312936;51849.48150518446;7531.246875312425;7680.270374314431;7745.845083098419;7792.259735325135;7908.604569771604;11993.280403175837;12005.75988480243;12228.816567751668;12329.568465103679;12479.126461147633;10241.590336386462;10369.170466362522;10794.190435717195;10941.23411361197;11134.777304454028;10481.947590262;10512.31669941482;10591;10730.517126729472;11000.559977600806;10519;10549.367037977747;10623.468826558796;10894.727631809268;10906.454677266263;7348.412127029718;7391.704331826667;7593.848123037619;7637.770866874002;7725.806854828675;9738.220942324739;10225.386476811414;10507.684769456928;10689.839652405375;10923.83614245771 19:31:39 INFO - PROCESS | 3476 | |3;mootools.html;1377.407714682686;1410.5063227870244;1483.3695679336279;1660.9003459792407;1699.3372584691965;6603.669816509179;7394.630268486581;7504.962475187624;8113.513189208652;8117.269445749888;7573.204813494586;7871.842563148748;7898.4865983711015;7902.40731945105;7907.762767116996;2039.6532589459791;2067.183462532299;2071.658176400892;2076.6469700150933;2081.157131361801;2137.625915464795;2137.9251726189586;2142.8714277143345;2183.6942828004094;2183.8908054597287;2159;2163.891805409731;2179.7493288271894;2181.3674034529968;2181.7054697615777;2092.06902928197;2096.8532202745814;2102.4743814046487;2104.3160972683786;2104.4002459299104;2032.298856894369;2049.4466494046524;2054.3323419888598;2073.1189244570996;2073.8651987620756;7882.014748156481;7935.880961785578;7947.086085100172;7985.321247693953;7988.360931125554;4430.158269928703;4600;4602.677812553123;4612.884677883047;4622.468416132154;2680.9865950670123;2771.9445611087667;2854.743073123429;2872.2819295176205;2914.650241970956;907.7458311672676;958.7938593202495;961.5480724059681;968.2883080935507;978.9021097890226;10618.734531636694;10680.946595267053;10725.731856703645;10734.57061717538;10763;3745.6816170625257;3834.69322454203;4009.4787677602308;4012.337964235868;4015.578364271768;9217.63129474827;9225.53872306382;9232.353735238603;9233.907660923305;9236.72289831306;4522.66080043998;4551.089782043605;4566.474855391606;4568.451785785727;4569;3532.8056956867104;3980.2636512245326;4081.0613558881028;4170.687198460128;4176.874693759192;3524.9118772030392;3589.964100359015;3629.94555081674;3654.2143439160177;3789;1210.1347536511437;1211.6304527119314;1217.2818037358002;1217.5921066442663;1223.5411720604773;819.0826274572516;821.9917800822035;822.9466283157568;832.0805509911581;832.1969299625769;5067.062593420229;5274.604404669665;5402.513773760302;5423.674579525241;5428.131498960148;927.3925578745932;941.8304705153138;962.0908241711516;963.1043129889271;1001.689476262361;3574.749767516249;3659.213269147146;3669.853205871735;3709.091272638167;3779.829907654162;9580.66467673628;9957.601695932082;9972.750681232883;9978.750531236632;9987.700368988943;9727.07592778685;9791.167750741266;9798.118169364792;9798.608055677692;9867.75330616726;7002.894956575656;7257;7313.963430182922;7356.301151390717;7462.888056679154;5447.863803404946;5590.636608620427;5596.132599447093;5731.856703582277;5759.9136012959;8748.2126608603;8869.600867961086;9047.457152570603;9049.366544341832;9115.316351273548;8901.198892099743;9057.728268151966;9114.36199466031;9175.31185161129;9216.769580760534;5942.851428714317;6545.738170473128;6723.462123030244;6906.516543841883;7023.754168604074;7376.077990251219;7439.8140046499275;7451.739189128354;7460.515066520658;7472.178060413242;6441.454051027813;6592.967035164794;6738.797836064926;6744.291849355944;6951.75668851608;6408.839779005562;6481.8703625928165;6549.901751473636;6596.670166491752;6643.56816806906;6146.78486252979;6216.471599914058;6241.063840423973;6243.7814676486105;6253.749850005949;4564.338170965125;4607.654425918003;4683.391159149289;4693.55411235932;4745.47799742035;4557.977210113928;4593.908121837611;4673.813047478063;4726.36194113804;4791.065742180242 19:31:39 INFO - PROCESS | 3476 | |4;prototype.html;282.66159733661124;287.46674918027065;298.3674609827167;299.25784055542255;302.84857571214394;4898.657094003421;4987.975060124703;5100.285959965608;5164.6384753067305;5177.110354720528;5019.2471129330615;5029.044481548503;5033.84898453047;5037.4458809530925;5059.873503162414;3973.602639736018;3996.740211886233;3997.3004724173225;4018.7387819791766;4019.437278780973;3920.7843568603857;4010.556199768081;4015.9196816063663;4020.2763502569524;4024.7585144891254;3951.5258169019758;3952.7351247600777;3958.148997965437;3964.9801750991205;3969.523657161145;3979.3235150024566;3980.462637543938;3982.4623675803687;3984.7409918355215;3989.98005009976;3507.719382449398;3521.436570148764;3521.7358698097746;3525.5416795816636;3526.5239192708914;4852.247901575226;4909.705417674915;4919.99140176263;4920.261960705887;5023.547880690755;4475.77621118946;4476.507584165739;4480.283154695266;4483.237849565582;4506.752128632957;5286.365636123652;5308.389535203424;5311.336082989626;5323.254744335796;5345.305110335631;3708.647678470568;3791.298609757176;3794.4877441545314;3809.8666546670734;3811.6760075393627;5516.172574113875;5528.723563821833;5535.58483113768;5553.333599967989;5596.944030559683;3876.5348158221195;3912.315344814703;3918;3927.9410808837893;3931.8427262909163;3758.267137908136;3880.8447662093763;3976.5029371328583;3981.7610943343493;3988.5213774346685;4406.845760398371;4411.382406463098;4421.889452763707;4431.4903786065015;4454.1982443159895;5331.747039445727;5332.813351532678;5369.221462887859;5401.405845357008;5413.188021796684;1281.6347341007768;1283.8445399140662;1309.6398490415213;1316.1445060710614;1335.2188969452784;871.2855458524076;917.0874979395544;927.248928368024;945.4894357047255;952.2477242977969;4590.291727880566;4620.768961551909;4626.537346265347;4627.167109920179;4642.883927901829;5390.865228369322;5390.9191362129595;5408.457460363468;5410.83767486976;5411.756470958816;4472.396226509444;4566.657500687462;4641.187792136363;4652.1626107300335;4652.9294463963215;2511.9246422607353;2513.5978243481322;2527.54504189244;2528.8988440462176;2541.351955251436;4499.370088187591;4501.942043619747;4522.778849710559;4549.817047567656;4555.840545580955;4502.938002158564;4854.320395144682;4866.975665121652;4871.373563534124;4905.828296009622;4432.202203603382;4455.6212721918355;4471.664625153061;4493.662975276868;4501.707389019769;4736.715797052188;4752.5485078917445;4758.571728544448;4765.332133753159;4795.880102997453;4678.953210467988;4681.027547507426;4706.270528068155;4725.432948046257;4729.834455794168;4741.170295198258;5144.254083157846;5154.201098829687;5178.741062946913;5185.9222111669105;3780;3797.0317569020826;3810.714196435334;3832.59757725446;3861.1119442527815;5241.213817927342;5529.668219906818;5557.888842223052;5575.135853942646;5587.357453892854;4986.775595098302;5275.733823882318;5289.259503669567;5325.09473389517;5328.854296326153;5357.01790337562;5362.383325917569;5366.570674345965;5369.3556773187465;5375.381831089318;5042.294078828893;5172.379314482287;5173.3533308336455;5265.473452654704;5314.441983591667;5310.9468905312;5321.5476684482255;5324.547413469899;5346.358436987586;5361.303030605996;5235.528802407802;5236.816711415082;5241.135212689864;5251.789928402821;5253.894922101613 19:31:39 INFO - PROCESS | 3476 | |5;yui.html;626.3016736338982;667.0894229376902;677.3835809413434;685.3454950522251;729.9087614048244;11708.590199343003;13111.623279555652;13746.106503077293;14334.784978225334;14348.426062957482;13324.533641322556;13571.796423053662;13581.253031083286;13585.796213056812;13606.183628982244;623.4918541388777;771.5100910921564;791.3985371117963;792.6789650191681;793.2939683681528;730.0800990751665;773.0452890680034;779.0262172284645;780.2275747010475;784.9175836537167;820.6389188756958;824.0605709491185;827.1356432528023;827.1728271728272;830.7092517618815;812.6993012585322;815.2621877201143;815.5840521334133;815.8816971539123;816.608028146493;605.721368170642;605.7698074731574;605.8848818724472;605.9575829691923;607.4684650930436;12119.575814846527;12151.331676757774;12168;12176.634700958897;12441.253524788543;13032.86967130326;13390.933045334808;13584.456621735118;13592.93203533976;13833.584992450242;10663.786724265472;10687.412192329419;10785.406802625852;10862.837057444145;10985.780284394268;3289.7039266465895;3324.7838890472044;3327.7670563060356;3335.7331413487104;3341.6491268416707;63109.36890631127;64335;64369.356306436806;64606;65303.346966530204;10640.414777187329;10690.465476726133;10691.732706682395;10720.142388608892;10886.07468365182;19636.90181549083;19649.115789789495;19686.606267874562;19775.40673779789;20284.898575507028;6996.845520489062;7108.147022357351;7163.212046674862;7190.316919892602;7216.819579510554;3734.682551983112;3790.3556395412847;3801.923961520754;3821.9531560143246;3855.151866589346;2707.1878436468983;2807.298175456136;2826.5336219523547;2832.0229520815287;2909.6799352071257;533.5210904457061;535.234614501267;540.8026070484245;544.4201924949915;549.4697616799727;540.8938720316961;597.6981624279798;616.9413905678954;620.7392894984117;634.7905191286865;8342.749717508485;8573.657053717907;8670.702263900072;8674.30605551567;8864.20222180007;556.8830545585472;580.89834279001;602.1870474858993;603.8104933281429;608.349066498842;4118.91762164761;4305.74165550068;4346.36977638247;4380.386745855582;4425.424694789721;90747.54626226827;95341.41927226583;95858.52070739602;97687;98439.50780246196;89025;89629.55185224162;89828;90186;90672.5466372664;45194;72893.27106728971;77030.2296977023;77584.61207693926;78880;8045.235702608243;8311.335093192409;8399.41204115706;8446.113158118309;8520.488770673779;47071.529284708085;47987.28019079647;48286.60126166694;48760.75619621879;48780.756096219295;65271;68192.31807682058;69921.65039174771;70833.29166708267;71553.6422317885;10216.131628811634;10239.232057595858;10297.588096476356;10369.688909332732;10533.9473302633;11052.723681908017;11190.720231994264;11196.216264861381;11205.887941120485;11348.375839328915;11198.776024479303;11313.943430282796;11386.715332116431;11451.25566838153;11510;10236.232282578687;10338.844917326096;10439.947800261254;10493.108085812792;10534.157267418435;10780.892191077988;10848.077913377136;10875.456227188768;11043.226974111734;11496.597619083626;8757.211850933192;8787.692430764893;8950.741186790872;9098.59056342453;9218.26253899673;8924;9387.389819661701;9397.342186046912;9414.340996130479;9477.289203309918 19:31:39 INFO - PROCESS | 3476 | __end_tp_report 19:31:39 INFO - PROCESS | 3476 | __start_cc_report 19:31:39 INFO - PROCESS | 3476 | _x_x_mozilla_cycle_collect,378 19:31:39 INFO - PROCESS | 3476 | __end_cc_report 19:31:39 INFO - PROCESS | 3476 | __startTimestamp1470882699836__endTimestamp 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | ------- Summary: start ------- 19:31:39 INFO - PROCESS | 3476 | Number of tests: 6 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | [#0] dojo.html Cycles:165 Average:4830.16 Median:4990.33 stddev:621.59 (12.5%) stddev-sans-first:600.59 19:31:39 INFO - PROCESS | 3476 | Values: 2698.8 2714.8 2734.4 2737.6 2752.2 4741.2 4942.0 4947.5 4990.3 5007.2 4805.0 4850.8 4872.1 4879.3 4880.4 4445.5 4495.1 4549.4 4571.4 4601.5 4497.4 4523.0 4538.6 4564.7 4595.6 493.0 4417.4 4581.2 4596.0 4603.8 4408.3 4416.6 4507.8 4523.8 4524.9 4435.9 4448.2 4458.4 4464.0 4490.2 4824.0 4829.6 4831.1 4834.8 4836.2 5223.1 5278.6 5280.4 5300.5 5330.1 5288.6 5290.7 5317.5 5318.3 5341.0 4665.1 4909.9 4932.5 4961.5 4964.3 5415.5 5439.2 5450.7 5473.3 5504.3 5211.1 5220.6 5221.9 5222.5 5271.7 5021.4 5222.2 5226.6 5308.6 5309.3 5230.1 5260.3 5260.9 5306.6 5306.6 5228.3 5242.8 5257.3 5266.3 5303.9 4250.1 4361.4 4397.9 4412.2 4419.4 3854.2 3859.0 3888.4 3901.5 3907.2 4475.0 4565.0 4570.4 4576.7 4614.9 5053.5 5233.4 5253.7 5291.2 5362.4 4553.4 4570.6 4597.0 4612.5 4613.0 4691.1 4697.4 4698.8 4705.9 4729.3 4739.8 4905.8 4922.4 4945.2 4973.4 5289.2 5309.9 5310.6 5346.6 5352.7 4965.8 4990.6 4997.8 5000.7 5042.7 4904.8 5135.1 5197.4 5216.0 5242.1 5284.7 5291.2 5307.3 5340.6 5343.6 5091.0 5127.2 5133.8 5136.8 5160.0 4880.4 5058.3 5065.5 5124.1 5132.5 5009.2 5028.0 5033.1 5061.5 5073.6 5124.6 5152.7 5167.6 5169.0 5222.0 4787.2 4991.4 5034.6 5043.3 5051.7 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | [#1] ext.html Cycles:180 Average:44905.58 Median:36189.55 stddev:83564.52 (230.9%) stddev-sans-first:83732.60 19:31:39 INFO - PROCESS | 3476 | Values: 556.2 556.7 569.2 576.0 593.8 34902.5 38276.8 38290.2 38357.0 38545.6 38212.2 38670.0 38672.6 38680.0 38809.2 7660.9 7765.3 7804.9 7810.3 7830.9 7747.6 7788.3 7792.7 7815.8 7826.6 7857.4 7865.0 7879.3 7881.0 7934.7 7805.2 7815.1 7823.9 7824.1 7846.6 7716.5 7804.5 7811.8 7825.8 7845.1 37092.8 37200.6 37448.8 37483.6 37511.4 2430.9 2641.6 3083.4 3166.4 3232.6 27721.9 27788.3 28081.0 28343.3 29131.6 3211.1 3230.9 3302.6 3339.2 3379.5 225705.0 228160.0 228476.0 228970.0 229695.0 31578.4 31923.2 32046.2 32046.7 32121.5 31365.5 33316.0 33459.0 33650.7 33663.8 13428.1 13512.9 13520.7 13539.7 13570.9 11117.1 11146.0 11202.8 11219.4 11236.4 7753.9 7763.3 7766.1 7813.0 7903.9 3089.3 3092.7 3092.9 3099.8 3149.8 844.6 907.4 938.9 946.2 992.5 26793.7 26944.5 27198.0 27419.2 27522.3 965.9 982.3 991.7 1046.8 1088.3 14569.6 14754.0 15200.4 15416.7 15427.0 388572.0 391105.0 391843.0 394192.0 394200.0 48509.5 48917.8 49093.0 49240.5 49268.8 1121.1 1159.5 1168.6 1191.2 1191.8 25408.0 27211.7 27915.3 28074.7 28347.9 42489.4 42656.8 42832.8 42835.1 42872.4 306365.0 306655.0 307425.0 308978.0 310247.0 25059.9 25361.5 25670.9 25680.5 25719.7 38672.2 41642.6 42282.4 42832.6 43274.6 36010.8 36368.3 36398.5 37271.1 37457.4 34144.7 36591.1 36808.6 36839.3 36850.6 35873.3 36395.5 36588.8 36939.3 37068.6 31225.8 33439.0 33532.5 33634.5 33770.0 25546.9 25597.9 25729.6 25834.9 26188.9 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | [#2] jquery.html Cycles:180 Average:24095.16 Median:390287.50 stddev:63699.38 (16.3%) stddev-sans-first:63853.14 19:31:39 INFO - PROCESS | 3476 | Values: 356.6 358.6 360.6 375.5 376.7 15923.7 17113.7 17707.1 17877.4 17907.9 16692.8 16996.2 17256.0 17564.3 17610.7 5141.8 5357.1 5363.3 5364.7 5365.6 3673.9 5278.3 5917.8 6193.5 6250.2 6213.8 6284.4 6290.6 6300.5 6314.3 6072.3 6193.9 6196.0 6223.6 6226.1 4464.6 4751.2 5413.4 5422.7 5425.6 11769.3 11933.5 12010.3 12050.3 15580.5 1817.7 1825.1 1866.8 1871.4 1907.0 8748.3 8881.6 8977.2 9271.5 13161.1 1680.7 1698.5 1731.9 1749.4 1760.4 68567.3 68677.7 69399.0 69703.0 70054.0 9822.2 9894.2 10084.3 10149.6 10308.3 13782.7 13822.8 13868.0 13868.2 13883.4 6833.4 7097.9 7260.9 7448.3 7452.4 6552.0 6603.7 6812.0 7058.2 7082.6 4108.8 4219.2 4228.8 4270.9 4420.2 1633.6 1668.8 1706.2 1733.7 1787.2 798.3 887.2 901.4 959.3 980.3 16660.4 17421.9 17639.4 17775.5 17829.5 859.2 879.3 882.8 897.1 944.1 9588.0 9647.5 10034.5 10116.6 10157.5 373918.0 387201.0 387405.0 389473.0 391102.0 74446.3 74657.3 74720.0 76270.6 77737.2 901.4 901.5 907.8 909.6 917.1 15100.5 15245.5 15875.7 15944.3 16220.7 36658.5 37292.6 37556.8 37816.4 37840.2 47189.3 50382.0 50975.2 51753.7 51849.5 7531.2 7680.3 7745.8 7792.3 7908.6 11993.3 12005.8 12228.8 12329.6 12479.1 10241.6 10369.2 10794.2 10941.2 11134.8 10481.9 10512.3 10591.0 10730.5 11000.6 10519.0 10549.4 10623.5 10894.7 10906.5 7348.4 7391.7 7593.8 7637.8 7725.8 9738.2 10225.4 10507.7 10689.8 10923.8 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | [#3] mootools.html Cycles:180 Average:5147.01 Median:5438.00 stddev:2911.40 (53.5%) stddev-sans-first:2905.79 19:31:39 INFO - PROCESS | 3476 | Values: 1377.4 1410.5 1483.4 1660.9 1699.3 6603.7 7394.6 7505.0 8113.5 8117.3 7573.2 7871.8 7898.5 7902.4 7907.8 2039.7 2067.2 2071.7 2076.6 2081.2 2137.6 2137.9 2142.9 2183.7 2183.9 2159.0 2163.9 2179.7 2181.4 2181.7 2092.1 2096.9 2102.5 2104.3 2104.4 2032.3 2049.4 2054.3 2073.1 2073.9 7882.0 7935.9 7947.1 7985.3 7988.4 4430.2 4600.0 4602.7 4612.9 4622.5 2681.0 2771.9 2854.7 2872.3 2914.7 907.7 958.8 961.5 968.3 978.9 10618.7 10680.9 10725.7 10734.6 10763.0 3745.7 3834.7 4009.5 4012.3 4015.6 9217.6 9225.5 9232.4 9233.9 9236.7 4522.7 4551.1 4566.5 4568.5 4569.0 3532.8 3980.3 4081.1 4170.7 4176.9 3524.9 3590.0 3629.9 3654.2 3789.0 1210.1 1211.6 1217.3 1217.6 1223.5 819.1 822.0 822.9 832.1 832.2 5067.1 5274.6 5402.5 5423.7 5428.1 927.4 941.8 962.1 963.1 1001.7 3574.7 3659.2 3669.9 3709.1 3779.8 9580.7 9957.6 9972.8 9978.8 9987.7 9727.1 9791.2 9798.1 9798.6 9867.8 7002.9 7257.0 7314.0 7356.3 7462.9 5447.9 5590.6 5596.1 5731.9 5759.9 8748.2 8869.6 9047.5 9049.4 9115.3 8901.2 9057.7 9114.4 9175.3 9216.8 5942.9 6545.7 6723.5 6906.5 7023.8 7376.1 7439.8 7451.7 7460.5 7472.2 6441.5 6593.0 6738.8 6744.3 6951.8 6408.8 6481.9 6549.9 6596.7 6643.6 6146.8 6216.5 6241.1 6243.8 6253.7 4564.3 4607.7 4683.4 4693.6 4745.5 4558.0 4593.9 4673.8 4726.4 4791.1 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | [#4] prototype.html Cycles:180 Average:4304.12 Median:4665.94 stddev:1247.80 (26.7%) stddev-sans-first:1214.25 19:31:39 INFO - PROCESS | 3476 | Values: 282.7 287.5 298.4 299.3 302.8 4898.7 4988.0 5100.3 5164.6 5177.1 5019.2 5029.0 5033.8 5037.4 5059.9 3973.6 3996.7 3997.3 4018.7 4019.4 3920.8 4010.6 4015.9 4020.3 4024.8 3951.5 3952.7 3958.1 3965.0 3969.5 3979.3 3980.5 3982.5 3984.7 3990.0 3507.7 3521.4 3521.7 3525.5 3526.5 4852.2 4909.7 4920.0 4920.3 5023.5 4475.8 4476.5 4480.3 4483.2 4506.8 5286.4 5308.4 5311.3 5323.3 5345.3 3708.6 3791.3 3794.5 3809.9 3811.7 5516.2 5528.7 5535.6 5553.3 5596.9 3876.5 3912.3 3918.0 3927.9 3931.8 3758.3 3880.8 3976.5 3981.8 3988.5 4406.8 4411.4 4421.9 4431.5 4454.2 5331.7 5332.8 5369.2 5401.4 5413.2 1281.6 1283.8 1309.6 1316.1 1335.2 871.3 917.1 927.2 945.5 952.2 4590.3 4620.8 4626.5 4627.2 4642.9 5390.9 5390.9 5408.5 5410.8 5411.8 4472.4 4566.7 4641.2 4652.2 4652.9 2511.9 2513.6 2527.5 2528.9 2541.4 4499.4 4501.9 4522.8 4549.8 4555.8 4502.9 4854.3 4867.0 4871.4 4905.8 4432.2 4455.6 4471.7 4493.7 4501.7 4736.7 4752.5 4758.6 4765.3 4795.9 4679.0 4681.0 4706.3 4725.4 4729.8 4741.2 5144.3 5154.2 5178.7 5185.9 3780.0 3797.0 3810.7 3832.6 3861.1 5241.2 5529.7 5557.9 5575.1 5587.4 4986.8 5275.7 5289.3 5325.1 5328.9 5357.0 5362.4 5366.6 5369.4 5375.4 5042.3 5172.4 5173.4 5265.5 5314.4 5310.9 5321.5 5324.5 5346.4 5361.3 5235.5 5236.8 5241.1 5251.8 5253.9 19:31:39 INFO - PROCESS | 3476 | 19:31:39 INFO - PROCESS | 3476 | [#5] yui.html Cycles:180 Average:18017.57 Median:546.94 stddev:26012.95 (4756.0%) stddev-sans-first:26053.14 19:31:39 INFO - PROCESS | 3476 | Values: 626.3 667.1 677.4 685.3 729.9 11708.6 13111.6 13746.1 14334.8 14348.4 13324.5 13571.8 13581.3 13585.8 13606.2 623.5 771.5 791.4 792.7 793.3 730.1 773.0 779.0 780.2 784.9 820.6 824.1 827.1 827.2 830.7 812.7 815.3 815.6 815.9 816.6 605.7 605.8 605.9 606.0 607.5 12119.6 12151.3 12168.0 12176.6 12441.3 13032.9 13390.9 13584.5 13592.9 13833.6 10663.8 10687.4 10785.4 10862.8 10985.8 3289.7 3324.8 3327.8 3335.7 3341.6 63109.4 64335.0 64369.4 64606.0 65303.3 10640.4 10690.5 10691.7 10720.1 10886.1 19636.9 19649.1 19686.6 19775.4 20284.9 6996.8 7108.1 7163.2 7190.3 7216.8 3734.7 3790.4 3801.9 3822.0 3855.2 2707.2 2807.3 2826.5 2832.0 2909.7 533.5 535.2 540.8 544.4 549.5 540.9 597.7 616.9 620.7 634.8 8342.7 8573.7 8670.7 8674.3 8864.2 556.9 580.9 602.2 603.8 608.3 4118.9 4305.7 4346.4 4380.4 4425.4 90747.5 95341.4 95858.5 97687.0 98439.5 89025.0 89629.6 89828.0 90186.0 90672.5 45194.0 72893.3 77030.2 77584.6 78880.0 8045.2 8311.3 8399.4 8446.1 8520.5 47071.5 47987.3 48286.6 48760.8 48780.8 65271.0 68192.3 69921.7 70833.3 71553.6 10216.1 10239.2 10297.6 10369.7 10533.9 11052.7 11190.7 11196.2 11205.9 11348.4 11198.8 11313.9 11386.7 11451.3 11510.0 10236.2 10338.8 10439.9 10493.1 10534.2 10780.9 10848.1 10875.5 11043.2 11496.6 8757.2 8787.7 8950.7 9098.6 9218.3 8924.0 9387.4 9397.3 9414.3 9477.3 19:31:39 INFO - PROCESS | 3476 | -------- Summary: end -------- 19:31:39 INFO - PROCESS | 3476 | 19:31:40 INFO - TEST-INFO | 3476: exit 0 19:31:40 INFO - TEST-OK | dromaeo_css | took 1119353ms 19:31:40 INFO - TEST-START | kraken 19:31:40 INFO - operating with platform_type : linux_ 19:31:40 INFO - Initialising browser for kraken test... 19:31:40 INFO - TEST-INFO | started process 3725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5O7EfR/profile http://localhost:52017/getInfo.html) 19:31:45 INFO - PROCESS | 3725 | __metrics Screen width/height:1600/1200 19:31:45 INFO - PROCESS | 3725 | colorDepth:24 19:31:45 INFO - PROCESS | 3725 | Browser inner width/height: 1024/697 19:31:45 INFO - PROCESS | 3725 | __metrics 19:31:45 ERROR - PROCESS | 3725 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:31:46 INFO - TEST-INFO | 3725: exit 0 19:31:46 INFO - Browser initialized. 19:31:46 INFO - Running cycle 1/1 for kraken test... 19:31:46 INFO - TEST-INFO | started process 3846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5O7EfR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:58 INFO - PROCESS | 3846 | RSS: Main: 163667968 19:31:58 INFO - PROCESS | 3846 | 19:32:01 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52017/tests/kraken/driver.html?testName=audio-beat-detection) 19:32:02 INFO - PROCESS | 3846 | RSS: Main: 169160704 19:32:02 INFO - PROCESS | 3846 | 19:32:05 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52017/tests/kraken/driver.html?testName=audio-dft) 19:32:05 INFO - PROCESS | 3846 | RSS: Main: 168361984 19:32:05 INFO - PROCESS | 3846 | 19:32:08 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52017/tests/kraken/driver.html?testName=audio-fft) 19:32:09 INFO - PROCESS | 3846 | RSS: Main: 164540416 19:32:09 INFO - PROCESS | 3846 | 19:32:11 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52017/tests/kraken/driver.html?testName=audio-oscillator) 19:32:12 INFO - PROCESS | 3846 | RSS: Main: 165474304 19:32:12 INFO - PROCESS | 3846 | 19:32:14 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52017/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:32:15 INFO - PROCESS | 3846 | RSS: Main: 165781504 19:32:15 INFO - PROCESS | 3846 | 19:32:18 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52017/tests/kraken/driver.html?testName=imaging-darkroom) 19:32:18 INFO - PROCESS | 3846 | RSS: Main: 165941248 19:32:18 INFO - PROCESS | 3846 | 19:32:22 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52017/tests/kraken/driver.html?testName=imaging-desaturate) 19:32:23 INFO - PROCESS | 3846 | RSS: Main: 163057664 19:32:23 INFO - PROCESS | 3846 | 19:32:26 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52017/tests/kraken/driver.html?testName=json-parse-financial) 19:32:26 INFO - PROCESS | 3846 | RSS: Main: 165064704 19:32:26 INFO - PROCESS | 3846 | 19:32:28 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52017/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:32:29 INFO - PROCESS | 3846 | RSS: Main: 164532224 19:32:29 INFO - PROCESS | 3846 | 19:32:30 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:32:31 INFO - PROCESS | 3846 | RSS: Main: 164466688 19:32:31 INFO - PROCESS | 3846 | 19:32:33 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:32:34 INFO - PROCESS | 3846 | RSS: Main: 165646336 19:32:34 INFO - PROCESS | 3846 | 19:32:37 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:32:37 INFO - PROCESS | 3846 | RSS: Main: 165351424 19:32:37 INFO - PROCESS | 3846 | 19:32:40 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:32:41 INFO - PROCESS | 3846 | RSS: Main: 165249024 19:32:41 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:52017/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52017/tests/kraken/driver.html?testName=ai-astar) 19:32:43 INFO - PROCESS | 3846 | RSS: Main: 166039552 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | __start_tp_report 19:32:43 INFO - PROCESS | 3846 | _x_x_mozilla_page_load 19:32:43 INFO - PROCESS | 3846 | _x_x_mozilla_page_load_details 19:32:43 INFO - PROCESS | 3846 | |i|pagename|runs| 19:32:43 INFO - PROCESS | 3846 | |0;ai-astar;109;117;109;114;118;115;116;116;117;114 19:32:43 INFO - PROCESS | 3846 | |1;audio-beat-detection;160;128;147;186;130;151;149;126;199;124 19:32:43 INFO - PROCESS | 3846 | |2;audio-dft;165;164;165;179;166;169;163;161;166;162 19:32:43 INFO - PROCESS | 3846 | |3;audio-fft;78;76;76;176;77;76;76;79;155;76 19:32:43 INFO - PROCESS | 3846 | |4;audio-oscillator;85;85;167;86;86;86;127;90;85;137 19:32:43 INFO - PROCESS | 3846 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;117;118;118 19:32:43 INFO - PROCESS | 3846 | |6;imaging-darkroom;148;148;148;155;148;148;148;148;148;147 19:32:43 INFO - PROCESS | 3846 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;95;95 19:32:43 INFO - PROCESS | 3846 | |8;json-parse-financial;65;68;65;65;64;63;65;64;63;64 19:32:43 INFO - PROCESS | 3846 | |9;json-stringify-tinderbox;66;67;67;66;67;66;66;67;66;67 19:32:43 INFO - PROCESS | 3846 | |10;stanford-crypto-aes;82;82;90;90;87;86;81;80;87;81 19:32:43 INFO - PROCESS | 3846 | |11;stanford-crypto-ccm;135;135;138;143;143;144;135;141;154;132 19:32:43 INFO - PROCESS | 3846 | |12;stanford-crypto-pbkdf2;171;172;171;175;170;168;179;173;172;175 19:32:43 INFO - PROCESS | 3846 | |13;stanford-crypto-sha256-iterative;70;69;69;73;69;71;69;71;71;68 19:32:43 INFO - PROCESS | 3846 | __end_tp_report 19:32:43 INFO - PROCESS | 3846 | __start_cc_report 19:32:43 INFO - PROCESS | 3846 | _x_x_mozilla_cycle_collect,914 19:32:43 INFO - PROCESS | 3846 | __end_cc_report 19:32:43 INFO - PROCESS | 3846 | __startTimestamp1470882763539__endTimestamp 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | ------- Summary: start ------- 19:32:43 INFO - PROCESS | 3846 | Number of tests: 14 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#0] ai-astar Cycles:10 Average:114.50 Median:116.00 stddev:3.17 (2.7%) stddev-sans-first:2.67 19:32:43 INFO - PROCESS | 3846 | Values: 109.0 117.0 109.0 114.0 118.0 115.0 116.0 116.0 117.0 114.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:150.00 stddev:25.70 (17.1%) stddev-sans-first:27.00 19:32:43 INFO - PROCESS | 3846 | Values: 160.0 128.0 147.0 186.0 130.0 151.0 149.0 126.0 199.0 124.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.50 stddev:5.10 (3.1%) stddev-sans-first:5.40 19:32:43 INFO - PROCESS | 3846 | Values: 165.0 164.0 165.0 179.0 166.0 169.0 163.0 161.0 166.0 162.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:37.76 (49.7%) stddev-sans-first:39.58 19:32:43 INFO - PROCESS | 3846 | Values: 78.0 76.0 76.0 176.0 77.0 76.0 76.0 79.0 155.0 76.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.50 stddev:29.50 (34.5%) stddev-sans-first:30.53 19:32:43 INFO - PROCESS | 3846 | Values: 85.0 85.0 167.0 86.0 86.0 86.0 127.0 90.0 85.0 137.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:32:43 INFO - PROCESS | 3846 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:2.27 (1.5%) stddev-sans-first:2.40 19:32:43 INFO - PROCESS | 3846 | Values: 148.0 148.0 148.0 155.0 148.0 148.0 148.0 148.0 148.0 147.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:32:43 INFO - PROCESS | 3846 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 19:32:43 INFO - PROCESS | 3846 | Values: 65.0 68.0 65.0 65.0 64.0 63.0 65.0 64.0 63.0 64.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:32:43 INFO - PROCESS | 3846 | Values: 66.0 67.0 67.0 66.0 67.0 66.0 66.0 67.0 66.0 67.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:86.50 stddev:3.84 (4.4%) stddev-sans-first:3.95 19:32:43 INFO - PROCESS | 3846 | Values: 82.0 82.0 90.0 90.0 87.0 86.0 81.0 80.0 87.0 81.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:142.00 stddev:6.45 (4.5%) stddev-sans-first:6.58 19:32:43 INFO - PROCESS | 3846 | Values: 135.0 135.0 138.0 143.0 143.0 144.0 135.0 141.0 154.0 132.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:172.50 stddev:3.10 (1.8%) stddev-sans-first:3.23 19:32:43 INFO - PROCESS | 3846 | Values: 171.0 172.0 171.0 175.0 170.0 168.0 179.0 173.0 172.0 175.0 19:32:43 INFO - PROCESS | 3846 | 19:32:43 INFO - PROCESS | 3846 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.49 (2.1%) stddev-sans-first:1.58 19:32:43 INFO - PROCESS | 3846 | Values: 70.0 69.0 69.0 73.0 69.0 71.0 69.0 71.0 71.0 68.0 19:32:43 INFO - PROCESS | 3846 | -------- Summary: end -------- 19:32:43 INFO - PROCESS | 3846 | 19:32:44 INFO - TEST-INFO | 3846: exit 0 19:32:44 INFO - TEST-OK | kraken | took 63924ms 19:32:44 INFO - SUITE-END | took 1183s 19:32:44 INFO - Completed test suite (00:19:43) 19:32:44 INFO - javascript benchmark 19:32:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6382.203033387638, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2698.8245764025337, 2714.8099633025695, 2734.3710946482315, 2737.5893615957602, 2752.215618548714, 4741.170295198343, 4942.036302920932, 4947.505249475055, 4990.326305948696, 5007.248912663103, 4804.951950480494, 4850.757462126897, 4872.147374209508, 4879.316895634614, 4880.365552478182, 4445.466544014715, 4495.100979804036, 4549.385832912564, 4571.3600095986585, 4601.470830854444, 4497.370368148446, 4522.977385113087, 4538.568835960578, 4564.748938808364, 4595.58639722425, 493.0021881490081, 4417.3815665806815, 4581.1753884300815, 4596.0, 4603.838865639704, 4408.250597398418, 4416.55834416559, 4507.842225522124, 4523.796429160696, 4524.9321260180795, 4435.911281774346, 4448.1770872388715, 4458.420405347317, 4464.0, 4490.236659767847, 4824.035192961422, 4829.613630909519, 4831.1062453445875, 4834.806607735686, 4836.177849765549, 5223.138182199932, 5278.577713782888, 5280.419153893069, 5300.522952934216, 5330.147176451749, 5288.550473209743, 5290.656107353048, 5317.494837990384, 5318.282031925679, 5341.03861304965, 4665.113628410591, 4909.877253068702, 4932.482089380635, 4961.5286547777905, 4964.255361695702, 5415.512603865671, 5439.156930675752, 5450.672959622356, 5473.31583552056, 5504.284443022381, 5211.114110601206, 5220.634555581073, 5221.947780522222, 5222.451642577551, 5271.736413179326, 5021.397432308147, 5222.190560463135, 5226.555742761831, 5308.575313974873, 5309.33633295838, 5230.058589453859, 5260.263563101169, 5260.92108618371, 5306.628536002443, 5306.62853600252, 5228.346456692913, 5242.816501422432, 5257.290265814143, 5266.34170728659, 5303.920441193385, 4250.128723611652, 4361.367601697736, 4397.868063958086, 4412.2499175139665, 4419.425474688334, 3854.2291541691775, 3858.961410385916, 3888.3972984187494, 3901.453796468497, 3907.199024200032, 4474.977814559616, 4565.041341318294, 4570.3829982951875, 4576.702514336557, 4614.884627884263, 5053.46938571452, 5233.39815921174, 5253.711045892513, 5291.1798671206025, 5362.383325917569, 4553.362529245908, 4570.565796249351, 4596.954030459719, 4612.5156858530045, 4613.0, 4691.132140554008, 4697.412823397075, 4698.835540756126, 4705.929411058837, 4729.290606409066, 4739.834105806281, 4905.779239934212, 4922.360093187863, 4945.233488809312, 4973.428055773632, 5289.18017707256, 5309.946900530946, 5310.628256022196, 5346.599005074713, 5352.732363381738, 4965.776540055634, 4990.625703072212, 4997.800087996439, 5000.67495612784, 5042.672226305279, 4904.779284932258, 5135.075686376488, 5197.376314842243, 5216.0, 5242.135047717084, 5284.656497327662, 5291.206319052173, 5307.256984022317, 5340.626156169031, 5343.572514198932, 5090.974545127251, 5127.179651255781, 5133.794648214179, 5136.845894623168, 5160.0, 4880.438749543848, 5058.31712718793, 5065.493450654905, 5124.077666020152, 5132.461091585479, 5009.223570346602, 5028.0, 5033.094043072282, 5061.493850614909, 5073.568746656428, 5124.6412751108555, 5152.716600586854, 5167.560757335668, 5169.0, 5222.033923724123, 4787.186178349759, 4991.351124353956, 5034.647574669738, 5043.344365232496, 5051.722155281494], "value": 4792.341786314213, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1546449396915, 556.6826908662063, 569.1832220763205, 576.0380165124241, 593.7713980117653, 34902.47646285305, 38276.80861595695, 38290.23419531611, 38357.0, 38545.61454385462, 38212.23575528488, 38669.99999999993, 38672.61327386725, 38680.0, 38809.22381552374, 7660.885086723718, 7765.339946104588, 7804.882926756103, 7810.258025487598, 7830.882536761953, 7747.573883436408, 7788.299053085221, 7792.727254546092, 7815.765527034198, 7826.569538675399, 7857.449978501507, 7864.960675196616, 7879.3302569281395, 7880.960595197016, 7934.7222847200355, 7805.219478052178, 7815.140334563193, 7823.882641760378, 7824.139344672081, 7846.568438735867, 7716.498427602188, 7804.531728096275, 7811.804704882366, 7825.765227043141, 7845.137034926153, 37092.847107995854, 37200.62799371999, 37448.81275593632, 37483.625163748286, 37511.43732844009, 2430.90276388946, 2641.590553464216, 3083.367909578531, 3166.3508980658908, 3232.563603913465, 27721.86139069312, 27788.30529236765, 28081.0, 28343.291417714518, 29131.563026554617, 3211.132994091582, 3230.854611542486, 3302.554155189043, 3339.1985923378456, 3379.5437615921783, 225705.0, 228160.0, 228476.0, 228970.0, 229695.0, 31578.36843263168, 31923.201919952186, 32046.198845028593, 32046.67953320437, 32121.51817722736, 31365.52951705726, 33316.0, 33459.0, 33650.663493365246, 33663.82176623806, 13428.060035797596, 13512.932435337956, 13520.729585408433, 13539.729205416033, 13570.932145339408, 11117.110631149488, 11146.0, 11202.831957520644, 11219.439028048564, 11236.438178091063, 7753.875688025205, 7763.301302882654, 7766.145723970359, 7812.960935195288, 7903.881441778378, 3089.274020605156, 3092.721655051056, 3092.876284948622, 3099.8450077496036, 3149.811011339327, 844.5692696724715, 907.3915220873027, 938.8826396700413, 946.1673727120091, 992.4591097851688, 26793.732062679515, 26944.461110777676, 27198.0, 27419.17742467729, 27522.311942201206, 965.946872921996, 982.2633025231077, 991.7421470417744, 1046.8063408269495, 1088.2708585247904, 14569.635759105895, 14754.0, 15200.391984320724, 15416.691666166615, 15427.0, 388572.0, 391105.0, 391843.0, 394192.0, 394200.0, 48509.5149048505, 48917.755411222715, 49093.0, 49240.52278431653, 49268.75365623149, 1121.1087185687397, 1159.5072094359864, 1168.6435637130758, 1191.2316555821446, 1191.803352446854, 25408.0, 27211.72788272092, 27915.302117447227, 28074.719252808027, 28347.858260708563, 42489.36265956075, 42656.78671606622, 42832.78583607062, 42835.143297134506, 42872.35691464568, 306365.0, 306655.0, 307425.0, 308978.0, 310247.0, 25059.87470062638, 25361.49277014486, 25670.87164564165, 25680.486390272465, 25719.742802571735, 38672.22655546929, 41642.58357416387, 42282.36576451294, 42832.57167428286, 43274.567254327056, 36010.819945900104, 36368.27263454769, 36398.454023189144, 37271.068223294635, 37457.43813842849, 34144.65855341415, 36591.08522286964, 36808.631913681595, 36839.263214735016, 36850.63149368579, 35873.28253434865, 36395.45406818847, 36588.81705591455, 36939.26121477609, 37068.629313706515, 31225.8438707805, 33439.0, 33532.48506361984, 33634.49548256729, 33770.0, 25546.872265638554, 25597.87201063983, 25729.613946708094, 25834.87082564575, 26188.8690556546], "value": 16129.341772943859, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5845789655052, 358.6216541548665, 360.5979333043657, 375.5437143870197, 376.69299520890473, 15923.68152636948, 17113.743293850588, 17707.1146442678, 17877.374291899785, 17907.91046044771, 16692.83307166928, 16996.150192490357, 17256.0, 17564.297428102862, 17610.735838962424, 5141.82003629873, 5357.08929481989, 5363.329583802025, 5364.7317634118135, 5365.624406291561, 3673.871414500493, 5278.313819203518, 5917.792877249297, 6193.473554747852, 6250.218722659668, 6213.7514499420195, 6284.402981716752, 6290.64751078518, 6300.495960323186, 6314.336994615545, 6072.301685306202, 6193.938060619404, 6196.0, 6223.595466294676, 6226.128342032096, 4464.575865292792, 4751.1922973094315, 5413.431589683105, 5422.728863556807, 5425.565954723652, 11769.293842369485, 11933.462994165284, 12010.339431331273, 12050.337231452266, 15580.454684086002, 1817.690992531273, 1825.069214700499, 1866.75732154819, 1871.391797665764, 1906.9892956732954, 8748.256398206096, 8881.600327985256, 8977.236934860544, 9271.490068046254, 13161.144525605805, 1680.7226807576735, 1698.4819630012842, 1731.8874273172203, 1749.3614830586744, 1760.3926645307477, 68567.31432685709, 68677.65661171712, 69399.0, 69703.0, 70053.99999999949, 9822.165115965223, 9894.208463322917, 10084.294099412971, 10149.579058931755, 10308.278420510493, 13782.724345513034, 13822.792658110136, 13868.029237953246, 13868.167909925436, 13883.37524811386, 6833.350831670983, 7097.89353159703, 7260.854782904313, 7448.292412220831, 7452.441066920002, 6551.967240163769, 6603.70283337251, 6812.0, 7058.223595404502, 7082.575045497287, 4108.77401742901, 4219.198352313051, 4228.788560571959, 4270.893227669271, 4420.226460369422, 1633.616100216448, 1668.8247733987998, 1706.1554530507478, 1733.679269335177, 1787.2493552707895, 798.2616080125861, 887.2458410351279, 901.4185850126631, 959.2565761534867, 980.3186785184229, 16660.41688540895, 17421.912890435466, 17639.382621608183, 17775.46673599794, 17829.46511604654, 859.2266959736287, 879.336101243557, 882.8322618702426, 897.0804924951846, 944.0983860413289, 9588.0, 9647.517624118766, 10034.548445319979, 10116.59533618647, 10157.542910569042, 373918.0, 387201.0, 387405.0, 389473.0, 391102.0, 74446.25553744502, 74657.25342746612, 74720.0, 76270.61864690641, 77737.222627773, 901.4140808474544, 901.4501154295874, 907.7503686486269, 909.5815924674723, 917.064594114, 15100.546983590071, 15245.542633721006, 15875.682486350439, 15944.282507286967, 16220.67558648844, 36658.45012324764, 37292.627073728916, 37556.81221593874, 37816.43275350927, 37840.24319513649, 47189.29216061693, 50382.0, 50975.23537146871, 51753.7412312936, 51849.48150518446, 7531.246875312425, 7680.270374314431, 7745.845083098419, 7792.259735325135, 7908.604569771604, 11993.280403175837, 12005.75988480243, 12228.816567751668, 12329.568465103679, 12479.126461147633, 10241.590336386462, 10369.170466362522, 10794.190435717195, 10941.23411361197, 11134.777304454028, 10481.947590262, 10512.31669941482, 10591.0, 10730.517126729472, 11000.559977600806, 10519.0, 10549.367037977747, 10623.468826558796, 10894.727631809268, 10906.454677266263, 7348.412127029718, 7391.704331826667, 7593.848123037619, 7637.770866874002, 7725.806854828675, 9738.220942324739, 10225.386476811414, 10507.684769456928, 10689.839652405375, 10923.83614245771], "value": 8218.238417854996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.407714682686, 1410.5063227870244, 1483.3695679336279, 1660.9003459792407, 1699.3372584691965, 6603.669816509179, 7394.630268486581, 7504.962475187624, 8113.513189208652, 8117.269445749888, 7573.204813494586, 7871.842563148748, 7898.4865983711015, 7902.40731945105, 7907.762767116996, 2039.6532589459791, 2067.183462532299, 2071.658176400892, 2076.6469700150933, 2081.157131361801, 2137.625915464795, 2137.9251726189586, 2142.8714277143345, 2183.6942828004094, 2183.8908054597287, 2159.0, 2163.891805409731, 2179.7493288271894, 2181.3674034529968, 2181.7054697615777, 2092.06902928197, 2096.8532202745814, 2102.4743814046487, 2104.3160972683786, 2104.4002459299104, 2032.298856894369, 2049.4466494046524, 2054.3323419888598, 2073.1189244570996, 2073.8651987620756, 7882.014748156481, 7935.880961785578, 7947.086085100172, 7985.321247693953, 7988.360931125554, 4430.158269928703, 4600.0, 4602.677812553123, 4612.884677883047, 4622.468416132154, 2680.9865950670123, 2771.9445611087667, 2854.743073123429, 2872.2819295176205, 2914.650241970956, 907.7458311672676, 958.7938593202495, 961.5480724059681, 968.2883080935507, 978.9021097890226, 10618.734531636694, 10680.946595267053, 10725.731856703645, 10734.57061717538, 10763.0, 3745.6816170625257, 3834.69322454203, 4009.4787677602308, 4012.337964235868, 4015.578364271768, 9217.63129474827, 9225.53872306382, 9232.353735238603, 9233.907660923305, 9236.72289831306, 4522.66080043998, 4551.089782043605, 4566.474855391606, 4568.451785785727, 4569.0, 3532.8056956867104, 3980.2636512245326, 4081.0613558881028, 4170.687198460128, 4176.874693759192, 3524.9118772030392, 3589.964100359015, 3629.94555081674, 3654.2143439160177, 3789.0, 1210.1347536511437, 1211.6304527119314, 1217.2818037358002, 1217.5921066442663, 1223.5411720604773, 819.0826274572516, 821.9917800822035, 822.9466283157568, 832.0805509911581, 832.1969299625769, 5067.062593420229, 5274.604404669665, 5402.513773760302, 5423.674579525241, 5428.131498960148, 927.3925578745932, 941.8304705153138, 962.0908241711516, 963.1043129889271, 1001.689476262361, 3574.749767516249, 3659.213269147146, 3669.853205871735, 3709.091272638167, 3779.829907654162, 9580.66467673628, 9957.601695932082, 9972.750681232883, 9978.750531236632, 9987.700368988943, 9727.07592778685, 9791.167750741266, 9798.118169364792, 9798.608055677692, 9867.75330616726, 7002.894956575656, 7257.0, 7313.963430182922, 7356.301151390717, 7462.888056679154, 5447.863803404946, 5590.636608620427, 5596.132599447093, 5731.856703582277, 5759.9136012959, 8748.2126608603, 8869.600867961086, 9047.457152570603, 9049.366544341832, 9115.316351273548, 8901.198892099743, 9057.728268151966, 9114.36199466031, 9175.31185161129, 9216.769580760534, 5942.851428714317, 6545.738170473128, 6723.462123030244, 6906.516543841883, 7023.754168604074, 7376.077990251219, 7439.8140046499275, 7451.739189128354, 7460.515066520658, 7472.178060413242, 6441.454051027813, 6592.967035164794, 6738.797836064926, 6744.291849355944, 6951.75668851608, 6408.839779005562, 6481.8703625928165, 6549.901751473636, 6596.670166491752, 6643.56816806906, 6146.78486252979, 6216.471599914058, 6241.063840423973, 6243.7814676486105, 6253.749850005949, 4564.338170965125, 4607.654425918003, 4683.391159149289, 4693.55411235932, 4745.47799742035, 4557.977210113928, 4593.908121837611, 4673.813047478063, 4726.36194113804, 4791.065742180242], "value": 4144.2133940732265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.66159733661124, 287.46674918027065, 298.3674609827167, 299.25784055542255, 302.84857571214394, 4898.657094003421, 4987.975060124703, 5100.285959965608, 5164.6384753067305, 5177.110354720528, 5019.2471129330615, 5029.044481548503, 5033.84898453047, 5037.4458809530925, 5059.873503162414, 3973.602639736018, 3996.740211886233, 3997.3004724173225, 4018.7387819791766, 4019.437278780973, 3920.7843568603857, 4010.556199768081, 4015.9196816063663, 4020.2763502569524, 4024.7585144891254, 3951.5258169019758, 3952.7351247600777, 3958.148997965437, 3964.9801750991205, 3969.523657161145, 3979.3235150024566, 3980.462637543938, 3982.4623675803687, 3984.7409918355215, 3989.98005009976, 3507.719382449398, 3521.436570148764, 3521.7358698097746, 3525.5416795816636, 3526.5239192708914, 4852.247901575226, 4909.705417674915, 4919.99140176263, 4920.261960705887, 5023.547880690755, 4475.77621118946, 4476.507584165739, 4480.283154695266, 4483.237849565582, 4506.752128632957, 5286.365636123652, 5308.389535203424, 5311.336082989626, 5323.254744335796, 5345.305110335631, 3708.647678470568, 3791.298609757176, 3794.4877441545314, 3809.8666546670734, 3811.6760075393627, 5516.172574113875, 5528.723563821833, 5535.58483113768, 5553.333599967989, 5596.944030559683, 3876.5348158221195, 3912.315344814703, 3918.0, 3927.9410808837893, 3931.8427262909163, 3758.267137908136, 3880.8447662093763, 3976.5029371328583, 3981.7610943343493, 3988.5213774346685, 4406.845760398371, 4411.382406463098, 4421.889452763707, 4431.4903786065015, 4454.1982443159895, 5331.747039445727, 5332.813351532678, 5369.221462887859, 5401.405845357008, 5413.188021796684, 1281.6347341007768, 1283.8445399140662, 1309.6398490415213, 1316.1445060710614, 1335.2188969452784, 871.2855458524076, 917.0874979395544, 927.248928368024, 945.4894357047255, 952.2477242977969, 4590.291727880566, 4620.768961551909, 4626.537346265347, 4627.167109920179, 4642.883927901829, 5390.865228369322, 5390.9191362129595, 5408.457460363468, 5410.83767486976, 5411.756470958816, 4472.396226509444, 4566.657500687462, 4641.187792136363, 4652.1626107300335, 4652.9294463963215, 2511.9246422607353, 2513.5978243481322, 2527.54504189244, 2528.8988440462176, 2541.351955251436, 4499.370088187591, 4501.942043619747, 4522.778849710559, 4549.817047567656, 4555.840545580955, 4502.938002158564, 4854.320395144682, 4866.975665121652, 4871.373563534124, 4905.828296009622, 4432.202203603382, 4455.6212721918355, 4471.664625153061, 4493.662975276868, 4501.707389019769, 4736.715797052188, 4752.5485078917445, 4758.571728544448, 4765.332133753159, 4795.880102997453, 4678.953210467988, 4681.027547507426, 4706.270528068155, 4725.432948046257, 4729.834455794168, 4741.170295198258, 5144.254083157846, 5154.201098829687, 5178.741062946913, 5185.9222111669105, 3780.0, 3797.0317569020826, 3810.714196435334, 3832.59757725446, 3861.1119442527815, 5241.213817927342, 5529.668219906818, 5557.888842223052, 5575.135853942646, 5587.357453892854, 4986.775595098302, 5275.733823882318, 5289.259503669567, 5325.09473389517, 5328.854296326153, 5357.01790337562, 5362.383325917569, 5366.570674345965, 5369.3556773187465, 5375.381831089318, 5042.294078828893, 5172.379314482287, 5173.3533308336455, 5265.473452654704, 5314.441983591667, 5310.9468905312, 5321.5476684482255, 5324.547413469899, 5346.358436987586, 5361.303030605996, 5235.528802407802, 5236.816711415082, 5241.135212689864, 5251.789928402821, 5253.894922101613], "value": 3904.813190772815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.3016736338982, 667.0894229376902, 677.3835809413434, 685.3454950522251, 729.9087614048244, 11708.590199343003, 13111.623279555652, 13746.106503077293, 14334.784978225334, 14348.426062957482, 13324.533641322556, 13571.796423053662, 13581.253031083286, 13585.796213056812, 13606.183628982244, 623.4918541388777, 771.5100910921564, 791.3985371117963, 792.6789650191681, 793.2939683681528, 730.0800990751665, 773.0452890680034, 779.0262172284645, 780.2275747010475, 784.9175836537167, 820.6389188756958, 824.0605709491185, 827.1356432528023, 827.1728271728272, 830.7092517618815, 812.6993012585322, 815.2621877201143, 815.5840521334133, 815.8816971539123, 816.608028146493, 605.721368170642, 605.7698074731574, 605.8848818724472, 605.9575829691923, 607.4684650930436, 12119.575814846527, 12151.331676757774, 12168.0, 12176.634700958897, 12441.253524788543, 13032.86967130326, 13390.933045334808, 13584.456621735118, 13592.93203533976, 13833.584992450242, 10663.786724265472, 10687.412192329419, 10785.406802625852, 10862.837057444145, 10985.780284394268, 3289.7039266465895, 3324.7838890472044, 3327.7670563060356, 3335.7331413487104, 3341.6491268416707, 63109.36890631127, 64335.0, 64369.356306436806, 64606.0, 65303.346966530204, 10640.414777187329, 10690.465476726133, 10691.732706682395, 10720.142388608892, 10886.07468365182, 19636.90181549083, 19649.115789789495, 19686.606267874562, 19775.40673779789, 20284.898575507028, 6996.845520489062, 7108.147022357351, 7163.212046674862, 7190.316919892602, 7216.819579510554, 3734.682551983112, 3790.3556395412847, 3801.923961520754, 3821.9531560143246, 3855.151866589346, 2707.1878436468983, 2807.298175456136, 2826.5336219523547, 2832.0229520815287, 2909.6799352071257, 533.5210904457061, 535.234614501267, 540.8026070484245, 544.4201924949915, 549.4697616799727, 540.8938720316961, 597.6981624279798, 616.9413905678954, 620.7392894984117, 634.7905191286865, 8342.749717508485, 8573.657053717907, 8670.702263900072, 8674.30605551567, 8864.20222180007, 556.8830545585472, 580.89834279001, 602.1870474858993, 603.8104933281429, 608.349066498842, 4118.91762164761, 4305.74165550068, 4346.36977638247, 4380.386745855582, 4425.424694789721, 90747.54626226827, 95341.41927226583, 95858.52070739602, 97687.0, 98439.50780246196, 89025.0, 89629.55185224162, 89828.0, 90186.0, 90672.5466372664, 45194.0, 72893.27106728971, 77030.2296977023, 77584.61207693926, 78880.0, 8045.235702608243, 8311.335093192409, 8399.41204115706, 8446.113158118309, 8520.488770673779, 47071.529284708085, 47987.28019079647, 48286.60126166694, 48760.75619621879, 48780.756096219295, 65271.0, 68192.31807682058, 69921.65039174771, 70833.29166708267, 71553.6422317885, 10216.131628811634, 10239.232057595858, 10297.588096476356, 10369.688909332732, 10533.9473302633, 11052.723681908017, 11190.720231994264, 11196.216264861381, 11205.887941120485, 11348.375839328915, 11198.776024479303, 11313.943430282796, 11386.715332116431, 11451.25566838153, 11510.0, 10236.232282578687, 10338.844917326096, 10439.947800261254, 10493.108085812792, 10534.157267418435, 10780.892191077988, 10848.077913377136, 10875.456227188768, 11043.226974111734, 11496.597619083626, 8757.211850933192, 8787.692430764893, 8950.741186790872, 9098.59056342453, 9218.26253899673, 8924.0, 9387.389819661701, 9397.342186046912, 9414.340996130479, 9477.289203309918], "value": 6573.45936065891, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 109.0, 114.0, 118.0, 115.0, 116.0, 116.0, 117.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 147.0, 186.0, 130.0, 151.0, 149.0, 126.0, 199.0, 124.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 179.0, 166.0, 169.0, 163.0, 161.0, 166.0, 162.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 176.0, 77.0, 76.0, 76.0, 79.0, 155.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 167.0, 86.0, 86.0, 86.0, 127.0, 90.0, 85.0, 137.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 155.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 65.0, 64.0, 63.0, 65.0, 64.0, 63.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 90.0, 90.0, 87.0, 86.0, 81.0, 80.0, 87.0, 81.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 138.0, 143.0, 143.0, 144.0, 135.0, 141.0, 154.0, 132.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 171.0, 175.0, 170.0, 168.0, 179.0, 173.0, 172.0, 175.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 73.0, 69.0, 71.0, 69.0, 71.0, 71.0, 68.0], "value": 70.0, "unit": "score"}]}]} 19:32:44 INFO - Return code: 0 19:32:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:32:44 ERROR - # TBPL SUCCESS # 19:32:44 INFO - Running post-action listener: _resource_record_post_action 19:32:44 INFO - [mozharness: 2016-08-11 02:32:44.866066Z] Finished run-tests step (success) 19:32:44 INFO - Running post-run listener: _resource_record_post_run 19:32:44 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7634944; Write bytes: 383459328; Read time: 1120; Write time: 290052 19:32:44 INFO - TinderboxPrint: CPU usage
13.3% 19:32:44 INFO - TinderboxPrint: I/O read bytes / time
7,634,944 / 1,120 19:32:44 INFO - TinderboxPrint: I/O write bytes / time
383,459,328 / 290,052 19:32:44 INFO - TinderboxPrint: CPU idle
8,297.2 (86.6%) 19:32:44 INFO - TinderboxPrint: CPU user
1,222.2 (12.8%) 19:32:44 INFO - TinderboxPrint: Swap in / out
0 / 0 19:32:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 74956800; Read time: 0; Write time: 47324 19:32:44 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5419008; Write bytes: 292114432; Read time: 724; Write time: 237368 19:32:45 INFO - Running post-run listener: _upload_blobber_files 19:32:45 INFO - Blob upload gear active. 19:32:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:45 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 19:32:45 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:32:45 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:32:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:46 INFO - (blobuploader) - INFO - Done attempting. 19:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:32:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:47 INFO - (blobuploader) - INFO - Done attempting. 19:32:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:32:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:51 INFO - (blobuploader) - INFO - Done attempting. 19:32:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:32:51 INFO - Return code: 0 19:32:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:32:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:32:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09ed7e487c72b9e28741cb0b570ba80bcc0511e4c5c3d6da1077bfa47d3b43320d2bbc7b515aa0d8717f7c883ff33abe65f0d13393a5b4970571c9690a6f7e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11bfe34254ee3c34793154402b3a019801d3e177ed589ed2b28b3c943f5548fca8822f42582fc950ae011b0a222c67d4708f366dd6afa1223352f732e2bc2077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b84df34ddc8cd296ac6adc4e5bc3b81d6d82ce6224b8b4ae4e68685cd8486ef9f606a381988a33feb28c41106fe367fb34985cbc827305a1c3b288a59398b5f8"} 19:32:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:32:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:32:51 INFO - Contents: 19:32:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09ed7e487c72b9e28741cb0b570ba80bcc0511e4c5c3d6da1077bfa47d3b43320d2bbc7b515aa0d8717f7c883ff33abe65f0d13393a5b4970571c9690a6f7e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11bfe34254ee3c34793154402b3a019801d3e177ed589ed2b28b3c943f5548fca8822f42582fc950ae011b0a222c67d4708f366dd6afa1223352f732e2bc2077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b84df34ddc8cd296ac6adc4e5bc3b81d6d82ce6224b8b4ae4e68685cd8486ef9f606a381988a33feb28c41106fe367fb34985cbc827305a1c3b288a59398b5f8"} 19:32:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:32:51 INFO - Copying logs to upload dir... 19:32:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:32:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.911150 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-10 19:32:51.219594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 19:32:51.222846) ========= 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=62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09ed7e487c72b9e28741cb0b570ba80bcc0511e4c5c3d6da1077bfa47d3b43320d2bbc7b515aa0d8717f7c883ff33abe65f0d13393a5b4970571c9690a6f7e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11bfe34254ee3c34793154402b3a019801d3e177ed589ed2b28b3c943f5548fca8822f42582fc950ae011b0a222c67d4708f366dd6afa1223352f732e2bc2077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b84df34ddc8cd296ac6adc4e5bc3b81d6d82ce6224b8b4ae4e68685cd8486ef9f606a381988a33feb28c41106fe367fb34985cbc827305a1c3b288a59398b5f8"} build_url:https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011117 build_url: 'https://queue.taskcluster.net/v1/task/Qk3iVVmDSiSV2FF1W_AxdA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09ed7e487c72b9e28741cb0b570ba80bcc0511e4c5c3d6da1077bfa47d3b43320d2bbc7b515aa0d8717f7c883ff33abe65f0d13393a5b4970571c9690a6f7e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11bfe34254ee3c34793154402b3a019801d3e177ed589ed2b28b3c943f5548fca8822f42582fc950ae011b0a222c67d4708f366dd6afa1223352f732e2bc2077", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b84df34ddc8cd296ac6adc4e5bc3b81d6d82ce6224b8b4ae4e68685cd8486ef9f606a381988a33feb28c41106fe367fb34985cbc827305a1c3b288a59398b5f8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 19:32:51.248772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:32:51.249165) ========= 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=62c568580acbfdaac3eec7be000001dc-1470877796.826368-1266850015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004719 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 19:32:51.331611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 19:32:51.331969) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 19:32:51.332305) ========= ========= Total master_lag: 0.18 =========