builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1471379751.06 results: success (0) buildid: 20160816115917 builduid: dedd804235b64260a2c413ddb122973b revision: 049fe094cf32ba6afc256bf413e14f9360faca69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.056812) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.057284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.057562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.073359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.073654) ========= 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-1471378274.895143-1850082797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 13:35: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% 38.0M=0s 2016-08-16 13:35:51 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.234090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.234386) ========= 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-1471378274.895143-1850082797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014121 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.291236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.291542) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 049fe094cf32ba6afc256bf413e14f9360faca69 --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 049fe094cf32ba6afc256bf413e14f9360faca69 --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-1471378274.895143-1850082797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 13:35:51,942 truncating revision to first 12 chars 2016-08-16 13:35:51,942 Setting DEBUG logging. 2016-08-16 13:35:51,942 attempt 1/10 2016-08-16 13:35:51,942 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/049fe094cf32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 13:35:52,271 unpacking tar archive at: fx-team-049fe094cf32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.977475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.977741) ========= script_repo_revision: 049fe094cf32ba6afc256bf413e14f9360faca69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.978104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.978376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 13:35:51.994743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-16 13:35:51.995013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:35:52 INFO - MultiFileLogger online at 20160816 13:35:52 in /builds/slave/test 13:35:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:35:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:35:52 INFO - {'append_to_log': False, 13:35:52 INFO - 'base_work_dir': '/builds/slave/test', 13:35:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:35:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:35:52 INFO - 'branch': 'Fx-Team-Non-PGO', 13:35:52 INFO - 'buildbot_json_path': 'buildprops.json', 13:35:52 INFO - 'config_files': ('talos/linux_config.py',), 13:35:52 INFO - 'default_actions': ('clobber', 13:35:52 INFO - 'read-buildbot-config', 13:35:52 INFO - 'download-and-extract', 13:35:52 INFO - 'populate-webroot', 13:35:52 INFO - 'create-virtualenv', 13:35:52 INFO - 'install', 13:35:52 INFO - 'run-tests'), 13:35:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:35:52 INFO - 'download_minidump_stackwalk': True, 13:35:52 INFO - 'download_symbols': 'ondemand', 13:35:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:35:52 INFO - 'tooltool.py': '/tools/tooltool.py', 13:35:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:35:52 INFO - '/tools/misc-python/virtualenv.py')}, 13:35:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:35:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:35:52 INFO - 'installer_path': 'installer.exe', 13:35:52 INFO - 'log_level': 'info', 13:35:52 INFO - 'log_name': 'talos', 13:35:52 INFO - 'log_to_console': True, 13:35:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:35:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:35:52 INFO - 'opt_config_files': (), 13:35:52 INFO - 'pip_index': False, 13:35:52 INFO - 'sps_profile': False, 13:35:52 INFO - 'sps_profile_interval': 0, 13:35:52 INFO - 'suite': 'dromaeojs', 13:35:52 INFO - 'system_bits': '32', 13:35:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:35:52 INFO - 'title': 'talos-linux64-ix-005', 13:35:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:35:52 INFO - 'use_talos_json': True, 13:35:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:35:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:35:52 INFO - 'work_dir': 'build'} 13:35:52 INFO - [mozharness: 2016-08-16 20:35:52.737885Z] Running clobber step. 13:35:52 INFO - Running pre-action listener: _resource_record_pre_action 13:35:52 INFO - Running main action method: clobber 13:35:52 INFO - rmtree: /builds/slave/test/build 13:35:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:35:53 INFO - Running post-action listener: _resource_record_post_action 13:35:53 INFO - [mozharness: 2016-08-16 20:35:53.706036Z] Finished clobber step (success) 13:35:53 INFO - [mozharness: 2016-08-16 20:35:53.706136Z] Running read-buildbot-config step. 13:35:53 INFO - Running pre-action listener: _resource_record_pre_action 13:35:53 INFO - Running main action method: read_buildbot_config 13:35:53 INFO - Using buildbot properties: 13:35:53 INFO - { 13:35:53 INFO - "project": "", 13:35:53 INFO - "product": "firefox", 13:35:53 INFO - "script_repo_revision": "production", 13:35:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:35:53 INFO - "repository": "", 13:35:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:35:53 INFO - "buildid": "20160816115917", 13:35:53 INFO - "pgo_build": "False", 13:35:53 INFO - "basedir": "/builds/slave/test", 13:35:53 INFO - "buildnumber": 1872, 13:35:53 INFO - "slavename": "talos-linux64-ix-005", 13:35:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:35:53 INFO - "platform": "ubuntu64_hw", 13:35:53 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 13:35:53 INFO - "branch": "fx-team", 13:35:53 INFO - "repo_path": "integration/fx-team", 13:35:53 INFO - "revision": "049fe094cf32ba6afc256bf413e14f9360faca69", 13:35:53 INFO - "stage_platform": "linux64", 13:35:53 INFO - "builduid": "dedd804235b64260a2c413ddb122973b", 13:35:53 INFO - "slavebuilddir": "test" 13:35:53 INFO - } 13:35:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:35:53 INFO - Running post-action listener: _resource_record_post_action 13:35:53 INFO - [mozharness: 2016-08-16 20:35:53.708565Z] Finished read-buildbot-config step (success) 13:35:53 INFO - [mozharness: 2016-08-16 20:35:53.708653Z] Running download-and-extract step. 13:35:53 INFO - Running pre-action listener: _resource_record_pre_action 13:35:53 INFO - Running main action method: download_and_extract 13:35:53 INFO - mkdir: /builds/slave/test/build/tests 13:35: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')]} 13:35:53 INFO - trying https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:35:53 INFO - Downloading https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:35:54 INFO - Downloaded 1361 bytes. 13:35:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:35:54 INFO - Using the following test package requirements: 13:35:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:35:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:35:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:35:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'jsshell-linux-x86_64.zip'], 13:35:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:35:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:35:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:35:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:35:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:35:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:35:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:35: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')]} 13:35:54 INFO - trying https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:35:54 INFO - Downloading https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:35:55 INFO - Downloaded 20265717 bytes. 13:35:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:35:59 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 13:35: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')]} 13:35:59 INFO - trying https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:35:59 INFO - Downloading https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:00 INFO - Downloaded 20265717 bytes. 13:36:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:36: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')]} 13:36:04 INFO - trying https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:04 INFO - Downloading https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:05 INFO - Downloaded 14413719 bytes. 13:36:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 13:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:36:05 INFO - trying https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:36:05 INFO - Downloading https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:07 INFO - Downloaded 55628420 bytes. 13:36:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:36:07 INFO - mkdir: /builds/slave/test/properties 13:36:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:36:07 INFO - Writing to file /builds/slave/test/properties/build_url 13:36:07 INFO - Contents: 13:36:07 INFO - build_url:https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:36:08 INFO - Running post-action listener: _resource_record_post_action 13:36:08 INFO - Running post-action listener: set_extra_try_arguments 13:36:08 INFO - [mozharness: 2016-08-16 20:36:08.046450Z] Finished download-and-extract step (success) 13:36:08 INFO - [mozharness: 2016-08-16 20:36:08.046674Z] Running populate-webroot step. 13:36:08 INFO - Running pre-action listener: _resource_record_pre_action 13:36:08 INFO - Running main action method: populate_webroot 13:36:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:36:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:36:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:36:08 INFO - '--tppagecycles', 13:36:08 INFO - '7'], 13:36:08 INFO - 'tests': ['tsvgm']}}, 13:36:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:36:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:36:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:36:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:36:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['damp', 'tps']}, 13:36:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'tests': ['damp', 'tps']}, 13:36:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['dromaeo_dom']}, 13:36:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:36:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['basic_compositor_video']}, 13:36:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:36:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other-e10s': {'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tsvgx', 13:36:08 INFO - 'tsvgr_opacity', 13:36:08 INFO - 'tart', 13:36:08 INFO - 'tscrollx', 13:36:08 INFO - 'cart']}, 13:36:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:36:08 INFO - 'tsvgr_opacity', 13:36:08 INFO - 'tart', 13:36:08 INFO - 'tscrollx', 13:36:08 INFO - 'cart']}, 13:36:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tp5o']}, 13:36:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'tests': ['tp5o']}, 13:36:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s', 13:36:08 INFO - '--xperf_path', 13:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:08 INFO - 'tests': ['tp5n']}, 13:36:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--xperf_path', 13:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:08 INFO - 'tests': ['tp5n']}}, 13:36:08 INFO - 'talos.zip': {'path': '', 13:36:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:36:08 INFO - Running post-action listener: _resource_record_post_action 13:36:08 INFO - [mozharness: 2016-08-16 20:36:08.067785Z] Finished populate-webroot step (success) 13:36:08 INFO - [mozharness: 2016-08-16 20:36:08.067873Z] Running create-virtualenv step. 13:36:08 INFO - Running pre-action listener: _resource_record_pre_action 13:36:08 INFO - Running main action method: create_virtualenv 13:36:08 INFO - Creating virtualenv /builds/slave/test/build/venv 13:36:08 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 13:36:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:36:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:36:08 INFO - Using real prefix '/usr' 13:36:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:36:08 INFO - Installing distribute.............................................................................................................................................................................................done. 13:36:10 INFO - Installing pip.................done. 13:36:10 INFO - Return code: 0 13:36:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36: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', 'pip>=1.5'] in /builds/slave/test/build 13:36: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 pip>=1.5 13:36:10 INFO - Using env: {'DISPLAY': ':0', 13:36:10 INFO - 'HOME': '/home/cltbld', 13:36:10 INFO - 'LANG': 'en_US.UTF-8', 13:36:10 INFO - 'LANGUAGE': 'en_US:en', 13:36:10 INFO - 'LOGNAME': 'cltbld', 13:36:10 INFO - 'MAIL': '/var/mail/cltbld', 13:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:10 INFO - 'MOZ_NO_REMOTE': '1', 13:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:10 INFO - 'NO_EM_RESTART': '1', 13:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:10 INFO - 'PWD': '/builds/slave/test', 13:36:10 INFO - 'SHELL': '/bin/bash', 13:36:10 INFO - 'SHLVL': '1', 13:36:10 INFO - 'TERM': 'linux', 13:36:10 INFO - 'TMOUT': '86400', 13:36:10 INFO - 'USER': 'cltbld', 13:36:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:10 INFO - '_': '/tools/buildbot/bin/python'} 13:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:10 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 13:36:10 INFO - Cleaning up... 13:36:10 INFO - Return code: 0 13:36:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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', '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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:36: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 psutil>=3.1.1 13:36:10 INFO - Using env: {'DISPLAY': ':0', 13:36:10 INFO - 'HOME': '/home/cltbld', 13:36:10 INFO - 'LANG': 'en_US.UTF-8', 13:36:10 INFO - 'LANGUAGE': 'en_US:en', 13:36:10 INFO - 'LOGNAME': 'cltbld', 13:36:10 INFO - 'MAIL': '/var/mail/cltbld', 13:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:10 INFO - 'MOZ_NO_REMOTE': '1', 13:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:10 INFO - 'NO_EM_RESTART': '1', 13:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:10 INFO - 'PWD': '/builds/slave/test', 13:36:10 INFO - 'SHELL': '/bin/bash', 13:36:10 INFO - 'SHLVL': '1', 13:36:10 INFO - 'TERM': 'linux', 13:36:10 INFO - 'TMOUT': '86400', 13:36:10 INFO - 'USER': 'cltbld', 13:36:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:10 INFO - '_': '/tools/buildbot/bin/python'} 13:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:11 INFO - Downloading/unpacking psutil>=3.1.1 13:36:11 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 13:36:11 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 13:36:11 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 13:36:11 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 13:36:11 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 13:36:11 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 13:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:36:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:13 INFO - Installing collected packages: psutil 13:36:13 INFO - Running setup.py install for psutil 13:36:13 INFO - building 'psutil._psutil_linux' extension 13:36:13 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 13:36:13 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 13:36:13 INFO - building 'psutil._psutil_posix' extension 13:36:13 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 13:36:13 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 13:36:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:13 INFO - Successfully installed psutil 13:36:13 INFO - Cleaning up... 13:36:13 INFO - Return code: 0 13:36:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:36:13 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')]} 13:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:13 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')]} 13:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:13 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:13 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 13:36:13 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 13:36:13 INFO - Using env: {'DISPLAY': ':0', 13:36:13 INFO - 'HOME': '/home/cltbld', 13:36:13 INFO - 'LANG': 'en_US.UTF-8', 13:36:13 INFO - 'LANGUAGE': 'en_US:en', 13:36:13 INFO - 'LOGNAME': 'cltbld', 13:36:13 INFO - 'MAIL': '/var/mail/cltbld', 13:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:13 INFO - 'MOZ_NO_REMOTE': '1', 13:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:13 INFO - 'NO_EM_RESTART': '1', 13:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:13 INFO - 'PWD': '/builds/slave/test', 13:36:13 INFO - 'SHELL': '/bin/bash', 13:36:13 INFO - 'SHLVL': '1', 13:36:13 INFO - 'TERM': 'linux', 13:36:13 INFO - 'TMOUT': '86400', 13:36:13 INFO - 'USER': 'cltbld', 13:36:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:13 INFO - '_': '/tools/buildbot/bin/python'} 13:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:36:13 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 13:36:13 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 13:36:13 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 13:36:13 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 13:36:13 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 13:36:13 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 13:36:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:36:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:36:15 INFO - Installing collected packages: mozsystemmonitor 13:36:15 INFO - Running setup.py install for mozsystemmonitor 13:36:15 INFO - Successfully installed mozsystemmonitor 13:36:15 INFO - Cleaning up... 13:36:15 INFO - Return code: 0 13:36:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:15 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:15 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 13:36:15 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 13:36:15 INFO - Using env: {'DISPLAY': ':0', 13:36:15 INFO - 'HOME': '/home/cltbld', 13:36:15 INFO - 'LANG': 'en_US.UTF-8', 13:36:15 INFO - 'LANGUAGE': 'en_US:en', 13:36:15 INFO - 'LOGNAME': 'cltbld', 13:36:15 INFO - 'MAIL': '/var/mail/cltbld', 13:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:15 INFO - 'MOZ_NO_REMOTE': '1', 13:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:15 INFO - 'NO_EM_RESTART': '1', 13:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:15 INFO - 'PWD': '/builds/slave/test', 13:36:15 INFO - 'SHELL': '/bin/bash', 13:36:15 INFO - 'SHLVL': '1', 13:36:15 INFO - 'TERM': 'linux', 13:36:15 INFO - 'TMOUT': '86400', 13:36:15 INFO - 'USER': 'cltbld', 13:36:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:15 INFO - '_': '/tools/buildbot/bin/python'} 13:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:16 INFO - Downloading/unpacking jsonschema==2.5.1 13:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:36:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:36:18 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 13:36:18 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 13:36:18 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 13:36:18 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 13:36:18 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 13:36:18 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 13:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 13:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:36:18 INFO - warning: no files found matching '*.txt' 13:36:18 INFO - no previously-included directories found matching 'build' 13:36:18 INFO - no previously-included directories found matching 'dist' 13:36:18 INFO - no previously-included directories found matching '.git*' 13:36:18 INFO - Installing collected packages: jsonschema, functools32 13:36:18 INFO - Running setup.py install for functools32 13:36:18 INFO - warning: no files found matching '*.txt' 13:36:18 INFO - no previously-included directories found matching 'build' 13:36:18 INFO - no previously-included directories found matching 'dist' 13:36:18 INFO - no previously-included directories found matching '.git*' 13:36:18 INFO - Successfully installed jsonschema functools32 13:36:18 INFO - Cleaning up... 13:36:18 INFO - Return code: 0 13:36:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:36:18 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')]} 13:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:18 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')]} 13:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:18 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:18 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 13:36:18 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 13:36:18 INFO - Using env: {'DISPLAY': ':0', 13:36:18 INFO - 'HOME': '/home/cltbld', 13:36:18 INFO - 'LANG': 'en_US.UTF-8', 13:36:18 INFO - 'LANGUAGE': 'en_US:en', 13:36:18 INFO - 'LOGNAME': 'cltbld', 13:36:18 INFO - 'MAIL': '/var/mail/cltbld', 13:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:18 INFO - 'MOZ_NO_REMOTE': '1', 13:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:18 INFO - 'NO_EM_RESTART': '1', 13:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:18 INFO - 'PWD': '/builds/slave/test', 13:36:18 INFO - 'SHELL': '/bin/bash', 13:36:18 INFO - 'SHLVL': '1', 13:36:18 INFO - 'TERM': 'linux', 13:36:18 INFO - 'TMOUT': '86400', 13:36:18 INFO - 'USER': 'cltbld', 13:36:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:18 INFO - '_': '/tools/buildbot/bin/python'} 13:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:36:18 INFO - Cleaning up... 13:36:18 INFO - Return code: 0 13:36:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:36:18 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')]} 13:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:18 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')]} 13:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:18 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:18 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 13:36:18 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 13:36:18 INFO - Using env: {'DISPLAY': ':0', 13:36:18 INFO - 'HOME': '/home/cltbld', 13:36:18 INFO - 'LANG': 'en_US.UTF-8', 13:36:18 INFO - 'LANGUAGE': 'en_US:en', 13:36:18 INFO - 'LOGNAME': 'cltbld', 13:36:18 INFO - 'MAIL': '/var/mail/cltbld', 13:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:18 INFO - 'MOZ_NO_REMOTE': '1', 13:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:18 INFO - 'NO_EM_RESTART': '1', 13:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:18 INFO - 'PWD': '/builds/slave/test', 13:36:18 INFO - 'SHELL': '/bin/bash', 13:36:18 INFO - 'SHLVL': '1', 13:36:18 INFO - 'TERM': 'linux', 13:36:18 INFO - 'TMOUT': '86400', 13:36:18 INFO - 'USER': 'cltbld', 13:36:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:18 INFO - '_': '/tools/buildbot/bin/python'} 13:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:18 INFO - Downloading/unpacking blobuploader==1.2.4 13:36:18 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 13:36:18 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 13:36:18 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 13:36:18 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 13:36:18 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 13:36:18 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 13:36:20 INFO - Downloading blobuploader-1.2.4.tar.gz 13:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:36:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:36:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:36:21 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 13:36:21 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 13:36:21 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 13:36:21 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 13:36:21 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 13:36:21 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 13:36:21 INFO - Downloading docopt-0.6.1.tar.gz 13:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:36:21 INFO - Installing collected packages: blobuploader, requests, docopt 13:36:21 INFO - Running setup.py install for blobuploader 13:36:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:36:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:36:21 INFO - Running setup.py install for requests 13:36:22 INFO - Running setup.py install for docopt 13:36:22 INFO - Successfully installed blobuploader requests docopt 13:36:22 INFO - Cleaning up... 13:36:22 INFO - Return code: 0 13:36:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:22 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')]} 13:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:22 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')]} 13:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:22 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:22 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 13:36:22 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 13:36:22 INFO - Using env: {'DISPLAY': ':0', 13:36:22 INFO - 'HOME': '/home/cltbld', 13:36:22 INFO - 'LANG': 'en_US.UTF-8', 13:36:22 INFO - 'LANGUAGE': 'en_US:en', 13:36:22 INFO - 'LOGNAME': 'cltbld', 13:36:22 INFO - 'MAIL': '/var/mail/cltbld', 13:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:22 INFO - 'MOZ_NO_REMOTE': '1', 13:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:22 INFO - 'NO_EM_RESTART': '1', 13:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:22 INFO - 'PWD': '/builds/slave/test', 13:36:22 INFO - 'SHELL': '/bin/bash', 13:36:22 INFO - 'SHLVL': '1', 13:36:22 INFO - 'TERM': 'linux', 13:36:22 INFO - 'TMOUT': '86400', 13:36:22 INFO - 'USER': 'cltbld', 13:36:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:22 INFO - '_': '/tools/buildbot/bin/python'} 13:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:22 INFO - Running setup.py (path:/tmp/pip-M0hi6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:22 INFO - Running setup.py (path:/tmp/pip-9mrX97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:22 INFO - Running setup.py (path:/tmp/pip-Tgbdt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:22 INFO - Running setup.py (path:/tmp/pip-Y3hKVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:22 INFO - Running setup.py (path:/tmp/pip-Lsy6c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:22 INFO - Running setup.py (path:/tmp/pip-nEJKW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:22 INFO - Running setup.py (path:/tmp/pip-cIq5le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:22 INFO - Running setup.py (path:/tmp/pip-rGuHPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:22 INFO - Running setup.py (path:/tmp/pip-DdOTTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:23 INFO - Running setup.py (path:/tmp/pip-jHjpd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:23 INFO - Running setup.py (path:/tmp/pip-ig632o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:23 INFO - Running setup.py (path:/tmp/pip-f5wckw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:23 INFO - Running setup.py (path:/tmp/pip-mm6c8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:23 INFO - Running setup.py (path:/tmp/pip-VtXiIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:23 INFO - Running setup.py (path:/tmp/pip-sqQw32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:23 INFO - Running setup.py (path:/tmp/pip-xRWioE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:23 INFO - Running setup.py (path:/tmp/pip-xzevJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:36:23 INFO - Running setup.py install for manifestparser 13:36:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:36:23 INFO - Running setup.py install for mozcrash 13:36:23 INFO - Running setup.py install for mozdebug 13:36:23 INFO - Running setup.py install for mozdevice 13:36:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Running setup.py install for mozfile 13:36:24 INFO - Running setup.py install for mozhttpd 13:36:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Running setup.py install for mozinfo 13:36:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Running setup.py install for mozInstall 13:36:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Running setup.py install for mozleak 13:36:24 INFO - Running setup.py install for mozlog 13:36:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Running setup.py install for moznetwork 13:36:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Running setup.py install for mozprocess 13:36:24 INFO - Running setup.py install for mozprofile 13:36:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:36:24 INFO - Running setup.py install for mozrunner 13:36:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:36:25 INFO - Running setup.py install for mozscreenshot 13:36:25 INFO - Running setup.py install for moztest 13:36:25 INFO - Running setup.py install for mozversion 13:36:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:36:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:36:25 INFO - Cleaning up... 13:36:25 INFO - Return code: 0 13:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:25 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')]} 13:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 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')]} 13:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:25 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 13:36:25 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 13:36:25 INFO - Using env: {'DISPLAY': ':0', 13:36:25 INFO - 'HOME': '/home/cltbld', 13:36:25 INFO - 'LANG': 'en_US.UTF-8', 13:36:25 INFO - 'LANGUAGE': 'en_US:en', 13:36:25 INFO - 'LOGNAME': 'cltbld', 13:36:25 INFO - 'MAIL': '/var/mail/cltbld', 13:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:25 INFO - 'MOZ_NO_REMOTE': '1', 13:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:25 INFO - 'NO_EM_RESTART': '1', 13:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:25 INFO - 'PWD': '/builds/slave/test', 13:36:25 INFO - 'SHELL': '/bin/bash', 13:36:25 INFO - 'SHLVL': '1', 13:36:25 INFO - 'TERM': 'linux', 13:36:25 INFO - 'TMOUT': '86400', 13:36:25 INFO - 'USER': 'cltbld', 13:36:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:25 INFO - '_': '/tools/buildbot/bin/python'} 13:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:25 INFO - Running setup.py (path:/tmp/pip-TB6JHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:25 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)) 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:25 INFO - Running setup.py (path:/tmp/pip-wvEo_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:25 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)) 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:25 INFO - Running setup.py (path:/tmp/pip-xzv9wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:25 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)) 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:25 INFO - Running setup.py (path:/tmp/pip-p6Zecr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:25 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)) 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:25 INFO - Running setup.py (path:/tmp/pip-66UQiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:26 INFO - Running setup.py (path:/tmp/pip-HjQ6zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:26 INFO - Running setup.py (path:/tmp/pip-X99UNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:26 INFO - Running setup.py (path:/tmp/pip-zhe3SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:26 INFO - Running setup.py (path:/tmp/pip-6zJAfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:26 INFO - Running setup.py (path:/tmp/pip-IympYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:26 INFO - Running setup.py (path:/tmp/pip-K_yatI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:26 INFO - Running setup.py (path:/tmp/pip-hVSd30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:26 INFO - Running setup.py (path:/tmp/pip-SC7SSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:26 INFO - Running setup.py (path:/tmp/pip-P1EOZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:26 INFO - Running setup.py (path:/tmp/pip-3dELtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:26 INFO - Running setup.py (path:/tmp/pip-bOvY7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:26 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)) 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:26 INFO - Running setup.py (path:/tmp/pip-ee2xbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:26 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)) 13:36:26 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)) 13:36:26 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)) 13:36:26 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)) 13:36:26 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)) 13:36:26 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)) 13:36:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:36:26 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 13:36:26 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 13:36:26 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 13:36:26 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 13:36:26 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 13:36:26 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 13:36:29 INFO - Downloading blessings-1.6.tar.gz 13:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:36:29 INFO - Installing collected packages: blessings 13:36:29 INFO - Running setup.py install for blessings 13:36:29 INFO - Successfully installed blessings 13:36:29 INFO - Cleaning up... 13:36:30 INFO - Return code: 0 13:36:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:30 INFO - Reading from file tmpfile_stdout 13:36:30 INFO - Current package versions: 13:36:30 INFO - argparse == 1.2.1 13:36:30 INFO - blessings == 1.6 13:36:30 INFO - blobuploader == 1.2.4 13:36:30 INFO - docopt == 0.6.1 13:36:30 INFO - functools32 == 3.2.3-2 13:36:30 INFO - jsonschema == 2.5.1 13:36:30 INFO - manifestparser == 1.1 13:36:30 INFO - mozInstall == 1.12 13:36:30 INFO - mozcrash == 0.17 13:36:30 INFO - mozdebug == 0.1 13:36:30 INFO - mozdevice == 0.48 13:36:30 INFO - mozfile == 1.2 13:36:30 INFO - mozhttpd == 0.7 13:36:30 INFO - mozinfo == 0.9 13:36:30 INFO - mozleak == 0.1 13:36:30 INFO - mozlog == 3.3 13:36:30 INFO - moznetwork == 0.27 13:36:30 INFO - mozprocess == 0.23 13:36:30 INFO - mozprofile == 0.28 13:36:30 INFO - mozrunner == 6.12 13:36:30 INFO - mozscreenshot == 0.1 13:36:30 INFO - mozsystemmonitor == 0.3 13:36:30 INFO - moztest == 0.7 13:36:30 INFO - mozversion == 1.4 13:36:30 INFO - psutil == 3.1.1 13:36:30 INFO - requests == 1.2.3 13:36:30 INFO - wsgiref == 0.1.2 13:36:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:30 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')]} 13:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:30 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')]} 13:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:30 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:30 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 13:36:30 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 13:36:30 INFO - Using env: {'DISPLAY': ':0', 13:36:30 INFO - 'HOME': '/home/cltbld', 13:36:30 INFO - 'LANG': 'en_US.UTF-8', 13:36:30 INFO - 'LANGUAGE': 'en_US:en', 13:36:30 INFO - 'LOGNAME': 'cltbld', 13:36:30 INFO - 'MAIL': '/var/mail/cltbld', 13:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:30 INFO - 'MOZ_NO_REMOTE': '1', 13:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:30 INFO - 'NO_EM_RESTART': '1', 13:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:30 INFO - 'PWD': '/builds/slave/test', 13:36:30 INFO - 'SHELL': '/bin/bash', 13:36:30 INFO - 'SHLVL': '1', 13:36:30 INFO - 'TERM': 'linux', 13:36:30 INFO - 'TMOUT': '86400', 13:36:30 INFO - 'USER': 'cltbld', 13:36:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:30 INFO - '_': '/tools/buildbot/bin/python'} 13:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 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)) 13:36:30 INFO - Cleaning up... 13:36:30 INFO - Return code: 0 13:36:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:36:30 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')]} 13:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:30 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')]} 13:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:30 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 0x7f6b063b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, '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-1471378274.895143-1850082797', '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 13:36:30 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 13:36:30 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 13:36:30 INFO - Using env: {'DISPLAY': ':0', 13:36:30 INFO - 'HOME': '/home/cltbld', 13:36:30 INFO - 'LANG': 'en_US.UTF-8', 13:36:30 INFO - 'LANGUAGE': 'en_US:en', 13:36:30 INFO - 'LOGNAME': 'cltbld', 13:36:30 INFO - 'MAIL': '/var/mail/cltbld', 13:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:30 INFO - 'MOZ_NO_REMOTE': '1', 13:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:30 INFO - 'NO_EM_RESTART': '1', 13:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:30 INFO - 'PWD': '/builds/slave/test', 13:36:30 INFO - 'SHELL': '/bin/bash', 13:36:30 INFO - 'SHLVL': '1', 13:36:30 INFO - 'TERM': 'linux', 13:36:30 INFO - 'TMOUT': '86400', 13:36:30 INFO - 'USER': 'cltbld', 13:36:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:30 INFO - '_': '/tools/buildbot/bin/python'} 13:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:36:30 INFO - Cleaning up... 13:36:30 INFO - Return code: 0 13:36:30 INFO - Running post-action listener: _resource_record_post_action 13:36:30 INFO - Running post-action listener: _start_resource_monitoring 13:36:30 INFO - Starting resource monitoring. 13:36:30 INFO - [mozharness: 2016-08-16 20:36:30.720625Z] Finished create-virtualenv step (success) 13:36:30 INFO - [mozharness: 2016-08-16 20:36:30.721134Z] Running install step. 13:36:30 INFO - Running pre-action listener: _resource_record_pre_action 13:36:30 INFO - Running main action method: install 13:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:30 INFO - Reading from file tmpfile_stdout 13:36:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:36:31 INFO - Reading from file tmpfile_stdout 13:36:31 INFO - Output received: 13:36:31 INFO - Usage: mozinstall [options] installer 13:36:31 INFO - Options: 13:36:31 INFO - -h, --help show this help message and exit 13:36:31 INFO - -d DEST, --destination=DEST 13:36:31 INFO - Directory to install application into. [default: 13:36:31 INFO - "/builds/slave/test"] 13:36:31 INFO - --app=APP Application being installed. [default: firefox] 13:36:31 INFO - mkdir: /builds/slave/test/build/application 13:36:31 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'] 13:36:31 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 13:36:47 INFO - Reading from file tmpfile_stdout 13:36:47 INFO - Output received: 13:36:47 INFO - /builds/slave/test/build/application/firefox/firefox 13:36:47 INFO - Running post-action listener: _resource_record_post_action 13:36:47 INFO - [mozharness: 2016-08-16 20:36:47.049364Z] Finished install step (success) 13:36:47 INFO - [mozharness: 2016-08-16 20:36:47.049699Z] Running run-tests step. 13:36:47 INFO - Running pre-action listener: _resource_record_pre_action 13:36:47 INFO - Running main action method: run_tests 13:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:36:47 INFO - Python 2.7.3 13:36:47 INFO - Return code: 0 13:36:47 INFO - grabbing minidump binary from tooltool 13:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:36:47 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 0x238d090>, '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 0x23909b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:36:47 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 13:36:47 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 13:36:47 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 13:36:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:36:47 INFO - Return code: 0 13:36:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:36:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:36:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:36:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:36:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:47 INFO - Using env: {'DISPLAY': ':0', 13:36:47 INFO - 'HOME': '/home/cltbld', 13:36:47 INFO - 'LANG': 'en_US.UTF-8', 13:36:47 INFO - 'LANGUAGE': 'en_US:en', 13:36:47 INFO - 'LOGNAME': 'cltbld', 13:36:47 INFO - 'MAIL': '/var/mail/cltbld', 13:36:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:47 INFO - 'MOZ_NO_REMOTE': '1', 13:36:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:47 INFO - 'NO_EM_RESTART': '1', 13:36:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:47 INFO - 'PWD': '/builds/slave/test', 13:36:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:47 INFO - 'SHELL': '/bin/bash', 13:36:47 INFO - 'SHLVL': '1', 13:36:47 INFO - 'TERM': 'linux', 13:36:47 INFO - 'TMOUT': '86400', 13:36:47 INFO - 'USER': 'cltbld', 13:36:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471378274.895143-1850082797', 13:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:47 INFO - '_': '/tools/buildbot/bin/python'} 13:36:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/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 13:36:47 INFO - mozversion application_buildid: 20160816115917 13:36:47 INFO - mozversion application_changeset: 049fe094cf32ba6afc256bf413e14f9360faca69 13:36:47 INFO - mozversion application_display_name: Nightly 13:36:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:36:47 INFO - mozversion application_name: Firefox 13:36:47 INFO - mozversion application_remotingname: firefox 13:36:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:36:47 INFO - mozversion application_vendor: Mozilla 13:36:47 INFO - mozversion application_version: 51.0a1 13:36:47 INFO - mozversion platform_buildid: 20160816115917 13:36:47 INFO - mozversion platform_changeset: 049fe094cf32ba6afc256bf413e14f9360faca69 13:36:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:36:47 INFO - mozversion platform_version: 51.0a1 13:36:47 INFO - using testdate: 1471379807 13:36:47 INFO - actual date: 1471379807 13:36:47 INFO - starting webserver on 'localhost:58845' 13:36:47 INFO - SUITE-START | Running 2 tests 13:36:47 INFO - TEST-START | dromaeo_css 13:36:47 INFO - operating with platform_type : linux_ 13:36:47 INFO - Initialising browser for dromaeo_css test... 13:36:47 INFO - TEST-INFO | started process 12778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwq_11q/profile http://localhost:58845/getInfo.html) 13:36:51 INFO - PROCESS | 12778 | __metrics Screen width/height:1600/1200 13:36:51 INFO - PROCESS | 12778 | colorDepth:24 13:36:51 INFO - PROCESS | 12778 | Browser inner width/height: 1024/697 13:36:51 INFO - PROCESS | 12778 | __metrics 13:36:52 INFO - PROCESS | 12778 | 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" 13:36:52 INFO - PROCESS | 12778 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:36:52 INFO - PROCESS | 12778 | console.error: PushService: 13:36:52 INFO - PROCESS | 12778 | stateChangeProcessEnqueue: Error transitioning state 13:36:52 INFO - PROCESS | 12778 | UnknownError 13:36:53 INFO - TEST-INFO | 12778: exit 0 13:36:53 INFO - Browser initialized. 13:36:53 INFO - Running cycle 1/1 for dromaeo_css test... 13:36:53 INFO - TEST-INFO | started process 12855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwq_11q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:05 INFO - PROCESS | 12855 | RSS: Main: 161820672 13:37:05 INFO - PROCESS | 12855 | 13:37:56 INFO - PROCESS | 12855 | 1471379875998 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] 13:40:09 INFO - PROCESS | 12855 | Cycle 1(1): loaded http://localhost:58845/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58845/tests/dromaeo/cssquery-ext.html) 13:40:10 INFO - PROCESS | 12855 | RSS: Main: 263905280 13:40:10 INFO - PROCESS | 12855 | 13:43:13 INFO - PROCESS | 12855 | Cycle 1(1): loaded http://localhost:58845/tests/dromaeo/cssquery-ext.html (next: http://localhost:58845/tests/dromaeo/cssquery-jquery.html) 13:43:13 INFO - PROCESS | 12855 | RSS: Main: 245956608 13:43:13 INFO - PROCESS | 12855 | 13:46:15 INFO - PROCESS | 12855 | Cycle 1(1): loaded http://localhost:58845/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58845/tests/dromaeo/cssquery-mootools.html) 13:46:16 INFO - PROCESS | 12855 | RSS: Main: 247078912 13:46:16 INFO - PROCESS | 12855 | 13:49:18 INFO - PROCESS | 12855 | Cycle 1(1): loaded http://localhost:58845/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58845/tests/dromaeo/cssquery-prototype.html) 13:49:19 INFO - PROCESS | 12855 | RSS: Main: 194088960 13:49:19 INFO - PROCESS | 12855 | 13:52:22 INFO - PROCESS | 12855 | Cycle 1(1): loaded http://localhost:58845/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58845/tests/dromaeo/cssquery-yui.html) 13:52:23 INFO - PROCESS | 12855 | RSS: Main: 191242240 13:52:23 INFO - PROCESS | 12855 | 13:55:25 INFO - PROCESS | 12855 | Cycle 1(1): loaded http://localhost:58845/tests/dromaeo/cssquery-yui.html (next: http://localhost:58845/tests/dromaeo/cssquery-dojo.html) 13:55:26 INFO - PROCESS | 12855 | RSS: Main: 285306880 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | __start_tp_report 13:55:26 INFO - PROCESS | 12855 | _x_x_mozilla_page_load 13:55:26 INFO - PROCESS | 12855 | _x_x_mozilla_page_load_details 13:55:26 INFO - PROCESS | 12855 | |i|pagename|runs| 13:55:26 INFO - PROCESS | 12855 | |0;dojo.html;2616.6336712860198;2625.8687065646714;2644.761971422572;2657.5216461037016;2664.107523979467;4662.883427914304;4713.929291060636;4754.429468463785;4759.405074365704;4802.927956080657;4733.053389322132;4751.144793937098;4794.496577859327;4804.087223427547;4821.156297647906;4332;4444.333349997502;4457.665675074382;4463.308187230984;4482.17079840229;4351.151525452538;4380.649548036149;4425.468943726757;4427.424434823469;4431.0251744616135;4530.728156310615;4546.54534546546;4574.931376029345;4576.931346029813;4577.496475387705;4309.913801723948;4431.158079964796;4444.088961762831;4457.33140028995;4532.0256144929;4303.870883873489;4314.9784251078545;4335.978320108379;4354.0203454222865;4362.738235705868;4708.0819240248165;4748.192807222746;4767.785449654774;4839.419269687624;4841.15279826029;5077.289179514871;5135.229715542661;5140.460251673595;5178.430372659004;5182.0931337016245;5029.321041659366;5087.135187018216;5175.482451754832;5181.378234611833;5266.368035835686;4837.419509658793;4860.538248866387;4876.561109500162;4876.707397556158;4882.218844984785;5100.795968161232;5352.384475785257;5352.625316227826;5355.303810504687;5360.035193665178;4998.100341938413;5045.798168073309;5047.419546752097;5066.265391518209;5127.820526281562;5180.922286165711;5186.377634683862;5210.21846722987;5234.92147617786;5235.973820130875;4924.113659541317;5128.461511541309;5139.100657384943;5140.331756871583;5187.299714538564;4941.036497882878;5021.4225364083595;5032.069067222503;5033.647644664911;5035.974820125876;4281.743095414286;4291.763952982554;4308.504521980012;4310.331898555729;4333.783310834446;3768.0391500167284;3774.3960966245268;3774.9245015100096;3799.848006079781;3806.124591343951;4315.654747620183;4365.738055716603;4417.712848664826;4444.73331600105;4445;5135.12702840518;5164.3802743671;5172.327597412313;5216.295800067019;5219.869503262449;4389.582989615981;4389.758563279051;4411.823527058882;4437.134758722018;4465.843695470643;4438.889027774267;4633.096546173464;4640.257558790578;4650.790714417859;4692.296155576691;4795.808167673254;4825.565699087099;4829.2997515359375;4865.878353041202;4908.484609115992;5140.357455318085;5142.331496905528;5156.922646160236;5165.354330708661;5200.921986170135;4745.1221524018165;4805.183118869871;4832.420109586872;4836.492168322276;4871.269309603588;5045.772940217773;5092.745362731923;5113.974430127825;5156.7421628919155;5176.663516871391;5185.299984502044;5202.297689811979;5203.843884683465;5207.114790485551;5255.763490642854;4828.299896514915;5065.670731402447;5080.364954380702;5087.796488140433;5094.541491265803;4899.216125419915;4920.21276595743;4955.182394904945;4991.2513123030385;5034.84895453137;4874.561289483963;4882.853514394574;4940.135476291706;4950.851474455772;4951.480094590161;4849.854504364875;5005.474425185449;5010.9248361273885;5025.095482813129;5026.874328141679;4816.109019831342;4871.098846713369;4892.559669629608;4913.017396520781;4998.4501704813165 13:55:26 INFO - PROCESS | 12855 | |1;ext.html;567.1464446008756;569.857535616096;581.1718301420475;581.2792137749192;581.3227589857815;28302;37970.81014594927;39889.80055099724;39940;44041.559584404145;39833;40228.79885600568;40281.59718402815;40306;40344;7613.809654758634;7751.6124193790365;7762;7762.223777622249;7766.495177813452;7695.0765908090825;7787.065552133752;7787.454878158531;7788.299053085221;7792.610369481532;7774.8445031099345;7816.179301173352;7819.804504887395;7826.452148349618;7831;7733.96133019337;7787.415943804181;7790.220977902221;7795.1035630902325;7796.4932279401655;7661.463697541174;7726.343260822837;7727.536347819093;7729.806754831118;7739.496932699357;37687.24625507502;38022.619773802464;38023;38037.42943855844;38076.23847523034;3128.8904888329025;3154.479510880702;3187.6174859017065;3208.727258183034;3381.9492707609406;28775.424491510053;29106.272343191376;29351.119466416043;29444.55833162504;29499.70500294991;3183.8726450941936;3254.3653987472453;3297.3734990351995;3397.3205358928312;3401.48977653354;246619;246965;247661;247673;248544.9999999982;31082.533761993134;50557.74721126445;50805.745971269906;50872.23691644628;50904.74547627238;31791.523127153112;33740;33785.66214337825;33788.155296117795;33796.662033379354;11480.425978701198;11610.76778464426;11625.1862369635;11631.88368116308;11722.238054526428;9660.75848103789;9674.467904265333;9758.414495130315;9759.463229522444;9772.31593788428;7846.411519136088;7901.802454938557;7904.0910295315625;7969.688790250878;7971.242731940456;3099.5660607514965;3101.65881753007;3116.4546204414137;3121.812691238533;3177.0468859342104;864.1574464896801;872.2934423117296;903.6159632156307;961.2598299309493;976.2092704908904;28130.71869281281;28321.858390708327;28360;28628.856855716003;28816.423671526452;751.5302935665209;941.3222479814659;952.8951815300311;1001.3391161833155;1063.1335461598771;13698.52055178064;14675.48635797742;14727.26363681833;14792;14992.850071499364;368442;663883;677460;677624;680705.3329933649;49867.50132498701;50358.244626330634;50392.24411633828;50419;50476.21428392885;1102.20090434436;1193.6956076200513;1200.963971080869;1221.5602383142061;1232.8150777383464;26732.331691707863;29139.417211656073;29360.41279174447;29606.851965740032;29750;41456.37815432831;42079;42144.78927605342;42195.156096878505;42198.57801421946;295681;297020;297401;298000;298964;25718;25880.870595646902;26222.213333600022;27096.864515677295;27264;41799;42419.5758042428;42566.361504578075;42951.570484296004;43047.56952430561;36315.45526817047;36772.26455470929;36775.632243678294;37075.58488302404;37611.81194094122;36478.27043459169;36543.269134616625;36828;37666.623333766314;38220.80889595534;28978.7102128976;33411;36462.8176859114;39087;39610.60389396069;29361.70638293675;30670;34381.14047148841;34646.480302794975;34669;25634.487310254062;25656.486870262863;25674.743252567234;25702.742972570035;25887.611685825104 13:55:26 INFO - PROCESS | 12855 | |2;jquery.html;364.1478939282081;364.23328892680905;367.42497990644637;380.0953730122308;384.2718049296583;16039;16553.33786648534;17257.48227553174;17302.48092557222;17332.56668583283;15556.766648500281;16280.918595407036;16365.263563139657;16468.423605173823;16516.174191290447;4877.122118018764;5152.510511501401;5153.768080436389;5156.69059856408;5161.27742116104;3771.5662698789715;3945.7040721945827;5028.572571331441;5669.461401166883;6022.3074346450285;6007.068904319837;6086.7869624563145;6098.725557349908;6104.877902441948;6108.755649774026;5827.242458480413;6002.909956350658;6003.069524223731;6050;6067.302260240085;5292.814751483718;5295.179247216649;5298.947010529884;5300.522952934254;6282.120503129566;23606;23822.166224182245;23864.284071477883;24086.518269634686;24327.756722432903;2099.0973881231066;2115.206797450956;2204.3166618348205;2287.7025986621634;2703.9459210815676;13623.25072121033;14681.48614798477;14826.629334266621;15264.38942442301;15645.061296322143;1888.830005299516;1891.2718603337676;1908.570571621388;1913.8277555020115;1934.8839069655726;64822.675886620265;76608.61695691486;82524.58737706274;84668.57665711633;84967.15032849654;16472.341106355612;16976.236069376908;17063.658726825393;17286.13569321529;17341.393051243398;29367.412651746847;29378.55932161019;29397.82645644396;29493.557596636067;29643.110706678835;7898.565578893216;7988.081370642334;8063.879041814377;8194.959025204837;8378.329733621418;6363.172787537591;6463.741450341934;6562.475001999828;6573.83565410859;6715.496337774589;8519.787005324917;8550.385496465231;8601.13988601135;8674.956625216833;8695.260947810337;2655.362712948878;2997.3405850712807;3072.6620071792086;3130.4521708700886;3332.9333413331597;764.8240904591863;789.258097388453;832.1013305629905;885.5926273913943;911.0661571888867;16163.43427980015;16946.915265423595;17591.560210994572;17641.7353739694;18149.183286752126;859.5401460218878;861.801785589318;862.9741107766777;881.352206128495;920.2453987729997;8503.362247831437;9886.406815591088;9998.300118991747;10066.14437772783;10068.244881633907;266801;361100;363566;364098;364291;48218;48287.27569086466;48288.27567586489;49037.754811225714;50250.497495025316;853.5774791478134;895.632790555882;905.4838741917044;905.5517518828223;907.1427501011613;10082;10420.11429028541;16004.519864404087;16075.196240188177;16536.75194872054;37450.438243426914;38337.4249386265;38673.22653546857;40533.79733101316;40655.7967210162;51415.48584514107;52598.737006314725;53387.4661253398;54202;55756;10649.680509584725;10818.56725730962;11198.888011119785;11430.657080287605;11450.770984580427;7585.256367308204;11610.825837612612;12389;12506.687332816753;12626.621201363974;5190.792368305226;10125.59497620087;10864.45677716127;10921.672349829518;11769.352685602375;10736.516856741622;11024.173187010845;11224.66326010221;11417.372044537298;11604.07167426587;10931.344119352865;11471.598494053002;11592.536298547964;11655.417229138679;11847.407629618658;10558;11077.501512431798;11244.381559014333;11539.249948753304;11916.404179791149;11317.377544235145;11413.771724565297;11440.82838757436;11545.249558778652;11938.462769175581 13:55:26 INFO - PROCESS | 12855 | |3;mootools.html;1340.4638144742103;1375.546069796967;1424.8788852947498;1606.1888746183176;1678.4041665208858;7411.14771801243;8028.197180281969;8042.557659328734;8053.557054362008;8054.758357249285;6832.521723479358;7550.471466997313;7731.613419329039;7738.458307918448;7953.76138715838;2185.0495034659893;2217.2128894242555;2219.3120132758895;2220.31170337196;2228.955420891581;2161.3299877038166;2177;2223.7442694090146;2229.698990636268;2230.130249202812;2202.9559408811815;2215.3464727905307;2222.4554984028937;2226.0205509575817;2228.4094714900484;2134.9893250533723;2138.2729871843494;2143.356992902131;2145.2598853395552;2147.3987283560627;2128.5955668423103;2157.902894369757;2164.9783502164933;2169.631162702344;2170.0994087453687;7942.404319675989;7990.720324788663;8109.675612975474;8111;8116.5941702914615;4371.519132895379;4491.887702807423;4496;4496.865094047183;4498.122866041123;2913.621229240185;2985.283531952316;3045.193023848682;3051.7558595312544;3070.8157510549213;865.2429124516049;904.6697955246353;918.6600957645647;923.8198551282503;927.1562877781254;10371.533281002374;10397.32417392867;10465.215108866865;10560.630377936735;10561.683149505527;3910.3743401056263;4119.340905455113;4132;4274.807633656431;4295;8951.239144672776;8968.461892286483;9006.819863602692;9008.41445306053;9015.323850711224;4408.382826404306;4430.069685366109;4435.379046933432;4437.400950871591;4443.311286750559;3620.6922411594783;3944.3886197639413;4003.7597744135446;4024.215278020758;4126.216018956388;3662.8717994870585;3681.3189559931498;3785.8296376663116;3793.468914351993;3805.82873770681;1204.3857632607433;1215.3254943506438;1217.9842360892737;1218.969525761863;1219.1405059433077;757.9469437139347;776.6466257852776;815.8001289683947;822.8189798244376;846.9788255293666;4993.950060499421;5084.847454576368;5146.330976972969;5154.819581314711;5303.15149576066;807.414624397319;822.5188264865121;859.9570021498901;871.6295574380863;884.9070847561043;3327.900162995114;3523.735719821024;3546;3567.8929632111076;3627.4196128619296;9234.76913077165;9770.75573110678;9808.803823923481;9820.852687209697;9833.852492212622;9494;9740.220782337396;9789.118979291898;9810.362326448758;9848.409095454152;7337.926620733831;7419.035525381773;7422.369098626569;7438.962805185939;7441.441891858132;4982.377202849644;4985.3020577118505;5013.724245166405;5095.312132862165;5236.528712415901;8638.438501497634;8874.290056795311;8901.688440904538;9027.819443610959;9110.635574576943;9015.14356136166;9169.266458683423;9228.584713688035;9263.073692630684;9266.351355405057;6232.501399888089;6284.4344009039405;6586.473082153512;6620.238672552526;6759.831004224934;7449.106107267163;7522.398208143226;7733.613319333898;7769.611519423893;7770;6637.6681165940545;6761.22245941723;6841.179058512811;6929.896051559332;7005.824854378681;6496.935030649822;6657.434118099822;6826.795196144124;6955.061066755923;6989.301069893173;6146.446819786241;6208.068789681584;6214.378562143749;6215.254169499689;6230.43926046658;4531.45622525299;4583.7249765012875;4598.26427771555;4652.092841895797;4676.976615116902;4604.148232576984;4646.8141274348645;4647.186742320148;4684.601808846286;4869.147899117569 13:55:26 INFO - PROCESS | 12855 | |4;prototype.html;295.6304619225969;304.06348446783903;307.71690045158454;308.910415979366;313.17946978915245;4789.64077694173;4810.903781924364;4831.951680483194;4840.814000569857;4870.245112007645;4568.543145685429;4663.277192035232;4712.85861424157;4717.504662010482;4806.870385459414;3621.6559426854406;3691.7231207659397;3714.090047938259;3789.924201515968;3798.9430158547643;3789.128500444899;3791.2939177370154;3802.6007269236748;3818.923621527568;3829.770213787168;3653.17803494213;3751.4935483709623;3766.642168993955;3789.7347185697013;3793.506844110276;3578.033930838672;3652.6895213906582;3720.720945929039;3749.512563366772;3754.361758501048;3327.4676051831834;3329.8844886962897;3331.6168640606397;3334.8332583370734;3344.812591529996;4689.812407503696;4698.248280275174;4698.389209402756;4706.317583950342;4709.7174169549935;3988.74073185242;4281.743095414254;4282.635975942048;4291.527931927485;4295.548967358445;4877.853664390074;4959.231319145538;4963.1810751226;4963.677360971561;4994.777324090781;3572.964270357289;3583.4803953426867;3586.4620306954166;3590.3716849551483;3594.532710747586;5215.608829337777;5239.371275446971;5266;5269.4730526947;5278.9208161877605;3437.1063523483576;3626.5648122225502;3649.233660931234;3666.7249956253386;3680.1719613086843;3707.4428739929294;3714.591394946554;3718.9814050930113;3724.2923844469465;3725.5715592706642;4246.554111818215;4246.702730808814;4250.596193361625;4257.084726783756;4271.188474189894;4759.38128043359;4989.700617962933;5026.472220416877;5030.748462576857;5043.697378157322;1265.0828149591473;1279.5457612547411;1284.9678758031123;1285.6721536008258;1285.8199852020725;800.7517669522466;815.1278132398277;827.4456114403364;830.1822704635929;833.9749807505784;3959.980200098981;3965.6827453803626;3970.940435893464;3977.1846771411792;3982.7809470478824;4564.1556312082375;4572;4584.4498660160325;4585.738921796533;4596.322342345087;3964.484616999829;3983.26727873376;3984.2828290907337;3990.4413382126527;4003.0592810689463;2471.530409222242;2502.4369516858924;2582.3931376126593;2703.2295795698133;2733;4821.879453013703;4834.734089625034;4835.081334546425;4853.320535125085;4866.172750632401;5240.737963101829;5253.369595648546;5256.579473642099;5259.263703081495;5263.289455923478;4708.246680531099;4816.109019831342;4848.418189817245;4850.6362022848425;4858.732769697701;5131.127708289525;5143.897122057613;5155.32980712505;5160;5167.682241028664;5054.2671312660195;5065.189569668835;5066.670666406671;5069.3156423883775;5079.257201111359;4697.600703940203;4865.878353041202;4877.097736918681;4922.704637721748;4923.8276660316715;3657.9634203657624;3665;3678.9448158278183;3680.190358121209;3693.1505753677343;5200.947990520046;5209.661372010807;5212.374515058065;5224.6342756008235;5229.843104706865;4865.489123641966;4996.625253105959;5016.573591244785;5020.774065167149;5054.873628159326;5001.174806156943;5014.247862820606;5020.246962955586;5048.273932076638;5051;4950.183219768842;4957.380327459067;4967.254911763264;4967.304577359245;4997.275395067768;4807.6394270429155;5023.120953833138;5048.141815891234;5065.113605119163;5069.721165335942;4960.849860338639;4968.720644374695;4971.130052240916;4977.626677999092;4993.575546078624 13:55:26 INFO - PROCESS | 12855 | |5;yui.html;601.2484394506866;616.0974172836796;654.5320096131267;730.1165589636539;736.1975446763029;12182.939085304572;13200.33998300086;13219.735605287888;13222.471101155943;13222.933885330573;13498.257595832225;13659.590212293648;13667.17996920183;13684.657883552916;13688.93155534221;627.1439485102848;742.5359150530918;760.6653072648031;777.327611615951;782.077148964222;774.1097737601747;787.1813314153273;789.9052113746359;790.0282652337628;790.4269404681588;836.2933321343486;837.660747397302;838.8070743728946;839.5214727605268;840.4915026409026;651.6481100205931;672.4553111979263;828.9005319361685;829.2081062585216;830.2278880641002;494.36967865970814;494.8663860757611;579.1920271221622;594.2660813894836;600.7566935391174;12077.27536347822;12091.818622720666;12145.210561313486;12173.08701847365;12203.572874949423;12310.753784924342;12676.492940282378;12903.290319032449;13194.736105277936;13437.462501499927;11708.121890858134;11759;11850.229735067192;12125.514979400814;12130.696732581668;3228.91927701807;3312.089175476763;4073.226087043482;4136.627703506669;4207.221663992141;59987;60009.69995149996;60397;60755;61357.386426135614;9738.464384458923;10080.445575493419;10137.138343240907;10148.543315550818;10256.38461692301;17842.91078544625;17992.550186245186;18142.274309027754;18182.63634727298;18284.17721202549;6448;6500.284968653445;6524.445422139076;6534.379233972765;6899.724011039502;3674.9816250919107;3683.4658974448553;3760.6803421708914;3799.35410980134;3819.52255968004;2970.9702902970694;3101.364220334826;3101.364220334826;3103.6275646922063;3110.751139908802;568.6616463204386;582.705733604527;588.490955323642;588.4938952500846;605.300877486495;518.4918779595941;536.6270442042743;542.7232111623101;549.3984087424265;577.9479846813807;7652.617369131633;7853.921460785434;7871.685132594746;8117.918820811835;8210.958945205235;595.3599880128879;610.6732897899602;620.4849974521137;620.525298146918;622.3527531367417;3725.441183822394;3988.960110398917;3993.4209539616595;4008.178323443687;4052.371882358239;93657;103893;104440.47779761053;104749;106155.81532554036;73697.6315118421;80741;82347.5882620583;89072.5546372277;90329.54835225914;51933.740331298104;54700.45299546954;63406.68296658487;72964;86544;8017.438779285394;8262.710805121791;8385.245327920517;8482.151784821468;8487.618057187565;39643.405348919216;46391.76804115958;47031;47034.76482617565;49884.750576246886;38092;39167.824965251086;39311.80344098376;41546;59501.70249148727;10521.894781052397;10772.784544308914;10898.945505272422;11045.697222873205;11120.833187502032;12017.339046352534;12018.33899135556;12040.458179382123;12122.151449398458;12172.39138043112;11034.724131896766;11137.721556961142;11236.55053797839;11852.407379630811;12135.238076196407;10289.639862604772;10377.533011014371;10416.635417760343;10841.67474975752;10978.121750259801;11063.944680276547;11391.886081139413;11584.42077896085;11977.760444791229;12297.938510307391;10563.419011954416;10926.08562054581;11133.777324453627;11145.164112691742;11296.096312295162;9649.662261820802;10491.213159012952;10590.8411373831;10632.202584806017;10634.680959571226 13:55:26 INFO - PROCESS | 12855 | __end_tp_report 13:55:26 INFO - PROCESS | 12855 | __start_cc_report 13:55:26 INFO - PROCESS | 12855 | _x_x_mozilla_cycle_collect,1080 13:55:26 INFO - PROCESS | 12855 | __end_cc_report 13:55:26 INFO - PROCESS | 12855 | __startTimestamp1471380926238__endTimestamp 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | ------- Summary: start ------- 13:55:26 INFO - PROCESS | 12855 | Number of tests: 6 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | [#0] dojo.html Cycles:165 Average:4745.50 Median:4865.88 stddev:509.72 (10.5%) stddev-sans-first:483.15 13:55:26 INFO - PROCESS | 12855 | Values: 2616.6 2625.9 2644.8 2657.5 2664.1 4662.9 4713.9 4754.4 4759.4 4802.9 4733.1 4751.1 4794.5 4804.1 4821.2 4332.0 4444.3 4457.7 4463.3 4482.2 4351.2 4380.6 4425.5 4427.4 4431.0 4530.7 4546.5 4574.9 4576.9 4577.5 4309.9 4431.2 4444.1 4457.3 4532.0 4303.9 4315.0 4336.0 4354.0 4362.7 4708.1 4748.2 4767.8 4839.4 4841.2 5077.3 5135.2 5140.5 5178.4 5182.1 5029.3 5087.1 5175.5 5181.4 5266.4 4837.4 4860.5 4876.6 4876.7 4882.2 5100.8 5352.4 5352.6 5355.3 5360.0 4998.1 5045.8 5047.4 5066.3 5127.8 5180.9 5186.4 5210.2 5234.9 5236.0 4924.1 5128.5 5139.1 5140.3 5187.3 4941.0 5021.4 5032.1 5033.6 5036.0 4281.7 4291.8 4308.5 4310.3 4333.8 3768.0 3774.4 3774.9 3799.8 3806.1 4315.7 4365.7 4417.7 4444.7 4445.0 5135.1 5164.4 5172.3 5216.3 5219.9 4389.6 4389.8 4411.8 4437.1 4465.8 4438.9 4633.1 4640.3 4650.8 4692.3 4795.8 4825.6 4829.3 4865.9 4908.5 5140.4 5142.3 5156.9 5165.4 5200.9 4745.1 4805.2 4832.4 4836.5 4871.3 5045.8 5092.7 5114.0 5156.7 5176.7 5185.3 5202.3 5203.8 5207.1 5255.8 4828.3 5065.7 5080.4 5087.8 5094.5 4899.2 4920.2 4955.2 4991.3 5034.8 4874.6 4882.9 4940.1 4950.9 4951.5 4849.9 5005.5 5010.9 5025.1 5026.9 4816.1 4871.1 4892.6 4913.0 4998.5 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | [#1] ext.html Cycles:180 Average:51855.68 Median:37639.22 stddev:114373.35 (303.9%) stddev-sans-first:114629.37 13:55:26 INFO - PROCESS | 12855 | Values: 567.1 569.9 581.2 581.3 581.3 28302.0 37970.8 39889.8 39940.0 44041.6 39833.0 40228.8 40281.6 40306.0 40344.0 7613.8 7751.6 7762.0 7762.2 7766.5 7695.1 7787.1 7787.5 7788.3 7792.6 7774.8 7816.2 7819.8 7826.5 7831.0 7734.0 7787.4 7790.2 7795.1 7796.5 7661.5 7726.3 7727.5 7729.8 7739.5 37687.2 38022.6 38023.0 38037.4 38076.2 3128.9 3154.5 3187.6 3208.7 3381.9 28775.4 29106.3 29351.1 29444.6 29499.7 3183.9 3254.4 3297.4 3397.3 3401.5 246619.0 246965.0 247661.0 247673.0 248545.0 31082.5 50557.7 50805.7 50872.2 50904.7 31791.5 33740.0 33785.7 33788.2 33796.7 11480.4 11610.8 11625.2 11631.9 11722.2 9660.8 9674.5 9758.4 9759.5 9772.3 7846.4 7901.8 7904.1 7969.7 7971.2 3099.6 3101.7 3116.5 3121.8 3177.0 864.2 872.3 903.6 961.3 976.2 28130.7 28321.9 28360.0 28628.9 28816.4 751.5 941.3 952.9 1001.3 1063.1 13698.5 14675.5 14727.3 14792.0 14992.9 368442.0 663883.0 677460.0 677624.0 680705.3 49867.5 50358.2 50392.2 50419.0 50476.2 1102.2 1193.7 1201.0 1221.6 1232.8 26732.3 29139.4 29360.4 29606.9 29750.0 41456.4 42079.0 42144.8 42195.2 42198.6 295681.0 297020.0 297401.0 298000.0 298964.0 25718.0 25880.9 26222.2 27096.9 27264.0 41799.0 42419.6 42566.4 42951.6 43047.6 36315.5 36772.3 36775.6 37075.6 37611.8 36478.3 36543.3 36828.0 37666.6 38220.8 28978.7 33411.0 36462.8 39087.0 39610.6 29361.7 30670.0 34381.1 34646.5 34669.0 25634.5 25656.5 25674.7 25702.7 25887.6 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | [#2] jquery.html Cycles:180 Average:23945.51 Median:182216.47 stddev:57050.96 (31.3%) stddev-sans-first:57183.53 13:55:26 INFO - PROCESS | 12855 | Values: 364.1 364.2 367.4 380.1 384.3 16039.0 16553.3 17257.5 17302.5 17332.6 15556.8 16280.9 16365.3 16468.4 16516.2 4877.1 5152.5 5153.8 5156.7 5161.3 3771.6 3945.7 5028.6 5669.5 6022.3 6007.1 6086.8 6098.7 6104.9 6108.8 5827.2 6002.9 6003.1 6050.0 6067.3 5292.8 5295.2 5298.9 5300.5 6282.1 23606.0 23822.2 23864.3 24086.5 24327.8 2099.1 2115.2 2204.3 2287.7 2703.9 13623.3 14681.5 14826.6 15264.4 15645.1 1888.8 1891.3 1908.6 1913.8 1934.9 64822.7 76608.6 82524.6 84668.6 84967.2 16472.3 16976.2 17063.7 17286.1 17341.4 29367.4 29378.6 29397.8 29493.6 29643.1 7898.6 7988.1 8063.9 8195.0 8378.3 6363.2 6463.7 6562.5 6573.8 6715.5 8519.8 8550.4 8601.1 8675.0 8695.3 2655.4 2997.3 3072.7 3130.5 3332.9 764.8 789.3 832.1 885.6 911.1 16163.4 16946.9 17591.6 17641.7 18149.2 859.5 861.8 863.0 881.4 920.2 8503.4 9886.4 9998.3 10066.1 10068.2 266801.0 361100.0 363566.0 364098.0 364291.0 48218.0 48287.3 48288.3 49037.8 50250.5 853.6 895.6 905.5 905.6 907.1 10082.0 10420.1 16004.5 16075.2 16536.8 37450.4 38337.4 38673.2 40533.8 40655.8 51415.5 52598.7 53387.5 54202.0 55756.0 10649.7 10818.6 11198.9 11430.7 11450.8 7585.3 11610.8 12389.0 12506.7 12626.6 5190.8 10125.6 10864.5 10921.7 11769.4 10736.5 11024.2 11224.7 11417.4 11604.1 10931.3 11471.6 11592.5 11655.4 11847.4 10558.0 11077.5 11244.4 11539.2 11916.4 11317.4 11413.8 11440.8 11545.2 11938.5 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | [#3] mootools.html Cycles:180 Average:5135.33 Median:5120.82 stddev:2888.95 (56.4%) stddev-sans-first:2882.98 13:55:26 INFO - PROCESS | 12855 | Values: 1340.5 1375.5 1424.9 1606.2 1678.4 7411.1 8028.2 8042.6 8053.6 8054.8 6832.5 7550.5 7731.6 7738.5 7953.8 2185.0 2217.2 2219.3 2220.3 2229.0 2161.3 2177.0 2223.7 2229.7 2230.1 2203.0 2215.3 2222.5 2226.0 2228.4 2135.0 2138.3 2143.4 2145.3 2147.4 2128.6 2157.9 2165.0 2169.6 2170.1 7942.4 7990.7 8109.7 8111.0 8116.6 4371.5 4491.9 4496.0 4496.9 4498.1 2913.6 2985.3 3045.2 3051.8 3070.8 865.2 904.7 918.7 923.8 927.2 10371.5 10397.3 10465.2 10560.6 10561.7 3910.4 4119.3 4132.0 4274.8 4295.0 8951.2 8968.5 9006.8 9008.4 9015.3 4408.4 4430.1 4435.4 4437.4 4443.3 3620.7 3944.4 4003.8 4024.2 4126.2 3662.9 3681.3 3785.8 3793.5 3805.8 1204.4 1215.3 1218.0 1219.0 1219.1 757.9 776.6 815.8 822.8 847.0 4994.0 5084.8 5146.3 5154.8 5303.2 807.4 822.5 860.0 871.6 884.9 3327.9 3523.7 3546.0 3567.9 3627.4 9234.8 9770.8 9808.8 9820.9 9833.9 9494.0 9740.2 9789.1 9810.4 9848.4 7337.9 7419.0 7422.4 7439.0 7441.4 4982.4 4985.3 5013.7 5095.3 5236.5 8638.4 8874.3 8901.7 9027.8 9110.6 9015.1 9169.3 9228.6 9263.1 9266.4 6232.5 6284.4 6586.5 6620.2 6759.8 7449.1 7522.4 7733.6 7769.6 7770.0 6637.7 6761.2 6841.2 6929.9 7005.8 6496.9 6657.4 6826.8 6955.1 6989.3 6146.4 6208.1 6214.4 6215.3 6230.4 4531.5 4583.7 4598.3 4652.1 4677.0 4604.1 4646.8 4647.2 4684.6 4869.1 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | [#4] prototype.html Cycles:180 Average:4124.66 Median:4702.35 stddev:1204.67 (25.6%) stddev-sans-first:1173.26 13:55:26 INFO - PROCESS | 12855 | Values: 295.6 304.1 307.7 308.9 313.2 4789.6 4810.9 4832.0 4840.8 4870.2 4568.5 4663.3 4712.9 4717.5 4806.9 3621.7 3691.7 3714.1 3789.9 3798.9 3789.1 3791.3 3802.6 3818.9 3829.8 3653.2 3751.5 3766.6 3789.7 3793.5 3578.0 3652.7 3720.7 3749.5 3754.4 3327.5 3329.9 3331.6 3334.8 3344.8 4689.8 4698.2 4698.4 4706.3 4709.7 3988.7 4281.7 4282.6 4291.5 4295.5 4877.9 4959.2 4963.2 4963.7 4994.8 3573.0 3583.5 3586.5 3590.4 3594.5 5215.6 5239.4 5266.0 5269.5 5278.9 3437.1 3626.6 3649.2 3666.7 3680.2 3707.4 3714.6 3719.0 3724.3 3725.6 4246.6 4246.7 4250.6 4257.1 4271.2 4759.4 4989.7 5026.5 5030.7 5043.7 1265.1 1279.5 1285.0 1285.7 1285.8 800.8 815.1 827.4 830.2 834.0 3960.0 3965.7 3970.9 3977.2 3982.8 4564.2 4572.0 4584.4 4585.7 4596.3 3964.5 3983.3 3984.3 3990.4 4003.1 2471.5 2502.4 2582.4 2703.2 2733.0 4821.9 4834.7 4835.1 4853.3 4866.2 5240.7 5253.4 5256.6 5259.3 5263.3 4708.2 4816.1 4848.4 4850.6 4858.7 5131.1 5143.9 5155.3 5160.0 5167.7 5054.3 5065.2 5066.7 5069.3 5079.3 4697.6 4865.9 4877.1 4922.7 4923.8 3658.0 3665.0 3678.9 3680.2 3693.2 5200.9 5209.7 5212.4 5224.6 5229.8 4865.5 4996.6 5016.6 5020.8 5054.9 5001.2 5014.2 5020.2 5048.3 5051.0 4950.2 4957.4 4967.3 4967.3 4997.3 4807.6 5023.1 5048.1 5065.1 5069.7 4960.8 4968.7 4971.1 4977.6 4993.6 13:55:26 INFO - PROCESS | 12855 | 13:55:26 INFO - PROCESS | 12855 | [#5] yui.html Cycles:180 Average:17086.40 Median:4000.80 stddev:24561.96 (613.9%) stddev-sans-first:24599.67 13:55:26 INFO - PROCESS | 12855 | Values: 601.2 616.1 654.5 730.1 736.2 12182.9 13200.3 13219.7 13222.5 13222.9 13498.3 13659.6 13667.2 13684.7 13688.9 627.1 742.5 760.7 777.3 782.1 774.1 787.2 789.9 790.0 790.4 836.3 837.7 838.8 839.5 840.5 651.6 672.5 828.9 829.2 830.2 494.4 494.9 579.2 594.3 600.8 12077.3 12091.8 12145.2 12173.1 12203.6 12310.8 12676.5 12903.3 13194.7 13437.5 11708.1 11759.0 11850.2 12125.5 12130.7 3228.9 3312.1 4073.2 4136.6 4207.2 59987.0 60009.7 60397.0 60755.0 61357.4 9738.5 10080.4 10137.1 10148.5 10256.4 17842.9 17992.6 18142.3 18182.6 18284.2 6448.0 6500.3 6524.4 6534.4 6899.7 3675.0 3683.5 3760.7 3799.4 3819.5 2971.0 3101.4 3101.4 3103.6 3110.8 568.7 582.7 588.5 588.5 605.3 518.5 536.6 542.7 549.4 577.9 7652.6 7853.9 7871.7 8117.9 8211.0 595.4 610.7 620.5 620.5 622.4 3725.4 3989.0 3993.4 4008.2 4052.4 93657.0 103893.0 104440.5 104749.0 106155.8 73697.6 80741.0 82347.6 89072.6 90329.5 51933.7 54700.5 63406.7 72964.0 86544.0 8017.4 8262.7 8385.2 8482.2 8487.6 39643.4 46391.8 47031.0 47034.8 49884.8 38092.0 39167.8 39311.8 41546.0 59501.7 10521.9 10772.8 10898.9 11045.7 11120.8 12017.3 12018.3 12040.5 12122.2 12172.4 11034.7 11137.7 11236.6 11852.4 12135.2 10289.6 10377.5 10416.6 10841.7 10978.1 11063.9 11391.9 11584.4 11977.8 12297.9 10563.4 10926.1 11133.8 11145.2 11296.1 9649.7 10491.2 10590.8 10632.2 10634.7 13:55:26 INFO - PROCESS | 12855 | -------- Summary: end -------- 13:55:26 INFO - PROCESS | 12855 | 13:55:27 INFO - TEST-INFO | 12855: exit 0 13:55:27 INFO - TEST-OK | dromaeo_css | took 1119761ms 13:55:27 INFO - TEST-START | kraken 13:55:27 INFO - operating with platform_type : linux_ 13:55:27 INFO - Initialising browser for kraken test... 13:55:27 INFO - TEST-INFO | started process 13154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEZmvm/profile http://localhost:58845/getInfo.html) 13:55:31 INFO - PROCESS | 13154 | __metrics Screen width/height:1600/1200 13:55:31 INFO - PROCESS | 13154 | colorDepth:24 13:55:31 INFO - PROCESS | 13154 | Browser inner width/height: 1024/697 13:55:31 INFO - PROCESS | 13154 | __metrics 13:55:31 INFO - PROCESS | 13154 | 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" 13:55:31 INFO - PROCESS | 13154 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:55:32 INFO - PROCESS | 13154 | console.error: PushService: 13:55:32 INFO - PROCESS | 13154 | stateChangeProcessEnqueue: Error transitioning state 13:55:32 INFO - PROCESS | 13154 | UnknownError 13:55:32 INFO - TEST-INFO | 13154: exit 0 13:55:32 INFO - Browser initialized. 13:55:32 INFO - Running cycle 1/1 for kraken test... 13:55:32 INFO - TEST-INFO | started process 13234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEZmvm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:44 INFO - PROCESS | 13234 | RSS: Main: 157609984 13:55:44 INFO - PROCESS | 13234 | 13:55:47 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58845/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:48 INFO - PROCESS | 13234 | RSS: Main: 205549568 13:55:48 INFO - PROCESS | 13234 | 13:55:51 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58845/tests/kraken/driver.html?testName=audio-dft) 13:55:51 INFO - PROCESS | 13234 | RSS: Main: 195788800 13:55:51 INFO - PROCESS | 13234 | 13:55:54 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58845/tests/kraken/driver.html?testName=audio-fft) 13:55:55 INFO - PROCESS | 13234 | RSS: Main: 277659648 13:55:55 INFO - PROCESS | 13234 | 13:55:57 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58845/tests/kraken/driver.html?testName=audio-oscillator) 13:55:58 INFO - PROCESS | 13234 | RSS: Main: 188575744 13:55:58 INFO - PROCESS | 13234 | 13:56:00 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58845/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:56:01 INFO - PROCESS | 13234 | RSS: Main: 192294912 13:56:01 INFO - PROCESS | 13234 | 13:56:04 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58845/tests/kraken/driver.html?testName=imaging-darkroom) 13:56:05 INFO - PROCESS | 13234 | RSS: Main: 229203968 13:56:05 INFO - PROCESS | 13234 | 13:56:08 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58845/tests/kraken/driver.html?testName=imaging-desaturate) 13:56:09 INFO - PROCESS | 13234 | RSS: Main: 228098048 13:56:09 INFO - PROCESS | 13234 | 13:56:12 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58845/tests/kraken/driver.html?testName=json-parse-financial) 13:56:12 INFO - PROCESS | 13234 | RSS: Main: 228188160 13:56:12 INFO - PROCESS | 13234 | 13:56:14 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58845/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:56:15 INFO - PROCESS | 13234 | RSS: Main: 190582784 13:56:15 INFO - PROCESS | 13234 | 13:56:16 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:56:17 INFO - PROCESS | 13234 | RSS: Main: 198115328 13:56:17 INFO - PROCESS | 13234 | 13:56:19 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:56:20 INFO - PROCESS | 13234 | RSS: Main: 195489792 13:56:20 INFO - PROCESS | 13234 | 13:56:23 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:56:23 INFO - PROCESS | 13234 | RSS: Main: 190529536 13:56:23 INFO - PROCESS | 13234 | 13:56:26 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:56:27 INFO - PROCESS | 13234 | RSS: Main: 193126400 13:56:27 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | Cycle 1(1): loaded http://localhost:58845/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58845/tests/kraken/driver.html?testName=ai-astar) 13:56:29 INFO - PROCESS | 13234 | RSS: Main: 243630080 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | __start_tp_report 13:56:29 INFO - PROCESS | 13234 | _x_x_mozilla_page_load 13:56:29 INFO - PROCESS | 13234 | _x_x_mozilla_page_load_details 13:56:29 INFO - PROCESS | 13234 | |i|pagename|runs| 13:56:29 INFO - PROCESS | 13234 | |0;ai-astar;107;115;115;116;111;116;116;114;117;114 13:56:29 INFO - PROCESS | 13234 | |1;audio-beat-detection;145;126;122;185;123;125;147;122;172;123 13:56:29 INFO - PROCESS | 13234 | |2;audio-dft;162;160;161;161;161;162;161;161;160;160 13:56:29 INFO - PROCESS | 13234 | |3;audio-fft;84;76;75;113;77;76;77;77;133;76 13:56:29 INFO - PROCESS | 13234 | |4;audio-oscillator;86;87;127;86;86;86;125;85;85;125 13:56:29 INFO - PROCESS | 13234 | |5;imaging-gaussian-blur;117;116;118;117;117;117;123;117;117;117 13:56:29 INFO - PROCESS | 13234 | |6;imaging-darkroom;146;146;147;146;147;146;146;146;147;146 13:56:29 INFO - PROCESS | 13234 | |7;imaging-desaturate;95;95;96;96;96;95;95;96;95;95 13:56:29 INFO - PROCESS | 13234 | |8;json-parse-financial;67;64;66;65;67;69;67;66;68;65 13:56:29 INFO - PROCESS | 13234 | |9;json-stringify-tinderbox;67;68;67;68;67;67;69;67;68;68 13:56:29 INFO - PROCESS | 13234 | |10;stanford-crypto-aes;92;81;82;88;85;83;83;82;82;83 13:56:29 INFO - PROCESS | 13234 | |11;stanford-crypto-ccm;133;133;131;132;136;131;138;139;165;134 13:56:29 INFO - PROCESS | 13234 | |12;stanford-crypto-pbkdf2;177;172;172;177;170;171;174;171;169;169 13:56:29 INFO - PROCESS | 13234 | |13;stanford-crypto-sha256-iterative;69;72;68;67;66;66;67;66;67;67 13:56:29 INFO - PROCESS | 13234 | __end_tp_report 13:56:29 INFO - PROCESS | 13234 | __start_cc_report 13:56:29 INFO - PROCESS | 13234 | _x_x_mozilla_cycle_collect,1930 13:56:29 INFO - PROCESS | 13234 | __end_cc_report 13:56:29 INFO - PROCESS | 13234 | __startTimestamp1471380989347__endTimestamp 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | ------- Summary: start ------- 13:56:29 INFO - PROCESS | 13234 | Number of tests: 14 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.50 stddev:3.00 (2.6%) stddev-sans-first:1.76 13:56:29 INFO - PROCESS | 13234 | Values: 107.0 115.0 115.0 116.0 111.0 116.0 116.0 114.0 117.0 114.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:135.50 stddev:23.00 (17.0%) stddev-sans-first:24.29 13:56:29 INFO - PROCESS | 13234 | Values: 145.0 126.0 122.0 185.0 123.0 125.0 147.0 122.0 172.0 123.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 13:56:29 INFO - PROCESS | 13234 | Values: 162.0 160.0 161.0 161.0 161.0 162.0 161.0 161.0 160.0 160.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#3] audio-fft Cycles:10 Average:86.40 Median:76.50 stddev:20.01 (26.2%) stddev-sans-first:21.21 13:56:29 INFO - PROCESS | 13234 | Values: 84.0 76.0 75.0 113.0 77.0 76.0 77.0 77.0 133.0 76.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:86.00 stddev:19.25 (22.4%) stddev-sans-first:19.93 13:56:29 INFO - PROCESS | 13234 | Values: 86.0 87.0 127.0 86.0 86.0 86.0 125.0 85.0 85.0 125.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.96 (1.7%) stddev-sans-first:2.06 13:56:29 INFO - PROCESS | 13234 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 123.0 117.0 117.0 117.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:56:29 INFO - PROCESS | 13234 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:56:29 INFO - PROCESS | 13234 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:67.00 stddev:1.51 (2.2%) stddev-sans-first:1.58 13:56:29 INFO - PROCESS | 13234 | Values: 67.0 64.0 66.0 65.0 67.0 69.0 67.0 66.0 68.0 65.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 13:56:29 INFO - PROCESS | 13234 | Values: 67.0 68.0 67.0 68.0 67.0 67.0 69.0 67.0 68.0 68.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:3.41 (4.1%) stddev-sans-first:2.11 13:56:29 INFO - PROCESS | 13234 | Values: 92.0 81.0 82.0 88.0 85.0 83.0 83.0 82.0 82.0 83.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:135.00 stddev:10.15 (7.5%) stddev-sans-first:10.65 13:56:29 INFO - PROCESS | 13234 | Values: 133.0 133.0 131.0 132.0 136.0 131.0 138.0 139.0 165.0 134.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:2.94 (1.7%) stddev-sans-first:2.55 13:56:29 INFO - PROCESS | 13234 | Values: 177.0 172.0 172.0 177.0 170.0 171.0 174.0 171.0 169.0 169.0 13:56:29 INFO - PROCESS | 13234 | 13:56:29 INFO - PROCESS | 13234 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.84 (2.7%) stddev-sans-first:1.87 13:56:29 INFO - PROCESS | 13234 | Values: 69.0 72.0 68.0 67.0 66.0 66.0 67.0 66.0 67.0 67.0 13:56:29 INFO - PROCESS | 13234 | -------- Summary: end -------- 13:56:29 INFO - PROCESS | 13234 | 13:56:30 INFO - TEST-INFO | 13234: exit 0 13:56:30 INFO - TEST-OK | kraken | took 63370ms 13:56:30 INFO - SUITE-END | took 1183s 13:56:30 INFO - Completed test suite (00:19:43) 13:56:30 INFO - javascript benchmark 13:56:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.6336712860198, 2625.8687065646714, 2644.761971422572, 2657.5216461037016, 2664.107523979467, 4662.883427914304, 4713.929291060636, 4754.429468463785, 4759.405074365704, 4802.927956080657, 4733.053389322132, 4751.144793937098, 4794.496577859327, 4804.087223427547, 4821.156297647906, 4332.0, 4444.333349997502, 4457.665675074382, 4463.308187230984, 4482.17079840229, 4351.151525452538, 4380.649548036149, 4425.468943726757, 4427.424434823469, 4431.0251744616135, 4530.728156310615, 4546.54534546546, 4574.931376029345, 4576.931346029813, 4577.496475387705, 4309.913801723948, 4431.158079964796, 4444.088961762831, 4457.33140028995, 4532.0256144929, 4303.870883873489, 4314.9784251078545, 4335.978320108379, 4354.0203454222865, 4362.738235705868, 4708.0819240248165, 4748.192807222746, 4767.785449654774, 4839.419269687624, 4841.15279826029, 5077.289179514871, 5135.229715542661, 5140.460251673595, 5178.430372659004, 5182.0931337016245, 5029.321041659366, 5087.135187018216, 5175.482451754832, 5181.378234611833, 5266.368035835686, 4837.419509658793, 4860.538248866387, 4876.561109500162, 4876.707397556158, 4882.218844984785, 5100.795968161232, 5352.384475785257, 5352.625316227826, 5355.303810504687, 5360.035193665178, 4998.100341938413, 5045.798168073309, 5047.419546752097, 5066.265391518209, 5127.820526281562, 5180.922286165711, 5186.377634683862, 5210.21846722987, 5234.92147617786, 5235.973820130875, 4924.113659541317, 5128.461511541309, 5139.100657384943, 5140.331756871583, 5187.299714538564, 4941.036497882878, 5021.4225364083595, 5032.069067222503, 5033.647644664911, 5035.974820125876, 4281.743095414286, 4291.763952982554, 4308.504521980012, 4310.331898555729, 4333.783310834446, 3768.0391500167284, 3774.3960966245268, 3774.9245015100096, 3799.848006079781, 3806.124591343951, 4315.654747620183, 4365.738055716603, 4417.712848664826, 4444.73331600105, 4445.0, 5135.12702840518, 5164.3802743671, 5172.327597412313, 5216.295800067019, 5219.869503262449, 4389.582989615981, 4389.758563279051, 4411.823527058882, 4437.134758722018, 4465.843695470643, 4438.889027774267, 4633.096546173464, 4640.257558790578, 4650.790714417859, 4692.296155576691, 4795.808167673254, 4825.565699087099, 4829.2997515359375, 4865.878353041202, 4908.484609115992, 5140.357455318085, 5142.331496905528, 5156.922646160236, 5165.354330708661, 5200.921986170135, 4745.1221524018165, 4805.183118869871, 4832.420109586872, 4836.492168322276, 4871.269309603588, 5045.772940217773, 5092.745362731923, 5113.974430127825, 5156.7421628919155, 5176.663516871391, 5185.299984502044, 5202.297689811979, 5203.843884683465, 5207.114790485551, 5255.763490642854, 4828.299896514915, 5065.670731402447, 5080.364954380702, 5087.796488140433, 5094.541491265803, 4899.216125419915, 4920.21276595743, 4955.182394904945, 4991.2513123030385, 5034.84895453137, 4874.561289483963, 4882.853514394574, 4940.135476291706, 4950.851474455772, 4951.480094590161, 4849.854504364875, 5005.474425185449, 5010.9248361273885, 5025.095482813129, 5026.874328141679, 4816.109019831342, 4871.098846713369, 4892.559669629608, 4913.017396520781, 4998.4501704813165], "value": 4712.082560806614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.1464446008756, 569.857535616096, 581.1718301420475, 581.2792137749192, 581.3227589857815, 28302.0, 37970.81014594927, 39889.80055099724, 39940.0, 44041.559584404145, 39833.0, 40228.79885600568, 40281.59718402815, 40306.0, 40344.0, 7613.809654758634, 7751.6124193790365, 7762.0, 7762.223777622249, 7766.495177813452, 7695.0765908090825, 7787.065552133752, 7787.454878158531, 7788.299053085221, 7792.610369481532, 7774.8445031099345, 7816.179301173352, 7819.804504887395, 7826.452148349618, 7831.0, 7733.96133019337, 7787.415943804181, 7790.220977902221, 7795.1035630902325, 7796.4932279401655, 7661.463697541174, 7726.343260822837, 7727.536347819093, 7729.806754831118, 7739.496932699357, 37687.24625507502, 38022.619773802464, 38023.0, 38037.42943855844, 38076.23847523034, 3128.8904888329025, 3154.479510880702, 3187.6174859017065, 3208.727258183034, 3381.9492707609406, 28775.424491510053, 29106.272343191376, 29351.119466416043, 29444.55833162504, 29499.70500294991, 3183.8726450941936, 3254.3653987472453, 3297.3734990351995, 3397.3205358928312, 3401.48977653354, 246619.0, 246965.0, 247661.0, 247673.0, 248544.9999999982, 31082.533761993134, 50557.74721126445, 50805.745971269906, 50872.23691644628, 50904.74547627238, 31791.523127153112, 33740.0, 33785.66214337825, 33788.155296117795, 33796.662033379354, 11480.425978701198, 11610.76778464426, 11625.1862369635, 11631.88368116308, 11722.238054526428, 9660.75848103789, 9674.467904265333, 9758.414495130315, 9759.463229522444, 9772.31593788428, 7846.411519136088, 7901.802454938557, 7904.0910295315625, 7969.688790250878, 7971.242731940456, 3099.5660607514965, 3101.65881753007, 3116.4546204414137, 3121.812691238533, 3177.0468859342104, 864.1574464896801, 872.2934423117296, 903.6159632156307, 961.2598299309493, 976.2092704908904, 28130.71869281281, 28321.858390708327, 28360.0, 28628.856855716003, 28816.423671526452, 751.5302935665209, 941.3222479814659, 952.8951815300311, 1001.3391161833155, 1063.1335461598771, 13698.52055178064, 14675.48635797742, 14727.26363681833, 14792.0, 14992.850071499364, 368442.0, 663883.0, 677460.0, 677624.0, 680705.3329933649, 49867.50132498701, 50358.244626330634, 50392.24411633828, 50419.0, 50476.21428392885, 1102.20090434436, 1193.6956076200513, 1200.963971080869, 1221.5602383142061, 1232.8150777383464, 26732.331691707863, 29139.417211656073, 29360.41279174447, 29606.851965740032, 29750.0, 41456.37815432831, 42079.0, 42144.78927605342, 42195.156096878505, 42198.57801421946, 295681.0, 297020.0, 297401.0, 298000.0, 298964.0, 25718.0, 25880.870595646902, 26222.213333600022, 27096.864515677295, 27264.0, 41799.0, 42419.5758042428, 42566.361504578075, 42951.570484296004, 43047.56952430561, 36315.45526817047, 36772.26455470929, 36775.632243678294, 37075.58488302404, 37611.81194094122, 36478.27043459169, 36543.269134616625, 36828.0, 37666.623333766314, 38220.80889595534, 28978.7102128976, 33411.0, 36462.8176859114, 39087.0, 39610.60389396069, 29361.70638293675, 30670.0, 34381.14047148841, 34646.480302794975, 34669.0, 25634.487310254062, 25656.486870262863, 25674.743252567234, 25702.742972570035, 25887.611685825104], "value": 16514.242568031725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.1478939282081, 364.23328892680905, 367.42497990644637, 380.0953730122308, 384.2718049296583, 16039.0, 16553.33786648534, 17257.48227553174, 17302.48092557222, 17332.56668583283, 15556.766648500281, 16280.918595407036, 16365.263563139657, 16468.423605173823, 16516.174191290447, 4877.122118018764, 5152.510511501401, 5153.768080436389, 5156.69059856408, 5161.27742116104, 3771.5662698789715, 3945.7040721945827, 5028.572571331441, 5669.461401166883, 6022.3074346450285, 6007.068904319837, 6086.7869624563145, 6098.725557349908, 6104.877902441948, 6108.755649774026, 5827.242458480413, 6002.909956350658, 6003.069524223731, 6050.0, 6067.302260240085, 5292.814751483718, 5295.179247216649, 5298.947010529884, 5300.522952934254, 6282.120503129566, 23606.0, 23822.166224182245, 23864.284071477883, 24086.518269634686, 24327.756722432903, 2099.0973881231066, 2115.206797450956, 2204.3166618348205, 2287.7025986621634, 2703.9459210815676, 13623.25072121033, 14681.48614798477, 14826.629334266621, 15264.38942442301, 15645.061296322143, 1888.830005299516, 1891.2718603337676, 1908.570571621388, 1913.8277555020115, 1934.8839069655726, 64822.675886620265, 76608.61695691486, 82524.58737706274, 84668.57665711633, 84967.15032849654, 16472.341106355612, 16976.236069376908, 17063.658726825393, 17286.13569321529, 17341.393051243398, 29367.412651746847, 29378.55932161019, 29397.82645644396, 29493.557596636067, 29643.110706678835, 7898.565578893216, 7988.081370642334, 8063.879041814377, 8194.959025204837, 8378.329733621418, 6363.172787537591, 6463.741450341934, 6562.475001999828, 6573.83565410859, 6715.496337774589, 8519.787005324917, 8550.385496465231, 8601.13988601135, 8674.956625216833, 8695.260947810337, 2655.362712948878, 2997.3405850712807, 3072.6620071792086, 3130.4521708700886, 3332.9333413331597, 764.8240904591863, 789.258097388453, 832.1013305629905, 885.5926273913943, 911.0661571888867, 16163.43427980015, 16946.915265423595, 17591.560210994572, 17641.7353739694, 18149.183286752126, 859.5401460218878, 861.801785589318, 862.9741107766777, 881.352206128495, 920.2453987729997, 8503.362247831437, 9886.406815591088, 9998.300118991747, 10066.14437772783, 10068.244881633907, 266801.0, 361100.0, 363566.0, 364098.0, 364291.0, 48218.0, 48287.27569086466, 48288.27567586489, 49037.754811225714, 50250.497495025316, 853.5774791478134, 895.632790555882, 905.4838741917044, 905.5517518828223, 907.1427501011613, 10082.0, 10420.11429028541, 16004.519864404087, 16075.196240188177, 16536.75194872054, 37450.438243426914, 38337.4249386265, 38673.22653546857, 40533.79733101316, 40655.7967210162, 51415.48584514107, 52598.737006314725, 53387.4661253398, 54202.0, 55756.0, 10649.680509584725, 10818.56725730962, 11198.888011119785, 11430.657080287605, 11450.770984580427, 7585.256367308204, 11610.825837612612, 12389.0, 12506.687332816753, 12626.621201363974, 5190.792368305226, 10125.59497620087, 10864.45677716127, 10921.672349829518, 11769.352685602375, 10736.516856741622, 11024.173187010845, 11224.66326010221, 11417.372044537298, 11604.07167426587, 10931.344119352865, 11471.598494053002, 11592.536298547964, 11655.417229138679, 11847.407629618658, 10558.0, 11077.501512431798, 11244.381559014333, 11539.249948753304, 11916.404179791149, 11317.377544235145, 11413.771724565297, 11440.82838757436, 11545.249558778652, 11938.462769175581], "value": 9189.256301643965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.4638144742103, 1375.546069796967, 1424.8788852947498, 1606.1888746183176, 1678.4041665208858, 7411.14771801243, 8028.197180281969, 8042.557659328734, 8053.557054362008, 8054.758357249285, 6832.521723479358, 7550.471466997313, 7731.613419329039, 7738.458307918448, 7953.76138715838, 2185.0495034659893, 2217.2128894242555, 2219.3120132758895, 2220.31170337196, 2228.955420891581, 2161.3299877038166, 2177.0, 2223.7442694090146, 2229.698990636268, 2230.130249202812, 2202.9559408811815, 2215.3464727905307, 2222.4554984028937, 2226.0205509575817, 2228.4094714900484, 2134.9893250533723, 2138.2729871843494, 2143.356992902131, 2145.2598853395552, 2147.3987283560627, 2128.5955668423103, 2157.902894369757, 2164.9783502164933, 2169.631162702344, 2170.0994087453687, 7942.404319675989, 7990.720324788663, 8109.675612975474, 8111.0, 8116.5941702914615, 4371.519132895379, 4491.887702807423, 4496.0, 4496.865094047183, 4498.122866041123, 2913.621229240185, 2985.283531952316, 3045.193023848682, 3051.7558595312544, 3070.8157510549213, 865.2429124516049, 904.6697955246353, 918.6600957645647, 923.8198551282503, 927.1562877781254, 10371.533281002374, 10397.32417392867, 10465.215108866865, 10560.630377936735, 10561.683149505527, 3910.3743401056263, 4119.340905455113, 4132.0, 4274.807633656431, 4295.0, 8951.239144672776, 8968.461892286483, 9006.819863602692, 9008.41445306053, 9015.323850711224, 4408.382826404306, 4430.069685366109, 4435.379046933432, 4437.400950871591, 4443.311286750559, 3620.6922411594783, 3944.3886197639413, 4003.7597744135446, 4024.215278020758, 4126.216018956388, 3662.8717994870585, 3681.3189559931498, 3785.8296376663116, 3793.468914351993, 3805.82873770681, 1204.3857632607433, 1215.3254943506438, 1217.9842360892737, 1218.969525761863, 1219.1405059433077, 757.9469437139347, 776.6466257852776, 815.8001289683947, 822.8189798244376, 846.9788255293666, 4993.950060499421, 5084.847454576368, 5146.330976972969, 5154.819581314711, 5303.15149576066, 807.414624397319, 822.5188264865121, 859.9570021498901, 871.6295574380863, 884.9070847561043, 3327.900162995114, 3523.735719821024, 3546.0, 3567.8929632111076, 3627.4196128619296, 9234.76913077165, 9770.75573110678, 9808.803823923481, 9820.852687209697, 9833.852492212622, 9494.0, 9740.220782337396, 9789.118979291898, 9810.362326448758, 9848.409095454152, 7337.926620733831, 7419.035525381773, 7422.369098626569, 7438.962805185939, 7441.441891858132, 4982.377202849644, 4985.3020577118505, 5013.724245166405, 5095.312132862165, 5236.528712415901, 8638.438501497634, 8874.290056795311, 8901.688440904538, 9027.819443610959, 9110.635574576943, 9015.14356136166, 9169.266458683423, 9228.584713688035, 9263.073692630684, 9266.351355405057, 6232.501399888089, 6284.4344009039405, 6586.473082153512, 6620.238672552526, 6759.831004224934, 7449.106107267163, 7522.398208143226, 7733.613319333898, 7769.611519423893, 7770.0, 6637.6681165940545, 6761.22245941723, 6841.179058512811, 6929.896051559332, 7005.824854378681, 6496.935030649822, 6657.434118099822, 6826.795196144124, 6955.061066755923, 6989.301069893173, 6146.446819786241, 6208.068789681584, 6214.378562143749, 6215.254169499689, 6230.43926046658, 4531.45622525299, 4583.7249765012875, 4598.26427771555, 4652.092841895797, 4676.976615116902, 4604.148232576984, 4646.8141274348645, 4647.186742320148, 4684.601808846286, 4869.147899117569], "value": 4131.293572362327, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.6304619225969, 304.06348446783903, 307.71690045158454, 308.910415979366, 313.17946978915245, 4789.64077694173, 4810.903781924364, 4831.951680483194, 4840.814000569857, 4870.245112007645, 4568.543145685429, 4663.277192035232, 4712.85861424157, 4717.504662010482, 4806.870385459414, 3621.6559426854406, 3691.7231207659397, 3714.090047938259, 3789.924201515968, 3798.9430158547643, 3789.128500444899, 3791.2939177370154, 3802.6007269236748, 3818.923621527568, 3829.770213787168, 3653.17803494213, 3751.4935483709623, 3766.642168993955, 3789.7347185697013, 3793.506844110276, 3578.033930838672, 3652.6895213906582, 3720.720945929039, 3749.512563366772, 3754.361758501048, 3327.4676051831834, 3329.8844886962897, 3331.6168640606397, 3334.8332583370734, 3344.812591529996, 4689.812407503696, 4698.248280275174, 4698.389209402756, 4706.317583950342, 4709.7174169549935, 3988.74073185242, 4281.743095414254, 4282.635975942048, 4291.527931927485, 4295.548967358445, 4877.853664390074, 4959.231319145538, 4963.1810751226, 4963.677360971561, 4994.777324090781, 3572.964270357289, 3583.4803953426867, 3586.4620306954166, 3590.3716849551483, 3594.532710747586, 5215.608829337777, 5239.371275446971, 5266.0, 5269.4730526947, 5278.9208161877605, 3437.1063523483576, 3626.5648122225502, 3649.233660931234, 3666.7249956253386, 3680.1719613086843, 3707.4428739929294, 3714.591394946554, 3718.9814050930113, 3724.2923844469465, 3725.5715592706642, 4246.554111818215, 4246.702730808814, 4250.596193361625, 4257.084726783756, 4271.188474189894, 4759.38128043359, 4989.700617962933, 5026.472220416877, 5030.748462576857, 5043.697378157322, 1265.0828149591473, 1279.5457612547411, 1284.9678758031123, 1285.6721536008258, 1285.8199852020725, 800.7517669522466, 815.1278132398277, 827.4456114403364, 830.1822704635929, 833.9749807505784, 3959.980200098981, 3965.6827453803626, 3970.940435893464, 3977.1846771411792, 3982.7809470478824, 4564.1556312082375, 4572.0, 4584.4498660160325, 4585.738921796533, 4596.322342345087, 3964.484616999829, 3983.26727873376, 3984.2828290907337, 3990.4413382126527, 4003.0592810689463, 2471.530409222242, 2502.4369516858924, 2582.3931376126593, 2703.2295795698133, 2733.0, 4821.879453013703, 4834.734089625034, 4835.081334546425, 4853.320535125085, 4866.172750632401, 5240.737963101829, 5253.369595648546, 5256.579473642099, 5259.263703081495, 5263.289455923478, 4708.246680531099, 4816.109019831342, 4848.418189817245, 4850.6362022848425, 4858.732769697701, 5131.127708289525, 5143.897122057613, 5155.32980712505, 5160.0, 5167.682241028664, 5054.2671312660195, 5065.189569668835, 5066.670666406671, 5069.3156423883775, 5079.257201111359, 4697.600703940203, 4865.878353041202, 4877.097736918681, 4922.704637721748, 4923.8276660316715, 3657.9634203657624, 3665.0, 3678.9448158278183, 3680.190358121209, 3693.1505753677343, 5200.947990520046, 5209.661372010807, 5212.374515058065, 5224.6342756008235, 5229.843104706865, 4865.489123641966, 4996.625253105959, 5016.573591244785, 5020.774065167149, 5054.873628159326, 5001.174806156943, 5014.247862820606, 5020.246962955586, 5048.273932076638, 5051.0, 4950.183219768842, 4957.380327459067, 4967.254911763264, 4967.304577359245, 4997.275395067768, 4807.6394270429155, 5023.120953833138, 5048.141815891234, 5065.113605119163, 5069.721165335942, 4960.849860338639, 4968.720644374695, 4971.130052240916, 4977.626677999092, 4993.575546078624], "value": 3744.4211167938283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.2484394506866, 616.0974172836796, 654.5320096131267, 730.1165589636539, 736.1975446763029, 12182.939085304572, 13200.33998300086, 13219.735605287888, 13222.471101155943, 13222.933885330573, 13498.257595832225, 13659.590212293648, 13667.17996920183, 13684.657883552916, 13688.93155534221, 627.1439485102848, 742.5359150530918, 760.6653072648031, 777.327611615951, 782.077148964222, 774.1097737601747, 787.1813314153273, 789.9052113746359, 790.0282652337628, 790.4269404681588, 836.2933321343486, 837.660747397302, 838.8070743728946, 839.5214727605268, 840.4915026409026, 651.6481100205931, 672.4553111979263, 828.9005319361685, 829.2081062585216, 830.2278880641002, 494.36967865970814, 494.8663860757611, 579.1920271221622, 594.2660813894836, 600.7566935391174, 12077.27536347822, 12091.818622720666, 12145.210561313486, 12173.08701847365, 12203.572874949423, 12310.753784924342, 12676.492940282378, 12903.290319032449, 13194.736105277936, 13437.462501499927, 11708.121890858134, 11759.0, 11850.229735067192, 12125.514979400814, 12130.696732581668, 3228.91927701807, 3312.089175476763, 4073.226087043482, 4136.627703506669, 4207.221663992141, 59987.0, 60009.69995149996, 60397.0, 60755.0, 61357.386426135614, 9738.464384458923, 10080.445575493419, 10137.138343240907, 10148.543315550818, 10256.38461692301, 17842.91078544625, 17992.550186245186, 18142.274309027754, 18182.63634727298, 18284.17721202549, 6448.0, 6500.284968653445, 6524.445422139076, 6534.379233972765, 6899.724011039502, 3674.9816250919107, 3683.4658974448553, 3760.6803421708914, 3799.35410980134, 3819.52255968004, 2970.9702902970694, 3101.364220334826, 3101.364220334826, 3103.6275646922063, 3110.751139908802, 568.6616463204386, 582.705733604527, 588.490955323642, 588.4938952500846, 605.300877486495, 518.4918779595941, 536.6270442042743, 542.7232111623101, 549.3984087424265, 577.9479846813807, 7652.617369131633, 7853.921460785434, 7871.685132594746, 8117.918820811835, 8210.958945205235, 595.3599880128879, 610.6732897899602, 620.4849974521137, 620.525298146918, 622.3527531367417, 3725.441183822394, 3988.960110398917, 3993.4209539616595, 4008.178323443687, 4052.371882358239, 93657.0, 103893.0, 104440.47779761053, 104749.0, 106155.81532554036, 73697.6315118421, 80741.0, 82347.5882620583, 89072.5546372277, 90329.54835225914, 51933.740331298104, 54700.45299546954, 63406.68296658487, 72964.0, 86544.0, 8017.438779285394, 8262.710805121791, 8385.245327920517, 8482.151784821468, 8487.618057187565, 39643.405348919216, 46391.76804115958, 47031.0, 47034.76482617565, 49884.750576246886, 38092.0, 39167.824965251086, 39311.80344098376, 41546.0, 59501.70249148727, 10521.894781052397, 10772.784544308914, 10898.945505272422, 11045.697222873205, 11120.833187502032, 12017.339046352534, 12018.33899135556, 12040.458179382123, 12122.151449398458, 12172.39138043112, 11034.724131896766, 11137.721556961142, 11236.55053797839, 11852.407379630811, 12135.238076196407, 10289.639862604772, 10377.533011014371, 10416.635417760343, 10841.67474975752, 10978.121750259801, 11063.944680276547, 11391.886081139413, 11584.42077896085, 11977.760444791229, 12297.938510307391, 10563.419011954416, 10926.08562054581, 11133.777324453627, 11145.164112691742, 11296.096312295162, 9649.662261820802, 10491.213159012952, 10590.8411373831, 10632.202584806017, 10634.680959571226], "value": 6495.0835054155295, "unit": "score"}], "name": "dromaeo_css", "value": 6447.769312889658, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 116.0, 111.0, 116.0, 116.0, 114.0, 117.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 122.0, 185.0, 123.0, 125.0, 147.0, 122.0, 172.0, 123.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 75.0, 113.0, 77.0, 76.0, 77.0, 77.0, 133.0, 76.0], "value": 86.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 127.0, 86.0, 86.0, 86.0, 125.0, 85.0, 85.0, 125.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 123.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 65.0, 67.0, 69.0, 67.0, 66.0, 68.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 69.0, 67.0, 68.0, 68.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 81.0, 82.0, 88.0, 85.0, 83.0, 83.0, 82.0, 82.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 131.0, 132.0, 136.0, 131.0, 138.0, 139.0, 165.0, 134.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 172.0, 177.0, 170.0, 171.0, 174.0, 171.0, 169.0, 169.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 68.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1552.4999999999998, "alertThreshold": 2.0}]} 13:56:30 INFO - Return code: 0 13:56:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:56:30 INFO - # TBPL SUCCESS # 13:56:30 INFO - Running post-action listener: _resource_record_post_action 13:56:30 INFO - [mozharness: 2016-08-16 20:56:30.634417Z] Finished run-tests step (success) 13:56:30 INFO - Running post-run listener: _resource_record_post_run 13:56:30 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 412037120; Read time: 184; Write time: 235884 13:56:30 INFO - TinderboxPrint: CPU usage
13.0% 13:56:30 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 13:56:30 INFO - TinderboxPrint: I/O write bytes / time
412,037,120 / 235,884 13:56:30 INFO - TinderboxPrint: CPU idle
8,326.2 (87.0%) 13:56:30 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 13:56:30 INFO - TinderboxPrint: Swap in / out
0 / 0 13:56:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116899840; Read time: 92; Write time: 67980 13:56:30 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281214976; Read time: 92; Write time: 165508 13:56:31 INFO - Running post-run listener: _upload_blobber_files 13:56:31 INFO - Blob upload gear active. 13:56:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:56:31 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 13:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:56:31 INFO - (blobuploader) - INFO - Open directory for files ... 13:56:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:56:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:32 INFO - (blobuploader) - INFO - Done attempting. 13:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:56:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:33 INFO - (blobuploader) - INFO - Done attempting. 13:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:56:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:36 INFO - (blobuploader) - INFO - Done attempting. 13:56:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:56:36 INFO - Return code: 0 13:56:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:56:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:56:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3af0838d6cfabc0f10e851368e73ad0ffa9676b4b11c3dd6696f8493a1cc20d301d735e2dab63a8c1b93ab098602482ede38d9a9f80c4bc3e00bbb53ca30236", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f48be7cab181ec1f555c3d149685f6b36ca2d165a5df04b7140b9daf85d021c4c279a51bb03b2e002b4607a467cd9dd735c05c0c905e6e459f532ca6f4d67d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65cc727bf449a6242ea71ce1976900b2d13f8a5f7e5334c865d7b66519ae9ba9533768e4ba42f0a255bb454f79f02408912029335e08a5ce9fb8ac7d965cc352"} 13:56:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:56:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:56:36 INFO - Contents: 13:56:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3af0838d6cfabc0f10e851368e73ad0ffa9676b4b11c3dd6696f8493a1cc20d301d735e2dab63a8c1b93ab098602482ede38d9a9f80c4bc3e00bbb53ca30236", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f48be7cab181ec1f555c3d149685f6b36ca2d165a5df04b7140b9daf85d021c4c279a51bb03b2e002b4607a467cd9dd735c05c0c905e6e459f532ca6f4d67d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65cc727bf449a6242ea71ce1976900b2d13f8a5f7e5334c865d7b66519ae9ba9533768e4ba42f0a255bb454f79f02408912029335e08a5ce9fb8ac7d965cc352"} 13:56:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:56:36 INFO - Copying logs to upload dir... 13:56:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:56:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.097072 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-16 13:56:36.107691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 13:56:36.111576) ========= 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-1471378274.895143-1850082797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3af0838d6cfabc0f10e851368e73ad0ffa9676b4b11c3dd6696f8493a1cc20d301d735e2dab63a8c1b93ab098602482ede38d9a9f80c4bc3e00bbb53ca30236", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f48be7cab181ec1f555c3d149685f6b36ca2d165a5df04b7140b9daf85d021c4c279a51bb03b2e002b4607a467cd9dd735c05c0c905e6e459f532ca6f4d67d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65cc727bf449a6242ea71ce1976900b2d13f8a5f7e5334c865d7b66519ae9ba9533768e4ba42f0a255bb454f79f02408912029335e08a5ce9fb8ac7d965cc352"} build_url:https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/UfGf_VZUStCcQbG1NFa5pw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3af0838d6cfabc0f10e851368e73ad0ffa9676b4b11c3dd6696f8493a1cc20d301d735e2dab63a8c1b93ab098602482ede38d9a9f80c4bc3e00bbb53ca30236", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8f48be7cab181ec1f555c3d149685f6b36ca2d165a5df04b7140b9daf85d021c4c279a51bb03b2e002b4607a467cd9dd735c05c0c905e6e459f532ca6f4d67d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65cc727bf449a6242ea71ce1976900b2d13f8a5f7e5334c865d7b66519ae9ba9533768e4ba42f0a255bb454f79f02408912029335e08a5ce9fb8ac7d965cc352"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 13:56:36.141717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:56:36.142488) ========= 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-1471378274.895143-1850082797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 13:56:36.226412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 13:56:36.227133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 13:56:36.227827) ========= ========= Total master_lag: 0.19 =========