builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1470626870.85 results: success (0) buildid: 20160807173002 builduid: 5c1a786ee8f9494cb29e5e4a36c0cfc0 revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:50.849730) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:50.850266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:50.850545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:50.864066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:50.864382) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 20:27:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-08-07 20:27:51 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:50.991531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:50.991822) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015091 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:51.040549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 20:27:51.040882) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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=7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 20:27:51,917 truncating revision to first 12 chars 2016-08-07 20:27:51,918 Setting DEBUG logging. 2016-08-07 20:27:51,918 attempt 1/10 2016-08-07 20:27:51,918 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/763fe887c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 20:27:52,592 unpacking tar archive at: fx-team-763fe887c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986979 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 20:27:52.075950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:52.076243) ========= script_repo_revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:52.076620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:52.076891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 20:27:52.101275) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-07 20:27:52.101536) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:27:53 INFO - MultiFileLogger online at 20160807 20:27:53 in /builds/slave/test 20:27:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:27:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:27:53 INFO - {'append_to_log': False, 20:27:53 INFO - 'base_work_dir': '/builds/slave/test', 20:27:53 INFO - 'blob_upload_branch': 'Fx-Team', 20:27:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:27:53 INFO - 'branch': 'Fx-Team', 20:27:53 INFO - 'buildbot_json_path': 'buildprops.json', 20:27:53 INFO - 'config_files': ('talos/linux_config.py',), 20:27:53 INFO - 'default_actions': ('clobber', 20:27:53 INFO - 'read-buildbot-config', 20:27:53 INFO - 'download-and-extract', 20:27:53 INFO - 'populate-webroot', 20:27:53 INFO - 'create-virtualenv', 20:27:53 INFO - 'install', 20:27:53 INFO - 'run-tests'), 20:27:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:27:53 INFO - 'download_minidump_stackwalk': True, 20:27:53 INFO - 'download_symbols': 'ondemand', 20:27:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:27:53 INFO - 'tooltool.py': '/tools/tooltool.py', 20:27:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:27:53 INFO - '/tools/misc-python/virtualenv.py')}, 20:27:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:27:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:27:53 INFO - 'installer_path': 'installer.exe', 20:27:53 INFO - 'log_level': 'info', 20:27:53 INFO - 'log_name': 'talos', 20:27:53 INFO - 'log_to_console': True, 20:27:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:27:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:27:53 INFO - 'opt_config_files': (), 20:27:53 INFO - 'pip_index': False, 20:27:53 INFO - 'sps_profile': False, 20:27:53 INFO - 'sps_profile_interval': 0, 20:27:53 INFO - 'suite': 'dromaeojs', 20:27:53 INFO - 'system_bits': '32', 20:27:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:27:53 INFO - 'title': 'talos-linux64-ix-005', 20:27:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:27:53 INFO - 'use_talos_json': True, 20:27:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:27:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:27:53 INFO - 'work_dir': 'build'} 20:27:53 INFO - [mozharness: 2016-08-08 03:27:53.064901Z] Running clobber step. 20:27:53 INFO - Running pre-action listener: _resource_record_pre_action 20:27:53 INFO - Running main action method: clobber 20:27:53 INFO - rmtree: /builds/slave/test/build 20:27:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:27:53 INFO - Running post-action listener: _resource_record_post_action 20:27:53 INFO - [mozharness: 2016-08-08 03:27:53.532857Z] Finished clobber step (success) 20:27:53 INFO - [mozharness: 2016-08-08 03:27:53.532958Z] Running read-buildbot-config step. 20:27:53 INFO - Running pre-action listener: _resource_record_pre_action 20:27:53 INFO - Running main action method: read_buildbot_config 20:27:53 INFO - Using buildbot properties: 20:27:53 INFO - { 20:27:53 INFO - "project": "", 20:27:53 INFO - "product": "firefox", 20:27:53 INFO - "script_repo_revision": "production", 20:27:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:27:53 INFO - "repository": "", 20:27:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:27:53 INFO - "buildid": "20160807173002", 20:27:53 INFO - "pgo_build": "True", 20:27:53 INFO - "basedir": "/builds/slave/test", 20:27:53 INFO - "buildnumber": 962, 20:27:53 INFO - "slavename": "talos-linux64-ix-005", 20:27:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:27:53 INFO - "platform": "ubuntu64_hw", 20:27:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:27:53 INFO - "branch": "fx-team", 20:27:53 INFO - "repo_path": "integration/fx-team", 20:27:53 INFO - "revision": "763fe887c37cee5fcfe0f00e94fdffc84a41ea1c", 20:27:53 INFO - "stage_platform": "linux64-pgo", 20:27:53 INFO - "builduid": "5c1a786ee8f9494cb29e5e4a36c0cfc0", 20:27:53 INFO - "slavebuilddir": "test" 20:27:53 INFO - } 20:27:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:27:53 INFO - Running post-action listener: _resource_record_post_action 20:27:53 INFO - [mozharness: 2016-08-08 03:27:53.535409Z] Finished read-buildbot-config step (success) 20:27:53 INFO - [mozharness: 2016-08-08 03:27:53.535498Z] Running download-and-extract step. 20:27:53 INFO - Running pre-action listener: _resource_record_pre_action 20:27:53 INFO - Running main action method: download_and_extract 20:27:53 INFO - mkdir: /builds/slave/test/build/tests 20:27: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')]} 20:27:53 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:54 INFO - Downloaded 1361 bytes. 20:27:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:27:54 INFO - Using the following test package requirements: 20:27:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:27:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:27:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'jsshell-linux-x86_64.zip'], 20:27:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:27:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:27:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:27:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:27:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:27:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:54 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:55 INFO - Downloaded 21828560 bytes. 20:27:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:56 INFO - Return code: 0 20:27:56 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 20:27:56 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')]} 20:27:56 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:57 INFO - Downloaded 21828560 bytes. 20:27:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:58 INFO - Return code: 0 20:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:58 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:27:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:59 INFO - Downloaded 14413723 bytes. 20:27:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:27:59 INFO - Return code: 0 20:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:59 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:27:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:28:01 INFO - Downloaded 59972841 bytes. 20:28:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:28:01 INFO - mkdir: /builds/slave/test/properties 20:28:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:28:01 INFO - Writing to file /builds/slave/test/properties/build_url 20:28:01 INFO - Contents: 20:28:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:28:01 INFO - Running post-action listener: _resource_record_post_action 20:28:01 INFO - Running post-action listener: set_extra_try_arguments 20:28:01 INFO - [mozharness: 2016-08-08 03:28:01.978224Z] Finished download-and-extract step (success) 20:28:01 INFO - [mozharness: 2016-08-08 03:28:01.978456Z] Running populate-webroot step. 20:28:01 INFO - Running pre-action listener: _resource_record_pre_action 20:28:01 INFO - Running main action method: populate_webroot 20:28:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:28:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:28:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:28:01 INFO - '--tppagecycles', 20:28:01 INFO - '7'], 20:28:01 INFO - 'tests': ['tsvgm']}}, 20:28:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:28:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:28:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:28:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:28:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['damp', 'tps']}, 20:28:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'tests': ['damp', 'tps']}, 20:28:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['dromaeo_dom']}, 20:28:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:28:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['basic_compositor_video']}, 20:28:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:28:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['a11yr', 20:28:01 INFO - 'ts_paint', 20:28:01 INFO - 'tpaint', 20:28:01 INFO - 'sessionrestore', 20:28:01 INFO - 'sessionrestore_no_auto_restore', 20:28:01 INFO - 'tabpaint']}, 20:28:01 INFO - 'other-e10s': {'tests': ['a11yr', 20:28:01 INFO - 'ts_paint', 20:28:01 INFO - 'tpaint', 20:28:01 INFO - 'sessionrestore', 20:28:01 INFO - 'sessionrestore_no_auto_restore', 20:28:01 INFO - 'tabpaint']}, 20:28:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:28:01 INFO - 'ts_paint', 20:28:01 INFO - 'tpaint', 20:28:01 INFO - 'sessionrestore', 20:28:01 INFO - 'sessionrestore_no_auto_restore', 20:28:01 INFO - 'tabpaint']}, 20:28:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:28:01 INFO - 'ts_paint', 20:28:01 INFO - 'tpaint', 20:28:01 INFO - 'sessionrestore', 20:28:01 INFO - 'sessionrestore_no_auto_restore', 20:28:01 INFO - 'tabpaint']}, 20:28:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['a11yr', 20:28:01 INFO - 'ts_paint', 20:28:01 INFO - 'tpaint', 20:28:01 INFO - 'sessionrestore', 20:28:01 INFO - 'sessionrestore_no_auto_restore', 20:28:01 INFO - 'tabpaint']}, 20:28:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['a11yr', 20:28:01 INFO - 'ts_paint', 20:28:01 INFO - 'tpaint', 20:28:01 INFO - 'sessionrestore', 20:28:01 INFO - 'sessionrestore_no_auto_restore', 20:28:01 INFO - 'tabpaint']}, 20:28:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['tsvgx', 20:28:01 INFO - 'tsvgr_opacity', 20:28:01 INFO - 'tart', 20:28:01 INFO - 'tscrollx', 20:28:01 INFO - 'cart']}, 20:28:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:28:01 INFO - 'tsvgr_opacity', 20:28:01 INFO - 'tart', 20:28:01 INFO - 'tscrollx', 20:28:01 INFO - 'cart']}, 20:28:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'talos_options': ['--disable-e10s'], 20:28:01 INFO - 'tests': ['tp5o']}, 20:28:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'tests': ['tp5o']}, 20:28:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'talos_options': ['--disable-e10s', 20:28:01 INFO - '--xperf_path', 20:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:01 INFO - 'tests': ['tp5n']}, 20:28:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:01 INFO - 'talos_options': ['--xperf_path', 20:28:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:01 INFO - 'tests': ['tp5n']}}, 20:28:01 INFO - 'talos.zip': {'path': '', 20:28:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:01 INFO - Running post-action listener: _resource_record_post_action 20:28:01 INFO - [mozharness: 2016-08-08 03:28:01.998061Z] Finished populate-webroot step (success) 20:28:01 INFO - [mozharness: 2016-08-08 03:28:01.998150Z] Running create-virtualenv step. 20:28:01 INFO - Running pre-action listener: _resource_record_pre_action 20:28:01 INFO - Running main action method: create_virtualenv 20:28:01 INFO - Creating virtualenv /builds/slave/test/build/venv 20:28:01 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 20:28:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:28:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:28:02 INFO - Using real prefix '/usr' 20:28:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:28:02 INFO - Installing distribute.............................................................................................................................................................................................done. 20:28:04 INFO - Installing pip.................done. 20:28:04 INFO - Return code: 0 20:28:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28: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', 'pip>=1.5'] in /builds/slave/test/build 20:28: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 pip>=1.5 20:28:04 INFO - Using env: {'DISPLAY': ':0', 20:28:04 INFO - 'HOME': '/home/cltbld', 20:28:04 INFO - 'LANG': 'en_US.UTF-8', 20:28:04 INFO - 'LANGUAGE': 'en_US:en', 20:28:04 INFO - 'LOGNAME': 'cltbld', 20:28:04 INFO - 'MAIL': '/var/mail/cltbld', 20:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:04 INFO - 'MOZ_NO_REMOTE': '1', 20:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:04 INFO - 'NO_EM_RESTART': '1', 20:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:04 INFO - 'PWD': '/builds/slave/test', 20:28:04 INFO - 'SHELL': '/bin/bash', 20:28:04 INFO - 'SHLVL': '1', 20:28:04 INFO - 'TERM': 'linux', 20:28:04 INFO - 'TMOUT': '86400', 20:28:04 INFO - 'USER': 'cltbld', 20:28:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:04 INFO - '_': '/tools/buildbot/bin/python'} 20:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:04 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 20:28:04 INFO - Cleaning up... 20:28:04 INFO - Return code: 0 20:28:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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', '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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:28: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 psutil>=3.1.1 20:28:04 INFO - Using env: {'DISPLAY': ':0', 20:28:04 INFO - 'HOME': '/home/cltbld', 20:28:04 INFO - 'LANG': 'en_US.UTF-8', 20:28:04 INFO - 'LANGUAGE': 'en_US:en', 20:28:04 INFO - 'LOGNAME': 'cltbld', 20:28:04 INFO - 'MAIL': '/var/mail/cltbld', 20:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:04 INFO - 'MOZ_NO_REMOTE': '1', 20:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:04 INFO - 'NO_EM_RESTART': '1', 20:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:04 INFO - 'PWD': '/builds/slave/test', 20:28:04 INFO - 'SHELL': '/bin/bash', 20:28:04 INFO - 'SHLVL': '1', 20:28:04 INFO - 'TERM': 'linux', 20:28:04 INFO - 'TMOUT': '86400', 20:28:04 INFO - 'USER': 'cltbld', 20:28:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:04 INFO - '_': '/tools/buildbot/bin/python'} 20:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:05 INFO - Downloading/unpacking psutil>=3.1.1 20:28:05 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 20:28:05 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 20:28:05 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 20:28:05 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 20:28:05 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 20:28:05 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 20:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:28:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:07 INFO - Installing collected packages: psutil 20:28:07 INFO - Running setup.py install for psutil 20:28:07 INFO - building 'psutil._psutil_linux' extension 20:28:07 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 20:28:07 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 20:28:07 INFO - building 'psutil._psutil_posix' extension 20:28:07 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 20:28:07 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 20:28:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:07 INFO - Successfully installed psutil 20:28:07 INFO - Cleaning up... 20:28:07 INFO - Return code: 0 20:28:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:07 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:07 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 20:28:07 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 20:28:07 INFO - Using env: {'DISPLAY': ':0', 20:28:07 INFO - 'HOME': '/home/cltbld', 20:28:07 INFO - 'LANG': 'en_US.UTF-8', 20:28:07 INFO - 'LANGUAGE': 'en_US:en', 20:28:07 INFO - 'LOGNAME': 'cltbld', 20:28:07 INFO - 'MAIL': '/var/mail/cltbld', 20:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:07 INFO - 'MOZ_NO_REMOTE': '1', 20:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:07 INFO - 'NO_EM_RESTART': '1', 20:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:07 INFO - 'PWD': '/builds/slave/test', 20:28:07 INFO - 'SHELL': '/bin/bash', 20:28:07 INFO - 'SHLVL': '1', 20:28:07 INFO - 'TERM': 'linux', 20:28:07 INFO - 'TMOUT': '86400', 20:28:07 INFO - 'USER': 'cltbld', 20:28:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:07 INFO - '_': '/tools/buildbot/bin/python'} 20:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:28:07 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 20:28:07 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 20:28:07 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 20:28:07 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 20:28:07 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 20:28:07 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 20:28:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:28:09 INFO - Installing collected packages: mozsystemmonitor 20:28:09 INFO - Running setup.py install for mozsystemmonitor 20:28:09 INFO - Successfully installed mozsystemmonitor 20:28:09 INFO - Cleaning up... 20:28:10 INFO - Return code: 0 20:28:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:28:10 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')]} 20:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:10 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')]} 20:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:10 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:10 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 20:28:10 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 20:28:10 INFO - Using env: {'DISPLAY': ':0', 20:28:10 INFO - 'HOME': '/home/cltbld', 20:28:10 INFO - 'LANG': 'en_US.UTF-8', 20:28:10 INFO - 'LANGUAGE': 'en_US:en', 20:28:10 INFO - 'LOGNAME': 'cltbld', 20:28:10 INFO - 'MAIL': '/var/mail/cltbld', 20:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:10 INFO - 'MOZ_NO_REMOTE': '1', 20:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:10 INFO - 'NO_EM_RESTART': '1', 20:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:10 INFO - 'PWD': '/builds/slave/test', 20:28:10 INFO - 'SHELL': '/bin/bash', 20:28:10 INFO - 'SHLVL': '1', 20:28:10 INFO - 'TERM': 'linux', 20:28:10 INFO - 'TMOUT': '86400', 20:28:10 INFO - 'USER': 'cltbld', 20:28:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:10 INFO - '_': '/tools/buildbot/bin/python'} 20:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:10 INFO - Downloading/unpacking jsonschema==2.5.1 20:28:10 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 20:28:10 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 20:28:10 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 20:28:10 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 20:28:10 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 20:28:10 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 20:28:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:28:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:12 INFO - Downloading functools32-3.2.3-2.tar.gz 20:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:28:12 INFO - warning: no files found matching '*.txt' 20:28:12 INFO - no previously-included directories found matching 'build' 20:28:12 INFO - no previously-included directories found matching 'dist' 20:28:12 INFO - no previously-included directories found matching '.git*' 20:28:12 INFO - Installing collected packages: jsonschema, functools32 20:28:12 INFO - Running setup.py install for functools32 20:28:12 INFO - warning: no files found matching '*.txt' 20:28:12 INFO - no previously-included directories found matching 'build' 20:28:12 INFO - no previously-included directories found matching 'dist' 20:28:12 INFO - no previously-included directories found matching '.git*' 20:28:12 INFO - Successfully installed jsonschema functools32 20:28:12 INFO - Cleaning up... 20:28:12 INFO - Return code: 0 20:28:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:28:12 INFO - Using env: {'DISPLAY': ':0', 20:28:12 INFO - 'HOME': '/home/cltbld', 20:28:12 INFO - 'LANG': 'en_US.UTF-8', 20:28:12 INFO - 'LANGUAGE': 'en_US:en', 20:28:12 INFO - 'LOGNAME': 'cltbld', 20:28:12 INFO - 'MAIL': '/var/mail/cltbld', 20:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:12 INFO - 'MOZ_NO_REMOTE': '1', 20:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:12 INFO - 'NO_EM_RESTART': '1', 20:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:12 INFO - 'PWD': '/builds/slave/test', 20:28:12 INFO - 'SHELL': '/bin/bash', 20:28:12 INFO - 'SHLVL': '1', 20:28:12 INFO - 'TERM': 'linux', 20:28:12 INFO - 'TMOUT': '86400', 20:28:12 INFO - 'USER': 'cltbld', 20:28:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:12 INFO - '_': '/tools/buildbot/bin/python'} 20:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:28:12 INFO - Cleaning up... 20:28:12 INFO - Return code: 0 20:28:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:28:12 INFO - Using env: {'DISPLAY': ':0', 20:28:12 INFO - 'HOME': '/home/cltbld', 20:28:12 INFO - 'LANG': 'en_US.UTF-8', 20:28:12 INFO - 'LANGUAGE': 'en_US:en', 20:28:12 INFO - 'LOGNAME': 'cltbld', 20:28:12 INFO - 'MAIL': '/var/mail/cltbld', 20:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:12 INFO - 'MOZ_NO_REMOTE': '1', 20:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:12 INFO - 'NO_EM_RESTART': '1', 20:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:12 INFO - 'PWD': '/builds/slave/test', 20:28:12 INFO - 'SHELL': '/bin/bash', 20:28:12 INFO - 'SHLVL': '1', 20:28:12 INFO - 'TERM': 'linux', 20:28:12 INFO - 'TMOUT': '86400', 20:28:12 INFO - 'USER': 'cltbld', 20:28:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:12 INFO - '_': '/tools/buildbot/bin/python'} 20:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:12 INFO - Downloading/unpacking blobuploader==1.2.4 20:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:14 INFO - Downloading blobuploader-1.2.4.tar.gz 20:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:28:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:28:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:28:15 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 20:28:15 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 20:28:15 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 20:28:15 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 20:28:15 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 20:28:15 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 20:28:15 INFO - Downloading docopt-0.6.1.tar.gz 20:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:28:15 INFO - Installing collected packages: blobuploader, requests, docopt 20:28:15 INFO - Running setup.py install for blobuploader 20:28:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:28:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:28:15 INFO - Running setup.py install for requests 20:28:16 INFO - Running setup.py install for docopt 20:28:16 INFO - Successfully installed blobuploader requests docopt 20:28:16 INFO - Cleaning up... 20:28:16 INFO - Return code: 0 20:28:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:16 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:16 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 20:28:16 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 20:28:16 INFO - Using env: {'DISPLAY': ':0', 20:28:16 INFO - 'HOME': '/home/cltbld', 20:28:16 INFO - 'LANG': 'en_US.UTF-8', 20:28:16 INFO - 'LANGUAGE': 'en_US:en', 20:28:16 INFO - 'LOGNAME': 'cltbld', 20:28:16 INFO - 'MAIL': '/var/mail/cltbld', 20:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:16 INFO - 'MOZ_NO_REMOTE': '1', 20:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:16 INFO - 'NO_EM_RESTART': '1', 20:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:16 INFO - 'PWD': '/builds/slave/test', 20:28:16 INFO - 'SHELL': '/bin/bash', 20:28:16 INFO - 'SHLVL': '1', 20:28:16 INFO - 'TERM': 'linux', 20:28:16 INFO - 'TMOUT': '86400', 20:28:16 INFO - 'USER': 'cltbld', 20:28:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:16 INFO - '_': '/tools/buildbot/bin/python'} 20:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:16 INFO - Running setup.py (path:/tmp/pip-5chrXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:16 INFO - Running setup.py (path:/tmp/pip-l4WwsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:16 INFO - Running setup.py (path:/tmp/pip-TJojBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:16 INFO - Running setup.py (path:/tmp/pip-6CuiOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:16 INFO - Running setup.py (path:/tmp/pip-7kO6SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:16 INFO - Running setup.py (path:/tmp/pip-EKTqb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:16 INFO - Running setup.py (path:/tmp/pip-aw8IQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:16 INFO - Running setup.py (path:/tmp/pip-gFaRnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:17 INFO - Running setup.py (path:/tmp/pip-qjDmmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:17 INFO - Running setup.py (path:/tmp/pip-GYNN6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:17 INFO - Running setup.py (path:/tmp/pip-mg1YIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:17 INFO - Running setup.py (path:/tmp/pip-9Y0TjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:17 INFO - Running setup.py (path:/tmp/pip-2zBg3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:17 INFO - Running setup.py (path:/tmp/pip-rlwBHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:17 INFO - Running setup.py (path:/tmp/pip-J3TK_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:17 INFO - Running setup.py (path:/tmp/pip-ZAraGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:17 INFO - Running setup.py (path:/tmp/pip-m57jKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:28:17 INFO - Running setup.py install for manifestparser 20:28:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:28:17 INFO - Running setup.py install for mozcrash 20:28:17 INFO - Running setup.py install for mozdebug 20:28:18 INFO - Running setup.py install for mozdevice 20:28:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Running setup.py install for mozfile 20:28:18 INFO - Running setup.py install for mozhttpd 20:28:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Running setup.py install for mozinfo 20:28:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Running setup.py install for mozInstall 20:28:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Running setup.py install for mozleak 20:28:18 INFO - Running setup.py install for mozlog 20:28:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Running setup.py install for moznetwork 20:28:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:28:18 INFO - Running setup.py install for mozprocess 20:28:18 INFO - Running setup.py install for mozprofile 20:28:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Running setup.py install for mozrunner 20:28:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Running setup.py install for mozscreenshot 20:28:19 INFO - Running setup.py install for moztest 20:28:19 INFO - Running setup.py install for mozversion 20:28:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:28:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:28:19 INFO - Cleaning up... 20:28:19 INFO - Return code: 0 20:28:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:19 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')]} 20:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:19 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')]} 20:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:19 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:19 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 20:28:19 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 20:28:19 INFO - Using env: {'DISPLAY': ':0', 20:28:19 INFO - 'HOME': '/home/cltbld', 20:28:19 INFO - 'LANG': 'en_US.UTF-8', 20:28:19 INFO - 'LANGUAGE': 'en_US:en', 20:28:19 INFO - 'LOGNAME': 'cltbld', 20:28:19 INFO - 'MAIL': '/var/mail/cltbld', 20:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:19 INFO - 'MOZ_NO_REMOTE': '1', 20:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:19 INFO - 'NO_EM_RESTART': '1', 20:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:19 INFO - 'PWD': '/builds/slave/test', 20:28:19 INFO - 'SHELL': '/bin/bash', 20:28:19 INFO - 'SHLVL': '1', 20:28:19 INFO - 'TERM': 'linux', 20:28:19 INFO - 'TMOUT': '86400', 20:28:19 INFO - 'USER': 'cltbld', 20:28:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:19 INFO - '_': '/tools/buildbot/bin/python'} 20:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:19 INFO - Running setup.py (path:/tmp/pip-KLTVFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:19 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)) 20:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:19 INFO - Running setup.py (path:/tmp/pip-FajtYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:19 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)) 20:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:19 INFO - Running setup.py (path:/tmp/pip-KgTb3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:19 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)) 20:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:19 INFO - Running setup.py (path:/tmp/pip-RgIC3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:20 INFO - Running setup.py (path:/tmp/pip-oNEKV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:20 INFO - Running setup.py (path:/tmp/pip-BL8M8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:20 INFO - Running setup.py (path:/tmp/pip-pl5Esx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:20 INFO - Running setup.py (path:/tmp/pip-lPxsRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:20 INFO - Running setup.py (path:/tmp/pip-gFl1rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:20 INFO - Running setup.py (path:/tmp/pip-mW58F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:20 INFO - Running setup.py (path:/tmp/pip-e2DhmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:20 INFO - Running setup.py (path:/tmp/pip-MC8Jgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:20 INFO - Running setup.py (path:/tmp/pip-HzBiO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:20 INFO - Running setup.py (path:/tmp/pip-IDv9iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:20 INFO - Running setup.py (path:/tmp/pip-aJDhr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:20 INFO - Running setup.py (path:/tmp/pip-3HnwEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:20 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)) 20:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:20 INFO - Running setup.py (path:/tmp/pip-nNQK7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:20 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)) 20:28:20 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)) 20:28:20 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)) 20:28:20 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)) 20:28:20 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)) 20:28:20 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)) 20:28:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:22 INFO - Downloading blessings-1.6.tar.gz 20:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:28:22 INFO - Installing collected packages: blessings 20:28:22 INFO - Running setup.py install for blessings 20:28:23 INFO - Successfully installed blessings 20:28:23 INFO - Cleaning up... 20:28:23 INFO - Return code: 0 20:28:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:28:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:23 INFO - Reading from file tmpfile_stdout 20:28:23 INFO - Current package versions: 20:28:23 INFO - argparse == 1.2.1 20:28:23 INFO - blessings == 1.6 20:28:23 INFO - blobuploader == 1.2.4 20:28:23 INFO - docopt == 0.6.1 20:28:23 INFO - functools32 == 3.2.3-2 20:28:23 INFO - jsonschema == 2.5.1 20:28:23 INFO - manifestparser == 1.1 20:28:23 INFO - mozInstall == 1.12 20:28:23 INFO - mozcrash == 0.17 20:28:23 INFO - mozdebug == 0.1 20:28:23 INFO - mozdevice == 0.48 20:28:23 INFO - mozfile == 1.2 20:28:23 INFO - mozhttpd == 0.7 20:28:23 INFO - mozinfo == 0.9 20:28:23 INFO - mozleak == 0.1 20:28:23 INFO - mozlog == 3.3 20:28:23 INFO - moznetwork == 0.27 20:28:23 INFO - mozprocess == 0.23 20:28:23 INFO - mozprofile == 0.28 20:28:23 INFO - mozrunner == 6.12 20:28:23 INFO - mozscreenshot == 0.1 20:28:23 INFO - mozsystemmonitor == 0.3 20:28:23 INFO - moztest == 0.7 20:28:23 INFO - mozversion == 1.4 20:28:23 INFO - psutil == 3.1.1 20:28:23 INFO - requests == 1.2.3 20:28:23 INFO - wsgiref == 0.1.2 20:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:23 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')]} 20:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:23 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')]} 20:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:23 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:23 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 20:28:23 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 20:28:23 INFO - Using env: {'DISPLAY': ':0', 20:28:23 INFO - 'HOME': '/home/cltbld', 20:28:23 INFO - 'LANG': 'en_US.UTF-8', 20:28:23 INFO - 'LANGUAGE': 'en_US:en', 20:28:23 INFO - 'LOGNAME': 'cltbld', 20:28:23 INFO - 'MAIL': '/var/mail/cltbld', 20:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:23 INFO - 'MOZ_NO_REMOTE': '1', 20:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:23 INFO - 'NO_EM_RESTART': '1', 20:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:23 INFO - 'PWD': '/builds/slave/test', 20:28:23 INFO - 'SHELL': '/bin/bash', 20:28:23 INFO - 'SHLVL': '1', 20:28:23 INFO - 'TERM': 'linux', 20:28:23 INFO - 'TMOUT': '86400', 20:28:23 INFO - 'USER': 'cltbld', 20:28:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:23 INFO - '_': '/tools/buildbot/bin/python'} 20:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 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)) 20:28:23 INFO - Cleaning up... 20:28:23 INFO - Return code: 0 20:28:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:28:23 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')]} 20:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:23 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')]} 20:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:23 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 0x1314030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', '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 20:28:23 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 20:28:23 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 20:28:23 INFO - Using env: {'DISPLAY': ':0', 20:28:23 INFO - 'HOME': '/home/cltbld', 20:28:23 INFO - 'LANG': 'en_US.UTF-8', 20:28:23 INFO - 'LANGUAGE': 'en_US:en', 20:28:23 INFO - 'LOGNAME': 'cltbld', 20:28:23 INFO - 'MAIL': '/var/mail/cltbld', 20:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:23 INFO - 'MOZ_NO_REMOTE': '1', 20:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:23 INFO - 'NO_EM_RESTART': '1', 20:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:23 INFO - 'PWD': '/builds/slave/test', 20:28:23 INFO - 'SHELL': '/bin/bash', 20:28:23 INFO - 'SHLVL': '1', 20:28:23 INFO - 'TERM': 'linux', 20:28:23 INFO - 'TMOUT': '86400', 20:28:23 INFO - 'USER': 'cltbld', 20:28:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:23 INFO - '_': '/tools/buildbot/bin/python'} 20:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:28:23 INFO - Cleaning up... 20:28:23 INFO - Return code: 0 20:28:23 INFO - Running post-action listener: _resource_record_post_action 20:28:23 INFO - Running post-action listener: _start_resource_monitoring 20:28:23 INFO - Starting resource monitoring. 20:28:23 INFO - [mozharness: 2016-08-08 03:28:23.807560Z] Finished create-virtualenv step (success) 20:28:23 INFO - [mozharness: 2016-08-08 03:28:23.807998Z] Running install step. 20:28:23 INFO - Running pre-action listener: _resource_record_pre_action 20:28:23 INFO - Running main action method: install 20:28:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:24 INFO - Reading from file tmpfile_stdout 20:28:24 INFO - Detecting whether we're running mozinstall >=1.0... 20:28:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:28:24 INFO - Reading from file tmpfile_stdout 20:28:24 INFO - Output received: 20:28:24 INFO - Usage: mozinstall [options] installer 20:28:24 INFO - Options: 20:28:24 INFO - -h, --help show this help message and exit 20:28:24 INFO - -d DEST, --destination=DEST 20:28:24 INFO - Directory to install application into. [default: 20:28:24 INFO - "/builds/slave/test"] 20:28:24 INFO - --app=APP Application being installed. [default: firefox] 20:28:24 INFO - mkdir: /builds/slave/test/build/application 20:28:24 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'] 20:28:24 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 20:28:41 INFO - Reading from file tmpfile_stdout 20:28:41 INFO - Output received: 20:28:41 INFO - /builds/slave/test/build/application/firefox/firefox 20:28:41 INFO - Running post-action listener: _resource_record_post_action 20:28:41 INFO - [mozharness: 2016-08-08 03:28:41.229279Z] Finished install step (success) 20:28:41 INFO - [mozharness: 2016-08-08 03:28:41.229528Z] Running run-tests step. 20:28:41 INFO - Running pre-action listener: _resource_record_pre_action 20:28:41 INFO - Running main action method: run_tests 20:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:28:41 INFO - Python 2.7.3 20:28:41 INFO - Return code: 0 20:28:41 INFO - grabbing minidump binary from tooltool 20:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:41 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 0x15d33b0>, '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 0x15d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:28:41 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 20:28:41 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 20:28:41 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 20:28:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:28:41 INFO - Return code: 0 20:28:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:28:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:28:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:28:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:28:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 20:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 20:28:41 INFO - Using env: {'DISPLAY': ':0', 20:28:41 INFO - 'HOME': '/home/cltbld', 20:28:41 INFO - 'LANG': 'en_US.UTF-8', 20:28:41 INFO - 'LANGUAGE': 'en_US:en', 20:28:41 INFO - 'LOGNAME': 'cltbld', 20:28:41 INFO - 'MAIL': '/var/mail/cltbld', 20:28:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:28:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:41 INFO - 'MOZ_NO_REMOTE': '1', 20:28:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:41 INFO - 'NO_EM_RESTART': '1', 20:28:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:41 INFO - 'PWD': '/builds/slave/test', 20:28:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:28:41 INFO - 'SHELL': '/bin/bash', 20:28:41 INFO - 'SHLVL': '1', 20:28:41 INFO - 'TERM': 'linux', 20:28:41 INFO - 'TMOUT': '86400', 20:28:41 INFO - 'USER': 'cltbld', 20:28:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833', 20:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:41 INFO - '_': '/tools/buildbot/bin/python'} 20:28:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 20:28:41 INFO - mozversion application_buildid: 20160807173002 20:28:41 INFO - mozversion application_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 20:28:41 INFO - mozversion application_display_name: Nightly 20:28:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:28:41 INFO - mozversion application_name: Firefox 20:28:41 INFO - mozversion application_remotingname: firefox 20:28:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:28:41 INFO - mozversion application_vendor: Mozilla 20:28:41 INFO - mozversion application_version: 51.0a1 20:28:41 INFO - mozversion platform_buildid: 20160807173002 20:28:41 INFO - mozversion platform_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 20:28:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:28:41 INFO - mozversion platform_version: 51.0a1 20:28:41 INFO - using testdate: 1470626921 20:28:41 INFO - actual date: 1470626921 20:28:41 INFO - starting webserver on 'localhost:35640' 20:28:41 INFO - SUITE-START | Running 2 tests 20:28:41 INFO - TEST-START | dromaeo_css 20:28:41 INFO - operating with platform_type : linux_ 20:28:41 INFO - Initialising browser for dromaeo_css test... 20:28:41 INFO - TEST-INFO | started process 13078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWm6gs/profile http://localhost:35640/getInfo.html) 20:28:45 INFO - PROCESS | 13078 | __metrics Screen width/height:1600/1200 20:28:45 INFO - PROCESS | 13078 | colorDepth:24 20:28:45 INFO - PROCESS | 13078 | Browser inner width/height: 1024/697 20:28:45 INFO - PROCESS | 13078 | __metrics 20:28:46 INFO - PROCESS | 13078 | 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" 20:28:46 INFO - PROCESS | 13078 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:46 INFO - PROCESS | 13078 | console.error: PushService: 20:28:46 INFO - PROCESS | 13078 | stateChangeProcessEnqueue: Error transitioning state 20:28:46 INFO - PROCESS | 13078 | UnknownError 20:28:47 INFO - TEST-INFO | 13078: exit 0 20:28:47 INFO - Browser initialized. 20:28:47 INFO - Running cycle 1/1 for dromaeo_css test... 20:28:47 INFO - TEST-INFO | started process 13158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWm6gs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:58 INFO - PROCESS | 13158 | RSS: Main: 156078080 20:28:58 INFO - PROCESS | 13158 | 20:29:49 INFO - PROCESS | 13158 | 1470626989839 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] 20:31:59 INFO - PROCESS | 13158 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35640/tests/dromaeo/cssquery-ext.html) 20:32:00 INFO - PROCESS | 13158 | RSS: Main: 281235456 20:32:00 INFO - PROCESS | 13158 | 20:35:03 INFO - PROCESS | 13158 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-ext.html (next: http://localhost:35640/tests/dromaeo/cssquery-jquery.html) 20:35:03 INFO - PROCESS | 13158 | RSS: Main: 240562176 20:35:03 INFO - PROCESS | 13158 | 20:38:05 INFO - PROCESS | 13158 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35640/tests/dromaeo/cssquery-mootools.html) 20:38:06 INFO - PROCESS | 13158 | RSS: Main: 186011648 20:38:06 INFO - PROCESS | 13158 | 20:41:08 INFO - PROCESS | 13158 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35640/tests/dromaeo/cssquery-prototype.html) 20:41:08 INFO - PROCESS | 13158 | RSS: Main: 239087616 20:41:08 INFO - PROCESS | 13158 | 20:44:11 INFO - PROCESS | 13158 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35640/tests/dromaeo/cssquery-yui.html) 20:44:12 INFO - PROCESS | 13158 | RSS: Main: 182886400 20:44:12 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-yui.html (next: http://localhost:35640/tests/dromaeo/cssquery-dojo.html) 20:47:14 INFO - PROCESS | 13158 | RSS: Main: 275496960 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | __start_tp_report 20:47:14 INFO - PROCESS | 13158 | _x_x_mozilla_page_load 20:47:14 INFO - PROCESS | 13158 | _x_x_mozilla_page_load_details 20:47:14 INFO - PROCESS | 13158 | |i|pagename|runs| 20:47:14 INFO - PROCESS | 13158 | |0;dojo.html;2973.0783457128305;2978.210774144852;3010.6387233531964;3042.6196725409322;3086.614173228346;5200.115980283352;5272.077386457369;5290.7354632268425;5330.600204984627;5383.219433182187;5267.920981185285;5268.762905669245;5282.2076688496745;5318.095923692972;5356.062689029414;4798.4961579034225;4823.517648235174;4831.178699621055;4843.685160464576;4987.850364489072;4915.754212289389;4944.703317800925;4951.826686065989;4961.05739909416;4981.302617633516;4710.034442939189;4772.093302272592;4789.090072886141;4894.290327902452;4912.091263116317;4831.323614693945;4839.27410888366;4844.878878028042;4847.466778654345;4849.272609108627;4786.712797232177;4806.903861922777;4817.205161148407;4817.614590832725;4828.758562071917;5243.554297884646;5252.474752524755;5257.342832145981;5294.126469132589;5333.973330133324;5701.287339082614;5744.6840423776675;5750.884982300372;5757.424257574251;5759.22250496186;5511.255980442669;5743.0811070228565;5805.983952808284;5809.215755872945;5822.010258256064;5245.1869960155855;5304.761285742113;5324.893502130013;5331.3868905076415;5387.622866399314;5829.708514574254;5897.351291357947;5907.409259074144;5908.615939963888;5917.55618328627;5378.435264297271;5520;5677.063284558001;5689.175069614883;5691.146328050825;5631.971840140773;5679.148127780783;5732.828015159552;5733.31200255972;5734.885302294014;5644.379118296984;5648.8870222595315;5651.632643878134;5655.717214139277;5655.886882262414;5486.31421072366;5563.276774019432;5665.915011274834;5673.404292549306;5675.631083979611;4328.567143285709;4347.130573885235;4351.0210202704775;4392.363107349416;4397;3859.807009649506;3860.401637746154;3870.07118291608;3889.241597888441;3899.473571067926;5174.97412512935;5293.841184764463;5318.149096144598;5332.493413125747;5376.731163441812;5649.152627105967;5683.0338842396895;5705.600607957486;5735.913961290584;5752;5356.892862142813;5360.571154307646;5365.061114304981;5366.060939335601;5369.033573956725;4692.389989301437;4839.225723884161;4853.466118726938;4891.779869905863;4928.6303527235605;5857.912131318034;5899.498542623754;5905.966455870205;5949.672767997802;5954.940450595525;5688.317401911797;5688.8577785554035;5693.28833895763;5694.772209111589;5697.373288938131;5681.659100453986;5771.8557036074435;5907.940920590911;5911.290645122613;5918.2898052234;5539.14143307788;5545.1682247663175;5579;5616.466435688603;5629.746661400165;5635.887282254414;5643.435656434323;5644.181593668813;5646.209530665628;5658.717064146858;5351.892962140813;5499.9175012375645;5515.558755299647;5525.171224316385;5532.336119665666;5531.391546929754;5577.44225577439;5581.441855814386;5609.663420194802;5616.943830561642;5455.727213639381;5458.890822183614;5459.372172200247;5460.453954604666;5479.835604931858;5361.383440904346;5545.417731138334;5584.581156413204;5656.773729050792;5660.85847853807;5324.467553244799;5436.184572314184;5437.048516509516;5491.203775452617;5548.833534993795 20:47:14 INFO - PROCESS | 13158 | |1;ext.html;596.3916804859044;601.449673548703;617.6788070203492;633.7655067624978;639.5874660843753;44025.779871100676;45541.77229113858;45638.77180614096;45768.08463830726;49701.751491242496;45955;46413.30380044302;46492.302615460794;46495.53504464963;46535;8913.821723565508;9062.909370906305;9065.138811812867;9068.274538036974;9071.727848164566;8918.866217006751;9032.68385606504;9045.909540904606;9047.909520904805;9051.683191088314;9050;9113.726588202364;9117.72646820593;9118.224950879183;9122.908770912305;8998.86501702475;9039.502827344493;9048.77378065547;9050.04974477677;9050.04974477677;8985.910140898573;9047.68333108338;9048.547572621343;9053;9054.86417703735;43736.343954840704;43781.34327985083;43987.78006109981;44195.33706994398;44242.557574424485;3534.452159915217;3620.9094772630633;3628.7459877808565;3631.836567354449;3721.832517536717;32363.32619217653;33133.17167070819;33477.163070923176;33539.32921341584;33542;4356.259435895874;4368.47578290604;4390.27560452525;4445.53321901199;4591.586757191869;365937;365986;366611;366735.9999999973;367967.24229303957;59626.70186649039;59719.402805972255;59763;59845.70077149587;59975.70012149911;57648;57815.421845781006;57857.4214257852;57901.71049144812;57908;15198.772018419733;15377.53867383958;15383.61540961485;15385.153816540198;15387;12008.219465734699;12083.033357331393;12088.879111208951;12089.15375923677;12093.093018023683;15792.842071579367;18074.277028918696;18145.45563633093;18165.09174541294;18269.269229230948;5717.885642287131;6537.509686773511;6703.162104736908;6725.286118754225;6728.394444499921;1013.6502906497246;1037.8131936251395;1130.1693255457233;1133.3992983718642;1178.251810100575;32433.837830810695;32940;33431.3313733724;33671.15822104467;34271.4859277111;1143.8627364716122;1165.3066425476827;1170;1173.8356630071626;1210.4613447015993;17110.401135960183;17689.46931592054;17694.380696675555;17720.291188352578;17799.19903604341;566883;571749;571795;572721;572995;59768.70115649394;60361.66202548757;60401.69799150976;60443.39556604466;60504.69747651234;1254.5044707340733;1340.9128406653535;1381.5855243427134;1396.6019684390103;1397.6785339372002;33118.66881331156;34383;35251.64748352484;35314;35380.46929296114;51869.7406512965;52433.7378313106;52463.73768131135;52497.737511312196;52539.737301313246;437113;437930;441821.9544511413;442952;443043;28329;29347.119586412442;29441;30556.388872222877;30656.386872261985;49075.75462122667;49126.26310605415;49500;49642.00715985588;50821.237681435545;40706.796466017484;40970.385444218955;41572.08702978615;42480;43307.566924331615;41033.384499231935;41382;42514.78742606267;43152.136957261304;44907;42296.788516057226;43252.78373608112;43411;43446.565534345515;43589.91025224395;34758.82620586881;37220.62779372172;37410.8129459351;37445.81277093597;38553;28084;28794.28014299659;28958.420831583673;29286.41427171402;29311.560326595543 20:47:14 INFO - PROCESS | 13158 | |2;jquery.html;379.571084674318;393.2881484513032;398.9640932316092;403.2962480471577;419.1428528658892;14113.223772692498;17749.37877174299;19761.505962350948;19780.10989505472;20363.083661235243;17476;17781.28874845008;17788.555286117855;18020.098995050226;18078.096095195255;4261.637760790337;5808.273965754281;5976.880462390772;5977.372375900533;5978.103284507315;5750.223719797837;6623.933760662379;6705.094812200339;6786.151731033621;6803.183617965827;6643.202815662127;6655.933440665604;6701.1623547056615;6725.05849181115;6735.9663201683925;6573.244076931142;6647.900281495781;6669.066330713704;6683.13119294491;6706;5698.857528561819;5841.766329346821;5847.386024467412;5848.064309710426;5849.61977471463;21843.890780546153;24287.14994975185;24492.265232043068;24784.3803904902;25172.748272517223;2230.966535501969;2275.575259234841;2343.9296821095395;2376.964345534818;2617.9659034681194;10235.0788429041;10646.57413703451;10666.733331666694;10744.946275268574;13998.465539402849;1826.6164105537853;1879.5489082620072;1927.1327902443816;1989.801019898013;2004.4287378097317;81944;85768.57115714444;86531.56734216289;87245.56377218073;87522.5623871883;10755.880794569488;10829.29609575375;11014;11046.779064418828;11250;15772.842271577367;15778.76331855023;15794.052356858625;15795.21023948798;15832.366705331888;7622.58075805836;7813.296803287732;7869.134395216522;7927.326177274881;8203.630836612367;7480.970207066147;7528;7537.397008239328;7727.459077864495;7784.649690763929;4402.84590039347;4693;4714.764261786965;4841.757912104381;4916.778744956486;1769.2745974150537;1778.8754787165033;1861.9627607448047;1882.0871877139577;1923.422973108062;931.3852857114272;1006.8471600017939;1018.0582960761266;1051.7791263834526;1061.0662616897082;19895.204191832454;20037.599248014958;20448;20789.168433262803;20893.477663058242;984.1782111936614;985.8126955878361;986.0238364019569;991.4546999150439;1004.4224570871778;10597.258191926645;11312.434378281054;11351.205415620827;11380.658580242605;11404.486798094105;394915;395086;397497;496480;496920;97007.51496242474;100133.49933250288;101242;101478;101762;993.1210878372548;997.3467378866853;1034.5499707627055;1041.6979076067855;1046.863907691995;17160;17953.64092718112;18828.7175692362;18970.905145474186;19058.80941190626;42050.78974605107;43174.35238471488;44132.558674412845;44660.55339446564;45767.31349029834;56115;59152.40847591469;60896.69551652214;61191;61850.69074654598;8366.372522060748;9022.503762293138;9035.27717782589;9068.274538037072;9200.447973121634;12864.2924639142;13534.661633459242;13785.931070344584;14214.573562793134;14537.127772333693;12085.879141208476;12146.514139434325;12170;12294.569690061162;12541.93729031349;11580.36308003068;11744.70638234051;12003.879961200277;12004.279743215435;12510.874891251335;12007.279563226235;12096.334701591497;12133.332666703416;12298.938505307417;12606.747865042831;7704.499207551491;8524.232819046316;8543.273821725223;8621.224089831945;8977.506237157018;10218.59125634996;11961.760764784829;12000.819987700366;12009.819852702041;12606.49574017029 20:47:14 INFO - PROCESS | 13158 | |3;mootools.html;1340.0033949415374;1453.6438572549728;1520.756678931371;1619.3684463059408;1765.1527266911883;8563.186497282755;8914.687985920495;8979.640814367418;8985.191332780058;9315;8767.693130740425;8972.955135224314;9203.861942070875;9208.585613647385;9210.631574737003;2450.779429851313;2490.2155820916355;2492.7881130103965;2498.900043998238;2499.1128149506844;2411.445367565461;2485.9751402485927;2490.950180996379;2493.8628375439343;2495.2763698527406;2417.504411595619;2439.8048156147556;2490.10356271742;2492.5887228607257;2496.6754321938215;2362.338545207336;2383.1539803369815;2392.569337519246;2395.8682272475007;2397.1729753235104;2360.3273067175946;2382.332946774906;2384.034466041256;2385.749496302898;2400.663907053014;8909.376343655947;9031;9150.359474836763;9150.725478235663;9160.404573702688;5381.730913454312;5567.415421380778;5592.496675299242;5609.579281553859;5625.8593535161535;3414.26593282443;3417.9404384640843;3472.58329000519;3498.8600455981987;3525.347810655037;1132.4677401621225;1138.681169272605;1152.5562658376502;1206.6018213989362;1213.3447938113409;12677.683057923534;12935.353232338346;12967.481300747959;12989.41547630359;13030.86969130306;4892.339534162914;4927.975360123177;4999.750012499433;5099.209622508517;5146.562542183881;10964.232503724663;10992.395418252074;10999.450027498753;11005.669829905115;11012.063974562252;5552.194931734876;5573.637713548606;5587.944120558824;5604.215409842625;5605.299337582802;4374.19077470669;4613.8846528836375;5037.79848806051;5080.923786143211;5105.668131571436;4177.177882237718;4218.198542276958;4247.766372849523;4261.10516791471;4399.49405818335;1352.7970804379422;1383.4258782605307;1384.7507448659137;1407.3807524689105;1420.183394548139;920.204023519664;926.6247169896203;943.1228957069853;948.8956214816365;969.9224062075017;5907.320658124285;5984.371640977722;6091.543134264948;6204;6227.595206311576;474.3027749208658;479.18777671845885;483.8040593559614;484.23249150096785;486.3240096266193;3828.444875493038;3838.6353296436796;3878.864239751595;3920.549136849299;3956.723029387915;10698.786024279627;11386.202965792316;11419.029382502415;11422;11447.370394628375;11246.943765281121;11294.661160165208;11354.602588909349;11360.48877800501;11365.204435689588;8480.872786908201;8587.62597984332;8597.65609375643;8600.827983440297;8605.741827745178;5855;5932.525397968066;5976.491998180203;6007.549433792396;6071.605345652519;9611.519424028631;10599.788004240027;10662.680119596425;10700.678979630624;10711.303765255234;9494.28792840526;10108.545115469675;10274.948625256826;10362.689119326433;10364.896351036694;7530.6611202497115;7687.846243074995;7750.573718445314;7761.61191940412;7769.378449723896;8232.547209903274;8295.294899933573;8344.87482687748;8360.707375241838;8363.456375335583;7440;7605.163432022362;7633.084029916446;7681.462297639335;7821.256980586835;7414.518056326321;7487.47587668858;7542.773716788505;7588.696452142073;7650.311471967327;6573.276939536551;6576;6635.867282654416;6638.302978187221;6638.369354911276;4989.650724449254;5053.26727624485;5084.313617661568;5135.794568217229;5145.125328694056;4875.293082503088;5004.5746111579465;5085.118506152748;5131.409887862944;5144.382674079135 20:47:14 INFO - PROCESS | 13158 | |4;prototype.html;326.9511331613038;333.7947162495066;334.20459306849693;337.4011130243817;341.0637799241083;5055.898882022362;5151;5195.454477279884;5241.580673546107;5288.8413347599635;5125.948740512594;5141.331626888508;5145.151050076733;5163.535281824635;5173.430922598511;4058.5129784425762;4069;4080.449139366192;4086.9182616347657;4090.1615168890453;3833.8083095845236;3928.6464218220353;4011.6590089842252;4043.777592232426;4051.4327994080854;3992.2414741199223;4005.9599404006026;4015.6988225883174;4018.397240413932;4030.3954406838916;4018.075842556214;4018.6182312680394;4028.2547728669997;4031.314676504972;4035.233305671913;3382.813945233011;3434.742394320436;3465.497502862096;3481.651834816523;3516.6834984851484;4963.528464795875;4966.925496117561;4972.403311602631;4994.675346102492;5035.169197082477;4596.862094137181;4602.194615942197;4606.585407313324;4607.14767767964;4611.953880461186;5255.185446255837;5317.308749862493;5345.572354211654;5353.938733587558;5363.141897296414;3819.1216020315205;3839.616038396166;3854.6338097880657;3864.536255649312;3872.8063596820048;5551.833444996657;5566.192902029224;5571.804986825482;5573.247611572467;5588.776448942038;3855.51806024247;3973.8807835764974;3998.8800335989968;4003.959960400417;4012.4382586437923;4037.152198038445;4044.4742183515955;4053.533843608023;4054.553999060101;4061.5329237138108;4582.450105987303;4592.97703511487;4603.447586289667;4611.631069514431;4613.63090952723;5262.815801446931;5334.466553344634;5395.514403703685;5420.214068960057;5426.75579598919;1376.7058964573268;1396.9650758731113;1398.6503024581125;1399.930003499821;1400.271858633505;856.259335674637;897.156672727647;906.1301150895215;913.7943962608493;915.1717695485596;4552.6813123081065;4556.179887620194;4567.269236922077;4599.5400459953735;4602.447706275201;5246.23929530216;5373.865653358697;5495.53287970527;5523.558115350843;5524.226608274845;5151.278820965068;5159.432462429129;5160.580840268881;5165.948340516622;5181.35233095863;2804.4110736745106;2866.584345269924;2884.5096333623333;2898.2899189698237;2901.2746813296676;5676.716164191774;5691.686957217393;5712.857178570569;5726.770929162787;5731.684757338387;5602.730893987941;5603.131514615241;5651.350094739076;5658.462446067617;5673.858153546194;5513.917291240635;5704.458076482728;5781.248437703071;5797.507211886868;5823.272090988542;5501.14732216491;5527.8894422112135;5545.639533430314;5558.638688485235;5607.915881261702;5223.869403264949;5471.890562188654;5511.53151982086;5540.196671482693;5540.833774986757;5769.798057067983;5777.94222057774;5781.306243250837;5787.421257874179;5795.24661793981;3959.8812035638975;3970.6624936879534;3971.7418367806;3981.6217459341315;3989.7007724420205;5348.973255133699;5570.415106413769;5619.887602247851;5629.240052592848;5635.380108188014;5460.689434535603;5475.178723191553;5484.670919744828;5486.6982315973;5488.929658716672;5431.38812689557;5444.210589464426;5448.727563621882;5450.700211488406;5451.209574611738;5175.28297643725;5331.626786124934;5350.384705758887;5352.875896061871;5359.169328754049;5440.020796256554;5476.151196564539;5479.972600136974;5482;5487.149491828773;5107.591392688651;5234.502722241381;5240.659357141773;5248.711320877388;5255.973720131375 20:47:14 INFO - PROCESS | 13158 | |5;yui.html;744.5421066044381;765.5674543882707;771.1671394893516;806.7337778533084;879.0462348352038;14318.785218221721;15162.848371516282;15167.393304267844;15179.316930738116;15226.847731522681;13130.540431084914;13386.66533336667;14862.702745945075;15310.387584496606;15483;808.6401551309655;827.6978902700502;828.5401602110826;830.900291964965;831.8627426474625;679.2426444514381;803.6303300481785;814.1207495904409;814.6863457568849;824.8597738384459;854.6880388658158;857.1985193843744;857.2499063319596;857.8198578298565;860.8364410761935;856.5545916123643;858.2318824651902;858.459170722444;858.9699360522383;859.1623167411786;505.09335742342586;608.5192697768757;621.6549814852755;623.9594426362272;625.5714835337762;14591.78112328316;14600.70798584033;14626.488072917396;14627.26863656813;14651.413943442249;13676.589702308847;14308.499202527966;14356.425742970268;14536.563903082924;14573.344199511048;13066.150700204456;13613.52352667652;13618.046736728433;13667.17996920178;13692.863071369358;4337.240982827992;4396.494403143615;4412.095520418338;4417.204903117437;4425.491068527129;82161.58919205425;83414.58292708559;83821.58089209576;87249.56375218146;88265.55867220623;11513.736113255134;11796.643386010719;11815.822762658567;12011.159218854771;12031.278123312453;21758.12967481283;22166;22222.00000999959;22309.55380892373;22321.218757343417;8385.077641459435;8478.448900821428;8546.78633034179;8782.253508451726;8881.866771998426;4635.536446355338;4757.119932812441;4820;4820.301056346881;5087.135187018216;3281.4749640057953;3379.4761811919193;3403.149212696826;3403.1832360233366;3421.161815355204;580.7734983356494;588.6144575303098;589.7640943622586;593.6794131169206;602.6896148483535;693.5249354192395;697.7174244431013;704.4012589299055;722.2452537098744;731.0715391452932;9414.764630884145;9884;9896.703098907044;9954.502274886227;10267;649.6751624187906;662.595816551903;688.8932215506604;704.4294121761287;706.9893951590731;4379.781010949439;4657.976710116428;4676.672632915664;4735.360726301974;4794.760261986887;121556;128009.67937084247;128569.35715321364;129013.35493322473;130476;64837.67581162064;81405.18594813976;107079.46460267648;108048;109934.45032774785;95265.047349527;96193;96970;97098;99214;8829.11708829112;8937.910620893708;9114.954425227832;9124.589393477443;9184.265258779147;53689.46310536845;53977.73011134919;54246.45753542414;54910.72544637251;55347;74018;80373.59813200896;83156.58421707853;84751.57624212086;84942;11886.702832429259;12049.819252711392;12142.392880356123;12205.938970305091;12478.937605311916;13512.864871351554;13655.522056727967;14032.508862189774;14034.157950523002;14085.225312607496;11373.601923932623;13224.338783061;13294.800577991144;13386.665333366744;13424.328783560979;14061.156330620195;14062.789058163931;14083.225422601445;14195.361208745424;14533.418663253351;12544.372781361079;13095.672608184872;13118.475260989835;13133.408996595368;13157.802632960322;10422.1274987191;10908.836367454653;10987;11372.43137843121;11458.369789661316;8743.650253989768;9776.266779991387;10287.588496460057;10660.73348166271;10896.509657065293 20:47:14 INFO - PROCESS | 13158 | __end_tp_report 20:47:14 INFO - PROCESS | 13158 | __start_cc_report 20:47:14 INFO - PROCESS | 13158 | _x_x_mozilla_cycle_collect,1125 20:47:14 INFO - PROCESS | 13158 | __end_cc_report 20:47:14 INFO - PROCESS | 13158 | __startTimestamp1470628034965__endTimestamp 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | ------- Summary: start ------- 20:47:14 INFO - PROCESS | 13158 | Number of tests: 6 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | [#0] dojo.html Cycles:165 Average:5275.03 Median:5458.89 stddev:605.79 (11.1%) stddev-sans-first:580.11 20:47:14 INFO - PROCESS | 13158 | Values: 2973.1 2978.2 3010.6 3042.6 3086.6 5200.1 5272.1 5290.7 5330.6 5383.2 5267.9 5268.8 5282.2 5318.1 5356.1 4798.5 4823.5 4831.2 4843.7 4987.9 4915.8 4944.7 4951.8 4961.1 4981.3 4710.0 4772.1 4789.1 4894.3 4912.1 4831.3 4839.3 4844.9 4847.5 4849.3 4786.7 4806.9 4817.2 4817.6 4828.8 5243.6 5252.5 5257.3 5294.1 5334.0 5701.3 5744.7 5750.9 5757.4 5759.2 5511.3 5743.1 5806.0 5809.2 5822.0 5245.2 5304.8 5324.9 5331.4 5387.6 5829.7 5897.4 5907.4 5908.6 5917.6 5378.4 5520.0 5677.1 5689.2 5691.1 5632.0 5679.1 5732.8 5733.3 5734.9 5644.4 5648.9 5651.6 5655.7 5655.9 5486.3 5563.3 5665.9 5673.4 5675.6 4328.6 4347.1 4351.0 4392.4 4397.0 3859.8 3860.4 3870.1 3889.2 3899.5 5175.0 5293.8 5318.1 5332.5 5376.7 5649.2 5683.0 5705.6 5735.9 5752.0 5356.9 5360.6 5365.1 5366.1 5369.0 4692.4 4839.2 4853.5 4891.8 4928.6 5857.9 5899.5 5906.0 5949.7 5954.9 5688.3 5688.9 5693.3 5694.8 5697.4 5681.7 5771.9 5907.9 5911.3 5918.3 5539.1 5545.2 5579.0 5616.5 5629.7 5635.9 5643.4 5644.2 5646.2 5658.7 5351.9 5499.9 5515.6 5525.2 5532.3 5531.4 5577.4 5581.4 5609.7 5616.9 5455.7 5458.9 5459.4 5460.5 5479.8 5361.4 5545.4 5584.6 5656.8 5660.9 5324.5 5436.2 5437.0 5491.2 5548.8 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | [#1] ext.html Cycles:180 Average:62390.79 Median:220740.74 stddev:123962.63 (56.2%) stddev-sans-first:124223.56 20:47:14 INFO - PROCESS | 13158 | Values: 596.4 601.4 617.7 633.8 639.6 44025.8 45541.8 45638.8 45768.1 49701.8 45955.0 46413.3 46492.3 46495.5 46535.0 8913.8 9062.9 9065.1 9068.3 9071.7 8918.9 9032.7 9045.9 9047.9 9051.7 9050.0 9113.7 9117.7 9118.2 9122.9 8998.9 9039.5 9048.8 9050.0 9050.0 8985.9 9047.7 9048.5 9053.0 9054.9 43736.3 43781.3 43987.8 44195.3 44242.6 3534.5 3620.9 3628.7 3631.8 3721.8 32363.3 33133.2 33477.2 33539.3 33542.0 4356.3 4368.5 4390.3 4445.5 4591.6 365937.0 365986.0 366611.0 366736.0 367967.2 59626.7 59719.4 59763.0 59845.7 59975.7 57648.0 57815.4 57857.4 57901.7 57908.0 15198.8 15377.5 15383.6 15385.2 15387.0 12008.2 12083.0 12088.9 12089.2 12093.1 15792.8 18074.3 18145.5 18165.1 18269.3 5717.9 6537.5 6703.2 6725.3 6728.4 1013.7 1037.8 1130.2 1133.4 1178.3 32433.8 32940.0 33431.3 33671.2 34271.5 1143.9 1165.3 1170.0 1173.8 1210.5 17110.4 17689.5 17694.4 17720.3 17799.2 566883.0 571749.0 571795.0 572721.0 572995.0 59768.7 60361.7 60401.7 60443.4 60504.7 1254.5 1340.9 1381.6 1396.6 1397.7 33118.7 34383.0 35251.6 35314.0 35380.5 51869.7 52433.7 52463.7 52497.7 52539.7 437113.0 437930.0 441822.0 442952.0 443043.0 28329.0 29347.1 29441.0 30556.4 30656.4 49075.8 49126.3 49500.0 49642.0 50821.2 40706.8 40970.4 41572.1 42480.0 43307.6 41033.4 41382.0 42514.8 43152.1 44907.0 42296.8 43252.8 43411.0 43446.6 43589.9 34758.8 37220.6 37410.8 37445.8 38553.0 28084.0 28794.3 28958.4 29286.4 29311.6 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | [#2] jquery.html Cycles:180 Average:28192.56 Median:2360.45 stddev:73030.67 (3093.9%) stddev-sans-first:73205.69 20:47:14 INFO - PROCESS | 13158 | Values: 379.6 393.3 399.0 403.3 419.1 14113.2 17749.4 19761.5 19780.1 20363.1 17476.0 17781.3 17788.6 18020.1 18078.1 4261.6 5808.3 5976.9 5977.4 5978.1 5750.2 6623.9 6705.1 6786.2 6803.2 6643.2 6655.9 6701.2 6725.1 6736.0 6573.2 6647.9 6669.1 6683.1 6706.0 5698.9 5841.8 5847.4 5848.1 5849.6 21843.9 24287.1 24492.3 24784.4 25172.7 2231.0 2275.6 2343.9 2377.0 2618.0 10235.1 10646.6 10666.7 10744.9 13998.5 1826.6 1879.5 1927.1 1989.8 2004.4 81944.0 85768.6 86531.6 87245.6 87522.6 10755.9 10829.3 11014.0 11046.8 11250.0 15772.8 15778.8 15794.1 15795.2 15832.4 7622.6 7813.3 7869.1 7927.3 8203.6 7481.0 7528.0 7537.4 7727.5 7784.6 4402.8 4693.0 4714.8 4841.8 4916.8 1769.3 1778.9 1862.0 1882.1 1923.4 931.4 1006.8 1018.1 1051.8 1061.1 19895.2 20037.6 20448.0 20789.2 20893.5 984.2 985.8 986.0 991.5 1004.4 10597.3 11312.4 11351.2 11380.7 11404.5 394915.0 395086.0 397497.0 496480.0 496920.0 97007.5 100133.5 101242.0 101478.0 101762.0 993.1 997.3 1034.5 1041.7 1046.9 17160.0 17953.6 18828.7 18970.9 19058.8 42050.8 43174.4 44132.6 44660.6 45767.3 56115.0 59152.4 60896.7 61191.0 61850.7 8366.4 9022.5 9035.3 9068.3 9200.4 12864.3 13534.7 13785.9 14214.6 14537.1 12085.9 12146.5 12170.0 12294.6 12541.9 11580.4 11744.7 12003.9 12004.3 12510.9 12007.3 12096.3 12133.3 12298.9 12606.7 7704.5 8524.2 8543.3 8621.2 8977.5 10218.6 11961.8 12000.8 12009.8 12606.5 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | [#3] mootools.html Cycles:180 Average:5919.00 Median:4883.82 stddev:3411.10 (69.8%) stddev-sans-first:3403.31 20:47:14 INFO - PROCESS | 13158 | Values: 1340.0 1453.6 1520.8 1619.4 1765.2 8563.2 8914.7 8979.6 8985.2 9315.0 8767.7 8973.0 9203.9 9208.6 9210.6 2450.8 2490.2 2492.8 2498.9 2499.1 2411.4 2486.0 2491.0 2493.9 2495.3 2417.5 2439.8 2490.1 2492.6 2496.7 2362.3 2383.2 2392.6 2395.9 2397.2 2360.3 2382.3 2384.0 2385.7 2400.7 8909.4 9031.0 9150.4 9150.7 9160.4 5381.7 5567.4 5592.5 5609.6 5625.9 3414.3 3417.9 3472.6 3498.9 3525.3 1132.5 1138.7 1152.6 1206.6 1213.3 12677.7 12935.4 12967.5 12989.4 13030.9 4892.3 4928.0 4999.8 5099.2 5146.6 10964.2 10992.4 10999.5 11005.7 11012.1 5552.2 5573.6 5587.9 5604.2 5605.3 4374.2 4613.9 5037.8 5080.9 5105.7 4177.2 4218.2 4247.8 4261.1 4399.5 1352.8 1383.4 1384.8 1407.4 1420.2 920.2 926.6 943.1 948.9 969.9 5907.3 5984.4 6091.5 6204.0 6227.6 474.3 479.2 483.8 484.2 486.3 3828.4 3838.6 3878.9 3920.5 3956.7 10698.8 11386.2 11419.0 11422.0 11447.4 11246.9 11294.7 11354.6 11360.5 11365.2 8480.9 8587.6 8597.7 8600.8 8605.7 5855.0 5932.5 5976.5 6007.5 6071.6 9611.5 10599.8 10662.7 10700.7 10711.3 9494.3 10108.5 10274.9 10362.7 10364.9 7530.7 7687.8 7750.6 7761.6 7769.4 8232.5 8295.3 8344.9 8360.7 8363.5 7440.0 7605.2 7633.1 7681.5 7821.3 7414.5 7487.5 7542.8 7588.7 7650.3 6573.3 6576.0 6635.9 6638.3 6638.4 4989.7 5053.3 5084.3 5135.8 5145.1 4875.3 5004.6 5085.1 5131.4 5144.4 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | [#4] prototype.html Cycles:180 Average:4533.39 Median:5169.69 stddev:1336.31 (25.8%) stddev-sans-first:1302.22 20:47:14 INFO - PROCESS | 13158 | Values: 327.0 333.8 334.2 337.4 341.1 5055.9 5151.0 5195.5 5241.6 5288.8 5125.9 5141.3 5145.2 5163.5 5173.4 4058.5 4069.0 4080.4 4086.9 4090.2 3833.8 3928.6 4011.7 4043.8 4051.4 3992.2 4006.0 4015.7 4018.4 4030.4 4018.1 4018.6 4028.3 4031.3 4035.2 3382.8 3434.7 3465.5 3481.7 3516.7 4963.5 4966.9 4972.4 4994.7 5035.2 4596.9 4602.2 4606.6 4607.1 4612.0 5255.2 5317.3 5345.6 5353.9 5363.1 3819.1 3839.6 3854.6 3864.5 3872.8 5551.8 5566.2 5571.8 5573.2 5588.8 3855.5 3973.9 3998.9 4004.0 4012.4 4037.2 4044.5 4053.5 4054.6 4061.5 4582.5 4593.0 4603.4 4611.6 4613.6 5262.8 5334.5 5395.5 5420.2 5426.8 1376.7 1397.0 1398.7 1399.9 1400.3 856.3 897.2 906.1 913.8 915.2 4552.7 4556.2 4567.3 4599.5 4602.4 5246.2 5373.9 5495.5 5523.6 5524.2 5151.3 5159.4 5160.6 5165.9 5181.4 2804.4 2866.6 2884.5 2898.3 2901.3 5676.7 5691.7 5712.9 5726.8 5731.7 5602.7 5603.1 5651.4 5658.5 5673.9 5513.9 5704.5 5781.2 5797.5 5823.3 5501.1 5527.9 5545.6 5558.6 5607.9 5223.9 5471.9 5511.5 5540.2 5540.8 5769.8 5777.9 5781.3 5787.4 5795.2 3959.9 3970.7 3971.7 3981.6 3989.7 5349.0 5570.4 5619.9 5629.2 5635.4 5460.7 5475.2 5484.7 5486.7 5488.9 5431.4 5444.2 5448.7 5450.7 5451.2 5175.3 5331.6 5350.4 5352.9 5359.2 5440.0 5476.2 5480.0 5482.0 5487.1 5107.6 5234.5 5240.7 5248.7 5256.0 20:47:14 INFO - PROCESS | 13158 | 20:47:14 INFO - PROCESS | 13158 | [#5] yui.html Cycles:180 Average:21783.88 Median:4706.02 stddev:32470.92 (690.0%) stddev-sans-first:32523.58 20:47:14 INFO - PROCESS | 13158 | Values: 744.5 765.6 771.2 806.7 879.0 14318.8 15162.8 15167.4 15179.3 15226.8 13130.5 13386.7 14862.7 15310.4 15483.0 808.6 827.7 828.5 830.9 831.9 679.2 803.6 814.1 814.7 824.9 854.7 857.2 857.2 857.8 860.8 856.6 858.2 858.5 859.0 859.2 505.1 608.5 621.7 624.0 625.6 14591.8 14600.7 14626.5 14627.3 14651.4 13676.6 14308.5 14356.4 14536.6 14573.3 13066.2 13613.5 13618.0 13667.2 13692.9 4337.2 4396.5 4412.1 4417.2 4425.5 82161.6 83414.6 83821.6 87249.6 88265.6 11513.7 11796.6 11815.8 12011.2 12031.3 21758.1 22166.0 22222.0 22309.6 22321.2 8385.1 8478.4 8546.8 8782.3 8881.9 4635.5 4757.1 4820.0 4820.3 5087.1 3281.5 3379.5 3403.1 3403.2 3421.2 580.8 588.6 589.8 593.7 602.7 693.5 697.7 704.4 722.2 731.1 9414.8 9884.0 9896.7 9954.5 10267.0 649.7 662.6 688.9 704.4 707.0 4379.8 4658.0 4676.7 4735.4 4794.8 121556.0 128009.7 128569.4 129013.4 130476.0 64837.7 81405.2 107079.5 108048.0 109934.5 95265.0 96193.0 96970.0 97098.0 99214.0 8829.1 8937.9 9115.0 9124.6 9184.3 53689.5 53977.7 54246.5 54910.7 55347.0 74018.0 80373.6 83156.6 84751.6 84942.0 11886.7 12049.8 12142.4 12205.9 12478.9 13512.9 13655.5 14032.5 14034.2 14085.2 11373.6 13224.3 13294.8 13386.7 13424.3 14061.2 14062.8 14083.2 14195.4 14533.4 12544.4 13095.7 13118.5 13133.4 13157.8 10422.1 10908.8 10987.0 11372.4 11458.4 8743.7 9776.3 10287.6 10660.7 10896.5 20:47:14 INFO - PROCESS | 13158 | -------- Summary: end -------- 20:47:14 INFO - PROCESS | 13158 | 20:47:15 INFO - TEST-INFO | 13158: exit 0 20:47:15 INFO - TEST-OK | dromaeo_css | took 1114279ms 20:47:15 INFO - TEST-START | kraken 20:47:15 INFO - operating with platform_type : linux_ 20:47:15 INFO - Initialising browser for kraken test... 20:47:15 INFO - TEST-INFO | started process 13344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6FhA8/profile http://localhost:35640/getInfo.html) 20:47:19 INFO - PROCESS | 13344 | __metrics Screen width/height:1600/1200 20:47:19 INFO - PROCESS | 13344 | colorDepth:24 20:47:19 INFO - PROCESS | 13344 | Browser inner width/height: 1024/697 20:47:19 INFO - PROCESS | 13344 | __metrics 20:47:20 INFO - PROCESS | 13344 | 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" 20:47:20 INFO - PROCESS | 13344 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:47:21 INFO - TEST-INFO | 13344: exit 0 20:47:21 INFO - Browser initialized. 20:47:21 INFO - Running cycle 1/1 for kraken test... 20:47:21 INFO - TEST-INFO | started process 13424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6FhA8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:33 INFO - PROCESS | 13424 | RSS: Main: 156950528 20:47:33 INFO - PROCESS | 13424 | 20:47:35 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-beat-detection) 20:47:36 INFO - PROCESS | 13424 | RSS: Main: 213454848 20:47:36 INFO - PROCESS | 13424 | 20:47:39 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-dft) 20:47:39 INFO - PROCESS | 13424 | RSS: Main: 192589824 20:47:39 INFO - PROCESS | 13424 | 20:47:42 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-fft) 20:47:43 INFO - PROCESS | 13424 | RSS: Main: 268980224 20:47:43 INFO - PROCESS | 13424 | 20:47:45 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-oscillator) 20:47:46 INFO - PROCESS | 13424 | RSS: Main: 178937856 20:47:46 INFO - PROCESS | 13424 | 20:47:48 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35640/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:47:48 INFO - PROCESS | 13424 | RSS: Main: 183529472 20:47:48 INFO - PROCESS | 13424 | 20:47:51 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35640/tests/kraken/driver.html?testName=imaging-darkroom) 20:47:52 INFO - PROCESS | 13424 | RSS: Main: 219025408 20:47:52 INFO - PROCESS | 13424 | 20:47:55 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35640/tests/kraken/driver.html?testName=imaging-desaturate) 20:47:56 INFO - PROCESS | 13424 | RSS: Main: 220123136 20:47:56 INFO - PROCESS | 13424 | 20:47:59 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35640/tests/kraken/driver.html?testName=json-parse-financial) 20:47:59 INFO - PROCESS | 13424 | RSS: Main: 219717632 20:47:59 INFO - PROCESS | 13424 | 20:48:01 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35640/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:48:01 INFO - PROCESS | 13424 | RSS: Main: 183906304 20:48:01 INFO - PROCESS | 13424 | 20:48:03 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:48:04 INFO - PROCESS | 13424 | RSS: Main: 191426560 20:48:04 INFO - PROCESS | 13424 | 20:48:06 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:48:06 INFO - PROCESS | 13424 | RSS: Main: 193961984 20:48:06 INFO - PROCESS | 13424 | 20:48:09 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:48:10 INFO - PROCESS | 13424 | RSS: Main: 193728512 20:48:10 INFO - PROCESS | 13424 | 20:48:12 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:48:13 INFO - PROCESS | 13424 | RSS: Main: 196206592 20:48:13 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35640/tests/kraken/driver.html?testName=ai-astar) 20:48:15 INFO - PROCESS | 13424 | RSS: Main: 243433472 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | __start_tp_report 20:48:15 INFO - PROCESS | 13424 | _x_x_mozilla_page_load 20:48:15 INFO - PROCESS | 13424 | _x_x_mozilla_page_load_details 20:48:15 INFO - PROCESS | 13424 | |i|pagename|runs| 20:48:15 INFO - PROCESS | 13424 | |0;ai-astar;103;111;110;111;112;112;111;112;111;111 20:48:15 INFO - PROCESS | 13424 | |1;audio-beat-detection;140;117;121;180;121;121;146;117;159;118 20:48:15 INFO - PROCESS | 13424 | |2;audio-dft;161;160;161;159;162;160;161;161;163;161 20:48:15 INFO - PROCESS | 13424 | |3;audio-fft;73;75;76;122;76;76;74;74;118;75 20:48:15 INFO - PROCESS | 13424 | |4;audio-oscillator;84;82;136;86;83;83;123;84;84;121 20:48:15 INFO - PROCESS | 13424 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;116 20:48:15 INFO - PROCESS | 13424 | |6;imaging-darkroom;146;146;146;147;145;145;146;146;146;145 20:48:15 INFO - PROCESS | 13424 | |7;imaging-desaturate;94;95;95;95;95;96;95;95;95;96 20:48:15 INFO - PROCESS | 13424 | |8;json-parse-financial;50;49;52;51;50;52;51;51;50;50 20:48:15 INFO - PROCESS | 13424 | |9;json-stringify-tinderbox;62;63;63;63;63;63;62;62;62;63 20:48:15 INFO - PROCESS | 13424 | |10;stanford-crypto-aes;76;76;75;75;74;84;75;75;75;75 20:48:15 INFO - PROCESS | 13424 | |11;stanford-crypto-ccm;136;128;121;121;120;118;116;123;125;133 20:48:15 INFO - PROCESS | 13424 | |12;stanford-crypto-pbkdf2;160;164;164;161;158;158;159;164;161;162 20:48:15 INFO - PROCESS | 13424 | |13;stanford-crypto-sha256-iterative;62;64;63;63;63;65;63;64;63;61 20:48:15 INFO - PROCESS | 13424 | __end_tp_report 20:48:15 INFO - PROCESS | 13424 | __start_cc_report 20:48:15 INFO - PROCESS | 13424 | _x_x_mozilla_cycle_collect,1651 20:48:15 INFO - PROCESS | 13424 | __end_cc_report 20:48:15 INFO - PROCESS | 13424 | __startTimestamp1470628095301__endTimestamp 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | ------- Summary: start ------- 20:48:15 INFO - PROCESS | 13424 | Number of tests: 14 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 20:48:15 INFO - PROCESS | 13424 | Values: 103.0 111.0 110.0 111.0 112.0 112.0 111.0 112.0 111.0 111.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:130.50 stddev:21.76 (16.7%) stddev-sans-first:22.97 20:48:15 INFO - PROCESS | 13424 | Values: 140.0 117.0 121.0 180.0 121.0 121.0 146.0 117.0 159.0 118.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 20:48:15 INFO - PROCESS | 13424 | Values: 161.0 160.0 161.0 159.0 162.0 160.0 161.0 161.0 163.0 161.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:19.08 (25.4%) stddev-sans-first:19.82 20:48:15 INFO - PROCESS | 13424 | Values: 73.0 75.0 76.0 122.0 76.0 76.0 74.0 74.0 118.0 75.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:83.50 stddev:21.13 (25.3%) stddev-sans-first:21.91 20:48:15 INFO - PROCESS | 13424 | Values: 84.0 82.0 136.0 86.0 83.0 83.0 123.0 84.0 84.0 121.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:48:15 INFO - PROCESS | 13424 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:48:15 INFO - PROCESS | 13424 | Values: 146.0 146.0 146.0 147.0 145.0 145.0 146.0 146.0 146.0 145.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 20:48:15 INFO - PROCESS | 13424 | Values: 94.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.00 20:48:15 INFO - PROCESS | 13424 | Values: 50.0 49.0 52.0 51.0 50.0 52.0 51.0 51.0 50.0 50.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 20:48:15 INFO - PROCESS | 13424 | Values: 62.0 63.0 63.0 63.0 63.0 63.0 62.0 62.0 62.0 63.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:2.87 (3.8%) stddev-sans-first:3.04 20:48:15 INFO - PROCESS | 13424 | Values: 76.0 76.0 75.0 75.0 74.0 84.0 75.0 75.0 75.0 75.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:6.47 (5.2%) stddev-sans-first:5.24 20:48:15 INFO - PROCESS | 13424 | Values: 136.0 128.0 121.0 121.0 120.0 118.0 116.0 123.0 125.0 133.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.38 (1.5%) stddev-sans-first:2.49 20:48:15 INFO - PROCESS | 13424 | Values: 160.0 164.0 164.0 161.0 158.0 158.0 159.0 164.0 161.0 162.0 20:48:15 INFO - PROCESS | 13424 | 20:48:15 INFO - PROCESS | 13424 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.10 (1.7%) stddev-sans-first:1.09 20:48:15 INFO - PROCESS | 13424 | Values: 62.0 64.0 63.0 63.0 63.0 65.0 63.0 64.0 63.0 61.0 20:48:15 INFO - PROCESS | 13424 | -------- Summary: end -------- 20:48:15 INFO - PROCESS | 13424 | 20:48:16 INFO - TEST-INFO | 13424: exit 0 20:48:16 INFO - TEST-OK | kraken | took 60502ms 20:48:16 INFO - SUITE-END | took 1174s 20:48:16 INFO - Completed test suite (00:19:34) 20:48:16 INFO - javascript benchmark 20:48:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2973.0783457128305, 2978.210774144852, 3010.6387233531964, 3042.6196725409322, 3086.614173228346, 5200.115980283352, 5272.077386457369, 5290.7354632268425, 5330.600204984627, 5383.219433182187, 5267.920981185285, 5268.762905669245, 5282.2076688496745, 5318.095923692972, 5356.062689029414, 4798.4961579034225, 4823.517648235174, 4831.178699621055, 4843.685160464576, 4987.850364489072, 4915.754212289389, 4944.703317800925, 4951.826686065989, 4961.05739909416, 4981.302617633516, 4710.034442939189, 4772.093302272592, 4789.090072886141, 4894.290327902452, 4912.091263116317, 4831.323614693945, 4839.27410888366, 4844.878878028042, 4847.466778654345, 4849.272609108627, 4786.712797232177, 4806.903861922777, 4817.205161148407, 4817.614590832725, 4828.758562071917, 5243.554297884646, 5252.474752524755, 5257.342832145981, 5294.126469132589, 5333.973330133324, 5701.287339082614, 5744.6840423776675, 5750.884982300372, 5757.424257574251, 5759.22250496186, 5511.255980442669, 5743.0811070228565, 5805.983952808284, 5809.215755872945, 5822.010258256064, 5245.1869960155855, 5304.761285742113, 5324.893502130013, 5331.3868905076415, 5387.622866399314, 5829.708514574254, 5897.351291357947, 5907.409259074144, 5908.615939963888, 5917.55618328627, 5378.435264297271, 5520.0, 5677.063284558001, 5689.175069614883, 5691.146328050825, 5631.971840140773, 5679.148127780783, 5732.828015159552, 5733.31200255972, 5734.885302294014, 5644.379118296984, 5648.8870222595315, 5651.632643878134, 5655.717214139277, 5655.886882262414, 5486.31421072366, 5563.276774019432, 5665.915011274834, 5673.404292549306, 5675.631083979611, 4328.567143285709, 4347.130573885235, 4351.0210202704775, 4392.363107349416, 4397.0, 3859.807009649506, 3860.401637746154, 3870.07118291608, 3889.241597888441, 3899.473571067926, 5174.97412512935, 5293.841184764463, 5318.149096144598, 5332.493413125747, 5376.731163441812, 5649.152627105967, 5683.0338842396895, 5705.600607957486, 5735.913961290584, 5752.0, 5356.892862142813, 5360.571154307646, 5365.061114304981, 5366.060939335601, 5369.033573956725, 4692.389989301437, 4839.225723884161, 4853.466118726938, 4891.779869905863, 4928.6303527235605, 5857.912131318034, 5899.498542623754, 5905.966455870205, 5949.672767997802, 5954.940450595525, 5688.317401911797, 5688.8577785554035, 5693.28833895763, 5694.772209111589, 5697.373288938131, 5681.659100453986, 5771.8557036074435, 5907.940920590911, 5911.290645122613, 5918.2898052234, 5539.14143307788, 5545.1682247663175, 5579.0, 5616.466435688603, 5629.746661400165, 5635.887282254414, 5643.435656434323, 5644.181593668813, 5646.209530665628, 5658.717064146858, 5351.892962140813, 5499.9175012375645, 5515.558755299647, 5525.171224316385, 5532.336119665666, 5531.391546929754, 5577.44225577439, 5581.441855814386, 5609.663420194802, 5616.943830561642, 5455.727213639381, 5458.890822183614, 5459.372172200247, 5460.453954604666, 5479.835604931858, 5361.383440904346, 5545.417731138334, 5584.581156413204, 5656.773729050792, 5660.85847853807, 5324.467553244799, 5436.184572314184, 5437.048516509516, 5491.203775452617, 5548.833534993795], "value": 5233.434831757372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.3916804859044, 601.449673548703, 617.6788070203492, 633.7655067624978, 639.5874660843753, 44025.779871100676, 45541.77229113858, 45638.77180614096, 45768.08463830726, 49701.751491242496, 45955.0, 46413.30380044302, 46492.302615460794, 46495.53504464963, 46535.0, 8913.821723565508, 9062.909370906305, 9065.138811812867, 9068.274538036974, 9071.727848164566, 8918.866217006751, 9032.68385606504, 9045.909540904606, 9047.909520904805, 9051.683191088314, 9050.0, 9113.726588202364, 9117.72646820593, 9118.224950879183, 9122.908770912305, 8998.86501702475, 9039.502827344493, 9048.77378065547, 9050.04974477677, 9050.04974477677, 8985.910140898573, 9047.68333108338, 9048.547572621343, 9053.0, 9054.86417703735, 43736.343954840704, 43781.34327985083, 43987.78006109981, 44195.33706994398, 44242.557574424485, 3534.452159915217, 3620.9094772630633, 3628.7459877808565, 3631.836567354449, 3721.832517536717, 32363.32619217653, 33133.17167070819, 33477.163070923176, 33539.32921341584, 33542.0, 4356.259435895874, 4368.47578290604, 4390.27560452525, 4445.53321901199, 4591.586757191869, 365937.0, 365986.0, 366611.0, 366735.9999999973, 367967.24229303957, 59626.70186649039, 59719.402805972255, 59763.0, 59845.70077149587, 59975.70012149911, 57648.0, 57815.421845781006, 57857.4214257852, 57901.71049144812, 57908.0, 15198.772018419733, 15377.53867383958, 15383.61540961485, 15385.153816540198, 15387.0, 12008.219465734699, 12083.033357331393, 12088.879111208951, 12089.15375923677, 12093.093018023683, 15792.842071579367, 18074.277028918696, 18145.45563633093, 18165.09174541294, 18269.269229230948, 5717.885642287131, 6537.509686773511, 6703.162104736908, 6725.286118754225, 6728.394444499921, 1013.6502906497246, 1037.8131936251395, 1130.1693255457233, 1133.3992983718642, 1178.251810100575, 32433.837830810695, 32940.0, 33431.3313733724, 33671.15822104467, 34271.4859277111, 1143.8627364716122, 1165.3066425476827, 1170.0, 1173.8356630071626, 1210.4613447015993, 17110.401135960183, 17689.46931592054, 17694.380696675555, 17720.291188352578, 17799.19903604341, 566883.0, 571749.0, 571795.0, 572721.0, 572995.0, 59768.70115649394, 60361.66202548757, 60401.69799150976, 60443.39556604466, 60504.69747651234, 1254.5044707340733, 1340.9128406653535, 1381.5855243427134, 1396.6019684390103, 1397.6785339372002, 33118.66881331156, 34383.0, 35251.64748352484, 35314.0, 35380.46929296114, 51869.7406512965, 52433.7378313106, 52463.73768131135, 52497.737511312196, 52539.737301313246, 437113.0, 437930.0, 441821.9544511413, 442952.0, 443043.0, 28329.0, 29347.119586412442, 29441.0, 30556.388872222877, 30656.386872261985, 49075.75462122667, 49126.26310605415, 49500.0, 49642.00715985588, 50821.237681435545, 40706.796466017484, 40970.385444218955, 41572.08702978615, 42480.0, 43307.566924331615, 41033.384499231935, 41382.0, 42514.78742606267, 43152.136957261304, 44907.0, 42296.788516057226, 43252.78373608112, 43411.0, 43446.565534345515, 43589.91025224395, 34758.82620586881, 37220.62779372172, 37410.8129459351, 37445.81277093597, 38553.0, 28084.0, 28794.28014299659, 28958.420831583673, 29286.41427171402, 29311.560326595543], "value": 20523.674510575453, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.571084674318, 393.2881484513032, 398.9640932316092, 403.2962480471577, 419.1428528658892, 14113.223772692498, 17749.37877174299, 19761.505962350948, 19780.10989505472, 20363.083661235243, 17476.0, 17781.28874845008, 17788.555286117855, 18020.098995050226, 18078.096095195255, 4261.637760790337, 5808.273965754281, 5976.880462390772, 5977.372375900533, 5978.103284507315, 5750.223719797837, 6623.933760662379, 6705.094812200339, 6786.151731033621, 6803.183617965827, 6643.202815662127, 6655.933440665604, 6701.1623547056615, 6725.05849181115, 6735.9663201683925, 6573.244076931142, 6647.900281495781, 6669.066330713704, 6683.13119294491, 6706.0, 5698.857528561819, 5841.766329346821, 5847.386024467412, 5848.064309710426, 5849.61977471463, 21843.890780546153, 24287.14994975185, 24492.265232043068, 24784.3803904902, 25172.748272517223, 2230.966535501969, 2275.575259234841, 2343.9296821095395, 2376.964345534818, 2617.9659034681194, 10235.0788429041, 10646.57413703451, 10666.733331666694, 10744.946275268574, 13998.465539402849, 1826.6164105537853, 1879.5489082620072, 1927.1327902443816, 1989.801019898013, 2004.4287378097317, 81944.0, 85768.57115714444, 86531.56734216289, 87245.56377218073, 87522.5623871883, 10755.880794569488, 10829.29609575375, 11014.0, 11046.779064418828, 11250.0, 15772.842271577367, 15778.76331855023, 15794.052356858625, 15795.21023948798, 15832.366705331888, 7622.58075805836, 7813.296803287732, 7869.134395216522, 7927.326177274881, 8203.630836612367, 7480.970207066147, 7528.0, 7537.397008239328, 7727.459077864495, 7784.649690763929, 4402.84590039347, 4693.0, 4714.764261786965, 4841.757912104381, 4916.778744956486, 1769.2745974150537, 1778.8754787165033, 1861.9627607448047, 1882.0871877139577, 1923.422973108062, 931.3852857114272, 1006.8471600017939, 1018.0582960761266, 1051.7791263834526, 1061.0662616897082, 19895.204191832454, 20037.599248014958, 20448.0, 20789.168433262803, 20893.477663058242, 984.1782111936614, 985.8126955878361, 986.0238364019569, 991.4546999150439, 1004.4224570871778, 10597.258191926645, 11312.434378281054, 11351.205415620827, 11380.658580242605, 11404.486798094105, 394915.0, 395086.0, 397497.0, 496480.0, 496920.0, 97007.51496242474, 100133.49933250288, 101242.0, 101478.0, 101762.0, 993.1210878372548, 997.3467378866853, 1034.5499707627055, 1041.6979076067855, 1046.863907691995, 17160.0, 17953.64092718112, 18828.7175692362, 18970.905145474186, 19058.80941190626, 42050.78974605107, 43174.35238471488, 44132.558674412845, 44660.55339446564, 45767.31349029834, 56115.0, 59152.40847591469, 60896.69551652214, 61191.0, 61850.69074654598, 8366.372522060748, 9022.503762293138, 9035.27717782589, 9068.274538037072, 9200.447973121634, 12864.2924639142, 13534.661633459242, 13785.931070344584, 14214.573562793134, 14537.127772333693, 12085.879141208476, 12146.514139434325, 12170.0, 12294.569690061162, 12541.93729031349, 11580.36308003068, 11744.70638234051, 12003.879961200277, 12004.279743215435, 12510.874891251335, 12007.279563226235, 12096.334701591497, 12133.332666703416, 12298.938505307417, 12606.747865042831, 7704.499207551491, 8524.232819046316, 8543.273821725223, 8621.224089831945, 8977.506237157018, 10218.59125634996, 11961.760764784829, 12000.819987700366, 12009.819852702041, 12606.49574017029], "value": 9451.073574059541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.0033949415374, 1453.6438572549728, 1520.756678931371, 1619.3684463059408, 1765.1527266911883, 8563.186497282755, 8914.687985920495, 8979.640814367418, 8985.191332780058, 9315.0, 8767.693130740425, 8972.955135224314, 9203.861942070875, 9208.585613647385, 9210.631574737003, 2450.779429851313, 2490.2155820916355, 2492.7881130103965, 2498.900043998238, 2499.1128149506844, 2411.445367565461, 2485.9751402485927, 2490.950180996379, 2493.8628375439343, 2495.2763698527406, 2417.504411595619, 2439.8048156147556, 2490.10356271742, 2492.5887228607257, 2496.6754321938215, 2362.338545207336, 2383.1539803369815, 2392.569337519246, 2395.8682272475007, 2397.1729753235104, 2360.3273067175946, 2382.332946774906, 2384.034466041256, 2385.749496302898, 2400.663907053014, 8909.376343655947, 9031.0, 9150.359474836763, 9150.725478235663, 9160.404573702688, 5381.730913454312, 5567.415421380778, 5592.496675299242, 5609.579281553859, 5625.8593535161535, 3414.26593282443, 3417.9404384640843, 3472.58329000519, 3498.8600455981987, 3525.347810655037, 1132.4677401621225, 1138.681169272605, 1152.5562658376502, 1206.6018213989362, 1213.3447938113409, 12677.683057923534, 12935.353232338346, 12967.481300747959, 12989.41547630359, 13030.86969130306, 4892.339534162914, 4927.975360123177, 4999.750012499433, 5099.209622508517, 5146.562542183881, 10964.232503724663, 10992.395418252074, 10999.450027498753, 11005.669829905115, 11012.063974562252, 5552.194931734876, 5573.637713548606, 5587.944120558824, 5604.215409842625, 5605.299337582802, 4374.19077470669, 4613.8846528836375, 5037.79848806051, 5080.923786143211, 5105.668131571436, 4177.177882237718, 4218.198542276958, 4247.766372849523, 4261.10516791471, 4399.49405818335, 1352.7970804379422, 1383.4258782605307, 1384.7507448659137, 1407.3807524689105, 1420.183394548139, 920.204023519664, 926.6247169896203, 943.1228957069853, 948.8956214816365, 969.9224062075017, 5907.320658124285, 5984.371640977722, 6091.543134264948, 6204.0, 6227.595206311576, 474.3027749208658, 479.18777671845885, 483.8040593559614, 484.23249150096785, 486.3240096266193, 3828.444875493038, 3838.6353296436796, 3878.864239751595, 3920.549136849299, 3956.723029387915, 10698.786024279627, 11386.202965792316, 11419.029382502415, 11422.0, 11447.370394628375, 11246.943765281121, 11294.661160165208, 11354.602588909349, 11360.48877800501, 11365.204435689588, 8480.872786908201, 8587.62597984332, 8597.65609375643, 8600.827983440297, 8605.741827745178, 5855.0, 5932.525397968066, 5976.491998180203, 6007.549433792396, 6071.605345652519, 9611.519424028631, 10599.788004240027, 10662.680119596425, 10700.678979630624, 10711.303765255234, 9494.28792840526, 10108.545115469675, 10274.948625256826, 10362.689119326433, 10364.896351036694, 7530.6611202497115, 7687.846243074995, 7750.573718445314, 7761.61191940412, 7769.378449723896, 8232.547209903274, 8295.294899933573, 8344.87482687748, 8360.707375241838, 8363.456375335583, 7440.0, 7605.163432022362, 7633.084029916446, 7681.462297639335, 7821.256980586835, 7414.518056326321, 7487.47587668858, 7542.773716788505, 7588.696452142073, 7650.311471967327, 6573.276939536551, 6576.0, 6635.867282654416, 6638.302978187221, 6638.369354911276, 4989.650724449254, 5053.26727624485, 5084.313617661568, 5135.794568217229, 5145.125328694056, 4875.293082503088, 5004.5746111579465, 5085.118506152748, 5131.409887862944, 5144.382674079135], "value": 4661.913647096382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.9511331613038, 333.7947162495066, 334.20459306849693, 337.4011130243817, 341.0637799241083, 5055.898882022362, 5151.0, 5195.454477279884, 5241.580673546107, 5288.8413347599635, 5125.948740512594, 5141.331626888508, 5145.151050076733, 5163.535281824635, 5173.430922598511, 4058.5129784425762, 4069.0, 4080.449139366192, 4086.9182616347657, 4090.1615168890453, 3833.8083095845236, 3928.6464218220353, 4011.6590089842252, 4043.777592232426, 4051.4327994080854, 3992.2414741199223, 4005.9599404006026, 4015.6988225883174, 4018.397240413932, 4030.3954406838916, 4018.075842556214, 4018.6182312680394, 4028.2547728669997, 4031.314676504972, 4035.233305671913, 3382.813945233011, 3434.742394320436, 3465.497502862096, 3481.651834816523, 3516.6834984851484, 4963.528464795875, 4966.925496117561, 4972.403311602631, 4994.675346102492, 5035.169197082477, 4596.862094137181, 4602.194615942197, 4606.585407313324, 4607.14767767964, 4611.953880461186, 5255.185446255837, 5317.308749862493, 5345.572354211654, 5353.938733587558, 5363.141897296414, 3819.1216020315205, 3839.616038396166, 3854.6338097880657, 3864.536255649312, 3872.8063596820048, 5551.833444996657, 5566.192902029224, 5571.804986825482, 5573.247611572467, 5588.776448942038, 3855.51806024247, 3973.8807835764974, 3998.8800335989968, 4003.959960400417, 4012.4382586437923, 4037.152198038445, 4044.4742183515955, 4053.533843608023, 4054.553999060101, 4061.5329237138108, 4582.450105987303, 4592.97703511487, 4603.447586289667, 4611.631069514431, 4613.63090952723, 5262.815801446931, 5334.466553344634, 5395.514403703685, 5420.214068960057, 5426.75579598919, 1376.7058964573268, 1396.9650758731113, 1398.6503024581125, 1399.930003499821, 1400.271858633505, 856.259335674637, 897.156672727647, 906.1301150895215, 913.7943962608493, 915.1717695485596, 4552.6813123081065, 4556.179887620194, 4567.269236922077, 4599.5400459953735, 4602.447706275201, 5246.23929530216, 5373.865653358697, 5495.53287970527, 5523.558115350843, 5524.226608274845, 5151.278820965068, 5159.432462429129, 5160.580840268881, 5165.948340516622, 5181.35233095863, 2804.4110736745106, 2866.584345269924, 2884.5096333623333, 2898.2899189698237, 2901.2746813296676, 5676.716164191774, 5691.686957217393, 5712.857178570569, 5726.770929162787, 5731.684757338387, 5602.730893987941, 5603.131514615241, 5651.350094739076, 5658.462446067617, 5673.858153546194, 5513.917291240635, 5704.458076482728, 5781.248437703071, 5797.507211886868, 5823.272090988542, 5501.14732216491, 5527.8894422112135, 5545.639533430314, 5558.638688485235, 5607.915881261702, 5223.869403264949, 5471.890562188654, 5511.53151982086, 5540.196671482693, 5540.833774986757, 5769.798057067983, 5777.94222057774, 5781.306243250837, 5787.421257874179, 5795.24661793981, 3959.8812035638975, 3970.6624936879534, 3971.7418367806, 3981.6217459341315, 3989.7007724420205, 5348.973255133699, 5570.415106413769, 5619.887602247851, 5629.240052592848, 5635.380108188014, 5460.689434535603, 5475.178723191553, 5484.670919744828, 5486.6982315973, 5488.929658716672, 5431.38812689557, 5444.210589464426, 5448.727563621882, 5450.700211488406, 5451.209574611738, 5175.28297643725, 5331.626786124934, 5350.384705758887, 5352.875896061871, 5359.169328754049, 5440.020796256554, 5476.151196564539, 5479.972600136974, 5482.0, 5487.149491828773, 5107.591392688651, 5234.502722241381, 5240.659357141773, 5248.711320877388, 5255.973720131375], "value": 4110.355258248153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.5421066044381, 765.5674543882707, 771.1671394893516, 806.7337778533084, 879.0462348352038, 14318.785218221721, 15162.848371516282, 15167.393304267844, 15179.316930738116, 15226.847731522681, 13130.540431084914, 13386.66533336667, 14862.702745945075, 15310.387584496606, 15483.0, 808.6401551309655, 827.6978902700502, 828.5401602110826, 830.900291964965, 831.8627426474625, 679.2426444514381, 803.6303300481785, 814.1207495904409, 814.6863457568849, 824.8597738384459, 854.6880388658158, 857.1985193843744, 857.2499063319596, 857.8198578298565, 860.8364410761935, 856.5545916123643, 858.2318824651902, 858.459170722444, 858.9699360522383, 859.1623167411786, 505.09335742342586, 608.5192697768757, 621.6549814852755, 623.9594426362272, 625.5714835337762, 14591.78112328316, 14600.70798584033, 14626.488072917396, 14627.26863656813, 14651.413943442249, 13676.589702308847, 14308.499202527966, 14356.425742970268, 14536.563903082924, 14573.344199511048, 13066.150700204456, 13613.52352667652, 13618.046736728433, 13667.17996920178, 13692.863071369358, 4337.240982827992, 4396.494403143615, 4412.095520418338, 4417.204903117437, 4425.491068527129, 82161.58919205425, 83414.58292708559, 83821.58089209576, 87249.56375218146, 88265.55867220623, 11513.736113255134, 11796.643386010719, 11815.822762658567, 12011.159218854771, 12031.278123312453, 21758.12967481283, 22166.0, 22222.00000999959, 22309.55380892373, 22321.218757343417, 8385.077641459435, 8478.448900821428, 8546.78633034179, 8782.253508451726, 8881.866771998426, 4635.536446355338, 4757.119932812441, 4820.0, 4820.301056346881, 5087.135187018216, 3281.4749640057953, 3379.4761811919193, 3403.149212696826, 3403.1832360233366, 3421.161815355204, 580.7734983356494, 588.6144575303098, 589.7640943622586, 593.6794131169206, 602.6896148483535, 693.5249354192395, 697.7174244431013, 704.4012589299055, 722.2452537098744, 731.0715391452932, 9414.764630884145, 9884.0, 9896.703098907044, 9954.502274886227, 10267.0, 649.6751624187906, 662.595816551903, 688.8932215506604, 704.4294121761287, 706.9893951590731, 4379.781010949439, 4657.976710116428, 4676.672632915664, 4735.360726301974, 4794.760261986887, 121556.0, 128009.67937084247, 128569.35715321364, 129013.35493322473, 130476.0, 64837.67581162064, 81405.18594813976, 107079.46460267648, 108048.0, 109934.45032774785, 95265.047349527, 96193.0, 96970.0, 97098.0, 99214.0, 8829.11708829112, 8937.910620893708, 9114.954425227832, 9124.589393477443, 9184.265258779147, 53689.46310536845, 53977.73011134919, 54246.45753542414, 54910.72544637251, 55347.0, 74018.0, 80373.59813200896, 83156.58421707853, 84751.57624212086, 84942.0, 11886.702832429259, 12049.819252711392, 12142.392880356123, 12205.938970305091, 12478.937605311916, 13512.864871351554, 13655.522056727967, 14032.508862189774, 14034.157950523002, 14085.225312607496, 11373.601923932623, 13224.338783061, 13294.800577991144, 13386.665333366744, 13424.328783560979, 14061.156330620195, 14062.789058163931, 14083.225422601445, 14195.361208745424, 14533.418663253351, 12544.372781361079, 13095.672608184872, 13118.475260989835, 13133.408996595368, 13157.802632960322, 10422.1274987191, 10908.836367454653, 10987.0, 11372.43137843121, 11458.369789661316, 8743.650253989768, 9776.266779991387, 10287.588496460057, 10660.73348166271, 10896.509657065293], "value": 7607.153203716308, "unit": "score"}], "name": "dromaeo_css", "value": 7272.87442961037, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 111.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 121.0, 180.0, 121.0, 121.0, 146.0, 117.0, 159.0, 118.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 162.0, 160.0, 161.0, 161.0, 163.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 122.0, 76.0, 76.0, 74.0, 74.0, 118.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 136.0, 86.0, 83.0, 83.0, 123.0, 84.0, 84.0, 121.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 52.0, 51.0, 50.0, 52.0, 51.0, 51.0, 50.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 74.0, 84.0, 75.0, 75.0, 75.0, 75.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 128.0, 121.0, 121.0, 120.0, 118.0, 116.0, 123.0, 125.0, 133.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 164.0, 161.0, 158.0, 158.0, 159.0, 164.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 63.0, 65.0, 63.0, 64.0, 63.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1480.9999999999998, "alertThreshold": 2.0}]} 20:48:16 INFO - Return code: 0 20:48:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:48:16 INFO - # TBPL SUCCESS # 20:48:16 INFO - Running post-action listener: _resource_record_post_action 20:48:16 INFO - [mozharness: 2016-08-08 03:48:16.601679Z] Finished run-tests step (success) 20:48:16 INFO - Running post-run listener: _resource_record_post_run 20:48:16 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 549007360; Read time: 0; Write time: 393656 20:48:16 INFO - TinderboxPrint: CPU usage
13.0% 20:48:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:48:16 INFO - TinderboxPrint: I/O write bytes / time
549,007,360 / 393,656 20:48:16 INFO - TinderboxPrint: CPU idle
8,276.9 (87.0%) 20:48:16 INFO - TinderboxPrint: CPU user
1,193.2 (12.5%) 20:48:16 INFO - TinderboxPrint: Swap in / out
0 / 0 20:48:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258347008; Read time: 0; Write time: 225776 20:48:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290238464; Read time: 0; Write time: 167880 20:48:17 INFO - Running post-run listener: _upload_blobber_files 20:48:17 INFO - Blob upload gear active. 20:48:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:48:17 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 20:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:48:17 INFO - (blobuploader) - INFO - Open directory for files ... 20:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:48:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:18 INFO - (blobuploader) - INFO - Done attempting. 20:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:19 INFO - (blobuploader) - INFO - Done attempting. 20:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:22 INFO - (blobuploader) - INFO - Done attempting. 20:48:22 INFO - (blobuploader) - INFO - Iteration through files over. 20:48:22 INFO - Return code: 0 20:48:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:48:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:48:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/617c46af46c8ac8476716e245bcb6bf79d46eb96b1bcbcd44b3de60a005f089f7931232e84d54a0b1c9f5c8ae2436e87dc3a2dae2e098cd2d0ad0479cf5662a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03177911c6f008c36c7b00bf7af9484fd74176711c13011095030f6a996fc49aa8c1c5950ef55fdf9aaff70fa40e9316b60c9d517561f3f6944ae9b90a08b5af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960dfcb11862ce05b01a878a7d12c128f3e48ac83bbd07ef9dee7d202e6addbc1d9ca08e96541d9203d81a66d180564b3a00ecfd55b467a792ee481d76662ec2"} 20:48:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:48:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:48:22 INFO - Contents: 20:48:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/617c46af46c8ac8476716e245bcb6bf79d46eb96b1bcbcd44b3de60a005f089f7931232e84d54a0b1c9f5c8ae2436e87dc3a2dae2e098cd2d0ad0479cf5662a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03177911c6f008c36c7b00bf7af9484fd74176711c13011095030f6a996fc49aa8c1c5950ef55fdf9aaff70fa40e9316b60c9d517561f3f6944ae9b90a08b5af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960dfcb11862ce05b01a878a7d12c128f3e48ac83bbd07ef9dee7d202e6addbc1d9ca08e96541d9203d81a66d180564b3a00ecfd55b467a792ee481d76662ec2"} 20:48:22 INFO - Running post-run listener: copy_logs_to_upload_dir 20:48:22 INFO - Copying logs to upload dir... 20:48:22 INFO - mkdir: /builds/slave/test/build/upload/logs 20:48:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.752591 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-07 20:48:21.865116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 20:48:21.868591) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833 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/sha512/617c46af46c8ac8476716e245bcb6bf79d46eb96b1bcbcd44b3de60a005f089f7931232e84d54a0b1c9f5c8ae2436e87dc3a2dae2e098cd2d0ad0479cf5662a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03177911c6f008c36c7b00bf7af9484fd74176711c13011095030f6a996fc49aa8c1c5950ef55fdf9aaff70fa40e9316b60c9d517561f3f6944ae9b90a08b5af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960dfcb11862ce05b01a878a7d12c128f3e48ac83bbd07ef9dee7d202e6addbc1d9ca08e96541d9203d81a66d180564b3a00ecfd55b467a792ee481d76662ec2"} build_url:https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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/sha512/617c46af46c8ac8476716e245bcb6bf79d46eb96b1bcbcd44b3de60a005f089f7931232e84d54a0b1c9f5c8ae2436e87dc3a2dae2e098cd2d0ad0479cf5662a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03177911c6f008c36c7b00bf7af9484fd74176711c13011095030f6a996fc49aa8c1c5950ef55fdf9aaff70fa40e9316b60c9d517561f3f6944ae9b90a08b5af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/960dfcb11862ce05b01a878a7d12c128f3e48ac83bbd07ef9dee7d202e6addbc1d9ca08e96541d9203d81a66d180564b3a00ecfd55b467a792ee481d76662ec2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 20:48:21.893754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:48:21.894076) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470626827.230561-838097833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:48:21.977082) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 20:48:21.977411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 20:48:21.977694) ========= ========= Total master_lag: 0.20 =========