builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1470760359.06 results: success (0) buildid: 20160809064921 builduid: f0943623292a464f9eae2dd0e2c94b79 revision: 613fec9a571e48c64918ebd0a8153096300ff992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.062947) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.063466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.063817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.076483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.076883) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 09:32:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-08-09 09:32:39 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084357 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.174042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.174437) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018069 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.224793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.225218) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 613fec9a571e48c64918ebd0a8153096300ff992 --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 613fec9a571e48c64918ebd0a8153096300ff992 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 09:32:39,845 truncating revision to first 12 chars 2016-08-09 09:32:39,845 Setting DEBUG logging. 2016-08-09 09:32:39,845 attempt 1/10 2016-08-09 09:32:39,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/613fec9a571e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 09:32:40,143 unpacking tar archive at: fx-team-613fec9a571e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625147 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.865333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.865720) ========= script_repo_revision: 613fec9a571e48c64918ebd0a8153096300ff992 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.866179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.866496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 09:32:39.876089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-09 09:32:39.876410) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:40 INFO - MultiFileLogger online at 20160809 09:32:40 in /builds/slave/test 09:32:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:32:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:40 INFO - {'append_to_log': False, 09:32:40 INFO - 'base_work_dir': '/builds/slave/test', 09:32:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:32:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:40 INFO - 'branch': 'Fx-Team-Non-PGO', 09:32:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:40 INFO - 'config_files': ('talos/linux_config.py',), 09:32:40 INFO - 'default_actions': ('clobber', 09:32:40 INFO - 'read-buildbot-config', 09:32:40 INFO - 'download-and-extract', 09:32:40 INFO - 'populate-webroot', 09:32:40 INFO - 'create-virtualenv', 09:32:40 INFO - 'install', 09:32:40 INFO - 'run-tests'), 09:32:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:40 INFO - 'download_minidump_stackwalk': True, 09:32:40 INFO - 'download_symbols': 'ondemand', 09:32:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:40 INFO - 'installer_path': 'installer.exe', 09:32:40 INFO - 'log_level': 'info', 09:32:40 INFO - 'log_name': 'talos', 09:32:40 INFO - 'log_to_console': True, 09:32:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:40 INFO - 'opt_config_files': (), 09:32:40 INFO - 'pip_index': False, 09:32:40 INFO - 'sps_profile': False, 09:32:40 INFO - 'sps_profile_interval': 0, 09:32:40 INFO - 'suite': 'dromaeojs-e10s', 09:32:40 INFO - 'system_bits': '32', 09:32:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:40 INFO - 'title': 'talos-linux64-ix-019', 09:32:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:40 INFO - 'use_talos_json': True, 09:32:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:40 INFO - 'work_dir': 'build'} 09:32:40 INFO - [mozharness: 2016-08-09 16:32:40.589690Z] Running clobber step. 09:32:40 INFO - Running pre-action listener: _resource_record_pre_action 09:32:40 INFO - Running main action method: clobber 09:32:40 INFO - rmtree: /builds/slave/test/build 09:32:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:41 INFO - Running post-action listener: _resource_record_post_action 09:32:41 INFO - [mozharness: 2016-08-09 16:32:41.598837Z] Finished clobber step (success) 09:32:41 INFO - [mozharness: 2016-08-09 16:32:41.598938Z] Running read-buildbot-config step. 09:32:41 INFO - Running pre-action listener: _resource_record_pre_action 09:32:41 INFO - Running main action method: read_buildbot_config 09:32:41 INFO - Using buildbot properties: 09:32:41 INFO - { 09:32:41 INFO - "project": "", 09:32:41 INFO - "product": "firefox", 09:32:41 INFO - "script_repo_revision": "production", 09:32:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:32:41 INFO - "repository": "", 09:32:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:32:41 INFO - "buildid": "20160809064921", 09:32:41 INFO - "pgo_build": "False", 09:32:41 INFO - "basedir": "/builds/slave/test", 09:32:41 INFO - "buildnumber": 1742, 09:32:41 INFO - "slavename": "talos-linux64-ix-019", 09:32:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:32:41 INFO - "platform": "ubuntu64_hw", 09:32:41 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 09:32:41 INFO - "branch": "fx-team", 09:32:41 INFO - "repo_path": "integration/fx-team", 09:32:41 INFO - "revision": "613fec9a571e48c64918ebd0a8153096300ff992", 09:32:41 INFO - "stage_platform": "linux64", 09:32:41 INFO - "builduid": "f0943623292a464f9eae2dd0e2c94b79", 09:32:41 INFO - "slavebuilddir": "test" 09:32:41 INFO - } 09:32:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:32:41 INFO - Running post-action listener: _resource_record_post_action 09:32:41 INFO - [mozharness: 2016-08-09 16:32:41.601377Z] Finished read-buildbot-config step (success) 09:32:41 INFO - [mozharness: 2016-08-09 16:32:41.601466Z] Running download-and-extract step. 09:32:41 INFO - Running pre-action listener: _resource_record_pre_action 09:32:41 INFO - Running main action method: download_and_extract 09:32:41 INFO - mkdir: /builds/slave/test/build/tests 09:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:41 INFO - trying https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:32:41 INFO - Downloading https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:42 INFO - Downloaded 1361 bytes. 09:32:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:32:42 INFO - Using the following test package requirements: 09:32:42 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:32:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:32:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'jsshell-linux-x86_64.zip'], 09:32:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:32:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:32:42 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:32:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:32:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:32:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:32: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')]} 09:32:42 INFO - trying https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:32:42 INFO - Downloading https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:43 INFO - Downloaded 20259579 bytes. 09:32:43 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'] 09:32:43 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 09:32:44 INFO - Return code: 0 09:32:44 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 09:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:44 INFO - trying https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:32:44 INFO - Downloading https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:44 INFO - Downloaded 20259579 bytes. 09:32:44 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'] 09:32:44 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 09:32:46 INFO - Return code: 0 09:32: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')]} 09:32:46 INFO - trying https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:47 INFO - Downloaded 14413723 bytes. 09:32:47 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'] 09:32:47 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 09:32:47 INFO - Return code: 0 09:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:47 INFO - trying https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:32:47 INFO - Downloading https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/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 09:32:48 INFO - Downloaded 55614963 bytes. 09:32:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:32:48 INFO - mkdir: /builds/slave/test/properties 09:32:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:48 INFO - Contents: 09:32:48 INFO - build_url:https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:32:49 INFO - Running post-action listener: _resource_record_post_action 09:32:49 INFO - Running post-action listener: set_extra_try_arguments 09:32:49 INFO - [mozharness: 2016-08-09 16:32:49.130304Z] Finished download-and-extract step (success) 09:32:49 INFO - [mozharness: 2016-08-09 16:32:49.130537Z] Running populate-webroot step. 09:32:49 INFO - Running pre-action listener: _resource_record_pre_action 09:32:49 INFO - Running main action method: populate_webroot 09:32:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:49 INFO - '--tppagecycles', 09:32:49 INFO - '7'], 09:32:49 INFO - 'tests': ['tsvgm']}}, 09:32:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['damp', 'tps']}, 09:32:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'tests': ['damp', 'tps']}, 09:32:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['dromaeo_dom']}, 09:32:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['basic_compositor_video']}, 09:32:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:32:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['a11yr', 09:32:49 INFO - 'ts_paint', 09:32:49 INFO - 'tpaint', 09:32:49 INFO - 'sessionrestore', 09:32:49 INFO - 'sessionrestore_no_auto_restore', 09:32:49 INFO - 'tabpaint']}, 09:32:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:49 INFO - 'ts_paint', 09:32:49 INFO - 'tpaint', 09:32:49 INFO - 'sessionrestore', 09:32:49 INFO - 'sessionrestore_no_auto_restore', 09:32:49 INFO - 'tabpaint']}, 09:32:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:49 INFO - 'ts_paint', 09:32:49 INFO - 'tpaint', 09:32:49 INFO - 'sessionrestore', 09:32:49 INFO - 'sessionrestore_no_auto_restore', 09:32:49 INFO - 'tabpaint']}, 09:32:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:49 INFO - 'ts_paint', 09:32:49 INFO - 'tpaint', 09:32:49 INFO - 'sessionrestore', 09:32:49 INFO - 'sessionrestore_no_auto_restore', 09:32:49 INFO - 'tabpaint']}, 09:32:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['a11yr', 09:32:49 INFO - 'ts_paint', 09:32:49 INFO - 'tpaint', 09:32:49 INFO - 'sessionrestore', 09:32:49 INFO - 'sessionrestore_no_auto_restore', 09:32:49 INFO - 'tabpaint']}, 09:32:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['a11yr', 09:32:49 INFO - 'ts_paint', 09:32:49 INFO - 'tpaint', 09:32:49 INFO - 'sessionrestore', 09:32:49 INFO - 'sessionrestore_no_auto_restore', 09:32:49 INFO - 'tabpaint']}, 09:32:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['tsvgx', 09:32:49 INFO - 'tsvgr_opacity', 09:32:49 INFO - 'tart', 09:32:49 INFO - 'tscrollx', 09:32:49 INFO - 'cart']}, 09:32:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:49 INFO - 'tsvgr_opacity', 09:32:49 INFO - 'tart', 09:32:49 INFO - 'tscrollx', 09:32:49 INFO - 'cart']}, 09:32:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'talos_options': ['--disable-e10s'], 09:32:49 INFO - 'tests': ['tp5o']}, 09:32:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'tests': ['tp5o']}, 09:32:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'talos_options': ['--disable-e10s', 09:32:49 INFO - '--xperf_path', 09:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:49 INFO - 'tests': ['tp5n']}, 09:32:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:49 INFO - 'talos_options': ['--xperf_path', 09:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:49 INFO - 'tests': ['tp5n']}}, 09:32:49 INFO - 'talos.zip': {'path': '', 09:32:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:49 INFO - Running post-action listener: _resource_record_post_action 09:32:49 INFO - [mozharness: 2016-08-09 16:32:49.152756Z] Finished populate-webroot step (success) 09:32:49 INFO - [mozharness: 2016-08-09 16:32:49.152844Z] Running create-virtualenv step. 09:32:49 INFO - Running pre-action listener: _resource_record_pre_action 09:32:49 INFO - Running main action method: create_virtualenv 09:32:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:49 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 09:32:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:49 INFO - Using real prefix '/usr' 09:32:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:51 INFO - Installing pip.................done. 09:32:51 INFO - Return code: 0 09:32:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:51 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')]} 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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')]} 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:32:51 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 09:32:51 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 09:32:51 INFO - Using env: {'DISPLAY': ':0', 09:32:51 INFO - 'HOME': '/home/cltbld', 09:32:51 INFO - 'LANG': 'en_US.UTF-8', 09:32:51 INFO - 'LANGUAGE': 'en_US:en', 09:32:51 INFO - 'LOGNAME': 'cltbld', 09:32:51 INFO - 'MAIL': '/var/mail/cltbld', 09:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:51 INFO - 'MOZ_NO_REMOTE': '1', 09:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:51 INFO - 'NO_EM_RESTART': '1', 09:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:51 INFO - 'PWD': '/builds/slave/test', 09:32:51 INFO - 'SHELL': '/bin/bash', 09:32:51 INFO - 'SHLVL': '1', 09:32:51 INFO - 'TERM': 'linux', 09:32:51 INFO - 'TMOUT': '86400', 09:32:51 INFO - 'USER': 'cltbld', 09:32:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:51 INFO - '_': '/tools/buildbot/bin/python'} 09:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 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 09:32:51 INFO - Cleaning up... 09:32:51 INFO - Return code: 0 09:32:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:51 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')]} 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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')]} 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:32:51 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 09:32:51 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 09:32:51 INFO - Using env: {'DISPLAY': ':0', 09:32:51 INFO - 'HOME': '/home/cltbld', 09:32:51 INFO - 'LANG': 'en_US.UTF-8', 09:32:51 INFO - 'LANGUAGE': 'en_US:en', 09:32:51 INFO - 'LOGNAME': 'cltbld', 09:32:51 INFO - 'MAIL': '/var/mail/cltbld', 09:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:51 INFO - 'MOZ_NO_REMOTE': '1', 09:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:51 INFO - 'NO_EM_RESTART': '1', 09:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:51 INFO - 'PWD': '/builds/slave/test', 09:32:51 INFO - 'SHELL': '/bin/bash', 09:32:51 INFO - 'SHLVL': '1', 09:32:51 INFO - 'TERM': 'linux', 09:32:51 INFO - 'TMOUT': '86400', 09:32:51 INFO - 'USER': 'cltbld', 09:32:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:51 INFO - '_': '/tools/buildbot/bin/python'} 09:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:52 INFO - Downloading/unpacking psutil>=3.1.1 09:32:52 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 09:32:52 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 09:32:52 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 09:32:52 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 09:32:52 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 09:32:52 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 09:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:54 INFO - Installing collected packages: psutil 09:32:54 INFO - Running setup.py install for psutil 09:32:54 INFO - building 'psutil._psutil_linux' extension 09:32:54 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 09:32:54 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 09:32:54 INFO - building 'psutil._psutil_posix' extension 09:32:54 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 09:32:54 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 09:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:54 INFO - Successfully installed psutil 09:32:54 INFO - Cleaning up... 09:32:54 INFO - Return code: 0 09:32:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32:54 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')]} 09:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:54 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')]} 09:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:54 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:32:54 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 09:32:54 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 09:32:54 INFO - Using env: {'DISPLAY': ':0', 09:32:54 INFO - 'HOME': '/home/cltbld', 09:32:54 INFO - 'LANG': 'en_US.UTF-8', 09:32:54 INFO - 'LANGUAGE': 'en_US:en', 09:32:54 INFO - 'LOGNAME': 'cltbld', 09:32:54 INFO - 'MAIL': '/var/mail/cltbld', 09:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:54 INFO - 'MOZ_NO_REMOTE': '1', 09:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:54 INFO - 'NO_EM_RESTART': '1', 09:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:54 INFO - 'PWD': '/builds/slave/test', 09:32:54 INFO - 'SHELL': '/bin/bash', 09:32:54 INFO - 'SHLVL': '1', 09:32:54 INFO - 'TERM': 'linux', 09:32:54 INFO - 'TMOUT': '86400', 09:32:54 INFO - 'USER': 'cltbld', 09:32:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:54 INFO - '_': '/tools/buildbot/bin/python'} 09:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32:54 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 09:32:54 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 09:32:54 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 09:32:54 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 09:32:54 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 09:32:54 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 09:32:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:57 INFO - Installing collected packages: mozsystemmonitor 09:32:57 INFO - Running setup.py install for mozsystemmonitor 09:32:57 INFO - Successfully installed mozsystemmonitor 09:32:57 INFO - Cleaning up... 09:32:58 INFO - Return code: 0 09:32:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:58 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:32:58 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 09:32:58 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 09:32:58 INFO - Using env: {'DISPLAY': ':0', 09:32:58 INFO - 'HOME': '/home/cltbld', 09:32:58 INFO - 'LANG': 'en_US.UTF-8', 09:32:58 INFO - 'LANGUAGE': 'en_US:en', 09:32:58 INFO - 'LOGNAME': 'cltbld', 09:32:58 INFO - 'MAIL': '/var/mail/cltbld', 09:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:58 INFO - 'MOZ_NO_REMOTE': '1', 09:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:58 INFO - 'NO_EM_RESTART': '1', 09:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:58 INFO - 'PWD': '/builds/slave/test', 09:32:58 INFO - 'SHELL': '/bin/bash', 09:32:58 INFO - 'SHLVL': '1', 09:32:58 INFO - 'TERM': 'linux', 09:32:58 INFO - 'TMOUT': '86400', 09:32:58 INFO - 'USER': 'cltbld', 09:32:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:58 INFO - '_': '/tools/buildbot/bin/python'} 09:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:58 INFO - Downloading/unpacking jsonschema==2.5.1 09:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:00 INFO - warning: no files found matching '*.txt' 09:33:00 INFO - no previously-included directories found matching 'build' 09:33:00 INFO - no previously-included directories found matching 'dist' 09:33:00 INFO - no previously-included directories found matching '.git*' 09:33:00 INFO - Installing collected packages: jsonschema, functools32 09:33:00 INFO - Running setup.py install for functools32 09:33:00 INFO - warning: no files found matching '*.txt' 09:33:00 INFO - no previously-included directories found matching 'build' 09:33:00 INFO - no previously-included directories found matching 'dist' 09:33:00 INFO - no previously-included directories found matching '.git*' 09:33:00 INFO - Successfully installed jsonschema functools32 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'DISPLAY': ':0', 09:33:00 INFO - 'HOME': '/home/cltbld', 09:33:00 INFO - 'LANG': 'en_US.UTF-8', 09:33:00 INFO - 'LANGUAGE': 'en_US:en', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MAIL': '/var/mail/cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SHLVL': '1', 09:33:00 INFO - 'TERM': 'linux', 09:33:00 INFO - 'TMOUT': '86400', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - '_': '/tools/buildbot/bin/python'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'DISPLAY': ':0', 09:33:00 INFO - 'HOME': '/home/cltbld', 09:33:00 INFO - 'LANG': 'en_US.UTF-8', 09:33:00 INFO - 'LANGUAGE': 'en_US:en', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MAIL': '/var/mail/cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SHLVL': '1', 09:33:00 INFO - 'TERM': 'linux', 09:33:00 INFO - 'TMOUT': '86400', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - '_': '/tools/buildbot/bin/python'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:02 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 09:33:02 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 09:33:02 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 09:33:02 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 09:33:02 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 09:33:02 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 09:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:03 INFO - Downloading docopt-0.6.1.tar.gz 09:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:03 INFO - Running setup.py install for blobuploader 09:33:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:03 INFO - Running setup.py install for requests 09:33:04 INFO - Running setup.py install for docopt 09:33:04 INFO - Successfully installed blobuploader requests docopt 09:33:04 INFO - Cleaning up... 09:33:04 INFO - Return code: 0 09:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:04 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:33:04 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 09:33:04 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 09:33:04 INFO - Using env: {'DISPLAY': ':0', 09:33:04 INFO - 'HOME': '/home/cltbld', 09:33:04 INFO - 'LANG': 'en_US.UTF-8', 09:33:04 INFO - 'LANGUAGE': 'en_US:en', 09:33:04 INFO - 'LOGNAME': 'cltbld', 09:33:04 INFO - 'MAIL': '/var/mail/cltbld', 09:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:04 INFO - 'MOZ_NO_REMOTE': '1', 09:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:04 INFO - 'NO_EM_RESTART': '1', 09:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:04 INFO - 'PWD': '/builds/slave/test', 09:33:04 INFO - 'SHELL': '/bin/bash', 09:33:04 INFO - 'SHLVL': '1', 09:33:04 INFO - 'TERM': 'linux', 09:33:04 INFO - 'TMOUT': '86400', 09:33:04 INFO - 'USER': 'cltbld', 09:33:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:04 INFO - '_': '/tools/buildbot/bin/python'} 09:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:04 INFO - Running setup.py (path:/tmp/pip-_cM2B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:04 INFO - Running setup.py (path:/tmp/pip-asXO_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:04 INFO - Running setup.py (path:/tmp/pip-M5x1vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:04 INFO - Running setup.py (path:/tmp/pip-O2PH6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:04 INFO - Running setup.py (path:/tmp/pip-IuUgdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:04 INFO - Running setup.py (path:/tmp/pip-wB0Mes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:04 INFO - Running setup.py (path:/tmp/pip-v8cWsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:04 INFO - Running setup.py (path:/tmp/pip-QA6noh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:05 INFO - Running setup.py (path:/tmp/pip-11vYvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:05 INFO - Running setup.py (path:/tmp/pip-fXVeoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:05 INFO - Running setup.py (path:/tmp/pip-Tkq0wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:05 INFO - Running setup.py (path:/tmp/pip-b1ZpoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:05 INFO - Running setup.py (path:/tmp/pip-U95BoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:05 INFO - Running setup.py (path:/tmp/pip-bqMLAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:05 INFO - Running setup.py (path:/tmp/pip-Aiss6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:05 INFO - Running setup.py (path:/tmp/pip-pSNMmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:05 INFO - Running setup.py (path:/tmp/pip-JGzA4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:05 INFO - Running setup.py install for manifestparser 09:33:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:05 INFO - Running setup.py install for mozcrash 09:33:05 INFO - Running setup.py install for mozdebug 09:33:05 INFO - Running setup.py install for mozdevice 09:33:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Running setup.py install for mozfile 09:33:06 INFO - Running setup.py install for mozhttpd 09:33:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Running setup.py install for mozinfo 09:33:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Running setup.py install for mozInstall 09:33:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Running setup.py install for mozleak 09:33:06 INFO - Running setup.py install for mozlog 09:33:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Running setup.py install for moznetwork 09:33:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:06 INFO - Running setup.py install for mozprocess 09:33:06 INFO - Running setup.py install for mozprofile 09:33:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:07 INFO - Running setup.py install for mozrunner 09:33:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:07 INFO - Running setup.py install for mozscreenshot 09:33:07 INFO - Running setup.py install for moztest 09:33:07 INFO - Running setup.py install for mozversion 09:33:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:07 INFO - Cleaning up... 09:33:07 INFO - Return code: 0 09:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:07 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:33:07 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 09:33:07 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 09:33:07 INFO - Using env: {'DISPLAY': ':0', 09:33:07 INFO - 'HOME': '/home/cltbld', 09:33:07 INFO - 'LANG': 'en_US.UTF-8', 09:33:07 INFO - 'LANGUAGE': 'en_US:en', 09:33:07 INFO - 'LOGNAME': 'cltbld', 09:33:07 INFO - 'MAIL': '/var/mail/cltbld', 09:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:07 INFO - 'MOZ_NO_REMOTE': '1', 09:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:07 INFO - 'NO_EM_RESTART': '1', 09:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:07 INFO - 'PWD': '/builds/slave/test', 09:33:07 INFO - 'SHELL': '/bin/bash', 09:33:07 INFO - 'SHLVL': '1', 09:33:07 INFO - 'TERM': 'linux', 09:33:07 INFO - 'TMOUT': '86400', 09:33:07 INFO - 'USER': 'cltbld', 09:33:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:07 INFO - '_': '/tools/buildbot/bin/python'} 09:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:07 INFO - Running setup.py (path:/tmp/pip-1EcvPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:07 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)) 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:07 INFO - Running setup.py (path:/tmp/pip-TlfvX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:07 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)) 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:07 INFO - Running setup.py (path:/tmp/pip-HPsi1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:07 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)) 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:07 INFO - Running setup.py (path:/tmp/pip-SAWoXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:08 INFO - Running setup.py (path:/tmp/pip-KjrIQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:08 INFO - Running setup.py (path:/tmp/pip-9rZGaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:08 INFO - Running setup.py (path:/tmp/pip-hdVL7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:08 INFO - Running setup.py (path:/tmp/pip-77lGfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:08 INFO - Running setup.py (path:/tmp/pip-kP6waA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:08 INFO - Running setup.py (path:/tmp/pip-1Op_iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:08 INFO - Running setup.py (path:/tmp/pip-Q5p9bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:08 INFO - Running setup.py (path:/tmp/pip-J1QnPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:08 INFO - Running setup.py (path:/tmp/pip-kPiwrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:08 INFO - Running setup.py (path:/tmp/pip-PSf8Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:08 INFO - Running setup.py (path:/tmp/pip-SHucUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:08 INFO - Running setup.py (path:/tmp/pip-IKO4ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:08 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)) 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:08 INFO - Running setup.py (path:/tmp/pip-kQ81t7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:08 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)) 09:33:08 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)) 09:33:08 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)) 09:33:08 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)) 09:33:08 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)) 09:33:08 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)) 09:33:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:10 INFO - Downloading blessings-1.6.tar.gz 09:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:10 INFO - Installing collected packages: blessings 09:33:10 INFO - Running setup.py install for blessings 09:33:11 INFO - Successfully installed blessings 09:33:11 INFO - Cleaning up... 09:33:11 INFO - Return code: 0 09:33:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:11 INFO - Reading from file tmpfile_stdout 09:33:11 INFO - Current package versions: 09:33:11 INFO - argparse == 1.2.1 09:33:11 INFO - blessings == 1.6 09:33:11 INFO - blobuploader == 1.2.4 09:33:11 INFO - docopt == 0.6.1 09:33:11 INFO - functools32 == 3.2.3-2 09:33:11 INFO - jsonschema == 2.5.1 09:33:11 INFO - manifestparser == 1.1 09:33:11 INFO - mozInstall == 1.12 09:33:11 INFO - mozcrash == 0.17 09:33:11 INFO - mozdebug == 0.1 09:33:11 INFO - mozdevice == 0.48 09:33:11 INFO - mozfile == 1.2 09:33:11 INFO - mozhttpd == 0.7 09:33:11 INFO - mozinfo == 0.9 09:33:11 INFO - mozleak == 0.1 09:33:11 INFO - mozlog == 3.3 09:33:11 INFO - moznetwork == 0.27 09:33:11 INFO - mozprocess == 0.23 09:33:11 INFO - mozprofile == 0.28 09:33:11 INFO - mozrunner == 6.12 09:33:11 INFO - mozscreenshot == 0.1 09:33:11 INFO - mozsystemmonitor == 0.3 09:33:11 INFO - moztest == 0.7 09:33:11 INFO - mozversion == 1.4 09:33:11 INFO - psutil == 3.1.1 09:33:11 INFO - requests == 1.2.3 09:33:11 INFO - wsgiref == 0.1.2 09:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:11 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')]} 09:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 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')]} 09:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:33:11 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 09:33:11 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 09:33:11 INFO - Using env: {'DISPLAY': ':0', 09:33:11 INFO - 'HOME': '/home/cltbld', 09:33:11 INFO - 'LANG': 'en_US.UTF-8', 09:33:11 INFO - 'LANGUAGE': 'en_US:en', 09:33:11 INFO - 'LOGNAME': 'cltbld', 09:33:11 INFO - 'MAIL': '/var/mail/cltbld', 09:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:11 INFO - 'MOZ_NO_REMOTE': '1', 09:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:11 INFO - 'NO_EM_RESTART': '1', 09:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:11 INFO - 'PWD': '/builds/slave/test', 09:33:11 INFO - 'SHELL': '/bin/bash', 09:33:11 INFO - 'SHLVL': '1', 09:33:11 INFO - 'TERM': 'linux', 09:33:11 INFO - 'TMOUT': '86400', 09:33:11 INFO - 'USER': 'cltbld', 09:33:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:11 INFO - '_': '/tools/buildbot/bin/python'} 09:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 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)) 09:33:11 INFO - Cleaning up... 09:33:11 INFO - Return code: 0 09:33:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:11 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')]} 09:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 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')]} 09:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:11 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 0x26aa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', '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 09:33:11 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 09:33:11 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 09:33:11 INFO - Using env: {'DISPLAY': ':0', 09:33:11 INFO - 'HOME': '/home/cltbld', 09:33:11 INFO - 'LANG': 'en_US.UTF-8', 09:33:11 INFO - 'LANGUAGE': 'en_US:en', 09:33:11 INFO - 'LOGNAME': 'cltbld', 09:33:11 INFO - 'MAIL': '/var/mail/cltbld', 09:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:11 INFO - 'MOZ_NO_REMOTE': '1', 09:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:11 INFO - 'NO_EM_RESTART': '1', 09:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:11 INFO - 'PWD': '/builds/slave/test', 09:33:11 INFO - 'SHELL': '/bin/bash', 09:33:11 INFO - 'SHLVL': '1', 09:33:11 INFO - 'TERM': 'linux', 09:33:11 INFO - 'TMOUT': '86400', 09:33:11 INFO - 'USER': 'cltbld', 09:33:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:11 INFO - '_': '/tools/buildbot/bin/python'} 09:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:11 INFO - Cleaning up... 09:33:11 INFO - Return code: 0 09:33:11 INFO - Running post-action listener: _resource_record_post_action 09:33:11 INFO - Running post-action listener: _start_resource_monitoring 09:33:11 INFO - Starting resource monitoring. 09:33:11 INFO - [mozharness: 2016-08-09 16:33:11.801624Z] Finished create-virtualenv step (success) 09:33:11 INFO - [mozharness: 2016-08-09 16:33:11.802064Z] Running install step. 09:33:11 INFO - Running pre-action listener: _resource_record_pre_action 09:33:11 INFO - Running main action method: install 09:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:12 INFO - Reading from file tmpfile_stdout 09:33:12 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:12 INFO - Reading from file tmpfile_stdout 09:33:12 INFO - Output received: 09:33:12 INFO - Usage: mozinstall [options] installer 09:33:12 INFO - Options: 09:33:12 INFO - -h, --help show this help message and exit 09:33:12 INFO - -d DEST, --destination=DEST 09:33:12 INFO - Directory to install application into. [default: 09:33:12 INFO - "/builds/slave/test"] 09:33:12 INFO - --app=APP Application being installed. [default: firefox] 09:33:12 INFO - mkdir: /builds/slave/test/build/application 09:33:12 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'] 09:33:12 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 09:33:28 INFO - Reading from file tmpfile_stdout 09:33:28 INFO - Output received: 09:33:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:28 INFO - Running post-action listener: _resource_record_post_action 09:33:28 INFO - [mozharness: 2016-08-09 16:33:28.125688Z] Finished install step (success) 09:33:28 INFO - [mozharness: 2016-08-09 16:33:28.125935Z] Running run-tests step. 09:33:28 INFO - Running pre-action listener: _resource_record_pre_action 09:33:28 INFO - Running main action method: run_tests 09:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:28 INFO - Python 2.7.3 09:33:28 INFO - Return code: 0 09:33:28 INFO - grabbing minidump binary from tooltool 09:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:28 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 0x2968570>, '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 0x2969470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:28 INFO - Return code: 0 09:33:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:33:28 INFO - Using env: {'DISPLAY': ':0', 09:33:28 INFO - 'HOME': '/home/cltbld', 09:33:28 INFO - 'LANG': 'en_US.UTF-8', 09:33:28 INFO - 'LANGUAGE': 'en_US:en', 09:33:28 INFO - 'LOGNAME': 'cltbld', 09:33:28 INFO - 'MAIL': '/var/mail/cltbld', 09:33:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:28 INFO - 'MOZ_NO_REMOTE': '1', 09:33:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:28 INFO - 'NO_EM_RESTART': '1', 09:33:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:28 INFO - 'PWD': '/builds/slave/test', 09:33:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:28 INFO - 'SHELL': '/bin/bash', 09:33:28 INFO - 'SHLVL': '1', 09:33:28 INFO - 'TERM': 'linux', 09:33:28 INFO - 'TMOUT': '86400', 09:33:28 INFO - 'USER': 'cltbld', 09:33:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305', 09:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:28 INFO - '_': '/tools/buildbot/bin/python'} 09:33:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:33:28 INFO - mozversion application_buildid: 20160809064921 09:33:28 INFO - mozversion application_changeset: 613fec9a571e48c64918ebd0a8153096300ff992 09:33:28 INFO - mozversion application_display_name: Nightly 09:33:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:28 INFO - mozversion application_name: Firefox 09:33:28 INFO - mozversion application_remotingname: firefox 09:33:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:33:28 INFO - mozversion application_vendor: Mozilla 09:33:28 INFO - mozversion application_version: 51.0a1 09:33:28 INFO - mozversion platform_buildid: 20160809064921 09:33:28 INFO - mozversion platform_changeset: 613fec9a571e48c64918ebd0a8153096300ff992 09:33:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:33:28 INFO - mozversion platform_version: 51.0a1 09:33:28 INFO - using testdate: 1470760408 09:33:28 INFO - actual date: 1470760408 09:33:28 INFO - starting webserver on 'localhost:49450' 09:33:28 INFO - SUITE-START | Running 2 tests 09:33:28 INFO - TEST-START | dromaeo_css 09:33:28 INFO - operating with platform_type : linux_ 09:33:28 INFO - Initialising browser for dromaeo_css test... 09:33:28 INFO - TEST-INFO | started process 25989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUXHxo/profile http://localhost:49450/getInfo.html) 09:33:33 INFO - PROCESS | 25989 | __metrics Screen width/height:1600/1200 09:33:33 INFO - PROCESS | 25989 | colorDepth:24 09:33:33 INFO - PROCESS | 25989 | Browser inner width/height: 1024/697 09:33:33 INFO - PROCESS | 25989 | __metrics 09:33:34 ERROR - PROCESS | 25989 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:33:35 INFO - TEST-INFO | 25989: exit 0 09:33:35 INFO - Browser initialized. 09:33:35 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:35 INFO - TEST-INFO | started process 26109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUXHxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:46 INFO - PROCESS | 26109 | RSS: Main: 164282368 09:33:46 INFO - PROCESS | 26109 | 09:34:36 INFO - PROCESS | 26109 | 1470760476592 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] 09:36:48 INFO - PROCESS | 26109 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49450/tests/dromaeo/cssquery-ext.html) 09:36:50 INFO - PROCESS | 26109 | RSS: Main: 166170624 09:36:50 INFO - PROCESS | 26109 | 09:39:52 INFO - PROCESS | 26109 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-ext.html (next: http://localhost:49450/tests/dromaeo/cssquery-jquery.html) 09:39:53 INFO - PROCESS | 26109 | RSS: Main: 166453248 09:39:53 INFO - PROCESS | 26109 | 09:42:55 INFO - PROCESS | 26109 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49450/tests/dromaeo/cssquery-mootools.html) 09:42:55 INFO - PROCESS | 26109 | RSS: Main: 169181184 09:42:55 INFO - PROCESS | 26109 | 09:45:57 INFO - PROCESS | 26109 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49450/tests/dromaeo/cssquery-prototype.html) 09:45:58 INFO - PROCESS | 26109 | RSS: Main: 163434496 09:45:58 INFO - PROCESS | 26109 | 09:49:01 INFO - PROCESS | 26109 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49450/tests/dromaeo/cssquery-yui.html) 09:49:01 INFO - PROCESS | 26109 | RSS: Main: 165474304 09:49:01 INFO - PROCESS | 26109 | 09:52:04 INFO - PROCESS | 26109 | Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-yui.html (next: http://localhost:49450/tests/dromaeo/cssquery-dojo.html) 09:52:04 INFO - PROCESS | 26109 | RSS: Main: 169050112 09:52:04 INFO - PROCESS | 26109 | 09:52:04 INFO - PROCESS | 26109 | __start_tp_report 09:52:04 INFO - PROCESS | 26109 | _x_x_mozilla_page_load 09:52:04 INFO - PROCESS | 26109 | _x_x_mozilla_page_load_details 09:52:04 INFO - PROCESS | 26109 | |i|pagename|runs| 09:52:05 INFO - PROCESS | 26109 | |0;dojo.html;2660.4014096828214;2685.462907418517;2698.25797905576;2702.567589185731;2708.6072519484687;4603.44758628965;4837.08095461862;4851.17530019897;4880.389951256093;4891.339669144664;4698.13084579353;4736.692115012522;4750.28745688147;4752.263399173125;4807.639427042968;4309.26742453782;4366.67249956253;4406.977965110186;4492.056668099703;4508.256137737286;4413.58070983256;4415.624671902892;4458.554144585548;4466.441694788152;4503.166914120881;4170.16596680662;4316.2446571849805;4353.717008394444;4364.061726728737;4376.956230437702;4350.042990542076;4354.7604881731495;4364.781760911942;4368.628666563346;4417.160739459525;4324.870253892388;4360.563943605645;4383.364412160251;4396.900774806299;4425.380446737459;4733.219018861918;4778.450478194983;4809.182438985381;4809.759512024385;4815.229563269895;5132.974335128338;5141.794328226866;5148.639595228336;5174.482551744795;5192.091384007821;4944.085344211332;5161.483851614846;5185.222216667492;5191.325127733408;5195.844124676266;4700.083483720676;4713.764311784397;4736.3369128322065;4751.4535828379485;4798.736069516141;5155.304033955368;5177.404598471224;5177.948220517822;5178.171492561172;5246.370435547682;4833.516648335139;4989.301497790312;5006.148954677714;5012.398512178562;5015.699058056455;5044.218146187347;5059.974700126476;5073.7716802743225;5075.264086707407;5138.203578445347;5036.143855544493;5055.140626093573;5057.544820966131;5060.898782024339;5069.7465126744255;4851.102546028996;5005.6996580205305;5019.422766381913;5034.89930201394;5050.292958985745;4211.7262377945335;4252.638525725348;4263.850765223202;4274.679399045084;4303.289957157097;3704.9800965951704;3718.1262403335195;3719.5536535615897;3750.3999360102252;3752.5309336332957;4279.550647182064;4409.36064270679;4411.84558540456;4430.667699922518;4434.711743736647;5012.924806127911;5065.670731402447;5069.214271787879;5111.080005598954;5134.101532231919;4396.560343965578;4418.403515525427;4418.867433976986;4431.8670439886855;4461.196984542748;4379.255526560492;4558.293464513005;4561.589456948891;4589.472210695746;4604.447466304065;4847.515248475124;4859.538343857399;4882.707037577757;4892.90214195707;4946.233333833262;5186.273921651047;5195.116830138961;5199.532042116228;5219.399769026459;5254.185601231815;4656.8602941911795;4858;4891.608671306358;4903.485134060872;4906.754662266801;4952.5542701157065;4972.825951091694;4988.027334669705;4996.375453068366;5026.070177017264;5085.4914508548845;5087.64386492942;5089.185730283137;5095.821646242363;5128.153854613947;4705.2706830439965;4870.512948705243;4899.681520701286;4901.436334821541;4949.257611358325;4905.4358748742925;4935.753212339297;4952.083864484937;5003.3245511856885;5023.572996295356;4879.609631229422;4883;4902.730349830794;4911.115999120049;4962.925556116734;4987.501249874984;5013.799448022184;5015.022070696179;5019.447860735243;5073.036123136592;4690.366800482027;4886.95113048865;4926.211806111005;4935.259711043373;5000.649954503296 09:52:05 INFO - PROCESS | 26109 | |1;ext.html;558.7373934250901;558.991615125773;564.1763025982066;573.2061095382895;602.2174363882906;35495.82252088739;39662.60337396629;39778.80110599443;39809.60190398099;39872.40191397131;38490.615093849054;39191;39237.60762392375;39259.21481570367;39334;7568.735094271701;7653.15815260321;7763.573003484835;7772.689092436324;7777.533347999138;7616.3906887448875;7734.071911370644;7734.922650773505;7741.225877412242;7745.883811742829;7763.534187948741;7780.338671212954;7780.455368124233;7783.805404864867;7800.492967957065;7710.614469276542;7726.150123486412;7744.070711514598;7750.922490775077;7767.844643107134;7612.923870761277;7622.4664273500875;7639.465237433382;7703.075630924269;7727.18864519223;36958.260834783425;37188.62811371878;37189.62810371889;37249.25501489955;37323.62676373229;3030.3787723516625;3067.3251884585356;3160.3995240904383;3193.2495863472063;3682.097886017916;28518;28724;29084.854575727197;29168;29864.253393665116;3479.1302174456387;3527.7177825773874;3536.9469457958153;3560.768550044239;3600.5859326177565;258734;260267;262080;262269;262983;32169.35661286808;54670.726646366515;54909;55006.17490737642;55073.724631376586;32681.346373072407;34204.48693269603;34248.82875585656;34518;34613.13467163341;12932.806007909889;13039;13044.086913915935;13152.802707959388;13160.078794484485;10707.196960228013;10720.785584288271;10755.78488430227;10774.299670521548;10782;7795.922040779519;7979.800504987422;8003;8085;8097.514149151069;3088.258817883692;3114.096911895525;3130.436521426165;3174.3016536361965;3199.9680003200137;876.6274333408276;907.4782000349825;932.874062001621;953.6376177052675;981.9738373399814;28087.285018391245;28773.56839647407;29161.85419072891;29490.11529654114;29557;925.5326060339486;930.8138372325562;973.73709098543;979.8481235408523;990.9306348555532;14488.855111448962;15001.849981500045;15248.847511524964;15252.084874907541;15312.234388280542;204025;204526;205999;206914;441943;50927.74536127296;51325.23012154821;51349.22976155361;51525;51603.48396515987;1164.2665120973732;1182.5092586576475;1203.8435003449495;1214.842070530843;1216.2580825696318;26704.599431008162;27669.86165069162;27740.58389124205;28284.15147545577;28512.144635660963;42826.35760463658;42937;43088;43149.352759708;43185.56814431815;330516;332083;334724;334925;335357.848161384;25206.49587008213;25722.8713856437;25831.870840645675;25918.740812591634;26391.34021649474;41869;42286.788566056974;42298.15403691847;42605.147897041265;43094.78452607717;35946.28107437785;36429.27141457209;36871.44692829663;37973.620263797005;38059.61940380672;35558.822205888806;35571.64428355683;35940;35943.64056359403;35988.4601730969;35592.110197245274;35705.28589428145;35926.461103082955;35959.82020089988;36641.26717465689;31491.795574309577;33343.49984750279;33865;34014.65985340214;34016.489752654226;25644.230673079837;25882.482350353264;25965.6105158419;25971.870140649175;26441.867790661694 09:52:05 INFO - PROCESS | 26109 | |2;jquery.html;346.5079586986479;355.2628296285208;358.1672611179009;378.33602028440083;387.82547853465945;16055.11696856674;17121.743173852403;17858.196381162863;18023.27906883723;18107.275708971658;16944.3222271109;17260.96434213948;17900.462986110404;18058.735888487812;18075.367362142326;5119.155339369009;5329.573634109262;5330.147176451768;5331.306930099082;5331.360236771593;3755.1550901047317;5284.920726189111;5904;6149.723262453178;6160.969195154018;6177.860175826814;6197.69011549423;6203.596766210182;6223.471004964584;6226.782062627809;6186.690665466709;6200.255969283669;6227.782027629034;6231.626102433823;6232.096346029823;4589.426321709786;4892.119418504668;5441;5465.125579907196;5484.670919744788;11176.720581985433;11290.435478226056;11298.096152307879;11309.434528273554;12759.93620031894;1875.6436277107307;1876.69972804352;1891.7162425636266;2391.9880400597885;2414.263649586875;9180.403273787182;9215.815683686289;9336.15974562286;9571.760705982337;9670.56482458291;1642.4005238088132;1691.6870378979804;1720.5096547484031;1775.7602723632403;1879.9718004229946;63167;67326.66336668334;68820.6558967202;69400;70080.29919700789;9919.80160396788;10027.247956403298;10093;10259.58961641541;10328.535215915303;13521.256330901699;13648.727025459435;13868.167909925436;13883.861161388257;13897.652558686113;7092.893606595905;7376.668049937765;7469.178390377054;7604.885926710993;7618.771436856903;6960.860782784417;7096.432285417154;7154.284571542804;7208.891866622005;7281.890771638429;4055.959440405617;4174;4306.2894622387585;4417.977910110493;4451.844185453494;1507.1936513964977;1564.6166689161228;1628.9266982985794;1787.3744189533559;1809.1316168239318;790.6244533846492;825.8183199696057;863;873.0265753684723;921.2675922641516;16355.754663680054;17027.829721702874;17033.7444938326;17662.558436039202;17890.373836915907;855.5123579559715;866.0170706248454;885.2519620920312;888.4447220487195;941.1435593609782;9638.228941684649;9648.662296819577;9863.964283750247;9875.160611348116;10096.293259471766;392387;393410;400684;405761;405918;70599;75327;75440.62279688567;77114.61442692751;78746.6062669683;885.2077390735385;892.1078921078921;923.6674797073048;928.4336554701762;930.4417349590192;15210.239488025332;15400.998935069185;15743.370265189722;15982.280797363914;15987.120708361152;35218;37017;37524;37596.436053459765;38048.42927356147;49900;51134.74432627962;51537.96924061573;51562.48437515577;52429.7378513105;6952.235254121942;6980.336867997532;7069.116360454943;7105;7141.928580714126;9681.903180968382;9896.356736812084;10486.790264194826;11053.557857685602;11409.144314176636;9118.143417781162;9246.121618446237;9307.348485605942;9405.670801521914;9823.410595364301;9848.852267216142;9985.101340879355;10210.183185345302;10237.9488102559;10313.174946004452;9252.768680782765;9434.905650943678;9523.380980236263;9571.37786043905;9842.458664773507;6673.199216093905;6880.518363714492;6962.1297337832775;7146.785596431907;7625.1231108421025;7880.408969327209;9007.504587247502;9316.860247096163;9658.227341812779;9700 09:52:05 INFO - PROCESS | 26109 | |3;mootools.html;1315.3423288355818;1374.8831349335308;1400.6988497473042;1652.3555813232833;1668.3243286468976;6236;6937.3409526095065;7011.1937127230385;7516.248375162481;7561.281678240565;6986.720531178759;7206.099237595301;7229.819254518639;7270.054892863934;7303.890441643366;2068.7931206879266;2107.1992642795717;2109.1879626343894;2111.6199084164846;2112.725345705056;2050.159434631801;2081.2195426714984;2086.426232785981;2132.9146834126695;2136.519283161284;2092;2094.1623350659784;2106.399676092314;2114.851960362775;2128.712623795783;2071.2854065347433;2082.239982406426;2084.062172022596;2084.32259515658;2091.299414696071;2042.2647846775149;2044.2231951858198;2063.092239414653;2068.2864411777914;2071.2025870039993;6978.162620485524;7083.964580177118;7143.321384468467;7143.5356701814735;7190.424766018706;4327.935080973788;4475.977620111878;4501.324801279801;4520.095980803852;4539.727616342997;2662.1747258349974;2740.931476713098;2763.765079968205;2816.788740844445;2819.2528979820363;887.3256325192835;928.0487500312234;942.4345392764355;946.8532377481501;963.0706368354571;9674.75813104671;9767.951160244224;9801.264905132073;9808.90191098087;9811.509424528746;3906.648401643866;3980.840766369313;4127.277726397869;4161.334186530141;4164.1879833432795;8416.452930559493;8420.15798420153;8429.199226073513;8443.704470343508;8453.746387608382;4494.325851122292;4517.548245175456;4526.23054080807;4538.773061346919;4552.817887284537;3419.333230020172;4023;4120.031792528754;4135.958640413617;4149.668026557929;3514.61339252682;3563.322968635951;3616.9819150904077;3641.8361173747244;3673.3204357194004;1124.3815901254277;1159.6579009192308;1194.474431250247;1196.8085106382937;1197.9460924258428;763.9274268944441;794.9483283586549;798.5328582779023;801.6913488307043;808.5189312359137;4867.488913664085;4901.828436004723;4953.8018479261145;4974.353334066621;5045.990801839646;411.6727201874517;425.07121938564336;425.3407218810831;430.5543762206164;445.91973444779603;3379.053864917827;3381.9154521136675;3388.4070287699556;3398.235397035647;3449.5688038995127;8701.912980870236;9104.13510716481;9106.954465227764;9125.543722813833;9130.589123489459;9060.95469522648;9081.273498120134;9103.544822758968;9106.908930910738;9107.316951228684;6901.171859376806;6966.268541803139;7006.439484841302;7029.051078104492;7042.507024508338;4901.926471103007;4926.285688575208;4964.553190212898;4997.075541024922;5143.0999575073465;8077;8339.499630022217;8371.16288371158;8458.95770521168;8486.787830304293;8389.622466989122;8462.449940753831;8523.573821308786;8569.657213711382;8573.399862009599;5586.52514536269;6076.54425918049;6264.060390941395;6346.238451385679;6509.349065093453;6929.133858267716;6998.195207551197;7009.334113259232;7049.823754406181;7066.505344625827;6284.088807123033;6383.87232255343;6393.2328120625825;6520.543561950808;6528.510361722795;6049.758009679564;6115.266168059861;6170.413810687977;6298.905516417166;6349.269833969152;5661.264035675335;5770.105633626795;5777.62445441045;5792.797252096325;5812.593118481665;4231.344141658048;4237.724547904377;4275.786210689391;4284.978575107105;4421.955780442155;4424.247877860707;4438.60052595268;4445.155420470101;4509.864704058883;4617.191991401559 09:52:05 INFO - PROCESS | 26109 | |4;prototype.html;286.4228579412484;295.35022949511074;302.41784564712924;303.24038284098333;303.53862129563066;4841.709497430148;4986.925196122061;5074.619403544735;5123.718195499246;5125.359330083739;4950.727709975949;4984.551390374865;4989.700617962916;4998.225275082368;5018.64869459138;3955.66376857966;3960.8019599020076;3978.8408463661417;3979.1643754811525;4000.599940006005;3868;3925.8037098145123;3979.104701442167;4002.359622460407;4002.439658447805;3897.532296124469;3933.567307596162;3935.2129574085156;3936.6850651947775;3965.9801700991457;3923.0976875318693;3948.545917219528;3950.585188555218;3962.316015693333;3972.205558888234;3519.1554027033585;3520.1375662962737;3522.1018640246575;3526.2594855080465;3532.328857517089;4603.424571928509;4835.540623640749;4877.195262781673;5002.1746411842005;5006.849794506171;4363.38912552243;4376.446361541639;4379.58393952574;4383.956160438419;4396.582324679151;5195.168633094934;5210.557102646279;5226.372835259755;5227.2159176123505;5250.579953603703;3503.9649603503894;3669.43123815809;3696.8336424860945;3703.611120832301;3714.4985426967555;5508.55931525477;5510;5518.172274158908;5530.668159910378;5532.446755324476;3829.6553310202216;3848.7113466490127;3852.653261206505;3857;3859.6333348331864;3907.6092390761264;3909.9638595772144;3913.5108111486065;3931.8034098295543;3942.4677668514382;4172.3532852407925;4405;4417.558244175557;4421.801018954155;4430.224710675619;5219.739013049409;5266.894662106736;5272.578193744491;5281.181416880313;5333.57331413486;1268.987310126887;1307.1895424836662;1320.386020500472;1330.767115754739;1332.8000799880097;879.7668617816283;898.7393655839865;924.3621900888365;927.1331305229631;931.9207867331353;4620.953790462052;4622.2835460503675;4622.722636641813;4625.930611040837;4683.250679891201;5409.215663728737;5412.810551630674;5418.349798024262;5422.511973922287;5427.945720542823;4516.345129956138;4633.536646335339;4650.348951146842;4654.185517534418;4665.46347170073;2487.017628036915;2499.4001439654717;2519.760622740837;2538.860362680033;2546.8666443432494;4534.863954081383;4545.681802273875;4547.8635640930825;4553.362529245908;4556.954430455653;4542.068875880436;4800.783964721596;4843.370361853007;4867.464578896319;4870.951290487121;4484.506704262529;4491.7754112293605;4525.547445255448;4541.977290113595;4549.363089167519;4789.808407663794;4795.472498025284;4802.8799280018275;4817.975910120567;4821.831235906867;4700.341952126773;4725;4751.978324660215;4767.808047988003;4778.307145463958;4742.743173059211;5155.118381790694;5198.8960220794615;5201.063808514353;5207.3751149862255;3829.3107240695826;3845.057960799622;3846.3461211593535;3851.9614803852724;3869.8065096744485;5206.869828254324;5490.6431081979545;5498.645826046029;5510.649890776625;5538.778448862162;5162.793488260428;5287.312649355559;5315.601329900351;5316.255724198692;5322.084049742012;5303.257543943928;5304.814331498379;5314.707691076873;5321.920171197357;5329.147336426153;5127.743612819269;5223.608229382888;5240.89518209626;5254.527092561688;5274.340707411574;5325.866853328698;5338.946610533845;5343.7862485500145;5350.866228344167;5351.839444816662;5247.344081989751;5249.553787928069;5257.5005374489365;5259.631825772312;5263.763130659053 09:52:05 INFO - PROCESS | 26109 | |5;yui.html;617.3980369140089;649.6849028221312;660.7786391558825;748.0985412577844;748.4685873030148;13147.868521314784;13396.196228226314;13801.30993450326;14318.57044288673;14355.066920650164;15329;15376.769348459755;15517.53447396577;15525.990810597303;15626.062436253833;783.0329543014373;810.4893916832388;814.4339683919678;815.3110621524831;819.5246756880995;647.9416852483275;769.4344656677338;786.8111653203218;797.1988151907325;800.5396896784343;840.4663038970236;843.6119385082869;845.1252953193446;845.2181731898;845.8308338332328;832.7751507093081;835.0855812884912;835.3359079531787;836.690424542917;839.5172775653963;611.4619135161074;612.9478994285491;612.9632222066646;613.5950272819962;613.8894998900196;13122.47510099595;13143.408546615425;13167.407466664023;13276;13315.53395631158;12989.41547630359;13261.204327740366;13338.533151339754;13423.597292081253;13490.865091349157;10386.532606032746;10407.68776936693;10418.895811041944;10421.426821524814;10485.895141048568;3220.500822372536;3257.8371081445835;3258.771885967983;3308.0902751743224;3326.185084654251;54151.72924135393;55873;56874.43125568733;63417.36582634161;68929;9892.25808064398;10067.69796906094;10288.742781430374;10451.457614306564;10467.319624224401;18202;18335.174917128763;19047.1428785705;19101.235950561822;19162.13770380336;6640.468762498988;6760.83097922546;6781.898271525931;6798.184217893884;6876.243613202544;3808.733388662767;3812.0850995760816;3833.8466461341236;3891.3384724596885;3929.1945151243926;2774.9445011099665;2869.827810331387;2879.5824605432094;2958.9408211835644;2995.5057415526194;499.4381321013859;500.6443203531209;503.979840806371;512.0169274992024;519.6622195572908;599.5772980049055;608;608.1546650156287;614.2291424262611;619.7304172684896;7748.573828439377;7886.320794600509;8340.541270230196;8428.11504791988;8450.704225352083;578.9739461724232;608.9025755879038;610.1172846819107;610.7862248213179;611.4894063456974;3621.3662609043313;3818.59904710007;3870.651641352292;3928.135810121769;3974.5429275633096;63804.68097659482;105414.47292763487;108657;109567;110094.44952775184;88678.55660721655;90807;91177;91592.54203729072;94540.52729736308;75525.24474755292;76920;77228;78717.60641196757;79966.20033799588;7315.268473152642;7691.5769632670745;7702.576358300347;7767.805804854924;7882.802929926797;48188.31340903052;48717;49403.50596493989;49407.50592494029;51020.23469647884;37858.24283514369;53192.20211696905;68237.31762682309;69027.65486172537;70259.64870175616;10942.835857462303;11388.544458221579;11838.28970261787;12045.51817927273;12102.51589936428;12680;12848.293343865804;13118.058555136962;13137.934310328386;13616.931915340756;12260.448279827608;12379.381030948596;12589.82808591757;12965.41655625518;13154.539591114266;10724.302920310154;11038.392888390894;11374.374409407232;11447.25592836463;11656.125790565911;11485.598004069818;11595.652130436101;11771.176017678681;11853.051755859338;12277.877221228031;9041.412308199946;9086.22767064807;9129.974217016737;9321;9340.252779777737;8680.091264732426;8786.780330491789;9433.811323773623;9499.477528735986;9686.273529485175 09:52:05 INFO - PROCESS | 26109 | __end_tp_report 09:52:05 INFO - PROCESS | 26109 | __start_cc_report 09:52:05 INFO - PROCESS | 26109 | _x_x_mozilla_cycle_collect,370 09:52:05 INFO - PROCESS | 26109 | __end_cc_report 09:52:05 INFO - PROCESS | 26109 | __startTimestamp1470761524994__endTimestamp 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - PROCESS | 26109 | ------- Summary: start ------- 09:52:05 INFO - PROCESS | 26109 | Number of tests: 6 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - PROCESS | 26109 | [#0] dojo.html Cycles:165 Average:4708.83 Median:4879.61 stddev:494.85 (10.1%) stddev-sans-first:469.55 09:52:05 INFO - PROCESS | 26109 | Values: 2660.4 2685.5 2698.3 2702.6 2708.6 4603.4 4837.1 4851.2 4880.4 4891.3 4698.1 4736.7 4750.3 4752.3 4807.6 4309.3 4366.7 4407.0 4492.1 4508.3 4413.6 4415.6 4458.6 4466.4 4503.2 4170.2 4316.2 4353.7 4364.1 4377.0 4350.0 4354.8 4364.8 4368.6 4417.2 4324.9 4360.6 4383.4 4396.9 4425.4 4733.2 4778.5 4809.2 4809.8 4815.2 5133.0 5141.8 5148.6 5174.5 5192.1 4944.1 5161.5 5185.2 5191.3 5195.8 4700.1 4713.8 4736.3 4751.5 4798.7 5155.3 5177.4 5177.9 5178.2 5246.4 4833.5 4989.3 5006.1 5012.4 5015.7 5044.2 5060.0 5073.8 5075.3 5138.2 5036.1 5055.1 5057.5 5060.9 5069.7 4851.1 5005.7 5019.4 5034.9 5050.3 4211.7 4252.6 4263.9 4274.7 4303.3 3705.0 3718.1 3719.6 3750.4 3752.5 4279.6 4409.4 4411.8 4430.7 4434.7 5012.9 5065.7 5069.2 5111.1 5134.1 4396.6 4418.4 4418.9 4431.9 4461.2 4379.3 4558.3 4561.6 4589.5 4604.4 4847.5 4859.5 4882.7 4892.9 4946.2 5186.3 5195.1 5199.5 5219.4 5254.2 4656.9 4858.0 4891.6 4903.5 4906.8 4952.6 4972.8 4988.0 4996.4 5026.1 5085.5 5087.6 5089.2 5095.8 5128.2 4705.3 4870.5 4899.7 4901.4 4949.3 4905.4 4935.8 4952.1 5003.3 5023.6 4879.6 4883.0 4902.7 4911.1 4962.9 4987.5 5013.8 5015.0 5019.4 5073.0 4690.4 4887.0 4926.2 4935.3 5000.6 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - PROCESS | 26109 | [#1] ext.html Cycles:180 Average:43410.57 Median:35944.96 stddev:76358.97 (212.4%) stddev-sans-first:76505.39 09:52:05 INFO - PROCESS | 26109 | Values: 558.7 559.0 564.2 573.2 602.2 35495.8 39662.6 39778.8 39809.6 39872.4 38490.6 39191.0 39237.6 39259.2 39334.0 7568.7 7653.2 7763.6 7772.7 7777.5 7616.4 7734.1 7734.9 7741.2 7745.9 7763.5 7780.3 7780.5 7783.8 7800.5 7710.6 7726.2 7744.1 7750.9 7767.8 7612.9 7622.5 7639.5 7703.1 7727.2 36958.3 37188.6 37189.6 37249.3 37323.6 3030.4 3067.3 3160.4 3193.2 3682.1 28518.0 28724.0 29084.9 29168.0 29864.3 3479.1 3527.7 3536.9 3560.8 3600.6 258734.0 260267.0 262080.0 262269.0 262983.0 32169.4 54670.7 54909.0 55006.2 55073.7 32681.3 34204.5 34248.8 34518.0 34613.1 12932.8 13039.0 13044.1 13152.8 13160.1 10707.2 10720.8 10755.8 10774.3 10782.0 7795.9 7979.8 8003.0 8085.0 8097.5 3088.3 3114.1 3130.4 3174.3 3200.0 876.6 907.5 932.9 953.6 982.0 28087.3 28773.6 29161.9 29490.1 29557.0 925.5 930.8 973.7 979.8 990.9 14488.9 15001.8 15248.8 15252.1 15312.2 204025.0 204526.0 205999.0 206914.0 441943.0 50927.7 51325.2 51349.2 51525.0 51603.5 1164.3 1182.5 1203.8 1214.8 1216.3 26704.6 27669.9 27740.6 28284.2 28512.1 42826.4 42937.0 43088.0 43149.4 43185.6 330516.0 332083.0 334724.0 334925.0 335357.8 25206.5 25722.9 25831.9 25918.7 26391.3 41869.0 42286.8 42298.2 42605.1 43094.8 35946.3 36429.3 36871.4 37973.6 38059.6 35558.8 35571.6 35940.0 35943.6 35988.5 35592.1 35705.3 35926.5 35959.8 36641.3 31491.8 33343.5 33865.0 34014.7 34016.5 25644.2 25882.5 25965.6 25971.9 26441.9 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - PROCESS | 26109 | [#2] jquery.html Cycles:180 Average:24230.44 Median:5453.06 stddev:65917.18 (1208.8%) stddev-sans-first:66077.70 09:52:05 INFO - PROCESS | 26109 | Values: 346.5 355.3 358.2 378.3 387.8 16055.1 17121.7 17858.2 18023.3 18107.3 16944.3 17261.0 17900.5 18058.7 18075.4 5119.2 5329.6 5330.1 5331.3 5331.4 3755.2 5284.9 5904.0 6149.7 6161.0 6177.9 6197.7 6203.6 6223.5 6226.8 6186.7 6200.3 6227.8 6231.6 6232.1 4589.4 4892.1 5441.0 5465.1 5484.7 11176.7 11290.4 11298.1 11309.4 12759.9 1875.6 1876.7 1891.7 2392.0 2414.3 9180.4 9215.8 9336.2 9571.8 9670.6 1642.4 1691.7 1720.5 1775.8 1880.0 63167.0 67326.7 68820.7 69400.0 70080.3 9919.8 10027.2 10093.0 10259.6 10328.5 13521.3 13648.7 13868.2 13883.9 13897.7 7092.9 7376.7 7469.2 7604.9 7618.8 6960.9 7096.4 7154.3 7208.9 7281.9 4056.0 4174.0 4306.3 4418.0 4451.8 1507.2 1564.6 1628.9 1787.4 1809.1 790.6 825.8 863.0 873.0 921.3 16355.8 17027.8 17033.7 17662.6 17890.4 855.5 866.0 885.3 888.4 941.1 9638.2 9648.7 9864.0 9875.2 10096.3 392387.0 393410.0 400684.0 405761.0 405918.0 70599.0 75327.0 75440.6 77114.6 78746.6 885.2 892.1 923.7 928.4 930.4 15210.2 15401.0 15743.4 15982.3 15987.1 35218.0 37017.0 37524.0 37596.4 38048.4 49900.0 51134.7 51538.0 51562.5 52429.7 6952.2 6980.3 7069.1 7105.0 7141.9 9681.9 9896.4 10486.8 11053.6 11409.1 9118.1 9246.1 9307.3 9405.7 9823.4 9848.9 9985.1 10210.2 10237.9 10313.2 9252.8 9434.9 9523.4 9571.4 9842.5 6673.2 6880.5 6962.1 7146.8 7625.1 7880.4 9007.5 9316.9 9658.2 9700.0 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - PROCESS | 26109 | [#3] mootools.html Cycles:180 Average:4829.15 Median:4969.45 stddev:2667.26 (53.7%) stddev-sans-first:2661.67 09:52:05 INFO - PROCESS | 26109 | Values: 1315.3 1374.9 1400.7 1652.4 1668.3 6236.0 6937.3 7011.2 7516.2 7561.3 6986.7 7206.1 7229.8 7270.1 7303.9 2068.8 2107.2 2109.2 2111.6 2112.7 2050.2 2081.2 2086.4 2132.9 2136.5 2092.0 2094.2 2106.4 2114.9 2128.7 2071.3 2082.2 2084.1 2084.3 2091.3 2042.3 2044.2 2063.1 2068.3 2071.2 6978.2 7084.0 7143.3 7143.5 7190.4 4327.9 4476.0 4501.3 4520.1 4539.7 2662.2 2740.9 2763.8 2816.8 2819.3 887.3 928.0 942.4 946.9 963.1 9674.8 9768.0 9801.3 9808.9 9811.5 3906.6 3980.8 4127.3 4161.3 4164.2 8416.5 8420.2 8429.2 8443.7 8453.7 4494.3 4517.5 4526.2 4538.8 4552.8 3419.3 4023.0 4120.0 4136.0 4149.7 3514.6 3563.3 3617.0 3641.8 3673.3 1124.4 1159.7 1194.5 1196.8 1197.9 763.9 794.9 798.5 801.7 808.5 4867.5 4901.8 4953.8 4974.4 5046.0 411.7 425.1 425.3 430.6 445.9 3379.1 3381.9 3388.4 3398.2 3449.6 8701.9 9104.1 9107.0 9125.5 9130.6 9061.0 9081.3 9103.5 9106.9 9107.3 6901.2 6966.3 7006.4 7029.1 7042.5 4901.9 4926.3 4964.6 4997.1 5143.1 8077.0 8339.5 8371.2 8459.0 8486.8 8389.6 8462.4 8523.6 8569.7 8573.4 5586.5 6076.5 6264.1 6346.2 6509.3 6929.1 6998.2 7009.3 7049.8 7066.5 6284.1 6383.9 6393.2 6520.5 6528.5 6049.8 6115.3 6170.4 6298.9 6349.3 5661.3 5770.1 5777.6 5792.8 5812.6 4231.3 4237.7 4275.8 4285.0 4422.0 4424.2 4438.6 4445.2 4509.9 4617.2 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - PROCESS | 26109 | [#4] prototype.html Cycles:180 Average:4287.61 Median:4674.36 stddev:1244.69 (26.6%) stddev-sans-first:1211.41 09:52:05 INFO - PROCESS | 26109 | Values: 286.4 295.4 302.4 303.2 303.5 4841.7 4986.9 5074.6 5123.7 5125.4 4950.7 4984.6 4989.7 4998.2 5018.6 3955.7 3960.8 3978.8 3979.2 4000.6 3868.0 3925.8 3979.1 4002.4 4002.4 3897.5 3933.6 3935.2 3936.7 3966.0 3923.1 3948.5 3950.6 3962.3 3972.2 3519.2 3520.1 3522.1 3526.3 3532.3 4603.4 4835.5 4877.2 5002.2 5006.8 4363.4 4376.4 4379.6 4384.0 4396.6 5195.2 5210.6 5226.4 5227.2 5250.6 3504.0 3669.4 3696.8 3703.6 3714.5 5508.6 5510.0 5518.2 5530.7 5532.4 3829.7 3848.7 3852.7 3857.0 3859.6 3907.6 3910.0 3913.5 3931.8 3942.5 4172.4 4405.0 4417.6 4421.8 4430.2 5219.7 5266.9 5272.6 5281.2 5333.6 1269.0 1307.2 1320.4 1330.8 1332.8 879.8 898.7 924.4 927.1 931.9 4621.0 4622.3 4622.7 4625.9 4683.3 5409.2 5412.8 5418.3 5422.5 5427.9 4516.3 4633.5 4650.3 4654.2 4665.5 2487.0 2499.4 2519.8 2538.9 2546.9 4534.9 4545.7 4547.9 4553.4 4557.0 4542.1 4800.8 4843.4 4867.5 4871.0 4484.5 4491.8 4525.5 4542.0 4549.4 4789.8 4795.5 4802.9 4818.0 4821.8 4700.3 4725.0 4752.0 4767.8 4778.3 4742.7 5155.1 5198.9 5201.1 5207.4 3829.3 3845.1 3846.3 3852.0 3869.8 5206.9 5490.6 5498.6 5510.6 5538.8 5162.8 5287.3 5315.6 5316.3 5322.1 5303.3 5304.8 5314.7 5321.9 5329.1 5127.7 5223.6 5240.9 5254.5 5274.3 5325.9 5338.9 5343.8 5350.9 5351.8 5247.3 5249.6 5257.5 5259.6 5263.8 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - PROCESS | 26109 | [#5] yui.html Cycles:180 Average:18174.19 Median:25762.11 stddev:26407.68 (102.5%) stddev-sans-first:26448.85 09:52:05 INFO - PROCESS | 26109 | Values: 617.4 649.7 660.8 748.1 748.5 13147.9 13396.2 13801.3 14318.6 14355.1 15329.0 15376.8 15517.5 15526.0 15626.1 783.0 810.5 814.4 815.3 819.5 647.9 769.4 786.8 797.2 800.5 840.5 843.6 845.1 845.2 845.8 832.8 835.1 835.3 836.7 839.5 611.5 612.9 613.0 613.6 613.9 13122.5 13143.4 13167.4 13276.0 13315.5 12989.4 13261.2 13338.5 13423.6 13490.9 10386.5 10407.7 10418.9 10421.4 10485.9 3220.5 3257.8 3258.8 3308.1 3326.2 54151.7 55873.0 56874.4 63417.4 68929.0 9892.3 10067.7 10288.7 10451.5 10467.3 18202.0 18335.2 19047.1 19101.2 19162.1 6640.5 6760.8 6781.9 6798.2 6876.2 3808.7 3812.1 3833.8 3891.3 3929.2 2774.9 2869.8 2879.6 2958.9 2995.5 499.4 500.6 504.0 512.0 519.7 599.6 608.0 608.2 614.2 619.7 7748.6 7886.3 8340.5 8428.1 8450.7 579.0 608.9 610.1 610.8 611.5 3621.4 3818.6 3870.7 3928.1 3974.5 63804.7 105414.5 108657.0 109567.0 110094.4 88678.6 90807.0 91177.0 91592.5 94540.5 75525.2 76920.0 77228.0 78717.6 79966.2 7315.3 7691.6 7702.6 7767.8 7882.8 48188.3 48717.0 49403.5 49407.5 51020.2 37858.2 53192.2 68237.3 69027.7 70259.6 10942.8 11388.5 11838.3 12045.5 12102.5 12680.0 12848.3 13118.1 13137.9 13616.9 12260.4 12379.4 12589.8 12965.4 13154.5 10724.3 11038.4 11374.4 11447.3 11656.1 11485.6 11595.7 11771.2 11853.1 12277.9 9041.4 9086.2 9130.0 9321.0 9340.3 8680.1 8786.8 9433.8 9499.5 9686.3 09:52:05 INFO - PROCESS | 26109 | -------- Summary: end -------- 09:52:05 INFO - PROCESS | 26109 | 09:52:05 INFO - TEST-INFO | 26109: exit 0 09:52:05 INFO - TEST-OK | dromaeo_css | took 1117475ms 09:52:05 INFO - TEST-START | kraken 09:52:05 INFO - operating with platform_type : linux_ 09:52:05 INFO - Initialising browser for kraken test... 09:52:05 INFO - TEST-INFO | started process 26354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf6QAxI/profile http://localhost:49450/getInfo.html) 09:52:10 INFO - PROCESS | 26354 | __metrics Screen width/height:1600/1200 09:52:10 INFO - PROCESS | 26354 | colorDepth:24 09:52:10 INFO - PROCESS | 26354 | Browser inner width/height: 1024/697 09:52:10 INFO - PROCESS | 26354 | __metrics 09:52:11 ERROR - PROCESS | 26354 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:52:12 INFO - TEST-INFO | 26354: exit 0 09:52:12 INFO - Browser initialized. 09:52:12 INFO - Running cycle 1/1 for kraken test... 09:52:12 INFO - TEST-INFO | started process 26474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf6QAxI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:24 INFO - PROCESS | 26474 | RSS: Main: 164421632 09:52:24 INFO - PROCESS | 26474 | 09:52:27 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:28 INFO - PROCESS | 26474 | RSS: Main: 169230336 09:52:28 INFO - PROCESS | 26474 | 09:52:31 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-dft) 09:52:31 INFO - PROCESS | 26474 | RSS: Main: 168013824 09:52:31 INFO - PROCESS | 26474 | 09:52:34 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-fft) 09:52:35 INFO - PROCESS | 26474 | RSS: Main: 164528128 09:52:35 INFO - PROCESS | 26474 | 09:52:37 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-oscillator) 09:52:38 INFO - PROCESS | 26474 | RSS: Main: 165138432 09:52:38 INFO - PROCESS | 26474 | 09:52:40 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:40 INFO - PROCESS | 26474 | RSS: Main: 165380096 09:52:40 INFO - PROCESS | 26474 | 09:52:44 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:44 INFO - PROCESS | 26474 | RSS: Main: 165998592 09:52:44 INFO - PROCESS | 26474 | 09:52:48 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:49 INFO - PROCESS | 26474 | RSS: Main: 162467840 09:52:49 INFO - PROCESS | 26474 | 09:52:52 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49450/tests/kraken/driver.html?testName=json-parse-financial) 09:52:52 INFO - PROCESS | 26474 | RSS: Main: 165007360 09:52:52 INFO - PROCESS | 26474 | 09:52:54 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:55 INFO - PROCESS | 26474 | RSS: Main: 165150720 09:52:55 INFO - PROCESS | 26474 | 09:52:56 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:57 INFO - PROCESS | 26474 | RSS: Main: 165179392 09:52:57 INFO - PROCESS | 26474 | 09:52:59 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:00 INFO - PROCESS | 26474 | RSS: Main: 165617664 09:53:00 INFO - PROCESS | 26474 | 09:53:03 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:04 INFO - PROCESS | 26474 | RSS: Main: 166047744 09:53:04 INFO - PROCESS | 26474 | 09:53:06 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:07 INFO - PROCESS | 26474 | RSS: Main: 166084608 09:53:07 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49450/tests/kraken/driver.html?testName=ai-astar) 09:53:09 INFO - PROCESS | 26474 | RSS: Main: 166789120 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | __start_tp_report 09:53:09 INFO - PROCESS | 26474 | _x_x_mozilla_page_load 09:53:09 INFO - PROCESS | 26474 | _x_x_mozilla_page_load_details 09:53:09 INFO - PROCESS | 26474 | |i|pagename|runs| 09:53:09 INFO - PROCESS | 26474 | |0;ai-astar;107;119;111;115;117;117;120;117;119;116 09:53:09 INFO - PROCESS | 26474 | |1;audio-beat-detection;156;124;144;198;129;151;150;130;186;123 09:53:09 INFO - PROCESS | 26474 | |2;audio-dft;163;164;164;173;162;163;164;165;164;162 09:53:09 INFO - PROCESS | 26474 | |3;audio-fft;76;76;77;175;81;77;77;77;155;77 09:53:09 INFO - PROCESS | 26474 | |4;audio-oscillator;86;87;143;88;86;85;145;85;88;142 09:53:09 INFO - PROCESS | 26474 | |5;imaging-gaussian-blur;118;118;117;118;118;118;118;118;118;118 09:53:09 INFO - PROCESS | 26474 | |6;imaging-darkroom;149;148;148;148;148;148;148;149;147;149 09:53:09 INFO - PROCESS | 26474 | |7;imaging-desaturate;95;95;96;95;96;96;100;100;100;96 09:53:09 INFO - PROCESS | 26474 | |8;json-parse-financial;63;63;63;63;66;63;63;63;64;66 09:53:09 INFO - PROCESS | 26474 | |9;json-stringify-tinderbox;66;66;69;65;66;65;66;65;66;65 09:53:09 INFO - PROCESS | 26474 | |10;stanford-crypto-aes;80;84;79;80;81;79;81;80;85;80 09:53:09 INFO - PROCESS | 26474 | |11;stanford-crypto-ccm;142;133;134;140;131;144;134;134;206;141 09:53:09 INFO - PROCESS | 26474 | |12;stanford-crypto-pbkdf2;173;169;170;172;177;175;168;174;178;173 09:53:09 INFO - PROCESS | 26474 | |13;stanford-crypto-sha256-iterative;69;69;68;69;68;68;69;68;69;70 09:53:09 INFO - PROCESS | 26474 | __end_tp_report 09:53:09 INFO - PROCESS | 26474 | __start_cc_report 09:53:09 INFO - PROCESS | 26474 | _x_x_mozilla_cycle_collect,943 09:53:09 INFO - PROCESS | 26474 | __end_cc_report 09:53:09 INFO - PROCESS | 26474 | __startTimestamp1470761589611__endTimestamp 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | ------- Summary: start ------- 09:53:09 INFO - PROCESS | 26474 | Number of tests: 14 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:3.99 (3.4%) stddev-sans-first:2.68 09:53:09 INFO - PROCESS | 26474 | Values: 107.0 119.0 111.0 115.0 117.0 117.0 120.0 117.0 119.0 116.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:150.50 stddev:25.63 (17.0%) stddev-sans-first:27.06 09:53:09 INFO - PROCESS | 26474 | Values: 156.0 124.0 144.0 198.0 129.0 151.0 150.0 130.0 186.0 123.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.17 (1.9%) stddev-sans-first:3.32 09:53:09 INFO - PROCESS | 26474 | Values: 163.0 164.0 164.0 173.0 162.0 163.0 164.0 165.0 164.0 162.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:37.32 (48.5%) stddev-sans-first:38.96 09:53:09 INFO - PROCESS | 26474 | Values: 76.0 76.0 77.0 175.0 81.0 77.0 77.0 77.0 155.0 77.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.00 stddev:27.52 (32.0%) stddev-sans-first:28.45 09:53:09 INFO - PROCESS | 26474 | Values: 86.0 87.0 143.0 88.0 86.0 85.0 145.0 85.0 88.0 142.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:53:09 INFO - PROCESS | 26474 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 09:53:09 INFO - PROCESS | 26474 | Values: 149.0 148.0 148.0 148.0 148.0 148.0 148.0 149.0 147.0 149.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:95.50 stddev:2.18 (2.3%) stddev-sans-first:2.20 09:53:09 INFO - PROCESS | 26474 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 100.0 100.0 100.0 96.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.30 09:53:09 INFO - PROCESS | 26474 | Values: 63.0 63.0 63.0 63.0 66.0 63.0 63.0 63.0 64.0 66.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 09:53:09 INFO - PROCESS | 26474 | Values: 66.0 66.0 69.0 65.0 66.0 65.0 66.0 65.0 66.0 65.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:2.02 (2.5%) stddev-sans-first:2.12 09:53:09 INFO - PROCESS | 26474 | Values: 80.0 84.0 79.0 80.0 81.0 79.0 81.0 80.0 85.0 80.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:140.50 stddev:22.27 (15.8%) stddev-sans-first:23.61 09:53:09 INFO - PROCESS | 26474 | Values: 142.0 133.0 134.0 140.0 131.0 144.0 134.0 134.0 206.0 141.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.50 stddev:3.28 (1.9%) stddev-sans-first:3.48 09:53:09 INFO - PROCESS | 26474 | Values: 173.0 169.0 170.0 172.0 177.0 175.0 168.0 174.0 178.0 173.0 09:53:09 INFO - PROCESS | 26474 | 09:53:09 INFO - PROCESS | 26474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:53:09 INFO - PROCESS | 26474 | Values: 69.0 69.0 68.0 69.0 68.0 68.0 69.0 68.0 69.0 70.0 09:53:09 INFO - PROCESS | 26474 | -------- Summary: end -------- 09:53:09 INFO - PROCESS | 26474 | 09:53:10 INFO - TEST-INFO | 26474: exit 0 09:53:10 INFO - TEST-OK | kraken | took 64904ms 09:53:10 INFO - SUITE-END | took 1182s 09:53:11 INFO - Completed test suite (00:19:42) 09:53:11 INFO - javascript benchmark 09:53:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6286.295394813712, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.4014096828214, 2685.462907418517, 2698.25797905576, 2702.567589185731, 2708.6072519484687, 4603.44758628965, 4837.08095461862, 4851.17530019897, 4880.389951256093, 4891.339669144664, 4698.13084579353, 4736.692115012522, 4750.28745688147, 4752.263399173125, 4807.639427042968, 4309.26742453782, 4366.67249956253, 4406.977965110186, 4492.056668099703, 4508.256137737286, 4413.58070983256, 4415.624671902892, 4458.554144585548, 4466.441694788152, 4503.166914120881, 4170.16596680662, 4316.2446571849805, 4353.717008394444, 4364.061726728737, 4376.956230437702, 4350.042990542076, 4354.7604881731495, 4364.781760911942, 4368.628666563346, 4417.160739459525, 4324.870253892388, 4360.563943605645, 4383.364412160251, 4396.900774806299, 4425.380446737459, 4733.219018861918, 4778.450478194983, 4809.182438985381, 4809.759512024385, 4815.229563269895, 5132.974335128338, 5141.794328226866, 5148.639595228336, 5174.482551744795, 5192.091384007821, 4944.085344211332, 5161.483851614846, 5185.222216667492, 5191.325127733408, 5195.844124676266, 4700.083483720676, 4713.764311784397, 4736.3369128322065, 4751.4535828379485, 4798.736069516141, 5155.304033955368, 5177.404598471224, 5177.948220517822, 5178.171492561172, 5246.370435547682, 4833.516648335139, 4989.301497790312, 5006.148954677714, 5012.398512178562, 5015.699058056455, 5044.218146187347, 5059.974700126476, 5073.7716802743225, 5075.264086707407, 5138.203578445347, 5036.143855544493, 5055.140626093573, 5057.544820966131, 5060.898782024339, 5069.7465126744255, 4851.102546028996, 5005.6996580205305, 5019.422766381913, 5034.89930201394, 5050.292958985745, 4211.7262377945335, 4252.638525725348, 4263.850765223202, 4274.679399045084, 4303.289957157097, 3704.9800965951704, 3718.1262403335195, 3719.5536535615897, 3750.3999360102252, 3752.5309336332957, 4279.550647182064, 4409.36064270679, 4411.84558540456, 4430.667699922518, 4434.711743736647, 5012.924806127911, 5065.670731402447, 5069.214271787879, 5111.080005598954, 5134.101532231919, 4396.560343965578, 4418.403515525427, 4418.867433976986, 4431.8670439886855, 4461.196984542748, 4379.255526560492, 4558.293464513005, 4561.589456948891, 4589.472210695746, 4604.447466304065, 4847.515248475124, 4859.538343857399, 4882.707037577757, 4892.90214195707, 4946.233333833262, 5186.273921651047, 5195.116830138961, 5199.532042116228, 5219.399769026459, 5254.185601231815, 4656.8602941911795, 4858.0, 4891.608671306358, 4903.485134060872, 4906.754662266801, 4952.5542701157065, 4972.825951091694, 4988.027334669705, 4996.375453068366, 5026.070177017264, 5085.4914508548845, 5087.64386492942, 5089.185730283137, 5095.821646242363, 5128.153854613947, 4705.2706830439965, 4870.512948705243, 4899.681520701286, 4901.436334821541, 4949.257611358325, 4905.4358748742925, 4935.753212339297, 4952.083864484937, 5003.3245511856885, 5023.572996295356, 4879.609631229422, 4883.0, 4902.730349830794, 4911.115999120049, 4962.925556116734, 4987.501249874984, 5013.799448022184, 5015.022070696179, 5019.447860735243, 5073.036123136592, 4690.366800482027, 4886.95113048865, 4926.211806111005, 4935.259711043373, 5000.649954503296], "value": 4677.479105419812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.7373934250901, 558.991615125773, 564.1763025982066, 573.2061095382895, 602.2174363882906, 35495.82252088739, 39662.60337396629, 39778.80110599443, 39809.60190398099, 39872.40191397131, 38490.615093849054, 39191.0, 39237.60762392375, 39259.21481570367, 39334.0, 7568.735094271701, 7653.15815260321, 7763.573003484835, 7772.689092436324, 7777.533347999138, 7616.3906887448875, 7734.071911370644, 7734.922650773505, 7741.225877412242, 7745.883811742829, 7763.534187948741, 7780.338671212954, 7780.455368124233, 7783.805404864867, 7800.492967957065, 7710.614469276542, 7726.150123486412, 7744.070711514598, 7750.922490775077, 7767.844643107134, 7612.923870761277, 7622.4664273500875, 7639.465237433382, 7703.075630924269, 7727.18864519223, 36958.260834783425, 37188.62811371878, 37189.62810371889, 37249.25501489955, 37323.62676373229, 3030.3787723516625, 3067.3251884585356, 3160.3995240904383, 3193.2495863472063, 3682.097886017916, 28518.0, 28724.0, 29084.854575727197, 29168.0, 29864.253393665116, 3479.1302174456387, 3527.7177825773874, 3536.9469457958153, 3560.768550044239, 3600.5859326177565, 258734.0, 260267.0, 262080.0, 262269.0, 262983.0, 32169.35661286808, 54670.726646366515, 54909.0, 55006.17490737642, 55073.724631376586, 32681.346373072407, 34204.48693269603, 34248.82875585656, 34518.0, 34613.13467163341, 12932.806007909889, 13039.0, 13044.086913915935, 13152.802707959388, 13160.078794484485, 10707.196960228013, 10720.785584288271, 10755.78488430227, 10774.299670521548, 10782.0, 7795.922040779519, 7979.800504987422, 8003.0, 8085.0, 8097.514149151069, 3088.258817883692, 3114.096911895525, 3130.436521426165, 3174.3016536361965, 3199.9680003200137, 876.6274333408276, 907.4782000349825, 932.874062001621, 953.6376177052675, 981.9738373399814, 28087.285018391245, 28773.56839647407, 29161.85419072891, 29490.11529654114, 29557.0, 925.5326060339486, 930.8138372325562, 973.73709098543, 979.8481235408523, 990.9306348555532, 14488.855111448962, 15001.849981500045, 15248.847511524964, 15252.084874907541, 15312.234388280542, 204025.0, 204526.0, 205999.0, 206914.0, 441943.0, 50927.74536127296, 51325.23012154821, 51349.22976155361, 51525.0, 51603.48396515987, 1164.2665120973732, 1182.5092586576475, 1203.8435003449495, 1214.842070530843, 1216.2580825696318, 26704.599431008162, 27669.86165069162, 27740.58389124205, 28284.15147545577, 28512.144635660963, 42826.35760463658, 42937.0, 43088.0, 43149.352759708, 43185.56814431815, 330516.0, 332083.0, 334724.0, 334925.0, 335357.848161384, 25206.49587008213, 25722.8713856437, 25831.870840645675, 25918.740812591634, 26391.34021649474, 41869.0, 42286.788566056974, 42298.15403691847, 42605.147897041265, 43094.78452607717, 35946.28107437785, 36429.27141457209, 36871.44692829663, 37973.620263797005, 38059.61940380672, 35558.822205888806, 35571.64428355683, 35940.0, 35943.64056359403, 35988.4601730969, 35592.110197245274, 35705.28589428145, 35926.461103082955, 35959.82020089988, 36641.26717465689, 31491.795574309577, 33343.49984750279, 33865.0, 34014.65985340214, 34016.489752654226, 25644.230673079837, 25882.482350353264, 25965.6105158419, 25971.870140649175, 26441.867790661694], "value": 16373.660176835529, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5079586986479, 355.2628296285208, 358.1672611179009, 378.33602028440083, 387.82547853465945, 16055.11696856674, 17121.743173852403, 17858.196381162863, 18023.27906883723, 18107.275708971658, 16944.3222271109, 17260.96434213948, 17900.462986110404, 18058.735888487812, 18075.367362142326, 5119.155339369009, 5329.573634109262, 5330.147176451768, 5331.306930099082, 5331.360236771593, 3755.1550901047317, 5284.920726189111, 5904.0, 6149.723262453178, 6160.969195154018, 6177.860175826814, 6197.69011549423, 6203.596766210182, 6223.471004964584, 6226.782062627809, 6186.690665466709, 6200.255969283669, 6227.782027629034, 6231.626102433823, 6232.096346029823, 4589.426321709786, 4892.119418504668, 5441.0, 5465.125579907196, 5484.670919744788, 11176.720581985433, 11290.435478226056, 11298.096152307879, 11309.434528273554, 12759.93620031894, 1875.6436277107307, 1876.69972804352, 1891.7162425636266, 2391.9880400597885, 2414.263649586875, 9180.403273787182, 9215.815683686289, 9336.15974562286, 9571.760705982337, 9670.56482458291, 1642.4005238088132, 1691.6870378979804, 1720.5096547484031, 1775.7602723632403, 1879.9718004229946, 63167.0, 67326.66336668334, 68820.6558967202, 69400.0, 70080.29919700789, 9919.80160396788, 10027.247956403298, 10093.0, 10259.58961641541, 10328.535215915303, 13521.256330901699, 13648.727025459435, 13868.167909925436, 13883.861161388257, 13897.652558686113, 7092.893606595905, 7376.668049937765, 7469.178390377054, 7604.885926710993, 7618.771436856903, 6960.860782784417, 7096.432285417154, 7154.284571542804, 7208.891866622005, 7281.890771638429, 4055.959440405617, 4174.0, 4306.2894622387585, 4417.977910110493, 4451.844185453494, 1507.1936513964977, 1564.6166689161228, 1628.9266982985794, 1787.3744189533559, 1809.1316168239318, 790.6244533846492, 825.8183199696057, 863.0, 873.0265753684723, 921.2675922641516, 16355.754663680054, 17027.829721702874, 17033.7444938326, 17662.558436039202, 17890.373836915907, 855.5123579559715, 866.0170706248454, 885.2519620920312, 888.4447220487195, 941.1435593609782, 9638.228941684649, 9648.662296819577, 9863.964283750247, 9875.160611348116, 10096.293259471766, 392387.0, 393410.0, 400684.0, 405761.0, 405918.0, 70599.0, 75327.0, 75440.62279688567, 77114.61442692751, 78746.6062669683, 885.2077390735385, 892.1078921078921, 923.6674797073048, 928.4336554701762, 930.4417349590192, 15210.239488025332, 15400.998935069185, 15743.370265189722, 15982.280797363914, 15987.120708361152, 35218.0, 37017.0, 37524.0, 37596.436053459765, 38048.42927356147, 49900.0, 51134.74432627962, 51537.96924061573, 51562.48437515577, 52429.7378513105, 6952.235254121942, 6980.336867997532, 7069.116360454943, 7105.0, 7141.928580714126, 9681.903180968382, 9896.356736812084, 10486.790264194826, 11053.557857685602, 11409.144314176636, 9118.143417781162, 9246.121618446237, 9307.348485605942, 9405.670801521914, 9823.410595364301, 9848.852267216142, 9985.101340879355, 10210.183185345302, 10237.9488102559, 10313.174946004452, 9252.768680782765, 9434.905650943678, 9523.380980236263, 9571.37786043905, 9842.458664773507, 6673.199216093905, 6880.518363714492, 6962.1297337832775, 7146.785596431907, 7625.1231108421025, 7880.408969327209, 9007.504587247502, 9316.860247096163, 9658.227341812779, 9700.0], "value": 8054.515617410505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.3423288355818, 1374.8831349335308, 1400.6988497473042, 1652.3555813232833, 1668.3243286468976, 6236.0, 6937.3409526095065, 7011.1937127230385, 7516.248375162481, 7561.281678240565, 6986.720531178759, 7206.099237595301, 7229.819254518639, 7270.054892863934, 7303.890441643366, 2068.7931206879266, 2107.1992642795717, 2109.1879626343894, 2111.6199084164846, 2112.725345705056, 2050.159434631801, 2081.2195426714984, 2086.426232785981, 2132.9146834126695, 2136.519283161284, 2092.0, 2094.1623350659784, 2106.399676092314, 2114.851960362775, 2128.712623795783, 2071.2854065347433, 2082.239982406426, 2084.062172022596, 2084.32259515658, 2091.299414696071, 2042.2647846775149, 2044.2231951858198, 2063.092239414653, 2068.2864411777914, 2071.2025870039993, 6978.162620485524, 7083.964580177118, 7143.321384468467, 7143.5356701814735, 7190.424766018706, 4327.935080973788, 4475.977620111878, 4501.324801279801, 4520.095980803852, 4539.727616342997, 2662.1747258349974, 2740.931476713098, 2763.765079968205, 2816.788740844445, 2819.2528979820363, 887.3256325192835, 928.0487500312234, 942.4345392764355, 946.8532377481501, 963.0706368354571, 9674.75813104671, 9767.951160244224, 9801.264905132073, 9808.90191098087, 9811.509424528746, 3906.648401643866, 3980.840766369313, 4127.277726397869, 4161.334186530141, 4164.1879833432795, 8416.452930559493, 8420.15798420153, 8429.199226073513, 8443.704470343508, 8453.746387608382, 4494.325851122292, 4517.548245175456, 4526.23054080807, 4538.773061346919, 4552.817887284537, 3419.333230020172, 4023.0, 4120.031792528754, 4135.958640413617, 4149.668026557929, 3514.61339252682, 3563.322968635951, 3616.9819150904077, 3641.8361173747244, 3673.3204357194004, 1124.3815901254277, 1159.6579009192308, 1194.474431250247, 1196.8085106382937, 1197.9460924258428, 763.9274268944441, 794.9483283586549, 798.5328582779023, 801.6913488307043, 808.5189312359137, 4867.488913664085, 4901.828436004723, 4953.8018479261145, 4974.353334066621, 5045.990801839646, 411.6727201874517, 425.07121938564336, 425.3407218810831, 430.5543762206164, 445.91973444779603, 3379.053864917827, 3381.9154521136675, 3388.4070287699556, 3398.235397035647, 3449.5688038995127, 8701.912980870236, 9104.13510716481, 9106.954465227764, 9125.543722813833, 9130.589123489459, 9060.95469522648, 9081.273498120134, 9103.544822758968, 9106.908930910738, 9107.316951228684, 6901.171859376806, 6966.268541803139, 7006.439484841302, 7029.051078104492, 7042.507024508338, 4901.926471103007, 4926.285688575208, 4964.553190212898, 4997.075541024922, 5143.0999575073465, 8077.0, 8339.499630022217, 8371.16288371158, 8458.95770521168, 8486.787830304293, 8389.622466989122, 8462.449940753831, 8523.573821308786, 8569.657213711382, 8573.399862009599, 5586.52514536269, 6076.54425918049, 6264.060390941395, 6346.238451385679, 6509.349065093453, 6929.133858267716, 6998.195207551197, 7009.334113259232, 7049.823754406181, 7066.505344625827, 6284.088807123033, 6383.87232255343, 6393.2328120625825, 6520.543561950808, 6528.510361722795, 6049.758009679564, 6115.266168059861, 6170.413810687977, 6298.905516417166, 6349.269833969152, 5661.264035675335, 5770.105633626795, 5777.62445441045, 5792.797252096325, 5812.593118481665, 4231.344141658048, 4237.724547904377, 4275.786210689391, 4284.978575107105, 4421.955780442155, 4424.247877860707, 4438.60052595268, 4445.155420470101, 4509.864704058883, 4617.191991401559], "value": 3866.2979355347798, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.4228579412484, 295.35022949511074, 302.41784564712924, 303.24038284098333, 303.53862129563066, 4841.709497430148, 4986.925196122061, 5074.619403544735, 5123.718195499246, 5125.359330083739, 4950.727709975949, 4984.551390374865, 4989.700617962916, 4998.225275082368, 5018.64869459138, 3955.66376857966, 3960.8019599020076, 3978.8408463661417, 3979.1643754811525, 4000.599940006005, 3868.0, 3925.8037098145123, 3979.104701442167, 4002.359622460407, 4002.439658447805, 3897.532296124469, 3933.567307596162, 3935.2129574085156, 3936.6850651947775, 3965.9801700991457, 3923.0976875318693, 3948.545917219528, 3950.585188555218, 3962.316015693333, 3972.205558888234, 3519.1554027033585, 3520.1375662962737, 3522.1018640246575, 3526.2594855080465, 3532.328857517089, 4603.424571928509, 4835.540623640749, 4877.195262781673, 5002.1746411842005, 5006.849794506171, 4363.38912552243, 4376.446361541639, 4379.58393952574, 4383.956160438419, 4396.582324679151, 5195.168633094934, 5210.557102646279, 5226.372835259755, 5227.2159176123505, 5250.579953603703, 3503.9649603503894, 3669.43123815809, 3696.8336424860945, 3703.611120832301, 3714.4985426967555, 5508.55931525477, 5510.0, 5518.172274158908, 5530.668159910378, 5532.446755324476, 3829.6553310202216, 3848.7113466490127, 3852.653261206505, 3857.0, 3859.6333348331864, 3907.6092390761264, 3909.9638595772144, 3913.5108111486065, 3931.8034098295543, 3942.4677668514382, 4172.3532852407925, 4405.0, 4417.558244175557, 4421.801018954155, 4430.224710675619, 5219.739013049409, 5266.894662106736, 5272.578193744491, 5281.181416880313, 5333.57331413486, 1268.987310126887, 1307.1895424836662, 1320.386020500472, 1330.767115754739, 1332.8000799880097, 879.7668617816283, 898.7393655839865, 924.3621900888365, 927.1331305229631, 931.9207867331353, 4620.953790462052, 4622.2835460503675, 4622.722636641813, 4625.930611040837, 4683.250679891201, 5409.215663728737, 5412.810551630674, 5418.349798024262, 5422.511973922287, 5427.945720542823, 4516.345129956138, 4633.536646335339, 4650.348951146842, 4654.185517534418, 4665.46347170073, 2487.017628036915, 2499.4001439654717, 2519.760622740837, 2538.860362680033, 2546.8666443432494, 4534.863954081383, 4545.681802273875, 4547.8635640930825, 4553.362529245908, 4556.954430455653, 4542.068875880436, 4800.783964721596, 4843.370361853007, 4867.464578896319, 4870.951290487121, 4484.506704262529, 4491.7754112293605, 4525.547445255448, 4541.977290113595, 4549.363089167519, 4789.808407663794, 4795.472498025284, 4802.8799280018275, 4817.975910120567, 4821.831235906867, 4700.341952126773, 4725.0, 4751.978324660215, 4767.808047988003, 4778.307145463958, 4742.743173059211, 5155.118381790694, 5198.8960220794615, 5201.063808514353, 5207.3751149862255, 3829.3107240695826, 3845.057960799622, 3846.3461211593535, 3851.9614803852724, 3869.8065096744485, 5206.869828254324, 5490.6431081979545, 5498.645826046029, 5510.649890776625, 5538.778448862162, 5162.793488260428, 5287.312649355559, 5315.601329900351, 5316.255724198692, 5322.084049742012, 5303.257543943928, 5304.814331498379, 5314.707691076873, 5321.920171197357, 5329.147336426153, 5127.743612819269, 5223.608229382888, 5240.89518209626, 5254.527092561688, 5274.340707411574, 5325.866853328698, 5338.946610533845, 5343.7862485500145, 5350.866228344167, 5351.839444816662, 5247.344081989751, 5249.553787928069, 5257.5005374489365, 5259.631825772312, 5263.763130659053], "value": 3891.0102022203196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.3980369140089, 649.6849028221312, 660.7786391558825, 748.0985412577844, 748.4685873030148, 13147.868521314784, 13396.196228226314, 13801.30993450326, 14318.57044288673, 14355.066920650164, 15329.0, 15376.769348459755, 15517.53447396577, 15525.990810597303, 15626.062436253833, 783.0329543014373, 810.4893916832388, 814.4339683919678, 815.3110621524831, 819.5246756880995, 647.9416852483275, 769.4344656677338, 786.8111653203218, 797.1988151907325, 800.5396896784343, 840.4663038970236, 843.6119385082869, 845.1252953193446, 845.2181731898, 845.8308338332328, 832.7751507093081, 835.0855812884912, 835.3359079531787, 836.690424542917, 839.5172775653963, 611.4619135161074, 612.9478994285491, 612.9632222066646, 613.5950272819962, 613.8894998900196, 13122.47510099595, 13143.408546615425, 13167.407466664023, 13276.0, 13315.53395631158, 12989.41547630359, 13261.204327740366, 13338.533151339754, 13423.597292081253, 13490.865091349157, 10386.532606032746, 10407.68776936693, 10418.895811041944, 10421.426821524814, 10485.895141048568, 3220.500822372536, 3257.8371081445835, 3258.771885967983, 3308.0902751743224, 3326.185084654251, 54151.72924135393, 55873.0, 56874.43125568733, 63417.36582634161, 68929.0, 9892.25808064398, 10067.69796906094, 10288.742781430374, 10451.457614306564, 10467.319624224401, 18202.0, 18335.174917128763, 19047.1428785705, 19101.235950561822, 19162.13770380336, 6640.468762498988, 6760.83097922546, 6781.898271525931, 6798.184217893884, 6876.243613202544, 3808.733388662767, 3812.0850995760816, 3833.8466461341236, 3891.3384724596885, 3929.1945151243926, 2774.9445011099665, 2869.827810331387, 2879.5824605432094, 2958.9408211835644, 2995.5057415526194, 499.4381321013859, 500.6443203531209, 503.979840806371, 512.0169274992024, 519.6622195572908, 599.5772980049055, 608.0, 608.1546650156287, 614.2291424262611, 619.7304172684896, 7748.573828439377, 7886.320794600509, 8340.541270230196, 8428.11504791988, 8450.704225352083, 578.9739461724232, 608.9025755879038, 610.1172846819107, 610.7862248213179, 611.4894063456974, 3621.3662609043313, 3818.59904710007, 3870.651641352292, 3928.135810121769, 3974.5429275633096, 63804.68097659482, 105414.47292763487, 108657.0, 109567.0, 110094.44952775184, 88678.55660721655, 90807.0, 91177.0, 91592.54203729072, 94540.52729736308, 75525.24474755292, 76920.0, 77228.0, 78717.60641196757, 79966.20033799588, 7315.268473152642, 7691.5769632670745, 7702.576358300347, 7767.805804854924, 7882.802929926797, 48188.31340903052, 48717.0, 49403.50596493989, 49407.50592494029, 51020.23469647884, 37858.24283514369, 53192.20211696905, 68237.31762682309, 69027.65486172537, 70259.64870175616, 10942.835857462303, 11388.544458221579, 11838.28970261787, 12045.51817927273, 12102.51589936428, 12680.0, 12848.293343865804, 13118.058555136962, 13137.934310328386, 13616.931915340756, 12260.448279827608, 12379.381030948596, 12589.82808591757, 12965.41655625518, 13154.539591114266, 10724.302920310154, 11038.392888390894, 11374.374409407232, 11447.25592836463, 11656.125790565911, 11485.598004069818, 11595.652130436101, 11771.176017678681, 11853.051755859338, 12277.877221228031, 9041.412308199946, 9086.22767064807, 9129.974217016737, 9321.0, 9340.252779777737, 8680.091264732426, 8786.780330491789, 9433.811323773623, 9499.477528735986, 9686.273529485175], "value": 6649.147160874658, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 111.0, 115.0, 117.0, 117.0, 120.0, 117.0, 119.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 144.0, 198.0, 129.0, 151.0, 150.0, 130.0, 186.0, 123.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 173.0, 162.0, 163.0, 164.0, 165.0, 164.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 175.0, 81.0, 77.0, 77.0, 77.0, 155.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 143.0, 88.0, 86.0, 85.0, 145.0, 85.0, 88.0, 142.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 100.0, 100.0, 100.0, 96.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 66.0, 63.0, 63.0, 63.0, 64.0, 66.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 69.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 79.0, 80.0, 81.0, 79.0, 81.0, 80.0, 85.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 134.0, 140.0, 131.0, 144.0, 134.0, 134.0, 206.0, 141.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 170.0, 172.0, 177.0, 175.0, 168.0, 174.0, 178.0, 173.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 70.0], "value": 68.7, "unit": "score"}]}]} 09:53:11 INFO - Return code: 0 09:53:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:11 ERROR - # TBPL SUCCESS # 09:53:11 INFO - Running post-action listener: _resource_record_post_action 09:53:11 INFO - [mozharness: 2016-08-09 16:53:11.406670Z] Finished run-tests step (success) 09:53:11 INFO - Running post-run listener: _resource_record_post_run 09:53:11 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537354240; Read time: 8; Write time: 429724 09:53:11 INFO - TinderboxPrint: CPU usage
13.4% 09:53:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:53:11 INFO - TinderboxPrint: I/O write bytes / time
537,354,240 / 429,724 09:53:11 INFO - TinderboxPrint: CPU idle
8,287.8 (86.6%) 09:53:11 INFO - TinderboxPrint: CPU user
1,221.4 (12.8%) 09:53:11 INFO - TinderboxPrint: Swap in / out
0 / 0 09:53:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241008640; Read time: 0; Write time: 222916 09:53:11 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 296038400; Read time: 0; Write time: 206776 09:53:12 INFO - Running post-run listener: _upload_blobber_files 09:53:12 INFO - Blob upload gear active. 09:53:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:12 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 09:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:13 INFO - (blobuploader) - INFO - Done attempting. 09:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:13 INFO - (blobuploader) - INFO - Done attempting. 09:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:17 INFO - (blobuploader) - INFO - Done attempting. 09:53:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:17 INFO - Return code: 0 09:53:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a89dd4484fecc7e4d54c2c2c2ec21f0270747a6ea7a9192b5851107f3ff99ae990fdbd9e29d243ba50a92f6f6cf5d3bc0f6a05c091fddbd6acaff2772cb2e769", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25ae7c99728c9403461763967d0725fc6cfebda5dfa17d94d3374ad8edb8a7fe8d50890491ae70fcb4452539b5efed269a746fac26efff36b237172af8f3a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9795bebe6ddb6d59c422c2b4a5b39972e809fb4e719f657a956d9d463a60daa889a7bb936767c59620b7fd491de740ff5106346c05ef88454922aaffa05fcf4"} 09:53:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:17 INFO - Contents: 09:53:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a89dd4484fecc7e4d54c2c2c2ec21f0270747a6ea7a9192b5851107f3ff99ae990fdbd9e29d243ba50a92f6f6cf5d3bc0f6a05c091fddbd6acaff2772cb2e769", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25ae7c99728c9403461763967d0725fc6cfebda5dfa17d94d3374ad8edb8a7fe8d50890491ae70fcb4452539b5efed269a746fac26efff36b237172af8f3a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9795bebe6ddb6d59c422c2b4a5b39972e809fb4e719f657a956d9d463a60daa889a7bb936767c59620b7fd491de740ff5106346c05ef88454922aaffa05fcf4"} 09:53:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:17 INFO - Copying logs to upload dir... 09:53:17 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.005895 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-09 09:53:16.901590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 09:53:16.904781) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a89dd4484fecc7e4d54c2c2c2ec21f0270747a6ea7a9192b5851107f3ff99ae990fdbd9e29d243ba50a92f6f6cf5d3bc0f6a05c091fddbd6acaff2772cb2e769", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25ae7c99728c9403461763967d0725fc6cfebda5dfa17d94d3374ad8edb8a7fe8d50890491ae70fcb4452539b5efed269a746fac26efff36b237172af8f3a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9795bebe6ddb6d59c422c2b4a5b39972e809fb4e719f657a956d9d463a60daa889a7bb936767c59620b7fd491de740ff5106346c05ef88454922aaffa05fcf4"} build_url:https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/c6dDT7ZYRwa2_oe6skfj8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a89dd4484fecc7e4d54c2c2c2ec21f0270747a6ea7a9192b5851107f3ff99ae990fdbd9e29d243ba50a92f6f6cf5d3bc0f6a05c091fddbd6acaff2772cb2e769", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f25ae7c99728c9403461763967d0725fc6cfebda5dfa17d94d3374ad8edb8a7fe8d50890491ae70fcb4452539b5efed269a746fac26efff36b237172af8f3a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9795bebe6ddb6d59c422c2b4a5b39972e809fb4e719f657a956d9d463a60daa889a7bb936767c59620b7fd491de740ff5106346c05ef88454922aaffa05fcf4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 09:53:16.933441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:53:16.933779) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1470760358.803845-995853305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 09:53:17.016812) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 09:53:17.017673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 09:53:17.018274) ========= ========= Total master_lag: 0.18 =========