builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1470503067.33 results: success (0) buildid: 20160806072421 builduid: e567f4ce31f04d1cb928bf26dce163de revision: fa0934fbb4d5e3a189aba0b82b4f3ebb9cb5ee96 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.334864) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.335297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.335577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.355010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.355300) ========= 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=5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-06 10:04:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.9M=0.001s 2016-08-06 10:04:27 (13.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.492865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.493164) ========= 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=5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017731 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.548282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:27.548600) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fa0934fbb4d5e3a189aba0b82b4f3ebb9cb5ee96 --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 fa0934fbb4d5e3a189aba0b82b4f3ebb9cb5ee96 --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=5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-06 10:04:27,744 truncating revision to first 12 chars 2016-08-06 10:04:27,744 Setting DEBUG logging. 2016-08-06 10:04:27,744 attempt 1/10 2016-08-06 10:04:27,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fa0934fbb4d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 10:04:28,197 unpacking tar archive at: fx-team-fa0934fbb4d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:28.333757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:28.334076) ========= script_repo_revision: fa0934fbb4d5e3a189aba0b82b4f3ebb9cb5ee96 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:28.334485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:28.334756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 10:04:28.343085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-06 10:04:28.343356) ========= /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=5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:28 INFO - MultiFileLogger online at 20160806 10:04:28 in /builds/slave/test 10:04:28 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 10:04:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:28 INFO - {'append_to_log': False, 10:04:28 INFO - 'base_work_dir': '/builds/slave/test', 10:04:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:04:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:28 INFO - 'branch': 'Fx-Team-Non-PGO', 10:04:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:28 INFO - 'config_files': ('talos/linux_config.py',), 10:04:28 INFO - 'default_actions': ('clobber', 10:04:28 INFO - 'read-buildbot-config', 10:04:28 INFO - 'download-and-extract', 10:04:28 INFO - 'populate-webroot', 10:04:28 INFO - 'create-virtualenv', 10:04:28 INFO - 'install', 10:04:28 INFO - 'run-tests'), 10:04:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:28 INFO - 'download_minidump_stackwalk': True, 10:04:28 INFO - 'download_symbols': 'ondemand', 10:04:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:28 INFO - 'installer_path': 'installer.exe', 10:04:28 INFO - 'log_level': 'info', 10:04:28 INFO - 'log_name': 'talos', 10:04:28 INFO - 'log_to_console': True, 10:04:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:28 INFO - 'opt_config_files': (), 10:04:28 INFO - 'pip_index': False, 10:04:28 INFO - 'sps_profile': False, 10:04:28 INFO - 'sps_profile_interval': 0, 10:04:28 INFO - 'suite': 'dromaeojs-e10s', 10:04:28 INFO - 'system_bits': '32', 10:04:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:28 INFO - 'title': 'talos-linux64-ix-039', 10:04:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:28 INFO - 'use_talos_json': True, 10:04:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:28 INFO - 'work_dir': 'build'} 10:04:28 INFO - [mozharness: 2016-08-06 17:04:28.632980Z] Running clobber step. 10:04:28 INFO - Running pre-action listener: _resource_record_pre_action 10:04:28 INFO - Running main action method: clobber 10:04:28 INFO - rmtree: /builds/slave/test/build 10:04:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:29 INFO - Running post-action listener: _resource_record_post_action 10:04:29 INFO - [mozharness: 2016-08-06 17:04:29.071332Z] Finished clobber step (success) 10:04:29 INFO - [mozharness: 2016-08-06 17:04:29.071434Z] Running read-buildbot-config step. 10:04:29 INFO - Running pre-action listener: _resource_record_pre_action 10:04:29 INFO - Running main action method: read_buildbot_config 10:04:29 INFO - Using buildbot properties: 10:04:29 INFO - { 10:04:29 INFO - "project": "", 10:04:29 INFO - "product": "firefox", 10:04:29 INFO - "script_repo_revision": "production", 10:04:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:04:29 INFO - "repository": "", 10:04:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:04:29 INFO - "buildid": "20160806072421", 10:04:29 INFO - "pgo_build": "False", 10:04:29 INFO - "basedir": "/builds/slave/test", 10:04:29 INFO - "buildnumber": 1507, 10:04:29 INFO - "slavename": "talos-linux64-ix-039", 10:04:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:04:29 INFO - "platform": "ubuntu64_hw", 10:04:29 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 10:04:29 INFO - "branch": "fx-team", 10:04:29 INFO - "repo_path": "integration/fx-team", 10:04:29 INFO - "revision": "fa0934fbb4d5e3a189aba0b82b4f3ebb9cb5ee96", 10:04:29 INFO - "stage_platform": "linux64", 10:04:29 INFO - "builduid": "e567f4ce31f04d1cb928bf26dce163de", 10:04:29 INFO - "slavebuilddir": "test" 10:04:29 INFO - } 10:04:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:04:29 INFO - Running post-action listener: _resource_record_post_action 10:04:29 INFO - [mozharness: 2016-08-06 17:04:29.073882Z] Finished read-buildbot-config step (success) 10:04:29 INFO - [mozharness: 2016-08-06 17:04:29.073972Z] Running download-and-extract step. 10:04:29 INFO - Running pre-action listener: _resource_record_pre_action 10:04:29 INFO - Running main action method: download_and_extract 10:04:29 INFO - mkdir: /builds/slave/test/build/tests 10:04:29 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')]} 10:04:29 INFO - trying https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:04:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:29 INFO - Downloaded 1361 bytes. 10:04:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:04:29 INFO - Using the following test package requirements: 10:04:29 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:04:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'jsshell-linux-x86_64.zip'], 10:04:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:04:29 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:04:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04:29 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')]} 10:04:29 INFO - trying https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:04:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:30 INFO - Downloaded 20254079 bytes. 10:04:30 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'] 10:04:30 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 10:04:31 INFO - Return code: 0 10:04:31 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 10:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:31 INFO - trying https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:04:31 INFO - Downloading https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:32 INFO - Downloaded 20254079 bytes. 10:04:32 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'] 10:04:32 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 10:04:33 INFO - Return code: 0 10:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:33 INFO - trying https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:33 INFO - Downloading https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:34 INFO - Downloaded 14413723 bytes. 10:04:34 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'] 10:04:34 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 10:04:35 INFO - Return code: 0 10:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:35 INFO - trying https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:04:35 INFO - Downloading https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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 10:04:36 INFO - Downloaded 56127609 bytes. 10:04:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:04:36 INFO - mkdir: /builds/slave/test/properties 10:04:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:36 INFO - Contents: 10:04:36 INFO - build_url:https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:04:37 INFO - Running post-action listener: _resource_record_post_action 10:04:37 INFO - Running post-action listener: set_extra_try_arguments 10:04:37 INFO - [mozharness: 2016-08-06 17:04:37.173501Z] Finished download-and-extract step (success) 10:04:37 INFO - [mozharness: 2016-08-06 17:04:37.173735Z] Running populate-webroot step. 10:04:37 INFO - Running pre-action listener: _resource_record_pre_action 10:04:37 INFO - Running main action method: populate_webroot 10:04:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:37 INFO - '--tppagecycles', 10:04:37 INFO - '7'], 10:04:37 INFO - 'tests': ['tsvgm']}}, 10:04:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['damp', 'tps']}, 10:04:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'tests': ['damp', 'tps']}, 10:04:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['dromaeo_dom']}, 10:04:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['basic_compositor_video']}, 10:04:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:04:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['a11yr', 10:04:37 INFO - 'ts_paint', 10:04:37 INFO - 'tpaint', 10:04:37 INFO - 'sessionrestore', 10:04:37 INFO - 'sessionrestore_no_auto_restore', 10:04:37 INFO - 'tabpaint']}, 10:04:37 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:37 INFO - 'ts_paint', 10:04:37 INFO - 'tpaint', 10:04:37 INFO - 'sessionrestore', 10:04:37 INFO - 'sessionrestore_no_auto_restore', 10:04:37 INFO - 'tabpaint']}, 10:04:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:37 INFO - 'ts_paint', 10:04:37 INFO - 'tpaint', 10:04:37 INFO - 'sessionrestore', 10:04:37 INFO - 'sessionrestore_no_auto_restore', 10:04:37 INFO - 'tabpaint']}, 10:04:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:37 INFO - 'ts_paint', 10:04:37 INFO - 'tpaint', 10:04:37 INFO - 'sessionrestore', 10:04:37 INFO - 'sessionrestore_no_auto_restore', 10:04:37 INFO - 'tabpaint']}, 10:04:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['a11yr', 10:04:37 INFO - 'ts_paint', 10:04:37 INFO - 'tpaint', 10:04:37 INFO - 'sessionrestore', 10:04:37 INFO - 'sessionrestore_no_auto_restore', 10:04:37 INFO - 'tabpaint']}, 10:04:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['a11yr', 10:04:37 INFO - 'ts_paint', 10:04:37 INFO - 'tpaint', 10:04:37 INFO - 'sessionrestore', 10:04:37 INFO - 'sessionrestore_no_auto_restore', 10:04:37 INFO - 'tabpaint']}, 10:04:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['tsvgx', 10:04:37 INFO - 'tsvgr_opacity', 10:04:37 INFO - 'tart', 10:04:37 INFO - 'tscrollx', 10:04:37 INFO - 'cart']}, 10:04:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:37 INFO - 'tsvgr_opacity', 10:04:37 INFO - 'tart', 10:04:37 INFO - 'tscrollx', 10:04:37 INFO - 'cart']}, 10:04:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'talos_options': ['--disable-e10s'], 10:04:37 INFO - 'tests': ['tp5o']}, 10:04:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'tests': ['tp5o']}, 10:04:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'talos_options': ['--disable-e10s', 10:04:37 INFO - '--xperf_path', 10:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:37 INFO - 'tests': ['tp5n']}, 10:04:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:37 INFO - 'talos_options': ['--xperf_path', 10:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:37 INFO - 'tests': ['tp5n']}}, 10:04:37 INFO - 'talos.zip': {'path': '', 10:04:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:37 INFO - Running post-action listener: _resource_record_post_action 10:04:37 INFO - [mozharness: 2016-08-06 17:04:37.195805Z] Finished populate-webroot step (success) 10:04:37 INFO - [mozharness: 2016-08-06 17:04:37.195895Z] Running create-virtualenv step. 10:04:37 INFO - Running pre-action listener: _resource_record_pre_action 10:04:37 INFO - Running main action method: create_virtualenv 10:04:37 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:37 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 10:04:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:37 INFO - Using real prefix '/usr' 10:04:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:37 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:39 INFO - Installing pip.................done. 10:04:39 INFO - Return code: 0 10:04:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:39 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 10:04:39 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 10:04:39 INFO - Using env: {'DISPLAY': ':0', 10:04:39 INFO - 'HOME': '/home/cltbld', 10:04:39 INFO - 'LANG': 'en_US.UTF-8', 10:04:39 INFO - 'LANGUAGE': 'en_US:en', 10:04:39 INFO - 'LOGNAME': 'cltbld', 10:04:39 INFO - 'MAIL': '/var/mail/cltbld', 10:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:39 INFO - 'MOZ_NO_REMOTE': '1', 10:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:39 INFO - 'NO_EM_RESTART': '1', 10:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:39 INFO - 'PWD': '/builds/slave/test', 10:04:39 INFO - 'SHELL': '/bin/bash', 10:04:39 INFO - 'SHLVL': '1', 10:04:39 INFO - 'TERM': 'linux', 10:04:39 INFO - 'TMOUT': '86400', 10:04:39 INFO - 'USER': 'cltbld', 10:04:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:39 INFO - '_': '/tools/buildbot/bin/python'} 10:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:39 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 10:04:39 INFO - Cleaning up... 10:04:39 INFO - Return code: 0 10:04:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:39 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:39 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 10:04:39 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 10:04:39 INFO - Using env: {'DISPLAY': ':0', 10:04:39 INFO - 'HOME': '/home/cltbld', 10:04:39 INFO - 'LANG': 'en_US.UTF-8', 10:04:39 INFO - 'LANGUAGE': 'en_US:en', 10:04:39 INFO - 'LOGNAME': 'cltbld', 10:04:39 INFO - 'MAIL': '/var/mail/cltbld', 10:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:39 INFO - 'MOZ_NO_REMOTE': '1', 10:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:39 INFO - 'NO_EM_RESTART': '1', 10:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:39 INFO - 'PWD': '/builds/slave/test', 10:04:39 INFO - 'SHELL': '/bin/bash', 10:04:39 INFO - 'SHLVL': '1', 10:04:39 INFO - 'TERM': 'linux', 10:04:39 INFO - 'TMOUT': '86400', 10:04:39 INFO - 'USER': 'cltbld', 10:04:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:39 INFO - '_': '/tools/buildbot/bin/python'} 10:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:40 INFO - Downloading/unpacking psutil>=3.1.1 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:40 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 10:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:42 INFO - Installing collected packages: psutil 10:04:42 INFO - Running setup.py install for psutil 10:04:42 INFO - building 'psutil._psutil_linux' extension 10:04:42 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 10:04:42 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 10:04:42 INFO - building 'psutil._psutil_posix' extension 10:04:42 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 10:04:42 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 10:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:42 INFO - Successfully installed psutil 10:04:42 INFO - Cleaning up... 10:04:42 INFO - Return code: 0 10:04:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:42 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:42 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 10:04:42 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 10:04:42 INFO - Using env: {'DISPLAY': ':0', 10:04:42 INFO - 'HOME': '/home/cltbld', 10:04:42 INFO - 'LANG': 'en_US.UTF-8', 10:04:42 INFO - 'LANGUAGE': 'en_US:en', 10:04:42 INFO - 'LOGNAME': 'cltbld', 10:04:42 INFO - 'MAIL': '/var/mail/cltbld', 10:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:42 INFO - 'MOZ_NO_REMOTE': '1', 10:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:42 INFO - 'NO_EM_RESTART': '1', 10:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:42 INFO - 'PWD': '/builds/slave/test', 10:04:42 INFO - 'SHELL': '/bin/bash', 10:04:42 INFO - 'SHLVL': '1', 10:04:42 INFO - 'TERM': 'linux', 10:04:42 INFO - 'TMOUT': '86400', 10:04:42 INFO - 'USER': 'cltbld', 10:04:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:42 INFO - '_': '/tools/buildbot/bin/python'} 10:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:04:42 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 10:04:42 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 10:04:42 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 10:04:42 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 10:04:42 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 10:04:42 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 10:04:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:04:44 INFO - Installing collected packages: mozsystemmonitor 10:04:44 INFO - Running setup.py install for mozsystemmonitor 10:04:44 INFO - Successfully installed mozsystemmonitor 10:04:44 INFO - Cleaning up... 10:04:45 INFO - Return code: 0 10:04:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:04:45 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')]} 10:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:45 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')]} 10:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:45 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:45 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 10:04:45 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 10:04:45 INFO - Using env: {'DISPLAY': ':0', 10:04:45 INFO - 'HOME': '/home/cltbld', 10:04:45 INFO - 'LANG': 'en_US.UTF-8', 10:04:45 INFO - 'LANGUAGE': 'en_US:en', 10:04:45 INFO - 'LOGNAME': 'cltbld', 10:04:45 INFO - 'MAIL': '/var/mail/cltbld', 10:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:45 INFO - 'MOZ_NO_REMOTE': '1', 10:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:45 INFO - 'NO_EM_RESTART': '1', 10:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:45 INFO - 'PWD': '/builds/slave/test', 10:04:45 INFO - 'SHELL': '/bin/bash', 10:04:45 INFO - 'SHLVL': '1', 10:04:45 INFO - 'TERM': 'linux', 10:04:45 INFO - 'TMOUT': '86400', 10:04:45 INFO - 'USER': 'cltbld', 10:04:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:45 INFO - '_': '/tools/buildbot/bin/python'} 10:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:45 INFO - Downloading/unpacking jsonschema==2.5.1 10:04:45 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 10:04:45 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 10:04:45 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 10:04:45 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 10:04:45 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 10:04:45 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 10:04:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:47 INFO - warning: no files found matching '*.txt' 10:04:47 INFO - no previously-included directories found matching 'build' 10:04:47 INFO - no previously-included directories found matching 'dist' 10:04:47 INFO - no previously-included directories found matching '.git*' 10:04:47 INFO - Installing collected packages: jsonschema, functools32 10:04:47 INFO - Running setup.py install for functools32 10:04:47 INFO - warning: no files found matching '*.txt' 10:04:47 INFO - no previously-included directories found matching 'build' 10:04:47 INFO - no previously-included directories found matching 'dist' 10:04:47 INFO - no previously-included directories found matching '.git*' 10:04:47 INFO - Successfully installed jsonschema functools32 10:04:47 INFO - Cleaning up... 10:04:47 INFO - Return code: 0 10:04:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:47 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:47 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 10:04:47 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 10:04:47 INFO - Using env: {'DISPLAY': ':0', 10:04:47 INFO - 'HOME': '/home/cltbld', 10:04:47 INFO - 'LANG': 'en_US.UTF-8', 10:04:47 INFO - 'LANGUAGE': 'en_US:en', 10:04:47 INFO - 'LOGNAME': 'cltbld', 10:04:47 INFO - 'MAIL': '/var/mail/cltbld', 10:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:47 INFO - 'MOZ_NO_REMOTE': '1', 10:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:47 INFO - 'NO_EM_RESTART': '1', 10:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:47 INFO - 'PWD': '/builds/slave/test', 10:04:47 INFO - 'SHELL': '/bin/bash', 10:04:47 INFO - 'SHLVL': '1', 10:04:47 INFO - 'TERM': 'linux', 10:04:47 INFO - 'TMOUT': '86400', 10:04:47 INFO - 'USER': 'cltbld', 10:04:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:47 INFO - '_': '/tools/buildbot/bin/python'} 10:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:04:47 INFO - Cleaning up... 10:04:47 INFO - Return code: 0 10:04:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:47 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:47 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 10:04:47 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 10:04:47 INFO - Using env: {'DISPLAY': ':0', 10:04:47 INFO - 'HOME': '/home/cltbld', 10:04:47 INFO - 'LANG': 'en_US.UTF-8', 10:04:47 INFO - 'LANGUAGE': 'en_US:en', 10:04:47 INFO - 'LOGNAME': 'cltbld', 10:04:47 INFO - 'MAIL': '/var/mail/cltbld', 10:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:47 INFO - 'MOZ_NO_REMOTE': '1', 10:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:47 INFO - 'NO_EM_RESTART': '1', 10:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:47 INFO - 'PWD': '/builds/slave/test', 10:04:47 INFO - 'SHELL': '/bin/bash', 10:04:47 INFO - 'SHLVL': '1', 10:04:47 INFO - 'TERM': 'linux', 10:04:47 INFO - 'TMOUT': '86400', 10:04:47 INFO - 'USER': 'cltbld', 10:04:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:47 INFO - '_': '/tools/buildbot/bin/python'} 10:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:47 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 10:04:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:49 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 10:04:49 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 10:04:49 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 10:04:49 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 10:04:49 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 10:04:49 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 10:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 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 10:04:50 INFO - Downloading docopt-0.6.1.tar.gz 10:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:50 INFO - Running setup.py install for blobuploader 10:04:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:50 INFO - Running setup.py install for requests 10:04:51 INFO - Running setup.py install for docopt 10:04:51 INFO - Successfully installed blobuploader requests docopt 10:04:51 INFO - Cleaning up... 10:04:51 INFO - Return code: 0 10:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:51 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:51 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 10:04:51 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 10:04:51 INFO - Using env: {'DISPLAY': ':0', 10:04:51 INFO - 'HOME': '/home/cltbld', 10:04:51 INFO - 'LANG': 'en_US.UTF-8', 10:04:51 INFO - 'LANGUAGE': 'en_US:en', 10:04:51 INFO - 'LOGNAME': 'cltbld', 10:04:51 INFO - 'MAIL': '/var/mail/cltbld', 10:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:51 INFO - 'MOZ_NO_REMOTE': '1', 10:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:51 INFO - 'NO_EM_RESTART': '1', 10:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:51 INFO - 'PWD': '/builds/slave/test', 10:04:51 INFO - 'SHELL': '/bin/bash', 10:04:51 INFO - 'SHLVL': '1', 10:04:51 INFO - 'TERM': 'linux', 10:04:51 INFO - 'TMOUT': '86400', 10:04:51 INFO - 'USER': 'cltbld', 10:04:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:51 INFO - '_': '/tools/buildbot/bin/python'} 10:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:51 INFO - Running setup.py (path:/tmp/pip-tWj7Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:51 INFO - Running setup.py (path:/tmp/pip-8PdMKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:51 INFO - Running setup.py (path:/tmp/pip-_kCv_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:51 INFO - Running setup.py (path:/tmp/pip-KQq3Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:51 INFO - Running setup.py (path:/tmp/pip-ofSo5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:51 INFO - Running setup.py (path:/tmp/pip-7xg13p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:51 INFO - Running setup.py (path:/tmp/pip-SINI7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:52 INFO - Running setup.py (path:/tmp/pip-Zz4eLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:52 INFO - Running setup.py (path:/tmp/pip-lGPwDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:52 INFO - Running setup.py (path:/tmp/pip-BF19mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:52 INFO - Running setup.py (path:/tmp/pip-EN5BrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:52 INFO - Running setup.py (path:/tmp/pip-EjdFFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:52 INFO - Running setup.py (path:/tmp/pip-FygVb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:52 INFO - Running setup.py (path:/tmp/pip-8cMLBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:52 INFO - Running setup.py (path:/tmp/pip-2P08Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:52 INFO - Running setup.py (path:/tmp/pip-sDcX1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:52 INFO - Running setup.py (path:/tmp/pip-Z1nT0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:52 INFO - Running setup.py install for manifestparser 10:04:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:52 INFO - Running setup.py install for mozcrash 10:04:52 INFO - Running setup.py install for mozdebug 10:04:53 INFO - Running setup.py install for mozdevice 10:04:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for mozfile 10:04:53 INFO - Running setup.py install for mozhttpd 10:04:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for mozinfo 10:04:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for mozInstall 10:04:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for mozleak 10:04:53 INFO - Running setup.py install for mozlog 10:04:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for moznetwork 10:04:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:53 INFO - Running setup.py install for mozprocess 10:04:53 INFO - Running setup.py install for mozprofile 10:04:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Running setup.py install for mozrunner 10:04:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Running setup.py install for mozscreenshot 10:04:54 INFO - Running setup.py install for moztest 10:04:54 INFO - Running setup.py install for mozversion 10:04:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:04:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:54 INFO - Cleaning up... 10:04:54 INFO - Return code: 0 10:04:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:54 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:54 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 10:04:54 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 10:04:54 INFO - Using env: {'DISPLAY': ':0', 10:04:54 INFO - 'HOME': '/home/cltbld', 10:04:54 INFO - 'LANG': 'en_US.UTF-8', 10:04:54 INFO - 'LANGUAGE': 'en_US:en', 10:04:54 INFO - 'LOGNAME': 'cltbld', 10:04:54 INFO - 'MAIL': '/var/mail/cltbld', 10:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:54 INFO - 'MOZ_NO_REMOTE': '1', 10:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:54 INFO - 'NO_EM_RESTART': '1', 10:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:54 INFO - 'PWD': '/builds/slave/test', 10:04:54 INFO - 'SHELL': '/bin/bash', 10:04:54 INFO - 'SHLVL': '1', 10:04:54 INFO - 'TERM': 'linux', 10:04:54 INFO - 'TMOUT': '86400', 10:04:54 INFO - 'USER': 'cltbld', 10:04:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:54 INFO - '_': '/tools/buildbot/bin/python'} 10:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:54 INFO - Running setup.py (path:/tmp/pip-oUlA_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:54 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)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:54 INFO - Running setup.py (path:/tmp/pip-9AibDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:54 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)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:54 INFO - Running setup.py (path:/tmp/pip-wrM5L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:54 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)) 10:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:54 INFO - Running setup.py (path:/tmp/pip-hFVZ9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:55 INFO - Running setup.py (path:/tmp/pip-yUnGlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:55 INFO - Running setup.py (path:/tmp/pip-Y8W6X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:55 INFO - Running setup.py (path:/tmp/pip-_rEkcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:55 INFO - Running setup.py (path:/tmp/pip-55vlT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:55 INFO - Running setup.py (path:/tmp/pip-fRZ1p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:55 INFO - Running setup.py (path:/tmp/pip-Y8Rm0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:55 INFO - Running setup.py (path:/tmp/pip-c0aO9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:55 INFO - Running setup.py (path:/tmp/pip-cmay4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:55 INFO - Running setup.py (path:/tmp/pip-lJZkGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:55 INFO - Running setup.py (path:/tmp/pip-xUmYdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:55 INFO - Running setup.py (path:/tmp/pip-XRR18p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:55 INFO - Running setup.py (path:/tmp/pip-gSmSJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:55 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)) 10:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:55 INFO - Running setup.py (path:/tmp/pip-6lhn9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:55 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)) 10:04:55 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)) 10:04:55 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)) 10:04:55 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)) 10:04:55 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)) 10:04:55 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)) 10:04:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:55 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 10:04:55 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 10:04:55 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 10:04:55 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 10:04:55 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 10:04:55 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 10:04:57 INFO - Downloading blessings-1.6.tar.gz 10:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:58 INFO - Installing collected packages: blessings 10:04:58 INFO - Running setup.py install for blessings 10:04:58 INFO - Successfully installed blessings 10:04:58 INFO - Cleaning up... 10:04:58 INFO - Return code: 0 10:04:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:58 INFO - Reading from file tmpfile_stdout 10:04:58 INFO - Current package versions: 10:04:58 INFO - argparse == 1.2.1 10:04:58 INFO - blessings == 1.6 10:04:58 INFO - blobuploader == 1.2.4 10:04:58 INFO - docopt == 0.6.1 10:04:58 INFO - functools32 == 3.2.3-2 10:04:58 INFO - jsonschema == 2.5.1 10:04:58 INFO - manifestparser == 1.1 10:04:58 INFO - mozInstall == 1.12 10:04:58 INFO - mozcrash == 0.17 10:04:58 INFO - mozdebug == 0.1 10:04:58 INFO - mozdevice == 0.48 10:04:58 INFO - mozfile == 1.2 10:04:58 INFO - mozhttpd == 0.7 10:04:58 INFO - mozinfo == 0.9 10:04:58 INFO - mozleak == 0.1 10:04:58 INFO - mozlog == 3.3 10:04:58 INFO - moznetwork == 0.27 10:04:58 INFO - mozprocess == 0.23 10:04:58 INFO - mozprofile == 0.28 10:04:58 INFO - mozrunner == 6.12 10:04:58 INFO - mozscreenshot == 0.1 10:04:58 INFO - mozsystemmonitor == 0.3 10:04:58 INFO - moztest == 0.7 10:04:58 INFO - mozversion == 1.4 10:04:58 INFO - psutil == 3.1.1 10:04:58 INFO - requests == 1.2.3 10:04:58 INFO - wsgiref == 0.1.2 10:04:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:58 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 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04:58 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 10:04:58 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 10:04:58 INFO - Using env: {'DISPLAY': ':0', 10:04:58 INFO - 'HOME': '/home/cltbld', 10:04:58 INFO - 'LANG': 'en_US.UTF-8', 10:04:58 INFO - 'LANGUAGE': 'en_US:en', 10:04:58 INFO - 'LOGNAME': 'cltbld', 10:04:58 INFO - 'MAIL': '/var/mail/cltbld', 10:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:58 INFO - 'MOZ_NO_REMOTE': '1', 10:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:58 INFO - 'NO_EM_RESTART': '1', 10:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:58 INFO - 'PWD': '/builds/slave/test', 10:04:58 INFO - 'SHELL': '/bin/bash', 10:04:58 INFO - 'SHLVL': '1', 10:04:58 INFO - 'TERM': 'linux', 10:04:58 INFO - 'TMOUT': '86400', 10:04:58 INFO - 'USER': 'cltbld', 10:04:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:58 INFO - '_': '/tools/buildbot/bin/python'} 10:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 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)) 10:04:58 INFO - Cleaning up... 10:04:58 INFO - Return code: 0 10:04:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, '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': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', '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 10:04: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'] in /builds/slave/test/build 10:04: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 10:04:58 INFO - Using env: {'DISPLAY': ':0', 10:04:58 INFO - 'HOME': '/home/cltbld', 10:04:58 INFO - 'LANG': 'en_US.UTF-8', 10:04:58 INFO - 'LANGUAGE': 'en_US:en', 10:04:58 INFO - 'LOGNAME': 'cltbld', 10:04:58 INFO - 'MAIL': '/var/mail/cltbld', 10:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:58 INFO - 'MOZ_NO_REMOTE': '1', 10:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:58 INFO - 'NO_EM_RESTART': '1', 10:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:58 INFO - 'PWD': '/builds/slave/test', 10:04:58 INFO - 'SHELL': '/bin/bash', 10:04:58 INFO - 'SHLVL': '1', 10:04:58 INFO - 'TERM': 'linux', 10:04:58 INFO - 'TMOUT': '86400', 10:04:58 INFO - 'USER': 'cltbld', 10:04:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:58 INFO - '_': '/tools/buildbot/bin/python'} 10:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:04:58 INFO - Cleaning up... 10:04:58 INFO - Return code: 0 10:04:58 INFO - Running post-action listener: _resource_record_post_action 10:04:58 INFO - Running post-action listener: _start_resource_monitoring 10:04:58 INFO - Starting resource monitoring. 10:04:58 INFO - [mozharness: 2016-08-06 17:04:58.959026Z] Finished create-virtualenv step (success) 10:04:58 INFO - [mozharness: 2016-08-06 17:04:58.959577Z] Running install step. 10:04:58 INFO - Running pre-action listener: _resource_record_pre_action 10:04:58 INFO - Running main action method: install 10:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:59 INFO - Reading from file tmpfile_stdout 10:04:59 INFO - Detecting whether we're running mozinstall >=1.0... 10:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:04:59 INFO - Reading from file tmpfile_stdout 10:04:59 INFO - Output received: 10:04:59 INFO - Usage: mozinstall [options] installer 10:04:59 INFO - Options: 10:04:59 INFO - -h, --help show this help message and exit 10:04:59 INFO - -d DEST, --destination=DEST 10:04:59 INFO - Directory to install application into. [default: 10:04:59 INFO - "/builds/slave/test"] 10:04:59 INFO - --app=APP Application being installed. [default: firefox] 10:04:59 INFO - mkdir: /builds/slave/test/build/application 10:04:59 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'] 10:04:59 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 10:05:15 INFO - Reading from file tmpfile_stdout 10:05:15 INFO - Output received: 10:05:15 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:15 INFO - Running post-action listener: _resource_record_post_action 10:05:15 INFO - [mozharness: 2016-08-06 17:05:15.595010Z] Finished install step (success) 10:05:15 INFO - [mozharness: 2016-08-06 17:05:15.595313Z] Running run-tests step. 10:05:15 INFO - Running pre-action listener: _resource_record_pre_action 10:05:15 INFO - Running main action method: run_tests 10:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:15 INFO - Python 2.7.3 10:05:15 INFO - Return code: 0 10:05:15 INFO - grabbing minidump binary from tooltool 10:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:15 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 0x105b570>, '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 0x105c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:15 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 10:05:15 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 10:05:15 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 10:05:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:15 INFO - Return code: 0 10:05:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:15 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/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 10:05:15 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/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 10:05:15 INFO - Using env: {'DISPLAY': ':0', 10:05:15 INFO - 'HOME': '/home/cltbld', 10:05:15 INFO - 'LANG': 'en_US.UTF-8', 10:05:15 INFO - 'LANGUAGE': 'en_US:en', 10:05:15 INFO - 'LOGNAME': 'cltbld', 10:05:15 INFO - 'MAIL': '/var/mail/cltbld', 10:05:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:15 INFO - 'MOZ_NO_REMOTE': '1', 10:05:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:15 INFO - 'NO_EM_RESTART': '1', 10:05:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:15 INFO - 'PWD': '/builds/slave/test', 10:05:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:15 INFO - 'SHELL': '/bin/bash', 10:05:15 INFO - 'SHLVL': '1', 10:05:15 INFO - 'TERM': 'linux', 10:05:15 INFO - 'TMOUT': '86400', 10:05:15 INFO - 'USER': 'cltbld', 10:05:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781', 10:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:15 INFO - '_': '/tools/buildbot/bin/python'} 10:05:15 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/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 10:05:15 INFO - mozversion application_buildid: 20160806072421 10:05:15 INFO - mozversion application_changeset: fa0934fbb4d5e3a189aba0b82b4f3ebb9cb5ee96 10:05:15 INFO - mozversion application_display_name: Nightly 10:05:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:15 INFO - mozversion application_name: Firefox 10:05:15 INFO - mozversion application_remotingname: firefox 10:05:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:05:15 INFO - mozversion application_vendor: Mozilla 10:05:15 INFO - mozversion application_version: 51.0a1 10:05:15 INFO - mozversion platform_buildid: 20160806072421 10:05:15 INFO - mozversion platform_changeset: fa0934fbb4d5e3a189aba0b82b4f3ebb9cb5ee96 10:05:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:05:15 INFO - mozversion platform_version: 51.0a1 10:05:15 INFO - using testdate: 1470503115 10:05:15 INFO - actual date: 1470503115 10:05:15 INFO - starting webserver on 'localhost:42679' 10:05:15 INFO - SUITE-START | Running 2 tests 10:05:15 INFO - TEST-START | dromaeo_css 10:05:15 INFO - operating with platform_type : linux_ 10:05:15 INFO - Initialising browser for dromaeo_css test... 10:05:15 INFO - TEST-INFO | started process 14161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPJ8zU/profile http://localhost:42679/getInfo.html) 10:05:20 INFO - PROCESS | 14161 | __metrics Screen width/height:1600/1200 10:05:20 INFO - PROCESS | 14161 | colorDepth:24 10:05:20 INFO - PROCESS | 14161 | Browser inner width/height: 1024/697 10:05:20 INFO - PROCESS | 14161 | __metrics 10:05:21 ERROR - PROCESS | 14161 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:05:22 INFO - TEST-INFO | 14161: exit 0 10:05:22 INFO - Browser initialized. 10:05:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:22 INFO - TEST-INFO | started process 14281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPJ8zU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:34 INFO - PROCESS | 14281 | RSS: Main: 165097472 10:05:34 INFO - PROCESS | 14281 | 10:06:23 INFO - PROCESS | 14281 | 1470503183906 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] 10:08:36 INFO - PROCESS | 14281 | Cycle 1(1): loaded http://localhost:42679/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42679/tests/dromaeo/cssquery-ext.html) 10:08:37 INFO - PROCESS | 14281 | RSS: Main: 166600704 10:08:37 INFO - PROCESS | 14281 | 10:11:39 INFO - PROCESS | 14281 | Cycle 1(1): loaded http://localhost:42679/tests/dromaeo/cssquery-ext.html (next: http://localhost:42679/tests/dromaeo/cssquery-jquery.html) 10:11:40 INFO - PROCESS | 14281 | RSS: Main: 167297024 10:11:40 INFO - PROCESS | 14281 | 10:14:42 INFO - PROCESS | 14281 | Cycle 1(1): loaded http://localhost:42679/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42679/tests/dromaeo/cssquery-mootools.html) 10:14:43 INFO - PROCESS | 14281 | RSS: Main: 170614784 10:14:43 INFO - PROCESS | 14281 | 10:17:45 INFO - PROCESS | 14281 | Cycle 1(1): loaded http://localhost:42679/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42679/tests/dromaeo/cssquery-prototype.html) 10:17:45 INFO - PROCESS | 14281 | RSS: Main: 164786176 10:17:45 INFO - PROCESS | 14281 | 10:20:48 INFO - PROCESS | 14281 | Cycle 1(1): loaded http://localhost:42679/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42679/tests/dromaeo/cssquery-yui.html) 10:20:49 INFO - PROCESS | 14281 | RSS: Main: 166686720 10:20:49 INFO - PROCESS | 14281 | 10:23:51 INFO - PROCESS | 14281 | Cycle 1(1): loaded http://localhost:42679/tests/dromaeo/cssquery-yui.html (next: http://localhost:42679/tests/dromaeo/cssquery-dojo.html) 10:23:52 INFO - PROCESS | 14281 | RSS: Main: 170442752 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | __start_tp_report 10:23:52 INFO - PROCESS | 14281 | _x_x_mozilla_page_load 10:23:52 INFO - PROCESS | 14281 | _x_x_mozilla_page_load_details 10:23:52 INFO - PROCESS | 14281 | |i|pagename|runs| 10:23:52 INFO - PROCESS | 14281 | |0;dojo.html;2643.1806140096573;2658.9734102658967;2679.11589175572;2683.6242925990364;2690.7981901357402;4504.346869703891;4764.618830493561;4767.213409787385;4786;4791.976040119799;4677.555632214942;4703.15343238217;4704.129735998834;4723.409573803275;4799.5680388765;4290.957090429102;4389.078293558357;4436.268015777393;4452.554744525538;4498.685092043558;4412.624926881219;4468.798904049309;4479.574440428154;4490;4496.9775151124195;4237.555056719062;4264.1471705659;4292.785360731951;4407.933880991755;4438.3564383164585;4352.630026447756;4357;4377.146456440995;4394.231009573312;4397.956020439787;4319.07139964909;4336.848210312624;4358.934615980763;4365.301551751704;4373.540778218305;4525.208088584517;4578.931316030262;4614.907701845944;4667.766611669403;4740.431148262231;5026.874328141789;5033.395992480926;5053.065182941167;5053.620978426633;5074.086664400406;5030.0694371541385;5049.267856160873;5054.444011158769;5059.519345662156;5083.906960003617;4555.157295900269;4660.091282200006;4705.529447055335;4718.646101542398;4754.144254034238;5210.53105220532;5212.270282160501;5226.294450249244;5227.18978558324;5248.895022099613;4949.950500495021;4973.477784832613;5002.974985125124;5010.89978200434;5026.346574945233;4836.202026665561;4997.525235102659;5059.418166910778;5064.265681476165;5106.846794596168;5006.799728010838;5060.114479965991;5064.974675126675;5072.442031376546;5078.5937125029905;5048.242763585418;5061.848144555669;5064.366954130734;5069.264956581275;5091.618128640367;4071.8371265149653;4227.196832601796;4241.2365774160335;4250.978745106317;4307.870763877088;3723.1622884851236;3728.12389088564;3737.7570457920147;3762.6425489578446;3778.7732736035928;4307.806148723253;4405.118976204772;4407.272799987966;4415.757133357696;4430.446194225722;4858.1012512685265;5001.449840517613;5009.474005229398;5044.445111037783;5065.493450654979;4367.10474352757;4378.715383500063;4378.846740364135;4379.189849877783;4418.182636212311;4507.842225522091;4517.977410112929;4526.932096018562;4537.659675524349;4592.5407459254475;4566.908661826745;4697.929531057105;4721.811127554996;4744.146053710365;4756.357891684647;5083.466236045162;5094.337736094284;5123.590112791042;5126.333576635014;5147.2279158126585;4836.056968891033;4838.95161048385;4839.951600484091;4848.418189817245;4883.291922671264;4819.1566475867285;4965.900681986413;5005;5028.170351892043;5100.617453690914;5100.311457953278;5106.463821298858;5112.667676601009;5116.411612664591;5119.897602047864;4920.72935988524;4932.383452068491;4939.209726443752;4974.7512624369365;4987.476314986874;4698.765061746967;4890.486498917562;4927.211646136744;4951.858313823248;4953.777080031479;4861.124997500484;4890.682105663121;4931.605471562339;4947.084789313988;4950.331705219749;5016.072026675077;5025.623078269071;5036.899262014813;5039.571636410946;5046.34397528319;4629.722216667011;4788.497207793132;4832.903341933072;4870.09903167915;4966.031623833318 10:23:52 INFO - PROCESS | 14281 | |1;ext.html;545.342861851469;549.9670019798813;563.8928603565321;563.9830805075846;604.211503987297;34474.65525344746;38657.420138697904;38697.22605547891;38805.223895522075;38852.22295554094;39003.41494877579;39569.60430395695;39599.80200099003;39657.80171099141;39688.80155599225;7500.099988001448;7723.884141737878;7737.032870891138;7743.574103424309;7746.380289576849;7628.504147230412;7715.691372345127;7719.150893401721;7732.690692372298;7734.265244801763;7670.616469176547;7708.537487750725;7719.150893401721;7724.7682569523;7753.612319384037;7687.077550693896;7694.884576731353;7702.961485192566;7734.1492435832015;7743.961280193619;7674.846503069907;7717.768466946;7743.7676869694;7754.651040703126;7762.068551773767;36158.27683446316;36660.450093248626;36700.63299366999;36821.263574728626;36899.26201475982;2570.3959569501153;2961.6446026476747;2968.1095671298526;2980.8956686516085;3104.611923509561;25817.09640162585;26772.196834095008;27891.86054069737;28034;28322.716772832213;3263.559419478364;3323.778256082699;3338.96661033389;3362.0922350965348;3406.5230867678547;218155;218734;218988;221059.9999999984;222110;29672.554911676343;29793.553096703567;29869.55195672067;31419.858014198853;32563;34258.97223083312;34357.82821085928;34415.82792086023;34477.82761086179;34489.65510344915;12406.069544784177;12493.812592810933;12502.062345324137;12503;12507.562235321902;9746.512674366253;9817.509124543887;9833.803323933624;9851.605935762633;9906.702798916043;7781.06627204739;7837.373010159174;7872.606369681493;7922.960385198037;7963.562004089715;3069.9539506907413;3109.657937626859;3114.2525793809323;3140.952885706716;3147.3862596793865;840.2227939156378;868.3140319147802;932.47315266874;981.3081777347096;1006.335818359879;28371;28628.570571441443;28782.85608571944;28921.42157156845;29420.411591768046;952.5570609666399;1012.9696109116738;1060.3637817309552;1075.774087441646;1085.777415629794;13955.511557095453;14295.642608934651;14626.707465850623;14919.477818276308;14971.40114395412;371658;380097;381348;383038;383148;50088.24867626988;50366;50675.493245067075;50677.23984140241;51006.74496627493;1120.708615759892;1147.718808891827;1161.1291531351656;1162.3548930343572;1162.5001249462812;26812.731872681023;27972.440551188454;28743;28804.279893002004;29002.41995160127;43674;43805.34291985686;44113.33829992617;44130.77934610435;44136.117277653626;318608;320634;321514;322940;323755;24860.50278994446;25334.1133060342;25361.365965851;25462;25464.745352546237;41871.37192942047;41910.580894190665;41926.16147676968;42247.366289505066;43431.782841085595;30303.69696303097;30364.392712146077;30605;30679.693203067683;31440.685593143775;35564.28871422609;35973.28053438969;36094.27811443704;36259;36430.8178459106;32363.51454728228;35376.823115884254;35803.46294805632;36653.450198246515;36763.63236367602;31773;33059;33988.83005585055;34062.31875362528;34231.48652770161;25684.871575642002;26061.218163455127;26330.73669263283;26331.21006369812;26432 10:23:52 INFO - PROCESS | 14281 | |2;jquery.html;367.73890537718216;377.23609690376963;378.19255888677674;380.21485632169566;396.3104198694273;16074.51776446707;16434.835651643494;17094.401695940644;17133.571660708458;17170.656586868256;15922.601934951632;16360.590985225346;16436.506904792845;16703.498895033168;17253.705972052085;4543.591076803095;4734.597559207472;4739.691920025188;4744.478107408182;4756.1914474539235;3475.1138459692743;4344.978929951475;4624.075184963004;4669.696469729473;6114.571979961404;6132;6135.294441139282;6140.938590614103;6148;6150.6924653767355;5089.516495932899;5349.812756553502;5372.113601255827;6130.570860039799;6144.815655530341;5221.765020574083;5257.8159764408065;5268.4994925482015;5276.630635855492;5296.179092240709;18379.816201837944;19193.232270709155;19889.701654475193;20579.691304630443;20601.5879682407;1807.656545256397;1904.2478221102726;2095;2251.5271792923504;2353.294011796454;8985.6855010075;9140.725778226664;9614.51927403627;10798.298110622783;13425.66435839102;1661.418503523757;1697.8302169782924;1727.4385824606927;1739.2955852879604;1757.411267225481;55487.72256138734;58410;66315.66842165806;67202;68113.9999999995;9867.40795552269;9867.703968880945;9981.650642227487;10042.297039207331;10333.689989300334;13745;13788.517401890886;13803.309834508435;13807.447702091804;13829.861701383059;6991.091158149408;7205.855882882418;7316.487845850846;7374.041374621265;7512.32389084985;6419.903701444482;6481.837954051092;6582.24304205013;6613.404793568602;6659.034440006172;4287.935680964788;4302.591253830881;4314.439122914001;4341.196878577473;4342.305231162999;1829.6889528780139;1866.374764453896;1874.4845167578753;1903.657341678511;1955.9413217603494;777.3780975219802;790.7548659915444;802.6829402386024;862.6592495964059;887.992128933665;17297.394591189248;17356.218970146372;17533.736993945102;17980.820191797913;18114.3659971903;784.8626490364163;790.1387487638501;830.2154464031553;830.3357314148657;840.7603832907593;9554.331196816294;9741.172000380047;9979.611119399302;10058.14505767018;10076.848847267296;405959;409875;413794;418903;421414;43331.13337733228;67008.66495667491;73331.26668733351;73858;73968;870.3280239709845;880.7181701855473;893.3924931046821;897.7665806890255;911.2618778789202;15100.622484437978;15335.923320383326;15638;15914.7612785806;16084.919575402047;34257.657423425444;35199.47200792041;36485.63514364822;36606.63393366032;36661.63338366582;49998.750006249735;50394.244086339466;50953.490465094874;52338;53585.73207134095;7055.506114571931;7223.349898509159;7231;7303.780886573411;7600;7872.779719143542;9915.504224788587;11069.446527673745;11223;11617.361045142598;9649.324547281623;9699.817541053206;9723.562439690373;9861.457619830979;10178.033086856736;9451.432914025181;9684.806303874024;9692.660756873476;9878.950605246928;9954.352967057119;9414.670486533212;9802.460864652512;9814.362066465657;9837.557309921214;9871.062249086326;7159.713611455483;7227.747028853965;7231.783046508614;7377.963110184414;7641.6561254742555;7970.561619111005;9620.615175393186;9688.41869487833;10057.597696092367;10219.335743176669 10:23:52 INFO - PROCESS | 14281 | |3;mootools.html;1395.3581352577814;1404.7050119474911;1478.4751413248296;1712.297957837287;1717.02129786022;6822.624755638438;7530;7619.657115429805;8147;8155.551444670548;7727.652255648495;7894.052713674353;7965.880511792313;7966.32286255669;7978.561179135145;2086.332373640436;2125.861818981761;2127.042830726172;2138.647123224666;2139.732533433321;2101.4326131944367;2147.2699282244034;2174.945626359338;2182.3562049195525;2184.6176919039185;2120.141342756186;2126.4258650164525;2128.5849259394427;2145.4850835799452;2156.406988078283;2087.217293514924;2096.2453516733963;2099.9055042523123;2106.7050612914127;2107.9894600526977;2053.8151566359097;2078.044099714133;2082.427332483564;2084.270505323125;2087.65553683642;7955.880661790078;8018.919810801875;8033.517988920684;8061.516309021477;8071.556064416454;4449.466064072332;4542.6138778203895;4571.885702857422;4583.518730533279;4584.954150458486;2801.5097357962277;2854.0438952950785;2899.1157696902437;2938.6620538637903;2959.9852000740075;841.8163769780244;879.5074758135464;888.6756333938131;889.0131953531575;1755.4382597568783;10507.579696812118;10756.838647420294;10838.783224335548;10850.403227822466;10888.020078193;3842.135519508144;4035.9192816143513;4087.2847251731423;4099.938500922489;4119.8970025748995;8494.957525212458;8514;8550.273226775793;8578.742637720754;8597.312215022783;4326;4366.628836548929;4372.868813935587;4381.780910954503;4385.495667998157;3456.844442000116;3956.347202711578;4047.8988025299013;4055.5741647127215;4060.5127384714024;3302.306515631696;3372.629010808809;3425.7773244739014;3437.9828100859336;3492.5808902931303;1003.6537394598852;1007.6926537406162;1009.4448053570507;1010.141379827141;1019.3068713274896;665.6671664167916;827.8551253530608;827.9461834980707;830.6635812495949;867.7700409391516;5220.451852555503;5239.292695486137;5299.417064122943;5405.702686352289;5437.293151890229;370.97959612221047;383.459322355483;384.72299944040805;385.7299890076901;388.2351767018968;3948.230095131422;3949.5260568731937;4042.7574345538774;4127.174565086994;4130.979345103256;9624.133827955518;9667.758306042264;9729.4648794317;9767.951160244153;9838.852417213748;9599.952000239955;9638.662646807328;9775.51122443875;9817.214622830157;9819.950900245452;7269.345758881726;7281.089863767029;7351.44864135192;7500.924990750132;7515.361194298436;5400.62195646301;5635.520980716685;5677.261955945701;5770.2498675171955;5809.128630705428;8848.557572121239;8854.867176992479;8907.465552066897;8914.955425222832;8961.103889610988;8828.38201325901;9269.814603708022;9277.16505514507;9301.348905576544;9322.580483878377;6018.8194354169445;6635.9004614929845;6825.078614386995;7098.3256590623805;7232.493725439169;7516.699332026877;7563.924360756542;7572.053493313336;7590;7592.8861067082935;6786.830329241809;6859.965700171467;6889.517733758589;6907.654617269217;7041.295870412918;6648.867022659617;6747.224069231905;6792.286809885089;6793.592384456949;6885.208201056742;6293;6314.652694101868;6347.460465860454;6368.108464815023;6374.4900407966325;4587.495375508758;4719.433667959729;4727.881802954816;4808.927866081942;4869.220924652039;4637.62898968075;4640.164770341371;4702.811887524461;4707.105649926503;4749 10:23:52 INFO - PROCESS | 14281 | |4;prototype.html;299.4729276473406;304.24395377486945;308.70518654684776;309.8745008271649;311.0714517166259;4796.83211087612;4798.032806549316;4943.60451163907;4981.576565991891;5037.093323201818;4818.927716084253;4923.60611151108;4951.133551628469;4963.826266080688;4979.576735977446;3921.588233235512;3927.9410808837893;3937.960620393788;3939.3106206413904;3941.457759744963;3641.4901913732097;3927.116398810259;3935.0949281665235;3939.3106206413904;3940.581390699346;3802.353599888012;3808.5048943637426;3827.4450204720297;3829.0044588406936;3833.8083095845236;3815.2560250751117;3816.847326106966;3817.3701339278987;3822.694184465236;3829.9617003829885;3337.8664853405835;3353.4466812976075;3359.8488068036995;3375.6666116883694;3380.8309584520675;4754.072955773626;4862.805487780484;4864.659473836833;4876.536729010738;4891.652007036607;4358;4358.629516491102;4361.0841723237845;4363.650907927358;4404.889877753082;5126.436092029874;5129.640925135204;5142.280080788692;5150.673434315193;5168.405633352175;3579.176789338441;3662.7252956028406;3666.983159262395;3669.2294618130227;3683.9132455925564;5395.676259424408;5397.352317721859;5399.082156033444;5401.892612014528;5405.4054054054;3724.8510059597857;3731.9550525852806;3735.7198210133806;3737.8691745788765;3765.5104836371097;3820.178661587772;3825.0246187222638;3828.8277027533827;3831.5593706724085;3838.8848334550007;4212.722001267524;4269.295566231599;4286.249906266391;4310.935335969963;4326.913461730748;5097.974510127426;5107.463716309734;5135.38375394955;5138.717370544656;5144.897102057937;1247.9937600311941;1274.3182397417522;1281.333706472629;1300.9089363744447;1301.290796515901;862.2283056664376;880.2429910277157;889.5241046040337;896.9865452018225;903.8172812657359;4440.400545926259;4446.3330500424545;4472.217361961643;4472.217361961643;4483.887902802391;5101.7704203310195;5196.558292545101;5230.712310822865;5262.158054711304;5269.1569348903995;4453.599176074169;4463.86608401742;4465;4469;4469.642428605704;2652.872529175093;2843.232327271625;2859.628248327704;2865.782042631873;2866.3550701092086;5062.316587260672;5064.316317297192;5071.442141364447;5080.161773307437;5081.59347252219;5246.3704355477585;5420.268263784417;5432.348118225838;5435.673859568438;5447.645903016291;4982.252662100714;4999.400071991385;5032.47159048302;5037.5214354636255;5040.470750571284;5314.9468505316;5362.597805164551;5367.919481207863;5368.651037682538;5375.731213439234;4988.56018143845;5184.714840683799;5211.895762084813;5234.973825131003;5292.364916210079;5018.899622007612;5027.59779217669;5029.346184995927;5037.269595908646;5045.394552653705;3722.1997270586953;3752.2870654575545;3753.5120434344453;3753.6058713835746;3756.1924186300075;5186.858891043964;5190.6942590781855;5227.764750586157;5349.518543331119;5356.0626890294825;5094.541491265803;5119.590432765295;5129.358830146231;5132.640715149903;5138.640295179302;5121.411037730709;5157.355330583677;5160.896782064413;5173.689578625294;5188.092083885381;4863.270509423614;5052.368453943257;5069.645124841226;5084.491550844886;5129.486801393523;5192.9747398513855;5234.906037584997;5236.722025918738;5239.685618862881;5245.763940622757;5089.1094058538865;5118.718470484159;5128.256402821645;5143.3570803649545;5162.7867451149705 10:23:52 INFO - PROCESS | 14281 | |5;yui.html;554.7143221241064;578.8900108979296;592.9318128415232;723.645413747264;755.0938873351979;12499.125061245717;13327.866721332795;13346.799798003014;13383.93308033461;13396.933015334922;12757.489700411996;12953.158044727086;13200.603981880535;13264.602061938158;13316.267605281706;781.5467029123109;800.4236949396454;802.7551596762985;802.7631848604676;803.2489622203229;642.9164208652869;763.3702195688552;785.0814546980047;787.0437418536477;789.5341748368461;835.064727505195;835.4193835284449;837.2883049408015;838.4675730910855;840.2899549880341;815.7267315449302;821.5686764448683;821.7452589697212;821.9260266576036;825.475822852487;597.3339726205294;601.8465291350722;602.8553147244629;608.6834845880162;610.2707264818544;12895.09734318598;12973.221606703628;12980.740385192243;12986.675333116747;12992.805107923388;12792.61622151337;13143.34283285832;13377.130486518345;13405.798913016313;13531.458741650322;10407.21945854064;10410.479476026245;10478.79042419155;10515.579376824919;10799.4060326682;3062.3875224954877;3063.341381602944;3070.416620842033;3077.307605788702;3154.6372167200607;63424.365756342304;64863.67568162129;64870.83727045923;67094.32905670979;67322.66338668324;8944.910550894409;9926.354786938826;9953.402795832273;10009.449480278654;10082.848757268646;15729.68540629181;16394.09832459226;16528.09095499759;16580;16623.91688041552;6520.739170433224;6595.472362211011;6608.372204640552;6825.829354266084;6975.860482790417;3572.4105522588484;3627.7279204059273;3726.3851464508593;3741.5884252732176;3826.7512611680154;2766.14249582626;2860.070477094911;2866.240446281737;2867.0538722221618;2869.153599688097;472.53219312880003;474.42049734751384;482.06238865407147;487.8316980641673;488.83379650918147;499.6427554298694;510.40792680490455;540.235566673161;543.4592580382466;544.27067729243;8264.545450000307;8265.628046737791;8553.401261911731;8625.956870215734;8640.13598640131;506.6909185396905;516.803614626447;523.494827491465;550.8237364043467;554.0774610273929;3753.3806921858136;3838.7504812187676;3993.600639935983;4019.879403617838;4020.9396859047138;97245;101788;101864;102554.48722756338;102770.45844312341;51855.48144518506;90461;90942;91311;91622;78287;80679;83088.86022537516;84823.09449057812;85324.14675853286;8451.45065570736;8990.280777537911;9101.180893719596;9249.676261330822;9268.351215414856;41108.58891411048;43106.56893431026;43444.782776085915;44628.33057504075;45272.547274526834;38805.2238955225;47319.763401182776;54552.727236363564;56524.71737641285;61839.38160618516;10878;11821.408929553316;11831.645050648494;12023.398830058637;12251.632451026484;13154.144980576231;13544.255065971467;13708.040437169302;13928.233947133005;14060.067850728234;12567.37163141821;12784.836451143572;12990.870091299344;13013.284269365276;13593;12174.513019479122;12405.255684658949;12506.374681266083;12880.35598220104;12920.806187907001;12295.385230738248;12596;12644.663735806314;12659;12669.303188324731;10247.641332553325;10484.42335671515;10498.055175034284;10555.691212892862;10803.837942431028;8760.868586971328;9807.803843922939;9924.40453572788;10444.2166837489;10635.521401537104 10:23:52 INFO - PROCESS | 14281 | __end_tp_report 10:23:52 INFO - PROCESS | 14281 | __start_cc_report 10:23:52 INFO - PROCESS | 14281 | _x_x_mozilla_cycle_collect,366 10:23:52 INFO - PROCESS | 14281 | __end_cc_report 10:23:52 INFO - PROCESS | 14281 | __startTimestamp1470504232190__endTimestamp 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | ------- Summary: start ------- 10:23:52 INFO - PROCESS | 14281 | Number of tests: 6 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | [#0] dojo.html Cycles:165 Average:4680.30 Median:4799.57 stddev:488.96 (10.2%) stddev-sans-first:463.61 10:23:52 INFO - PROCESS | 14281 | Values: 2643.2 2659.0 2679.1 2683.6 2690.8 4504.3 4764.6 4767.2 4786.0 4792.0 4677.6 4703.2 4704.1 4723.4 4799.6 4291.0 4389.1 4436.3 4452.6 4498.7 4412.6 4468.8 4479.6 4490.0 4497.0 4237.6 4264.1 4292.8 4407.9 4438.4 4352.6 4357.0 4377.1 4394.2 4398.0 4319.1 4336.8 4358.9 4365.3 4373.5 4525.2 4578.9 4614.9 4667.8 4740.4 5026.9 5033.4 5053.1 5053.6 5074.1 5030.1 5049.3 5054.4 5059.5 5083.9 4555.2 4660.1 4705.5 4718.6 4754.1 5210.5 5212.3 5226.3 5227.2 5248.9 4950.0 4973.5 5003.0 5010.9 5026.3 4836.2 4997.5 5059.4 5064.3 5106.8 5006.8 5060.1 5065.0 5072.4 5078.6 5048.2 5061.8 5064.4 5069.3 5091.6 4071.8 4227.2 4241.2 4251.0 4307.9 3723.2 3728.1 3737.8 3762.6 3778.8 4307.8 4405.1 4407.3 4415.8 4430.4 4858.1 5001.4 5009.5 5044.4 5065.5 4367.1 4378.7 4378.8 4379.2 4418.2 4507.8 4518.0 4526.9 4537.7 4592.5 4566.9 4697.9 4721.8 4744.1 4756.4 5083.5 5094.3 5123.6 5126.3 5147.2 4836.1 4839.0 4840.0 4848.4 4883.3 4819.2 4965.9 5005.0 5028.2 5100.6 5100.3 5106.5 5112.7 5116.4 5119.9 4920.7 4932.4 4939.2 4974.8 4987.5 4698.8 4890.5 4927.2 4951.9 4953.8 4861.1 4890.7 4931.6 4947.1 4950.3 5016.1 5025.6 5036.9 5039.6 5046.3 4629.7 4788.5 4832.9 4870.1 4966.0 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | [#1] ext.html Cycles:180 Average:44580.96 Median:34483.74 stddev:82955.56 (240.6%) stddev-sans-first:83122.39 10:23:52 INFO - PROCESS | 14281 | Values: 545.3 550.0 563.9 564.0 604.2 34474.7 38657.4 38697.2 38805.2 38852.2 39003.4 39569.6 39599.8 39657.8 39688.8 7500.1 7723.9 7737.0 7743.6 7746.4 7628.5 7715.7 7719.2 7732.7 7734.3 7670.6 7708.5 7719.2 7724.8 7753.6 7687.1 7694.9 7703.0 7734.1 7744.0 7674.8 7717.8 7743.8 7754.7 7762.1 36158.3 36660.5 36700.6 36821.3 36899.3 2570.4 2961.6 2968.1 2980.9 3104.6 25817.1 26772.2 27891.9 28034.0 28322.7 3263.6 3323.8 3339.0 3362.1 3406.5 218155.0 218734.0 218988.0 221060.0 222110.0 29672.6 29793.6 29869.6 31419.9 32563.0 34259.0 34357.8 34415.8 34477.8 34489.7 12406.1 12493.8 12502.1 12503.0 12507.6 9746.5 9817.5 9833.8 9851.6 9906.7 7781.1 7837.4 7872.6 7923.0 7963.6 3070.0 3109.7 3114.3 3141.0 3147.4 840.2 868.3 932.5 981.3 1006.3 28371.0 28628.6 28782.9 28921.4 29420.4 952.6 1013.0 1060.4 1075.8 1085.8 13955.5 14295.6 14626.7 14919.5 14971.4 371658.0 380097.0 381348.0 383038.0 383148.0 50088.2 50366.0 50675.5 50677.2 51006.7 1120.7 1147.7 1161.1 1162.4 1162.5 26812.7 27972.4 28743.0 28804.3 29002.4 43674.0 43805.3 44113.3 44130.8 44136.1 318608.0 320634.0 321514.0 322940.0 323755.0 24860.5 25334.1 25361.4 25462.0 25464.7 41871.4 41910.6 41926.2 42247.4 43431.8 30303.7 30364.4 30605.0 30679.7 31440.7 35564.3 35973.3 36094.3 36259.0 36430.8 32363.5 35376.8 35803.5 36653.5 36763.6 31773.0 33059.0 33988.8 34062.3 34231.5 25684.9 26061.2 26330.7 26331.2 26432.0 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | [#2] jquery.html Cycles:180 Average:24388.25 Median:28087.63 stddev:67960.58 (242.0%) stddev-sans-first:68127.30 10:23:52 INFO - PROCESS | 14281 | Values: 367.7 377.2 378.2 380.2 396.3 16074.5 16434.8 17094.4 17133.6 17170.7 15922.6 16360.6 16436.5 16703.5 17253.7 4543.6 4734.6 4739.7 4744.5 4756.2 3475.1 4345.0 4624.1 4669.7 6114.6 6132.0 6135.3 6140.9 6148.0 6150.7 5089.5 5349.8 5372.1 6130.6 6144.8 5221.8 5257.8 5268.5 5276.6 5296.2 18379.8 19193.2 19889.7 20579.7 20601.6 1807.7 1904.2 2095.0 2251.5 2353.3 8985.7 9140.7 9614.5 10798.3 13425.7 1661.4 1697.8 1727.4 1739.3 1757.4 55487.7 58410.0 66315.7 67202.0 68114.0 9867.4 9867.7 9981.7 10042.3 10333.7 13745.0 13788.5 13803.3 13807.4 13829.9 6991.1 7205.9 7316.5 7374.0 7512.3 6419.9 6481.8 6582.2 6613.4 6659.0 4287.9 4302.6 4314.4 4341.2 4342.3 1829.7 1866.4 1874.5 1903.7 1955.9 777.4 790.8 802.7 862.7 888.0 17297.4 17356.2 17533.7 17980.8 18114.4 784.9 790.1 830.2 830.3 840.8 9554.3 9741.2 9979.6 10058.1 10076.8 405959.0 409875.0 413794.0 418903.0 421414.0 43331.1 67008.7 73331.3 73858.0 73968.0 870.3 880.7 893.4 897.8 911.3 15100.6 15335.9 15638.0 15914.8 16084.9 34257.7 35199.5 36485.6 36606.6 36661.6 49998.8 50394.2 50953.5 52338.0 53585.7 7055.5 7223.3 7231.0 7303.8 7600.0 7872.8 9915.5 11069.4 11223.0 11617.4 9649.3 9699.8 9723.6 9861.5 10178.0 9451.4 9684.8 9692.7 9879.0 9954.4 9414.7 9802.5 9814.4 9837.6 9871.1 7159.7 7227.7 7231.8 7378.0 7641.7 7970.6 9620.6 9688.4 10057.6 10219.3 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | [#3] mootools.html Cycles:180 Average:5143.76 Median:5044.84 stddev:2929.65 (58.1%) stddev-sans-first:2924.33 10:23:52 INFO - PROCESS | 14281 | Values: 1395.4 1404.7 1478.5 1712.3 1717.0 6822.6 7530.0 7619.7 8147.0 8155.6 7727.7 7894.1 7965.9 7966.3 7978.6 2086.3 2125.9 2127.0 2138.6 2139.7 2101.4 2147.3 2174.9 2182.4 2184.6 2120.1 2126.4 2128.6 2145.5 2156.4 2087.2 2096.2 2099.9 2106.7 2108.0 2053.8 2078.0 2082.4 2084.3 2087.7 7955.9 8018.9 8033.5 8061.5 8071.6 4449.5 4542.6 4571.9 4583.5 4585.0 2801.5 2854.0 2899.1 2938.7 2960.0 841.8 879.5 888.7 889.0 1755.4 10507.6 10756.8 10838.8 10850.4 10888.0 3842.1 4035.9 4087.3 4099.9 4119.9 8495.0 8514.0 8550.3 8578.7 8597.3 4326.0 4366.6 4372.9 4381.8 4385.5 3456.8 3956.3 4047.9 4055.6 4060.5 3302.3 3372.6 3425.8 3438.0 3492.6 1003.7 1007.7 1009.4 1010.1 1019.3 665.7 827.9 827.9 830.7 867.8 5220.5 5239.3 5299.4 5405.7 5437.3 371.0 383.5 384.7 385.7 388.2 3948.2 3949.5 4042.8 4127.2 4131.0 9624.1 9667.8 9729.5 9768.0 9838.9 9600.0 9638.7 9775.5 9817.2 9820.0 7269.3 7281.1 7351.4 7500.9 7515.4 5400.6 5635.5 5677.3 5770.2 5809.1 8848.6 8854.9 8907.5 8915.0 8961.1 8828.4 9269.8 9277.2 9301.3 9322.6 6018.8 6635.9 6825.1 7098.3 7232.5 7516.7 7563.9 7572.1 7590.0 7592.9 6786.8 6860.0 6889.5 6907.7 7041.3 6648.9 6747.2 6792.3 6793.6 6885.2 6293.0 6314.7 6347.5 6368.1 6374.5 4587.5 4719.4 4727.9 4808.9 4869.2 4637.6 4640.2 4702.8 4707.1 4749.0 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | [#4] prototype.html Cycles:180 Average:4283.95 Median:4947.37 stddev:1246.73 (25.2%) stddev-sans-first:1213.83 10:23:52 INFO - PROCESS | 14281 | Values: 299.5 304.2 308.7 309.9 311.1 4796.8 4798.0 4943.6 4981.6 5037.1 4818.9 4923.6 4951.1 4963.8 4979.6 3921.6 3927.9 3938.0 3939.3 3941.5 3641.5 3927.1 3935.1 3939.3 3940.6 3802.4 3808.5 3827.4 3829.0 3833.8 3815.3 3816.8 3817.4 3822.7 3830.0 3337.9 3353.4 3359.8 3375.7 3380.8 4754.1 4862.8 4864.7 4876.5 4891.7 4358.0 4358.6 4361.1 4363.7 4404.9 5126.4 5129.6 5142.3 5150.7 5168.4 3579.2 3662.7 3667.0 3669.2 3683.9 5395.7 5397.4 5399.1 5401.9 5405.4 3724.9 3732.0 3735.7 3737.9 3765.5 3820.2 3825.0 3828.8 3831.6 3838.9 4212.7 4269.3 4286.2 4310.9 4326.9 5098.0 5107.5 5135.4 5138.7 5144.9 1248.0 1274.3 1281.3 1300.9 1301.3 862.2 880.2 889.5 897.0 903.8 4440.4 4446.3 4472.2 4472.2 4483.9 5101.8 5196.6 5230.7 5262.2 5269.2 4453.6 4463.9 4465.0 4469.0 4469.6 2652.9 2843.2 2859.6 2865.8 2866.4 5062.3 5064.3 5071.4 5080.2 5081.6 5246.4 5420.3 5432.3 5435.7 5447.6 4982.3 4999.4 5032.5 5037.5 5040.5 5314.9 5362.6 5367.9 5368.7 5375.7 4988.6 5184.7 5211.9 5235.0 5292.4 5018.9 5027.6 5029.3 5037.3 5045.4 3722.2 3752.3 3753.5 3753.6 3756.2 5186.9 5190.7 5227.8 5349.5 5356.1 5094.5 5119.6 5129.4 5132.6 5138.6 5121.4 5157.4 5160.9 5173.7 5188.1 4863.3 5052.4 5069.6 5084.5 5129.5 5193.0 5234.9 5236.7 5239.7 5245.8 5089.1 5118.7 5128.3 5143.4 5162.8 10:23:52 INFO - PROCESS | 14281 | 10:23:52 INFO - PROCESS | 14281 | [#5] yui.html Cycles:180 Average:17908.09 Median:43275.68 stddev:25923.79 (59.9%) stddev-sans-first:25963.76 10:23:52 INFO - PROCESS | 14281 | Values: 554.7 578.9 592.9 723.6 755.1 12499.1 13327.9 13346.8 13383.9 13396.9 12757.5 12953.2 13200.6 13264.6 13316.3 781.5 800.4 802.8 802.8 803.2 642.9 763.4 785.1 787.0 789.5 835.1 835.4 837.3 838.5 840.3 815.7 821.6 821.7 821.9 825.5 597.3 601.8 602.9 608.7 610.3 12895.1 12973.2 12980.7 12986.7 12992.8 12792.6 13143.3 13377.1 13405.8 13531.5 10407.2 10410.5 10478.8 10515.6 10799.4 3062.4 3063.3 3070.4 3077.3 3154.6 63424.4 64863.7 64870.8 67094.3 67322.7 8944.9 9926.4 9953.4 10009.4 10082.8 15729.7 16394.1 16528.1 16580.0 16623.9 6520.7 6595.5 6608.4 6825.8 6975.9 3572.4 3627.7 3726.4 3741.6 3826.8 2766.1 2860.1 2866.2 2867.1 2869.2 472.5 474.4 482.1 487.8 488.8 499.6 510.4 540.2 543.5 544.3 8264.5 8265.6 8553.4 8626.0 8640.1 506.7 516.8 523.5 550.8 554.1 3753.4 3838.8 3993.6 4019.9 4020.9 97245.0 101788.0 101864.0 102554.5 102770.5 51855.5 90461.0 90942.0 91311.0 91622.0 78287.0 80679.0 83088.9 84823.1 85324.1 8451.5 8990.3 9101.2 9249.7 9268.4 41108.6 43106.6 43444.8 44628.3 45272.5 38805.2 47319.8 54552.7 56524.7 61839.4 10878.0 11821.4 11831.6 12023.4 12251.6 13154.1 13544.3 13708.0 13928.2 14060.1 12567.4 12784.8 12990.9 13013.3 13593.0 12174.5 12405.3 12506.4 12880.4 12920.8 12295.4 12596.0 12644.7 12659.0 12669.3 10247.6 10484.4 10498.1 10555.7 10803.8 8760.9 9807.8 9924.4 10444.2 10635.5 10:23:52 INFO - PROCESS | 14281 | -------- Summary: end -------- 10:23:52 INFO - PROCESS | 14281 | 10:23:53 INFO - TEST-INFO | 14281: exit 0 10:23:53 INFO - TEST-OK | dromaeo_css | took 1117196ms 10:23:53 INFO - TEST-START | kraken 10:23:53 INFO - operating with platform_type : linux_ 10:23:53 INFO - Initialising browser for kraken test... 10:23:53 INFO - TEST-INFO | started process 14529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf885Hn/profile http://localhost:42679/getInfo.html) 10:23:57 INFO - PROCESS | 14529 | __metrics Screen width/height:1600/1200 10:23:57 INFO - PROCESS | 14529 | colorDepth:24 10:23:57 INFO - PROCESS | 14529 | Browser inner width/height: 1024/697 10:23:57 INFO - PROCESS | 14529 | __metrics 10:23:58 ERROR - PROCESS | 14529 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:23:59 INFO - TEST-INFO | 14529: exit 0 10:23:59 INFO - Browser initialized. 10:23:59 INFO - Running cycle 1/1 for kraken test... 10:23:59 INFO - TEST-INFO | started process 14650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf885Hn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:11 INFO - PROCESS | 14650 | RSS: Main: 165048320 10:24:11 INFO - PROCESS | 14650 | 10:24:14 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42679/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:15 INFO - PROCESS | 14650 | RSS: Main: 170192896 10:24:15 INFO - PROCESS | 14650 | 10:24:17 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42679/tests/kraken/driver.html?testName=audio-dft) 10:24:18 INFO - PROCESS | 14650 | RSS: Main: 168947712 10:24:18 INFO - PROCESS | 14650 | 10:24:21 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42679/tests/kraken/driver.html?testName=audio-fft) 10:24:22 INFO - PROCESS | 14650 | RSS: Main: 165351424 10:24:22 INFO - PROCESS | 14650 | 10:24:24 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42679/tests/kraken/driver.html?testName=audio-oscillator) 10:24:24 INFO - PROCESS | 14650 | RSS: Main: 165969920 10:24:24 INFO - PROCESS | 14650 | 10:24:27 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42679/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:27 INFO - PROCESS | 14650 | RSS: Main: 166002688 10:24:27 INFO - PROCESS | 14650 | 10:24:31 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42679/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:31 INFO - PROCESS | 14650 | RSS: Main: 166547456 10:24:31 INFO - PROCESS | 14650 | 10:24:35 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42679/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:35 INFO - PROCESS | 14650 | RSS: Main: 164085760 10:24:35 INFO - PROCESS | 14650 | 10:24:38 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42679/tests/kraken/driver.html?testName=json-parse-financial) 10:24:39 INFO - PROCESS | 14650 | RSS: Main: 166113280 10:24:39 INFO - PROCESS | 14650 | 10:24:41 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42679/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:41 INFO - PROCESS | 14650 | RSS: Main: 165842944 10:24:41 INFO - PROCESS | 14650 | 10:24:43 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:44 INFO - PROCESS | 14650 | RSS: Main: 166027264 10:24:44 INFO - PROCESS | 14650 | 10:24:46 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:47 INFO - PROCESS | 14650 | RSS: Main: 166260736 10:24:47 INFO - PROCESS | 14650 | 10:24:50 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:50 INFO - PROCESS | 14650 | RSS: Main: 166420480 10:24:50 INFO - PROCESS | 14650 | 10:24:53 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:54 INFO - PROCESS | 14650 | RSS: Main: 166858752 10:24:54 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | Cycle 1(1): loaded http://localhost:42679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42679/tests/kraken/driver.html?testName=ai-astar) 10:24:56 INFO - PROCESS | 14650 | RSS: Main: 167399424 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | __start_tp_report 10:24:56 INFO - PROCESS | 14650 | _x_x_mozilla_page_load 10:24:56 INFO - PROCESS | 14650 | _x_x_mozilla_page_load_details 10:24:56 INFO - PROCESS | 14650 | |i|pagename|runs| 10:24:56 INFO - PROCESS | 14650 | |0;ai-astar;105;117;110;124;115;116;115;116;117;116 10:24:56 INFO - PROCESS | 14650 | |1;audio-beat-detection;150;127;153;173;123;156;149;124;172;124 10:24:56 INFO - PROCESS | 14650 | |2;audio-dft;173;164;165;166;170;165;164;166;163;162 10:24:56 INFO - PROCESS | 14650 | |3;audio-fft;76;77;76;167;76;76;77;76;166;78 10:24:56 INFO - PROCESS | 14650 | |4;audio-oscillator;87;85;157;87;87;87;135;86;89;146 10:24:56 INFO - PROCESS | 14650 | |5;imaging-gaussian-blur;118;119;121;119;118;118;118;117;119;118 10:24:56 INFO - PROCESS | 14650 | |6;imaging-darkroom;150;148;148;150;147;148;147;149;147;147 10:24:56 INFO - PROCESS | 14650 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;95 10:24:56 INFO - PROCESS | 14650 | |8;json-parse-financial;63;63;64;63;63;62;62;62;64;62 10:24:56 INFO - PROCESS | 14650 | |9;json-stringify-tinderbox;66;66;65;65;66;65;65;64;66;66 10:24:56 INFO - PROCESS | 14650 | |10;stanford-crypto-aes;87;85;89;80;81;80;80;81;86;81 10:24:56 INFO - PROCESS | 14650 | |11;stanford-crypto-ccm;162;138;135;131;136;149;140;137;168;138 10:24:56 INFO - PROCESS | 14650 | |12;stanford-crypto-pbkdf2;173;170;165;177;170;165;169;172;168;167 10:24:56 INFO - PROCESS | 14650 | |13;stanford-crypto-sha256-iterative;69;68;69;69;69;68;68;67;66;67 10:24:56 INFO - PROCESS | 14650 | __end_tp_report 10:24:56 INFO - PROCESS | 14650 | __start_cc_report 10:24:56 INFO - PROCESS | 14650 | _x_x_mozilla_cycle_collect,934 10:24:56 INFO - PROCESS | 14650 | __end_cc_report 10:24:56 INFO - PROCESS | 14650 | __startTimestamp1470504296325__endTimestamp 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | ------- Summary: start ------- 10:24:56 INFO - PROCESS | 14650 | Number of tests: 14 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:4.91 (4.2%) stddev-sans-first:3.60 10:24:56 INFO - PROCESS | 14650 | Values: 105.0 117.0 110.0 124.0 115.0 116.0 115.0 116.0 117.0 116.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:151.50 stddev:19.52 (12.9%) stddev-sans-first:20.62 10:24:56 INFO - PROCESS | 14650 | Values: 150.0 127.0 153.0 173.0 123.0 156.0 149.0 124.0 172.0 124.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.33 (2.0%) stddev-sans-first:2.29 10:24:56 INFO - PROCESS | 14650 | Values: 173.0 164.0 165.0 166.0 170.0 165.0 164.0 166.0 163.0 162.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:37.95 (49.9%) stddev-sans-first:39.66 10:24:56 INFO - PROCESS | 14650 | Values: 76.0 77.0 76.0 167.0 76.0 76.0 77.0 76.0 166.0 78.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:87.00 stddev:29.05 (33.4%) stddev-sans-first:30.11 10:24:56 INFO - PROCESS | 14650 | Values: 87.0 85.0 157.0 87.0 87.0 87.0 135.0 86.0 89.0 146.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 10:24:56 INFO - PROCESS | 14650 | Values: 118.0 119.0 121.0 119.0 118.0 118.0 118.0 117.0 119.0 118.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.05 10:24:56 INFO - PROCESS | 14650 | Values: 150.0 148.0 148.0 150.0 147.0 148.0 147.0 149.0 147.0 147.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:24:56 INFO - PROCESS | 14650 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 10:24:56 INFO - PROCESS | 14650 | Values: 63.0 63.0 64.0 63.0 63.0 62.0 62.0 62.0 64.0 62.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 10:24:56 INFO - PROCESS | 14650 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 65.0 64.0 66.0 66.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:3.40 (4.1%) stddev-sans-first:3.28 10:24:56 INFO - PROCESS | 14650 | Values: 87.0 85.0 89.0 80.0 81.0 80.0 80.0 81.0 86.0 81.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:139.00 stddev:12.35 (8.9%) stddev-sans-first:11.11 10:24:56 INFO - PROCESS | 14650 | Values: 162.0 138.0 135.0 131.0 136.0 149.0 140.0 137.0 168.0 138.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:3.72 (2.2%) stddev-sans-first:3.73 10:24:56 INFO - PROCESS | 14650 | Values: 173.0 170.0 165.0 177.0 170.0 165.0 169.0 172.0 168.0 167.0 10:24:56 INFO - PROCESS | 14650 | 10:24:56 INFO - PROCESS | 14650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.05 (1.5%) stddev-sans-first:1.05 10:24:56 INFO - PROCESS | 14650 | Values: 69.0 68.0 69.0 69.0 69.0 68.0 68.0 67.0 66.0 67.0 10:24:56 INFO - PROCESS | 14650 | -------- Summary: end -------- 10:24:56 INFO - PROCESS | 14650 | 10:24:57 INFO - TEST-INFO | 14650: exit 0 10:24:57 INFO - TEST-OK | kraken | took 64390ms 10:24:57 INFO - SUITE-END | took 1181s 10:24:57 INFO - Completed test suite (00:19:41) 10:24:57 INFO - javascript benchmark 10:24:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6285.508838908418, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.1806140096573, 2658.9734102658967, 2679.11589175572, 2683.6242925990364, 2690.7981901357402, 4504.346869703891, 4764.618830493561, 4767.213409787385, 4786.0, 4791.976040119799, 4677.555632214942, 4703.15343238217, 4704.129735998834, 4723.409573803275, 4799.5680388765, 4290.957090429102, 4389.078293558357, 4436.268015777393, 4452.554744525538, 4498.685092043558, 4412.624926881219, 4468.798904049309, 4479.574440428154, 4490.0, 4496.9775151124195, 4237.555056719062, 4264.1471705659, 4292.785360731951, 4407.933880991755, 4438.3564383164585, 4352.630026447756, 4357.0, 4377.146456440995, 4394.231009573312, 4397.956020439787, 4319.07139964909, 4336.848210312624, 4358.934615980763, 4365.301551751704, 4373.540778218305, 4525.208088584517, 4578.931316030262, 4614.907701845944, 4667.766611669403, 4740.431148262231, 5026.874328141789, 5033.395992480926, 5053.065182941167, 5053.620978426633, 5074.086664400406, 5030.0694371541385, 5049.267856160873, 5054.444011158769, 5059.519345662156, 5083.906960003617, 4555.157295900269, 4660.091282200006, 4705.529447055335, 4718.646101542398, 4754.144254034238, 5210.53105220532, 5212.270282160501, 5226.294450249244, 5227.18978558324, 5248.895022099613, 4949.950500495021, 4973.477784832613, 5002.974985125124, 5010.89978200434, 5026.346574945233, 4836.202026665561, 4997.525235102659, 5059.418166910778, 5064.265681476165, 5106.846794596168, 5006.799728010838, 5060.114479965991, 5064.974675126675, 5072.442031376546, 5078.5937125029905, 5048.242763585418, 5061.848144555669, 5064.366954130734, 5069.264956581275, 5091.618128640367, 4071.8371265149653, 4227.196832601796, 4241.2365774160335, 4250.978745106317, 4307.870763877088, 3723.1622884851236, 3728.12389088564, 3737.7570457920147, 3762.6425489578446, 3778.7732736035928, 4307.806148723253, 4405.118976204772, 4407.272799987966, 4415.757133357696, 4430.446194225722, 4858.1012512685265, 5001.449840517613, 5009.474005229398, 5044.445111037783, 5065.493450654979, 4367.10474352757, 4378.715383500063, 4378.846740364135, 4379.189849877783, 4418.182636212311, 4507.842225522091, 4517.977410112929, 4526.932096018562, 4537.659675524349, 4592.5407459254475, 4566.908661826745, 4697.929531057105, 4721.811127554996, 4744.146053710365, 4756.357891684647, 5083.466236045162, 5094.337736094284, 5123.590112791042, 5126.333576635014, 5147.2279158126585, 4836.056968891033, 4838.95161048385, 4839.951600484091, 4848.418189817245, 4883.291922671264, 4819.1566475867285, 4965.900681986413, 5005.0, 5028.170351892043, 5100.617453690914, 5100.311457953278, 5106.463821298858, 5112.667676601009, 5116.411612664591, 5119.897602047864, 4920.72935988524, 4932.383452068491, 4939.209726443752, 4974.7512624369365, 4987.476314986874, 4698.765061746967, 4890.486498917562, 4927.211646136744, 4951.858313823248, 4953.777080031479, 4861.124997500484, 4890.682105663121, 4931.605471562339, 4947.084789313988, 4950.331705219749, 5016.072026675077, 5025.623078269071, 5036.899262014813, 5039.571636410946, 5046.34397528319, 4629.722216667011, 4788.497207793132, 4832.903341933072, 4870.09903167915, 4966.031623833318], "value": 4649.504187041615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.342861851469, 549.9670019798813, 563.8928603565321, 563.9830805075846, 604.211503987297, 34474.65525344746, 38657.420138697904, 38697.22605547891, 38805.223895522075, 38852.22295554094, 39003.41494877579, 39569.60430395695, 39599.80200099003, 39657.80171099141, 39688.80155599225, 7500.099988001448, 7723.884141737878, 7737.032870891138, 7743.574103424309, 7746.380289576849, 7628.504147230412, 7715.691372345127, 7719.150893401721, 7732.690692372298, 7734.265244801763, 7670.616469176547, 7708.537487750725, 7719.150893401721, 7724.7682569523, 7753.612319384037, 7687.077550693896, 7694.884576731353, 7702.961485192566, 7734.1492435832015, 7743.961280193619, 7674.846503069907, 7717.768466946, 7743.7676869694, 7754.651040703126, 7762.068551773767, 36158.27683446316, 36660.450093248626, 36700.63299366999, 36821.263574728626, 36899.26201475982, 2570.3959569501153, 2961.6446026476747, 2968.1095671298526, 2980.8956686516085, 3104.611923509561, 25817.09640162585, 26772.196834095008, 27891.86054069737, 28034.0, 28322.716772832213, 3263.559419478364, 3323.778256082699, 3338.96661033389, 3362.0922350965348, 3406.5230867678547, 218155.0, 218734.0, 218988.0, 221059.9999999984, 222110.0, 29672.554911676343, 29793.553096703567, 29869.55195672067, 31419.858014198853, 32563.0, 34258.97223083312, 34357.82821085928, 34415.82792086023, 34477.82761086179, 34489.65510344915, 12406.069544784177, 12493.812592810933, 12502.062345324137, 12503.0, 12507.562235321902, 9746.512674366253, 9817.509124543887, 9833.803323933624, 9851.605935762633, 9906.702798916043, 7781.06627204739, 7837.373010159174, 7872.606369681493, 7922.960385198037, 7963.562004089715, 3069.9539506907413, 3109.657937626859, 3114.2525793809323, 3140.952885706716, 3147.3862596793865, 840.2227939156378, 868.3140319147802, 932.47315266874, 981.3081777347096, 1006.335818359879, 28371.0, 28628.570571441443, 28782.85608571944, 28921.42157156845, 29420.411591768046, 952.5570609666399, 1012.9696109116738, 1060.3637817309552, 1075.774087441646, 1085.777415629794, 13955.511557095453, 14295.642608934651, 14626.707465850623, 14919.477818276308, 14971.40114395412, 371658.0, 380097.0, 381348.0, 383038.0, 383148.0, 50088.24867626988, 50366.0, 50675.493245067075, 50677.23984140241, 51006.74496627493, 1120.708615759892, 1147.718808891827, 1161.1291531351656, 1162.3548930343572, 1162.5001249462812, 26812.731872681023, 27972.440551188454, 28743.0, 28804.279893002004, 29002.41995160127, 43674.0, 43805.34291985686, 44113.33829992617, 44130.77934610435, 44136.117277653626, 318608.0, 320634.0, 321514.0, 322940.0, 323755.0, 24860.50278994446, 25334.1133060342, 25361.365965851, 25462.0, 25464.745352546237, 41871.37192942047, 41910.580894190665, 41926.16147676968, 42247.366289505066, 43431.782841085595, 30303.69696303097, 30364.392712146077, 30605.0, 30679.693203067683, 31440.685593143775, 35564.28871422609, 35973.28053438969, 36094.27811443704, 36259.0, 36430.8178459106, 32363.51454728228, 35376.823115884254, 35803.46294805632, 36653.450198246515, 36763.63236367602, 31773.0, 33059.0, 33988.83005585055, 34062.31875362528, 34231.48652770161, 25684.871575642002, 26061.218163455127, 26330.73669263283, 26331.21006369812, 26432.0], "value": 15965.328892452997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.73890537718216, 377.23609690376963, 378.19255888677674, 380.21485632169566, 396.3104198694273, 16074.51776446707, 16434.835651643494, 17094.401695940644, 17133.571660708458, 17170.656586868256, 15922.601934951632, 16360.590985225346, 16436.506904792845, 16703.498895033168, 17253.705972052085, 4543.591076803095, 4734.597559207472, 4739.691920025188, 4744.478107408182, 4756.1914474539235, 3475.1138459692743, 4344.978929951475, 4624.075184963004, 4669.696469729473, 6114.571979961404, 6132.0, 6135.294441139282, 6140.938590614103, 6148.0, 6150.6924653767355, 5089.516495932899, 5349.812756553502, 5372.113601255827, 6130.570860039799, 6144.815655530341, 5221.765020574083, 5257.8159764408065, 5268.4994925482015, 5276.630635855492, 5296.179092240709, 18379.816201837944, 19193.232270709155, 19889.701654475193, 20579.691304630443, 20601.5879682407, 1807.656545256397, 1904.2478221102726, 2095.0, 2251.5271792923504, 2353.294011796454, 8985.6855010075, 9140.725778226664, 9614.51927403627, 10798.298110622783, 13425.66435839102, 1661.418503523757, 1697.8302169782924, 1727.4385824606927, 1739.2955852879604, 1757.411267225481, 55487.72256138734, 58410.0, 66315.66842165806, 67202.0, 68113.9999999995, 9867.40795552269, 9867.703968880945, 9981.650642227487, 10042.297039207331, 10333.689989300334, 13745.0, 13788.517401890886, 13803.309834508435, 13807.447702091804, 13829.861701383059, 6991.091158149408, 7205.855882882418, 7316.487845850846, 7374.041374621265, 7512.32389084985, 6419.903701444482, 6481.837954051092, 6582.24304205013, 6613.404793568602, 6659.034440006172, 4287.935680964788, 4302.591253830881, 4314.439122914001, 4341.196878577473, 4342.305231162999, 1829.6889528780139, 1866.374764453896, 1874.4845167578753, 1903.657341678511, 1955.9413217603494, 777.3780975219802, 790.7548659915444, 802.6829402386024, 862.6592495964059, 887.992128933665, 17297.394591189248, 17356.218970146372, 17533.736993945102, 17980.820191797913, 18114.3659971903, 784.8626490364163, 790.1387487638501, 830.2154464031553, 830.3357314148657, 840.7603832907593, 9554.331196816294, 9741.172000380047, 9979.611119399302, 10058.14505767018, 10076.848847267296, 405959.0, 409875.0, 413794.0, 418903.0, 421414.0, 43331.13337733228, 67008.66495667491, 73331.26668733351, 73858.0, 73968.0, 870.3280239709845, 880.7181701855473, 893.3924931046821, 897.7665806890255, 911.2618778789202, 15100.622484437978, 15335.923320383326, 15638.0, 15914.7612785806, 16084.919575402047, 34257.657423425444, 35199.47200792041, 36485.63514364822, 36606.63393366032, 36661.63338366582, 49998.750006249735, 50394.244086339466, 50953.490465094874, 52338.0, 53585.73207134095, 7055.506114571931, 7223.349898509159, 7231.0, 7303.780886573411, 7600.0, 7872.779719143542, 9915.504224788587, 11069.446527673745, 11223.0, 11617.361045142598, 9649.324547281623, 9699.817541053206, 9723.562439690373, 9861.457619830979, 10178.033086856736, 9451.432914025181, 9684.806303874024, 9692.660756873476, 9878.950605246928, 9954.352967057119, 9414.670486533212, 9802.460864652512, 9814.362066465657, 9837.557309921214, 9871.062249086326, 7159.713611455483, 7227.747028853965, 7231.783046508614, 7377.963110184414, 7641.6561254742555, 7970.561619111005, 9620.615175393186, 9688.41869487833, 10057.597696092367, 10219.335743176669], "value": 8058.592788584833, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.3581352577814, 1404.7050119474911, 1478.4751413248296, 1712.297957837287, 1717.02129786022, 6822.624755638438, 7530.0, 7619.657115429805, 8147.0, 8155.551444670548, 7727.652255648495, 7894.052713674353, 7965.880511792313, 7966.32286255669, 7978.561179135145, 2086.332373640436, 2125.861818981761, 2127.042830726172, 2138.647123224666, 2139.732533433321, 2101.4326131944367, 2147.2699282244034, 2174.945626359338, 2182.3562049195525, 2184.6176919039185, 2120.141342756186, 2126.4258650164525, 2128.5849259394427, 2145.4850835799452, 2156.406988078283, 2087.217293514924, 2096.2453516733963, 2099.9055042523123, 2106.7050612914127, 2107.9894600526977, 2053.8151566359097, 2078.044099714133, 2082.427332483564, 2084.270505323125, 2087.65553683642, 7955.880661790078, 8018.919810801875, 8033.517988920684, 8061.516309021477, 8071.556064416454, 4449.466064072332, 4542.6138778203895, 4571.885702857422, 4583.518730533279, 4584.954150458486, 2801.5097357962277, 2854.0438952950785, 2899.1157696902437, 2938.6620538637903, 2959.9852000740075, 841.8163769780244, 879.5074758135464, 888.6756333938131, 889.0131953531575, 1755.4382597568783, 10507.579696812118, 10756.838647420294, 10838.783224335548, 10850.403227822466, 10888.020078193, 3842.135519508144, 4035.9192816143513, 4087.2847251731423, 4099.938500922489, 4119.8970025748995, 8494.957525212458, 8514.0, 8550.273226775793, 8578.742637720754, 8597.312215022783, 4326.0, 4366.628836548929, 4372.868813935587, 4381.780910954503, 4385.495667998157, 3456.844442000116, 3956.347202711578, 4047.8988025299013, 4055.5741647127215, 4060.5127384714024, 3302.306515631696, 3372.629010808809, 3425.7773244739014, 3437.9828100859336, 3492.5808902931303, 1003.6537394598852, 1007.6926537406162, 1009.4448053570507, 1010.141379827141, 1019.3068713274896, 665.6671664167916, 827.8551253530608, 827.9461834980707, 830.6635812495949, 867.7700409391516, 5220.451852555503, 5239.292695486137, 5299.417064122943, 5405.702686352289, 5437.293151890229, 370.97959612221047, 383.459322355483, 384.72299944040805, 385.7299890076901, 388.2351767018968, 3948.230095131422, 3949.5260568731937, 4042.7574345538774, 4127.174565086994, 4130.979345103256, 9624.133827955518, 9667.758306042264, 9729.4648794317, 9767.951160244153, 9838.852417213748, 9599.952000239955, 9638.662646807328, 9775.51122443875, 9817.214622830157, 9819.950900245452, 7269.345758881726, 7281.089863767029, 7351.44864135192, 7500.924990750132, 7515.361194298436, 5400.62195646301, 5635.520980716685, 5677.261955945701, 5770.2498675171955, 5809.128630705428, 8848.557572121239, 8854.867176992479, 8907.465552066897, 8914.955425222832, 8961.103889610988, 8828.38201325901, 9269.814603708022, 9277.16505514507, 9301.348905576544, 9322.580483878377, 6018.8194354169445, 6635.9004614929845, 6825.078614386995, 7098.3256590623805, 7232.493725439169, 7516.699332026877, 7563.924360756542, 7572.053493313336, 7590.0, 7592.8861067082935, 6786.830329241809, 6859.965700171467, 6889.517733758589, 6907.654617269217, 7041.295870412918, 6648.867022659617, 6747.224069231905, 6792.286809885089, 6793.592384456949, 6885.208201056742, 6293.0, 6314.652694101868, 6347.460465860454, 6368.108464815023, 6374.4900407966325, 4587.495375508758, 4719.433667959729, 4727.881802954816, 4808.927866081942, 4869.220924652039, 4637.62898968075, 4640.164770341371, 4702.811887524461, 4707.105649926503, 4749.0], "value": 4043.775566517508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.4729276473406, 304.24395377486945, 308.70518654684776, 309.8745008271649, 311.0714517166259, 4796.83211087612, 4798.032806549316, 4943.60451163907, 4981.576565991891, 5037.093323201818, 4818.927716084253, 4923.60611151108, 4951.133551628469, 4963.826266080688, 4979.576735977446, 3921.588233235512, 3927.9410808837893, 3937.960620393788, 3939.3106206413904, 3941.457759744963, 3641.4901913732097, 3927.116398810259, 3935.0949281665235, 3939.3106206413904, 3940.581390699346, 3802.353599888012, 3808.5048943637426, 3827.4450204720297, 3829.0044588406936, 3833.8083095845236, 3815.2560250751117, 3816.847326106966, 3817.3701339278987, 3822.694184465236, 3829.9617003829885, 3337.8664853405835, 3353.4466812976075, 3359.8488068036995, 3375.6666116883694, 3380.8309584520675, 4754.072955773626, 4862.805487780484, 4864.659473836833, 4876.536729010738, 4891.652007036607, 4358.0, 4358.629516491102, 4361.0841723237845, 4363.650907927358, 4404.889877753082, 5126.436092029874, 5129.640925135204, 5142.280080788692, 5150.673434315193, 5168.405633352175, 3579.176789338441, 3662.7252956028406, 3666.983159262395, 3669.2294618130227, 3683.9132455925564, 5395.676259424408, 5397.352317721859, 5399.082156033444, 5401.892612014528, 5405.4054054054, 3724.8510059597857, 3731.9550525852806, 3735.7198210133806, 3737.8691745788765, 3765.5104836371097, 3820.178661587772, 3825.0246187222638, 3828.8277027533827, 3831.5593706724085, 3838.8848334550007, 4212.722001267524, 4269.295566231599, 4286.249906266391, 4310.935335969963, 4326.913461730748, 5097.974510127426, 5107.463716309734, 5135.38375394955, 5138.717370544656, 5144.897102057937, 1247.9937600311941, 1274.3182397417522, 1281.333706472629, 1300.9089363744447, 1301.290796515901, 862.2283056664376, 880.2429910277157, 889.5241046040337, 896.9865452018225, 903.8172812657359, 4440.400545926259, 4446.3330500424545, 4472.217361961643, 4472.217361961643, 4483.887902802391, 5101.7704203310195, 5196.558292545101, 5230.712310822865, 5262.158054711304, 5269.1569348903995, 4453.599176074169, 4463.86608401742, 4465.0, 4469.0, 4469.642428605704, 2652.872529175093, 2843.232327271625, 2859.628248327704, 2865.782042631873, 2866.3550701092086, 5062.316587260672, 5064.316317297192, 5071.442141364447, 5080.161773307437, 5081.59347252219, 5246.3704355477585, 5420.268263784417, 5432.348118225838, 5435.673859568438, 5447.645903016291, 4982.252662100714, 4999.400071991385, 5032.47159048302, 5037.5214354636255, 5040.470750571284, 5314.9468505316, 5362.597805164551, 5367.919481207863, 5368.651037682538, 5375.731213439234, 4988.56018143845, 5184.714840683799, 5211.895762084813, 5234.973825131003, 5292.364916210079, 5018.899622007612, 5027.59779217669, 5029.346184995927, 5037.269595908646, 5045.394552653705, 3722.1997270586953, 3752.2870654575545, 3753.5120434344453, 3753.6058713835746, 3756.1924186300075, 5186.858891043964, 5190.6942590781855, 5227.764750586157, 5349.518543331119, 5356.0626890294825, 5094.541491265803, 5119.590432765295, 5129.358830146231, 5132.640715149903, 5138.640295179302, 5121.411037730709, 5157.355330583677, 5160.896782064413, 5173.689578625294, 5188.092083885381, 4863.270509423614, 5052.368453943257, 5069.645124841226, 5084.491550844886, 5129.486801393523, 5192.9747398513855, 5234.906037584997, 5236.722025918738, 5239.685618862881, 5245.763940622757, 5089.1094058538865, 5118.718470484159, 5128.256402821645, 5143.3570803649545, 5162.7867451149705], "value": 3887.487919926549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.7143221241064, 578.8900108979296, 592.9318128415232, 723.645413747264, 755.0938873351979, 12499.125061245717, 13327.866721332795, 13346.799798003014, 13383.93308033461, 13396.933015334922, 12757.489700411996, 12953.158044727086, 13200.603981880535, 13264.602061938158, 13316.267605281706, 781.5467029123109, 800.4236949396454, 802.7551596762985, 802.7631848604676, 803.2489622203229, 642.9164208652869, 763.3702195688552, 785.0814546980047, 787.0437418536477, 789.5341748368461, 835.064727505195, 835.4193835284449, 837.2883049408015, 838.4675730910855, 840.2899549880341, 815.7267315449302, 821.5686764448683, 821.7452589697212, 821.9260266576036, 825.475822852487, 597.3339726205294, 601.8465291350722, 602.8553147244629, 608.6834845880162, 610.2707264818544, 12895.09734318598, 12973.221606703628, 12980.740385192243, 12986.675333116747, 12992.805107923388, 12792.61622151337, 13143.34283285832, 13377.130486518345, 13405.798913016313, 13531.458741650322, 10407.21945854064, 10410.479476026245, 10478.79042419155, 10515.579376824919, 10799.4060326682, 3062.3875224954877, 3063.341381602944, 3070.416620842033, 3077.307605788702, 3154.6372167200607, 63424.365756342304, 64863.67568162129, 64870.83727045923, 67094.32905670979, 67322.66338668324, 8944.910550894409, 9926.354786938826, 9953.402795832273, 10009.449480278654, 10082.848757268646, 15729.68540629181, 16394.09832459226, 16528.09095499759, 16580.0, 16623.91688041552, 6520.739170433224, 6595.472362211011, 6608.372204640552, 6825.829354266084, 6975.860482790417, 3572.4105522588484, 3627.7279204059273, 3726.3851464508593, 3741.5884252732176, 3826.7512611680154, 2766.14249582626, 2860.070477094911, 2866.240446281737, 2867.0538722221618, 2869.153599688097, 472.53219312880003, 474.42049734751384, 482.06238865407147, 487.8316980641673, 488.83379650918147, 499.6427554298694, 510.40792680490455, 540.235566673161, 543.4592580382466, 544.27067729243, 8264.545450000307, 8265.628046737791, 8553.401261911731, 8625.956870215734, 8640.13598640131, 506.6909185396905, 516.803614626447, 523.494827491465, 550.8237364043467, 554.0774610273929, 3753.3806921858136, 3838.7504812187676, 3993.600639935983, 4019.879403617838, 4020.9396859047138, 97245.0, 101788.0, 101864.0, 102554.48722756338, 102770.45844312341, 51855.48144518506, 90461.0, 90942.0, 91311.0, 91622.0, 78287.0, 80679.0, 83088.86022537516, 84823.09449057812, 85324.14675853286, 8451.45065570736, 8990.280777537911, 9101.180893719596, 9249.676261330822, 9268.351215414856, 41108.58891411048, 43106.56893431026, 43444.782776085915, 44628.33057504075, 45272.547274526834, 38805.2238955225, 47319.763401182776, 54552.727236363564, 56524.71737641285, 61839.38160618516, 10878.0, 11821.408929553316, 11831.645050648494, 12023.398830058637, 12251.632451026484, 13154.144980576231, 13544.255065971467, 13708.040437169302, 13928.233947133005, 14060.067850728234, 12567.37163141821, 12784.836451143572, 12990.870091299344, 13013.284269365276, 13593.0, 12174.513019479122, 12405.255684658949, 12506.374681266083, 12880.35598220104, 12920.806187907001, 12295.385230738248, 12596.0, 12644.663735806314, 12659.0, 12669.303188324731, 10247.641332553325, 10484.42335671515, 10498.055175034284, 10555.691212892862, 10803.837942431028, 8760.868586971328, 9807.803843922939, 9924.40453572788, 10444.2166837489, 10635.521401537104], "value": 6556.884896916446, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 110.0, 124.0, 115.0, 116.0, 115.0, 116.0, 117.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 153.0, 173.0, 123.0, 156.0, 149.0, 124.0, 172.0, 124.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 164.0, 165.0, 166.0, 170.0, 165.0, 164.0, 166.0, 163.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 167.0, 76.0, 76.0, 77.0, 76.0, 166.0, 78.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 157.0, 87.0, 87.0, 87.0, 135.0, 86.0, 89.0, 146.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 121.0, 119.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 150.0, 147.0, 148.0, 147.0, 149.0, 147.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 62.0, 64.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 80.0, 81.0, 80.0, 80.0, 81.0, 86.0, 81.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 138.0, 135.0, 131.0, 136.0, 149.0, 140.0, 137.0, 168.0, 138.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 165.0, 177.0, 170.0, 165.0, 169.0, 172.0, 168.0, 167.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 67.0, 66.0, 67.0], "value": 68.0, "unit": "score"}]}]} 10:24:57 INFO - Return code: 0 10:24:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:24:57 ERROR - # TBPL SUCCESS # 10:24:57 INFO - Running post-action listener: _resource_record_post_action 10:24:57 INFO - [mozharness: 2016-08-06 17:24:57.639049Z] Finished run-tests step (success) 10:24:57 INFO - Running post-run listener: _resource_record_post_run 10:24:57 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 139264; Write bytes: 545169408; Read time: 120; Write time: 766092 10:24:57 INFO - TinderboxPrint: CPU usage
13.4% 10:24:57 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 120 10:24:57 INFO - TinderboxPrint: I/O write bytes / time
545,169,408 / 766,092 10:24:57 INFO - TinderboxPrint: CPU idle
8,281.7 (86.6%) 10:24:57 INFO - TinderboxPrint: CPU user
1,218.0 (12.7%) 10:24:57 INFO - TinderboxPrint: Swap in / out
0 / 0 10:24:57 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 247848960; Read time: 0; Write time: 426668 10:24:57 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 135168; Write bytes: 293494784; Read time: 108; Write time: 338860 10:24:58 INFO - Running post-run listener: _upload_blobber_files 10:24:58 INFO - Blob upload gear active. 10:24:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:24:58 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 10:24:58 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'] 10:24:58 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 10:24:58 INFO - (blobuploader) - INFO - Open directory for files ... 10:24:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:24:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:25:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:02 INFO - (blobuploader) - INFO - Done attempting. 10:25:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:25:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:25:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:03 INFO - (blobuploader) - INFO - Done attempting. 10:25:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:25:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:25:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:03 INFO - (blobuploader) - INFO - Done attempting. 10:25:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:03 INFO - Return code: 0 10:25:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ad46695bf908d7099a01106d2fc038ba2a5a9e7984c5a289441146b8d6e52e8dca4aada61783e50251cff0f60686359e195dcba8a22c1a84b89dbfd96aa2e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/679194bf47d1b9680003e2ae3cfc89d6e26a61e51c74971c8587f30842c04b380f733da3a9bb0f6120cb491ba9c2717356299b8f31c8370f090ad949b4119efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df3366983411a1b4a7f36e1a3a92b1f9f3d05b2bc7a174baa528a35290757ba3dbb1627b1e158588ed1745c91c4de17bf4ce73c22cd691ec0674a48fc73fe31e"} 10:25:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:03 INFO - Contents: 10:25:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ad46695bf908d7099a01106d2fc038ba2a5a9e7984c5a289441146b8d6e52e8dca4aada61783e50251cff0f60686359e195dcba8a22c1a84b89dbfd96aa2e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/679194bf47d1b9680003e2ae3cfc89d6e26a61e51c74971c8587f30842c04b380f733da3a9bb0f6120cb491ba9c2717356299b8f31c8370f090ad949b4119efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df3366983411a1b4a7f36e1a3a92b1f9f3d05b2bc7a174baa528a35290757ba3dbb1627b1e158588ed1745c91c4de17bf4ce73c22cd691ec0674a48fc73fe31e"} 10:25:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:03 INFO - Copying logs to upload dir... 10:25:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.481075 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-06 10:25:03.836283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 10:25:03.839602) ========= 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=5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781 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/5ad46695bf908d7099a01106d2fc038ba2a5a9e7984c5a289441146b8d6e52e8dca4aada61783e50251cff0f60686359e195dcba8a22c1a84b89dbfd96aa2e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/679194bf47d1b9680003e2ae3cfc89d6e26a61e51c74971c8587f30842c04b380f733da3a9bb0f6120cb491ba9c2717356299b8f31c8370f090ad949b4119efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df3366983411a1b4a7f36e1a3a92b1f9f3d05b2bc7a174baa528a35290757ba3dbb1627b1e158588ed1745c91c4de17bf4ce73c22cd691ec0674a48fc73fe31e"} build_url:https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/dNixYkVIQP6JN5IBMADjRA/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/5ad46695bf908d7099a01106d2fc038ba2a5a9e7984c5a289441146b8d6e52e8dca4aada61783e50251cff0f60686359e195dcba8a22c1a84b89dbfd96aa2e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/679194bf47d1b9680003e2ae3cfc89d6e26a61e51c74971c8587f30842c04b380f733da3a9bb0f6120cb491ba9c2717356299b8f31c8370f090ad949b4119efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df3366983411a1b4a7f36e1a3a92b1f9f3d05b2bc7a174baa528a35290757ba3dbb1627b1e158588ed1745c91c4de17bf4ce73c22cd691ec0674a48fc73fe31e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 10:25:03.865138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:25:03.865469) ========= 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=5bd038846534b2fdfa68eeae000001e2-1470502966.380247-1807117781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 10:25:03.951057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 10:25:03.951441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 10:25:03.951720) ========= ========= Total master_lag: 0.17 =========