builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1470834896.54 results: success (0) buildid: 20160810034016 builduid: 1b0bfc7595a94fb38bb09f7b55e8740c revision: 2f24daceada71e15c03b5f90765264c720ed035a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.541345) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.541981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.542286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.557471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.557867) ========= 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-1470834896.491389-837617105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 06:14:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-08-10 06:14:57 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088023 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.659934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.660285) ========= 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-1470834896.491389-837617105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016120 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.711954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:56.712358) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f24daceada71e15c03b5f90765264c720ed035a --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 2f24daceada71e15c03b5f90765264c720ed035a --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-1470834896.491389-837617105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 06:14:57,515 truncating revision to first 12 chars 2016-08-10 06:14:57,515 Setting DEBUG logging. 2016-08-10 06:14:57,515 attempt 1/10 2016-08-10 06:14:57,515 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f24daceada7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 06:14:57,827 unpacking tar archive at: fx-team-2f24daceada7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:57.374880) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:57.375163) ========= script_repo_revision: 2f24daceada71e15c03b5f90765264c720ed035a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:57.375552) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:57.375822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 06:14:57.387015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-10 06:14:57.387300) ========= /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-1470834896.491389-837617105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:58 INFO - MultiFileLogger online at 20160810 06:14:58 in /builds/slave/test 06:14:58 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 06:14:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:58 INFO - {'append_to_log': False, 06:14:58 INFO - 'base_work_dir': '/builds/slave/test', 06:14:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:14:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:58 INFO - 'branch': 'Fx-Team-Non-PGO', 06:14:58 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:58 INFO - 'config_files': ('talos/linux_config.py',), 06:14:58 INFO - 'default_actions': ('clobber', 06:14:58 INFO - 'read-buildbot-config', 06:14:58 INFO - 'download-and-extract', 06:14:58 INFO - 'populate-webroot', 06:14:58 INFO - 'create-virtualenv', 06:14:58 INFO - 'install', 06:14:58 INFO - 'run-tests'), 06:14:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:58 INFO - 'download_minidump_stackwalk': True, 06:14:58 INFO - 'download_symbols': 'ondemand', 06:14:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:58 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:58 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:58 INFO - 'installer_path': 'installer.exe', 06:14:58 INFO - 'log_level': 'info', 06:14:58 INFO - 'log_name': 'talos', 06:14:58 INFO - 'log_to_console': True, 06:14:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:58 INFO - 'opt_config_files': (), 06:14:58 INFO - 'pip_index': False, 06:14:58 INFO - 'sps_profile': False, 06:14:58 INFO - 'sps_profile_interval': 0, 06:14:58 INFO - 'suite': 'dromaeojs-e10s', 06:14:58 INFO - 'system_bits': '32', 06:14:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:58 INFO - 'title': 'talos-linux64-ix-039', 06:14:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:58 INFO - 'use_talos_json': True, 06:14:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:58 INFO - 'work_dir': 'build'} 06:14:58 INFO - [mozharness: 2016-08-10 13:14:58.273696Z] Running clobber step. 06:14:58 INFO - Running pre-action listener: _resource_record_pre_action 06:14:58 INFO - Running main action method: clobber 06:14:58 INFO - rmtree: /builds/slave/test/build 06:14:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:59 INFO - Running post-action listener: _resource_record_post_action 06:14:59 INFO - [mozharness: 2016-08-10 13:14:59.284087Z] Finished clobber step (success) 06:14:59 INFO - [mozharness: 2016-08-10 13:14:59.284187Z] Running read-buildbot-config step. 06:14:59 INFO - Running pre-action listener: _resource_record_pre_action 06:14:59 INFO - Running main action method: read_buildbot_config 06:14:59 INFO - Using buildbot properties: 06:14:59 INFO - { 06:14:59 INFO - "project": "", 06:14:59 INFO - "product": "firefox", 06:14:59 INFO - "script_repo_revision": "production", 06:14:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:14:59 INFO - "repository": "", 06:14:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:14:59 INFO - "buildid": "20160810034016", 06:14:59 INFO - "pgo_build": "False", 06:14:59 INFO - "basedir": "/builds/slave/test", 06:14:59 INFO - "buildnumber": 1521, 06:14:59 INFO - "slavename": "talos-linux64-ix-039", 06:14:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:14:59 INFO - "platform": "ubuntu64_hw", 06:14:59 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 06:14:59 INFO - "branch": "fx-team", 06:14:59 INFO - "repo_path": "integration/fx-team", 06:14:59 INFO - "revision": "2f24daceada71e15c03b5f90765264c720ed035a", 06:14:59 INFO - "stage_platform": "linux64", 06:14:59 INFO - "builduid": "1b0bfc7595a94fb38bb09f7b55e8740c", 06:14:59 INFO - "slavebuilddir": "test" 06:14:59 INFO - } 06:14:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:14:59 INFO - Running post-action listener: _resource_record_post_action 06:14:59 INFO - [mozharness: 2016-08-10 13:14:59.286623Z] Finished read-buildbot-config step (success) 06:14:59 INFO - [mozharness: 2016-08-10 13:14:59.286712Z] Running download-and-extract step. 06:14:59 INFO - Running pre-action listener: _resource_record_pre_action 06:14:59 INFO - Running main action method: download_and_extract 06:14:59 INFO - mkdir: /builds/slave/test/build/tests 06:14:59 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')]} 06:14:59 INFO - trying https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:14:59 INFO - Downloading https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:14:59 INFO - Downloaded 1361 bytes. 06:14:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:14:59 INFO - Using the following test package requirements: 06:14:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:14:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'jsshell-linux-x86_64.zip'], 06:14:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:14:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:14:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14:59 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')]} 06:14:59 INFO - trying https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:14:59 INFO - Downloading https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:15:00 INFO - Downloaded 20259579 bytes. 06:15:00 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'] 06:15:00 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 06:15:01 INFO - Return code: 0 06:15:01 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 06:15:01 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')]} 06:15:01 INFO - trying https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:15:02 INFO - Downloaded 20259579 bytes. 06:15:02 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'] 06:15:02 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 06:15:04 INFO - Return code: 0 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:04 INFO - trying https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:15:04 INFO - Downloaded 14413723 bytes. 06:15:04 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'] 06:15:04 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 06:15:05 INFO - Return code: 0 06:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:05 INFO - trying https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:15:05 INFO - Downloading https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:15:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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 06:15:06 INFO - Downloaded 55631976 bytes. 06:15:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:15:06 INFO - mkdir: /builds/slave/test/properties 06:15:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:06 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:06 INFO - Contents: 06:15:06 INFO - build_url:https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:15:06 INFO - Running post-action listener: _resource_record_post_action 06:15:06 INFO - Running post-action listener: set_extra_try_arguments 06:15:06 INFO - [mozharness: 2016-08-10 13:15:06.812235Z] Finished download-and-extract step (success) 06:15:06 INFO - [mozharness: 2016-08-10 13:15:06.812467Z] Running populate-webroot step. 06:15:06 INFO - Running pre-action listener: _resource_record_pre_action 06:15:06 INFO - Running main action method: populate_webroot 06:15:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:15:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:15:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:15:06 INFO - '--tppagecycles', 06:15:06 INFO - '7'], 06:15:06 INFO - 'tests': ['tsvgm']}}, 06:15:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:15:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:15:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['damp', 'tps']}, 06:15:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'tests': ['damp', 'tps']}, 06:15:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['dromaeo_dom']}, 06:15:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['basic_compositor_video']}, 06:15:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:15:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['a11yr', 06:15:06 INFO - 'ts_paint', 06:15:06 INFO - 'tpaint', 06:15:06 INFO - 'sessionrestore', 06:15:06 INFO - 'sessionrestore_no_auto_restore', 06:15:06 INFO - 'tabpaint']}, 06:15:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:06 INFO - 'ts_paint', 06:15:06 INFO - 'tpaint', 06:15:06 INFO - 'sessionrestore', 06:15:06 INFO - 'sessionrestore_no_auto_restore', 06:15:06 INFO - 'tabpaint']}, 06:15:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:15:06 INFO - 'ts_paint', 06:15:06 INFO - 'tpaint', 06:15:06 INFO - 'sessionrestore', 06:15:06 INFO - 'sessionrestore_no_auto_restore', 06:15:06 INFO - 'tabpaint']}, 06:15:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:15:06 INFO - 'ts_paint', 06:15:06 INFO - 'tpaint', 06:15:06 INFO - 'sessionrestore', 06:15:06 INFO - 'sessionrestore_no_auto_restore', 06:15:06 INFO - 'tabpaint']}, 06:15:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['a11yr', 06:15:06 INFO - 'ts_paint', 06:15:06 INFO - 'tpaint', 06:15:06 INFO - 'sessionrestore', 06:15:06 INFO - 'sessionrestore_no_auto_restore', 06:15:06 INFO - 'tabpaint']}, 06:15:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['a11yr', 06:15:06 INFO - 'ts_paint', 06:15:06 INFO - 'tpaint', 06:15:06 INFO - 'sessionrestore', 06:15:06 INFO - 'sessionrestore_no_auto_restore', 06:15:06 INFO - 'tabpaint']}, 06:15:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['tsvgx', 06:15:06 INFO - 'tsvgr_opacity', 06:15:06 INFO - 'tart', 06:15:06 INFO - 'tscrollx', 06:15:06 INFO - 'cart']}, 06:15:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:06 INFO - 'tsvgr_opacity', 06:15:06 INFO - 'tart', 06:15:06 INFO - 'tscrollx', 06:15:06 INFO - 'cart']}, 06:15:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'talos_options': ['--disable-e10s'], 06:15:06 INFO - 'tests': ['tp5o']}, 06:15:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'tests': ['tp5o']}, 06:15:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'talos_options': ['--disable-e10s', 06:15:06 INFO - '--xperf_path', 06:15:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:06 INFO - 'tests': ['tp5n']}, 06:15:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:06 INFO - 'talos_options': ['--xperf_path', 06:15:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:06 INFO - 'tests': ['tp5n']}}, 06:15:06 INFO - 'talos.zip': {'path': '', 06:15:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:15:06 INFO - Running post-action listener: _resource_record_post_action 06:15:06 INFO - [mozharness: 2016-08-10 13:15:06.834490Z] Finished populate-webroot step (success) 06:15:06 INFO - [mozharness: 2016-08-10 13:15:06.834578Z] Running create-virtualenv step. 06:15:06 INFO - Running pre-action listener: _resource_record_pre_action 06:15:06 INFO - Running main action method: create_virtualenv 06:15:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:06 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 06:15:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:15:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:06 INFO - Using real prefix '/usr' 06:15:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:07 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:09 INFO - Installing pip.................done. 06:15:09 INFO - Return code: 0 06:15:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:09 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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:09 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 06:15:09 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 06:15:09 INFO - Using env: {'DISPLAY': ':0', 06:15:09 INFO - 'HOME': '/home/cltbld', 06:15:09 INFO - 'LANG': 'en_US.UTF-8', 06:15:09 INFO - 'LANGUAGE': 'en_US:en', 06:15:09 INFO - 'LOGNAME': 'cltbld', 06:15:09 INFO - 'MAIL': '/var/mail/cltbld', 06:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:09 INFO - 'MOZ_NO_REMOTE': '1', 06:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:09 INFO - 'NO_EM_RESTART': '1', 06:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:09 INFO - 'PWD': '/builds/slave/test', 06:15:09 INFO - 'SHELL': '/bin/bash', 06:15:09 INFO - 'SHLVL': '1', 06:15:09 INFO - 'TERM': 'linux', 06:15:09 INFO - 'TMOUT': '86400', 06:15:09 INFO - 'USER': 'cltbld', 06:15:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:09 INFO - '_': '/tools/buildbot/bin/python'} 06:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:09 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 06:15:09 INFO - Cleaning up... 06:15:09 INFO - Return code: 0 06:15:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:09 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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:09 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 06:15:09 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 06:15:09 INFO - Using env: {'DISPLAY': ':0', 06:15:09 INFO - 'HOME': '/home/cltbld', 06:15:09 INFO - 'LANG': 'en_US.UTF-8', 06:15:09 INFO - 'LANGUAGE': 'en_US:en', 06:15:09 INFO - 'LOGNAME': 'cltbld', 06:15:09 INFO - 'MAIL': '/var/mail/cltbld', 06:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:09 INFO - 'MOZ_NO_REMOTE': '1', 06:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:09 INFO - 'NO_EM_RESTART': '1', 06:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:09 INFO - 'PWD': '/builds/slave/test', 06:15:09 INFO - 'SHELL': '/bin/bash', 06:15:09 INFO - 'SHLVL': '1', 06:15:09 INFO - 'TERM': 'linux', 06:15:09 INFO - 'TMOUT': '86400', 06:15:09 INFO - 'USER': 'cltbld', 06:15:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:09 INFO - '_': '/tools/buildbot/bin/python'} 06:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:09 INFO - Downloading/unpacking psutil>=3.1.1 06:15:09 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 06:15:09 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 06:15:09 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 06:15:09 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 06:15:09 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 06:15:09 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 06:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:15:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:11 INFO - Installing collected packages: psutil 06:15:11 INFO - Running setup.py install for psutil 06:15:11 INFO - building 'psutil._psutil_linux' extension 06:15:11 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 06:15:12 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 06:15:12 INFO - building 'psutil._psutil_posix' extension 06:15:12 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 06:15:12 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 06:15:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:12 INFO - Successfully installed psutil 06:15:12 INFO - Cleaning up... 06:15:12 INFO - Return code: 0 06:15:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:15:12 INFO - Using env: {'DISPLAY': ':0', 06:15:12 INFO - 'HOME': '/home/cltbld', 06:15:12 INFO - 'LANG': 'en_US.UTF-8', 06:15:12 INFO - 'LANGUAGE': 'en_US:en', 06:15:12 INFO - 'LOGNAME': 'cltbld', 06:15:12 INFO - 'MAIL': '/var/mail/cltbld', 06:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:12 INFO - 'MOZ_NO_REMOTE': '1', 06:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:12 INFO - 'NO_EM_RESTART': '1', 06:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:12 INFO - 'PWD': '/builds/slave/test', 06:15:12 INFO - 'SHELL': '/bin/bash', 06:15:12 INFO - 'SHLVL': '1', 06:15:12 INFO - 'TERM': 'linux', 06:15:12 INFO - 'TMOUT': '86400', 06:15:12 INFO - 'USER': 'cltbld', 06:15:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:12 INFO - '_': '/tools/buildbot/bin/python'} 06:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:15:14 INFO - Installing collected packages: mozsystemmonitor 06:15:14 INFO - Running setup.py install for mozsystemmonitor 06:15:14 INFO - Successfully installed mozsystemmonitor 06:15:14 INFO - Cleaning up... 06:15:14 INFO - Return code: 0 06:15:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:15:14 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')]} 06:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 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')]} 06:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:14 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 06:15:14 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 06:15:14 INFO - Using env: {'DISPLAY': ':0', 06:15:14 INFO - 'HOME': '/home/cltbld', 06:15:14 INFO - 'LANG': 'en_US.UTF-8', 06:15:14 INFO - 'LANGUAGE': 'en_US:en', 06:15:14 INFO - 'LOGNAME': 'cltbld', 06:15:14 INFO - 'MAIL': '/var/mail/cltbld', 06:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:14 INFO - 'MOZ_NO_REMOTE': '1', 06:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:14 INFO - 'NO_EM_RESTART': '1', 06:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:14 INFO - 'PWD': '/builds/slave/test', 06:15:14 INFO - 'SHELL': '/bin/bash', 06:15:14 INFO - 'SHLVL': '1', 06:15:14 INFO - 'TERM': 'linux', 06:15:14 INFO - 'TMOUT': '86400', 06:15:14 INFO - 'USER': 'cltbld', 06:15:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:14 INFO - '_': '/tools/buildbot/bin/python'} 06:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:14 INFO - Downloading/unpacking jsonschema==2.5.1 06:15:14 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 06:15:14 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 06:15:14 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 06:15:14 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 06:15:14 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 06:15:14 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 06:15:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:15:16 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 06:15:16 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 06:15:16 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 06:15:16 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 06:15:16 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 06:15:16 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 06:15:17 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:17 INFO - warning: no files found matching '*.txt' 06:15:17 INFO - no previously-included directories found matching 'build' 06:15:17 INFO - no previously-included directories found matching 'dist' 06:15:17 INFO - no previously-included directories found matching '.git*' 06:15:17 INFO - Installing collected packages: jsonschema, functools32 06:15:17 INFO - Running setup.py install for functools32 06:15:17 INFO - warning: no files found matching '*.txt' 06:15:17 INFO - no previously-included directories found matching 'build' 06:15:17 INFO - no previously-included directories found matching 'dist' 06:15:17 INFO - no previously-included directories found matching '.git*' 06:15:17 INFO - Successfully installed jsonschema functools32 06:15:17 INFO - Cleaning up... 06:15:17 INFO - Return code: 0 06:15:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:15:17 INFO - Using env: {'DISPLAY': ':0', 06:15:17 INFO - 'HOME': '/home/cltbld', 06:15:17 INFO - 'LANG': 'en_US.UTF-8', 06:15:17 INFO - 'LANGUAGE': 'en_US:en', 06:15:17 INFO - 'LOGNAME': 'cltbld', 06:15:17 INFO - 'MAIL': '/var/mail/cltbld', 06:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:17 INFO - 'MOZ_NO_REMOTE': '1', 06:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:17 INFO - 'NO_EM_RESTART': '1', 06:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:17 INFO - 'PWD': '/builds/slave/test', 06:15:17 INFO - 'SHELL': '/bin/bash', 06:15:17 INFO - 'SHLVL': '1', 06:15:17 INFO - 'TERM': 'linux', 06:15:17 INFO - 'TMOUT': '86400', 06:15:17 INFO - 'USER': 'cltbld', 06:15:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:17 INFO - '_': '/tools/buildbot/bin/python'} 06:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:15:17 INFO - Cleaning up... 06:15:17 INFO - Return code: 0 06:15:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:15:17 INFO - Using env: {'DISPLAY': ':0', 06:15:17 INFO - 'HOME': '/home/cltbld', 06:15:17 INFO - 'LANG': 'en_US.UTF-8', 06:15:17 INFO - 'LANGUAGE': 'en_US:en', 06:15:17 INFO - 'LOGNAME': 'cltbld', 06:15:17 INFO - 'MAIL': '/var/mail/cltbld', 06:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:17 INFO - 'MOZ_NO_REMOTE': '1', 06:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:17 INFO - 'NO_EM_RESTART': '1', 06:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:17 INFO - 'PWD': '/builds/slave/test', 06:15:17 INFO - 'SHELL': '/bin/bash', 06:15:17 INFO - 'SHLVL': '1', 06:15:17 INFO - 'TERM': 'linux', 06:15:17 INFO - 'TMOUT': '86400', 06:15:17 INFO - 'USER': 'cltbld', 06:15:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:17 INFO - '_': '/tools/buildbot/bin/python'} 06:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:17 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:19 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:20 INFO - Downloading docopt-0.6.1.tar.gz 06:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:20 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:20 INFO - Running setup.py install for blobuploader 06:15:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:20 INFO - Running setup.py install for requests 06:15:20 INFO - Running setup.py install for docopt 06:15:20 INFO - Successfully installed blobuploader requests docopt 06:15:20 INFO - Cleaning up... 06:15:20 INFO - Return code: 0 06:15:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:20 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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:20 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 06:15:20 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 06:15:20 INFO - Using env: {'DISPLAY': ':0', 06:15:20 INFO - 'HOME': '/home/cltbld', 06:15:20 INFO - 'LANG': 'en_US.UTF-8', 06:15:20 INFO - 'LANGUAGE': 'en_US:en', 06:15:20 INFO - 'LOGNAME': 'cltbld', 06:15:20 INFO - 'MAIL': '/var/mail/cltbld', 06:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:20 INFO - 'MOZ_NO_REMOTE': '1', 06:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:20 INFO - 'NO_EM_RESTART': '1', 06:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:20 INFO - 'PWD': '/builds/slave/test', 06:15:20 INFO - 'SHELL': '/bin/bash', 06:15:20 INFO - 'SHLVL': '1', 06:15:20 INFO - 'TERM': 'linux', 06:15:20 INFO - 'TMOUT': '86400', 06:15:20 INFO - 'USER': 'cltbld', 06:15:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:20 INFO - '_': '/tools/buildbot/bin/python'} 06:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:21 INFO - Running setup.py (path:/tmp/pip-OU_Bva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:21 INFO - Running setup.py (path:/tmp/pip-WbDa4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:21 INFO - Running setup.py (path:/tmp/pip-fjRjNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:21 INFO - Running setup.py (path:/tmp/pip-sZd8U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:21 INFO - Running setup.py (path:/tmp/pip-T9_ADQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:21 INFO - Running setup.py (path:/tmp/pip-4n4S2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:21 INFO - Running setup.py (path:/tmp/pip-hoxB6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:21 INFO - Running setup.py (path:/tmp/pip-caOX1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:21 INFO - Running setup.py (path:/tmp/pip-uZHGq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:21 INFO - Running setup.py (path:/tmp/pip-d8sIks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:21 INFO - Running setup.py (path:/tmp/pip-I_Cd7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:21 INFO - Running setup.py (path:/tmp/pip-LjhcEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:22 INFO - Running setup.py (path:/tmp/pip-eSOpcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:22 INFO - Running setup.py (path:/tmp/pip-KbEEjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:22 INFO - Running setup.py (path:/tmp/pip-fPxVKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:22 INFO - Running setup.py (path:/tmp/pip-qbl7Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:22 INFO - Running setup.py (path:/tmp/pip-vlCkJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:22 INFO - Running setup.py install for manifestparser 06:15:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:22 INFO - Running setup.py install for mozcrash 06:15:22 INFO - Running setup.py install for mozdebug 06:15:22 INFO - Running setup.py install for mozdevice 06:15:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:22 INFO - Running setup.py install for mozfile 06:15:22 INFO - Running setup.py install for mozhttpd 06:15:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Running setup.py install for mozinfo 06:15:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Running setup.py install for mozInstall 06:15:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Running setup.py install for mozleak 06:15:23 INFO - Running setup.py install for mozlog 06:15:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Running setup.py install for moznetwork 06:15:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Running setup.py install for mozprocess 06:15:23 INFO - Running setup.py install for mozprofile 06:15:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Running setup.py install for mozrunner 06:15:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:23 INFO - Running setup.py install for mozscreenshot 06:15:23 INFO - Running setup.py install for moztest 06:15:24 INFO - Running setup.py install for mozversion 06:15:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:24 INFO - Cleaning up... 06:15:24 INFO - Return code: 0 06:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:24 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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:24 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 06:15:24 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 06:15:24 INFO - Using env: {'DISPLAY': ':0', 06:15:24 INFO - 'HOME': '/home/cltbld', 06:15:24 INFO - 'LANG': 'en_US.UTF-8', 06:15:24 INFO - 'LANGUAGE': 'en_US:en', 06:15:24 INFO - 'LOGNAME': 'cltbld', 06:15:24 INFO - 'MAIL': '/var/mail/cltbld', 06:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:24 INFO - 'MOZ_NO_REMOTE': '1', 06:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:24 INFO - 'NO_EM_RESTART': '1', 06:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:24 INFO - 'PWD': '/builds/slave/test', 06:15:24 INFO - 'SHELL': '/bin/bash', 06:15:24 INFO - 'SHLVL': '1', 06:15:24 INFO - 'TERM': 'linux', 06:15:24 INFO - 'TMOUT': '86400', 06:15:24 INFO - 'USER': 'cltbld', 06:15:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:24 INFO - '_': '/tools/buildbot/bin/python'} 06:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:24 INFO - Running setup.py (path:/tmp/pip-raEm1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:24 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)) 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:24 INFO - Running setup.py (path:/tmp/pip-GiwFwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:24 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)) 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:24 INFO - Running setup.py (path:/tmp/pip-ivtKNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:24 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)) 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:24 INFO - Running setup.py (path:/tmp/pip-VXIqBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:24 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)) 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:24 INFO - Running setup.py (path:/tmp/pip-4F5vTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:24 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)) 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:24 INFO - Running setup.py (path:/tmp/pip-GByjrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:24 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)) 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:24 INFO - Running setup.py (path:/tmp/pip-MNKy2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:24 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)) 06:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:24 INFO - Running setup.py (path:/tmp/pip-2W9g_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:25 INFO - Running setup.py (path:/tmp/pip-f_vfRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:25 INFO - Running setup.py (path:/tmp/pip-R5uIu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:25 INFO - Running setup.py (path:/tmp/pip-W2GyTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:25 INFO - Running setup.py (path:/tmp/pip-CaI3os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:25 INFO - Running setup.py (path:/tmp/pip-CMexay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:25 INFO - Running setup.py (path:/tmp/pip-fvt2Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:25 INFO - Running setup.py (path:/tmp/pip-RS3jWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:25 INFO - Running setup.py (path:/tmp/pip-Pnq3zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:25 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)) 06:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:25 INFO - Running setup.py (path:/tmp/pip-QvXXiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:25 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)) 06:15:25 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)) 06:15:25 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)) 06:15:25 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)) 06:15:25 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)) 06:15:25 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)) 06:15:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:27 INFO - Downloading blessings-1.6.tar.gz 06:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:27 INFO - Installing collected packages: blessings 06:15:27 INFO - Running setup.py install for blessings 06:15:27 INFO - Successfully installed blessings 06:15:27 INFO - Cleaning up... 06:15:27 INFO - Return code: 0 06:15:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:28 INFO - Reading from file tmpfile_stdout 06:15:28 INFO - Current package versions: 06:15:28 INFO - argparse == 1.2.1 06:15:28 INFO - blessings == 1.6 06:15:28 INFO - blobuploader == 1.2.4 06:15:28 INFO - docopt == 0.6.1 06:15:28 INFO - functools32 == 3.2.3-2 06:15:28 INFO - jsonschema == 2.5.1 06:15:28 INFO - manifestparser == 1.1 06:15:28 INFO - mozInstall == 1.12 06:15:28 INFO - mozcrash == 0.17 06:15:28 INFO - mozdebug == 0.1 06:15:28 INFO - mozdevice == 0.48 06:15:28 INFO - mozfile == 1.2 06:15:28 INFO - mozhttpd == 0.7 06:15:28 INFO - mozinfo == 0.9 06:15:28 INFO - mozleak == 0.1 06:15:28 INFO - mozlog == 3.3 06:15:28 INFO - moznetwork == 0.27 06:15:28 INFO - mozprocess == 0.23 06:15:28 INFO - mozprofile == 0.28 06:15:28 INFO - mozrunner == 6.12 06:15:28 INFO - mozscreenshot == 0.1 06:15:28 INFO - mozsystemmonitor == 0.3 06:15:28 INFO - moztest == 0.7 06:15:28 INFO - mozversion == 1.4 06:15:28 INFO - psutil == 3.1.1 06:15:28 INFO - requests == 1.2.3 06:15:28 INFO - wsgiref == 0.1.2 06:15:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:28 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 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:28 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 06:15:28 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 06:15:28 INFO - Using env: {'DISPLAY': ':0', 06:15:28 INFO - 'HOME': '/home/cltbld', 06:15:28 INFO - 'LANG': 'en_US.UTF-8', 06:15:28 INFO - 'LANGUAGE': 'en_US:en', 06:15:28 INFO - 'LOGNAME': 'cltbld', 06:15:28 INFO - 'MAIL': '/var/mail/cltbld', 06:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:28 INFO - 'MOZ_NO_REMOTE': '1', 06:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:28 INFO - 'NO_EM_RESTART': '1', 06:15:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:28 INFO - 'PWD': '/builds/slave/test', 06:15:28 INFO - 'SHELL': '/bin/bash', 06:15:28 INFO - 'SHLVL': '1', 06:15:28 INFO - 'TERM': 'linux', 06:15:28 INFO - 'TMOUT': '86400', 06:15:28 INFO - 'USER': 'cltbld', 06:15:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:28 INFO - '_': '/tools/buildbot/bin/python'} 06:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 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)) 06:15:28 INFO - Cleaning up... 06:15:28 INFO - Return code: 0 06:15:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2998400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, '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-1470834896.491389-837617105', '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 06:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:15:28 INFO - Using env: {'DISPLAY': ':0', 06:15:28 INFO - 'HOME': '/home/cltbld', 06:15:28 INFO - 'LANG': 'en_US.UTF-8', 06:15:28 INFO - 'LANGUAGE': 'en_US:en', 06:15:28 INFO - 'LOGNAME': 'cltbld', 06:15:28 INFO - 'MAIL': '/var/mail/cltbld', 06:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:28 INFO - 'MOZ_NO_REMOTE': '1', 06:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:28 INFO - 'NO_EM_RESTART': '1', 06:15:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:28 INFO - 'PWD': '/builds/slave/test', 06:15:28 INFO - 'SHELL': '/bin/bash', 06:15:28 INFO - 'SHLVL': '1', 06:15:28 INFO - 'TERM': 'linux', 06:15:28 INFO - 'TMOUT': '86400', 06:15:28 INFO - 'USER': 'cltbld', 06:15:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:28 INFO - '_': '/tools/buildbot/bin/python'} 06:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:28 INFO - Cleaning up... 06:15:28 INFO - Return code: 0 06:15:28 INFO - Running post-action listener: _resource_record_post_action 06:15:28 INFO - Running post-action listener: _start_resource_monitoring 06:15:28 INFO - Starting resource monitoring. 06:15:28 INFO - [mozharness: 2016-08-10 13:15:28.491417Z] Finished create-virtualenv step (success) 06:15:28 INFO - [mozharness: 2016-08-10 13:15:28.491863Z] Running install step. 06:15:28 INFO - Running pre-action listener: _resource_record_pre_action 06:15:28 INFO - Running main action method: install 06:15:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:28 INFO - Reading from file tmpfile_stdout 06:15:28 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:28 INFO - Reading from file tmpfile_stdout 06:15:28 INFO - Output received: 06:15:28 INFO - Usage: mozinstall [options] installer 06:15:28 INFO - Options: 06:15:28 INFO - -h, --help show this help message and exit 06:15:28 INFO - -d DEST, --destination=DEST 06:15:28 INFO - Directory to install application into. [default: 06:15:28 INFO - "/builds/slave/test"] 06:15:28 INFO - --app=APP Application being installed. [default: firefox] 06:15:28 INFO - mkdir: /builds/slave/test/build/application 06:15:28 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'] 06:15:28 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 06:15:44 INFO - Reading from file tmpfile_stdout 06:15:44 INFO - Output received: 06:15:44 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:44 INFO - Running post-action listener: _resource_record_post_action 06:15:44 INFO - [mozharness: 2016-08-10 13:15:44.840660Z] Finished install step (success) 06:15:44 INFO - [mozharness: 2016-08-10 13:15:44.840908Z] Running run-tests step. 06:15:44 INFO - Running pre-action listener: _resource_record_pre_action 06:15:44 INFO - Running main action method: run_tests 06:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:44 INFO - Python 2.7.3 06:15:44 INFO - Return code: 0 06:15:44 INFO - grabbing minidump binary from tooltool 06:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:44 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 0x2a27570>, '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 0x2a28470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:44 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 06:15:44 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 06:15:44 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 06:15:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:44 INFO - Return code: 0 06:15:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:44 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/UplTwkyuTwqvccbb8WyCsA/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 06:15:44 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/UplTwkyuTwqvccbb8WyCsA/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 06:15:44 INFO - Using env: {'DISPLAY': ':0', 06:15:44 INFO - 'HOME': '/home/cltbld', 06:15:44 INFO - 'LANG': 'en_US.UTF-8', 06:15:44 INFO - 'LANGUAGE': 'en_US:en', 06:15:44 INFO - 'LOGNAME': 'cltbld', 06:15:44 INFO - 'MAIL': '/var/mail/cltbld', 06:15:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:44 INFO - 'MOZ_NO_REMOTE': '1', 06:15:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:44 INFO - 'NO_EM_RESTART': '1', 06:15:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:44 INFO - 'PWD': '/builds/slave/test', 06:15:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:44 INFO - 'SHELL': '/bin/bash', 06:15:44 INFO - 'SHLVL': '1', 06:15:44 INFO - 'TERM': 'linux', 06:15:44 INFO - 'TMOUT': '86400', 06:15:44 INFO - 'USER': 'cltbld', 06:15:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1470834896.491389-837617105', 06:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:44 INFO - '_': '/tools/buildbot/bin/python'} 06:15:44 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/UplTwkyuTwqvccbb8WyCsA/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 06:15:45 INFO - mozversion application_buildid: 20160810034016 06:15:45 INFO - mozversion application_changeset: 2f24daceada71e15c03b5f90765264c720ed035a 06:15:45 INFO - mozversion application_display_name: Nightly 06:15:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:45 INFO - mozversion application_name: Firefox 06:15:45 INFO - mozversion application_remotingname: firefox 06:15:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:15:45 INFO - mozversion application_vendor: Mozilla 06:15:45 INFO - mozversion application_version: 51.0a1 06:15:45 INFO - mozversion platform_buildid: 20160810034016 06:15:45 INFO - mozversion platform_changeset: 2f24daceada71e15c03b5f90765264c720ed035a 06:15:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:15:45 INFO - mozversion platform_version: 51.0a1 06:15:45 INFO - using testdate: 1470834945 06:15:45 INFO - actual date: 1470834945 06:15:45 INFO - starting webserver on 'localhost:43801' 06:15:45 INFO - SUITE-START | Running 2 tests 06:15:45 INFO - TEST-START | dromaeo_css 06:15:45 INFO - operating with platform_type : linux_ 06:15:45 INFO - Initialising browser for dromaeo_css test... 06:15:45 INFO - TEST-INFO | started process 13281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplilV6T/profile http://localhost:43801/getInfo.html) 06:15:49 INFO - PROCESS | 13281 | __metrics Screen width/height:1600/1200 06:15:49 INFO - PROCESS | 13281 | colorDepth:24 06:15:49 INFO - PROCESS | 13281 | Browser inner width/height: 1024/697 06:15:49 INFO - PROCESS | 13281 | __metrics 06:15:50 ERROR - PROCESS | 13281 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 06:15:51 INFO - TEST-INFO | 13281: exit 0 06:15:51 INFO - Browser initialized. 06:15:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:51 INFO - TEST-INFO | started process 13400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplilV6T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:03 INFO - PROCESS | 13400 | RSS: Main: 164089856 06:16:03 INFO - PROCESS | 13400 | 06:16:52 INFO - PROCESS | 13400 | 1470835012991 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] 06:19:05 INFO - PROCESS | 13400 | Cycle 1(1): loaded http://localhost:43801/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43801/tests/dromaeo/cssquery-ext.html) 06:19:06 INFO - PROCESS | 13400 | RSS: Main: 165789696 06:19:06 INFO - PROCESS | 13400 | 06:22:08 INFO - PROCESS | 13400 | Cycle 1(1): loaded http://localhost:43801/tests/dromaeo/cssquery-ext.html (next: http://localhost:43801/tests/dromaeo/cssquery-jquery.html) 06:22:09 INFO - PROCESS | 13400 | RSS: Main: 165736448 06:22:09 INFO - PROCESS | 13400 | 06:25:11 INFO - PROCESS | 13400 | Cycle 1(1): loaded http://localhost:43801/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43801/tests/dromaeo/cssquery-mootools.html) 06:25:11 INFO - PROCESS | 13400 | RSS: Main: 168689664 06:25:11 INFO - PROCESS | 13400 | 06:28:13 INFO - PROCESS | 13400 | Cycle 1(1): loaded http://localhost:43801/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43801/tests/dromaeo/cssquery-prototype.html) 06:28:14 INFO - PROCESS | 13400 | RSS: Main: 162914304 06:28:14 INFO - PROCESS | 13400 | 06:31:17 INFO - PROCESS | 13400 | Cycle 1(1): loaded http://localhost:43801/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43801/tests/dromaeo/cssquery-yui.html) 06:31:17 INFO - PROCESS | 13400 | RSS: Main: 165154816 06:31:17 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | Cycle 1(1): loaded http://localhost:43801/tests/dromaeo/cssquery-yui.html (next: http://localhost:43801/tests/dromaeo/cssquery-dojo.html) 06:34:20 INFO - PROCESS | 13400 | RSS: Main: 169156608 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | __start_tp_report 06:34:20 INFO - PROCESS | 13400 | _x_x_mozilla_page_load 06:34:20 INFO - PROCESS | 13400 | _x_x_mozilla_page_load_details 06:34:20 INFO - PROCESS | 13400 | |i|pagename|runs| 06:34:20 INFO - PROCESS | 13400 | |0;dojo.html;2652.708202097769;2666.2934322404553;2693.717159698232;2696.7707744841687;2705.147878418297;4548.1585906607215;4690.1792186367375;4783.880402989923;4797;4808.615310775138;4584.129015487063;4660.440747110351;4660.673752837294;4670.883227919304;4745;4270;4319.438472998506;4342.50061242958;4373.759443230621;4461.754603496806;4313.1158112587;4334.414853994717;4351.4343135392355;4371.475422949251;4411.294192929132;4312.870613881589;4450.310201918708;4450.443694538183;4453.710508816916;4458.754768487748;4210.200061988213;4311.051568654891;4359.84740534083;4388.780560971939;4399.956000439986;4265.53079161292;4284.550122237151;4286.271333873218;4288.485381754178;4393.692441529094;4771.236602143675;4782.13921494131;4785.521447855222;4785.593224575915;4844.95155048452;5050.494950504957;5058.620603454756;5117.1556693145585;5136.075506408845;5137.075326441239;5127.410347810012;5151.433342332378;5158.277841102249;5172.939547392813;5203.765830537635;4799.66402351839;4804.20730579454;4810.037992401463;4834.419869615669;4842.83050093245;4952.90094198114;5080;5095.515925987025;5144.382674079135;5321.5476684482255;4970.304157417964;4979.6265280104135;4981.37732783402;4989.850304490871;5008.398992120969;5040.647154699209;5049.82325618609;5069.467705890902;5070.61970352225;5098.821541246039;4888.755562221946;4995.782265667599;4999.275105109738;5024;5029.823956161516;4791.712497250176;5013.147764879979;5017.7491125443585;5020.046191223656;5024.120778863684;4377.584129507692;4406.030673251879;4408.360787685768;4417.050334178167;4445.422095127613;3693.8522459101873;3755.3803622401997;3844.557875844258;3859.55615104261;3885.8057097145597;4340;4407.096545208225;4420.690551661352;4448.399466072104;4450.621697155778;5138.868112690102;5163.612729045261;5170.45710200431;5179.637425380187;5180.870478238075;4212.157568486315;4338.110687309094;4390.780460976938;4408.118376324748;4454.532274111237;4600.631949444037;4618.861434156981;4642.4661163966575;4685.273782563708;4699.083678682624;4796.664233503621;4806.95193048079;4809.975950120227;4812.542808433333;4861.246506791524;4848.0546293472435;5054.368203974504;5142.357205349332;5148.176291793295;5199.2980947573105;4769.093872164278;4774.164521208844;4815.662903596854;4848.80604775805;4851.442084160226;5063.088644044107;5096.770645320896;5099.954509325506;5108.66793658411;5144.614153938394;4866.90266194667;5081.060003899291;5128.717920514258;5146.871328216825;5150.330457040711;4982.227754698028;5044.495550444926;5045.167547354646;5064.518870707277;5079.390473143247;5036.622253330942;5038.244263360525;5040.470750571138;5044.899102018013;5080.923786143285;4640.721556706609;4895.241237608177;4954.77703503336;4964.528369804862;4971.9005619886675;5049.722265275298;5063.87340316495;5068.341115655089;5099.26060721186;5100.923486147636;4812.975935120442;4838.201696720002;4855.8057677692495;4861.975690121527;4873.171560834738 06:34:20 INFO - PROCESS | 13400 | |1;ext.html;536.1769683535773;546.3498436860136;574.1588572740935;579.979700710475;592.4490224091593;34542;35461.2907741845;38109.80945095271;38125.618743812556;38207.617923820755;37986.24027519448;38623.91008719303;38673;38679.61320386795;38751.224975500474;7507.136679281884;7742.61286935651;7742.922570774276;7764.417668674843;7777.766666999999;7583.9241607584045;7589.127250366196;7599.544027358348;7627.122880868716;7659.119201291839;7584.165741768401;7703.3452156566755;7715.459917805756;7715.6913723451;7729.497582657109;7570.659320330598;7641.3122818946;7643.7324693635455;7670.348020418299;7676;7627.2372762723835;7723.922760772432;7730.768076957644;7734.651940662684;7745.031871016123;26911.730882691118;26937.46125077507;26994.730052699615;27129;27155.864220678966;3156.8105913645254;3176.6188057433023;3760.905977350561;3763.8118094095184;3901.707371947087;28381.858090709415;28671.28321791951;28972.710272897424;28998.13005609835;29689.70310296891;3517.9472307915403;3525.4711793230963;3546.6098729139776;3576.5708115026364;3614.3132804767274;264425;264783;264970;265374;266981;31510.21224469361;32795.34409311848;32807.50788738171;51358;51715;33857.66142338545;34065;34082;34171.31657366888;34257.31485370328;13751.106178098591;13910.234937078356;13939.233342166279;13939.442422303197;13968.441262349595;10705.1435885129;10772.192085593455;10817.188710846718;10829.458527073615;10830.783384332426;7772.106207786177;7851;7971.8405631887035;8001.799955001172;8029.558374289353;3093.7370323522755;3119.376124775054;3137.796043257181;3158.7157155856085;3176.491761318178;866.4931015355961;902.273669695888;966.8501382285757;985.4481490365418;1048.1509976918721;28800.71199288022;28808.567871481944;28959.710402896122;29238.26904327409;29662.258443538653;905.8686490458847;950.9634498396642;1021.7394564386034;1023.534291897185;1024.912882404989;14180.64548386278;14803.777943330859;15002.774958375632;15184.164870932205;15248.313825877862;400620;406201;406570;406712;407370;47928;48599.27101093486;48625;48684;48699.75650121726;1185.968207659342;1199.244475980127;1228.2875931959443;1228.7603917236231;1235.7404944961659;25862;26993.46013079688;27417.725822742315;28254.43491130207;28291.151265462067;41514.792426037675;41826.79086604669;41955.58044419517;41969;42046.57953420427;277977;279966;347285;348205;349964;22704.545909081397;25430.745692542838;25524.23427297184;25805.096821611154;25893.09374171895;43121;43801.56198438102;43859.561404385546;43990.340144898495;44059.77970110129;36743.81628091949;36832;37701.24597508089;37765.62234377621;38314.425283620214;37287.627123728416;37515;37613.623863762106;38121;38216.23567528578;31545;35771;36491.81754091319;36588.81705591561;36721.63278367182;32213.838930805196;33257.334853303284;33956;34205.828970854986;34475.310493790486;25599.616005759555;25648.23055308344;25700.742992569834;25713;26123 06:34:20 INFO - PROCESS | 13400 | |2;jquery.html;364.20239675111503;372.14406864212316;382.1668762098625;383.7083816299615;385.4353372309566;15998.920005399987;16477;17244.65510689787;17383.82616173838;17396.30414783407;16541.503754887344;17186.14069296533;17224.138793060327;17287.82712172878;17297.308107675708;5053.873653158673;5273.736313184345;5295.0998330283755;5298.36419629645;5306.973465132669;5148.485151484841;5215.947840521584;5224.085784987631;5264.026155161288;5400.162974738902;5486.506214440699;5520.696361700105;5525;5531.225628412006;5535.059039963196;5363.115086010823;5399.379071406799;5451.972740136313;5524.944750552483;5570.108782594785;5250.553702935255;5255.5795536357;5284.260203571503;5287.180487024518;5310.946890531084;11314.434278286053;11349.829752553718;11548.59579914699;11570.305781653044;12924.741505169937;2053.3429302623167;2378.1676413255223;2390.8087353011715;2406.542756876188;2453.9386515337083;9438.858417123749;9503.714888553355;9515.524223788783;9962.302638815287;10004.19966402686;1733.575274057864;1761.1722490429477;1770.6133698162923;1772.8404443600139;1783.2064731194623;68784.6560767193;73212.6339368305;73832.99999999946;74455.62772186159;74557;9932.162549928287;9951.80096398068;10071.899281007096;10202.387856728472;10495.475226238657;13377.130486518345;13393.933030334982;13401.195928244142;13401.329933503286;13401.932990334986;7168.462365322622;7507.624618769149;7573.053368328959;7751.34113600339;7827.804304892309;7210.134783825974;7238.276172382825;7446.702131914771;7459.172502736864;7487.28870757288;4286.935695964563;4351;4427.29163333865;4512.323151527297;4536.115457485825;1759.9208035638171;1837.136545823461;1862.9627407452047;1873.8875667459995;1926.7398901148447;828.4490813608883;891.5720454181899;914.9725508234764;949.4161090929167;993.036754348281;17107.315707371567;17893.023348712788;18088.27646894136;18090.63818723618;18475.630487390445;844.907060223375;880.5245167609419;889.0620395482828;892.6652505310509;938.8544775559662;9749.756256093513;10157.171709092287;10180.490975451346;10218.739312108724;10298.17614590846;389210;397274;405422;407187;408766;76441.23558764342;77021;79007;79437.60281198558;80796;891.2157301574573;911.5396724654007;933.8645896345128;934.7336009237334;942.3733217410345;15623.687526249638;15626.765598516258;15785;16294.822885586835;16374.672506550041;37197.6280237205;37445.81277093597;38085.23829523339;38335;39232.80383598064;47225.29162062503;52049.479505204465;53026;54225.45774542362;54666.180007299125;7770.844583108194;7963.681452742057;8020.83958320842;8150.144234855255;8155.5922203888385;11515.654530364103;12335.026395776633;12632.557860474839;12744.872551274739;12979.610611681665;9739;9782.951085244527;10200.744981375525;10315.48422578883;10643.308184967953;10387.584496620051;10666.040056394962;10717.9464102679;10872;10899.400532970763;9781.951090244504;10141.138003269805;10218.386896786216;10327.48362581853;10596.682099536718;7450.739224127129;7491.737789177353;7709.306162445407;7792.72725454629;7918.326942209977;9840.212782977202;10233.74415639615;10381.740456488647;10474.476276186007;10536.735591728735 06:34:20 INFO - PROCESS | 13400 | |3;mootools.html;1364.5565191312824;1387.042940371144;1497.5582203250046;1633.6079340958174;1731.8268173182676;6743.258241593421;7514.248575142483;7670.808229794258;8135.186481351861;8156.347492200632;7742.883856742139;7994.080680721719;8011.839763204733;8015.4389192756535;8027.678892844294;1864.9627007459808;1882.7270045843345;1888.424030670645;1901.0969789350086;1905.9237630494833;2102.905369258387;2152.0961196297594;2174.1738139507042;2206.4042708468705;2208.447888027993;2175.4561359660083;2184.715986921698;2185.4536365908525;2191.6822060801173;2194.264921251383;2138.080625331115;2147.602693501707;2151.3868547463976;2153.3862849087936;2157.751858536257;2106.0149891128003;2136.295022642524;2139.871607703543;2148.1836901977304;2157.1479265690123;7970.960145199295;7984.960075199645;7991.480553763987;7992.760217193493;8019;4525.570070843298;4528.18492671319;4538.546145385468;4552.840650577214;4574.4968053514085;2744.917652470429;2831.405404864981;2834.7873909456875;2887.22045047838;2891.190466669336;849.3332733803934;884.9734507964771;891.2157301574573;892.076700614867;895.6865097215988;10609.204309676728;10613.5223914924;10667.679969600924;10765.83851242232;10771.653543307166;4008.158286759813;4121.5466298707115;4240.575942405796;4266.978665106717;4311.137772445523;9166.991630920593;9194.540272986324;9195.080491950752;9195.908040919505;9208.90791092094;4633.189191891405;4644.814207431665;4664.673472856935;4693.507181745936;4700.741459219776;3372.359251742161;4150.91698166041;4204.705670603028;4254.978725106354;4258.74447533149;3418.538497302882;3446.9827650861585;3531.8940431787087;3605.3330133925306;3629.310431018098;1156.8149096144577;1164.1792536261914;1179.4692388425242;1182.467889449751;1183.089021453476;823.2631794543969;823.4565186976687;831.476170012888;836.3372766767491;842.2083241752733;5092.668976516515;5419.105847535191;5469.589780766459;5531.502164805106;5651.4348565143155;809.5911564659809;847.7753395350237;874.309295656437;883.4787475389551;892.4868200784575;3521;3521.8591256349973;3536.2220311531423;3538.5222994895876;3622.8007459589976;9386.530673466299;9845.45849978258;9877.950610247046;9887.209023278121;9896.307258491837;8882.733517994342;9347.065293470598;9863.260255480724;9863.605455781688;9869;7164.140303163654;7322.96338518304;7329.963350183215;7365.668544915492;7369;5435.673859568438;5495.560355171657;5560.4161563035295;5607.130894711327;5678.119891416837;8925.687600933936;8992.640294388151;9025.503597302211;9100.089991001112;9110.498922559324;8844.380893337404;8844.823103538021;8937.01692813777;8969.833921590152;9126.634934602542;5910.172575839472;6797.1843378794865;7000;7147.749828755968;7152.105986751656;7539.019927409402;7737.1102323233545;7746.070471543451;7753.457257991887;7773.3004029637605;6874.587524748531;7021.859562808613;7032.964835175996;7067.717291308496;7165.964170179116;6699.263081061177;6742.9662851685425;6754.93245067543;6811.761588344384;6941.132358455193;5811.389804070512;6092.512598992159;6137.447629713347;6160.353162917829;6170.50635949132;4370.956290437055;4412.271975124068;4444.644428445781;4499.34759459883;4551.817927282872;4450.666200035075;4525.04973955473;4589.921368478338;4621.676482646317;4750.121227572772 06:34:20 INFO - PROCESS | 13400 | |4;prototype.html;288.53977905241146;295.22503428500187;302.4072817278135;306.5019343566704;308.81471117329596;4830.4686484486765;4905;5005.8486548093915;5012.423571289299;5021.246812978051;4916.459189489154;4935.6545041847085;4939.431965323989;4974.801007959677;4984.800607975686;3905.902352441183;3947.1710940702487;3954.4068389741483;3960.1287716702423;3962.821673024721;3725.292194483053;3941.605839416064;3977.82099805508;3985;3996.48045754053;3884.844606215748;3888.3778595424737;3890.3386424307937;3905.921881562367;3921.803909804513;3896.6687831534355;3903.1413089120347;3914.9804250978846;3915.628015338567;3922.411423373538;3445.810480423576;3450.8274586270586;3455.1707590178175;3462.2556150427527;3469;4675.2052151134385;4884.462709101996;4900.681455705403;4975.079610272075;4978.303037574742;4343.283358245885;4386.539413361615;4402.251617225047;4443.355713421568;4448.399466072071;5277.6305658603915;5293.517815011803;5295.126304159809;5297.920531192035;5322.33470816148;3616.0656488701493;3633.4004889193516;3653.415453527423;3704.499892514503;3710.7402481826284;5418.187271909206;5460.563154947595;5464.808731694372;5466.590005749545;5467.17992301154;3837.5586807517493;3841.8847434577006;3842.7886466244067;3857.4406711026745;3864.787436691009;3889.2999260132883;3910.3743401055694;3926.2932672118723;3926.371780515104;3927.0771368728324;4127.9174416512105;4261.552536983634;4318.114786468766;4357.172137293904;4372.606465418127;5198.662086964335;5199.142141546602;5214.167586823682;5222.448734860332;5281.551068159172;1229.4283158331418;1321.5837011341396;1338.3442113364576;1349.4737052549513;1361.4554178328747;878.3456325037888;894.2890402130322;909.667971190524;913.6984795017628;914.4330515080693;3971.960280397217;4038.394240863894;4040.8483582178937;4048.9392659110135;4061.4517040199785;4653.60444362233;4677.2750223715375;4683.367745354401;4685.718856868599;4687.718736875799;4011.8395264189107;4017.859374921922;4024.899377515527;4035.858744943913;4067.6848368579513;2368.7631236876173;2494.713107992568;2506.448581312108;2506.5989441689244;2519.9164359325664;4412.757298348557;4424.823007079745;4430.822767089345;4451.376807246988;4461.330800379969;4780.49804770501;4785.195769363365;4790.281457781291;4840.443349014838;4862.95137048625;4429.873660642909;4437.400950871655;4703.882402939886;5096.261042148942;5103.744812759422;5383.5962302826665;5421.241026256406;5436.53789427903;5436.646617969819;5447.210154527651;5320.228566857862;5337.386200586827;5342.973285133549;5343.866403339947;5343.893122137458;4890.24201248807;5065.898682026265;5067.594592432522;5086.338775959101;5091.490850914879;3759.642833930772;3807.7905715184825;3827.846886124635;3833.578306386351;3857.605307329532;5196.558292545024;5422.267993820784;5498.835034948958;5514.393416724238;5518.586106041983;5099.796008159632;5204.0892843752945;5216.608754343515;5230.529252367305;5240.921386179287;5218.295530103387;5224;5224.52979231871;5237.371515418175;5243.973780131075;5009.949900500948;5121.667091639031;5142.228665700025;5162.6386152968935;5165.66084489031;5269.394019687785;5277.709725965109;5279.31368922053;5281.392639846313;5291.285676433632;5142.845714628567;5150.768215430239;5159.767810448464;5175.1019429119815;5178.404483484447 06:34:20 INFO - PROCESS | 13400 | |5;yui.html;639.8208501619546;660.606938871372;726.0052284327151;754.466321654472;760.4144808497457;14002.929985350072;14333.569992900204;14663.486777962773;14716.411343546246;14790.556283311491;13732.313384330793;13749.65625859354;13788.793168102486;13837.377318020688;13900;647.876903388357;783.3106865957964;804.6620419423826;807.3621838747382;808.9635966381527;760.794585461925;809.2918696140877;812.5084323983993;814.7392834293029;817.6320655704927;854.7521218846528;857.9184977427135;858.2618947705;858.669412276275;859.5487369131225;854.2226573817827;854.2738672128703;855.3713020929612;855.6106971328031;856.0668870930715;622.841175500249;622.8941080016363;622.9968850155766;623.5416968528128;623.7411474238186;13379.397927093305;13380.397882095232;13390.464381424732;13429.798553021616;13443.798343024862;13918.164910105324;13977.72044559103;14016.75731882904;14159.78760318596;14407.927960360235;10433.739156521071;10571.78856422875;10583.312084714546;10625.521851516623;10698.786024279549;3331.1172539276868;3366.983165084159;3374.5950485941844;3399.711024562915;3484.233468636896;46262.53737462616;46959;47782.761086194696;68919.65540172317;70629;10507.264491485523;10545.9472702636;10665.146788256921;10727.83908241377;10823.67528974132;17251;18013.819861801476;19043.143058562397;19077.523061923286;19180.904095479433;7101.360877521048;7109.964450177819;7185.712571497082;7200.423966082701;7289.4168466523615;3758.4550240215017;3772.981135094307;3782.7730336179916;3817.84728610858;3840;2952.630921134858;3032.4844776388068;3056.251218451449;3067.7545796336685;3070.3398769264713;512.602732882012;519.5843325339789;526.8814516733781;526.9604779641542;532.4196625678029;551.48987186852;582.1645938078871;583.6731430398991;594.2601461180772;602.3434456442499;8428.4942903426;8596.312295016383;8730.388872778845;8808.339374546935;8835.293176545862;585.2859511396175;604.1602172979561;605.4944121658376;625.4527288622455;629.1380808292669;3876.321643712339;3880.0881792778673;3904.2972264992572;3968.3849003404516;4080.6939479539155;61958.38041619616;62100.37899621036;63164.36835631585;75867;92277;75235;76825.6158719214;78552.60723696345;78869;80217.59891200507;66641;69744.65127674329;70974.2902570978;71658;72731;8207.974003249594;8917.331200159884;9025.187733104052;9129.269658427176;9241.768955775891;32165.839170803996;41870.58129418667;42119.57880421157;42858;43236.567634323255;54543;54683;54683.45316546943;65477.34522654903;67012.664936675;11378.146639001943;12013.81979270329;12120.33338166374;12135.696607584881;12466.688332791753;13256.08388972125;13263.86736132665;13402.329883505981;13533.796993044914;13615;11796.410179491162;11796.94101529487;12291.385430728249;12533.74932501363;12598.370081496072;11928.300379468814;11959.282443053444;12317.815232771336;12400.56598019065;12678.049146313879;12165.513379465076;12244.387780611112;12491.312977785945;12850.614481565568;12971.156874803108;9493.762655933657;9904.42919525889;10191.439470829175;10364.429956352473;10499.94750026245;10410.427426491615;10608.469576521298;10651.946740266249;10706;10776.245662803529 06:34:20 INFO - PROCESS | 13400 | __end_tp_report 06:34:20 INFO - PROCESS | 13400 | __start_cc_report 06:34:20 INFO - PROCESS | 13400 | _x_x_mozilla_cycle_collect,365 06:34:20 INFO - PROCESS | 13400 | __end_cc_report 06:34:20 INFO - PROCESS | 13400 | __startTimestamp1470836060894__endTimestamp 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | ------- Summary: start ------- 06:34:20 INFO - PROCESS | 13400 | Number of tests: 6 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | [#0] dojo.html Cycles:165 Average:4710.53 Median:4834.42 stddev:492.10 (10.2%) stddev-sans-first:466.38 06:34:20 INFO - PROCESS | 13400 | Values: 2652.7 2666.3 2693.7 2696.8 2705.1 4548.2 4690.2 4783.9 4797.0 4808.6 4584.1 4660.4 4660.7 4670.9 4745.0 4270.0 4319.4 4342.5 4373.8 4461.8 4313.1 4334.4 4351.4 4371.5 4411.3 4312.9 4450.3 4450.4 4453.7 4458.8 4210.2 4311.1 4359.8 4388.8 4400.0 4265.5 4284.6 4286.3 4288.5 4393.7 4771.2 4782.1 4785.5 4785.6 4845.0 5050.5 5058.6 5117.2 5136.1 5137.1 5127.4 5151.4 5158.3 5172.9 5203.8 4799.7 4804.2 4810.0 4834.4 4842.8 4952.9 5080.0 5095.5 5144.4 5321.5 4970.3 4979.6 4981.4 4989.9 5008.4 5040.6 5049.8 5069.5 5070.6 5098.8 4888.8 4995.8 4999.3 5024.0 5029.8 4791.7 5013.1 5017.7 5020.0 5024.1 4377.6 4406.0 4408.4 4417.1 4445.4 3693.9 3755.4 3844.6 3859.6 3885.8 4340.0 4407.1 4420.7 4448.4 4450.6 5138.9 5163.6 5170.5 5179.6 5180.9 4212.2 4338.1 4390.8 4408.1 4454.5 4600.6 4618.9 4642.5 4685.3 4699.1 4796.7 4807.0 4810.0 4812.5 4861.2 4848.1 5054.4 5142.4 5148.2 5199.3 4769.1 4774.2 4815.7 4848.8 4851.4 5063.1 5096.8 5100.0 5108.7 5144.6 4866.9 5081.1 5128.7 5146.9 5150.3 4982.2 5044.5 5045.2 5064.5 5079.4 5036.6 5038.2 5040.5 5044.9 5080.9 4640.7 4895.2 4954.8 4964.5 4971.9 5049.7 5063.9 5068.3 5099.3 5100.9 4813.0 4838.2 4855.8 4862.0 4873.2 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | [#1] ext.html Cycles:180 Average:46736.77 Median:19673.79 stddev:88833.04 (451.5%) stddev-sans-first:89014.52 06:34:20 INFO - PROCESS | 13400 | Values: 536.2 546.3 574.2 580.0 592.4 34542.0 35461.3 38109.8 38125.6 38207.6 37986.2 38623.9 38673.0 38679.6 38751.2 7507.1 7742.6 7742.9 7764.4 7777.8 7583.9 7589.1 7599.5 7627.1 7659.1 7584.2 7703.3 7715.5 7715.7 7729.5 7570.7 7641.3 7643.7 7670.3 7676.0 7627.2 7723.9 7730.8 7734.7 7745.0 26911.7 26937.5 26994.7 27129.0 27155.9 3156.8 3176.6 3760.9 3763.8 3901.7 28381.9 28671.3 28972.7 28998.1 29689.7 3517.9 3525.5 3546.6 3576.6 3614.3 264425.0 264783.0 264970.0 265374.0 266981.0 31510.2 32795.3 32807.5 51358.0 51715.0 33857.7 34065.0 34082.0 34171.3 34257.3 13751.1 13910.2 13939.2 13939.4 13968.4 10705.1 10772.2 10817.2 10829.5 10830.8 7772.1 7851.0 7971.8 8001.8 8029.6 3093.7 3119.4 3137.8 3158.7 3176.5 866.5 902.3 966.9 985.4 1048.2 28800.7 28808.6 28959.7 29238.3 29662.3 905.9 951.0 1021.7 1023.5 1024.9 14180.6 14803.8 15002.8 15184.2 15248.3 400620.0 406201.0 406570.0 406712.0 407370.0 47928.0 48599.3 48625.0 48684.0 48699.8 1186.0 1199.2 1228.3 1228.8 1235.7 25862.0 26993.5 27417.7 28254.4 28291.2 41514.8 41826.8 41955.6 41969.0 42046.6 277977.0 279966.0 347285.0 348205.0 349964.0 22704.5 25430.7 25524.2 25805.1 25893.1 43121.0 43801.6 43859.6 43990.3 44059.8 36743.8 36832.0 37701.2 37765.6 38314.4 37287.6 37515.0 37613.6 38121.0 38216.2 31545.0 35771.0 36491.8 36588.8 36721.6 32213.8 33257.3 33956.0 34205.8 34475.3 25599.6 25648.2 25700.7 25713.0 26123.0 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | [#2] jquery.html Cycles:180 Average:24749.42 Median:4389.15 stddev:66373.39 (1512.2%) stddev-sans-first:66534.33 06:34:20 INFO - PROCESS | 13400 | Values: 364.2 372.1 382.2 383.7 385.4 15998.9 16477.0 17244.7 17383.8 17396.3 16541.5 17186.1 17224.1 17287.8 17297.3 5053.9 5273.7 5295.1 5298.4 5307.0 5148.5 5215.9 5224.1 5264.0 5400.2 5486.5 5520.7 5525.0 5531.2 5535.1 5363.1 5399.4 5452.0 5524.9 5570.1 5250.6 5255.6 5284.3 5287.2 5310.9 11314.4 11349.8 11548.6 11570.3 12924.7 2053.3 2378.2 2390.8 2406.5 2453.9 9438.9 9503.7 9515.5 9962.3 10004.2 1733.6 1761.2 1770.6 1772.8 1783.2 68784.7 73212.6 73833.0 74455.6 74557.0 9932.2 9951.8 10071.9 10202.4 10495.5 13377.1 13393.9 13401.2 13401.3 13401.9 7168.5 7507.6 7573.1 7751.3 7827.8 7210.1 7238.3 7446.7 7459.2 7487.3 4286.9 4351.0 4427.3 4512.3 4536.1 1759.9 1837.1 1863.0 1873.9 1926.7 828.4 891.6 915.0 949.4 993.0 17107.3 17893.0 18088.3 18090.6 18475.6 844.9 880.5 889.1 892.7 938.9 9749.8 10157.2 10180.5 10218.7 10298.2 389210.0 397274.0 405422.0 407187.0 408766.0 76441.2 77021.0 79007.0 79437.6 80796.0 891.2 911.5 933.9 934.7 942.4 15623.7 15626.8 15785.0 16294.8 16374.7 37197.6 37445.8 38085.2 38335.0 39232.8 47225.3 52049.5 53026.0 54225.5 54666.2 7770.8 7963.7 8020.8 8150.1 8155.6 11515.7 12335.0 12632.6 12744.9 12979.6 9739.0 9783.0 10200.7 10315.5 10643.3 10387.6 10666.0 10717.9 10872.0 10899.4 9782.0 10141.1 10218.4 10327.5 10596.7 7450.7 7491.7 7709.3 7792.7 7918.3 9840.2 10233.7 10381.7 10474.5 10536.7 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | [#3] mootools.html Cycles:180 Average:5158.49 Median:5545.96 stddev:2925.94 (52.8%) stddev-sans-first:2920.25 06:34:20 INFO - PROCESS | 13400 | Values: 1364.6 1387.0 1497.6 1633.6 1731.8 6743.3 7514.2 7670.8 8135.2 8156.3 7742.9 7994.1 8011.8 8015.4 8027.7 1865.0 1882.7 1888.4 1901.1 1905.9 2102.9 2152.1 2174.2 2206.4 2208.4 2175.5 2184.7 2185.5 2191.7 2194.3 2138.1 2147.6 2151.4 2153.4 2157.8 2106.0 2136.3 2139.9 2148.2 2157.1 7971.0 7985.0 7991.5 7992.8 8019.0 4525.6 4528.2 4538.5 4552.8 4574.5 2744.9 2831.4 2834.8 2887.2 2891.2 849.3 885.0 891.2 892.1 895.7 10609.2 10613.5 10667.7 10765.8 10771.7 4008.2 4121.5 4240.6 4267.0 4311.1 9167.0 9194.5 9195.1 9195.9 9208.9 4633.2 4644.8 4664.7 4693.5 4700.7 3372.4 4150.9 4204.7 4255.0 4258.7 3418.5 3447.0 3531.9 3605.3 3629.3 1156.8 1164.2 1179.5 1182.5 1183.1 823.3 823.5 831.5 836.3 842.2 5092.7 5419.1 5469.6 5531.5 5651.4 809.6 847.8 874.3 883.5 892.5 3521.0 3521.9 3536.2 3538.5 3622.8 9386.5 9845.5 9878.0 9887.2 9896.3 8882.7 9347.1 9863.3 9863.6 9869.0 7164.1 7323.0 7330.0 7365.7 7369.0 5435.7 5495.6 5560.4 5607.1 5678.1 8925.7 8992.6 9025.5 9100.1 9110.5 8844.4 8844.8 8937.0 8969.8 9126.6 5910.2 6797.2 7000.0 7147.7 7152.1 7539.0 7737.1 7746.1 7753.5 7773.3 6874.6 7021.9 7033.0 7067.7 7166.0 6699.3 6743.0 6754.9 6811.8 6941.1 5811.4 6092.5 6137.4 6160.4 6170.5 4371.0 4412.3 4444.6 4499.3 4551.8 4450.7 4525.0 4589.9 4621.7 4750.1 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | [#4] prototype.html Cycles:180 Average:4244.64 Median:4684.54 stddev:1244.52 (26.6%) stddev-sans-first:1212.07 06:34:20 INFO - PROCESS | 13400 | Values: 288.5 295.2 302.4 306.5 308.8 4830.5 4905.0 5005.8 5012.4 5021.2 4916.5 4935.7 4939.4 4974.8 4984.8 3905.9 3947.2 3954.4 3960.1 3962.8 3725.3 3941.6 3977.8 3985.0 3996.5 3884.8 3888.4 3890.3 3905.9 3921.8 3896.7 3903.1 3915.0 3915.6 3922.4 3445.8 3450.8 3455.2 3462.3 3469.0 4675.2 4884.5 4900.7 4975.1 4978.3 4343.3 4386.5 4402.3 4443.4 4448.4 5277.6 5293.5 5295.1 5297.9 5322.3 3616.1 3633.4 3653.4 3704.5 3710.7 5418.2 5460.6 5464.8 5466.6 5467.2 3837.6 3841.9 3842.8 3857.4 3864.8 3889.3 3910.4 3926.3 3926.4 3927.1 4127.9 4261.6 4318.1 4357.2 4372.6 5198.7 5199.1 5214.2 5222.4 5281.6 1229.4 1321.6 1338.3 1349.5 1361.5 878.3 894.3 909.7 913.7 914.4 3972.0 4038.4 4040.8 4048.9 4061.5 4653.6 4677.3 4683.4 4685.7 4687.7 4011.8 4017.9 4024.9 4035.9 4067.7 2368.8 2494.7 2506.4 2506.6 2519.9 4412.8 4424.8 4430.8 4451.4 4461.3 4780.5 4785.2 4790.3 4840.4 4863.0 4429.9 4437.4 4703.9 5096.3 5103.7 5383.6 5421.2 5436.5 5436.6 5447.2 5320.2 5337.4 5343.0 5343.9 5343.9 4890.2 5065.9 5067.6 5086.3 5091.5 3759.6 3807.8 3827.8 3833.6 3857.6 5196.6 5422.3 5498.8 5514.4 5518.6 5099.8 5204.1 5216.6 5230.5 5240.9 5218.3 5224.0 5224.5 5237.4 5244.0 5009.9 5121.7 5142.2 5162.6 5165.7 5269.4 5277.7 5279.3 5281.4 5291.3 5142.8 5150.8 5159.8 5175.1 5178.4 06:34:20 INFO - PROCESS | 13400 | 06:34:20 INFO - PROCESS | 13400 | [#5] yui.html Cycles:180 Average:16643.89 Median:42488.79 stddev:22001.39 (51.8%) stddev-sans-first:22030.29 06:34:20 INFO - PROCESS | 13400 | Values: 639.8 660.6 726.0 754.5 760.4 14002.9 14333.6 14663.5 14716.4 14790.6 13732.3 13749.7 13788.8 13837.4 13900.0 647.9 783.3 804.7 807.4 809.0 760.8 809.3 812.5 814.7 817.6 854.8 857.9 858.3 858.7 859.5 854.2 854.3 855.4 855.6 856.1 622.8 622.9 623.0 623.5 623.7 13379.4 13380.4 13390.5 13429.8 13443.8 13918.2 13977.7 14016.8 14159.8 14407.9 10433.7 10571.8 10583.3 10625.5 10698.8 3331.1 3367.0 3374.6 3399.7 3484.2 46262.5 46959.0 47782.8 68919.7 70629.0 10507.3 10545.9 10665.1 10727.8 10823.7 17251.0 18013.8 19043.1 19077.5 19180.9 7101.4 7110.0 7185.7 7200.4 7289.4 3758.5 3773.0 3782.8 3817.8 3840.0 2952.6 3032.5 3056.3 3067.8 3070.3 512.6 519.6 526.9 527.0 532.4 551.5 582.2 583.7 594.3 602.3 8428.5 8596.3 8730.4 8808.3 8835.3 585.3 604.2 605.5 625.5 629.1 3876.3 3880.1 3904.3 3968.4 4080.7 61958.4 62100.4 63164.4 75867.0 92277.0 75235.0 76825.6 78552.6 78869.0 80217.6 66641.0 69744.7 70974.3 71658.0 72731.0 8208.0 8917.3 9025.2 9129.3 9241.8 32165.8 41870.6 42119.6 42858.0 43236.6 54543.0 54683.0 54683.5 65477.3 67012.7 11378.1 12013.8 12120.3 12135.7 12466.7 13256.1 13263.9 13402.3 13533.8 13615.0 11796.4 11796.9 12291.4 12533.7 12598.4 11928.3 11959.3 12317.8 12400.6 12678.0 12165.5 12244.4 12491.3 12850.6 12971.2 9493.8 9904.4 10191.4 10364.4 10499.9 10410.4 10608.5 10651.9 10706.0 10776.2 06:34:20 INFO - PROCESS | 13400 | -------- Summary: end -------- 06:34:20 INFO - PROCESS | 13400 | 06:34:21 INFO - TEST-INFO | 13400: exit 0 06:34:21 INFO - TEST-OK | dromaeo_css | took 1116666ms 06:34:21 INFO - TEST-START | kraken 06:34:21 INFO - operating with platform_type : linux_ 06:34:21 INFO - Initialising browser for kraken test... 06:34:21 INFO - TEST-INFO | started process 13645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgARhHE/profile http://localhost:43801/getInfo.html) 06:34:26 INFO - PROCESS | 13645 | __metrics Screen width/height:1600/1200 06:34:26 INFO - PROCESS | 13645 | colorDepth:24 06:34:26 INFO - PROCESS | 13645 | Browser inner width/height: 1024/697 06:34:26 INFO - PROCESS | 13645 | __metrics 06:34:27 ERROR - PROCESS | 13645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 06:34:28 INFO - TEST-INFO | 13645: exit 0 06:34:28 INFO - Browser initialized. 06:34:28 INFO - Running cycle 1/1 for kraken test... 06:34:28 INFO - TEST-INFO | started process 13767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgARhHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:40 INFO - PROCESS | 13767 | RSS: Main: 163549184 06:34:40 INFO - PROCESS | 13767 | 06:34:42 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43801/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:43 INFO - PROCESS | 13767 | RSS: Main: 168828928 06:34:43 INFO - PROCESS | 13767 | 06:34:46 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43801/tests/kraken/driver.html?testName=audio-dft) 06:34:47 INFO - PROCESS | 13767 | RSS: Main: 167735296 06:34:47 INFO - PROCESS | 13767 | 06:34:50 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43801/tests/kraken/driver.html?testName=audio-fft) 06:34:50 INFO - PROCESS | 13767 | RSS: Main: 163426304 06:34:50 INFO - PROCESS | 13767 | 06:34:53 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43801/tests/kraken/driver.html?testName=audio-oscillator) 06:34:53 INFO - PROCESS | 13767 | RSS: Main: 164478976 06:34:53 INFO - PROCESS | 13767 | 06:34:55 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43801/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:56 INFO - PROCESS | 13767 | RSS: Main: 164872192 06:34:56 INFO - PROCESS | 13767 | 06:34:59 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43801/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:00 INFO - PROCESS | 13767 | RSS: Main: 164966400 06:35:00 INFO - PROCESS | 13767 | 06:35:03 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43801/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:04 INFO - PROCESS | 13767 | RSS: Main: 162529280 06:35:04 INFO - PROCESS | 13767 | 06:35:07 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43801/tests/kraken/driver.html?testName=json-parse-financial) 06:35:08 INFO - PROCESS | 13767 | RSS: Main: 164429824 06:35:08 INFO - PROCESS | 13767 | 06:35:09 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43801/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:10 INFO - PROCESS | 13767 | RSS: Main: 165261312 06:35:10 INFO - PROCESS | 13767 | 06:35:12 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:13 INFO - PROCESS | 13767 | RSS: Main: 165064704 06:35:13 INFO - PROCESS | 13767 | 06:35:15 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:16 INFO - PROCESS | 13767 | RSS: Main: 165785600 06:35:16 INFO - PROCESS | 13767 | 06:35:18 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:19 INFO - PROCESS | 13767 | RSS: Main: 165330944 06:35:19 INFO - PROCESS | 13767 | 06:35:22 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:23 INFO - PROCESS | 13767 | RSS: Main: 166146048 06:35:23 INFO - PROCESS | 13767 | 06:35:24 INFO - PROCESS | 13767 | Cycle 1(1): loaded http://localhost:43801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43801/tests/kraken/driver.html?testName=ai-astar) 06:35:25 INFO - PROCESS | 13767 | RSS: Main: 166154240 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | __start_tp_report 06:35:25 INFO - PROCESS | 13767 | _x_x_mozilla_page_load 06:35:25 INFO - PROCESS | 13767 | _x_x_mozilla_page_load_details 06:35:25 INFO - PROCESS | 13767 | |i|pagename|runs| 06:35:25 INFO - PROCESS | 13767 | |0;ai-astar;106;117;111;115;116;117;117;115;116;114 06:35:25 INFO - PROCESS | 13767 | |1;audio-beat-detection;157;123;151;194;122;156;144;132;180;124 06:35:25 INFO - PROCESS | 13767 | |2;audio-dft;166;167;166;169;163;163;163;163;162;164 06:35:25 INFO - PROCESS | 13767 | |3;audio-fft;75;75;78;173;76;77;77;76;160;79 06:35:25 INFO - PROCESS | 13767 | |4;audio-oscillator;86;85;161;86;86;86;146;87;87;137 06:35:25 INFO - PROCESS | 13767 | |5;imaging-gaussian-blur;118;117;117;118;121;118;117;117;118;117 06:35:25 INFO - PROCESS | 13767 | |6;imaging-darkroom;149;147;148;151;149;147;147;150;147;146 06:35:25 INFO - PROCESS | 13767 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;97;96 06:35:25 INFO - PROCESS | 13767 | |8;json-parse-financial;62;65;64;64;64;61;63;64;63;64 06:35:25 INFO - PROCESS | 13767 | |9;json-stringify-tinderbox;66;65;66;66;64;64;65;65;65;66 06:35:25 INFO - PROCESS | 13767 | |10;stanford-crypto-aes;86;79;79;79;80;79;82;82;81;84 06:35:25 INFO - PROCESS | 13767 | |11;stanford-crypto-ccm;152;141;142;131;141;144;130;149;144;140 06:35:25 INFO - PROCESS | 13767 | |12;stanford-crypto-pbkdf2;172;175;171;174;170;174;168;174;167;174 06:35:25 INFO - PROCESS | 13767 | |13;stanford-crypto-sha256-iterative;70;71;70;72;69;68;67;69;68;68 06:35:25 INFO - PROCESS | 13767 | __end_tp_report 06:35:25 INFO - PROCESS | 13767 | __start_cc_report 06:35:25 INFO - PROCESS | 13767 | _x_x_mozilla_cycle_collect,930 06:35:25 INFO - PROCESS | 13767 | __end_cc_report 06:35:25 INFO - PROCESS | 13767 | __startTimestamp1470836125118__endTimestamp 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | ------- Summary: start ------- 06:35:25 INFO - PROCESS | 13767 | Number of tests: 14 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#0] ai-astar Cycles:10 Average:114.40 Median:116.00 stddev:3.47 (3.0%) stddev-sans-first:1.94 06:35:25 INFO - PROCESS | 13767 | Values: 106.0 117.0 111.0 115.0 116.0 117.0 117.0 115.0 116.0 114.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.50 stddev:24.59 (16.0%) stddev-sans-first:25.88 06:35:25 INFO - PROCESS | 13767 | Values: 157.0 123.0 151.0 194.0 122.0 156.0 144.0 132.0 180.0 124.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.27 (1.4%) stddev-sans-first:2.35 06:35:25 INFO - PROCESS | 13767 | Values: 166.0 167.0 166.0 169.0 163.0 163.0 163.0 163.0 162.0 164.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:38.04 (49.7%) stddev-sans-first:39.68 06:35:25 INFO - PROCESS | 13767 | Values: 75.0 75.0 78.0 173.0 76.0 77.0 77.0 76.0 160.0 79.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:86.00 stddev:30.43 (35.4%) stddev-sans-first:31.51 06:35:25 INFO - PROCESS | 13767 | Values: 86.0 85.0 161.0 86.0 86.0 86.0 146.0 87.0 87.0 137.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.30 06:35:25 INFO - PROCESS | 13767 | Values: 118.0 117.0 117.0 118.0 121.0 118.0 117.0 117.0 118.0 117.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:1.60 (1.1%) stddev-sans-first:1.66 06:35:25 INFO - PROCESS | 13767 | Values: 149.0 147.0 148.0 151.0 149.0 147.0 147.0 150.0 147.0 146.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:35:25 INFO - PROCESS | 13767 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 97.0 96.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:1.17 (1.8%) stddev-sans-first:1.13 06:35:25 INFO - PROCESS | 13767 | Values: 62.0 65.0 64.0 64.0 64.0 61.0 63.0 64.0 63.0 64.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 06:35:25 INFO - PROCESS | 13767 | Values: 66.0 65.0 66.0 66.0 64.0 64.0 65.0 65.0 65.0 66.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.50 stddev:2.42 (3.0%) stddev-sans-first:1.81 06:35:25 INFO - PROCESS | 13767 | Values: 86.0 79.0 79.0 79.0 80.0 79.0 82.0 82.0 81.0 84.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:143.00 stddev:6.87 (4.8%) stddev-sans-first:6.12 06:35:25 INFO - PROCESS | 13767 | Values: 152.0 141.0 142.0 131.0 141.0 144.0 130.0 149.0 144.0 140.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:174.00 stddev:2.81 (1.6%) stddev-sans-first:2.98 06:35:25 INFO - PROCESS | 13767 | Values: 172.0 175.0 171.0 174.0 170.0 174.0 168.0 174.0 167.0 174.0 06:35:25 INFO - PROCESS | 13767 | 06:35:25 INFO - PROCESS | 13767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.55 (2.2%) stddev-sans-first:1.62 06:35:25 INFO - PROCESS | 13767 | Values: 70.0 71.0 70.0 72.0 69.0 68.0 67.0 69.0 68.0 68.0 06:35:25 INFO - PROCESS | 13767 | -------- Summary: end -------- 06:35:25 INFO - PROCESS | 13767 | 06:35:26 INFO - TEST-INFO | 13767: exit 0 06:35:26 INFO - TEST-OK | kraken | took 64439ms 06:35:26 INFO - SUITE-END | took 1181s 06:35:26 INFO - Completed test suite (00:19:41) 06:35:26 INFO - javascript benchmark 06:35:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6376.474587504407, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.708202097769, 2666.2934322404553, 2693.717159698232, 2696.7707744841687, 2705.147878418297, 4548.1585906607215, 4690.1792186367375, 4783.880402989923, 4797.0, 4808.615310775138, 4584.129015487063, 4660.440747110351, 4660.673752837294, 4670.883227919304, 4745.0, 4270.0, 4319.438472998506, 4342.50061242958, 4373.759443230621, 4461.754603496806, 4313.1158112587, 4334.414853994717, 4351.4343135392355, 4371.475422949251, 4411.294192929132, 4312.870613881589, 4450.310201918708, 4450.443694538183, 4453.710508816916, 4458.754768487748, 4210.200061988213, 4311.051568654891, 4359.84740534083, 4388.780560971939, 4399.956000439986, 4265.53079161292, 4284.550122237151, 4286.271333873218, 4288.485381754178, 4393.692441529094, 4771.236602143675, 4782.13921494131, 4785.521447855222, 4785.593224575915, 4844.95155048452, 5050.494950504957, 5058.620603454756, 5117.1556693145585, 5136.075506408845, 5137.075326441239, 5127.410347810012, 5151.433342332378, 5158.277841102249, 5172.939547392813, 5203.765830537635, 4799.66402351839, 4804.20730579454, 4810.037992401463, 4834.419869615669, 4842.83050093245, 4952.90094198114, 5080.0, 5095.515925987025, 5144.382674079135, 5321.5476684482255, 4970.304157417964, 4979.6265280104135, 4981.37732783402, 4989.850304490871, 5008.398992120969, 5040.647154699209, 5049.82325618609, 5069.467705890902, 5070.61970352225, 5098.821541246039, 4888.755562221946, 4995.782265667599, 4999.275105109738, 5024.0, 5029.823956161516, 4791.712497250176, 5013.147764879979, 5017.7491125443585, 5020.046191223656, 5024.120778863684, 4377.584129507692, 4406.030673251879, 4408.360787685768, 4417.050334178167, 4445.422095127613, 3693.8522459101873, 3755.3803622401997, 3844.557875844258, 3859.55615104261, 3885.8057097145597, 4340.0, 4407.096545208225, 4420.690551661352, 4448.399466072104, 4450.621697155778, 5138.868112690102, 5163.612729045261, 5170.45710200431, 5179.637425380187, 5180.870478238075, 4212.157568486315, 4338.110687309094, 4390.780460976938, 4408.118376324748, 4454.532274111237, 4600.631949444037, 4618.861434156981, 4642.4661163966575, 4685.273782563708, 4699.083678682624, 4796.664233503621, 4806.95193048079, 4809.975950120227, 4812.542808433333, 4861.246506791524, 4848.0546293472435, 5054.368203974504, 5142.357205349332, 5148.176291793295, 5199.2980947573105, 4769.093872164278, 4774.164521208844, 4815.662903596854, 4848.80604775805, 4851.442084160226, 5063.088644044107, 5096.770645320896, 5099.954509325506, 5108.66793658411, 5144.614153938394, 4866.90266194667, 5081.060003899291, 5128.717920514258, 5146.871328216825, 5150.330457040711, 4982.227754698028, 5044.495550444926, 5045.167547354646, 5064.518870707277, 5079.390473143247, 5036.622253330942, 5038.244263360525, 5040.470750571138, 5044.899102018013, 5080.923786143285, 4640.721556706609, 4895.241237608177, 4954.77703503336, 4964.528369804862, 4971.9005619886675, 5049.722265275298, 5063.87340316495, 5068.341115655089, 5099.26060721186, 5100.923486147636, 4812.975935120442, 4838.201696720002, 4855.8057677692495, 4861.975690121527, 4873.171560834738], "value": 4679.545996423381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.1769683535773, 546.3498436860136, 574.1588572740935, 579.979700710475, 592.4490224091593, 34542.0, 35461.2907741845, 38109.80945095271, 38125.618743812556, 38207.617923820755, 37986.24027519448, 38623.91008719303, 38673.0, 38679.61320386795, 38751.224975500474, 7507.136679281884, 7742.61286935651, 7742.922570774276, 7764.417668674843, 7777.766666999999, 7583.9241607584045, 7589.127250366196, 7599.544027358348, 7627.122880868716, 7659.119201291839, 7584.165741768401, 7703.3452156566755, 7715.459917805756, 7715.6913723451, 7729.497582657109, 7570.659320330598, 7641.3122818946, 7643.7324693635455, 7670.348020418299, 7676.0, 7627.2372762723835, 7723.922760772432, 7730.768076957644, 7734.651940662684, 7745.031871016123, 26911.730882691118, 26937.46125077507, 26994.730052699615, 27129.0, 27155.864220678966, 3156.8105913645254, 3176.6188057433023, 3760.905977350561, 3763.8118094095184, 3901.707371947087, 28381.858090709415, 28671.28321791951, 28972.710272897424, 28998.13005609835, 29689.70310296891, 3517.9472307915403, 3525.4711793230963, 3546.6098729139776, 3576.5708115026364, 3614.3132804767274, 264425.0, 264783.0, 264970.0, 265374.0, 266981.0, 31510.21224469361, 32795.34409311848, 32807.50788738171, 51358.0, 51715.0, 33857.66142338545, 34065.0, 34082.0, 34171.31657366888, 34257.31485370328, 13751.106178098591, 13910.234937078356, 13939.233342166279, 13939.442422303197, 13968.441262349595, 10705.1435885129, 10772.192085593455, 10817.188710846718, 10829.458527073615, 10830.783384332426, 7772.106207786177, 7851.0, 7971.8405631887035, 8001.799955001172, 8029.558374289353, 3093.7370323522755, 3119.376124775054, 3137.796043257181, 3158.7157155856085, 3176.491761318178, 866.4931015355961, 902.273669695888, 966.8501382285757, 985.4481490365418, 1048.1509976918721, 28800.71199288022, 28808.567871481944, 28959.710402896122, 29238.26904327409, 29662.258443538653, 905.8686490458847, 950.9634498396642, 1021.7394564386034, 1023.534291897185, 1024.912882404989, 14180.64548386278, 14803.777943330859, 15002.774958375632, 15184.164870932205, 15248.313825877862, 400620.0, 406201.0, 406570.0, 406712.0, 407370.0, 47928.0, 48599.27101093486, 48625.0, 48684.0, 48699.75650121726, 1185.968207659342, 1199.244475980127, 1228.2875931959443, 1228.7603917236231, 1235.7404944961659, 25862.0, 26993.46013079688, 27417.725822742315, 28254.43491130207, 28291.151265462067, 41514.792426037675, 41826.79086604669, 41955.58044419517, 41969.0, 42046.57953420427, 277977.0, 279966.0, 347285.0, 348205.0, 349964.0, 22704.545909081397, 25430.745692542838, 25524.23427297184, 25805.096821611154, 25893.09374171895, 43121.0, 43801.56198438102, 43859.561404385546, 43990.340144898495, 44059.77970110129, 36743.81628091949, 36832.0, 37701.24597508089, 37765.62234377621, 38314.425283620214, 37287.627123728416, 37515.0, 37613.623863762106, 38121.0, 38216.23567528578, 31545.0, 35771.0, 36491.81754091319, 36588.81705591561, 36721.63278367182, 32213.838930805196, 33257.334853303284, 33956.0, 34205.828970854986, 34475.310493790486, 25599.616005759555, 25648.23055308344, 25700.742992569834, 25713.0, 26123.0], "value": 16351.927775213946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.20239675111503, 372.14406864212316, 382.1668762098625, 383.7083816299615, 385.4353372309566, 15998.920005399987, 16477.0, 17244.65510689787, 17383.82616173838, 17396.30414783407, 16541.503754887344, 17186.14069296533, 17224.138793060327, 17287.82712172878, 17297.308107675708, 5053.873653158673, 5273.736313184345, 5295.0998330283755, 5298.36419629645, 5306.973465132669, 5148.485151484841, 5215.947840521584, 5224.085784987631, 5264.026155161288, 5400.162974738902, 5486.506214440699, 5520.696361700105, 5525.0, 5531.225628412006, 5535.059039963196, 5363.115086010823, 5399.379071406799, 5451.972740136313, 5524.944750552483, 5570.108782594785, 5250.553702935255, 5255.5795536357, 5284.260203571503, 5287.180487024518, 5310.946890531084, 11314.434278286053, 11349.829752553718, 11548.59579914699, 11570.305781653044, 12924.741505169937, 2053.3429302623167, 2378.1676413255223, 2390.8087353011715, 2406.542756876188, 2453.9386515337083, 9438.858417123749, 9503.714888553355, 9515.524223788783, 9962.302638815287, 10004.19966402686, 1733.575274057864, 1761.1722490429477, 1770.6133698162923, 1772.8404443600139, 1783.2064731194623, 68784.6560767193, 73212.6339368305, 73832.99999999946, 74455.62772186159, 74557.0, 9932.162549928287, 9951.80096398068, 10071.899281007096, 10202.387856728472, 10495.475226238657, 13377.130486518345, 13393.933030334982, 13401.195928244142, 13401.329933503286, 13401.932990334986, 7168.462365322622, 7507.624618769149, 7573.053368328959, 7751.34113600339, 7827.804304892309, 7210.134783825974, 7238.276172382825, 7446.702131914771, 7459.172502736864, 7487.28870757288, 4286.935695964563, 4351.0, 4427.29163333865, 4512.323151527297, 4536.115457485825, 1759.9208035638171, 1837.136545823461, 1862.9627407452047, 1873.8875667459995, 1926.7398901148447, 828.4490813608883, 891.5720454181899, 914.9725508234764, 949.4161090929167, 993.036754348281, 17107.315707371567, 17893.023348712788, 18088.27646894136, 18090.63818723618, 18475.630487390445, 844.907060223375, 880.5245167609419, 889.0620395482828, 892.6652505310509, 938.8544775559662, 9749.756256093513, 10157.171709092287, 10180.490975451346, 10218.739312108724, 10298.17614590846, 389210.0, 397274.0, 405422.0, 407187.0, 408766.0, 76441.23558764342, 77021.0, 79007.0, 79437.60281198558, 80796.0, 891.2157301574573, 911.5396724654007, 933.8645896345128, 934.7336009237334, 942.3733217410345, 15623.687526249638, 15626.765598516258, 15785.0, 16294.822885586835, 16374.672506550041, 37197.6280237205, 37445.81277093597, 38085.23829523339, 38335.0, 39232.80383598064, 47225.29162062503, 52049.479505204465, 53026.0, 54225.45774542362, 54666.180007299125, 7770.844583108194, 7963.681452742057, 8020.83958320842, 8150.144234855255, 8155.5922203888385, 11515.654530364103, 12335.026395776633, 12632.557860474839, 12744.872551274739, 12979.610611681665, 9739.0, 9782.951085244527, 10200.744981375525, 10315.48422578883, 10643.308184967953, 10387.584496620051, 10666.040056394962, 10717.9464102679, 10872.0, 10899.400532970763, 9781.951090244504, 10141.138003269805, 10218.386896786216, 10327.48362581853, 10596.682099536718, 7450.739224127129, 7491.737789177353, 7709.306162445407, 7792.72725454629, 7918.326942209977, 9840.212782977202, 10233.74415639615, 10381.740456488647, 10474.476276186007, 10536.735591728735], "value": 8298.460085730656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.5565191312824, 1387.042940371144, 1497.5582203250046, 1633.6079340958174, 1731.8268173182676, 6743.258241593421, 7514.248575142483, 7670.808229794258, 8135.186481351861, 8156.347492200632, 7742.883856742139, 7994.080680721719, 8011.839763204733, 8015.4389192756535, 8027.678892844294, 1864.9627007459808, 1882.7270045843345, 1888.424030670645, 1901.0969789350086, 1905.9237630494833, 2102.905369258387, 2152.0961196297594, 2174.1738139507042, 2206.4042708468705, 2208.447888027993, 2175.4561359660083, 2184.715986921698, 2185.4536365908525, 2191.6822060801173, 2194.264921251383, 2138.080625331115, 2147.602693501707, 2151.3868547463976, 2153.3862849087936, 2157.751858536257, 2106.0149891128003, 2136.295022642524, 2139.871607703543, 2148.1836901977304, 2157.1479265690123, 7970.960145199295, 7984.960075199645, 7991.480553763987, 7992.760217193493, 8019.0, 4525.570070843298, 4528.18492671319, 4538.546145385468, 4552.840650577214, 4574.4968053514085, 2744.917652470429, 2831.405404864981, 2834.7873909456875, 2887.22045047838, 2891.190466669336, 849.3332733803934, 884.9734507964771, 891.2157301574573, 892.076700614867, 895.6865097215988, 10609.204309676728, 10613.5223914924, 10667.679969600924, 10765.83851242232, 10771.653543307166, 4008.158286759813, 4121.5466298707115, 4240.575942405796, 4266.978665106717, 4311.137772445523, 9166.991630920593, 9194.540272986324, 9195.080491950752, 9195.908040919505, 9208.90791092094, 4633.189191891405, 4644.814207431665, 4664.673472856935, 4693.507181745936, 4700.741459219776, 3372.359251742161, 4150.91698166041, 4204.705670603028, 4254.978725106354, 4258.74447533149, 3418.538497302882, 3446.9827650861585, 3531.8940431787087, 3605.3330133925306, 3629.310431018098, 1156.8149096144577, 1164.1792536261914, 1179.4692388425242, 1182.467889449751, 1183.089021453476, 823.2631794543969, 823.4565186976687, 831.476170012888, 836.3372766767491, 842.2083241752733, 5092.668976516515, 5419.105847535191, 5469.589780766459, 5531.502164805106, 5651.4348565143155, 809.5911564659809, 847.7753395350237, 874.309295656437, 883.4787475389551, 892.4868200784575, 3521.0, 3521.8591256349973, 3536.2220311531423, 3538.5222994895876, 3622.8007459589976, 9386.530673466299, 9845.45849978258, 9877.950610247046, 9887.209023278121, 9896.307258491837, 8882.733517994342, 9347.065293470598, 9863.260255480724, 9863.605455781688, 9869.0, 7164.140303163654, 7322.96338518304, 7329.963350183215, 7365.668544915492, 7369.0, 5435.673859568438, 5495.560355171657, 5560.4161563035295, 5607.130894711327, 5678.119891416837, 8925.687600933936, 8992.640294388151, 9025.503597302211, 9100.089991001112, 9110.498922559324, 8844.380893337404, 8844.823103538021, 8937.01692813777, 8969.833921590152, 9126.634934602542, 5910.172575839472, 6797.1843378794865, 7000.0, 7147.749828755968, 7152.105986751656, 7539.019927409402, 7737.1102323233545, 7746.070471543451, 7753.457257991887, 7773.3004029637605, 6874.587524748531, 7021.859562808613, 7032.964835175996, 7067.717291308496, 7165.964170179116, 6699.263081061177, 6742.9662851685425, 6754.93245067543, 6811.761588344384, 6941.132358455193, 5811.389804070512, 6092.512598992159, 6137.447629713347, 6160.353162917829, 6170.50635949132, 4370.956290437055, 4412.271975124068, 4444.644428445781, 4499.34759459883, 4551.817927282872, 4450.666200035075, 4525.04973955473, 4589.921368478338, 4621.676482646317, 4750.121227572772], "value": 4128.496786262297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.53977905241146, 295.22503428500187, 302.4072817278135, 306.5019343566704, 308.81471117329596, 4830.4686484486765, 4905.0, 5005.8486548093915, 5012.423571289299, 5021.246812978051, 4916.459189489154, 4935.6545041847085, 4939.431965323989, 4974.801007959677, 4984.800607975686, 3905.902352441183, 3947.1710940702487, 3954.4068389741483, 3960.1287716702423, 3962.821673024721, 3725.292194483053, 3941.605839416064, 3977.82099805508, 3985.0, 3996.48045754053, 3884.844606215748, 3888.3778595424737, 3890.3386424307937, 3905.921881562367, 3921.803909804513, 3896.6687831534355, 3903.1413089120347, 3914.9804250978846, 3915.628015338567, 3922.411423373538, 3445.810480423576, 3450.8274586270586, 3455.1707590178175, 3462.2556150427527, 3469.0, 4675.2052151134385, 4884.462709101996, 4900.681455705403, 4975.079610272075, 4978.303037574742, 4343.283358245885, 4386.539413361615, 4402.251617225047, 4443.355713421568, 4448.399466072071, 5277.6305658603915, 5293.517815011803, 5295.126304159809, 5297.920531192035, 5322.33470816148, 3616.0656488701493, 3633.4004889193516, 3653.415453527423, 3704.499892514503, 3710.7402481826284, 5418.187271909206, 5460.563154947595, 5464.808731694372, 5466.590005749545, 5467.17992301154, 3837.5586807517493, 3841.8847434577006, 3842.7886466244067, 3857.4406711026745, 3864.787436691009, 3889.2999260132883, 3910.3743401055694, 3926.2932672118723, 3926.371780515104, 3927.0771368728324, 4127.9174416512105, 4261.552536983634, 4318.114786468766, 4357.172137293904, 4372.606465418127, 5198.662086964335, 5199.142141546602, 5214.167586823682, 5222.448734860332, 5281.551068159172, 1229.4283158331418, 1321.5837011341396, 1338.3442113364576, 1349.4737052549513, 1361.4554178328747, 878.3456325037888, 894.2890402130322, 909.667971190524, 913.6984795017628, 914.4330515080693, 3971.960280397217, 4038.394240863894, 4040.8483582178937, 4048.9392659110135, 4061.4517040199785, 4653.60444362233, 4677.2750223715375, 4683.367745354401, 4685.718856868599, 4687.718736875799, 4011.8395264189107, 4017.859374921922, 4024.899377515527, 4035.858744943913, 4067.6848368579513, 2368.7631236876173, 2494.713107992568, 2506.448581312108, 2506.5989441689244, 2519.9164359325664, 4412.757298348557, 4424.823007079745, 4430.822767089345, 4451.376807246988, 4461.330800379969, 4780.49804770501, 4785.195769363365, 4790.281457781291, 4840.443349014838, 4862.95137048625, 4429.873660642909, 4437.400950871655, 4703.882402939886, 5096.261042148942, 5103.744812759422, 5383.5962302826665, 5421.241026256406, 5436.53789427903, 5436.646617969819, 5447.210154527651, 5320.228566857862, 5337.386200586827, 5342.973285133549, 5343.866403339947, 5343.893122137458, 4890.24201248807, 5065.898682026265, 5067.594592432522, 5086.338775959101, 5091.490850914879, 3759.642833930772, 3807.7905715184825, 3827.846886124635, 3833.578306386351, 3857.605307329532, 5196.558292545024, 5422.267993820784, 5498.835034948958, 5514.393416724238, 5518.586106041983, 5099.796008159632, 5204.0892843752945, 5216.608754343515, 5230.529252367305, 5240.921386179287, 5218.295530103387, 5224.0, 5224.52979231871, 5237.371515418175, 5243.973780131075, 5009.949900500948, 5121.667091639031, 5142.228665700025, 5162.6386152968935, 5165.66084489031, 5269.394019687785, 5277.709725965109, 5279.31368922053, 5281.392639846313, 5291.285676433632, 5142.845714628567, 5150.768215430239, 5159.767810448464, 5175.1019429119815, 5178.404483484447], "value": 3851.7218955999524, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.8208501619546, 660.606938871372, 726.0052284327151, 754.466321654472, 760.4144808497457, 14002.929985350072, 14333.569992900204, 14663.486777962773, 14716.411343546246, 14790.556283311491, 13732.313384330793, 13749.65625859354, 13788.793168102486, 13837.377318020688, 13900.0, 647.876903388357, 783.3106865957964, 804.6620419423826, 807.3621838747382, 808.9635966381527, 760.794585461925, 809.2918696140877, 812.5084323983993, 814.7392834293029, 817.6320655704927, 854.7521218846528, 857.9184977427135, 858.2618947705, 858.669412276275, 859.5487369131225, 854.2226573817827, 854.2738672128703, 855.3713020929612, 855.6106971328031, 856.0668870930715, 622.841175500249, 622.8941080016363, 622.9968850155766, 623.5416968528128, 623.7411474238186, 13379.397927093305, 13380.397882095232, 13390.464381424732, 13429.798553021616, 13443.798343024862, 13918.164910105324, 13977.72044559103, 14016.75731882904, 14159.78760318596, 14407.927960360235, 10433.739156521071, 10571.78856422875, 10583.312084714546, 10625.521851516623, 10698.786024279549, 3331.1172539276868, 3366.983165084159, 3374.5950485941844, 3399.711024562915, 3484.233468636896, 46262.53737462616, 46959.0, 47782.761086194696, 68919.65540172317, 70629.0, 10507.264491485523, 10545.9472702636, 10665.146788256921, 10727.83908241377, 10823.67528974132, 17251.0, 18013.819861801476, 19043.143058562397, 19077.523061923286, 19180.904095479433, 7101.360877521048, 7109.964450177819, 7185.712571497082, 7200.423966082701, 7289.4168466523615, 3758.4550240215017, 3772.981135094307, 3782.7730336179916, 3817.84728610858, 3840.0, 2952.630921134858, 3032.4844776388068, 3056.251218451449, 3067.7545796336685, 3070.3398769264713, 512.602732882012, 519.5843325339789, 526.8814516733781, 526.9604779641542, 532.4196625678029, 551.48987186852, 582.1645938078871, 583.6731430398991, 594.2601461180772, 602.3434456442499, 8428.4942903426, 8596.312295016383, 8730.388872778845, 8808.339374546935, 8835.293176545862, 585.2859511396175, 604.1602172979561, 605.4944121658376, 625.4527288622455, 629.1380808292669, 3876.321643712339, 3880.0881792778673, 3904.2972264992572, 3968.3849003404516, 4080.6939479539155, 61958.38041619616, 62100.37899621036, 63164.36835631585, 75867.0, 92277.0, 75235.0, 76825.6158719214, 78552.60723696345, 78869.0, 80217.59891200507, 66641.0, 69744.65127674329, 70974.2902570978, 71658.0, 72731.0, 8207.974003249594, 8917.331200159884, 9025.187733104052, 9129.269658427176, 9241.768955775891, 32165.839170803996, 41870.58129418667, 42119.57880421157, 42858.0, 43236.567634323255, 54543.0, 54683.0, 54683.45316546943, 65477.34522654903, 67012.664936675, 11378.146639001943, 12013.81979270329, 12120.33338166374, 12135.696607584881, 12466.688332791753, 13256.08388972125, 13263.86736132665, 13402.329883505981, 13533.796993044914, 13615.0, 11796.410179491162, 11796.94101529487, 12291.385430728249, 12533.74932501363, 12598.370081496072, 11928.300379468814, 11959.282443053444, 12317.815232771336, 12400.56598019065, 12678.049146313879, 12165.513379465076, 12244.387780611112, 12491.312977785945, 12850.614481565568, 12971.156874803108, 9493.762655933657, 9904.42919525889, 10191.439470829175, 10364.429956352473, 10499.94750026245, 10410.427426491615, 10608.469576521298, 10651.946740266249, 10706.0, 10776.245662803529], "value": 6656.110260355834, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 111.0, 115.0, 116.0, 117.0, 117.0, 115.0, 116.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 151.0, 194.0, 122.0, 156.0, 144.0, 132.0, 180.0, 124.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 166.0, 169.0, 163.0, 163.0, 163.0, 163.0, 162.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 173.0, 76.0, 77.0, 77.0, 76.0, 160.0, 79.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 161.0, 86.0, 86.0, 86.0, 146.0, 87.0, 87.0, 137.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 121.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 151.0, 149.0, 147.0, 147.0, 150.0, 147.0, 146.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 64.0, 64.0, 61.0, 63.0, 64.0, 63.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 79.0, 79.0, 80.0, 79.0, 82.0, 82.0, 81.0, 84.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 141.0, 142.0, 131.0, 141.0, 144.0, 130.0, 149.0, 144.0, 140.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 171.0, 174.0, 170.0, 174.0, 168.0, 174.0, 167.0, 174.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 72.0, 69.0, 68.0, 67.0, 69.0, 68.0, 68.0], "value": 69.2, "unit": "score"}]}]} 06:35:26 INFO - Return code: 0 06:35:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:26 ERROR - # TBPL SUCCESS # 06:35:26 INFO - Running post-action listener: _resource_record_post_action 06:35:26 INFO - [mozharness: 2016-08-10 13:35:26.421804Z] Finished run-tests step (success) 06:35:26 INFO - Running post-run listener: _resource_record_post_run 06:35:26 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524476416; Read time: 16; Write time: 492052 06:35:26 INFO - TinderboxPrint: CPU usage
13.4% 06:35:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:35:26 INFO - TinderboxPrint: I/O write bytes / time
524,476,416 / 492,052 06:35:26 INFO - TinderboxPrint: CPU idle
8,273.9 (86.6%) 06:35:26 INFO - TinderboxPrint: CPU user
1,220.4 (12.8%) 06:35:26 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239190016; Read time: 0; Write time: 263336 06:35:26 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 285286400; Read time: 0; Write time: 228716 06:35:27 INFO - Running post-run listener: _upload_blobber_files 06:35:27 INFO - Blob upload gear active. 06:35:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:27 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 06:35:27 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'] 06:35:27 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 06:35:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:30 INFO - (blobuploader) - INFO - Done attempting. 06:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:31 INFO - (blobuploader) - INFO - Done attempting. 06:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:32 INFO - (blobuploader) - INFO - Done attempting. 06:35:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:32 INFO - Return code: 0 06:35:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2f763f20090fbb45c106724a25364e13c3af99308f076ab2e9bfaba71de11512d6f318c280b956587e80326b881c90f31fcfc13b89224bc6db2525c91dc0345", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9f71984b2d31f00380c714ffb6d02ea333631818a6e9a3fb7c70a457758944e2e3e374fa4369239fccc664d49dea1a345594585ad01a1403cb82181c56f60d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63458c26071d7f97590783a878690a34256708dcd7148454b638a8cc63e97df0009d9c7c66aeae996be4ed76467af3e29b2de5ac8d48ad934915f080f686ea08"} 06:35:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:32 INFO - Contents: 06:35:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2f763f20090fbb45c106724a25364e13c3af99308f076ab2e9bfaba71de11512d6f318c280b956587e80326b881c90f31fcfc13b89224bc6db2525c91dc0345", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9f71984b2d31f00380c714ffb6d02ea333631818a6e9a3fb7c70a457758944e2e3e374fa4369239fccc664d49dea1a345594585ad01a1403cb82181c56f60d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63458c26071d7f97590783a878690a34256708dcd7148454b638a8cc63e97df0009d9c7c66aeae996be4ed76467af3e29b2de5ac8d48ad934915f080f686ea08"} 06:35:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:32 INFO - Copying logs to upload dir... 06:35:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.933009 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-10 06:35:31.331155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 06:35:31.334652) ========= 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-1470834896.491389-837617105 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/f2f763f20090fbb45c106724a25364e13c3af99308f076ab2e9bfaba71de11512d6f318c280b956587e80326b881c90f31fcfc13b89224bc6db2525c91dc0345", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9f71984b2d31f00380c714ffb6d02ea333631818a6e9a3fb7c70a457758944e2e3e374fa4369239fccc664d49dea1a345594585ad01a1403cb82181c56f60d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63458c26071d7f97590783a878690a34256708dcd7148454b638a8cc63e97df0009d9c7c66aeae996be4ed76467af3e29b2de5ac8d48ad934915f080f686ea08"} build_url:https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/UplTwkyuTwqvccbb8WyCsA/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/f2f763f20090fbb45c106724a25364e13c3af99308f076ab2e9bfaba71de11512d6f318c280b956587e80326b881c90f31fcfc13b89224bc6db2525c91dc0345", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb9f71984b2d31f00380c714ffb6d02ea333631818a6e9a3fb7c70a457758944e2e3e374fa4369239fccc664d49dea1a345594585ad01a1403cb82181c56f60d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/63458c26071d7f97590783a878690a34256708dcd7148454b638a8cc63e97df0009d9c7c66aeae996be4ed76467af3e29b2de5ac8d48ad934915f080f686ea08"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 06:35:31.360360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:35:31.360696) ========= 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-1470834896.491389-837617105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 06:35:31.445260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 06:35:31.445573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 06:35:31.445954) ========= ========= Total master_lag: 0.17 =========