builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1470442634.26 results: success (0) buildid: 20160805143003 builduid: 21d3f47a68f34e00885c2255389635e1 revision: ba6d10b9a178a5700620a48b77b152908d4f8781 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.261100) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.261656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.263512) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.280248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.280609) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 17:17:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-08-05 17:17:14 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086058 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.382029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.382354) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017764 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.435661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:14.436067) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba6d10b9a178a5700620a48b77b152908d4f8781 --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 ba6d10b9a178a5700620a48b77b152908d4f8781 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 17:17:14,536 truncating revision to first 12 chars 2016-08-05 17:17:14,536 Setting DEBUG logging. 2016-08-05 17:17:14,537 attempt 1/10 2016-08-05 17:17:14,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba6d10b9a178?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 17:17:14,882 unpacking tar archive at: fx-team-ba6d10b9a178/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:15.167425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:15.167747) ========= script_repo_revision: ba6d10b9a178a5700620a48b77b152908d4f8781 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:15.168275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:15.168574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 17:17:15.179204) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-05 17:17:15.179645) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:15 INFO - MultiFileLogger online at 20160805 17:17:15 in /builds/slave/test 17:17:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:17:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:15 INFO - {'append_to_log': False, 17:17:15 INFO - 'base_work_dir': '/builds/slave/test', 17:17:15 INFO - 'blob_upload_branch': 'Fx-Team', 17:17:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:15 INFO - 'branch': 'Fx-Team', 17:17:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:15 INFO - 'config_files': ('talos/linux_config.py',), 17:17:15 INFO - 'default_actions': ('clobber', 17:17:15 INFO - 'read-buildbot-config', 17:17:15 INFO - 'download-and-extract', 17:17:15 INFO - 'populate-webroot', 17:17:15 INFO - 'create-virtualenv', 17:17:15 INFO - 'install', 17:17:15 INFO - 'run-tests'), 17:17:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:15 INFO - 'download_minidump_stackwalk': True, 17:17:15 INFO - 'download_symbols': 'ondemand', 17:17:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:15 INFO - 'installer_path': 'installer.exe', 17:17:15 INFO - 'log_level': 'info', 17:17:15 INFO - 'log_name': 'talos', 17:17:15 INFO - 'log_to_console': True, 17:17:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:15 INFO - 'opt_config_files': (), 17:17:15 INFO - 'pip_index': False, 17:17:15 INFO - 'sps_profile': False, 17:17:15 INFO - 'sps_profile_interval': 0, 17:17:15 INFO - 'suite': 'dromaeojs-e10s', 17:17:15 INFO - 'system_bits': '32', 17:17:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:15 INFO - 'title': 'talos-linux64-ix-008', 17:17:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:15 INFO - 'use_talos_json': True, 17:17:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:15 INFO - 'work_dir': 'build'} 17:17:15 INFO - [mozharness: 2016-08-06 00:17:15.362324Z] Running clobber step. 17:17:15 INFO - Running pre-action listener: _resource_record_pre_action 17:17:15 INFO - Running main action method: clobber 17:17:15 INFO - rmtree: /builds/slave/test/build 17:17:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:15 INFO - Running post-action listener: _resource_record_post_action 17:17:15 INFO - [mozharness: 2016-08-06 00:17:15.814580Z] Finished clobber step (success) 17:17:15 INFO - [mozharness: 2016-08-06 00:17:15.814679Z] Running read-buildbot-config step. 17:17:15 INFO - Running pre-action listener: _resource_record_pre_action 17:17:15 INFO - Running main action method: read_buildbot_config 17:17:15 INFO - Using buildbot properties: 17:17:15 INFO - { 17:17:15 INFO - "project": "", 17:17:15 INFO - "product": "firefox", 17:17:15 INFO - "script_repo_revision": "production", 17:17:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:17:15 INFO - "repository": "", 17:17:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:17:15 INFO - "buildid": "20160805143003", 17:17:15 INFO - "pgo_build": "True", 17:17:15 INFO - "basedir": "/builds/slave/test", 17:17:15 INFO - "buildnumber": 670, 17:17:15 INFO - "slavename": "talos-linux64-ix-008", 17:17:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:17:15 INFO - "platform": "ubuntu64_hw", 17:17:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:17:15 INFO - "branch": "fx-team", 17:17:15 INFO - "repo_path": "integration/fx-team", 17:17:15 INFO - "revision": "ba6d10b9a178a5700620a48b77b152908d4f8781", 17:17:15 INFO - "stage_platform": "linux64-pgo", 17:17:15 INFO - "builduid": "21d3f47a68f34e00885c2255389635e1", 17:17:15 INFO - "slavebuilddir": "test" 17:17:15 INFO - } 17:17:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:17:15 INFO - Running post-action listener: _resource_record_post_action 17:17:15 INFO - [mozharness: 2016-08-06 00:17:15.817105Z] Finished read-buildbot-config step (success) 17:17:15 INFO - [mozharness: 2016-08-06 00:17:15.817194Z] Running download-and-extract step. 17:17:15 INFO - Running pre-action listener: _resource_record_pre_action 17:17:15 INFO - Running main action method: download_and_extract 17:17:15 INFO - mkdir: /builds/slave/test/build/tests 17:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:15 INFO - trying https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:17:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:17:16 INFO - Downloaded 1361 bytes. 17:17:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:17:16 INFO - Using the following test package requirements: 17:17:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:17:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'jsshell-linux-x86_64.zip'], 17:17:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:17:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:17:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17: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')]} 17:17:16 INFO - trying https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:17:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:17 INFO - Downloaded 21825758 bytes. 17:17:17 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'] 17:17:17 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 17:17:18 INFO - Return code: 0 17:17:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:18 INFO - trying https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:17:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:19 INFO - Downloaded 21825758 bytes. 17:17:19 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'] 17:17:19 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 17:17:21 INFO - Return code: 0 17:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:21 INFO - trying https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:17:21 INFO - Downloaded 14413723 bytes. 17:17:21 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'] 17:17:21 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 17:17:22 INFO - Return code: 0 17:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:22 INFO - trying https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:17:23 INFO - Downloaded 59973174 bytes. 17:17:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:23 INFO - mkdir: /builds/slave/test/properties 17:17:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:23 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:23 INFO - Contents: 17:17:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:24 INFO - Running post-action listener: _resource_record_post_action 17:17:24 INFO - Running post-action listener: set_extra_try_arguments 17:17:24 INFO - [mozharness: 2016-08-06 00:17:24.123965Z] Finished download-and-extract step (success) 17:17:24 INFO - [mozharness: 2016-08-06 00:17:24.124196Z] Running populate-webroot step. 17:17:24 INFO - Running pre-action listener: _resource_record_pre_action 17:17:24 INFO - Running main action method: populate_webroot 17:17:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:24 INFO - '--tppagecycles', 17:17:24 INFO - '7'], 17:17:24 INFO - 'tests': ['tsvgm']}}, 17:17:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['damp', 'tps']}, 17:17:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'tests': ['damp', 'tps']}, 17:17:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['dromaeo_dom']}, 17:17:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['basic_compositor_video']}, 17:17:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:17:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['a11yr', 17:17:24 INFO - 'ts_paint', 17:17:24 INFO - 'tpaint', 17:17:24 INFO - 'sessionrestore', 17:17:24 INFO - 'sessionrestore_no_auto_restore', 17:17:24 INFO - 'tabpaint']}, 17:17:24 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:24 INFO - 'ts_paint', 17:17:24 INFO - 'tpaint', 17:17:24 INFO - 'sessionrestore', 17:17:24 INFO - 'sessionrestore_no_auto_restore', 17:17:24 INFO - 'tabpaint']}, 17:17:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:24 INFO - 'ts_paint', 17:17:24 INFO - 'tpaint', 17:17:24 INFO - 'sessionrestore', 17:17:24 INFO - 'sessionrestore_no_auto_restore', 17:17:24 INFO - 'tabpaint']}, 17:17:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:24 INFO - 'ts_paint', 17:17:24 INFO - 'tpaint', 17:17:24 INFO - 'sessionrestore', 17:17:24 INFO - 'sessionrestore_no_auto_restore', 17:17:24 INFO - 'tabpaint']}, 17:17:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['a11yr', 17:17:24 INFO - 'ts_paint', 17:17:24 INFO - 'tpaint', 17:17:24 INFO - 'sessionrestore', 17:17:24 INFO - 'sessionrestore_no_auto_restore', 17:17:24 INFO - 'tabpaint']}, 17:17:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['a11yr', 17:17:24 INFO - 'ts_paint', 17:17:24 INFO - 'tpaint', 17:17:24 INFO - 'sessionrestore', 17:17:24 INFO - 'sessionrestore_no_auto_restore', 17:17:24 INFO - 'tabpaint']}, 17:17:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['tsvgx', 17:17:24 INFO - 'tsvgr_opacity', 17:17:24 INFO - 'tart', 17:17:24 INFO - 'tscrollx', 17:17:24 INFO - 'cart']}, 17:17:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:24 INFO - 'tsvgr_opacity', 17:17:24 INFO - 'tart', 17:17:24 INFO - 'tscrollx', 17:17:24 INFO - 'cart']}, 17:17:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'talos_options': ['--disable-e10s'], 17:17:24 INFO - 'tests': ['tp5o']}, 17:17:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'tests': ['tp5o']}, 17:17:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'talos_options': ['--disable-e10s', 17:17:24 INFO - '--xperf_path', 17:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:24 INFO - 'tests': ['tp5n']}, 17:17:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:24 INFO - 'talos_options': ['--xperf_path', 17:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:24 INFO - 'tests': ['tp5n']}}, 17:17:24 INFO - 'talos.zip': {'path': '', 17:17:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:24 INFO - Running post-action listener: _resource_record_post_action 17:17:24 INFO - [mozharness: 2016-08-06 00:17:24.143199Z] Finished populate-webroot step (success) 17:17:24 INFO - [mozharness: 2016-08-06 00:17:24.143288Z] Running create-virtualenv step. 17:17:24 INFO - Running pre-action listener: _resource_record_pre_action 17:17:24 INFO - Running main action method: create_virtualenv 17:17:24 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:17:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:24 INFO - Using real prefix '/usr' 17:17:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:24 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:27 INFO - Installing pip.................done. 17:17:27 INFO - Return code: 0 17:17:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:27 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:17:27 INFO - Using env: {'DISPLAY': ':0', 17:17:27 INFO - 'HOME': '/home/cltbld', 17:17:27 INFO - 'LANG': 'en_US.UTF-8', 17:17:27 INFO - 'LANGUAGE': 'en_US:en', 17:17:27 INFO - 'LOGNAME': 'cltbld', 17:17:27 INFO - 'MAIL': '/var/mail/cltbld', 17:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:27 INFO - 'MOZ_NO_REMOTE': '1', 17:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:27 INFO - 'NO_EM_RESTART': '1', 17:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:27 INFO - 'PWD': '/builds/slave/test', 17:17:27 INFO - 'SHELL': '/bin/bash', 17:17:27 INFO - 'SHLVL': '1', 17:17:27 INFO - 'TERM': 'linux', 17:17:27 INFO - 'TMOUT': '86400', 17:17:27 INFO - 'USER': 'cltbld', 17:17:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:27 INFO - '_': '/tools/buildbot/bin/python'} 17:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:17:27 INFO - Cleaning up... 17:17:27 INFO - Return code: 0 17:17:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:27 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:17:27 INFO - Using env: {'DISPLAY': ':0', 17:17:27 INFO - 'HOME': '/home/cltbld', 17:17:27 INFO - 'LANG': 'en_US.UTF-8', 17:17:27 INFO - 'LANGUAGE': 'en_US:en', 17:17:27 INFO - 'LOGNAME': 'cltbld', 17:17:27 INFO - 'MAIL': '/var/mail/cltbld', 17:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:27 INFO - 'MOZ_NO_REMOTE': '1', 17:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:27 INFO - 'NO_EM_RESTART': '1', 17:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:27 INFO - 'PWD': '/builds/slave/test', 17:17:27 INFO - 'SHELL': '/bin/bash', 17:17:27 INFO - 'SHLVL': '1', 17:17:27 INFO - 'TERM': 'linux', 17:17:27 INFO - 'TMOUT': '86400', 17:17:27 INFO - 'USER': 'cltbld', 17:17:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:27 INFO - '_': '/tools/buildbot/bin/python'} 17:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:27 INFO - Downloading/unpacking psutil>=3.1.1 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:29 INFO - Installing collected packages: psutil 17:17:29 INFO - Running setup.py install for psutil 17:17:29 INFO - building 'psutil._psutil_linux' extension 17:17:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:17:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:17:29 INFO - building 'psutil._psutil_posix' extension 17:17:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:17:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:17:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:30 INFO - Successfully installed psutil 17:17:30 INFO - Cleaning up... 17:17:30 INFO - Return code: 0 17:17:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:17: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 mozsystemmonitor==0.3 17:17:30 INFO - Using env: {'DISPLAY': ':0', 17:17:30 INFO - 'HOME': '/home/cltbld', 17:17:30 INFO - 'LANG': 'en_US.UTF-8', 17:17:30 INFO - 'LANGUAGE': 'en_US:en', 17:17:30 INFO - 'LOGNAME': 'cltbld', 17:17:30 INFO - 'MAIL': '/var/mail/cltbld', 17:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:30 INFO - 'MOZ_NO_REMOTE': '1', 17:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:30 INFO - 'NO_EM_RESTART': '1', 17:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:30 INFO - 'PWD': '/builds/slave/test', 17:17:30 INFO - 'SHELL': '/bin/bash', 17:17:30 INFO - 'SHLVL': '1', 17:17:30 INFO - 'TERM': 'linux', 17:17:30 INFO - 'TMOUT': '86400', 17:17:30 INFO - 'USER': 'cltbld', 17:17:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:30 INFO - '_': '/tools/buildbot/bin/python'} 17:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:17:32 INFO - Installing collected packages: mozsystemmonitor 17:17:32 INFO - Running setup.py install for mozsystemmonitor 17:17:32 INFO - Successfully installed mozsystemmonitor 17:17:32 INFO - Cleaning up... 17:17:33 INFO - Return code: 0 17:17:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', '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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:17: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 jsonschema==2.5.1 17:17:33 INFO - Using env: {'DISPLAY': ':0', 17:17:33 INFO - 'HOME': '/home/cltbld', 17:17:33 INFO - 'LANG': 'en_US.UTF-8', 17:17:33 INFO - 'LANGUAGE': 'en_US:en', 17:17:33 INFO - 'LOGNAME': 'cltbld', 17:17:33 INFO - 'MAIL': '/var/mail/cltbld', 17:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:33 INFO - 'MOZ_NO_REMOTE': '1', 17:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:33 INFO - 'NO_EM_RESTART': '1', 17:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:33 INFO - 'PWD': '/builds/slave/test', 17:17:33 INFO - 'SHELL': '/bin/bash', 17:17:33 INFO - 'SHLVL': '1', 17:17:33 INFO - 'TERM': 'linux', 17:17:33 INFO - 'TMOUT': '86400', 17:17:33 INFO - 'USER': 'cltbld', 17:17:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:33 INFO - '_': '/tools/buildbot/bin/python'} 17:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:33 INFO - Downloading/unpacking jsonschema==2.5.1 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:35 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:35 INFO - warning: no files found matching '*.txt' 17:17:35 INFO - no previously-included directories found matching 'build' 17:17:35 INFO - no previously-included directories found matching 'dist' 17:17:35 INFO - no previously-included directories found matching '.git*' 17:17:35 INFO - Installing collected packages: jsonschema, functools32 17:17:35 INFO - Running setup.py install for functools32 17:17:35 INFO - warning: no files found matching '*.txt' 17:17:35 INFO - no previously-included directories found matching 'build' 17:17:35 INFO - no previously-included directories found matching 'dist' 17:17:35 INFO - no previously-included directories found matching '.git*' 17:17:35 INFO - Successfully installed jsonschema functools32 17:17:35 INFO - Cleaning up... 17:17:35 INFO - Return code: 0 17:17:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:35 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:17:35 INFO - Using env: {'DISPLAY': ':0', 17:17:35 INFO - 'HOME': '/home/cltbld', 17:17:35 INFO - 'LANG': 'en_US.UTF-8', 17:17:35 INFO - 'LANGUAGE': 'en_US:en', 17:17:35 INFO - 'LOGNAME': 'cltbld', 17:17:35 INFO - 'MAIL': '/var/mail/cltbld', 17:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:35 INFO - 'MOZ_NO_REMOTE': '1', 17:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:35 INFO - 'NO_EM_RESTART': '1', 17:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:35 INFO - 'PWD': '/builds/slave/test', 17:17:35 INFO - 'SHELL': '/bin/bash', 17:17:35 INFO - 'SHLVL': '1', 17:17:35 INFO - 'TERM': 'linux', 17:17:35 INFO - 'TMOUT': '86400', 17:17:35 INFO - 'USER': 'cltbld', 17:17:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:35 INFO - '_': '/tools/buildbot/bin/python'} 17:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:17:36 INFO - Cleaning up... 17:17:36 INFO - Return code: 0 17:17:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:36 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:36 INFO - Using env: {'DISPLAY': ':0', 17:17:36 INFO - 'HOME': '/home/cltbld', 17:17:36 INFO - 'LANG': 'en_US.UTF-8', 17:17:36 INFO - 'LANGUAGE': 'en_US:en', 17:17:36 INFO - 'LOGNAME': 'cltbld', 17:17:36 INFO - 'MAIL': '/var/mail/cltbld', 17:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:36 INFO - 'MOZ_NO_REMOTE': '1', 17:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:36 INFO - 'NO_EM_RESTART': '1', 17:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:36 INFO - 'PWD': '/builds/slave/test', 17:17:36 INFO - 'SHELL': '/bin/bash', 17:17:36 INFO - 'SHLVL': '1', 17:17:36 INFO - 'TERM': 'linux', 17:17:36 INFO - 'TMOUT': '86400', 17:17:36 INFO - 'USER': 'cltbld', 17:17:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:36 INFO - '_': '/tools/buildbot/bin/python'} 17:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:38 INFO - Downloading docopt-0.6.1.tar.gz 17:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:39 INFO - Running setup.py install for blobuploader 17:17:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:39 INFO - Running setup.py install for requests 17:17:39 INFO - Running setup.py install for docopt 17:17:39 INFO - Successfully installed blobuploader requests docopt 17:17:39 INFO - Cleaning up... 17:17:39 INFO - Return code: 0 17:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:39 INFO - Using env: {'DISPLAY': ':0', 17:17:39 INFO - 'HOME': '/home/cltbld', 17:17:39 INFO - 'LANG': 'en_US.UTF-8', 17:17:39 INFO - 'LANGUAGE': 'en_US:en', 17:17:39 INFO - 'LOGNAME': 'cltbld', 17:17:39 INFO - 'MAIL': '/var/mail/cltbld', 17:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:39 INFO - 'MOZ_NO_REMOTE': '1', 17:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:39 INFO - 'NO_EM_RESTART': '1', 17:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:39 INFO - 'PWD': '/builds/slave/test', 17:17:39 INFO - 'SHELL': '/bin/bash', 17:17:39 INFO - 'SHLVL': '1', 17:17:39 INFO - 'TERM': 'linux', 17:17:39 INFO - 'TMOUT': '86400', 17:17:39 INFO - 'USER': 'cltbld', 17:17:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:39 INFO - '_': '/tools/buildbot/bin/python'} 17:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:39 INFO - Running setup.py (path:/tmp/pip-MzYrsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:39 INFO - Running setup.py (path:/tmp/pip-aHRYxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:40 INFO - Running setup.py (path:/tmp/pip-YUX9Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:40 INFO - Running setup.py (path:/tmp/pip-sKT2O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:40 INFO - Running setup.py (path:/tmp/pip-bbLqBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:40 INFO - Running setup.py (path:/tmp/pip-0bV1F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:40 INFO - Running setup.py (path:/tmp/pip-SwgLQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:40 INFO - Running setup.py (path:/tmp/pip-CXSZZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:40 INFO - Running setup.py (path:/tmp/pip-D5eMUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:40 INFO - Running setup.py (path:/tmp/pip-8gSq2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:40 INFO - Running setup.py (path:/tmp/pip-3eMKq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:40 INFO - Running setup.py (path:/tmp/pip-vQU93L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:40 INFO - Running setup.py (path:/tmp/pip-VjxFz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:40 INFO - Running setup.py (path:/tmp/pip-_YX8UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:40 INFO - Running setup.py (path:/tmp/pip-Z2lNeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:40 INFO - Running setup.py (path:/tmp/pip-NamJ2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:41 INFO - Running setup.py (path:/tmp/pip-QrdVnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:41 INFO - Running setup.py install for manifestparser 17:17:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozcrash 17:17:41 INFO - Running setup.py install for mozdebug 17:17:41 INFO - Running setup.py install for mozdevice 17:17:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozfile 17:17:41 INFO - Running setup.py install for mozhttpd 17:17:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozinfo 17:17:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozInstall 17:17:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozleak 17:17:41 INFO - Running setup.py install for mozlog 17:17:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for moznetwork 17:17:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for mozprocess 17:17:42 INFO - Running setup.py install for mozprofile 17:17:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for mozrunner 17:17:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for mozscreenshot 17:17:42 INFO - Running setup.py install for moztest 17:17:42 INFO - Running setup.py install for mozversion 17:17:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:42 INFO - Cleaning up... 17:17:42 INFO - Return code: 0 17:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:42 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:42 INFO - Using env: {'DISPLAY': ':0', 17:17:42 INFO - 'HOME': '/home/cltbld', 17:17:42 INFO - 'LANG': 'en_US.UTF-8', 17:17:42 INFO - 'LANGUAGE': 'en_US:en', 17:17:42 INFO - 'LOGNAME': 'cltbld', 17:17:42 INFO - 'MAIL': '/var/mail/cltbld', 17:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:42 INFO - 'MOZ_NO_REMOTE': '1', 17:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:42 INFO - 'NO_EM_RESTART': '1', 17:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:42 INFO - 'PWD': '/builds/slave/test', 17:17:42 INFO - 'SHELL': '/bin/bash', 17:17:42 INFO - 'SHLVL': '1', 17:17:42 INFO - 'TERM': 'linux', 17:17:42 INFO - 'TMOUT': '86400', 17:17:42 INFO - 'USER': 'cltbld', 17:17:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:42 INFO - '_': '/tools/buildbot/bin/python'} 17:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:43 INFO - Running setup.py (path:/tmp/pip-Fp4t6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:43 INFO - Running setup.py (path:/tmp/pip-JcfQ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:43 INFO - Running setup.py (path:/tmp/pip-6qG0P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:43 INFO - Running setup.py (path:/tmp/pip-kx90qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:43 INFO - Running setup.py (path:/tmp/pip-NgMCOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:43 INFO - Running setup.py (path:/tmp/pip-jx3S_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:43 INFO - Running setup.py (path:/tmp/pip-yuzdxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:43 INFO - Running setup.py (path:/tmp/pip-Sl9Bt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:43 INFO - Running setup.py (path:/tmp/pip-oCaU4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:43 INFO - Running setup.py (path:/tmp/pip-Le_ipl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:43 INFO - Running setup.py (path:/tmp/pip-dDepWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:43 INFO - Running setup.py (path:/tmp/pip-pyqw0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:44 INFO - Running setup.py (path:/tmp/pip-QdjdsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:44 INFO - Running setup.py (path:/tmp/pip-HotvPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:44 INFO - Running setup.py (path:/tmp/pip-9_bdha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:44 INFO - Running setup.py (path:/tmp/pip-V33KzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:44 INFO - Running setup.py (path:/tmp/pip-_wiDJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - Downloading blessings-1.6.tar.gz 17:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:46 INFO - Installing collected packages: blessings 17:17:46 INFO - Running setup.py install for blessings 17:17:46 INFO - Successfully installed blessings 17:17:46 INFO - Cleaning up... 17:17:46 INFO - Return code: 0 17:17:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:46 INFO - Reading from file tmpfile_stdout 17:17:46 INFO - Current package versions: 17:17:46 INFO - argparse == 1.2.1 17:17:46 INFO - blessings == 1.6 17:17:46 INFO - blobuploader == 1.2.4 17:17:46 INFO - docopt == 0.6.1 17:17:46 INFO - functools32 == 3.2.3-2 17:17:46 INFO - jsonschema == 2.5.1 17:17:46 INFO - manifestparser == 1.1 17:17:46 INFO - mozInstall == 1.12 17:17:46 INFO - mozcrash == 0.17 17:17:46 INFO - mozdebug == 0.1 17:17:46 INFO - mozdevice == 0.48 17:17:46 INFO - mozfile == 1.2 17:17:46 INFO - mozhttpd == 0.7 17:17:46 INFO - mozinfo == 0.9 17:17:46 INFO - mozleak == 0.1 17:17:46 INFO - mozlog == 3.3 17:17:46 INFO - moznetwork == 0.27 17:17:46 INFO - mozprocess == 0.23 17:17:46 INFO - mozprofile == 0.28 17:17:46 INFO - mozrunner == 6.12 17:17:46 INFO - mozscreenshot == 0.1 17:17:46 INFO - mozsystemmonitor == 0.3 17:17:46 INFO - moztest == 0.7 17:17:46 INFO - mozversion == 1.4 17:17:46 INFO - psutil == 3.1.1 17:17:46 INFO - requests == 1.2.3 17:17:46 INFO - wsgiref == 0.1.2 17:17:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:46 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:46 INFO - Using env: {'DISPLAY': ':0', 17:17:46 INFO - 'HOME': '/home/cltbld', 17:17:46 INFO - 'LANG': 'en_US.UTF-8', 17:17:46 INFO - 'LANGUAGE': 'en_US:en', 17:17:46 INFO - 'LOGNAME': 'cltbld', 17:17:46 INFO - 'MAIL': '/var/mail/cltbld', 17:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:46 INFO - 'MOZ_NO_REMOTE': '1', 17:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:46 INFO - 'NO_EM_RESTART': '1', 17:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:46 INFO - 'PWD': '/builds/slave/test', 17:17:46 INFO - 'SHELL': '/bin/bash', 17:17:46 INFO - 'SHLVL': '1', 17:17:46 INFO - 'TERM': 'linux', 17:17:46 INFO - 'TMOUT': '86400', 17:17:46 INFO - 'USER': 'cltbld', 17:17:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:46 INFO - '_': '/tools/buildbot/bin/python'} 17:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:17:46 INFO - Cleaning up... 17:17:46 INFO - Return code: 0 17:17:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:46 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 0x1fb0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:17:46 INFO - Using env: {'DISPLAY': ':0', 17:17:46 INFO - 'HOME': '/home/cltbld', 17:17:46 INFO - 'LANG': 'en_US.UTF-8', 17:17:46 INFO - 'LANGUAGE': 'en_US:en', 17:17:46 INFO - 'LOGNAME': 'cltbld', 17:17:46 INFO - 'MAIL': '/var/mail/cltbld', 17:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:46 INFO - 'MOZ_NO_REMOTE': '1', 17:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:46 INFO - 'NO_EM_RESTART': '1', 17:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:46 INFO - 'PWD': '/builds/slave/test', 17:17:46 INFO - 'SHELL': '/bin/bash', 17:17:46 INFO - 'SHLVL': '1', 17:17:46 INFO - 'TERM': 'linux', 17:17:46 INFO - 'TMOUT': '86400', 17:17:46 INFO - 'USER': 'cltbld', 17:17:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:46 INFO - '_': '/tools/buildbot/bin/python'} 17:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:17:47 INFO - Cleaning up... 17:17:47 INFO - Return code: 0 17:17:47 INFO - Running post-action listener: _resource_record_post_action 17:17:47 INFO - Running post-action listener: _start_resource_monitoring 17:17:47 INFO - Starting resource monitoring. 17:17:47 INFO - [mozharness: 2016-08-06 00:17:47.199584Z] Finished create-virtualenv step (success) 17:17:47 INFO - [mozharness: 2016-08-06 00:17:47.200063Z] Running install step. 17:17:47 INFO - Running pre-action listener: _resource_record_pre_action 17:17:47 INFO - Running main action method: install 17:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:47 INFO - Reading from file tmpfile_stdout 17:17:47 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:47 INFO - Reading from file tmpfile_stdout 17:17:47 INFO - Output received: 17:17:47 INFO - Usage: mozinstall [options] installer 17:17:47 INFO - Options: 17:17:47 INFO - -h, --help show this help message and exit 17:17:47 INFO - -d DEST, --destination=DEST 17:17:47 INFO - Directory to install application into. [default: 17:17:47 INFO - "/builds/slave/test"] 17:17:47 INFO - --app=APP Application being installed. [default: firefox] 17:17:47 INFO - mkdir: /builds/slave/test/build/application 17:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:18:04 INFO - Reading from file tmpfile_stdout 17:18:04 INFO - Output received: 17:18:04 INFO - /builds/slave/test/build/application/firefox/firefox 17:18:04 INFO - Running post-action listener: _resource_record_post_action 17:18:04 INFO - [mozharness: 2016-08-06 00:18:04.517420Z] Finished install step (success) 17:18:04 INFO - [mozharness: 2016-08-06 00:18:04.517671Z] Running run-tests step. 17:18:04 INFO - Running pre-action listener: _resource_record_pre_action 17:18:04 INFO - Running main action method: run_tests 17:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:04 INFO - Python 2.7.3 17:18:04 INFO - Return code: 0 17:18:04 INFO - grabbing minidump binary from tooltool 17:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:04 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 0x226f3b0>, '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 0x22702b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2270740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:18:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:18:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:18:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:04 INFO - Return code: 0 17:18:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:18:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:18:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:18:04 INFO - Using env: {'DISPLAY': ':0', 17:18:04 INFO - 'HOME': '/home/cltbld', 17:18:04 INFO - 'LANG': 'en_US.UTF-8', 17:18:04 INFO - 'LANGUAGE': 'en_US:en', 17:18:04 INFO - 'LOGNAME': 'cltbld', 17:18:04 INFO - 'MAIL': '/var/mail/cltbld', 17:18:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:04 INFO - 'MOZ_NO_REMOTE': '1', 17:18:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:04 INFO - 'NO_EM_RESTART': '1', 17:18:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:04 INFO - 'PWD': '/builds/slave/test', 17:18:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:04 INFO - 'SHELL': '/bin/bash', 17:18:04 INFO - 'SHLVL': '1', 17:18:04 INFO - 'TERM': 'linux', 17:18:04 INFO - 'TMOUT': '86400', 17:18:04 INFO - 'USER': 'cltbld', 17:18:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927', 17:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:04 INFO - '_': '/tools/buildbot/bin/python'} 17:18:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:18:04 INFO - mozversion application_buildid: 20160805143003 17:18:04 INFO - mozversion application_changeset: ba6d10b9a178a5700620a48b77b152908d4f8781 17:18:04 INFO - mozversion application_display_name: Nightly 17:18:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:04 INFO - mozversion application_name: Firefox 17:18:04 INFO - mozversion application_remotingname: firefox 17:18:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:18:04 INFO - mozversion application_vendor: Mozilla 17:18:04 INFO - mozversion application_version: 51.0a1 17:18:04 INFO - mozversion platform_buildid: 20160805143003 17:18:04 INFO - mozversion platform_changeset: ba6d10b9a178a5700620a48b77b152908d4f8781 17:18:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:04 INFO - mozversion platform_version: 51.0a1 17:18:04 INFO - using testdate: 1470442684 17:18:04 INFO - actual date: 1470442684 17:18:04 INFO - starting webserver on 'localhost:35964' 17:18:04 INFO - SUITE-START | Running 2 tests 17:18:04 INFO - TEST-START | dromaeo_css 17:18:04 INFO - operating with platform_type : linux_ 17:18:04 INFO - Initialising browser for dromaeo_css test... 17:18:04 INFO - TEST-INFO | started process 7967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFk4OQX/profile http://localhost:35964/getInfo.html) 17:18:09 INFO - PROCESS | 7967 | __metrics Screen width/height:1600/1200 17:18:09 INFO - PROCESS | 7967 | colorDepth:24 17:18:09 INFO - PROCESS | 7967 | Browser inner width/height: 1024/697 17:18:09 INFO - PROCESS | 7967 | __metrics 17:18:09 ERROR - PROCESS | 7967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:18:10 INFO - TEST-INFO | 7967: exit 0 17:18:10 INFO - Browser initialized. 17:18:10 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:10 INFO - TEST-INFO | started process 8086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFk4OQX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:22 INFO - PROCESS | 8086 | RSS: Main: 163811328 17:18:22 INFO - PROCESS | 8086 | 17:19:12 INFO - PROCESS | 8086 | 1470442752210 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:21:22 INFO - PROCESS | 8086 | Cycle 1(1): loaded http://localhost:35964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35964/tests/dromaeo/cssquery-ext.html) 17:21:23 INFO - PROCESS | 8086 | RSS: Main: 166178816 17:21:23 INFO - PROCESS | 8086 | 17:24:25 INFO - PROCESS | 8086 | Cycle 1(1): loaded http://localhost:35964/tests/dromaeo/cssquery-ext.html (next: http://localhost:35964/tests/dromaeo/cssquery-jquery.html) 17:24:25 INFO - PROCESS | 8086 | RSS: Main: 165306368 17:24:25 INFO - PROCESS | 8086 | 17:27:27 INFO - PROCESS | 8086 | Cycle 1(1): loaded http://localhost:35964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35964/tests/dromaeo/cssquery-mootools.html) 17:27:28 INFO - PROCESS | 8086 | RSS: Main: 169762816 17:27:28 INFO - PROCESS | 8086 | 17:30:30 INFO - PROCESS | 8086 | Cycle 1(1): loaded http://localhost:35964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35964/tests/dromaeo/cssquery-prototype.html) 17:30:30 INFO - PROCESS | 8086 | RSS: Main: 164519936 17:30:30 INFO - PROCESS | 8086 | 17:33:33 INFO - PROCESS | 8086 | Cycle 1(1): loaded http://localhost:35964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35964/tests/dromaeo/cssquery-yui.html) 17:33:33 INFO - PROCESS | 8086 | RSS: Main: 166948864 17:33:33 INFO - PROCESS | 8086 | 17:36:36 INFO - PROCESS | 8086 | Cycle 1(1): loaded http://localhost:35964/tests/dromaeo/cssquery-yui.html (next: http://localhost:35964/tests/dromaeo/cssquery-dojo.html) 17:36:37 INFO - PROCESS | 8086 | RSS: Main: 170000384 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | __start_tp_report 17:36:37 INFO - PROCESS | 8086 | _x_x_mozilla_page_load 17:36:37 INFO - PROCESS | 8086 | _x_x_mozilla_page_load_details 17:36:37 INFO - PROCESS | 8086 | |i|pagename|runs| 17:36:37 INFO - PROCESS | 8086 | |0;dojo.html;3104.4877595196795;3106.285554322506;3127.5152351385527;3133.0444214514573;3134.702203290688;5313.043652142613;5358.919616205755;5409.107497262957;5447.809326673567;5488.121900495921;5306.867328316794;5338.759755810988;5385.865353366158;5392.460753924605;5416.214648875921;4647.372604698373;4882.658213925018;4913.926291105637;4957.206846904496;5060.493950604929;4992.151334273182;4999.350084489011;5006.924896126543;5050.974745126287;5057;4780.378550788375;4803.711777293373;4927.999999999982;4961.652684312099;4974.179260422026;4815.614750819961;4870.123377791996;4885.389326334208;4905;4912.582430493412;4794.232922732346;4849.612031037508;4862.294967229767;4881.365422495089;4897.828575999859;5240.475952404767;5266.104762190437;5327.334083239595;5344.278522399465;5379.38137114233;5658.971705141489;5742;5742.97128514359;5770.567207459458;5782.681952492611;5752.539796816244;5757.992351338499;5761.884762304772;5776.277965254343;5789.363170051291;5210.97394513025;5268.868278292996;5356.946430535684;5357.705326207057;5379.220013098079;5825.563082768809;5887.293524777054;5903.2325797646035;5914.438128377883;5934;5650.915236271459;5651.463111004448;5652.943470565324;5655.1799989001365;5666.744996475169;5650.576206784508;5651.632643878217;5749.88500229993;5761.222234998221;5769.68266745333;5657.717114144359;5695.259616249861;5719.19931209631;5763.567732420001;5772.509336706343;5658.434156584309;5673.404292549306;5693.516051135617;5719.742611582489;5743.655380677173;4335.1329734053315;4366.8034938427845;4384.583464570925;4401.779911004501;4449.13241917823;3899.025243689078;3911.647951684362;3958.267720471722;3959.8614048508166;3962.623550762673;5470.835874923759;5481.972590137104;5514.862128446741;5523.530499907552;5524.502794748492;5668.008098582732;5755.424457554211;5840.707964601753;5849.210356601804;5850.180974663551;5418.91871621926;5445.210444485607;5525.171224316385;5545.029619816516;5556.305461817273;4963.156263435225;4975.601951843843;4980.12847751642;4982.651214415028;4984.800607975713;5863.73613187399;5907.9704601476715;6063.393660633901;6066.636001839904;6083.847903802441;5723.3418156912485;5780.884382312414;5812;5854.648721076749;5859.326177489644;5965.34381218057;6003.519718422603;6008.819735407945;6010.429009244115;6012.579119461596;5604.271444712162;5655.066913959151;5656.066748986371;5695.715214239354;5712.228849105318;5791.044477661138;5816.82549523515;5840.503557197516;5845.240118784531;5899.233099697012;5687.573431992534;5688.658680479184;5693.060644993529;5694.572907031907;5704.3154821421695;5500.9823182711325;5557.722113894209;5622.353429355513;5657.264555607745;5659.85850353728;5567.164925261243;5608.85977850557;5626.127950167731;5639.154126881001;5653.830385088454;5619.044762390322;5712.742926568398;5720.942790572041;5729.570282228933;5735.885282294247;5382.138857782736;5430.42980487059;5440.156775699773;5581.190727344431;5600.131979543177 17:36:37 INFO - PROCESS | 8086 | |1;ext.html;553.6944441683153;595.4105435618739;598.5510866849862;611.1260896917407;637.2639601260546;40161;44138.77930610347;44280.11439771211;44387;44614.33078503821;44511.33233001499;44808;44882.32676509855;45145.7742711286;45200.54799452004;8990.73027809165;9132.634694612241;9151.542422878863;9159.267258619328;9161.679341223058;8968.148025937526;9142.314326425512;9147.862782058275;9151.496667683276;9189.3108016899;9186.081391860795;9231.030741772118;9248.121428464285;9269.073092690744;9293.21007714345;9127.224185944202;9171.862422063674;9230.953845230732;9233.076692330815;9234.722958311262;8938.374313798036;9012.8648070279;9028.458292502472;9039.502827344493;9056.456612603264;42422.36366454505;42613.786931065144;42655.36016959748;42774.358384624255;42902.35646465306;3687.474080255034;3722.2183341498317;3776.433534969749;3919.513205644663;3920.862769803043;33501.16247093818;33733.83133084344;33790.1552461188;33804;35537.28925421503;4316.56834316569;4331.285337919239;4363.258246098171;4469.418975533193;4507.368968344402;249720;249723;249872;250213;250484;59673.40326596679;60520.737511498904;60810.69594651998;60981.08528372078;61025.38974610197;37011.4448283276;37537.24925501474;37818.81090594529;39796;40160.196796063916;16732.16339183036;16843.915780421263;16905.23926423314;16922.74615880763;16957.660846782994;12808.935955320163;12841.678958026125;12902.35488225585;12904.290099079299;12907.935460322638;19592.216311347387;19797;19839;19873.900630496755;19874.304399345954;7223.638818059076;7430.405567554691;7539.698412063456;7630.122535908331;7688;1030.835066389374;1094.5129417409175;1135.9545618175346;1149.741308205647;1157.1437136518916;33324.166895827795;33930;34278.65721342804;34352.31295374079;34600.65399346025;1134.1437214902696;1148.8104462763552;1167.7839599674087;1215.459120691284;1221.5480272299305;17844.643107138043;17856.375026874255;17919.37282195117;17957.7306340405;18036.729449058275;565622;571015;573955;577705;578761;60560.394396055475;60819.391806081374;60939.39060609426;61042;61240;1342.9462821487227;1350.5340657473157;1382.6958069224754;1388.1601631013293;1391.1235921369473;32619.673803261663;33760.66239337673;33821;34140;34156.984726916955;54924.725376372866;54962.450375497334;55067.17399239095;55180.44819551753;55305.44694553003;463212;463421;463499;465725;465821;30337;30439.847800760854;30476.695233047387;30779.230519237197;30857.074287771404;49766;49924.25113623371;50041.49958500369;51476;51756;42033;43203;43779.34330984974;44849.327260090475;44902.32646510239;42186.15627687368;42955.926101847705;43162.1367572653;44283.55716442923;44602.55397446114;42430.15139697127;42747.145057099304;42890.142197155255;42940.78529607332;43174.568254318314;36178.27643447064;37663.43504847484;38115.42826857544;38204;38960;29288.10582359123;29329.266768330963;29403.85298073496;29431.705682942895;29530.261743456587 17:36:37 INFO - PROCESS | 8086 | |2;jquery.html;380.6003696119076;387.5683763828586;390.826082393335;395.48389351895776;404.4196577910698;18698.532536686573;20217.898910505446;20286.98565071746;20491.795082049175;20891.477713057182;18858.905705471487;19001.809981900176;19459.221631134773;19471.123799429024;19608.41174764756;5142.382914050319;5171.456997015306;5285.233641122035;5322.33470816148;5337.626366154371;5212.869678258036;5294.444083371249;5330.093884039723;5330.280412144369;5341.946580534183;5291.365036195662;5306.469353064701;5707;5712.571557133211;5741.540676745851;5733.684647344395;5744.597878148531;5759.222504961818;5762.020456522359;5763.4236576342655;5107.591392688576;5378.542823859977;5420.945790542083;5456.563474922036;5459.481349271813;13601.523946661819;13643.38604762788;13661.726765464635;13669.863301366959;13777.173369597756;2293.2203050962585;2310.676505289261;2488.726240113586;2690.260178450922;2746.873781749493;9751;10034.749131271703;10090.243231757648;10283.691489255334;10513;1823.4803081121815;1927.9036048197534;1947.4157752674141;1954.9120289587004;1963.3324669612257;75025.62487187529;76139;76470.61764691141;76691.23308766897;78615;10736.89263107359;10809.297395669257;10843.945780271048;11077.50151243196;11110.166737494721;14951.626209344853;15076.698466030837;15151.318190681226;15163.545093647208;15215.467458638894;7533.585652789039;7640.617969101522;7964.920350796418;8120.309773669186;8403.579821008925;7693.153753087156;8108.8378232435025;8175;8380.24577788002;8387.580620968927;4511.639068874482;4578.084383123389;4604.148232576984;4718.245080787126;4820.590249828804;1830.2221555838714;1898.5348589595637;1929.977112130573;1932.285054529833;1964.9017549122486;950.6910254167424;990.3810118675827;1010.2675560218782;1041.8385150301715;1055.4195192644015;19558.5110372239;19999.600007999758;20045.198192072156;20186.596268074558;20219.494512637302;1027.3938376357985;1045.5713157605346;1052.315994603514;1054.478033373485;1087.6138970665459;10443.68668939933;11109.388983605979;11123.388213648326;11132.10943124548;11191.272567283264;491497;512024;523853;525329;527372;55516.444835551934;66513;84491.57754211313;88415.55792220998;90165;957.8228027814877;978.6819283732815;994.9702058369553;1010.0808264479435;1013.0376142664499;16558;17186.742198866777;17410;17466.039367834892;17474.12629368552;39216.411753824286;40366.59633403746;40717;40855;41074;49857.252141217185;51292.74353628208;54119;54469.1829622548;54856;8205;8383.287420569077;8446.788830279293;8526.701565445179;8679.34904882149;12460.501579936701;13398.196108233537;13440.596782096552;13492;13637.113587616774;11396.544138234378;11416.94291528537;11770.117241206772;11819.940900295443;11904.464299106734;10877.51051202682;10958.397288149228;10986.121110311316;11203.943980280046;11321.320720756781;11064.28082174656;11168.553257869595;11545.018673412518;11731.178817482694;11896.167268291136;8243.505389676639;8328.791780205544;8428.199321064489;8445.915540844759;8478.57607119654;8508.659653613786;10208.693739187836;10921.56313747473;11405.600803971822;11751.177417580688 17:36:37 INFO - PROCESS | 8086 | |3;mootools.html;1511.229273070734;1515.3181068519166;1664.3009935826951;1735.2885317020025;1792.9641407171857;7817.570033648161;8375.581220938951;8422.78943026423;8979.775505612362;9009.054049324817;8518.531480768555;8753.3872628916;8784.64861405543;8786.736397908056;8789.384743067987;2370.3955491349725;2409.5421869844763;2411.493586346869;2413.529361774446;2421.188901717918;2289.3132060381904;2319.18828410056;2321.8722970236713;2329.184785325131;2338.777816107467;2246.2025980776834;2279.7378301495373;2283.383486458655;2320.3503019154577;2355.422921384263;2269.341890851651;2280.1791355112146;2288.4050146961827;2291.51878105598;2311.838171328008;2239.585676649825;2261.6720575516624;2262.886855657227;2265.399669087693;2266.5466906618744;8941.50821704806;8973.865392019125;9021.458712477206;9048.547572621408;9049.321300902393;5242.23987521811;5365.06111430502;5373.838784836461;5390;5391.595630327741;3326.916827079318;3331.267121233325;3547.396942519752;3549.769264997767;3553.4136867416846;1040.3861721584226;1074.4412905289284;1090.650991682662;1103.9282446640943;1104.596822159914;12042.277463352139;12104.697382565506;12244.387780610934;12270.44782984759;12397;4397.846075387346;4626.190416677068;4654.348391225163;4739.549742774431;4756.9286460703115;10386.636467723745;10396.58413663445;10400.375977441226;10405.427701476492;10412.68761937143;5308.442613525602;5318.813841515528;5332.520073193354;5338.519533242027;5346.4118946915805;4329.134173165379;4745;4890.657653964188;4910.091633047826;4921.434035086011;3940.842366305373;4057.5739547347102;4087;4154.750714957112;4180.414741936132;1324.8865166857806;1328.7940369242783;1341.631051460856;1342.335543905773;1343.1202562321696;897.4615230861431;916.1434059154711;981.3915372469115;1013.5489707080278;1038.9896101038894;5890.410958904075;5907.497862681635;6033;6078.45293923549;6142.324344322121;450.4864454521848;451.11356185095786;452.79397873967264;458.36516424751295;458.43383421474454;4184.560621134798;4226.302660061117;4232.3016702243785;4261.062566235423;4278.529361770203;10509.159267258601;10754.73113172177;10808.567657293777;10819.621313253998;10828.350298982086;10005.49972501372;10767.730806729895;10817.459127043616;10843.349399035926;10858.728531786768;8155.469894456842;8234.547099909563;8261.8347633047;8283.710070147636;8316.584170791315;5961.940380596312;6110.969445152746;6174.506039516738;6214.130021797043;6394.1687580614225;9818.361806482555;10192.949035254776;10214.285000049926;10288.2798204125;10376.429296388771;10367.533460994424;10439.217058720475;10527.789444211227;10555.472226388496;10559.63041293551;7531.133919599316;7698.2686644768655;7709.768706938801;7723.845523089619;7736.574488403192;8674.30605551567;8698.347623928104;8790.164934331227;8807.383483156118;8831.735047948572;7628.618569071413;7703.460757746904;7870.724524641839;8036.316913062456;8059.355251579742;7678.731244406419;7762.534247945141;7821.726239581815;7902.367810575025;7974.800629984296;7096.574205547684;7167.104111986002;7219.566825990458;7222.494425390172;7263.0921134858145;5115.437301896863;5214.921776173284;5225.895482090261;5271.78912843482;5470.152126420411;5241;5266.315379000858;5273.261743355856;5321.54766844807;5485.122380419114 17:36:37 INFO - PROCESS | 8086 | |4;prototype.html;325.33306721221504;328.983550822459;329.3133815993653;336.76594766637197;339.3078120633907;5337.6797392156495;5419.647722898009;5568.443155684429;5568.582356323277;5584.9720751396235;5417.83286685325;5463.2078348639425;5464.480874316943;5470.671759694421;5486.271824375319;4293.29522400887;4296.785160741966;4305;4311.676624253178;4320.740755554677;4188.5811418858175;4300.354946757996;4305.978470107645;4323.913521729563;4341.956580434186;4303.720258183208;4307.375430562583;4314.201872653553;4321.891952701176;4325.610695037446;4279.443672322594;4324.243257429937;4330.372096046056;4334.934975975363;4370.409994650745;3569.0006798096574;3816.9618303816883;3835.712321575893;3842.769433833979;3844.6539811417106;5338.946610533883;5363.919541206885;5365.543928766059;5374.48942350476;5379.784808607651;4898.681585696918;4898.804047838083;4899.510048995107;4923.77842997066;4929.580985616227;5491.615586908918;5752.741126649311;5773.769049238025;5790.826275211751;5801.158831969383;4049.6355328020327;4050.392441133824;4056.7565946043037;4061.939070913939;4079.3676980068135;5983.115318674647;6014.548908831855;6048.243969503812;6050.757969681207;6056.152138700585;4060.4164375893424;4131.5455299916985;4138.213739389506;4192.140611174702;4193.266178418765;4219.945013746564;4221.2190744712325;4224.281872081753;4232.4286221360335;4241.766702831313;4853.417589889236;4867.732274724854;4873.561379475864;4875.756212189447;4889.48660390661;5624.200255918149;5754.712264386764;5798.6810725410505;5834.883302333929;5851.941480585225;1374.8144000559796;1413.6748547834056;1443.6968236670416;1445.7686770116732;1454.9490767823074;951.2390087929629;970.2141265574766;988.5650313861878;991.6182269826169;993.5231089077283;5473.808416705396;5490.121580547093;5524.613277070647;5526.364468086141;5536.2249285100115;5872.677002764889;5876.588638795329;5878.5297176225795;5933.1903769350765;5947.464728174485;5373.328333958255;5509.504144626922;5570.6657600544095;5649.802256920988;5654.773809047674;3178.8251646159683;3203.583534140547;3207.550942868;3209.293955329824;3212.646608873022;6026.216591843032;6149.7847575334645;6170.938290617126;6237.906431403532;6257.311695713468;6079.7777178095685;6120.17377654011;6120.387961203844;6121.081837724288;6169.383061693795;6189.907151392643;6199.070139479024;6229.53278504114;6250.249970003538;6254.123762871121;5860.560457965585;5886.646801191942;5975.970120149372;5980.697431488821;5982.49148822355;5928.34788173292;5946.613470124428;5968.791092311748;5972.940270597239;5988.191594134736;6077.787277445268;6124.590294987602;6236.34518375564;6251.874962500634;6269.868244796791;4181.60274773896;4181.958180418157;4182.937255941102;4188.602082802129;4194.077302993336;5774.960507108761;5815.79644712433;6001.609895356788;6002.538959026778;6013.977623803877;5753.647892745118;5801.158831969426;5803.129530570448;5822.534197264294;5826.883462330815;5786.132080188006;5806.954748145375;5844.181814545882;5853.678047707247;5873.9412605873395;5554.111861831744;5715.685637289989;5737.713114344349;5777.62445441045;5778.104393818965;5785.566082543742;5838.481994681499;5840.2115714378015;5849.766009359578;5898.02416190581;5438.401775804579;5691.971540142273;5707.429257074259;5733.713314334183;5757.683327417032 17:36:37 INFO - PROCESS | 8086 | |5;yui.html;760.7109298466581;793.1513280789558;824.8515267251893;829.9543525106119;874.9518776467294;15850.286737096829;16647.50057498277;17043.744343834853;17107.828921710796;17139.400120995768;15493.612659683513;15525.378984840621;15553.533393998197;15554.300056497457;15554.766678499831;656.0061506817176;796.6773456750011;810.623060276971;814.5560669435142;815.5188438821094;781.0939310399938;799.6201804143014;802.3500964218972;802.5545822068749;808.2806302390848;830.1366578758084;831.538496134645;834.2075028722708;835.3484282259817;836.7071524966274;817.9304759095484;824.1922915542742;826.7685048186457;826.8511667899776;827.6317038917684;600.2077258019416;600.5015836855399;601.1463721515415;602.9638221706712;605.3522730678176;15376.384944602203;15412.768808467881;15478.380864765395;15490.767638485431;15520.689586208213;14183.865290776714;14337.283135843167;14410.92794536031;14566.635834104232;14599.78100328496;11938.343391113485;12163.148579599432;12238.020958323314;12238.694032649255;12294.569690060895;3779.574573951984;3935.803209839525;3936.2717897188827;3953.071028308374;4016.6385025347568;77960.22039779586;78353.21646783574;78568.60715696443;79396.60301698513;79410;11218;11361.37512436824;11441.542338306375;11616.825747613793;11782.5876094338;20167.798322016886;20176.69734953977;20268.391948241577;20353;20399.694004589943;8082.83834323322;8126.634301456449;8142.552159631158;8144.837103257902;8343.123971982975;4613.440803831375;4626.097910907408;4660.4174478190225;4661.137689527381;4720.268358404453;3165.572647692578;3281.8194999274792;3315.1380641033506;3315.93368132636;3317.834108294576;607.9483243924227;618.3661746709658;626.4143026270451;634.0869148426251;642.6304874697067;674.1842370731372;707.2609123465991;708.6102643546029;742.4617152564456;761.8133557278392;8895.555222238992;9343.392679475948;9660.178884794872;9675;9835.52467129922;721.4300702445114;761.170324346465;771.182546500711;776.6582703610393;784.4391260248835;4650.09323181983;4696.1546921554445;4718.386609740712;4808.927866082012;4832.420109586872;101330.49334753427;124016.37991809983;128072;131559;135644.6088847767;109217.45391273152;111234.88208148467;113085;113940.29089563663;116332.41833790777;70443;81194.59402703067;85450;87902.99999999872;96534.51732741292;9853.802923941337;9923.751906202402;10176.389416635026;10343.63797267092;10346;51079.233811492115;51363;52069.739651301505;52170.739146304026;53674.73162634318;66307.33692663205;66792.33207668056;72094.63952680203;72916;74896.62551687207;12738.808917866425;12810.871891280967;12855.16441431304;12880.42038108306;13524.18854868711;15241.923790380977;15320.157391343582;15956.441524546584;16162.838371616133;16697.332106715596;13066;13449.260290684106;13833.170009799444;13854.584362469142;13895.58313250604;13060.673483162996;13543.560549611055;13589.524366647516;14779.408823646934;14846.77729834075;13192;13570;13574.04981651275;13835.169889806644;14023.579292621238;12114.75770484603;12155.331456769962;12304;12318.753624927273;12561.811572826598;10531.57873685044;10970.890291096986;11788.70528236801;12478.87521124777;12712.491500339884 17:36:37 INFO - PROCESS | 8086 | __end_tp_report 17:36:37 INFO - PROCESS | 8086 | __start_cc_report 17:36:37 INFO - PROCESS | 8086 | _x_x_mozilla_cycle_collect,321 17:36:37 INFO - PROCESS | 8086 | __end_cc_report 17:36:37 INFO - PROCESS | 8086 | __startTimestamp1470443797060__endTimestamp 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | ------- Summary: start ------- 17:36:37 INFO - PROCESS | 8086 | Number of tests: 6 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | [#0] dojo.html Cycles:165 Average:5356.20 Median:5600.13 stddev:611.07 (10.9%) stddev-sans-first:586.86 17:36:37 INFO - PROCESS | 8086 | Values: 3104.5 3106.3 3127.5 3133.0 3134.7 5313.0 5358.9 5409.1 5447.8 5488.1 5306.9 5338.8 5385.9 5392.5 5416.2 4647.4 4882.7 4913.9 4957.2 5060.5 4992.2 4999.4 5006.9 5051.0 5057.0 4780.4 4803.7 4928.0 4961.7 4974.2 4815.6 4870.1 4885.4 4905.0 4912.6 4794.2 4849.6 4862.3 4881.4 4897.8 5240.5 5266.1 5327.3 5344.3 5379.4 5659.0 5742.0 5743.0 5770.6 5782.7 5752.5 5758.0 5761.9 5776.3 5789.4 5211.0 5268.9 5356.9 5357.7 5379.2 5825.6 5887.3 5903.2 5914.4 5934.0 5650.9 5651.5 5652.9 5655.2 5666.7 5650.6 5651.6 5749.9 5761.2 5769.7 5657.7 5695.3 5719.2 5763.6 5772.5 5658.4 5673.4 5693.5 5719.7 5743.7 4335.1 4366.8 4384.6 4401.8 4449.1 3899.0 3911.6 3958.3 3959.9 3962.6 5470.8 5482.0 5514.9 5523.5 5524.5 5668.0 5755.4 5840.7 5849.2 5850.2 5418.9 5445.2 5525.2 5545.0 5556.3 4963.2 4975.6 4980.1 4982.7 4984.8 5863.7 5908.0 6063.4 6066.6 6083.8 5723.3 5780.9 5812.0 5854.6 5859.3 5965.3 6003.5 6008.8 6010.4 6012.6 5604.3 5655.1 5656.1 5695.7 5712.2 5791.0 5816.8 5840.5 5845.2 5899.2 5687.6 5688.7 5693.1 5694.6 5704.3 5501.0 5557.7 5622.4 5657.3 5659.9 5567.2 5608.9 5626.1 5639.2 5653.8 5619.0 5712.7 5720.9 5729.6 5735.9 5382.1 5430.4 5440.2 5581.2 5600.1 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | [#1] ext.html Cycles:180 Average:59648.44 Median:42921.57 stddev:119712.01 (278.9%) stddev-sans-first:119965.61 17:36:37 INFO - PROCESS | 8086 | Values: 553.7 595.4 598.6 611.1 637.3 40161.0 44138.8 44280.1 44387.0 44614.3 44511.3 44808.0 44882.3 45145.8 45200.5 8990.7 9132.6 9151.5 9159.3 9161.7 8968.1 9142.3 9147.9 9151.5 9189.3 9186.1 9231.0 9248.1 9269.1 9293.2 9127.2 9171.9 9231.0 9233.1 9234.7 8938.4 9012.9 9028.5 9039.5 9056.5 42422.4 42613.8 42655.4 42774.4 42902.4 3687.5 3722.2 3776.4 3919.5 3920.9 33501.2 33733.8 33790.2 33804.0 35537.3 4316.6 4331.3 4363.3 4469.4 4507.4 249720.0 249723.0 249872.0 250213.0 250484.0 59673.4 60520.7 60810.7 60981.1 61025.4 37011.4 37537.2 37818.8 39796.0 40160.2 16732.2 16843.9 16905.2 16922.7 16957.7 12808.9 12841.7 12902.4 12904.3 12907.9 19592.2 19797.0 19839.0 19873.9 19874.3 7223.6 7430.4 7539.7 7630.1 7688.0 1030.8 1094.5 1136.0 1149.7 1157.1 33324.2 33930.0 34278.7 34352.3 34600.7 1134.1 1148.8 1167.8 1215.5 1221.5 17844.6 17856.4 17919.4 17957.7 18036.7 565622.0 571015.0 573955.0 577705.0 578761.0 60560.4 60819.4 60939.4 61042.0 61240.0 1342.9 1350.5 1382.7 1388.2 1391.1 32619.7 33760.7 33821.0 34140.0 34157.0 54924.7 54962.5 55067.2 55180.4 55305.4 463212.0 463421.0 463499.0 465725.0 465821.0 30337.0 30439.8 30476.7 30779.2 30857.1 49766.0 49924.3 50041.5 51476.0 51756.0 42033.0 43203.0 43779.3 44849.3 44902.3 42186.2 42955.9 43162.1 44283.6 44602.6 42430.2 42747.1 42890.1 42940.8 43174.6 36178.3 37663.4 38115.4 38204.0 38960.0 29288.1 29329.3 29403.9 29431.7 29530.3 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | [#2] jquery.html Cycles:180 Average:28696.29 Median:2589.49 stddev:84661.93 (3269.4%) stddev-sans-first:84872.73 17:36:37 INFO - PROCESS | 8086 | Values: 380.6 387.6 390.8 395.5 404.4 18698.5 20217.9 20287.0 20491.8 20891.5 18858.9 19001.8 19459.2 19471.1 19608.4 5142.4 5171.5 5285.2 5322.3 5337.6 5212.9 5294.4 5330.1 5330.3 5341.9 5291.4 5306.5 5707.0 5712.6 5741.5 5733.7 5744.6 5759.2 5762.0 5763.4 5107.6 5378.5 5420.9 5456.6 5459.5 13601.5 13643.4 13661.7 13669.9 13777.2 2293.2 2310.7 2488.7 2690.3 2746.9 9751.0 10034.7 10090.2 10283.7 10513.0 1823.5 1927.9 1947.4 1954.9 1963.3 75025.6 76139.0 76470.6 76691.2 78615.0 10736.9 10809.3 10843.9 11077.5 11110.2 14951.6 15076.7 15151.3 15163.5 15215.5 7533.6 7640.6 7964.9 8120.3 8403.6 7693.2 8108.8 8175.0 8380.2 8387.6 4511.6 4578.1 4604.1 4718.2 4820.6 1830.2 1898.5 1930.0 1932.3 1964.9 950.7 990.4 1010.3 1041.8 1055.4 19558.5 19999.6 20045.2 20186.6 20219.5 1027.4 1045.6 1052.3 1054.5 1087.6 10443.7 11109.4 11123.4 11132.1 11191.3 491497.0 512024.0 523853.0 525329.0 527372.0 55516.4 66513.0 84491.6 88415.6 90165.0 957.8 978.7 995.0 1010.1 1013.0 16558.0 17186.7 17410.0 17466.0 17474.1 39216.4 40366.6 40717.0 40855.0 41074.0 49857.3 51292.7 54119.0 54469.2 54856.0 8205.0 8383.3 8446.8 8526.7 8679.3 12460.5 13398.2 13440.6 13492.0 13637.1 11396.5 11416.9 11770.1 11819.9 11904.5 10877.5 10958.4 10986.1 11203.9 11321.3 11064.3 11168.6 11545.0 11731.2 11896.2 8243.5 8328.8 8428.2 8445.9 8478.6 8508.7 10208.7 10921.6 11405.6 11751.2 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | [#3] mootools.html Cycles:180 Average:5838.39 Median:455.58 stddev:3315.17 (727.7%) stddev-sans-first:3308.53 17:36:37 INFO - PROCESS | 8086 | Values: 1511.2 1515.3 1664.3 1735.3 1793.0 7817.6 8375.6 8422.8 8979.8 9009.1 8518.5 8753.4 8784.6 8786.7 8789.4 2370.4 2409.5 2411.5 2413.5 2421.2 2289.3 2319.2 2321.9 2329.2 2338.8 2246.2 2279.7 2283.4 2320.4 2355.4 2269.3 2280.2 2288.4 2291.5 2311.8 2239.6 2261.7 2262.9 2265.4 2266.5 8941.5 8973.9 9021.5 9048.5 9049.3 5242.2 5365.1 5373.8 5390.0 5391.6 3326.9 3331.3 3547.4 3549.8 3553.4 1040.4 1074.4 1090.7 1103.9 1104.6 12042.3 12104.7 12244.4 12270.4 12397.0 4397.8 4626.2 4654.3 4739.5 4756.9 10386.6 10396.6 10400.4 10405.4 10412.7 5308.4 5318.8 5332.5 5338.5 5346.4 4329.1 4745.0 4890.7 4910.1 4921.4 3940.8 4057.6 4087.0 4154.8 4180.4 1324.9 1328.8 1341.6 1342.3 1343.1 897.5 916.1 981.4 1013.5 1039.0 5890.4 5907.5 6033.0 6078.5 6142.3 450.5 451.1 452.8 458.4 458.4 4184.6 4226.3 4232.3 4261.1 4278.5 10509.2 10754.7 10808.6 10819.6 10828.4 10005.5 10767.7 10817.5 10843.3 10858.7 8155.5 8234.5 8261.8 8283.7 8316.6 5961.9 6111.0 6174.5 6214.1 6394.2 9818.4 10192.9 10214.3 10288.3 10376.4 10367.5 10439.2 10527.8 10555.5 10559.6 7531.1 7698.3 7709.8 7723.8 7736.6 8674.3 8698.3 8790.2 8807.4 8831.7 7628.6 7703.5 7870.7 8036.3 8059.4 7678.7 7762.5 7821.7 7902.4 7974.8 7096.6 7167.1 7219.6 7222.5 7263.1 5115.4 5214.9 5225.9 5271.8 5470.2 5241.0 5266.3 5273.3 5321.5 5485.1 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | [#4] prototype.html Cycles:180 Average:4876.47 Median:5545.17 stddev:1448.94 (26.1%) stddev-sans-first:1412.16 17:36:37 INFO - PROCESS | 8086 | Values: 325.3 329.0 329.3 336.8 339.3 5337.7 5419.6 5568.4 5568.6 5585.0 5417.8 5463.2 5464.5 5470.7 5486.3 4293.3 4296.8 4305.0 4311.7 4320.7 4188.6 4300.4 4306.0 4323.9 4342.0 4303.7 4307.4 4314.2 4321.9 4325.6 4279.4 4324.2 4330.4 4334.9 4370.4 3569.0 3817.0 3835.7 3842.8 3844.7 5338.9 5363.9 5365.5 5374.5 5379.8 4898.7 4898.8 4899.5 4923.8 4929.6 5491.6 5752.7 5773.8 5790.8 5801.2 4049.6 4050.4 4056.8 4061.9 4079.4 5983.1 6014.5 6048.2 6050.8 6056.2 4060.4 4131.5 4138.2 4192.1 4193.3 4219.9 4221.2 4224.3 4232.4 4241.8 4853.4 4867.7 4873.6 4875.8 4889.5 5624.2 5754.7 5798.7 5834.9 5851.9 1374.8 1413.7 1443.7 1445.8 1454.9 951.2 970.2 988.6 991.6 993.5 5473.8 5490.1 5524.6 5526.4 5536.2 5872.7 5876.6 5878.5 5933.2 5947.5 5373.3 5509.5 5570.7 5649.8 5654.8 3178.8 3203.6 3207.6 3209.3 3212.6 6026.2 6149.8 6170.9 6237.9 6257.3 6079.8 6120.2 6120.4 6121.1 6169.4 6189.9 6199.1 6229.5 6250.2 6254.1 5860.6 5886.6 5976.0 5980.7 5982.5 5928.3 5946.6 5968.8 5972.9 5988.2 6077.8 6124.6 6236.3 6251.9 6269.9 4181.6 4182.0 4182.9 4188.6 4194.1 5775.0 5815.8 6001.6 6002.5 6014.0 5753.6 5801.2 5803.1 5822.5 5826.9 5786.1 5807.0 5844.2 5853.7 5873.9 5554.1 5715.7 5737.7 5777.6 5778.1 5785.6 5838.5 5840.2 5849.8 5898.0 5438.4 5692.0 5707.4 5733.7 5757.7 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - PROCESS | 8086 | [#5] yui.html Cycles:180 Average:21497.03 Median:3944.67 stddev:31709.57 (803.9%) stddev-sans-first:31760.30 17:36:37 INFO - PROCESS | 8086 | Values: 760.7 793.2 824.9 830.0 875.0 15850.3 16647.5 17043.7 17107.8 17139.4 15493.6 15525.4 15553.5 15554.3 15554.8 656.0 796.7 810.6 814.6 815.5 781.1 799.6 802.4 802.6 808.3 830.1 831.5 834.2 835.3 836.7 817.9 824.2 826.8 826.9 827.6 600.2 600.5 601.1 603.0 605.4 15376.4 15412.8 15478.4 15490.8 15520.7 14183.9 14337.3 14410.9 14566.6 14599.8 11938.3 12163.1 12238.0 12238.7 12294.6 3779.6 3935.8 3936.3 3953.1 4016.6 77960.2 78353.2 78568.6 79396.6 79410.0 11218.0 11361.4 11441.5 11616.8 11782.6 20167.8 20176.7 20268.4 20353.0 20399.7 8082.8 8126.6 8142.6 8144.8 8343.1 4613.4 4626.1 4660.4 4661.1 4720.3 3165.6 3281.8 3315.1 3315.9 3317.8 607.9 618.4 626.4 634.1 642.6 674.2 707.3 708.6 742.5 761.8 8895.6 9343.4 9660.2 9675.0 9835.5 721.4 761.2 771.2 776.7 784.4 4650.1 4696.2 4718.4 4808.9 4832.4 101330.5 124016.4 128072.0 131559.0 135644.6 109217.5 111234.9 113085.0 113940.3 116332.4 70443.0 81194.6 85450.0 87903.0 96534.5 9853.8 9923.8 10176.4 10343.6 10346.0 51079.2 51363.0 52069.7 52170.7 53674.7 66307.3 66792.3 72094.6 72916.0 74896.6 12738.8 12810.9 12855.2 12880.4 13524.2 15241.9 15320.2 15956.4 16162.8 16697.3 13066.0 13449.3 13833.2 13854.6 13895.6 13060.7 13543.6 13589.5 14779.4 14846.8 13192.0 13570.0 13574.0 13835.2 14023.6 12114.8 12155.3 12304.0 12318.8 12561.8 10531.6 10970.9 11788.7 12478.9 12712.5 17:36:37 INFO - PROCESS | 8086 | -------- Summary: end -------- 17:36:37 INFO - PROCESS | 8086 | 17:36:37 INFO - TEST-INFO | 8086: exit 0 17:36:37 INFO - TEST-OK | dromaeo_css | took 1112977ms 17:36:37 INFO - TEST-START | kraken 17:36:37 INFO - operating with platform_type : linux_ 17:36:37 INFO - Initialising browser for kraken test... 17:36:37 INFO - TEST-INFO | started process 8337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FK_W7/profile http://localhost:35964/getInfo.html) 17:36:42 INFO - PROCESS | 8337 | __metrics Screen width/height:1600/1200 17:36:42 INFO - PROCESS | 8337 | colorDepth:24 17:36:42 INFO - PROCESS | 8337 | Browser inner width/height: 1024/697 17:36:42 INFO - PROCESS | 8337 | __metrics 17:36:42 ERROR - PROCESS | 8337 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:36:43 INFO - TEST-INFO | 8337: exit 0 17:36:43 INFO - Browser initialized. 17:36:43 INFO - Running cycle 1/1 for kraken test... 17:36:43 INFO - TEST-INFO | started process 8459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FK_W7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:55 INFO - PROCESS | 8459 | RSS: Main: 164253696 17:36:55 INFO - PROCESS | 8459 | 17:36:57 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35964/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:58 INFO - PROCESS | 8459 | RSS: Main: 169525248 17:36:58 INFO - PROCESS | 8459 | 17:37:01 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35964/tests/kraken/driver.html?testName=audio-dft) 17:37:02 INFO - PROCESS | 8459 | RSS: Main: 169271296 17:37:02 INFO - PROCESS | 8459 | 17:37:04 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35964/tests/kraken/driver.html?testName=audio-fft) 17:37:05 INFO - PROCESS | 8459 | RSS: Main: 164397056 17:37:05 INFO - PROCESS | 8459 | 17:37:07 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35964/tests/kraken/driver.html?testName=audio-oscillator) 17:37:08 INFO - PROCESS | 8459 | RSS: Main: 165597184 17:37:08 INFO - PROCESS | 8459 | 17:37:10 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:11 INFO - PROCESS | 8459 | RSS: Main: 166100992 17:37:11 INFO - PROCESS | 8459 | 17:37:14 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35964/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:14 INFO - PROCESS | 8459 | RSS: Main: 166416384 17:37:14 INFO - PROCESS | 8459 | 17:37:18 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35964/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:18 INFO - PROCESS | 8459 | RSS: Main: 163819520 17:37:18 INFO - PROCESS | 8459 | 17:37:21 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35964/tests/kraken/driver.html?testName=json-parse-financial) 17:37:22 INFO - PROCESS | 8459 | RSS: Main: 165482496 17:37:22 INFO - PROCESS | 8459 | 17:37:23 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:24 INFO - PROCESS | 8459 | RSS: Main: 165765120 17:37:24 INFO - PROCESS | 8459 | 17:37:26 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:26 INFO - PROCESS | 8459 | RSS: Main: 165765120 17:37:26 INFO - PROCESS | 8459 | 17:37:28 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:29 INFO - PROCESS | 8459 | RSS: Main: 166277120 17:37:29 INFO - PROCESS | 8459 | 17:37:32 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:33 INFO - PROCESS | 8459 | RSS: Main: 166342656 17:37:33 INFO - PROCESS | 8459 | 17:37:35 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:36 INFO - PROCESS | 8459 | RSS: Main: 166457344 17:37:36 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | Cycle 1(1): loaded http://localhost:35964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35964/tests/kraken/driver.html?testName=ai-astar) 17:37:38 INFO - PROCESS | 8459 | RSS: Main: 167501824 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | __start_tp_report 17:37:38 INFO - PROCESS | 8459 | _x_x_mozilla_page_load 17:37:38 INFO - PROCESS | 8459 | _x_x_mozilla_page_load_details 17:37:38 INFO - PROCESS | 8459 | |i|pagename|runs| 17:37:38 INFO - PROCESS | 8459 | |0;ai-astar;102;112;108;114;112;114;113;113;114;111 17:37:38 INFO - PROCESS | 8459 | |1;audio-beat-detection;150;119;149;179;120;146;143;125;181;119 17:37:38 INFO - PROCESS | 8459 | |2;audio-dft;160;161;163;161;160;168;167;162;161;162 17:37:38 INFO - PROCESS | 8459 | |3;audio-fft;75;74;75;172;78;75;75;76;171;77 17:37:38 INFO - PROCESS | 8459 | |4;audio-oscillator;84;84;156;85;83;84;146;85;83;143 17:37:38 INFO - PROCESS | 8459 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;118;119 17:37:38 INFO - PROCESS | 8459 | |6;imaging-darkroom;147;147;148;148;148;147;147;147;147;146 17:37:38 INFO - PROCESS | 8459 | |7;imaging-desaturate;95;96;96;95;95;95;95;96;96;95 17:37:38 INFO - PROCESS | 8459 | |8;json-parse-financial;50;51;51;51;54;54;56;51;51;52 17:37:38 INFO - PROCESS | 8459 | |9;json-stringify-tinderbox;62;62;62;62;62;63;61;63;62;63 17:37:38 INFO - PROCESS | 8459 | |10;stanford-crypto-aes;76;75;82;82;76;78;76;76;88;78 17:37:38 INFO - PROCESS | 8459 | |11;stanford-crypto-ccm;130;124;124;144;125;123;135;124;135;137 17:37:38 INFO - PROCESS | 8459 | |12;stanford-crypto-pbkdf2;162;162;160;168;163;169;164;160;162;161 17:37:38 INFO - PROCESS | 8459 | |13;stanford-crypto-sha256-iterative;66;66;65;64;65;66;65;63;64;65 17:37:38 INFO - PROCESS | 8459 | __end_tp_report 17:37:38 INFO - PROCESS | 8459 | __start_cc_report 17:37:38 INFO - PROCESS | 8459 | _x_x_mozilla_cycle_collect,848 17:37:38 INFO - PROCESS | 8459 | __end_cc_report 17:37:38 INFO - PROCESS | 8459 | __startTimestamp1470443858346__endTimestamp 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | ------- Summary: start ------- 17:37:38 INFO - PROCESS | 8459 | Number of tests: 14 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.74 (3.3%) stddev-sans-first:1.94 17:37:38 INFO - PROCESS | 8459 | Values: 102.0 112.0 108.0 114.0 112.0 114.0 113.0 113.0 114.0 111.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:147.50 stddev:23.19 (15.7%) stddev-sans-first:24.46 17:37:38 INFO - PROCESS | 8459 | Values: 150.0 119.0 149.0 179.0 120.0 146.0 143.0 125.0 181.0 119.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.80 (1.7%) stddev-sans-first:2.82 17:37:38 INFO - PROCESS | 8459 | Values: 160.0 161.0 163.0 161.0 160.0 168.0 167.0 162.0 161.0 162.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:40.44 (53.9%) stddev-sans-first:42.26 17:37:38 INFO - PROCESS | 8459 | Values: 75.0 74.0 75.0 172.0 78.0 75.0 75.0 76.0 171.0 77.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:31.25 (37.2%) stddev-sans-first:32.35 17:37:38 INFO - PROCESS | 8459 | Values: 84.0 84.0 156.0 85.0 83.0 84.0 146.0 85.0 83.0 143.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 17:37:38 INFO - PROCESS | 8459 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 119.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:37:38 INFO - PROCESS | 8459 | Values: 147.0 147.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 146.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:37:38 INFO - PROCESS | 8459 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:51.50 stddev:1.91 (3.7%) stddev-sans-first:1.87 17:37:38 INFO - PROCESS | 8459 | Values: 50.0 51.0 51.0 51.0 54.0 54.0 56.0 51.0 51.0 52.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 17:37:38 INFO - PROCESS | 8459 | Values: 62.0 62.0 62.0 62.0 62.0 63.0 61.0 63.0 62.0 63.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:4.11 (5.3%) stddev-sans-first:4.24 17:37:38 INFO - PROCESS | 8459 | Values: 76.0 75.0 82.0 82.0 76.0 78.0 76.0 76.0 88.0 78.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:132.50 stddev:7.28 (5.5%) stddev-sans-first:7.72 17:37:38 INFO - PROCESS | 8459 | Values: 130.0 124.0 124.0 144.0 125.0 123.0 135.0 124.0 135.0 137.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:162.50 stddev:3.11 (1.9%) stddev-sans-first:3.27 17:37:38 INFO - PROCESS | 8459 | Values: 162.0 162.0 160.0 168.0 163.0 169.0 164.0 160.0 162.0 161.0 17:37:38 INFO - PROCESS | 8459 | 17:37:38 INFO - PROCESS | 8459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 17:37:38 INFO - PROCESS | 8459 | Values: 66.0 66.0 65.0 64.0 65.0 66.0 65.0 63.0 64.0 65.0 17:37:38 INFO - PROCESS | 8459 | -------- Summary: end -------- 17:37:38 INFO - PROCESS | 8459 | 17:37:39 INFO - TEST-INFO | 8459: exit 0 17:37:39 INFO - TEST-OK | kraken | took 61570ms 17:37:39 INFO - SUITE-END | took 1174s 17:37:39 INFO - Completed test suite (00:19:34) 17:37:39 INFO - javascript benchmark 17:37:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7297.7982491126395, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.4877595196795, 3106.285554322506, 3127.5152351385527, 3133.0444214514573, 3134.702203290688, 5313.043652142613, 5358.919616205755, 5409.107497262957, 5447.809326673567, 5488.121900495921, 5306.867328316794, 5338.759755810988, 5385.865353366158, 5392.460753924605, 5416.214648875921, 4647.372604698373, 4882.658213925018, 4913.926291105637, 4957.206846904496, 5060.493950604929, 4992.151334273182, 4999.350084489011, 5006.924896126543, 5050.974745126287, 5057.0, 4780.378550788375, 4803.711777293373, 4927.999999999982, 4961.652684312099, 4974.179260422026, 4815.614750819961, 4870.123377791996, 4885.389326334208, 4905.0, 4912.582430493412, 4794.232922732346, 4849.612031037508, 4862.294967229767, 4881.365422495089, 4897.828575999859, 5240.475952404767, 5266.104762190437, 5327.334083239595, 5344.278522399465, 5379.38137114233, 5658.971705141489, 5742.0, 5742.97128514359, 5770.567207459458, 5782.681952492611, 5752.539796816244, 5757.992351338499, 5761.884762304772, 5776.277965254343, 5789.363170051291, 5210.97394513025, 5268.868278292996, 5356.946430535684, 5357.705326207057, 5379.220013098079, 5825.563082768809, 5887.293524777054, 5903.2325797646035, 5914.438128377883, 5934.0, 5650.915236271459, 5651.463111004448, 5652.943470565324, 5655.1799989001365, 5666.744996475169, 5650.576206784508, 5651.632643878217, 5749.88500229993, 5761.222234998221, 5769.68266745333, 5657.717114144359, 5695.259616249861, 5719.19931209631, 5763.567732420001, 5772.509336706343, 5658.434156584309, 5673.404292549306, 5693.516051135617, 5719.742611582489, 5743.655380677173, 4335.1329734053315, 4366.8034938427845, 4384.583464570925, 4401.779911004501, 4449.13241917823, 3899.025243689078, 3911.647951684362, 3958.267720471722, 3959.8614048508166, 3962.623550762673, 5470.835874923759, 5481.972590137104, 5514.862128446741, 5523.530499907552, 5524.502794748492, 5668.008098582732, 5755.424457554211, 5840.707964601753, 5849.210356601804, 5850.180974663551, 5418.91871621926, 5445.210444485607, 5525.171224316385, 5545.029619816516, 5556.305461817273, 4963.156263435225, 4975.601951843843, 4980.12847751642, 4982.651214415028, 4984.800607975713, 5863.73613187399, 5907.9704601476715, 6063.393660633901, 6066.636001839904, 6083.847903802441, 5723.3418156912485, 5780.884382312414, 5812.0, 5854.648721076749, 5859.326177489644, 5965.34381218057, 6003.519718422603, 6008.819735407945, 6010.429009244115, 6012.579119461596, 5604.271444712162, 5655.066913959151, 5656.066748986371, 5695.715214239354, 5712.228849105318, 5791.044477661138, 5816.82549523515, 5840.503557197516, 5845.240118784531, 5899.233099697012, 5687.573431992534, 5688.658680479184, 5693.060644993529, 5694.572907031907, 5704.3154821421695, 5500.9823182711325, 5557.722113894209, 5622.353429355513, 5657.264555607745, 5659.85850353728, 5567.164925261243, 5608.85977850557, 5626.127950167731, 5639.154126881001, 5653.830385088454, 5619.044762390322, 5712.742926568398, 5720.942790572041, 5729.570282228933, 5735.885282294247, 5382.138857782736, 5430.42980487059, 5440.156775699773, 5581.190727344431, 5600.131979543177], "value": 5314.818856171824, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6944441683153, 595.4105435618739, 598.5510866849862, 611.1260896917407, 637.2639601260546, 40161.0, 44138.77930610347, 44280.11439771211, 44387.0, 44614.33078503821, 44511.33233001499, 44808.0, 44882.32676509855, 45145.7742711286, 45200.54799452004, 8990.73027809165, 9132.634694612241, 9151.542422878863, 9159.267258619328, 9161.679341223058, 8968.148025937526, 9142.314326425512, 9147.862782058275, 9151.496667683276, 9189.3108016899, 9186.081391860795, 9231.030741772118, 9248.121428464285, 9269.073092690744, 9293.21007714345, 9127.224185944202, 9171.862422063674, 9230.953845230732, 9233.076692330815, 9234.722958311262, 8938.374313798036, 9012.8648070279, 9028.458292502472, 9039.502827344493, 9056.456612603264, 42422.36366454505, 42613.786931065144, 42655.36016959748, 42774.358384624255, 42902.35646465306, 3687.474080255034, 3722.2183341498317, 3776.433534969749, 3919.513205644663, 3920.862769803043, 33501.16247093818, 33733.83133084344, 33790.1552461188, 33804.0, 35537.28925421503, 4316.56834316569, 4331.285337919239, 4363.258246098171, 4469.418975533193, 4507.368968344402, 249720.0, 249723.0, 249872.0, 250213.0, 250484.0, 59673.40326596679, 60520.737511498904, 60810.69594651998, 60981.08528372078, 61025.38974610197, 37011.4448283276, 37537.24925501474, 37818.81090594529, 39796.0, 40160.196796063916, 16732.16339183036, 16843.915780421263, 16905.23926423314, 16922.74615880763, 16957.660846782994, 12808.935955320163, 12841.678958026125, 12902.35488225585, 12904.290099079299, 12907.935460322638, 19592.216311347387, 19797.0, 19839.0, 19873.900630496755, 19874.304399345954, 7223.638818059076, 7430.405567554691, 7539.698412063456, 7630.122535908331, 7688.0, 1030.835066389374, 1094.5129417409175, 1135.9545618175346, 1149.741308205647, 1157.1437136518916, 33324.166895827795, 33930.0, 34278.65721342804, 34352.31295374079, 34600.65399346025, 1134.1437214902696, 1148.8104462763552, 1167.7839599674087, 1215.459120691284, 1221.5480272299305, 17844.643107138043, 17856.375026874255, 17919.37282195117, 17957.7306340405, 18036.729449058275, 565622.0, 571015.0, 573955.0, 577705.0, 578761.0, 60560.394396055475, 60819.391806081374, 60939.39060609426, 61042.0, 61240.0, 1342.9462821487227, 1350.5340657473157, 1382.6958069224754, 1388.1601631013293, 1391.1235921369473, 32619.673803261663, 33760.66239337673, 33821.0, 34140.0, 34156.984726916955, 54924.725376372866, 54962.450375497334, 55067.17399239095, 55180.44819551753, 55305.44694553003, 463212.0, 463421.0, 463499.0, 465725.0, 465821.0, 30337.0, 30439.847800760854, 30476.695233047387, 30779.230519237197, 30857.074287771404, 49766.0, 49924.25113623371, 50041.49958500369, 51476.0, 51756.0, 42033.0, 43203.0, 43779.34330984974, 44849.327260090475, 44902.32646510239, 42186.15627687368, 42955.926101847705, 43162.1367572653, 44283.55716442923, 44602.55397446114, 42430.15139697127, 42747.145057099304, 42890.142197155255, 42940.78529607332, 43174.568254318314, 36178.27643447064, 37663.43504847484, 38115.42826857544, 38204.0, 38960.0, 29288.10582359123, 29329.266768330963, 29403.85298073496, 29431.705682942895, 29530.261743456587], "value": 20471.28811144942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.6003696119076, 387.5683763828586, 390.826082393335, 395.48389351895776, 404.4196577910698, 18698.532536686573, 20217.898910505446, 20286.98565071746, 20491.795082049175, 20891.477713057182, 18858.905705471487, 19001.809981900176, 19459.221631134773, 19471.123799429024, 19608.41174764756, 5142.382914050319, 5171.456997015306, 5285.233641122035, 5322.33470816148, 5337.626366154371, 5212.869678258036, 5294.444083371249, 5330.093884039723, 5330.280412144369, 5341.946580534183, 5291.365036195662, 5306.469353064701, 5707.0, 5712.571557133211, 5741.540676745851, 5733.684647344395, 5744.597878148531, 5759.222504961818, 5762.020456522359, 5763.4236576342655, 5107.591392688576, 5378.542823859977, 5420.945790542083, 5456.563474922036, 5459.481349271813, 13601.523946661819, 13643.38604762788, 13661.726765464635, 13669.863301366959, 13777.173369597756, 2293.2203050962585, 2310.676505289261, 2488.726240113586, 2690.260178450922, 2746.873781749493, 9751.0, 10034.749131271703, 10090.243231757648, 10283.691489255334, 10513.0, 1823.4803081121815, 1927.9036048197534, 1947.4157752674141, 1954.9120289587004, 1963.3324669612257, 75025.62487187529, 76139.0, 76470.61764691141, 76691.23308766897, 78615.0, 10736.89263107359, 10809.297395669257, 10843.945780271048, 11077.50151243196, 11110.166737494721, 14951.626209344853, 15076.698466030837, 15151.318190681226, 15163.545093647208, 15215.467458638894, 7533.585652789039, 7640.617969101522, 7964.920350796418, 8120.309773669186, 8403.579821008925, 7693.153753087156, 8108.8378232435025, 8175.0, 8380.24577788002, 8387.580620968927, 4511.639068874482, 4578.084383123389, 4604.148232576984, 4718.245080787126, 4820.590249828804, 1830.2221555838714, 1898.5348589595637, 1929.977112130573, 1932.285054529833, 1964.9017549122486, 950.6910254167424, 990.3810118675827, 1010.2675560218782, 1041.8385150301715, 1055.4195192644015, 19558.5110372239, 19999.600007999758, 20045.198192072156, 20186.596268074558, 20219.494512637302, 1027.3938376357985, 1045.5713157605346, 1052.315994603514, 1054.478033373485, 1087.6138970665459, 10443.68668939933, 11109.388983605979, 11123.388213648326, 11132.10943124548, 11191.272567283264, 491497.0, 512024.0, 523853.0, 525329.0, 527372.0, 55516.444835551934, 66513.0, 84491.57754211313, 88415.55792220998, 90165.0, 957.8228027814877, 978.6819283732815, 994.9702058369553, 1010.0808264479435, 1013.0376142664499, 16558.0, 17186.742198866777, 17410.0, 17466.039367834892, 17474.12629368552, 39216.411753824286, 40366.59633403746, 40717.0, 40855.0, 41074.0, 49857.252141217185, 51292.74353628208, 54119.0, 54469.1829622548, 54856.0, 8205.0, 8383.287420569077, 8446.788830279293, 8526.701565445179, 8679.34904882149, 12460.501579936701, 13398.196108233537, 13440.596782096552, 13492.0, 13637.113587616774, 11396.544138234378, 11416.94291528537, 11770.117241206772, 11819.940900295443, 11904.464299106734, 10877.51051202682, 10958.397288149228, 10986.121110311316, 11203.943980280046, 11321.320720756781, 11064.28082174656, 11168.553257869595, 11545.018673412518, 11731.178817482694, 11896.167268291136, 8243.505389676639, 8328.791780205544, 8428.199321064489, 8445.915540844759, 8478.57607119654, 8508.659653613786, 10208.693739187836, 10921.56313747473, 11405.600803971822, 11751.177417580688], "value": 8939.399359199348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.229273070734, 1515.3181068519166, 1664.3009935826951, 1735.2885317020025, 1792.9641407171857, 7817.570033648161, 8375.581220938951, 8422.78943026423, 8979.775505612362, 9009.054049324817, 8518.531480768555, 8753.3872628916, 8784.64861405543, 8786.736397908056, 8789.384743067987, 2370.3955491349725, 2409.5421869844763, 2411.493586346869, 2413.529361774446, 2421.188901717918, 2289.3132060381904, 2319.18828410056, 2321.8722970236713, 2329.184785325131, 2338.777816107467, 2246.2025980776834, 2279.7378301495373, 2283.383486458655, 2320.3503019154577, 2355.422921384263, 2269.341890851651, 2280.1791355112146, 2288.4050146961827, 2291.51878105598, 2311.838171328008, 2239.585676649825, 2261.6720575516624, 2262.886855657227, 2265.399669087693, 2266.5466906618744, 8941.50821704806, 8973.865392019125, 9021.458712477206, 9048.547572621408, 9049.321300902393, 5242.23987521811, 5365.06111430502, 5373.838784836461, 5390.0, 5391.595630327741, 3326.916827079318, 3331.267121233325, 3547.396942519752, 3549.769264997767, 3553.4136867416846, 1040.3861721584226, 1074.4412905289284, 1090.650991682662, 1103.9282446640943, 1104.596822159914, 12042.277463352139, 12104.697382565506, 12244.387780610934, 12270.44782984759, 12397.0, 4397.846075387346, 4626.190416677068, 4654.348391225163, 4739.549742774431, 4756.9286460703115, 10386.636467723745, 10396.58413663445, 10400.375977441226, 10405.427701476492, 10412.68761937143, 5308.442613525602, 5318.813841515528, 5332.520073193354, 5338.519533242027, 5346.4118946915805, 4329.134173165379, 4745.0, 4890.657653964188, 4910.091633047826, 4921.434035086011, 3940.842366305373, 4057.5739547347102, 4087.0, 4154.750714957112, 4180.414741936132, 1324.8865166857806, 1328.7940369242783, 1341.631051460856, 1342.335543905773, 1343.1202562321696, 897.4615230861431, 916.1434059154711, 981.3915372469115, 1013.5489707080278, 1038.9896101038894, 5890.410958904075, 5907.497862681635, 6033.0, 6078.45293923549, 6142.324344322121, 450.4864454521848, 451.11356185095786, 452.79397873967264, 458.36516424751295, 458.43383421474454, 4184.560621134798, 4226.302660061117, 4232.3016702243785, 4261.062566235423, 4278.529361770203, 10509.159267258601, 10754.73113172177, 10808.567657293777, 10819.621313253998, 10828.350298982086, 10005.49972501372, 10767.730806729895, 10817.459127043616, 10843.349399035926, 10858.728531786768, 8155.469894456842, 8234.547099909563, 8261.8347633047, 8283.710070147636, 8316.584170791315, 5961.940380596312, 6110.969445152746, 6174.506039516738, 6214.130021797043, 6394.1687580614225, 9818.361806482555, 10192.949035254776, 10214.285000049926, 10288.2798204125, 10376.429296388771, 10367.533460994424, 10439.217058720475, 10527.789444211227, 10555.472226388496, 10559.63041293551, 7531.133919599316, 7698.2686644768655, 7709.768706938801, 7723.845523089619, 7736.574488403192, 8674.30605551567, 8698.347623928104, 8790.164934331227, 8807.383483156118, 8831.735047948572, 7628.618569071413, 7703.460757746904, 7870.724524641839, 8036.316913062456, 8059.355251579742, 7678.731244406419, 7762.534247945141, 7821.726239581815, 7902.367810575025, 7974.800629984296, 7096.574205547684, 7167.104111986002, 7219.566825990458, 7222.494425390172, 7263.0921134858145, 5115.437301896863, 5214.921776173284, 5225.895482090261, 5271.78912843482, 5470.152126420411, 5241.0, 5266.315379000858, 5273.261743355856, 5321.54766844807, 5485.122380419114], "value": 4595.056829066436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.33306721221504, 328.983550822459, 329.3133815993653, 336.76594766637197, 339.3078120633907, 5337.6797392156495, 5419.647722898009, 5568.443155684429, 5568.582356323277, 5584.9720751396235, 5417.83286685325, 5463.2078348639425, 5464.480874316943, 5470.671759694421, 5486.271824375319, 4293.29522400887, 4296.785160741966, 4305.0, 4311.676624253178, 4320.740755554677, 4188.5811418858175, 4300.354946757996, 4305.978470107645, 4323.913521729563, 4341.956580434186, 4303.720258183208, 4307.375430562583, 4314.201872653553, 4321.891952701176, 4325.610695037446, 4279.443672322594, 4324.243257429937, 4330.372096046056, 4334.934975975363, 4370.409994650745, 3569.0006798096574, 3816.9618303816883, 3835.712321575893, 3842.769433833979, 3844.6539811417106, 5338.946610533883, 5363.919541206885, 5365.543928766059, 5374.48942350476, 5379.784808607651, 4898.681585696918, 4898.804047838083, 4899.510048995107, 4923.77842997066, 4929.580985616227, 5491.615586908918, 5752.741126649311, 5773.769049238025, 5790.826275211751, 5801.158831969383, 4049.6355328020327, 4050.392441133824, 4056.7565946043037, 4061.939070913939, 4079.3676980068135, 5983.115318674647, 6014.548908831855, 6048.243969503812, 6050.757969681207, 6056.152138700585, 4060.4164375893424, 4131.5455299916985, 4138.213739389506, 4192.140611174702, 4193.266178418765, 4219.945013746564, 4221.2190744712325, 4224.281872081753, 4232.4286221360335, 4241.766702831313, 4853.417589889236, 4867.732274724854, 4873.561379475864, 4875.756212189447, 4889.48660390661, 5624.200255918149, 5754.712264386764, 5798.6810725410505, 5834.883302333929, 5851.941480585225, 1374.8144000559796, 1413.6748547834056, 1443.6968236670416, 1445.7686770116732, 1454.9490767823074, 951.2390087929629, 970.2141265574766, 988.5650313861878, 991.6182269826169, 993.5231089077283, 5473.808416705396, 5490.121580547093, 5524.613277070647, 5526.364468086141, 5536.2249285100115, 5872.677002764889, 5876.588638795329, 5878.5297176225795, 5933.1903769350765, 5947.464728174485, 5373.328333958255, 5509.504144626922, 5570.6657600544095, 5649.802256920988, 5654.773809047674, 3178.8251646159683, 3203.583534140547, 3207.550942868, 3209.293955329824, 3212.646608873022, 6026.216591843032, 6149.7847575334645, 6170.938290617126, 6237.906431403532, 6257.311695713468, 6079.7777178095685, 6120.17377654011, 6120.387961203844, 6121.081837724288, 6169.383061693795, 6189.907151392643, 6199.070139479024, 6229.53278504114, 6250.249970003538, 6254.123762871121, 5860.560457965585, 5886.646801191942, 5975.970120149372, 5980.697431488821, 5982.49148822355, 5928.34788173292, 5946.613470124428, 5968.791092311748, 5972.940270597239, 5988.191594134736, 6077.787277445268, 6124.590294987602, 6236.34518375564, 6251.874962500634, 6269.868244796791, 4181.60274773896, 4181.958180418157, 4182.937255941102, 4188.602082802129, 4194.077302993336, 5774.960507108761, 5815.79644712433, 6001.609895356788, 6002.538959026778, 6013.977623803877, 5753.647892745118, 5801.158831969426, 5803.129530570448, 5822.534197264294, 5826.883462330815, 5786.132080188006, 5806.954748145375, 5844.181814545882, 5853.678047707247, 5873.9412605873395, 5554.111861831744, 5715.685637289989, 5737.713114344349, 5777.62445441045, 5778.104393818965, 5785.566082543742, 5838.481994681499, 5840.2115714378015, 5849.766009359578, 5898.02416190581, 5438.401775804579, 5691.971540142273, 5707.429257074259, 5733.713314334183, 5757.683327417032], "value": 4408.438720011823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.7109298466581, 793.1513280789558, 824.8515267251893, 829.9543525106119, 874.9518776467294, 15850.286737096829, 16647.50057498277, 17043.744343834853, 17107.828921710796, 17139.400120995768, 15493.612659683513, 15525.378984840621, 15553.533393998197, 15554.300056497457, 15554.766678499831, 656.0061506817176, 796.6773456750011, 810.623060276971, 814.5560669435142, 815.5188438821094, 781.0939310399938, 799.6201804143014, 802.3500964218972, 802.5545822068749, 808.2806302390848, 830.1366578758084, 831.538496134645, 834.2075028722708, 835.3484282259817, 836.7071524966274, 817.9304759095484, 824.1922915542742, 826.7685048186457, 826.8511667899776, 827.6317038917684, 600.2077258019416, 600.5015836855399, 601.1463721515415, 602.9638221706712, 605.3522730678176, 15376.384944602203, 15412.768808467881, 15478.380864765395, 15490.767638485431, 15520.689586208213, 14183.865290776714, 14337.283135843167, 14410.92794536031, 14566.635834104232, 14599.78100328496, 11938.343391113485, 12163.148579599432, 12238.020958323314, 12238.694032649255, 12294.569690060895, 3779.574573951984, 3935.803209839525, 3936.2717897188827, 3953.071028308374, 4016.6385025347568, 77960.22039779586, 78353.21646783574, 78568.60715696443, 79396.60301698513, 79410.0, 11218.0, 11361.37512436824, 11441.542338306375, 11616.825747613793, 11782.5876094338, 20167.798322016886, 20176.69734953977, 20268.391948241577, 20353.0, 20399.694004589943, 8082.83834323322, 8126.634301456449, 8142.552159631158, 8144.837103257902, 8343.123971982975, 4613.440803831375, 4626.097910907408, 4660.4174478190225, 4661.137689527381, 4720.268358404453, 3165.572647692578, 3281.8194999274792, 3315.1380641033506, 3315.93368132636, 3317.834108294576, 607.9483243924227, 618.3661746709658, 626.4143026270451, 634.0869148426251, 642.6304874697067, 674.1842370731372, 707.2609123465991, 708.6102643546029, 742.4617152564456, 761.8133557278392, 8895.555222238992, 9343.392679475948, 9660.178884794872, 9675.0, 9835.52467129922, 721.4300702445114, 761.170324346465, 771.182546500711, 776.6582703610393, 784.4391260248835, 4650.09323181983, 4696.1546921554445, 4718.386609740712, 4808.927866082012, 4832.420109586872, 101330.49334753427, 124016.37991809983, 128072.0, 131559.0, 135644.6088847767, 109217.45391273152, 111234.88208148467, 113085.0, 113940.29089563663, 116332.41833790777, 70443.0, 81194.59402703067, 85450.0, 87902.99999999872, 96534.51732741292, 9853.802923941337, 9923.751906202402, 10176.389416635026, 10343.63797267092, 10346.0, 51079.233811492115, 51363.0, 52069.739651301505, 52170.739146304026, 53674.73162634318, 66307.33692663205, 66792.33207668056, 72094.63952680203, 72916.0, 74896.62551687207, 12738.808917866425, 12810.871891280967, 12855.16441431304, 12880.42038108306, 13524.18854868711, 15241.923790380977, 15320.157391343582, 15956.441524546584, 16162.838371616133, 16697.332106715596, 13066.0, 13449.260290684106, 13833.170009799444, 13854.584362469142, 13895.58313250604, 13060.673483162996, 13543.560549611055, 13589.524366647516, 14779.408823646934, 14846.77729834075, 13192.0, 13570.0, 13574.04981651275, 13835.169889806644, 14023.579292621238, 12114.75770484603, 12155.331456769962, 12304.0, 12318.753624927273, 12561.811572826598, 10531.57873685044, 10970.890291096986, 11788.70528236801, 12478.87521124777, 12712.491500339884], "value": 7666.36215389586, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 108.0, 114.0, 112.0, 114.0, 113.0, 113.0, 114.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 149.0, 179.0, 120.0, 146.0, 143.0, 125.0, 181.0, 119.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 161.0, 160.0, 168.0, 167.0, 162.0, 161.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 172.0, 78.0, 75.0, 75.0, 76.0, 171.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 156.0, 85.0, 83.0, 84.0, 146.0, 85.0, 83.0, 143.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 51.0, 54.0, 54.0, 56.0, 51.0, 51.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 61.0, 63.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 82.0, 82.0, 76.0, 78.0, 76.0, 76.0, 88.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 124.0, 144.0, 125.0, 123.0, 135.0, 124.0, 135.0, 137.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 168.0, 163.0, 169.0, 164.0, 160.0, 162.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 64.0, 65.0, 66.0, 65.0, 63.0, 64.0, 65.0], "value": 64.9, "unit": "score"}]}]} 17:37:39 INFO - Return code: 0 17:37:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:37:39 ERROR - # TBPL SUCCESS # 17:37:39 INFO - Running post-action listener: _resource_record_post_action 17:37:39 INFO - [mozharness: 2016-08-06 00:37:39.630905Z] Finished run-tests step (success) 17:37:39 INFO - Running post-run listener: _resource_record_post_run 17:37:39 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298196992; Read time: 12; Write time: 225420 17:37:39 INFO - TinderboxPrint: CPU usage
13.3% 17:37:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:37:39 INFO - TinderboxPrint: I/O write bytes / time
298,196,992 / 225,420 17:37:39 INFO - TinderboxPrint: CPU idle
8,244.2 (86.7%) 17:37:39 INFO - TinderboxPrint: CPU user
1,210.7 (12.7%) 17:37:39 INFO - TinderboxPrint: Swap in / out
0 / 0 17:37:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 7544832; Read time: 0; Write time: 1424 17:37:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290652160; Read time: 0; Write time: 223996 17:37:40 INFO - Running post-run listener: _upload_blobber_files 17:37:40 INFO - Blob upload gear active. 17:37:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:37:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:37:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:44 INFO - (blobuploader) - INFO - Done attempting. 17:37:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:37:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:45 INFO - (blobuploader) - INFO - Done attempting. 17:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:45 INFO - (blobuploader) - INFO - Done attempting. 17:37:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:45 INFO - Return code: 0 17:37:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b5cbd0eae901539bcb2d6eefb0617f66b44f5185d6870141982f82dd38d840428af8db55a4223a7bcd2b37610c924978e575b57a7b1e44788151d377ddbb4a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e819843b1a94ba9ad2622ef488d15fc9025665c435611e7fa1673f6e57caff1ce7f170d2f4c7fcaa638851d870a5793716ee60705da03fddd1160f6377f66572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/107911396b24d6e5b8f9f4ae8273d8da134ed1945938421a86bb57844b91fd26335584a8fd43b040d3008b03ce119aa782261c2562f3192caf980d0593aeac1e"} 17:37:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:45 INFO - Contents: 17:37:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b5cbd0eae901539bcb2d6eefb0617f66b44f5185d6870141982f82dd38d840428af8db55a4223a7bcd2b37610c924978e575b57a7b1e44788151d377ddbb4a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e819843b1a94ba9ad2622ef488d15fc9025665c435611e7fa1673f6e57caff1ce7f170d2f4c7fcaa638851d870a5793716ee60705da03fddd1160f6377f66572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/107911396b24d6e5b8f9f4ae8273d8da134ed1945938421a86bb57844b91fd26335584a8fd43b040d3008b03ce119aa782261c2562f3192caf980d0593aeac1e"} 17:37:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:45 INFO - Copying logs to upload dir... 17:37:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.729388 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-05 17:37:45.924194) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 17:37:45.927531) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927 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/sha512/7b5cbd0eae901539bcb2d6eefb0617f66b44f5185d6870141982f82dd38d840428af8db55a4223a7bcd2b37610c924978e575b57a7b1e44788151d377ddbb4a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e819843b1a94ba9ad2622ef488d15fc9025665c435611e7fa1673f6e57caff1ce7f170d2f4c7fcaa638851d870a5793716ee60705da03fddd1160f6377f66572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/107911396b24d6e5b8f9f4ae8273d8da134ed1945938421a86bb57844b91fd26335584a8fd43b040d3008b03ce119aa782261c2562f3192caf980d0593aeac1e"} build_url:https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/Ebrl7bznQhiwB8In-ifymA/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/sha512/7b5cbd0eae901539bcb2d6eefb0617f66b44f5185d6870141982f82dd38d840428af8db55a4223a7bcd2b37610c924978e575b57a7b1e44788151d377ddbb4a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e819843b1a94ba9ad2622ef488d15fc9025665c435611e7fa1673f6e57caff1ce7f170d2f4c7fcaa638851d870a5793716ee60705da03fddd1160f6377f66572", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/107911396b24d6e5b8f9f4ae8273d8da134ed1945938421a86bb57844b91fd26335584a8fd43b040d3008b03ce119aa782261c2562f3192caf980d0593aeac1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 17:37:45.953679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:37:45.954032) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1470442576.631225-1267090927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 17:37:46.039374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 17:37:46.039741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 17:37:46.040098) ========= ========= Total master_lag: 0.18 =========