builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1472917284.33 results: success (0) buildid: 20160903071749 builduid: 63f212c225e14be9917090e32f177c6e revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.343434) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.344010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.344301) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.390554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.390841) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-03 08:41:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-09-03 08:41:24 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.553802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.554421) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018615 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:24.604407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 08:41:24.604714) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bcab45259b4fe5787d0d6fea16067e763f2a11ea --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 bcab45259b4fe5787d0d6fea16067e763f2a11ea --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=14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-03 08:41:25,053 truncating revision to first 12 chars 2016-09-03 08:41:25,054 Setting DEBUG logging. 2016-09-03 08:41:25,054 attempt 1/10 2016-09-03 08:41:25,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bcab45259b4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 08:41:25,773 unpacking tar archive at: fx-team-bcab45259b4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 08:41:25.674099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:25.674434) ========= script_repo_revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:25.683430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:25.683724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 08:41:25.694487) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-03 08:41:25.694757) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:26 INFO - MultiFileLogger online at 20160903 08:41:26 in /builds/slave/test 08:41:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 08:41:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:26 INFO - {'append_to_log': False, 08:41:26 INFO - 'base_work_dir': '/builds/slave/test', 08:41:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:41:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:26 INFO - 'branch': 'Fx-Team-Non-PGO', 08:41:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:26 INFO - 'config_files': ('talos/linux_config.py',), 08:41:26 INFO - 'default_actions': ('clobber', 08:41:26 INFO - 'read-buildbot-config', 08:41:26 INFO - 'download-and-extract', 08:41:26 INFO - 'populate-webroot', 08:41:26 INFO - 'create-virtualenv', 08:41:26 INFO - 'install', 08:41:26 INFO - 'run-tests'), 08:41:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:26 INFO - 'download_minidump_stackwalk': True, 08:41:26 INFO - 'download_symbols': 'ondemand', 08:41:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:26 INFO - 'installer_path': 'installer.exe', 08:41:26 INFO - 'log_level': 'info', 08:41:26 INFO - 'log_name': 'talos', 08:41:26 INFO - 'log_to_console': True, 08:41:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:26 INFO - 'opt_config_files': (), 08:41:26 INFO - 'pip_index': False, 08:41:26 INFO - 'sps_profile': False, 08:41:26 INFO - 'sps_profile_interval': 0, 08:41:26 INFO - 'suite': 'dromaeojs', 08:41:26 INFO - 'system_bits': '32', 08:41:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:26 INFO - 'title': 'talos-linux64-ix-036', 08:41:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:26 INFO - 'use_talos_json': True, 08:41:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:26 INFO - 'work_dir': 'build'} 08:41:26 INFO - [mozharness: 2016-09-03 15:41:26.242613Z] Running clobber step. 08:41:26 INFO - Running pre-action listener: _resource_record_pre_action 08:41:26 INFO - Running main action method: clobber 08:41:26 INFO - rmtree: /builds/slave/test/build 08:41:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:26 INFO - Running post-action listener: _resource_record_post_action 08:41:26 INFO - [mozharness: 2016-09-03 15:41:26.703585Z] Finished clobber step (success) 08:41:26 INFO - [mozharness: 2016-09-03 15:41:26.703686Z] Running read-buildbot-config step. 08:41:26 INFO - Running pre-action listener: _resource_record_pre_action 08:41:26 INFO - Running main action method: read_buildbot_config 08:41:26 INFO - Using buildbot properties: 08:41:26 INFO - { 08:41:26 INFO - "project": "", 08:41:26 INFO - "product": "firefox", 08:41:26 INFO - "script_repo_revision": "production", 08:41:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:41:26 INFO - "repository": "", 08:41:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:41:26 INFO - "buildid": "20160903071749", 08:41:26 INFO - "pgo_build": "False", 08:41:26 INFO - "basedir": "/builds/slave/test", 08:41:26 INFO - "buildnumber": 2130, 08:41:26 INFO - "slavename": "talos-linux64-ix-036", 08:41:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:41:26 INFO - "platform": "ubuntu64_hw", 08:41:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:41:26 INFO - "branch": "fx-team", 08:41:26 INFO - "repo_path": "integration/fx-team", 08:41:26 INFO - "revision": "bcab45259b4fe5787d0d6fea16067e763f2a11ea", 08:41:26 INFO - "stage_platform": "linux64", 08:41:26 INFO - "builduid": "63f212c225e14be9917090e32f177c6e", 08:41:26 INFO - "slavebuilddir": "test" 08:41:26 INFO - } 08:41:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:41:26 INFO - Running post-action listener: _resource_record_post_action 08:41:26 INFO - [mozharness: 2016-09-03 15:41:26.706121Z] Finished read-buildbot-config step (success) 08:41:26 INFO - [mozharness: 2016-09-03 15:41:26.706212Z] Running download-and-extract step. 08:41:26 INFO - Running pre-action listener: _resource_record_pre_action 08:41:26 INFO - Running main action method: download_and_extract 08:41:26 INFO - mkdir: /builds/slave/test/build/tests 08:41:26 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')]} 08:41:26 INFO - trying https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:41:26 INFO - Downloading https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:27 INFO - Downloaded 1361 bytes. 08:41:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:41:27 INFO - Using the following test package requirements: 08:41:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:41:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:41:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'jsshell-linux-x86_64.zip'], 08:41:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:41:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:41:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:41:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:41:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:41:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:27 INFO - trying https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:41:27 INFO - Downloading https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:29 INFO - Downloaded 20335228 bytes. 08:41:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:41:33 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 08:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:33 INFO - trying https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:41:33 INFO - Downloading https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:34 INFO - Downloaded 20335228 bytes. 08:41:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:41:38 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')]} 08:41:38 INFO - trying https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:38 INFO - Downloading https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:40 INFO - Downloaded 14413998 bytes. 08:41:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:40 INFO - trying https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:41:40 INFO - Downloading https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/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 08:41:42 INFO - Downloaded 55763027 bytes. 08:41:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:41:42 INFO - mkdir: /builds/slave/test/properties 08:41:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:42 INFO - Contents: 08:41:42 INFO - build_url:https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:41:43 INFO - Running post-action listener: _resource_record_post_action 08:41:43 INFO - Running post-action listener: set_extra_try_arguments 08:41:43 INFO - [mozharness: 2016-09-03 15:41:43.299426Z] Finished download-and-extract step (success) 08:41:43 INFO - [mozharness: 2016-09-03 15:41:43.299652Z] Running populate-webroot step. 08:41:43 INFO - Running pre-action listener: _resource_record_pre_action 08:41:43 INFO - Running main action method: populate_webroot 08:41:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:43 INFO - '--tppagecycles', 08:41:43 INFO - '7'], 08:41:43 INFO - 'tests': ['tsvgm']}}, 08:41:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['damp', 'tps']}, 08:41:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'tests': ['damp', 'tps']}, 08:41:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['dromaeo_dom']}, 08:41:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['basic_compositor_video']}, 08:41:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:41:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['a11yr', 08:41:43 INFO - 'ts_paint', 08:41:43 INFO - 'tpaint', 08:41:43 INFO - 'sessionrestore', 08:41:43 INFO - 'sessionrestore_no_auto_restore', 08:41:43 INFO - 'tabpaint']}, 08:41:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:43 INFO - 'ts_paint', 08:41:43 INFO - 'tpaint', 08:41:43 INFO - 'sessionrestore', 08:41:43 INFO - 'sessionrestore_no_auto_restore', 08:41:43 INFO - 'tabpaint']}, 08:41:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:43 INFO - 'ts_paint', 08:41:43 INFO - 'tpaint', 08:41:43 INFO - 'sessionrestore', 08:41:43 INFO - 'sessionrestore_no_auto_restore', 08:41:43 INFO - 'tabpaint']}, 08:41:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:43 INFO - 'ts_paint', 08:41:43 INFO - 'tpaint', 08:41:43 INFO - 'sessionrestore', 08:41:43 INFO - 'sessionrestore_no_auto_restore', 08:41:43 INFO - 'tabpaint']}, 08:41:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['a11yr', 08:41:43 INFO - 'ts_paint', 08:41:43 INFO - 'tpaint', 08:41:43 INFO - 'sessionrestore', 08:41:43 INFO - 'sessionrestore_no_auto_restore', 08:41:43 INFO - 'tabpaint']}, 08:41:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['a11yr', 08:41:43 INFO - 'ts_paint', 08:41:43 INFO - 'tpaint', 08:41:43 INFO - 'sessionrestore', 08:41:43 INFO - 'sessionrestore_no_auto_restore', 08:41:43 INFO - 'tabpaint']}, 08:41:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['tsvgx', 08:41:43 INFO - 'tsvgr_opacity', 08:41:43 INFO - 'tart', 08:41:43 INFO - 'tscrollx', 08:41:43 INFO - 'cart']}, 08:41:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:43 INFO - 'tsvgr_opacity', 08:41:43 INFO - 'tart', 08:41:43 INFO - 'tscrollx', 08:41:43 INFO - 'cart']}, 08:41:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'talos_options': ['--disable-e10s'], 08:41:43 INFO - 'tests': ['tp5o']}, 08:41:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'tests': ['tp5o']}, 08:41:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'talos_options': ['--disable-e10s', 08:41:43 INFO - '--xperf_path', 08:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:43 INFO - 'tests': ['tp5n']}, 08:41:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:43 INFO - 'talos_options': ['--xperf_path', 08:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:43 INFO - 'tests': ['tp5n']}}, 08:41:43 INFO - 'talos.zip': {'path': '', 08:41:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:43 INFO - Running post-action listener: _resource_record_post_action 08:41:43 INFO - [mozharness: 2016-09-03 15:41:43.316381Z] Finished populate-webroot step (success) 08:41:43 INFO - [mozharness: 2016-09-03 15:41:43.316470Z] Running create-virtualenv step. 08:41:43 INFO - Running pre-action listener: _resource_record_pre_action 08:41:43 INFO - Running main action method: create_virtualenv 08:41:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:43 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 08:41:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:43 INFO - Using real prefix '/usr' 08:41:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:45 INFO - Installing pip.................done. 08:41:45 INFO - Return code: 0 08:41:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:41:45 INFO - Using env: {'DISPLAY': ':0', 08:41:45 INFO - 'HOME': '/home/cltbld', 08:41:45 INFO - 'LANG': 'en_US.UTF-8', 08:41:45 INFO - 'LANGUAGE': 'en_US:en', 08:41:45 INFO - 'LOGNAME': 'cltbld', 08:41:45 INFO - 'MAIL': '/var/mail/cltbld', 08:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:45 INFO - 'MOZ_NO_REMOTE': '1', 08:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:45 INFO - 'NO_EM_RESTART': '1', 08:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:45 INFO - 'PWD': '/builds/slave/test', 08:41:45 INFO - 'SHELL': '/bin/bash', 08:41:45 INFO - 'SHLVL': '1', 08:41:45 INFO - 'TERM': 'linux', 08:41:45 INFO - 'TMOUT': '86400', 08:41:45 INFO - 'USER': 'cltbld', 08:41:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:45 INFO - '_': '/tools/buildbot/bin/python'} 08:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:46 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 08:41:46 INFO - Cleaning up... 08:41:46 INFO - Return code: 0 08:41:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:41:46 INFO - Using env: {'DISPLAY': ':0', 08:41:46 INFO - 'HOME': '/home/cltbld', 08:41:46 INFO - 'LANG': 'en_US.UTF-8', 08:41:46 INFO - 'LANGUAGE': 'en_US:en', 08:41:46 INFO - 'LOGNAME': 'cltbld', 08:41:46 INFO - 'MAIL': '/var/mail/cltbld', 08:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:46 INFO - 'MOZ_NO_REMOTE': '1', 08:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:46 INFO - 'NO_EM_RESTART': '1', 08:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:46 INFO - 'PWD': '/builds/slave/test', 08:41:46 INFO - 'SHELL': '/bin/bash', 08:41:46 INFO - 'SHLVL': '1', 08:41:46 INFO - 'TERM': 'linux', 08:41:46 INFO - 'TMOUT': '86400', 08:41:46 INFO - 'USER': 'cltbld', 08:41:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:46 INFO - '_': '/tools/buildbot/bin/python'} 08:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:46 INFO - Downloading/unpacking psutil>=3.1.1 08:41:46 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 08:41:46 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 08:41:46 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 08:41:46 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 08:41:46 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 08:41:46 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 08:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:48 INFO - Installing collected packages: psutil 08:41:48 INFO - Running setup.py install for psutil 08:41:48 INFO - building 'psutil._psutil_linux' extension 08:41:48 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 08:41:48 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 08:41:48 INFO - building 'psutil._psutil_posix' extension 08:41:48 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 08:41:48 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 08:41:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:48 INFO - Successfully installed psutil 08:41:48 INFO - Cleaning up... 08:41:48 INFO - Return code: 0 08:41:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:48 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')]} 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 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')]} 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:41:48 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 08:41:48 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 08:41:48 INFO - Using env: {'DISPLAY': ':0', 08:41:48 INFO - 'HOME': '/home/cltbld', 08:41:48 INFO - 'LANG': 'en_US.UTF-8', 08:41:48 INFO - 'LANGUAGE': 'en_US:en', 08:41:48 INFO - 'LOGNAME': 'cltbld', 08:41:48 INFO - 'MAIL': '/var/mail/cltbld', 08:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:48 INFO - 'MOZ_NO_REMOTE': '1', 08:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:48 INFO - 'NO_EM_RESTART': '1', 08:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:48 INFO - 'PWD': '/builds/slave/test', 08:41:48 INFO - 'SHELL': '/bin/bash', 08:41:48 INFO - 'SHLVL': '1', 08:41:48 INFO - 'TERM': 'linux', 08:41:48 INFO - 'TMOUT': '86400', 08:41:48 INFO - 'USER': 'cltbld', 08:41:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:48 INFO - '_': '/tools/buildbot/bin/python'} 08:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:51 INFO - Installing collected packages: mozsystemmonitor 08:41:51 INFO - Running setup.py install for mozsystemmonitor 08:41:51 INFO - Successfully installed mozsystemmonitor 08:41:51 INFO - Cleaning up... 08:41:51 INFO - Return code: 0 08:41:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:51 INFO - Using env: {'DISPLAY': ':0', 08:41:51 INFO - 'HOME': '/home/cltbld', 08:41:51 INFO - 'LANG': 'en_US.UTF-8', 08:41:51 INFO - 'LANGUAGE': 'en_US:en', 08:41:51 INFO - 'LOGNAME': 'cltbld', 08:41:51 INFO - 'MAIL': '/var/mail/cltbld', 08:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:51 INFO - 'MOZ_NO_REMOTE': '1', 08:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:51 INFO - 'NO_EM_RESTART': '1', 08:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:51 INFO - 'PWD': '/builds/slave/test', 08:41:51 INFO - 'SHELL': '/bin/bash', 08:41:51 INFO - 'SHLVL': '1', 08:41:51 INFO - 'TERM': 'linux', 08:41:51 INFO - 'TMOUT': '86400', 08:41:51 INFO - 'USER': 'cltbld', 08:41:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:51 INFO - '_': '/tools/buildbot/bin/python'} 08:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:51 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 08:41:51 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 08:41:51 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 08:41:51 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 08:41:51 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 08:41:51 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 08:41:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:53 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 08:41:53 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 08:41:53 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 08:41:53 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 08:41:53 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 08:41:53 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 08:41:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:53 INFO - warning: no files found matching '*.txt' 08:41:53 INFO - no previously-included directories found matching 'build' 08:41:53 INFO - no previously-included directories found matching 'dist' 08:41:53 INFO - no previously-included directories found matching '.git*' 08:41:53 INFO - Installing collected packages: jsonschema, functools32 08:41:53 INFO - Running setup.py install for functools32 08:41:53 INFO - warning: no files found matching '*.txt' 08:41:53 INFO - no previously-included directories found matching 'build' 08:41:53 INFO - no previously-included directories found matching 'dist' 08:41:53 INFO - no previously-included directories found matching '.git*' 08:41:53 INFO - Successfully installed jsonschema functools32 08:41:53 INFO - Cleaning up... 08:41:53 INFO - Return code: 0 08:41:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:53 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')]} 08:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:53 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')]} 08:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:53 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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:41:53 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 08:41:53 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 08:41:53 INFO - Using env: {'DISPLAY': ':0', 08:41:53 INFO - 'HOME': '/home/cltbld', 08:41:53 INFO - 'LANG': 'en_US.UTF-8', 08:41:53 INFO - 'LANGUAGE': 'en_US:en', 08:41:53 INFO - 'LOGNAME': 'cltbld', 08:41:53 INFO - 'MAIL': '/var/mail/cltbld', 08:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:53 INFO - 'MOZ_NO_REMOTE': '1', 08:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:53 INFO - 'NO_EM_RESTART': '1', 08:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:53 INFO - 'PWD': '/builds/slave/test', 08:41:53 INFO - 'SHELL': '/bin/bash', 08:41:53 INFO - 'SHLVL': '1', 08:41:53 INFO - 'TERM': 'linux', 08:41:53 INFO - 'TMOUT': '86400', 08:41:53 INFO - 'USER': 'cltbld', 08:41:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:53 INFO - '_': '/tools/buildbot/bin/python'} 08:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:53 INFO - Cleaning up... 08:41:53 INFO - Return code: 0 08:41:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:53 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')]} 08:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:53 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')]} 08:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:53 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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:41:53 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 08:41:53 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 08:41:53 INFO - Using env: {'DISPLAY': ':0', 08:41:53 INFO - 'HOME': '/home/cltbld', 08:41:53 INFO - 'LANG': 'en_US.UTF-8', 08:41:53 INFO - 'LANGUAGE': 'en_US:en', 08:41:53 INFO - 'LOGNAME': 'cltbld', 08:41:53 INFO - 'MAIL': '/var/mail/cltbld', 08:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:53 INFO - 'MOZ_NO_REMOTE': '1', 08:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:53 INFO - 'NO_EM_RESTART': '1', 08:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:53 INFO - 'PWD': '/builds/slave/test', 08:41:53 INFO - 'SHELL': '/bin/bash', 08:41:53 INFO - 'SHLVL': '1', 08:41:53 INFO - 'TERM': 'linux', 08:41:53 INFO - 'TMOUT': '86400', 08:41:53 INFO - 'USER': 'cltbld', 08:41:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:53 INFO - '_': '/tools/buildbot/bin/python'} 08:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 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 08:41:56 INFO - Downloading docopt-0.6.1.tar.gz 08:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:56 INFO - Running setup.py install for blobuploader 08:41:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:56 INFO - Running setup.py install for requests 08:41:57 INFO - Running setup.py install for docopt 08:41:57 INFO - Successfully installed blobuploader requests docopt 08:41:57 INFO - Cleaning up... 08:41:57 INFO - Return code: 0 08:41:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:57 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')]} 08:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:57 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')]} 08:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:57 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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:41:57 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 08:41:57 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 08:41:57 INFO - Using env: {'DISPLAY': ':0', 08:41:57 INFO - 'HOME': '/home/cltbld', 08:41:57 INFO - 'LANG': 'en_US.UTF-8', 08:41:57 INFO - 'LANGUAGE': 'en_US:en', 08:41:57 INFO - 'LOGNAME': 'cltbld', 08:41:57 INFO - 'MAIL': '/var/mail/cltbld', 08:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:57 INFO - 'MOZ_NO_REMOTE': '1', 08:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:57 INFO - 'NO_EM_RESTART': '1', 08:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:57 INFO - 'PWD': '/builds/slave/test', 08:41:57 INFO - 'SHELL': '/bin/bash', 08:41:57 INFO - 'SHLVL': '1', 08:41:57 INFO - 'TERM': 'linux', 08:41:57 INFO - 'TMOUT': '86400', 08:41:57 INFO - 'USER': 'cltbld', 08:41:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:57 INFO - '_': '/tools/buildbot/bin/python'} 08:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:57 INFO - Running setup.py (path:/tmp/pip-doXYbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:57 INFO - Running setup.py (path:/tmp/pip-jGXBYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:57 INFO - Running setup.py (path:/tmp/pip-RqwOQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:57 INFO - Running setup.py (path:/tmp/pip-JkFIa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:57 INFO - Running setup.py (path:/tmp/pip-Maz5OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:57 INFO - Running setup.py (path:/tmp/pip-PpPvV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:58 INFO - Running setup.py (path:/tmp/pip-S7KFT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:58 INFO - Running setup.py (path:/tmp/pip-R5C9xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:58 INFO - Running setup.py (path:/tmp/pip-5_kRQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:58 INFO - Running setup.py (path:/tmp/pip-_VIHBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:58 INFO - Running setup.py (path:/tmp/pip-N5mfgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:58 INFO - Running setup.py (path:/tmp/pip-RpAXOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:58 INFO - Running setup.py (path:/tmp/pip-mkAKvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:58 INFO - Running setup.py (path:/tmp/pip-A8ajzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:58 INFO - Running setup.py (path:/tmp/pip-TsQCh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:58 INFO - Running setup.py (path:/tmp/pip-km0QZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:58 INFO - Running setup.py (path:/tmp/pip-KXmnve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:58 INFO - Running setup.py install for manifestparser 08:41:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:58 INFO - Running setup.py install for mozcrash 08:41:59 INFO - Running setup.py install for mozdebug 08:41:59 INFO - Running setup.py install for mozdevice 08:41:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Running setup.py install for mozfile 08:41:59 INFO - Running setup.py install for mozhttpd 08:41:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Running setup.py install for mozinfo 08:41:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Running setup.py install for mozInstall 08:41:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Running setup.py install for mozleak 08:41:59 INFO - Running setup.py install for mozlog 08:41:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Running setup.py install for moznetwork 08:41:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:59 INFO - Running setup.py install for mozprocess 08:42:00 INFO - Running setup.py install for mozprofile 08:42:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:00 INFO - Running setup.py install for mozrunner 08:42:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:00 INFO - Running setup.py install for mozscreenshot 08:42:00 INFO - Running setup.py install for moztest 08:42:00 INFO - Running setup.py install for mozversion 08:42:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:00 INFO - Cleaning up... 08:42:00 INFO - Return code: 0 08:42:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:42:00 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 08:42:00 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 08:42:00 INFO - Using env: {'DISPLAY': ':0', 08:42:00 INFO - 'HOME': '/home/cltbld', 08:42:00 INFO - 'LANG': 'en_US.UTF-8', 08:42:00 INFO - 'LANGUAGE': 'en_US:en', 08:42:00 INFO - 'LOGNAME': 'cltbld', 08:42:00 INFO - 'MAIL': '/var/mail/cltbld', 08:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:00 INFO - 'MOZ_NO_REMOTE': '1', 08:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:00 INFO - 'NO_EM_RESTART': '1', 08:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:00 INFO - 'PWD': '/builds/slave/test', 08:42:00 INFO - 'SHELL': '/bin/bash', 08:42:00 INFO - 'SHLVL': '1', 08:42:00 INFO - 'TERM': 'linux', 08:42:00 INFO - 'TMOUT': '86400', 08:42:00 INFO - 'USER': 'cltbld', 08:42:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:00 INFO - '_': '/tools/buildbot/bin/python'} 08:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:00 INFO - Running setup.py (path:/tmp/pip-ajDQ0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:00 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)) 08:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:00 INFO - Running setup.py (path:/tmp/pip-DDzDVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:01 INFO - Running setup.py (path:/tmp/pip-c5RFOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:01 INFO - Running setup.py (path:/tmp/pip-koR27j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:01 INFO - Running setup.py (path:/tmp/pip-E6CImL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:01 INFO - Running setup.py (path:/tmp/pip-Rz7Ulm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:01 INFO - Running setup.py (path:/tmp/pip-O8uJPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:01 INFO - Running setup.py (path:/tmp/pip-LCiKtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:01 INFO - Running setup.py (path:/tmp/pip-LWUbA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:01 INFO - Running setup.py (path:/tmp/pip-YG6pV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:01 INFO - Running setup.py (path:/tmp/pip-C4XKa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:01 INFO - Running setup.py (path:/tmp/pip-iAzsTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:01 INFO - Running setup.py (path:/tmp/pip-AjM9BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:01 INFO - Running setup.py (path:/tmp/pip-rhau8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:01 INFO - Running setup.py (path:/tmp/pip-BRRLmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:01 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)) 08:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:01 INFO - Running setup.py (path:/tmp/pip-oBk8Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:02 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)) 08:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:02 INFO - Running setup.py (path:/tmp/pip-zYG30f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:02 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)) 08:42:02 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)) 08:42:02 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)) 08:42:02 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)) 08:42:02 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)) 08:42:02 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)) 08:42:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:03 INFO - Downloading blessings-1.6.tar.gz 08:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:04 INFO - Installing collected packages: blessings 08:42:04 INFO - Running setup.py install for blessings 08:42:04 INFO - Successfully installed blessings 08:42:04 INFO - Cleaning up... 08:42:04 INFO - Return code: 0 08:42:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:04 INFO - Reading from file tmpfile_stdout 08:42:04 INFO - Current package versions: 08:42:04 INFO - argparse == 1.2.1 08:42:04 INFO - blessings == 1.6 08:42:04 INFO - blobuploader == 1.2.4 08:42:04 INFO - docopt == 0.6.1 08:42:04 INFO - functools32 == 3.2.3-2 08:42:04 INFO - jsonschema == 2.5.1 08:42:04 INFO - manifestparser == 1.1 08:42:04 INFO - mozInstall == 1.12 08:42:04 INFO - mozcrash == 0.17 08:42:04 INFO - mozdebug == 0.1 08:42:04 INFO - mozdevice == 0.48 08:42:04 INFO - mozfile == 1.2 08:42:04 INFO - mozhttpd == 0.7 08:42:04 INFO - mozinfo == 0.9 08:42:04 INFO - mozleak == 0.1 08:42:04 INFO - mozlog == 3.3 08:42:04 INFO - moznetwork == 0.27 08:42:04 INFO - mozprocess == 0.23 08:42:04 INFO - mozprofile == 0.28 08:42:04 INFO - mozrunner == 6.12 08:42:04 INFO - mozscreenshot == 0.1 08:42:04 INFO - mozsystemmonitor == 0.3 08:42:04 INFO - moztest == 0.7 08:42:04 INFO - mozversion == 1.4 08:42:04 INFO - psutil == 3.1.1 08:42:04 INFO - requests == 1.2.3 08:42:04 INFO - wsgiref == 0.1.2 08:42:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:04 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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:42:04 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 08:42:04 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 08:42:04 INFO - Using env: {'DISPLAY': ':0', 08:42:04 INFO - 'HOME': '/home/cltbld', 08:42:04 INFO - 'LANG': 'en_US.UTF-8', 08:42:04 INFO - 'LANGUAGE': 'en_US:en', 08:42:04 INFO - 'LOGNAME': 'cltbld', 08:42:04 INFO - 'MAIL': '/var/mail/cltbld', 08:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:04 INFO - 'MOZ_NO_REMOTE': '1', 08:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:04 INFO - 'NO_EM_RESTART': '1', 08:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:04 INFO - 'PWD': '/builds/slave/test', 08:42:04 INFO - 'SHELL': '/bin/bash', 08:42:04 INFO - 'SHLVL': '1', 08:42:04 INFO - 'TERM': 'linux', 08:42:04 INFO - 'TMOUT': '86400', 08:42:04 INFO - 'USER': 'cltbld', 08:42:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:04 INFO - '_': '/tools/buildbot/bin/python'} 08:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 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)) 08:42:04 INFO - Cleaning up... 08:42:04 INFO - Return code: 0 08:42:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:04 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 0x7f8fcaf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f29230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', '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 08:42:04 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 08:42:04 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 08:42:04 INFO - Using env: {'DISPLAY': ':0', 08:42:04 INFO - 'HOME': '/home/cltbld', 08:42:04 INFO - 'LANG': 'en_US.UTF-8', 08:42:04 INFO - 'LANGUAGE': 'en_US:en', 08:42:04 INFO - 'LOGNAME': 'cltbld', 08:42:04 INFO - 'MAIL': '/var/mail/cltbld', 08:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:04 INFO - 'MOZ_NO_REMOTE': '1', 08:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:04 INFO - 'NO_EM_RESTART': '1', 08:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:04 INFO - 'PWD': '/builds/slave/test', 08:42:04 INFO - 'SHELL': '/bin/bash', 08:42:04 INFO - 'SHLVL': '1', 08:42:04 INFO - 'TERM': 'linux', 08:42:04 INFO - 'TMOUT': '86400', 08:42:04 INFO - 'USER': 'cltbld', 08:42:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:04 INFO - '_': '/tools/buildbot/bin/python'} 08:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:04 INFO - Cleaning up... 08:42:04 INFO - Return code: 0 08:42:04 INFO - Running post-action listener: _resource_record_post_action 08:42:04 INFO - Running post-action listener: _start_resource_monitoring 08:42:04 INFO - Starting resource monitoring. 08:42:04 INFO - [mozharness: 2016-09-03 15:42:04.920606Z] Finished create-virtualenv step (success) 08:42:04 INFO - [mozharness: 2016-09-03 15:42:04.921078Z] Running install step. 08:42:04 INFO - Running pre-action listener: _resource_record_pre_action 08:42:04 INFO - Running main action method: install 08:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:05 INFO - Reading from file tmpfile_stdout 08:42:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:05 INFO - Reading from file tmpfile_stdout 08:42:05 INFO - Output received: 08:42:05 INFO - Usage: mozinstall [options] installer 08:42:05 INFO - Options: 08:42:05 INFO - -h, --help show this help message and exit 08:42:05 INFO - -d DEST, --destination=DEST 08:42:05 INFO - Directory to install application into. [default: 08:42:05 INFO - "/builds/slave/test"] 08:42:05 INFO - --app=APP Application being installed. [default: firefox] 08:42:05 INFO - mkdir: /builds/slave/test/build/application 08:42:05 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'] 08:42:05 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 08:42:21 INFO - Reading from file tmpfile_stdout 08:42:21 INFO - Output received: 08:42:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:42:21 INFO - Running post-action listener: _resource_record_post_action 08:42:21 INFO - [mozharness: 2016-09-03 15:42:21.336958Z] Finished install step (success) 08:42:21 INFO - [mozharness: 2016-09-03 15:42:21.337316Z] Running run-tests step. 08:42:21 INFO - Running pre-action listener: _resource_record_pre_action 08:42:21 INFO - Running main action method: run_tests 08:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:21 INFO - Python 2.7.3 08:42:21 INFO - Return code: 0 08:42:21 INFO - grabbing minidump binary from tooltool 08:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:21 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 0x1f23090>, '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 0x1f269b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f26e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:21 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 08:42:21 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 08:42:21 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 08:42:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:21 INFO - Return code: 0 08:42:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:42:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:42:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:21 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:42:21 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:42:21 INFO - Using env: {'DISPLAY': ':0', 08:42:21 INFO - 'HOME': '/home/cltbld', 08:42:21 INFO - 'LANG': 'en_US.UTF-8', 08:42:21 INFO - 'LANGUAGE': 'en_US:en', 08:42:21 INFO - 'LOGNAME': 'cltbld', 08:42:21 INFO - 'MAIL': '/var/mail/cltbld', 08:42:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:21 INFO - 'MOZ_NO_REMOTE': '1', 08:42:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:21 INFO - 'NO_EM_RESTART': '1', 08:42:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:21 INFO - 'PWD': '/builds/slave/test', 08:42:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:21 INFO - 'SHELL': '/bin/bash', 08:42:21 INFO - 'SHLVL': '1', 08:42:21 INFO - 'TERM': 'linux', 08:42:21 INFO - 'TMOUT': '86400', 08:42:21 INFO - 'USER': 'cltbld', 08:42:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610', 08:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:21 INFO - '_': '/tools/buildbot/bin/python'} 08:42:21 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:42:21 INFO - mozversion application_buildid: 20160903071749 08:42:21 INFO - mozversion application_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 08:42:21 INFO - mozversion application_display_name: Nightly 08:42:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:21 INFO - mozversion application_name: Firefox 08:42:21 INFO - mozversion application_remotingname: firefox 08:42:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:42:21 INFO - mozversion application_vendor: Mozilla 08:42:21 INFO - mozversion application_version: 51.0a1 08:42:21 INFO - mozversion platform_buildid: 20160903071749 08:42:21 INFO - mozversion platform_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 08:42:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:42:21 INFO - mozversion platform_version: 51.0a1 08:42:21 INFO - using testdate: 1472917341 08:42:21 INFO - actual date: 1472917341 08:42:21 INFO - starting webserver on 'localhost:46802' 08:42:21 INFO - SUITE-START | Running 2 tests 08:42:21 INFO - TEST-START | dromaeo_css 08:42:21 INFO - operating with platform_type : linux_ 08:42:21 INFO - Initialising browser for dromaeo_css test... 08:42:21 INFO - TEST-INFO | started process 32572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8r6Yu/profile http://localhost:46802/getInfo.html) 08:42:26 INFO - PROCESS | 32572 | __metrics Screen width/height:1600/1200 08:42:26 INFO - PROCESS | 32572 | colorDepth:24 08:42:26 INFO - PROCESS | 32572 | Browser inner width/height: 1024/697 08:42:26 INFO - PROCESS | 32572 | __metrics 08:42:27 INFO - PROCESS | 32572 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:42:27 INFO - PROCESS | 32572 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:28 INFO - TEST-INFO | 32572: exit 0 08:42:28 INFO - Browser initialized. 08:42:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:28 INFO - TEST-INFO | started process 32655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8r6Yu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:40 INFO - PROCESS | 32655 | RSS: Main: 180449280 08:42:40 INFO - PROCESS | 32655 | 08:43:32 INFO - PROCESS | 32655 | 1472917412354 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] 08:45:45 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:46802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46802/tests/dromaeo/cssquery-ext.html) 08:45:47 INFO - PROCESS | 32655 | RSS: Main: 291569664 08:45:47 INFO - PROCESS | 32655 | 08:48:50 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:46802/tests/dromaeo/cssquery-ext.html (next: http://localhost:46802/tests/dromaeo/cssquery-jquery.html) 08:48:50 INFO - PROCESS | 32655 | RSS: Main: 281636864 08:48:50 INFO - PROCESS | 32655 | 08:51:52 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:46802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46802/tests/dromaeo/cssquery-mootools.html) 08:51:53 INFO - PROCESS | 32655 | RSS: Main: 218828800 08:51:53 INFO - PROCESS | 32655 | 08:54:55 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:46802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46802/tests/dromaeo/cssquery-prototype.html) 08:54:56 INFO - PROCESS | 32655 | RSS: Main: 257335296 08:54:56 INFO - PROCESS | 32655 | 08:57:59 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:46802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46802/tests/dromaeo/cssquery-yui.html) 08:58:00 INFO - PROCESS | 32655 | RSS: Main: 219480064 08:58:00 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | Cycle 1(1): loaded http://localhost:46802/tests/dromaeo/cssquery-yui.html (next: http://localhost:46802/tests/dromaeo/cssquery-dojo.html) 09:01:03 INFO - PROCESS | 32655 | RSS: Main: 285855744 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | __start_tp_report 09:01:03 INFO - PROCESS | 32655 | _x_x_mozilla_page_load 09:01:03 INFO - PROCESS | 32655 | _x_x_mozilla_page_load_details 09:01:03 INFO - PROCESS | 32655 | |i|pagename|runs| 09:01:03 INFO - PROCESS | 32655 | |0;dojo.html;2596.389848385629;2599.3601421462686;2604.17968339973;2660.7605315521587;2668.3462551674843;4749.90500189996;4763.428388593369;4832.589229915453;4877.3903262092235;4906.067847109051;4748.928766068503;4779.569838714515;4795.904081918359;4812.6390520711;4841.467438581753;4346.282863327548;4375.781210939456;4451.043025749464;4515.209838278304;4589.35748995141;4431.246688063021;4496.9550304497025;4514.142312960544;4514.210013247685;4520.2315606347;4321.481422229353;4335.479742430928;4366.148601022802;4418.116376724636;4437.245668236407;4402.119576084764;4405.5814697604;4406.889827754299;4485.977570112162;4515.61617262533;4419.337099435078;4431.601155895953;4435.578620031092;4444.333349997494;4487.439070116236;4724.220503616899;4790.233562629963;4827.179379505457;4867.245576935546;4931.235658472907;5174.870628234286;5197.922031169498;5200.115980283361;5209.192575150858;5258.395284542288;5186.636935414523;5205.687658740488;5230.843074707765;5298.15229563268;5302.655327403706;4693.812247510062;4816.927746083811;4877;4880.902381952341;4936.185529387682;5339.813106541253;5364.061289274361;5364.678119312775;5418.295621569249;5428.6471379361;5129.589632829365;5162.586993040548;5168.250603662523;5170.560502357342;5229.320188375563;5027.673201241908;5126.307948426989;5163.483651634881;5169.327987361619;5179.559737422286;5168.431472538018;5169.069567477815;5171.974140129275;5214.191800270964;5237.135872580981;5134.435212126663;5154.871128221825;5155.200943853709;5159.303494028258;5219.243209734643;4312.525622181557;4354.56454354562;4398.494173170063;4460.264056430718;4467.597916187558;3851.7111216658864;3852.2680690668685;3891.3384724596885;3929.862454814068;3941.467901833273;4468.530804265571;4470.441194850644;4471.3740076388685;4475.440569928759;4529.886752831139;5031.698098114125;5149.0474262261605;5220.216967454912;5235;5239.502247286502;4418.779061046935;4428.7121337112985;4437.755923424243;4450.844220452269;4503.2569626012;4699.459562150328;4702.694324868872;4704.29435584665;4706.505816889246;4760.143174228672;4791.377120974391;4841.176999910094;4846.927296090491;4894.657373983787;4936.6297527685565;5208.166693329049;5214.478552144755;5223.895522089613;5290.365156181283;5297.708626025606;4900.534449227318;4908.6073114151495;4909.042736666316;4916.582090522345;4963.875903102451;4961.479044700254;4967.528084831935;5142.537171654569;5142.742862856917;5145.151050076695;5096.694198348111;5145.948540514697;5152.793888244578;5206.661566998133;5212.739363031757;4996.050750357421;5021.84934451967;5022.924656130234;5024.799008039784;5091.439941606346;4961.751912404293;5017.64876458659;5022.3219865317715;5028.547430731252;5030.170021946338;4993.525615066708;4995.500449954975;4998.0003999201035;5053.974730126326;5059.873503162303;5069.366329208849;5080.923786143285;5082.085224659597;5113.74431278442;5139.691618502902;4850.708957462563;4917.459079501324;4925.876853078702;4959.7272150032095;5005.124103281838 09:01:03 INFO - PROCESS | 32655 | |1;ext.html;539.6627108057464;544.7303584725561;547.5701574264201;571.67128900882;581.1341101758381;28177.577336339946;34408;35623.64376356236;35632.2873542529;38869.61130388695;34629.82685086577;34893.3021339573;34970.82514587424;35019.2996140077;35103.473447898235;7242.203357630657;7511.586862722562;7661.425393095512;7666;7667.501612395205;7213.314735100157;7459.403247740168;7460.25397460255;9464.1482266596;9696.369735967139;9812.50937453128;9876.111149996499;9877.70366888991;9879.456629885353;9888.357256778323;9777.31558790885;9830.655927042519;9842.50787460624;9850.655227067018;9850.753731156707;9632.27757918159;9677.661281855171;9695.321327507078;9697.127258546694;9703.320767546275;33375.83312083448;33636;33693.494597581055;33718;33745.6625433745;2728.0724553651853;2741.6572928383953;2791.6650001999687;2986.3728616990456;3106;26087.347816304555;26397.604035939476;26415.867920660465;26794.637899579662;27115.45769084627;3405.625381208065;3466.376052310583;3509.7192224621967;3630.3283892479976;3633.6729694327373;255651;256390;256941;257915;258612.70693646598;44680.3297950531;44984.3252351215;44995.55004449979;45027.77486112614;45065.54934450679;46810;46825.531744682114;46921.5307846924;46943;46977.295340569915;13034.739305213843;13165.670858228621;13201.20792752438;13204.557156925808;13221.471141154438;10001.549930253155;10033.64882229133;10036.24728145392;10038;10043.246756493292;12958.157719748186;13398.732025359439;13435.932820335836;13449.260290683911;13793.931030344784;4694.201985662446;4763.54746299101;4767.118083154627;4804.73573953429;4931.619146638946;798.4849771897094;823.6417158535936;826.89663792026;827.1934863508152;877.2543338162639;23523.882380587987;25071.749282506942;25180;25209.495810083696;25517.3620659485;860.9870851937226;867.7873920889423;873.362445414838;892.4065496444791;901.4084507042254;12932.547360842325;13011.925349113853;13298.202107873558;13314.600561983156;13424.597262082154;367046;369797;370135;370931;371430;39450.210995779926;40601.59398405978;41123.38314925278;41324.1735165295;41983.790081049396;1066;1079.6868908016745;1107.5237647811357;1108.41808050774;1111.1055600241882;25553.61669574995;26359;26725.866370668024;27147.321316967234;27193.32016699598;36801.26397472089;37229.44155837611;37235.81382093072;37249.441258380604;37354.626453735116;400242;409578;409600;410375;648994;33266.501002484496;33693;34724;35110.29779404448;35573.1106722334;36709.81645091758;36995.26009479741;37153.62846371502;37741.24517509689;37768.244635107694;31842.68157318397;31880.47944178462;31942.520862186622;32116.678833212303;33072.33855322928;32500.674993250712;32565.837170813993;33147.33705325928;33298.66701333052;33683.66316336805;31971;32663.18342041468;32869.835650821595;32912.34175316432;32963.34073318568;29267.70732292735;29669.554956675234;30331;30334.393312134074;30350.392992140474;23770.168044118374;23878.686672233194;23902;24054.87972560126;24212.39469013289 09:01:03 INFO - PROCESS | 32655 | |2;jquery.html;340.6682643744183;344.95515582974224;349.3990336621011;349.69925863757175;371.6766413220497;14624.707505849876;14999.325030373631;15458.84541154588;16400.67198656026;16575;14885.925570372134;14960.551183464513;15064.246787660628;15066;15102.093874367545;4837.806487740495;5052.368453943257;5053.747312634372;5189.377274727038;5434.456554344553;3427.365937301607;5396.973015134939;5424.294841670578;5432.6468779529205;5435.10320797068;5139.897202055957;5355.678659280456;5363.356397232337;5423.945760542403;5433.26650902129;5131.4868513148385;5190.792368305263;5335.253064570963;5354.491323324317;5355.3305836770405;5136.434992150897;5138.30632864566;5142.791444010654;5147.665401748912;5148.407933087706;11583.942080289544;12076.939615301868;17655;19663.41009769709;19776.60446791056;1804.6841802684478;1885.792562818089;1951.687729963199;1958.8922609256485;2076.179908935962;8405.915940840574;8572.742817715478;8626.223639872442;8931;8959.193672569434;1696.609779750652;1704.4886534039738;1752.6144248265489;1772.769539959797;1787.973180402282;67271;68162;69241.30758692398;69954.65022674853;73650.26349736488;9721.222302215805;9727.902720972841;9870.25973052024;10047.799044019224;10061.346012509164;13940.930295348458;13955.162690238618;13974.790378144337;13993.740563349347;13996.930015349859;6899.724011039602;7165.6775445105095;7204.9279507204255;7365.631718414058;7367.447441441914;6684.131062961784;6762.932370676231;6898.896516552256;6924.376806087375;7000.579965202002;4258.936115958263;4318.395424640553;4332.393464914914;4387.714798538085;4453.287474004209;1773.8492228160492;1779.919903604341;1822.4988128264833;1824.471850293586;1841.3647291684615;739.6190961654752;794.6503538443067;796.1163108949062;887.4941283468361;892.3575025981283;15598.454054108051;15739.763903541456;16352;16426.260818263207;16560.6687866242;765.9540427574364;775.4843029385509;787.747920665393;843.9450686641698;845.51805470881;8982.371234013557;9040;9237.3533852631;9255.722328330161;9317.72046838596;383634;384953;385435;387162;408220;84645.57677211575;85649.14350856536;87666.1233387658;88923.55538222268;89022;869.9565021749014;880.700561808988;909.9317551183688;917.8439665256789;922.3082687984012;15363.923180384027;15389.229938611157;16024.519264422086;16196.352145914032;16317.836821631632;36698.633013669525;37398.8130059348;37454.43818342782;38110.428343575426;39073;53255.76169192708;53864;54520.18219726628;56407.71796140993;56811.43188568061;4302.397664327059;5991.711781966898;6272.466840318624;6755.7973260802255;6883.827904302432;8657.480551166951;10562.630307939493;10578.576856925636;10665.9466702666;10862.293950893167;8862.512561808904;8997.200559888179;9143.846865948108;9368.48473333946;9746.31775775689;9644.324897257406;9652.083052110038;9658.517074146404;9827.852582211415;9977.650782222587;9505.76235594088;9681;9746.588693957341;9848.212143028397;10125.493725313852;6803.659817009031;6969.442444604318;7023.894641580483;7065.258147894397;7150.284971502808;8327.666893324442;9408;9454;9793.706188814347;9967.950160249153 09:01:03 INFO - PROCESS | 32655 | |3;mootools.html;1226.7117227451547;1237.115462444352;1247.5009996001597;1313.540260908682;1581.636223668556;7363.779086627396;7766.301032907038;7795.025621797268;7969.203079692028;7990.680372785082;7852.411069169807;7965.163657815919;7973.202679732039;7975.162607926171;7978.321842643368;1815.972760408595;2077.5013996640773;2163.556470923461;2178.0743184146754;2185.9234926777567;2148.602508535918;2177.738671359431;2182.19258874216;2183.2467798609455;2183.290430610058;2101.3800928726064;2126.0432805237706;2126.1495401839234;2126.383348828838;2194.780521947808;2079.9688004679942;2137.2519618133683;2142.335875878475;2144.378130342199;2146.3346362627635;2114.693369461435;2145.9356219313445;2156.115992443091;2156.1590979518;2161.8919054047233;7717.151113377524;7756.689732410697;7764.107127680332;7767.495112817649;7783.260590243918;4457.33140028995;4554.817807287704;4580.885477863047;4581.244094724367;4584.770761461914;2766.9446611067865;2939.5590661400747;2940.0885725424973;2942.102658689099;2950.5279155335256;963.1812958984807;1012.2003617142449;1015.5328548867456;1023.6724248240566;1033.0289527843802;10316.329438586468;10385.688429347132;10403.53184106717;10447.895521044844;10518.211134164969;4141.358089496133;4213.1784302060805;4269.359596060615;4322.71902326354;4335.769851460682;8344.374171937128;8493.872591911002;8500.617472213766;8508.787280317918;8512;4508.098380323949;4522.751248681354;4527.705699129612;4529.932051019237;4549.249373853278;3523.224890524081;3969.166475040274;4090.079732060263;4172.102997855475;4174.3321068628875;3351.5475410819226;3351.7821341612716;3441.3633477806684;3474.2704032153024;3481.7562770606323;1040.5629635553087;1056.5034433816095;1060.411471633251;1071.9464026798628;1072.0458791675414;598.8771054273237;673.727140508095;709.2942522190453;711.2567367101288;721.6355740351194;4563.520830312769;4727.621790256771;4730.408698912636;4772.95227047732;4901.805354630303;726.5422783646269;765.284459030808;779.6218833865571;801.8155824160359;815.9306458951056;3006.7895247332913;3059.8011129276524;3093.2421556718746;3136.3570468053995;3182.824944628068;9343;9778.022197780165;9779.022097790164;9782.951085244671;9784.902150978542;9724.513774311255;9728.124468797841;9732.172765314886;9736.610535578639;9740.318177727491;7299.160596531361;7412;7414.777556673308;7416.7774966751085;7433.293837085468;4534.773261336854;4718;4732.148213321635;4759.0719809636785;4779.737114458738;8595;8836.204741573289;8898.11018898105;8958.238549723086;9026.909730902607;9074.818503629758;9124.31567632417;9171.44971301724;9189.86215206759;9201.677941272023;5525.475079867406;5541.224228608079;5709.885802284014;5803;5936.842315748388;6984.4063254623925;7041.225465198926;7053.823654408681;7054.224035356004;7057.435405167472;6220;6282.403171698681;6350.333215012357;6394.584352017104;6423.678816059271;6037.849053773691;6043.09353596964;6092.147099405998;6092.268927728701;6134.631922084689;5799.072148456226;5909.645421274738;5911.556633252438;5916.67458289781;5918.260217472816;4258.318669012943;4276.615104640598;4282.764447955267;4329.588014981274;4449.110177964355;4277.422547955986;4282.743035417885;4322.3948647190045;4381.16757816014;4443.777811109496 09:01:03 INFO - PROCESS | 32655 | |4;prototype.html;287.1815326319987;298.11014122843306;301.59284965296837;301.79327160894786;306.2008158705779;4691.90616187676;4743.573078422941;4832.492588278233;4880.463149053606;4885;4804.663673542854;4808.903821923559;4826.3484429601995;4830.574980380788;4857.174280372336;3862.961370386295;3863.092173339263;3865.8646947356847;3867.6325749053794;3869.361555343365;3594.6944509716704;3650.7627004244773;3862.7296089273764;3872.6320999505;3896.707746918978;3795.639414255655;3799.8670046548377;3804.239152169563;3815.2369526094753;3835.271298453285;3806.562245341766;3810.5617853946874;3813.389857622795;3828.483154774098;3836.9808150959207;3370.3090866372336;3375.0718552398043;3384.915377115567;3389.57630296213;3397.3205358928067;4548.795304211319;4730.385049943486;4731.929021064687;4738.218193997986;4742.857714268577;4355.216061108999;4355.847545335898;4358.847440339605;4362.956370436286;4371.431713877176;4809.326694262806;5076.654686508078;5088.7964481420695;5092.79628814847;5092.893335065607;3587;3591.6587924147166;3595.46068089786;3602.6217247189193;3604.8377822998027;5263.710495922723;5270.578353731692;5277.393099793496;5292.888493416387;5303.602229832778;3652.2878038782183;3669.3945498992903;3672.247189326182;3682.576503702055;3685.318216129971;3596.1009747563107;3701.592824789271;3701.7408781385043;3746.344389731786;3748.8687895923513;4236.110416812504;4263.317869140985;4266.656003358994;4281.614654681093;4297.462817147856;5077.720725360141;5085.288059671649;5087.618428617869;5088.185890257541;5089.949100509021;1220.5666988219232;1221.5052903574067;1283.4417028592593;1289.7227096174367;1301.1997621462922;864.4208380385157;876.027609353617;880.097899652861;889.1730690457807;890.4790697442069;4425.291953287458;4431.4903786065015;4439.556044395535;4461.955380446219;4478.529754375809;5160.612954028463;5183.714895680774;5185.844424667266;5206.843794686166;5227.555657769056;4388.429504164502;4420.491643460979;4433.889152771207;4480.596746292849;4486.371907932892;2305.319930620471;2416.634601450175;2420.9031638734255;2452;2456.4647095565274;4299.419578356944;4343.500497442771;4352.477702675699;4353.49934757507;4355.564443555619;4653.045720797206;4674.76626168697;4696.8121275148615;4702.3416721659;4712.858614241578;4093.4678491795876;4357.782110894443;4360.215161271001;4380.6057454829215;4386.890327741832;4569.680122391401;4580.725156490621;4585.839495617637;4590.74750888691;4626.8149274028665;4435.489918659267;4477.574630410106;4490.865274041784;4512.435945506812;4519.661025423172;4126.546079931265;4242.618164365222;4309.978450107729;4335;4369.569887638188;3301.5873015873017;3311.2218628622736;3317.253617935945;3318;3326.7504937130298;4549.476810166873;4553.704009239389;4556.769672188557;4559.794809233659;4943.901121977468;4765.332853400458;5066.873328166826;5079.6698214615935;5080.339555857715;5086;5048.066107770074;5052;5059.392872855281;5060.291559181791;5069.493050694901;4784.210605250095;4968.056069346812;4985.9501404985485;5004.649674522749;5028.019536190408;5103.87240318995;5111.258867464123;5117.30916326306;5118.923216151835;5119.820806271762;4999.775010124626;5005.149124648891;5005.924911126409;5006.349174607278;5008.348914641073 09:01:03 INFO - PROCESS | 32655 | |5;yui.html;492.9802807887685;543.6466296907013;546.2243614068025;557.0140850694271;564.3989151553595;11779.528818847246;12911.612651620442;12932;12936.676583085427;12938.74122517549;10261.333013354146;11294.661160165188;11367.431628418588;11373.374464404455;11394.25937314074;699.8425354295281;729.449265804317;731.524509069104;732.2933369298626;732.326259840945;735.3161559749431;739.3198257603018;741.4809633256715;741.60694831739;744.8957145999565;774.4694884004475;774.6049514747491;776;776.1462391369505;776.5845272779064;765.5789315876245;771.1055175995874;771.1632878327022;771.6604693934679;771.7453240430644;561.1946856261278;561.4694114062213;562.4628479801779;562.6483447845097;563.0568797264607;12070.094742894318;12078.939605302005;12091.093168012347;12117.212381195193;12152;10815.459227038695;10938.124950003981;11210.551577936872;11215.214934954474;11425.771484570261;9385.953070234606;9430.858537121949;9544.52277386128;9579.185769209556;9580.281478889112;3042.087373787877;3079.9538006929915;3094.5512900629283;3102.1469095998555;3145.638251601072;53968.73015634936;56069;57019.144712829344;62380.376196238365;64727.35272647307;8670.956645216733;8946.418482798597;9131.497767622845;9144.131307525775;9224.53877306132;17032.48902532926;17143.74284385735;17167.227474763415;17240.224189911485;17435.215415306342;6546.279909209983;6623.172103487064;6657.46740260778;6673.599584024974;6716;3626.3472574936764;3688.5942546319884;3694.6859516941363;3734.2158146788934;3838.078861073378;2628.5925681519393;2726.481968425993;2743.27303264635;2745.766609838146;2746.052611848909;469.32651644889694;472.23262198926744;472.7305435901572;476.4853957725648;485.0275198227531;449.11524297134594;531.4711861697635;546.2052713302136;556.13798612151;561.50026476436;7506.9249307506225;7515.595009596986;7592.354649854824;7607.500549747067;7860.606969651494;456.34058785055277;553.4327314502667;554.877926856091;555.4556534596038;559.3707079535523;3526.1360966563357;3674.3202507536193;3767.7927713975996;3945.3292940200236;3978.6419222270133;101847;102418.48790755999;102773;104611;105595.4720226394;80068;89536;92829.5358523203;93071;93299;48997;66876;72418.63790681012;72760;74726.25273747194;7643;8006.519608823489;8109.415760937506;8214.876776848472;8233.917660823316;42584;44954.55045449504;45243;45374.31938520991;46378.30432543582;60031.399686004326;63961;64400.35599643944;64961;68799.65600172167;9796.65711700087;10016.148627366463;10039.598416063276;10137.898621013695;10331.535080921227;11463.369514676773;11582.88417115818;11706.414679265832;11967.820482692592;12348.320842353398;11105.278156919774;11140.665780026613;11496.367699776592;11646.592369267035;11845.644630661094;11397.829032564352;11647.41762911868;11977.461014254553;12178.939105304416;12397.75204495923;10743.301685390425;11275.492602833056;11520.251183673034;11605.825912611148;11755.353455559683;8915.375684523682;9233.076692330713;9313.39462934907;9703.854442183514;9724.465154416575;8256.380771442045;8849.64601415962;9124.17882390588;9468.824473760076;9558.856617150888 09:01:03 INFO - PROCESS | 32655 | __end_tp_report 09:01:03 INFO - PROCESS | 32655 | __start_cc_report 09:01:03 INFO - PROCESS | 32655 | _x_x_mozilla_cycle_collect,1105 09:01:03 INFO - PROCESS | 32655 | __end_cc_report 09:01:03 INFO - PROCESS | 32655 | __startTimestamp1472918463652__endTimestamp 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | ------- Summary: start ------- 09:01:03 INFO - PROCESS | 32655 | Number of tests: 6 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | [#0] dojo.html Cycles:165 Average:4790.82 Median:4917.46 stddev:515.61 (10.5%) stddev-sans-first:487.61 09:01:03 INFO - PROCESS | 32655 | Values: 2596.4 2599.4 2604.2 2660.8 2668.3 4749.9 4763.4 4832.6 4877.4 4906.1 4748.9 4779.6 4795.9 4812.6 4841.5 4346.3 4375.8 4451.0 4515.2 4589.4 4431.2 4497.0 4514.1 4514.2 4520.2 4321.5 4335.5 4366.1 4418.1 4437.2 4402.1 4405.6 4406.9 4486.0 4515.6 4419.3 4431.6 4435.6 4444.3 4487.4 4724.2 4790.2 4827.2 4867.2 4931.2 5174.9 5197.9 5200.1 5209.2 5258.4 5186.6 5205.7 5230.8 5298.2 5302.7 4693.8 4816.9 4877.0 4880.9 4936.2 5339.8 5364.1 5364.7 5418.3 5428.6 5129.6 5162.6 5168.3 5170.6 5229.3 5027.7 5126.3 5163.5 5169.3 5179.6 5168.4 5169.1 5172.0 5214.2 5237.1 5134.4 5154.9 5155.2 5159.3 5219.2 4312.5 4354.6 4398.5 4460.3 4467.6 3851.7 3852.3 3891.3 3929.9 3941.5 4468.5 4470.4 4471.4 4475.4 4529.9 5031.7 5149.0 5220.2 5235.0 5239.5 4418.8 4428.7 4437.8 4450.8 4503.3 4699.5 4702.7 4704.3 4706.5 4760.1 4791.4 4841.2 4846.9 4894.7 4936.6 5208.2 5214.5 5223.9 5290.4 5297.7 4900.5 4908.6 4909.0 4916.6 4963.9 4961.5 4967.5 5142.5 5142.7 5145.2 5096.7 5145.9 5152.8 5206.7 5212.7 4996.1 5021.8 5022.9 5024.8 5091.4 4961.8 5017.6 5022.3 5028.5 5030.2 4993.5 4995.5 4998.0 5054.0 5059.9 5069.4 5080.9 5082.1 5113.7 5139.7 4850.7 4917.5 4925.9 4959.7 5005.1 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | [#1] ext.html Cycles:180 Average:49081.38 Median:19264.51 stddev:99502.86 (516.5%) stddev-sans-first:99715.24 09:01:03 INFO - PROCESS | 32655 | Values: 539.7 544.7 547.6 571.7 581.1 28177.6 34408.0 35623.6 35632.3 38869.6 34629.8 34893.3 34970.8 35019.3 35103.5 7242.2 7511.6 7661.4 7666.0 7667.5 7213.3 7459.4 7460.3 9464.1 9696.4 9812.5 9876.1 9877.7 9879.5 9888.4 9777.3 9830.7 9842.5 9850.7 9850.8 9632.3 9677.7 9695.3 9697.1 9703.3 33375.8 33636.0 33693.5 33718.0 33745.7 2728.1 2741.7 2791.7 2986.4 3106.0 26087.3 26397.6 26415.9 26794.6 27115.5 3405.6 3466.4 3509.7 3630.3 3633.7 255651.0 256390.0 256941.0 257915.0 258612.7 44680.3 44984.3 44995.6 45027.8 45065.5 46810.0 46825.5 46921.5 46943.0 46977.3 13034.7 13165.7 13201.2 13204.6 13221.5 10001.5 10033.6 10036.2 10038.0 10043.2 12958.2 13398.7 13435.9 13449.3 13793.9 4694.2 4763.5 4767.1 4804.7 4931.6 798.5 823.6 826.9 827.2 877.3 23523.9 25071.7 25180.0 25209.5 25517.4 861.0 867.8 873.4 892.4 901.4 12932.5 13011.9 13298.2 13314.6 13424.6 367046.0 369797.0 370135.0 370931.0 371430.0 39450.2 40601.6 41123.4 41324.2 41983.8 1066.0 1079.7 1107.5 1108.4 1111.1 25553.6 26359.0 26725.9 27147.3 27193.3 36801.3 37229.4 37235.8 37249.4 37354.6 400242.0 409578.0 409600.0 410375.0 648994.0 33266.5 33693.0 34724.0 35110.3 35573.1 36709.8 36995.3 37153.6 37741.2 37768.2 31842.7 31880.5 31942.5 32116.7 33072.3 32500.7 32565.8 33147.3 33298.7 33683.7 31971.0 32663.2 32869.8 32912.3 32963.3 29267.7 29669.6 30331.0 30334.4 30350.4 23770.2 23878.7 23902.0 24054.9 24212.4 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | [#2] jquery.html Cycles:180 Average:24279.30 Median:5359.52 stddev:64796.91 (1209.0%) stddev-sans-first:64953.75 09:01:03 INFO - PROCESS | 32655 | Values: 340.7 345.0 349.4 349.7 371.7 14624.7 14999.3 15458.8 16400.7 16575.0 14885.9 14960.6 15064.2 15066.0 15102.1 4837.8 5052.4 5053.7 5189.4 5434.5 3427.4 5397.0 5424.3 5432.6 5435.1 5139.9 5355.7 5363.4 5423.9 5433.3 5131.5 5190.8 5335.3 5354.5 5355.3 5136.4 5138.3 5142.8 5147.7 5148.4 11583.9 12076.9 17655.0 19663.4 19776.6 1804.7 1885.8 1951.7 1958.9 2076.2 8405.9 8572.7 8626.2 8931.0 8959.2 1696.6 1704.5 1752.6 1772.8 1788.0 67271.0 68162.0 69241.3 69954.7 73650.3 9721.2 9727.9 9870.3 10047.8 10061.3 13940.9 13955.2 13974.8 13993.7 13996.9 6899.7 7165.7 7204.9 7365.6 7367.4 6684.1 6762.9 6898.9 6924.4 7000.6 4258.9 4318.4 4332.4 4387.7 4453.3 1773.8 1779.9 1822.5 1824.5 1841.4 739.6 794.7 796.1 887.5 892.4 15598.5 15739.8 16352.0 16426.3 16560.7 766.0 775.5 787.7 843.9 845.5 8982.4 9040.0 9237.4 9255.7 9317.7 383634.0 384953.0 385435.0 387162.0 408220.0 84645.6 85649.1 87666.1 88923.6 89022.0 870.0 880.7 909.9 917.8 922.3 15363.9 15389.2 16024.5 16196.4 16317.8 36698.6 37398.8 37454.4 38110.4 39073.0 53255.8 53864.0 54520.2 56407.7 56811.4 4302.4 5991.7 6272.5 6755.8 6883.8 8657.5 10562.6 10578.6 10665.9 10862.3 8862.5 8997.2 9143.8 9368.5 9746.3 9644.3 9652.1 9658.5 9827.9 9977.7 9505.8 9681.0 9746.6 9848.2 10125.5 6803.7 6969.4 7023.9 7065.3 7150.3 8327.7 9408.0 9454.0 9793.7 9968.0 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | [#3] mootools.html Cycles:180 Average:4961.84 Median:4651.39 stddev:2857.97 (61.4%) stddev-sans-first:2852.21 09:01:03 INFO - PROCESS | 32655 | Values: 1226.7 1237.1 1247.5 1313.5 1581.6 7363.8 7766.3 7795.0 7969.2 7990.7 7852.4 7965.2 7973.2 7975.2 7978.3 1816.0 2077.5 2163.6 2178.1 2185.9 2148.6 2177.7 2182.2 2183.2 2183.3 2101.4 2126.0 2126.1 2126.4 2194.8 2080.0 2137.3 2142.3 2144.4 2146.3 2114.7 2145.9 2156.1 2156.2 2161.9 7717.2 7756.7 7764.1 7767.5 7783.3 4457.3 4554.8 4580.9 4581.2 4584.8 2766.9 2939.6 2940.1 2942.1 2950.5 963.2 1012.2 1015.5 1023.7 1033.0 10316.3 10385.7 10403.5 10447.9 10518.2 4141.4 4213.2 4269.4 4322.7 4335.8 8344.4 8493.9 8500.6 8508.8 8512.0 4508.1 4522.8 4527.7 4529.9 4549.2 3523.2 3969.2 4090.1 4172.1 4174.3 3351.5 3351.8 3441.4 3474.3 3481.8 1040.6 1056.5 1060.4 1071.9 1072.0 598.9 673.7 709.3 711.3 721.6 4563.5 4727.6 4730.4 4773.0 4901.8 726.5 765.3 779.6 801.8 815.9 3006.8 3059.8 3093.2 3136.4 3182.8 9343.0 9778.0 9779.0 9783.0 9784.9 9724.5 9728.1 9732.2 9736.6 9740.3 7299.2 7412.0 7414.8 7416.8 7433.3 4534.8 4718.0 4732.1 4759.1 4779.7 8595.0 8836.2 8898.1 8958.2 9026.9 9074.8 9124.3 9171.4 9189.9 9201.7 5525.5 5541.2 5709.9 5803.0 5936.8 6984.4 7041.2 7053.8 7054.2 7057.4 6220.0 6282.4 6350.3 6394.6 6423.7 6037.8 6043.1 6092.1 6092.3 6134.6 5799.1 5909.6 5911.6 5916.7 5918.3 4258.3 4276.6 4282.8 4329.6 4449.1 4277.4 4282.7 4322.4 4381.2 4443.8 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | [#4] prototype.html Cycles:180 Average:4075.29 Median:4437.52 stddev:1175.95 (26.5%) stddev-sans-first:1144.36 09:01:03 INFO - PROCESS | 32655 | Values: 287.2 298.1 301.6 301.8 306.2 4691.9 4743.6 4832.5 4880.5 4885.0 4804.7 4808.9 4826.3 4830.6 4857.2 3863.0 3863.1 3865.9 3867.6 3869.4 3594.7 3650.8 3862.7 3872.6 3896.7 3795.6 3799.9 3804.2 3815.2 3835.3 3806.6 3810.6 3813.4 3828.5 3837.0 3370.3 3375.1 3384.9 3389.6 3397.3 4548.8 4730.4 4731.9 4738.2 4742.9 4355.2 4355.8 4358.8 4363.0 4371.4 4809.3 5076.7 5088.8 5092.8 5092.9 3587.0 3591.7 3595.5 3602.6 3604.8 5263.7 5270.6 5277.4 5292.9 5303.6 3652.3 3669.4 3672.2 3682.6 3685.3 3596.1 3701.6 3701.7 3746.3 3748.9 4236.1 4263.3 4266.7 4281.6 4297.5 5077.7 5085.3 5087.6 5088.2 5089.9 1220.6 1221.5 1283.4 1289.7 1301.2 864.4 876.0 880.1 889.2 890.5 4425.3 4431.5 4439.6 4462.0 4478.5 5160.6 5183.7 5185.8 5206.8 5227.6 4388.4 4420.5 4433.9 4480.6 4486.4 2305.3 2416.6 2420.9 2452.0 2456.5 4299.4 4343.5 4352.5 4353.5 4355.6 4653.0 4674.8 4696.8 4702.3 4712.9 4093.5 4357.8 4360.2 4380.6 4386.9 4569.7 4580.7 4585.8 4590.7 4626.8 4435.5 4477.6 4490.9 4512.4 4519.7 4126.5 4242.6 4310.0 4335.0 4369.6 3301.6 3311.2 3317.3 3318.0 3326.8 4549.5 4553.7 4556.8 4559.8 4943.9 4765.3 5066.9 5079.7 5080.3 5086.0 5048.1 5052.0 5059.4 5060.3 5069.5 4784.2 4968.1 4986.0 5004.6 5028.0 5103.9 5111.3 5117.3 5118.9 5119.8 4999.8 5005.1 5005.9 5006.3 5008.3 09:01:03 INFO - PROCESS | 32655 | 09:01:03 INFO - PROCESS | 32655 | [#5] yui.html Cycles:180 Average:17434.56 Median:544.93 stddev:25973.22 (4766.4%) stddev-sans-first:26014.93 09:01:03 INFO - PROCESS | 32655 | Values: 493.0 543.6 546.2 557.0 564.4 11779.5 12911.6 12932.0 12936.7 12938.7 10261.3 11294.7 11367.4 11373.4 11394.3 699.8 729.4 731.5 732.3 732.3 735.3 739.3 741.5 741.6 744.9 774.5 774.6 776.0 776.1 776.6 765.6 771.1 771.2 771.7 771.7 561.2 561.5 562.5 562.6 563.1 12070.1 12078.9 12091.1 12117.2 12152.0 10815.5 10938.1 11210.6 11215.2 11425.8 9386.0 9430.9 9544.5 9579.2 9580.3 3042.1 3080.0 3094.6 3102.1 3145.6 53968.7 56069.0 57019.1 62380.4 64727.4 8671.0 8946.4 9131.5 9144.1 9224.5 17032.5 17143.7 17167.2 17240.2 17435.2 6546.3 6623.2 6657.5 6673.6 6716.0 3626.3 3688.6 3694.7 3734.2 3838.1 2628.6 2726.5 2743.3 2745.8 2746.1 469.3 472.2 472.7 476.5 485.0 449.1 531.5 546.2 556.1 561.5 7506.9 7515.6 7592.4 7607.5 7860.6 456.3 553.4 554.9 555.5 559.4 3526.1 3674.3 3767.8 3945.3 3978.6 101847.0 102418.5 102773.0 104611.0 105595.5 80068.0 89536.0 92829.5 93071.0 93299.0 48997.0 66876.0 72418.6 72760.0 74726.3 7643.0 8006.5 8109.4 8214.9 8233.9 42584.0 44954.6 45243.0 45374.3 46378.3 60031.4 63961.0 64400.4 64961.0 68799.7 9796.7 10016.1 10039.6 10137.9 10331.5 11463.4 11582.9 11706.4 11967.8 12348.3 11105.3 11140.7 11496.4 11646.6 11845.6 11397.8 11647.4 11977.5 12178.9 12397.8 10743.3 11275.5 11520.3 11605.8 11755.4 8915.4 9233.1 9313.4 9703.9 9724.5 8256.4 8849.6 9124.2 9468.8 9558.9 09:01:03 INFO - PROCESS | 32655 | -------- Summary: end -------- 09:01:03 INFO - PROCESS | 32655 | 09:01:04 INFO - TEST-INFO | 32655: exit 0 09:01:04 INFO - TEST-OK | dromaeo_css | took 1122962ms 09:01:04 INFO - TEST-START | kraken 09:01:04 INFO - operating with platform_type : linux_ 09:01:04 INFO - Initialising browser for kraken test... 09:01:04 INFO - TEST-INFO | started process 496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkdUTHO/profile http://localhost:46802/getInfo.html) 09:01:09 INFO - PROCESS | 496 | __metrics Screen width/height:1600/1200 09:01:09 INFO - PROCESS | 496 | colorDepth:24 09:01:09 INFO - PROCESS | 496 | Browser inner width/height: 1024/697 09:01:09 INFO - PROCESS | 496 | __metrics 09:01:09 INFO - PROCESS | 496 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:01:09 INFO - PROCESS | 496 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:10 INFO - PROCESS | 496 | console.error: PushService: 09:01:10 INFO - PROCESS | 496 | stateChangeProcessEnqueue: Error transitioning state 09:01:10 INFO - PROCESS | 496 | UnknownError 09:01:11 INFO - TEST-INFO | 496: exit 0 09:01:11 INFO - Browser initialized. 09:01:11 INFO - Running cycle 1/1 for kraken test... 09:01:11 INFO - TEST-INFO | started process 582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkdUTHO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:23 INFO - PROCESS | 582 | RSS: Main: 179822592 09:01:23 INFO - PROCESS | 582 | 09:01:26 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46802/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:27 INFO - PROCESS | 582 | RSS: Main: 234278912 09:01:27 INFO - PROCESS | 582 | 09:01:29 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46802/tests/kraken/driver.html?testName=audio-dft) 09:01:30 INFO - PROCESS | 582 | RSS: Main: 224051200 09:01:30 INFO - PROCESS | 582 | 09:01:33 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46802/tests/kraken/driver.html?testName=audio-fft) 09:01:34 INFO - PROCESS | 582 | RSS: Main: 302272512 09:01:34 INFO - PROCESS | 582 | 09:01:36 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46802/tests/kraken/driver.html?testName=audio-oscillator) 09:01:36 INFO - PROCESS | 582 | RSS: Main: 212258816 09:01:36 INFO - PROCESS | 582 | 09:01:39 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:39 INFO - PROCESS | 582 | RSS: Main: 214470656 09:01:39 INFO - PROCESS | 582 | 09:01:42 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46802/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:43 INFO - PROCESS | 582 | RSS: Main: 252903424 09:01:43 INFO - PROCESS | 582 | 09:01:46 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46802/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:47 INFO - PROCESS | 582 | RSS: Main: 247488512 09:01:47 INFO - PROCESS | 582 | 09:01:50 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46802/tests/kraken/driver.html?testName=json-parse-financial) 09:01:51 INFO - PROCESS | 582 | RSS: Main: 250781696 09:01:51 INFO - PROCESS | 582 | 09:01:52 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:53 INFO - PROCESS | 582 | RSS: Main: 214122496 09:01:53 INFO - PROCESS | 582 | 09:01:55 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:56 INFO - PROCESS | 582 | RSS: Main: 221081600 09:01:56 INFO - PROCESS | 582 | 09:01:58 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:58 INFO - PROCESS | 582 | RSS: Main: 222830592 09:01:58 INFO - PROCESS | 582 | 09:02:01 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:02 INFO - PROCESS | 582 | RSS: Main: 223977472 09:02:02 INFO - PROCESS | 582 | 09:02:05 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:05 INFO - PROCESS | 582 | RSS: Main: 221872128 09:02:05 INFO - PROCESS | 582 | 09:02:07 INFO - PROCESS | 582 | Cycle 1(1): loaded http://localhost:46802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46802/tests/kraken/driver.html?testName=ai-astar) 09:02:08 INFO - PROCESS | 582 | RSS: Main: 272359424 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | __start_tp_report 09:02:08 INFO - PROCESS | 582 | _x_x_mozilla_page_load 09:02:08 INFO - PROCESS | 582 | _x_x_mozilla_page_load_details 09:02:08 INFO - PROCESS | 582 | |i|pagename|runs| 09:02:08 INFO - PROCESS | 582 | |0;ai-astar;114;115;119;114;116;117;114;114;113;128 09:02:08 INFO - PROCESS | 582 | |1;audio-beat-detection;148;123;152;189;126;148;156;122;182;123 09:02:08 INFO - PROCESS | 582 | |2;audio-dft;162;160;162;160;161;161;162;164;162;162 09:02:08 INFO - PROCESS | 582 | |3;audio-fft;75;76;77;167;78;77;77;77;155;77 09:02:08 INFO - PROCESS | 582 | |4;audio-oscillator;84;84;148;84;83;85;137;84;83;131 09:02:08 INFO - PROCESS | 582 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 09:02:08 INFO - PROCESS | 582 | |6;imaging-darkroom;147;147;147;148;147;147;147;147;148;149 09:02:08 INFO - PROCESS | 582 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;94;95 09:02:08 INFO - PROCESS | 582 | |8;json-parse-financial;63;62;64;64;65;64;63;65;63;65 09:02:08 INFO - PROCESS | 582 | |9;json-stringify-tinderbox;66;66;65;66;66;66;66;65;65;66 09:02:08 INFO - PROCESS | 582 | |10;stanford-crypto-aes;83;82;83;84;84;83;82;82;83;82 09:02:08 INFO - PROCESS | 582 | |11;stanford-crypto-ccm;135;140;131;132;133;141;141;132;197;132 09:02:08 INFO - PROCESS | 582 | |12;stanford-crypto-pbkdf2;179;177;175;173;175;182;173;174;174;176 09:02:08 INFO - PROCESS | 582 | |13;stanford-crypto-sha256-iterative;69;72;70;69;71;70;69;70;68;68 09:02:08 INFO - PROCESS | 582 | __end_tp_report 09:02:08 INFO - PROCESS | 582 | __start_cc_report 09:02:08 INFO - PROCESS | 582 | _x_x_mozilla_cycle_collect,1947 09:02:08 INFO - PROCESS | 582 | __end_cc_report 09:02:08 INFO - PROCESS | 582 | __startTimestamp1472918527998__endTimestamp 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | ------- Summary: start ------- 09:02:08 INFO - PROCESS | 582 | Number of tests: 14 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#0] ai-astar Cycles:10 Average:116.40 Median:115.50 stddev:4.45 (3.9%) stddev-sans-first:4.64 09:02:08 INFO - PROCESS | 582 | Values: 114.0 115.0 119.0 114.0 116.0 117.0 114.0 114.0 113.0 128.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:150.00 stddev:24.30 (16.2%) stddev-sans-first:25.77 09:02:08 INFO - PROCESS | 582 | Values: 148.0 123.0 152.0 189.0 126.0 148.0 156.0 122.0 182.0 123.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 09:02:08 INFO - PROCESS | 582 | Values: 162.0 160.0 162.0 160.0 161.0 161.0 162.0 164.0 162.0 162.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#3] audio-fft Cycles:10 Average:93.60 Median:77.00 stddev:35.64 (46.3%) stddev-sans-first:37.17 09:02:08 INFO - PROCESS | 582 | Values: 75.0 76.0 77.0 167.0 78.0 77.0 77.0 77.0 155.0 77.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:84.00 stddev:26.79 (31.9%) stddev-sans-first:27.76 09:02:08 INFO - PROCESS | 582 | Values: 84.0 84.0 148.0 84.0 83.0 85.0 137.0 84.0 83.0 131.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:02:08 INFO - PROCESS | 582 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:02:08 INFO - PROCESS | 582 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 149.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:02:08 INFO - PROCESS | 582 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 09:02:08 INFO - PROCESS | 582 | Values: 63.0 62.0 64.0 64.0 65.0 64.0 63.0 65.0 63.0 65.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 09:02:08 INFO - PROCESS | 582 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.83 09:02:08 INFO - PROCESS | 582 | Values: 83.0 82.0 83.0 84.0 84.0 83.0 82.0 82.0 83.0 82.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:137.50 stddev:19.94 (14.5%) stddev-sans-first:21.01 09:02:08 INFO - PROCESS | 582 | Values: 135.0 140.0 131.0 132.0 133.0 141.0 141.0 132.0 197.0 132.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:175.50 stddev:2.86 (1.6%) stddev-sans-first:2.79 09:02:08 INFO - PROCESS | 582 | Values: 179.0 177.0 175.0 173.0 175.0 182.0 173.0 174.0 174.0 176.0 09:02:08 INFO - PROCESS | 582 | 09:02:08 INFO - PROCESS | 582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 09:02:08 INFO - PROCESS | 582 | Values: 69.0 72.0 70.0 69.0 71.0 70.0 69.0 70.0 68.0 68.0 09:02:08 INFO - PROCESS | 582 | -------- Summary: end -------- 09:02:08 INFO - PROCESS | 582 | 09:02:09 INFO - TEST-INFO | 582: exit 0 09:02:09 INFO - TEST-OK | kraken | took 64798ms 09:02:09 INFO - SUITE-END | took 1187s 09:02:09 INFO - Completed test suite (00:19:48) 09:02:09 INFO - javascript benchmark 09:02:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.389848385629, 2599.3601421462686, 2604.17968339973, 2660.7605315521587, 2668.3462551674843, 4749.90500189996, 4763.428388593369, 4832.589229915453, 4877.3903262092235, 4906.067847109051, 4748.928766068503, 4779.569838714515, 4795.904081918359, 4812.6390520711, 4841.467438581753, 4346.282863327548, 4375.781210939456, 4451.043025749464, 4515.209838278304, 4589.35748995141, 4431.246688063021, 4496.9550304497025, 4514.142312960544, 4514.210013247685, 4520.2315606347, 4321.481422229353, 4335.479742430928, 4366.148601022802, 4418.116376724636, 4437.245668236407, 4402.119576084764, 4405.5814697604, 4406.889827754299, 4485.977570112162, 4515.61617262533, 4419.337099435078, 4431.601155895953, 4435.578620031092, 4444.333349997494, 4487.439070116236, 4724.220503616899, 4790.233562629963, 4827.179379505457, 4867.245576935546, 4931.235658472907, 5174.870628234286, 5197.922031169498, 5200.115980283361, 5209.192575150858, 5258.395284542288, 5186.636935414523, 5205.687658740488, 5230.843074707765, 5298.15229563268, 5302.655327403706, 4693.812247510062, 4816.927746083811, 4877.0, 4880.902381952341, 4936.185529387682, 5339.813106541253, 5364.061289274361, 5364.678119312775, 5418.295621569249, 5428.6471379361, 5129.589632829365, 5162.586993040548, 5168.250603662523, 5170.560502357342, 5229.320188375563, 5027.673201241908, 5126.307948426989, 5163.483651634881, 5169.327987361619, 5179.559737422286, 5168.431472538018, 5169.069567477815, 5171.974140129275, 5214.191800270964, 5237.135872580981, 5134.435212126663, 5154.871128221825, 5155.200943853709, 5159.303494028258, 5219.243209734643, 4312.525622181557, 4354.56454354562, 4398.494173170063, 4460.264056430718, 4467.597916187558, 3851.7111216658864, 3852.2680690668685, 3891.3384724596885, 3929.862454814068, 3941.467901833273, 4468.530804265571, 4470.441194850644, 4471.3740076388685, 4475.440569928759, 4529.886752831139, 5031.698098114125, 5149.0474262261605, 5220.216967454912, 5235.0, 5239.502247286502, 4418.779061046935, 4428.7121337112985, 4437.755923424243, 4450.844220452269, 4503.2569626012, 4699.459562150328, 4702.694324868872, 4704.29435584665, 4706.505816889246, 4760.143174228672, 4791.377120974391, 4841.176999910094, 4846.927296090491, 4894.657373983787, 4936.6297527685565, 5208.166693329049, 5214.478552144755, 5223.895522089613, 5290.365156181283, 5297.708626025606, 4900.534449227318, 4908.6073114151495, 4909.042736666316, 4916.582090522345, 4963.875903102451, 4961.479044700254, 4967.528084831935, 5142.537171654569, 5142.742862856917, 5145.151050076695, 5096.694198348111, 5145.948540514697, 5152.793888244578, 5206.661566998133, 5212.739363031757, 4996.050750357421, 5021.84934451967, 5022.924656130234, 5024.799008039784, 5091.439941606346, 4961.751912404293, 5017.64876458659, 5022.3219865317715, 5028.547430731252, 5030.170021946338, 4993.525615066708, 4995.500449954975, 4998.0003999201035, 5053.974730126326, 5059.873503162303, 5069.366329208849, 5080.923786143285, 5082.085224659597, 5113.74431278442, 5139.691618502902, 4850.708957462563, 4917.459079501324, 4925.876853078702, 4959.7272150032095, 5005.124103281838], "value": 4756.5710945098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.6627108057464, 544.7303584725561, 547.5701574264201, 571.67128900882, 581.1341101758381, 28177.577336339946, 34408.0, 35623.64376356236, 35632.2873542529, 38869.61130388695, 34629.82685086577, 34893.3021339573, 34970.82514587424, 35019.2996140077, 35103.473447898235, 7242.203357630657, 7511.586862722562, 7661.425393095512, 7666.0, 7667.501612395205, 7213.314735100157, 7459.403247740168, 7460.25397460255, 9464.1482266596, 9696.369735967139, 9812.50937453128, 9876.111149996499, 9877.70366888991, 9879.456629885353, 9888.357256778323, 9777.31558790885, 9830.655927042519, 9842.50787460624, 9850.655227067018, 9850.753731156707, 9632.27757918159, 9677.661281855171, 9695.321327507078, 9697.127258546694, 9703.320767546275, 33375.83312083448, 33636.0, 33693.494597581055, 33718.0, 33745.6625433745, 2728.0724553651853, 2741.6572928383953, 2791.6650001999687, 2986.3728616990456, 3106.0, 26087.347816304555, 26397.604035939476, 26415.867920660465, 26794.637899579662, 27115.45769084627, 3405.625381208065, 3466.376052310583, 3509.7192224621967, 3630.3283892479976, 3633.6729694327373, 255651.0, 256390.0, 256941.0, 257915.0, 258612.70693646598, 44680.3297950531, 44984.3252351215, 44995.55004449979, 45027.77486112614, 45065.54934450679, 46810.0, 46825.531744682114, 46921.5307846924, 46943.0, 46977.295340569915, 13034.739305213843, 13165.670858228621, 13201.20792752438, 13204.557156925808, 13221.471141154438, 10001.549930253155, 10033.64882229133, 10036.24728145392, 10038.0, 10043.246756493292, 12958.157719748186, 13398.732025359439, 13435.932820335836, 13449.260290683911, 13793.931030344784, 4694.201985662446, 4763.54746299101, 4767.118083154627, 4804.73573953429, 4931.619146638946, 798.4849771897094, 823.6417158535936, 826.89663792026, 827.1934863508152, 877.2543338162639, 23523.882380587987, 25071.749282506942, 25180.0, 25209.495810083696, 25517.3620659485, 860.9870851937226, 867.7873920889423, 873.362445414838, 892.4065496444791, 901.4084507042254, 12932.547360842325, 13011.925349113853, 13298.202107873558, 13314.600561983156, 13424.597262082154, 367046.0, 369797.0, 370135.0, 370931.0, 371430.0, 39450.210995779926, 40601.59398405978, 41123.38314925278, 41324.1735165295, 41983.790081049396, 1066.0, 1079.6868908016745, 1107.5237647811357, 1108.41808050774, 1111.1055600241882, 25553.61669574995, 26359.0, 26725.866370668024, 27147.321316967234, 27193.32016699598, 36801.26397472089, 37229.44155837611, 37235.81382093072, 37249.441258380604, 37354.626453735116, 400242.0, 409578.0, 409600.0, 410375.0, 648994.0, 33266.501002484496, 33693.0, 34724.0, 35110.29779404448, 35573.1106722334, 36709.81645091758, 36995.26009479741, 37153.62846371502, 37741.24517509689, 37768.244635107694, 31842.68157318397, 31880.47944178462, 31942.520862186622, 32116.678833212303, 33072.33855322928, 32500.674993250712, 32565.837170813993, 33147.33705325928, 33298.66701333052, 33683.66316336805, 31971.0, 32663.18342041468, 32869.835650821595, 32912.34175316432, 32963.34073318568, 29267.70732292735, 29669.554956675234, 30331.0, 30334.393312134074, 30350.392992140474, 23770.168044118374, 23878.686672233194, 23902.0, 24054.87972560126, 24212.39469013289], "value": 16654.824614975918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6682643744183, 344.95515582974224, 349.3990336621011, 349.69925863757175, 371.6766413220497, 14624.707505849876, 14999.325030373631, 15458.84541154588, 16400.67198656026, 16575.0, 14885.925570372134, 14960.551183464513, 15064.246787660628, 15066.0, 15102.093874367545, 4837.806487740495, 5052.368453943257, 5053.747312634372, 5189.377274727038, 5434.456554344553, 3427.365937301607, 5396.973015134939, 5424.294841670578, 5432.6468779529205, 5435.10320797068, 5139.897202055957, 5355.678659280456, 5363.356397232337, 5423.945760542403, 5433.26650902129, 5131.4868513148385, 5190.792368305263, 5335.253064570963, 5354.491323324317, 5355.3305836770405, 5136.434992150897, 5138.30632864566, 5142.791444010654, 5147.665401748912, 5148.407933087706, 11583.942080289544, 12076.939615301868, 17655.0, 19663.41009769709, 19776.60446791056, 1804.6841802684478, 1885.792562818089, 1951.687729963199, 1958.8922609256485, 2076.179908935962, 8405.915940840574, 8572.742817715478, 8626.223639872442, 8931.0, 8959.193672569434, 1696.609779750652, 1704.4886534039738, 1752.6144248265489, 1772.769539959797, 1787.973180402282, 67271.0, 68162.0, 69241.30758692398, 69954.65022674853, 73650.26349736488, 9721.222302215805, 9727.902720972841, 9870.25973052024, 10047.799044019224, 10061.346012509164, 13940.930295348458, 13955.162690238618, 13974.790378144337, 13993.740563349347, 13996.930015349859, 6899.724011039602, 7165.6775445105095, 7204.9279507204255, 7365.631718414058, 7367.447441441914, 6684.131062961784, 6762.932370676231, 6898.896516552256, 6924.376806087375, 7000.579965202002, 4258.936115958263, 4318.395424640553, 4332.393464914914, 4387.714798538085, 4453.287474004209, 1773.8492228160492, 1779.919903604341, 1822.4988128264833, 1824.471850293586, 1841.3647291684615, 739.6190961654752, 794.6503538443067, 796.1163108949062, 887.4941283468361, 892.3575025981283, 15598.454054108051, 15739.763903541456, 16352.0, 16426.260818263207, 16560.6687866242, 765.9540427574364, 775.4843029385509, 787.747920665393, 843.9450686641698, 845.51805470881, 8982.371234013557, 9040.0, 9237.3533852631, 9255.722328330161, 9317.72046838596, 383634.0, 384953.0, 385435.0, 387162.0, 408220.0, 84645.57677211575, 85649.14350856536, 87666.1233387658, 88923.55538222268, 89022.0, 869.9565021749014, 880.700561808988, 909.9317551183688, 917.8439665256789, 922.3082687984012, 15363.923180384027, 15389.229938611157, 16024.519264422086, 16196.352145914032, 16317.836821631632, 36698.633013669525, 37398.8130059348, 37454.43818342782, 38110.428343575426, 39073.0, 53255.76169192708, 53864.0, 54520.18219726628, 56407.71796140993, 56811.43188568061, 4302.397664327059, 5991.711781966898, 6272.466840318624, 6755.7973260802255, 6883.827904302432, 8657.480551166951, 10562.630307939493, 10578.576856925636, 10665.9466702666, 10862.293950893167, 8862.512561808904, 8997.200559888179, 9143.846865948108, 9368.48473333946, 9746.31775775689, 9644.324897257406, 9652.083052110038, 9658.517074146404, 9827.852582211415, 9977.650782222587, 9505.76235594088, 9681.0, 9746.588693957341, 9848.212143028397, 10125.493725313852, 6803.659817009031, 6969.442444604318, 7023.894641580483, 7065.258147894397, 7150.284971502808, 8327.666893324442, 9408.0, 9454.0, 9793.706188814347, 9967.950160249153], "value": 7885.165419102068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.7117227451547, 1237.115462444352, 1247.5009996001597, 1313.540260908682, 1581.636223668556, 7363.779086627396, 7766.301032907038, 7795.025621797268, 7969.203079692028, 7990.680372785082, 7852.411069169807, 7965.163657815919, 7973.202679732039, 7975.162607926171, 7978.321842643368, 1815.972760408595, 2077.5013996640773, 2163.556470923461, 2178.0743184146754, 2185.9234926777567, 2148.602508535918, 2177.738671359431, 2182.19258874216, 2183.2467798609455, 2183.290430610058, 2101.3800928726064, 2126.0432805237706, 2126.1495401839234, 2126.383348828838, 2194.780521947808, 2079.9688004679942, 2137.2519618133683, 2142.335875878475, 2144.378130342199, 2146.3346362627635, 2114.693369461435, 2145.9356219313445, 2156.115992443091, 2156.1590979518, 2161.8919054047233, 7717.151113377524, 7756.689732410697, 7764.107127680332, 7767.495112817649, 7783.260590243918, 4457.33140028995, 4554.817807287704, 4580.885477863047, 4581.244094724367, 4584.770761461914, 2766.9446611067865, 2939.5590661400747, 2940.0885725424973, 2942.102658689099, 2950.5279155335256, 963.1812958984807, 1012.2003617142449, 1015.5328548867456, 1023.6724248240566, 1033.0289527843802, 10316.329438586468, 10385.688429347132, 10403.53184106717, 10447.895521044844, 10518.211134164969, 4141.358089496133, 4213.1784302060805, 4269.359596060615, 4322.71902326354, 4335.769851460682, 8344.374171937128, 8493.872591911002, 8500.617472213766, 8508.787280317918, 8512.0, 4508.098380323949, 4522.751248681354, 4527.705699129612, 4529.932051019237, 4549.249373853278, 3523.224890524081, 3969.166475040274, 4090.079732060263, 4172.102997855475, 4174.3321068628875, 3351.5475410819226, 3351.7821341612716, 3441.3633477806684, 3474.2704032153024, 3481.7562770606323, 1040.5629635553087, 1056.5034433816095, 1060.411471633251, 1071.9464026798628, 1072.0458791675414, 598.8771054273237, 673.727140508095, 709.2942522190453, 711.2567367101288, 721.6355740351194, 4563.520830312769, 4727.621790256771, 4730.408698912636, 4772.95227047732, 4901.805354630303, 726.5422783646269, 765.284459030808, 779.6218833865571, 801.8155824160359, 815.9306458951056, 3006.7895247332913, 3059.8011129276524, 3093.2421556718746, 3136.3570468053995, 3182.824944628068, 9343.0, 9778.022197780165, 9779.022097790164, 9782.951085244671, 9784.902150978542, 9724.513774311255, 9728.124468797841, 9732.172765314886, 9736.610535578639, 9740.318177727491, 7299.160596531361, 7412.0, 7414.777556673308, 7416.7774966751085, 7433.293837085468, 4534.773261336854, 4718.0, 4732.148213321635, 4759.0719809636785, 4779.737114458738, 8595.0, 8836.204741573289, 8898.11018898105, 8958.238549723086, 9026.909730902607, 9074.818503629758, 9124.31567632417, 9171.44971301724, 9189.86215206759, 9201.677941272023, 5525.475079867406, 5541.224228608079, 5709.885802284014, 5803.0, 5936.842315748388, 6984.4063254623925, 7041.225465198926, 7053.823654408681, 7054.224035356004, 7057.435405167472, 6220.0, 6282.403171698681, 6350.333215012357, 6394.584352017104, 6423.678816059271, 6037.849053773691, 6043.09353596964, 6092.147099405998, 6092.268927728701, 6134.631922084689, 5799.072148456226, 5909.645421274738, 5911.556633252438, 5916.67458289781, 5918.260217472816, 4258.318669012943, 4276.615104640598, 4282.764447955267, 4329.588014981274, 4449.110177964355, 4277.422547955986, 4282.743035417885, 4322.3948647190045, 4381.16757816014, 4443.777811109496], "value": 3959.543468582726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.1815326319987, 298.11014122843306, 301.59284965296837, 301.79327160894786, 306.2008158705779, 4691.90616187676, 4743.573078422941, 4832.492588278233, 4880.463149053606, 4885.0, 4804.663673542854, 4808.903821923559, 4826.3484429601995, 4830.574980380788, 4857.174280372336, 3862.961370386295, 3863.092173339263, 3865.8646947356847, 3867.6325749053794, 3869.361555343365, 3594.6944509716704, 3650.7627004244773, 3862.7296089273764, 3872.6320999505, 3896.707746918978, 3795.639414255655, 3799.8670046548377, 3804.239152169563, 3815.2369526094753, 3835.271298453285, 3806.562245341766, 3810.5617853946874, 3813.389857622795, 3828.483154774098, 3836.9808150959207, 3370.3090866372336, 3375.0718552398043, 3384.915377115567, 3389.57630296213, 3397.3205358928067, 4548.795304211319, 4730.385049943486, 4731.929021064687, 4738.218193997986, 4742.857714268577, 4355.216061108999, 4355.847545335898, 4358.847440339605, 4362.956370436286, 4371.431713877176, 4809.326694262806, 5076.654686508078, 5088.7964481420695, 5092.79628814847, 5092.893335065607, 3587.0, 3591.6587924147166, 3595.46068089786, 3602.6217247189193, 3604.8377822998027, 5263.710495922723, 5270.578353731692, 5277.393099793496, 5292.888493416387, 5303.602229832778, 3652.2878038782183, 3669.3945498992903, 3672.247189326182, 3682.576503702055, 3685.318216129971, 3596.1009747563107, 3701.592824789271, 3701.7408781385043, 3746.344389731786, 3748.8687895923513, 4236.110416812504, 4263.317869140985, 4266.656003358994, 4281.614654681093, 4297.462817147856, 5077.720725360141, 5085.288059671649, 5087.618428617869, 5088.185890257541, 5089.949100509021, 1220.5666988219232, 1221.5052903574067, 1283.4417028592593, 1289.7227096174367, 1301.1997621462922, 864.4208380385157, 876.027609353617, 880.097899652861, 889.1730690457807, 890.4790697442069, 4425.291953287458, 4431.4903786065015, 4439.556044395535, 4461.955380446219, 4478.529754375809, 5160.612954028463, 5183.714895680774, 5185.844424667266, 5206.843794686166, 5227.555657769056, 4388.429504164502, 4420.491643460979, 4433.889152771207, 4480.596746292849, 4486.371907932892, 2305.319930620471, 2416.634601450175, 2420.9031638734255, 2452.0, 2456.4647095565274, 4299.419578356944, 4343.500497442771, 4352.477702675699, 4353.49934757507, 4355.564443555619, 4653.045720797206, 4674.76626168697, 4696.8121275148615, 4702.3416721659, 4712.858614241578, 4093.4678491795876, 4357.782110894443, 4360.215161271001, 4380.6057454829215, 4386.890327741832, 4569.680122391401, 4580.725156490621, 4585.839495617637, 4590.74750888691, 4626.8149274028665, 4435.489918659267, 4477.574630410106, 4490.865274041784, 4512.435945506812, 4519.661025423172, 4126.546079931265, 4242.618164365222, 4309.978450107729, 4335.0, 4369.569887638188, 3301.5873015873017, 3311.2218628622736, 3317.253617935945, 3318.0, 3326.7504937130298, 4549.476810166873, 4553.704009239389, 4556.769672188557, 4559.794809233659, 4943.901121977468, 4765.332853400458, 5066.873328166826, 5079.6698214615935, 5080.339555857715, 5086.0, 5048.066107770074, 5052.0, 5059.392872855281, 5060.291559181791, 5069.493050694901, 4784.210605250095, 4968.056069346812, 4985.9501404985485, 5004.649674522749, 5028.019536190408, 5103.87240318995, 5111.258867464123, 5117.30916326306, 5118.923216151835, 5119.820806271762, 4999.775010124626, 5005.149124648891, 5005.924911126409, 5006.349174607278, 5008.348914641073], "value": 3706.3508842003607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.9802807887685, 543.6466296907013, 546.2243614068025, 557.0140850694271, 564.3989151553595, 11779.528818847246, 12911.612651620442, 12932.0, 12936.676583085427, 12938.74122517549, 10261.333013354146, 11294.661160165188, 11367.431628418588, 11373.374464404455, 11394.25937314074, 699.8425354295281, 729.449265804317, 731.524509069104, 732.2933369298626, 732.326259840945, 735.3161559749431, 739.3198257603018, 741.4809633256715, 741.60694831739, 744.8957145999565, 774.4694884004475, 774.6049514747491, 776.0, 776.1462391369505, 776.5845272779064, 765.5789315876245, 771.1055175995874, 771.1632878327022, 771.6604693934679, 771.7453240430644, 561.1946856261278, 561.4694114062213, 562.4628479801779, 562.6483447845097, 563.0568797264607, 12070.094742894318, 12078.939605302005, 12091.093168012347, 12117.212381195193, 12152.0, 10815.459227038695, 10938.124950003981, 11210.551577936872, 11215.214934954474, 11425.771484570261, 9385.953070234606, 9430.858537121949, 9544.52277386128, 9579.185769209556, 9580.281478889112, 3042.087373787877, 3079.9538006929915, 3094.5512900629283, 3102.1469095998555, 3145.638251601072, 53968.73015634936, 56069.0, 57019.144712829344, 62380.376196238365, 64727.35272647307, 8670.956645216733, 8946.418482798597, 9131.497767622845, 9144.131307525775, 9224.53877306132, 17032.48902532926, 17143.74284385735, 17167.227474763415, 17240.224189911485, 17435.215415306342, 6546.279909209983, 6623.172103487064, 6657.46740260778, 6673.599584024974, 6716.0, 3626.3472574936764, 3688.5942546319884, 3694.6859516941363, 3734.2158146788934, 3838.078861073378, 2628.5925681519393, 2726.481968425993, 2743.27303264635, 2745.766609838146, 2746.052611848909, 469.32651644889694, 472.23262198926744, 472.7305435901572, 476.4853957725648, 485.0275198227531, 449.11524297134594, 531.4711861697635, 546.2052713302136, 556.13798612151, 561.50026476436, 7506.9249307506225, 7515.595009596986, 7592.354649854824, 7607.500549747067, 7860.606969651494, 456.34058785055277, 553.4327314502667, 554.877926856091, 555.4556534596038, 559.3707079535523, 3526.1360966563357, 3674.3202507536193, 3767.7927713975996, 3945.3292940200236, 3978.6419222270133, 101847.0, 102418.48790755999, 102773.0, 104611.0, 105595.4720226394, 80068.0, 89536.0, 92829.5358523203, 93071.0, 93299.0, 48997.0, 66876.0, 72418.63790681012, 72760.0, 74726.25273747194, 7643.0, 8006.519608823489, 8109.415760937506, 8214.876776848472, 8233.917660823316, 42584.0, 44954.55045449504, 45243.0, 45374.31938520991, 46378.30432543582, 60031.399686004326, 63961.0, 64400.35599643944, 64961.0, 68799.65600172167, 9796.65711700087, 10016.148627366463, 10039.598416063276, 10137.898621013695, 10331.535080921227, 11463.369514676773, 11582.88417115818, 11706.414679265832, 11967.820482692592, 12348.320842353398, 11105.278156919774, 11140.665780026613, 11496.367699776592, 11646.592369267035, 11845.644630661094, 11397.829032564352, 11647.41762911868, 11977.461014254553, 12178.939105304416, 12397.75204495923, 10743.301685390425, 11275.492602833056, 11520.251183673034, 11605.825912611148, 11755.353455559683, 8915.375684523682, 9233.076692330713, 9313.39462934907, 9703.854442183514, 9724.465154416575, 8256.380771442045, 8849.64601415962, 9124.17882390588, 9468.824473760076, 9558.856617150888], "value": 6179.646462555197, "unit": "score"}], "name": "dromaeo_css", "value": 6197.381191022314, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 119.0, 114.0, 116.0, 117.0, 114.0, 114.0, 113.0, 128.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 152.0, 189.0, 126.0, 148.0, 156.0, 122.0, 182.0, 123.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 160.0, 161.0, 161.0, 162.0, 164.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 167.0, 78.0, 77.0, 77.0, 77.0, 155.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 148.0, 84.0, 83.0, 85.0, 137.0, 84.0, 83.0, 131.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 149.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 64.0, 65.0, 64.0, 63.0, 65.0, 63.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 84.0, 83.0, 82.0, 82.0, 83.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 131.0, 132.0, 133.0, 141.0, 141.0, 132.0, 197.0, 132.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 175.0, 173.0, 175.0, 182.0, 173.0, 174.0, 174.0, 176.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 70.0, 69.0, 71.0, 70.0, 69.0, 70.0, 68.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1577.0, "alertThreshold": 2.0}]} 09:02:09 INFO - Return code: 0 09:02:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:09 INFO - # TBPL SUCCESS # 09:02:09 INFO - Running post-action listener: _resource_record_post_action 09:02:09 INFO - [mozharness: 2016-09-03 16:02:09.829079Z] Finished run-tests step (success) 09:02:09 INFO - Running post-run listener: _resource_record_post_run 09:02:09 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406114304; Read time: 16; Write time: 376368 09:02:09 INFO - TinderboxPrint: CPU usage
13.1% 09:02:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:02:09 INFO - TinderboxPrint: I/O write bytes / time
406,114,304 / 376,368 09:02:09 INFO - TinderboxPrint: CPU idle
8,344.8 (86.9%) 09:02:09 INFO - TinderboxPrint: CPU user
1,211.0 (12.6%) 09:02:09 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114405376; Read time: 0; Write time: 137612 09:02:09 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291708928; Read time: 0; Write time: 238756 09:02:10 INFO - Running post-run listener: _upload_blobber_files 09:02:10 INFO - Blob upload gear active. 09:02:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:02:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:11 INFO - (blobuploader) - INFO - Done attempting. 09:02:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:02:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:12 INFO - (blobuploader) - INFO - Done attempting. 09:02:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:17 INFO - (blobuploader) - INFO - Done attempting. 09:02:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:17 INFO - Return code: 0 09:02:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589bbcdecd63762372299d301e48fe82d5184bf6b4103f058a366008f203b5c236c61a88cab7cff84268ae2f047a9b5344ad007ae8b8f3038aadeb08685a0321", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bd32e6609b6df2d1b1b828587c91a5e4af1b9912bfa4d925b234f113e1afcd2739278590cc1feaddfb3e4baf08138f22075b6563619773302bcf7fdb98d83ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a57e58e39323d52bea394e1a953f7aec63d70fc65c19b78f62fe41c59e3733c3ae67a114a62af0dd1f3be8da9b8321036af43329711d20fc7da89844f586350"} 09:02:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:17 INFO - Contents: 09:02:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589bbcdecd63762372299d301e48fe82d5184bf6b4103f058a366008f203b5c236c61a88cab7cff84268ae2f047a9b5344ad007ae8b8f3038aadeb08685a0321", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bd32e6609b6df2d1b1b828587c91a5e4af1b9912bfa4d925b234f113e1afcd2739278590cc1feaddfb3e4baf08138f22075b6563619773302bcf7fdb98d83ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a57e58e39323d52bea394e1a953f7aec63d70fc65c19b78f62fe41c59e3733c3ae67a114a62af0dd1f3be8da9b8321036af43329711d20fc7da89844f586350"} 09:02:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:17 INFO - Copying logs to upload dir... 09:02:17 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.545996 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-03 09:02:17.270396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 09:02:17.273793) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589bbcdecd63762372299d301e48fe82d5184bf6b4103f058a366008f203b5c236c61a88cab7cff84268ae2f047a9b5344ad007ae8b8f3038aadeb08685a0321", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bd32e6609b6df2d1b1b828587c91a5e4af1b9912bfa4d925b234f113e1afcd2739278590cc1feaddfb3e4baf08138f22075b6563619773302bcf7fdb98d83ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a57e58e39323d52bea394e1a953f7aec63d70fc65c19b78f62fe41c59e3733c3ae67a114a62af0dd1f3be8da9b8321036af43329711d20fc7da89844f586350"} build_url:https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/I-0OgOYiQQyJdY9UJ8PcEg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/589bbcdecd63762372299d301e48fe82d5184bf6b4103f058a366008f203b5c236c61a88cab7cff84268ae2f047a9b5344ad007ae8b8f3038aadeb08685a0321", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8bd32e6609b6df2d1b1b828587c91a5e4af1b9912bfa4d925b234f113e1afcd2739278590cc1feaddfb3e4baf08138f22075b6563619773302bcf7fdb98d83ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a57e58e39323d52bea394e1a953f7aec63d70fc65c19b78f62fe41c59e3733c3ae67a114a62af0dd1f3be8da9b8321036af43329711d20fc7da89844f586350"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 09:02:17.305190) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 09:02:17.305724) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472916399.105187-1517964610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 09:02:17.392492) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 09:02:17.392922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 09:02:17.393267) ========= ========= Total master_lag: 0.20 =========