builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1472782025.24 results: success (0) buildid: 20160901174542 builduid: eae1db59bb6a4ca7ac9b3e2e285e6f88 revision: 2d457db23476fecab9e6e66a737c6723d0d2767c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.238451) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.238867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.239288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.263499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.263795) ========= 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=db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 19:07:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-09-01 19:07:05 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.408670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.409015) ========= 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=db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017263 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.458801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:05.459177) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2d457db23476fecab9e6e66a737c6723d0d2767c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2d457db23476fecab9e6e66a737c6723d0d2767c --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=db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 19:07:06,080 truncating revision to first 12 chars 2016-09-01 19:07:06,080 Setting DEBUG logging. 2016-09-01 19:07:06,080 attempt 1/10 2016-09-01 19:07:06,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2d457db23476?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 19:07:06,381 unpacking tar archive at: mozilla-central-2d457db23476/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:06.117980) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:06.118302) ========= script_repo_revision: 2d457db23476fecab9e6e66a737c6723d0d2767c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:06.118699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:06.119008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 19:07:06.132372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-01 19:07:06.132678) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:06 INFO - MultiFileLogger online at 20160901 19:07:06 in /builds/slave/test 19:07:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:07:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:06 INFO - {'append_to_log': False, 19:07:06 INFO - 'base_work_dir': '/builds/slave/test', 19:07:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:07:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:06 INFO - 'branch': 'Firefox-Non-PGO', 19:07:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:06 INFO - 'config_files': ('talos/linux_config.py',), 19:07:06 INFO - 'default_actions': ('clobber', 19:07:06 INFO - 'read-buildbot-config', 19:07:06 INFO - 'download-and-extract', 19:07:06 INFO - 'populate-webroot', 19:07:06 INFO - 'create-virtualenv', 19:07:06 INFO - 'install', 19:07:06 INFO - 'run-tests'), 19:07:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:06 INFO - 'download_minidump_stackwalk': True, 19:07:06 INFO - 'download_symbols': 'ondemand', 19:07:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:06 INFO - 'installer_path': 'installer.exe', 19:07:06 INFO - 'log_level': 'info', 19:07:06 INFO - 'log_name': 'talos', 19:07:06 INFO - 'log_to_console': True, 19:07:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:06 INFO - 'opt_config_files': (), 19:07:06 INFO - 'pip_index': False, 19:07:06 INFO - 'sps_profile': False, 19:07:06 INFO - 'sps_profile_interval': 0, 19:07:06 INFO - 'suite': 'dromaeojs-e10s', 19:07:06 INFO - 'system_bits': '32', 19:07:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:06 INFO - 'title': 'talos-linux64-ix-049', 19:07:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:06 INFO - 'use_talos_json': True, 19:07:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:06 INFO - 'work_dir': 'build'} 19:07:06 INFO - [mozharness: 2016-09-02 02:07:06.849392Z] Running clobber step. 19:07:06 INFO - Running pre-action listener: _resource_record_pre_action 19:07:06 INFO - Running main action method: clobber 19:07:06 INFO - rmtree: /builds/slave/test/build 19:07:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:07 INFO - Running post-action listener: _resource_record_post_action 19:07:07 INFO - [mozharness: 2016-09-02 02:07:07.832260Z] Finished clobber step (success) 19:07:07 INFO - [mozharness: 2016-09-02 02:07:07.832361Z] Running read-buildbot-config step. 19:07:07 INFO - Running pre-action listener: _resource_record_pre_action 19:07:07 INFO - Running main action method: read_buildbot_config 19:07:07 INFO - Using buildbot properties: 19:07:07 INFO - { 19:07:07 INFO - "project": "", 19:07:07 INFO - "product": "firefox", 19:07:07 INFO - "script_repo_revision": "production", 19:07:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:07:07 INFO - "repository": "", 19:07:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:07:07 INFO - "buildid": "20160901174542", 19:07:07 INFO - "pgo_build": "False", 19:07:07 INFO - "basedir": "/builds/slave/test", 19:07:07 INFO - "buildnumber": 433, 19:07:07 INFO - "slavename": "talos-linux64-ix-049", 19:07:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:07:07 INFO - "platform": "ubuntu64_hw", 19:07:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:07:07 INFO - "branch": "mozilla-central", 19:07:07 INFO - "repo_path": "mozilla-central", 19:07:07 INFO - "revision": "2d457db23476fecab9e6e66a737c6723d0d2767c", 19:07:07 INFO - "stage_platform": "linux64", 19:07:07 INFO - "builduid": "eae1db59bb6a4ca7ac9b3e2e285e6f88", 19:07:07 INFO - "slavebuilddir": "test" 19:07:07 INFO - } 19:07:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:07:07 INFO - Running post-action listener: _resource_record_post_action 19:07:07 INFO - [mozharness: 2016-09-02 02:07:07.835082Z] Finished read-buildbot-config step (success) 19:07:07 INFO - [mozharness: 2016-09-02 02:07:07.835173Z] Running download-and-extract step. 19:07:07 INFO - Running pre-action listener: _resource_record_pre_action 19:07:07 INFO - Running main action method: download_and_extract 19:07:07 INFO - mkdir: /builds/slave/test/build/tests 19:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:07 INFO - trying https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:07:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:08 INFO - Downloaded 1361 bytes. 19:07:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:07:08 INFO - Using the following test package requirements: 19:07:08 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:07:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'jsshell-linux-x86_64.zip'], 19:07:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:07:08 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:07:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07:08 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')]} 19:07:08 INFO - trying https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:07:08 INFO - Downloading https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:09 INFO - Downloaded 20334479 bytes. 19:07:09 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 19:07:13 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 19:07: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')]} 19:07:13 INFO - trying https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:07:13 INFO - Downloading https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:14 INFO - Downloaded 20334479 bytes. 19:07:14 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 19:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:19 INFO - trying https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:19 INFO - Downloading https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:19 INFO - Downloaded 14413998 bytes. 19:07:19 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 19:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:20 INFO - trying https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:07:20 INFO - Downloading https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/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 19:07:21 INFO - Downloaded 55861961 bytes. 19:07:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:07:21 INFO - mkdir: /builds/slave/test/properties 19:07:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:07:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:07:21 INFO - Contents: 19:07:21 INFO - build_url:https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:07:22 INFO - Running post-action listener: _resource_record_post_action 19:07:22 INFO - Running post-action listener: set_extra_try_arguments 19:07:22 INFO - [mozharness: 2016-09-02 02:07:22.103468Z] Finished download-and-extract step (success) 19:07:22 INFO - [mozharness: 2016-09-02 02:07:22.103698Z] Running populate-webroot step. 19:07:22 INFO - Running pre-action listener: _resource_record_pre_action 19:07:22 INFO - Running main action method: populate_webroot 19:07:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:22 INFO - '--tppagecycles', 19:07:22 INFO - '7'], 19:07:22 INFO - 'tests': ['tsvgm']}}, 19:07:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:07:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:07:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:07:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['damp', 'tps']}, 19:07:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'tests': ['damp', 'tps']}, 19:07:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['dromaeo_dom']}, 19:07:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['basic_compositor_video']}, 19:07:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:07:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['a11yr', 19:07:22 INFO - 'ts_paint', 19:07:22 INFO - 'tpaint', 19:07:22 INFO - 'sessionrestore', 19:07:22 INFO - 'sessionrestore_no_auto_restore', 19:07:22 INFO - 'tabpaint']}, 19:07:22 INFO - 'other-e10s': {'tests': ['a11yr', 19:07:22 INFO - 'ts_paint', 19:07:22 INFO - 'tpaint', 19:07:22 INFO - 'sessionrestore', 19:07:22 INFO - 'sessionrestore_no_auto_restore', 19:07:22 INFO - 'tabpaint']}, 19:07:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:07:22 INFO - 'ts_paint', 19:07:22 INFO - 'tpaint', 19:07:22 INFO - 'sessionrestore', 19:07:22 INFO - 'sessionrestore_no_auto_restore', 19:07:22 INFO - 'tabpaint']}, 19:07:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:07:22 INFO - 'ts_paint', 19:07:22 INFO - 'tpaint', 19:07:22 INFO - 'sessionrestore', 19:07:22 INFO - 'sessionrestore_no_auto_restore', 19:07:22 INFO - 'tabpaint']}, 19:07:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['a11yr', 19:07:22 INFO - 'ts_paint', 19:07:22 INFO - 'tpaint', 19:07:22 INFO - 'sessionrestore', 19:07:22 INFO - 'sessionrestore_no_auto_restore', 19:07:22 INFO - 'tabpaint']}, 19:07:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['a11yr', 19:07:22 INFO - 'ts_paint', 19:07:22 INFO - 'tpaint', 19:07:22 INFO - 'sessionrestore', 19:07:22 INFO - 'sessionrestore_no_auto_restore', 19:07:22 INFO - 'tabpaint']}, 19:07:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['tsvgx', 19:07:22 INFO - 'tsvgr_opacity', 19:07:22 INFO - 'tart', 19:07:22 INFO - 'tscrollx', 19:07:22 INFO - 'cart']}, 19:07:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:07:22 INFO - 'tsvgr_opacity', 19:07:22 INFO - 'tart', 19:07:22 INFO - 'tscrollx', 19:07:22 INFO - 'cart']}, 19:07:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'talos_options': ['--disable-e10s'], 19:07:22 INFO - 'tests': ['tp5o']}, 19:07:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'tests': ['tp5o']}, 19:07:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'talos_options': ['--disable-e10s', 19:07:22 INFO - '--xperf_path', 19:07:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:22 INFO - 'tests': ['tp5n']}, 19:07:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:22 INFO - 'talos_options': ['--xperf_path', 19:07:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:22 INFO - 'tests': ['tp5n']}}, 19:07:22 INFO - 'talos.zip': {'path': '', 19:07:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:22 INFO - Running post-action listener: _resource_record_post_action 19:07:22 INFO - [mozharness: 2016-09-02 02:07:22.121337Z] Finished populate-webroot step (success) 19:07:22 INFO - [mozharness: 2016-09-02 02:07:22.121427Z] Running create-virtualenv step. 19:07:22 INFO - Running pre-action listener: _resource_record_pre_action 19:07:22 INFO - Running main action method: create_virtualenv 19:07:22 INFO - Creating virtualenv /builds/slave/test/build/venv 19:07:22 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 19:07:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:07:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:22 INFO - Using real prefix '/usr' 19:07:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:07:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:24 INFO - Installing pip.................done. 19:07:24 INFO - Return code: 0 19:07:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:24 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:24 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 19:07:24 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 19:07:24 INFO - Using env: {'DISPLAY': ':0', 19:07:24 INFO - 'HOME': '/home/cltbld', 19:07:24 INFO - 'LANG': 'en_US.UTF-8', 19:07:24 INFO - 'LANGUAGE': 'en_US:en', 19:07:24 INFO - 'LOGNAME': 'cltbld', 19:07:24 INFO - 'MAIL': '/var/mail/cltbld', 19:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:24 INFO - 'MOZ_NO_REMOTE': '1', 19:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:24 INFO - 'NO_EM_RESTART': '1', 19:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:24 INFO - 'PWD': '/builds/slave/test', 19:07:24 INFO - 'SHELL': '/bin/bash', 19:07:24 INFO - 'SHLVL': '1', 19:07:24 INFO - 'TERM': 'linux', 19:07:24 INFO - 'TMOUT': '86400', 19:07:24 INFO - 'USER': 'cltbld', 19:07:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:24 INFO - '_': '/tools/buildbot/bin/python'} 19:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:24 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 19:07:24 INFO - Cleaning up... 19:07:24 INFO - Return code: 0 19:07:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:24 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:24 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 19:07:24 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 19:07:24 INFO - Using env: {'DISPLAY': ':0', 19:07:24 INFO - 'HOME': '/home/cltbld', 19:07:24 INFO - 'LANG': 'en_US.UTF-8', 19:07:24 INFO - 'LANGUAGE': 'en_US:en', 19:07:24 INFO - 'LOGNAME': 'cltbld', 19:07:24 INFO - 'MAIL': '/var/mail/cltbld', 19:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:24 INFO - 'MOZ_NO_REMOTE': '1', 19:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:24 INFO - 'NO_EM_RESTART': '1', 19:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:24 INFO - 'PWD': '/builds/slave/test', 19:07:24 INFO - 'SHELL': '/bin/bash', 19:07:24 INFO - 'SHLVL': '1', 19:07:24 INFO - 'TERM': 'linux', 19:07:24 INFO - 'TMOUT': '86400', 19:07:24 INFO - 'USER': 'cltbld', 19:07:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:24 INFO - '_': '/tools/buildbot/bin/python'} 19:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:25 INFO - Downloading/unpacking psutil>=3.1.1 19:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:27 INFO - Installing collected packages: psutil 19:07:27 INFO - Running setup.py install for psutil 19:07:27 INFO - building 'psutil._psutil_linux' extension 19:07:27 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 19:07:27 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 19:07:27 INFO - building 'psutil._psutil_posix' extension 19:07:27 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 19:07:27 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 19:07:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:27 INFO - Successfully installed psutil 19:07:27 INFO - Cleaning up... 19:07:27 INFO - Return code: 0 19:07:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:27 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:27 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 19:07:27 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 19:07:27 INFO - Using env: {'DISPLAY': ':0', 19:07:27 INFO - 'HOME': '/home/cltbld', 19:07:27 INFO - 'LANG': 'en_US.UTF-8', 19:07:27 INFO - 'LANGUAGE': 'en_US:en', 19:07:27 INFO - 'LOGNAME': 'cltbld', 19:07:27 INFO - 'MAIL': '/var/mail/cltbld', 19:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:27 INFO - 'MOZ_NO_REMOTE': '1', 19:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:27 INFO - 'NO_EM_RESTART': '1', 19:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:27 INFO - 'PWD': '/builds/slave/test', 19:07:27 INFO - 'SHELL': '/bin/bash', 19:07:27 INFO - 'SHLVL': '1', 19:07:27 INFO - 'TERM': 'linux', 19:07:27 INFO - 'TMOUT': '86400', 19:07:27 INFO - 'USER': 'cltbld', 19:07:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:27 INFO - '_': '/tools/buildbot/bin/python'} 19:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:07:27 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 19:07:27 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 19:07:27 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 19:07:27 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 19:07:27 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 19:07:27 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 19:07:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:07:29 INFO - Installing collected packages: mozsystemmonitor 19:07:29 INFO - Running setup.py install for mozsystemmonitor 19:07:29 INFO - Successfully installed mozsystemmonitor 19:07:29 INFO - Cleaning up... 19:07:29 INFO - Return code: 0 19:07:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:29 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:29 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 19:07:29 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 19:07:29 INFO - Using env: {'DISPLAY': ':0', 19:07:29 INFO - 'HOME': '/home/cltbld', 19:07:29 INFO - 'LANG': 'en_US.UTF-8', 19:07:29 INFO - 'LANGUAGE': 'en_US:en', 19:07:29 INFO - 'LOGNAME': 'cltbld', 19:07:29 INFO - 'MAIL': '/var/mail/cltbld', 19:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:29 INFO - 'MOZ_NO_REMOTE': '1', 19:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:29 INFO - 'NO_EM_RESTART': '1', 19:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:29 INFO - 'PWD': '/builds/slave/test', 19:07:29 INFO - 'SHELL': '/bin/bash', 19:07:29 INFO - 'SHLVL': '1', 19:07:30 INFO - 'TERM': 'linux', 19:07:30 INFO - 'TMOUT': '86400', 19:07:30 INFO - 'USER': 'cltbld', 19:07:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:30 INFO - '_': '/tools/buildbot/bin/python'} 19:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:07:30 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 19:07:30 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 19:07:30 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 19:07:30 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 19:07:30 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 19:07:30 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 19:07:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:07:32 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 19:07:32 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 19:07:32 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 19:07:32 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 19:07:32 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 19:07:32 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 19:07:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:32 INFO - warning: no files found matching '*.txt' 19:07:32 INFO - no previously-included directories found matching 'build' 19:07:32 INFO - no previously-included directories found matching 'dist' 19:07:32 INFO - no previously-included directories found matching '.git*' 19:07:32 INFO - Installing collected packages: jsonschema, functools32 19:07:32 INFO - Running setup.py install for functools32 19:07:32 INFO - warning: no files found matching '*.txt' 19:07:32 INFO - no previously-included directories found matching 'build' 19:07:32 INFO - no previously-included directories found matching 'dist' 19:07:32 INFO - no previously-included directories found matching '.git*' 19:07:32 INFO - Successfully installed jsonschema functools32 19:07:32 INFO - Cleaning up... 19:07:32 INFO - Return code: 0 19:07:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:07:32 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')]} 19:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 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')]} 19:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:32 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 19:07:32 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 19:07:32 INFO - Using env: {'DISPLAY': ':0', 19:07:32 INFO - 'HOME': '/home/cltbld', 19:07:32 INFO - 'LANG': 'en_US.UTF-8', 19:07:32 INFO - 'LANGUAGE': 'en_US:en', 19:07:32 INFO - 'LOGNAME': 'cltbld', 19:07:32 INFO - 'MAIL': '/var/mail/cltbld', 19:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:32 INFO - 'MOZ_NO_REMOTE': '1', 19:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:32 INFO - 'NO_EM_RESTART': '1', 19:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:32 INFO - 'PWD': '/builds/slave/test', 19:07:32 INFO - 'SHELL': '/bin/bash', 19:07:32 INFO - 'SHLVL': '1', 19:07:32 INFO - 'TERM': 'linux', 19:07:32 INFO - 'TMOUT': '86400', 19:07:32 INFO - 'USER': 'cltbld', 19:07:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:32 INFO - '_': '/tools/buildbot/bin/python'} 19:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:07:32 INFO - Cleaning up... 19:07:32 INFO - Return code: 0 19:07:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:07:32 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')]} 19:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 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')]} 19:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:32 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:32 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 19:07:32 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 19:07:32 INFO - Using env: {'DISPLAY': ':0', 19:07:32 INFO - 'HOME': '/home/cltbld', 19:07:32 INFO - 'LANG': 'en_US.UTF-8', 19:07:32 INFO - 'LANGUAGE': 'en_US:en', 19:07:32 INFO - 'LOGNAME': 'cltbld', 19:07:32 INFO - 'MAIL': '/var/mail/cltbld', 19:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:32 INFO - 'MOZ_NO_REMOTE': '1', 19:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:32 INFO - 'NO_EM_RESTART': '1', 19:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:32 INFO - 'PWD': '/builds/slave/test', 19:07:32 INFO - 'SHELL': '/bin/bash', 19:07:32 INFO - 'SHLVL': '1', 19:07:32 INFO - 'TERM': 'linux', 19:07:32 INFO - 'TMOUT': '86400', 19:07:32 INFO - 'USER': 'cltbld', 19:07:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:32 INFO - '_': '/tools/buildbot/bin/python'} 19:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:07:32 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 19:07:32 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 19:07:32 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 19:07:32 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 19:07:32 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 19:07:32 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 19:07:34 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:34 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 19:07:34 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 19:07:34 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 19:07:34 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 19:07:34 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 19:07:34 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 19:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:07:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:07:35 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 19:07:35 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 19:07:35 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 19:07:35 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 19:07:35 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 19:07:35 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 19:07:35 INFO - Downloading docopt-0.6.1.tar.gz 19:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:07:35 INFO - Installing collected packages: blobuploader, requests, docopt 19:07:35 INFO - Running setup.py install for blobuploader 19:07:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:07:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:07:35 INFO - Running setup.py install for requests 19:07:36 INFO - Running setup.py install for docopt 19:07:36 INFO - Successfully installed blobuploader requests docopt 19:07:36 INFO - Cleaning up... 19:07:36 INFO - Return code: 0 19:07:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:36 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')]} 19:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:36 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')]} 19:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:36 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:36 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 19:07:36 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 19:07:36 INFO - Using env: {'DISPLAY': ':0', 19:07:36 INFO - 'HOME': '/home/cltbld', 19:07:36 INFO - 'LANG': 'en_US.UTF-8', 19:07:36 INFO - 'LANGUAGE': 'en_US:en', 19:07:36 INFO - 'LOGNAME': 'cltbld', 19:07:36 INFO - 'MAIL': '/var/mail/cltbld', 19:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:36 INFO - 'MOZ_NO_REMOTE': '1', 19:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:36 INFO - 'NO_EM_RESTART': '1', 19:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:36 INFO - 'PWD': '/builds/slave/test', 19:07:36 INFO - 'SHELL': '/bin/bash', 19:07:36 INFO - 'SHLVL': '1', 19:07:36 INFO - 'TERM': 'linux', 19:07:36 INFO - 'TMOUT': '86400', 19:07:36 INFO - 'USER': 'cltbld', 19:07:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:36 INFO - '_': '/tools/buildbot/bin/python'} 19:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:36 INFO - Running setup.py (path:/tmp/pip-mxSunp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:36 INFO - Running setup.py (path:/tmp/pip-ET4Gf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:36 INFO - Running setup.py (path:/tmp/pip-GbaelZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:36 INFO - Running setup.py (path:/tmp/pip-ftT8zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:36 INFO - Running setup.py (path:/tmp/pip-rV97sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:36 INFO - Running setup.py (path:/tmp/pip-WCQaIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:36 INFO - Running setup.py (path:/tmp/pip-hvJMeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:36 INFO - Running setup.py (path:/tmp/pip-A8mahg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:37 INFO - Running setup.py (path:/tmp/pip-a1EPOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:37 INFO - Running setup.py (path:/tmp/pip-jzll8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:37 INFO - Running setup.py (path:/tmp/pip-4vGthr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:37 INFO - Running setup.py (path:/tmp/pip-W_WITZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:37 INFO - Running setup.py (path:/tmp/pip-O8UiWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:37 INFO - Running setup.py (path:/tmp/pip-VLj3gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:37 INFO - Running setup.py (path:/tmp/pip-jLDgHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:37 INFO - Running setup.py (path:/tmp/pip-wNHmR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:37 INFO - Running setup.py (path:/tmp/pip-ZBxkB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:07:37 INFO - Running setup.py install for manifestparser 19:07:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:07:37 INFO - Running setup.py install for mozcrash 19:07:37 INFO - Running setup.py install for mozdebug 19:07:37 INFO - Running setup.py install for mozdevice 19:07:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Running setup.py install for mozfile 19:07:38 INFO - Running setup.py install for mozhttpd 19:07:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Running setup.py install for mozinfo 19:07:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Running setup.py install for mozInstall 19:07:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Running setup.py install for mozleak 19:07:38 INFO - Running setup.py install for mozlog 19:07:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Running setup.py install for moznetwork 19:07:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:07:38 INFO - Running setup.py install for mozprocess 19:07:38 INFO - Running setup.py install for mozprofile 19:07:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:07:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:07:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:07:39 INFO - Running setup.py install for mozrunner 19:07:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:07:39 INFO - Running setup.py install for mozscreenshot 19:07:39 INFO - Running setup.py install for moztest 19:07:39 INFO - Running setup.py install for mozversion 19:07:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:07:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:39 INFO - Cleaning up... 19:07:39 INFO - Return code: 0 19:07:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:39 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:39 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 19:07:39 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 19:07:39 INFO - Using env: {'DISPLAY': ':0', 19:07:39 INFO - 'HOME': '/home/cltbld', 19:07:39 INFO - 'LANG': 'en_US.UTF-8', 19:07:39 INFO - 'LANGUAGE': 'en_US:en', 19:07:39 INFO - 'LOGNAME': 'cltbld', 19:07:39 INFO - 'MAIL': '/var/mail/cltbld', 19:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:39 INFO - 'MOZ_NO_REMOTE': '1', 19:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:39 INFO - 'NO_EM_RESTART': '1', 19:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:39 INFO - 'PWD': '/builds/slave/test', 19:07:39 INFO - 'SHELL': '/bin/bash', 19:07:39 INFO - 'SHLVL': '1', 19:07:39 INFO - 'TERM': 'linux', 19:07:39 INFO - 'TMOUT': '86400', 19:07:39 INFO - 'USER': 'cltbld', 19:07:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:39 INFO - '_': '/tools/buildbot/bin/python'} 19:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:39 INFO - Running setup.py (path:/tmp/pip-lER3ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:39 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)) 19:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:39 INFO - Running setup.py (path:/tmp/pip-8pgsSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:39 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)) 19:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:39 INFO - Running setup.py (path:/tmp/pip-VVfhkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:39 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)) 19:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:39 INFO - Running setup.py (path:/tmp/pip-pzeaXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:39 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)) 19:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:39 INFO - Running setup.py (path:/tmp/pip-X8eSld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:40 INFO - Running setup.py (path:/tmp/pip-5MrNMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:40 INFO - Running setup.py (path:/tmp/pip-MGBHma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:40 INFO - Running setup.py (path:/tmp/pip-pfZuqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:40 INFO - Running setup.py (path:/tmp/pip-9UxKoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:40 INFO - Running setup.py (path:/tmp/pip-3P1PPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:40 INFO - Running setup.py (path:/tmp/pip-MeJjNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:40 INFO - Running setup.py (path:/tmp/pip-3mgZn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:40 INFO - Running setup.py (path:/tmp/pip-LsOEJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:40 INFO - Running setup.py (path:/tmp/pip-55FjDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:40 INFO - Running setup.py (path:/tmp/pip-DqaEK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:40 INFO - Running setup.py (path:/tmp/pip-wKU27t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:40 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)) 19:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:40 INFO - Running setup.py (path:/tmp/pip-nDtjCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:40 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)) 19:07:40 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)) 19:07:40 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)) 19:07:40 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)) 19:07:40 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)) 19:07:40 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)) 19:07:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:42 INFO - Downloading blessings-1.6.tar.gz 19:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:42 INFO - Installing collected packages: blessings 19:07:42 INFO - Running setup.py install for blessings 19:07:43 INFO - Successfully installed blessings 19:07:43 INFO - Cleaning up... 19:07:43 INFO - Return code: 0 19:07:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:43 INFO - Reading from file tmpfile_stdout 19:07:43 INFO - Current package versions: 19:07:43 INFO - argparse == 1.2.1 19:07:43 INFO - blessings == 1.6 19:07:43 INFO - blobuploader == 1.2.4 19:07:43 INFO - docopt == 0.6.1 19:07:43 INFO - functools32 == 3.2.3-2 19:07:43 INFO - jsonschema == 2.5.1 19:07:43 INFO - manifestparser == 1.1 19:07:43 INFO - mozInstall == 1.12 19:07:43 INFO - mozcrash == 0.17 19:07:43 INFO - mozdebug == 0.1 19:07:43 INFO - mozdevice == 0.48 19:07:43 INFO - mozfile == 1.2 19:07:43 INFO - mozhttpd == 0.7 19:07:43 INFO - mozinfo == 0.9 19:07:43 INFO - mozleak == 0.1 19:07:43 INFO - mozlog == 3.3 19:07:43 INFO - moznetwork == 0.27 19:07:43 INFO - mozprocess == 0.23 19:07:43 INFO - mozprofile == 0.28 19:07:43 INFO - mozrunner == 6.12 19:07:43 INFO - mozscreenshot == 0.1 19:07:43 INFO - mozsystemmonitor == 0.3 19:07:43 INFO - moztest == 0.7 19:07:43 INFO - mozversion == 1.4 19:07:43 INFO - psutil == 3.1.1 19:07:43 INFO - requests == 1.2.3 19:07:43 INFO - wsgiref == 0.1.2 19:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:43 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')]} 19:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:43 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')]} 19:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:43 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:43 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 19:07:43 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 19:07:43 INFO - Using env: {'DISPLAY': ':0', 19:07:43 INFO - 'HOME': '/home/cltbld', 19:07:43 INFO - 'LANG': 'en_US.UTF-8', 19:07:43 INFO - 'LANGUAGE': 'en_US:en', 19:07:43 INFO - 'LOGNAME': 'cltbld', 19:07:43 INFO - 'MAIL': '/var/mail/cltbld', 19:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:43 INFO - 'MOZ_NO_REMOTE': '1', 19:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:43 INFO - 'NO_EM_RESTART': '1', 19:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:43 INFO - 'PWD': '/builds/slave/test', 19:07:43 INFO - 'SHELL': '/bin/bash', 19:07:43 INFO - 'SHLVL': '1', 19:07:43 INFO - 'TERM': 'linux', 19:07:43 INFO - 'TMOUT': '86400', 19:07:43 INFO - 'USER': 'cltbld', 19:07:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:43 INFO - '_': '/tools/buildbot/bin/python'} 19:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 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)) 19:07:43 INFO - Cleaning up... 19:07:43 INFO - Return code: 0 19:07:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:07:43 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')]} 19:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:43 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')]} 19:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:43 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 0x7fd9ee4e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, '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': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', '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 19:07:43 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 19:07:43 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 19:07:43 INFO - Using env: {'DISPLAY': ':0', 19:07:43 INFO - 'HOME': '/home/cltbld', 19:07:43 INFO - 'LANG': 'en_US.UTF-8', 19:07:43 INFO - 'LANGUAGE': 'en_US:en', 19:07:43 INFO - 'LOGNAME': 'cltbld', 19:07:43 INFO - 'MAIL': '/var/mail/cltbld', 19:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:43 INFO - 'MOZ_NO_REMOTE': '1', 19:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:43 INFO - 'NO_EM_RESTART': '1', 19:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:43 INFO - 'PWD': '/builds/slave/test', 19:07:43 INFO - 'SHELL': '/bin/bash', 19:07:43 INFO - 'SHLVL': '1', 19:07:43 INFO - 'TERM': 'linux', 19:07:43 INFO - 'TMOUT': '86400', 19:07:43 INFO - 'USER': 'cltbld', 19:07:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:43 INFO - '_': '/tools/buildbot/bin/python'} 19:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:07:43 INFO - Cleaning up... 19:07:43 INFO - Return code: 0 19:07:43 INFO - Running post-action listener: _resource_record_post_action 19:07:43 INFO - Running post-action listener: _start_resource_monitoring 19:07:43 INFO - Starting resource monitoring. 19:07:43 INFO - [mozharness: 2016-09-02 02:07:43.772678Z] Finished create-virtualenv step (success) 19:07:43 INFO - [mozharness: 2016-09-02 02:07:43.773148Z] Running install step. 19:07:43 INFO - Running pre-action listener: _resource_record_pre_action 19:07:43 INFO - Running main action method: install 19:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:43 INFO - Reading from file tmpfile_stdout 19:07:43 INFO - Detecting whether we're running mozinstall >=1.0... 19:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:07:44 INFO - Reading from file tmpfile_stdout 19:07:44 INFO - Output received: 19:07:44 INFO - Usage: mozinstall [options] installer 19:07:44 INFO - Options: 19:07:44 INFO - -h, --help show this help message and exit 19:07:44 INFO - -d DEST, --destination=DEST 19:07:44 INFO - Directory to install application into. [default: 19:07:44 INFO - "/builds/slave/test"] 19:07:44 INFO - --app=APP Application being installed. [default: firefox] 19:07:44 INFO - mkdir: /builds/slave/test/build/application 19:07:44 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'] 19:07:44 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 19:08:00 INFO - Reading from file tmpfile_stdout 19:08:00 INFO - Output received: 19:08:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:00 INFO - Running post-action listener: _resource_record_post_action 19:08:00 INFO - [mozharness: 2016-09-02 02:08:00.193759Z] Finished install step (success) 19:08:00 INFO - [mozharness: 2016-09-02 02:08:00.194045Z] Running run-tests step. 19:08:00 INFO - Running pre-action listener: _resource_record_pre_action 19:08:00 INFO - Running main action method: run_tests 19:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:00 INFO - Python 2.7.3 19:08:00 INFO - Return code: 0 19:08:00 INFO - grabbing minidump binary from tooltool 19:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:08:00 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 0x1748090>, '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 0x174b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:00 INFO - Return code: 0 19:08:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:08:00 INFO - Using env: {'DISPLAY': ':0', 19:08:00 INFO - 'HOME': '/home/cltbld', 19:08:00 INFO - 'LANG': 'en_US.UTF-8', 19:08:00 INFO - 'LANGUAGE': 'en_US:en', 19:08:00 INFO - 'LOGNAME': 'cltbld', 19:08:00 INFO - 'MAIL': '/var/mail/cltbld', 19:08:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:00 INFO - 'MOZ_NO_REMOTE': '1', 19:08:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:00 INFO - 'NO_EM_RESTART': '1', 19:08:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:00 INFO - 'PWD': '/builds/slave/test', 19:08:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:00 INFO - 'SHELL': '/bin/bash', 19:08:00 INFO - 'SHLVL': '1', 19:08:00 INFO - 'TERM': 'linux', 19:08:00 INFO - 'TMOUT': '86400', 19:08:00 INFO - 'USER': 'cltbld', 19:08:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288', 19:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:00 INFO - '_': '/tools/buildbot/bin/python'} 19:08:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:08:00 INFO - mozversion application_buildid: 20160901174542 19:08:00 INFO - mozversion application_changeset: 2d457db23476fecab9e6e66a737c6723d0d2767c 19:08:00 INFO - mozversion application_display_name: Nightly 19:08:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:00 INFO - mozversion application_name: Firefox 19:08:00 INFO - mozversion application_remotingname: firefox 19:08:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:08:00 INFO - mozversion application_vendor: Mozilla 19:08:00 INFO - mozversion application_version: 51.0a1 19:08:00 INFO - mozversion platform_buildid: 20160901174542 19:08:00 INFO - mozversion platform_changeset: 2d457db23476fecab9e6e66a737c6723d0d2767c 19:08:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:08:00 INFO - mozversion platform_version: 51.0a1 19:08:00 INFO - using testdate: 1472782080 19:08:00 INFO - actual date: 1472782080 19:08:00 INFO - starting webserver on 'localhost:35707' 19:08:00 INFO - SUITE-START | Running 2 tests 19:08:00 INFO - TEST-START | dromaeo_css 19:08:00 INFO - operating with platform_type : linux_ 19:08:00 INFO - Initialising browser for dromaeo_css test... 19:08:00 INFO - TEST-INFO | started process 16790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxgrgE/profile http://localhost:35707/getInfo.html) 19:08:05 INFO - PROCESS | 16790 | __metrics Screen width/height:1600/1200 19:08:05 INFO - PROCESS | 16790 | colorDepth:24 19:08:05 INFO - PROCESS | 16790 | Browser inner width/height: 1024/697 19:08:05 INFO - PROCESS | 16790 | __metrics 19:08:06 ERROR - PROCESS | 16790 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 19:08:07 INFO - TEST-INFO | 16790: exit 0 19:08:07 INFO - Browser initialized. 19:08:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:07 INFO - TEST-INFO | started process 16911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxgrgE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:19 INFO - PROCESS | 16911 | RSS: Main: 192839680 19:08:19 INFO - PROCESS | 16911 | 19:09:09 INFO - PROCESS | 16911 | 1472782149141 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] 19:11:21 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35707/tests/dromaeo/cssquery-ext.html) 19:11:23 INFO - PROCESS | 16911 | RSS: Main: 212422656 19:11:23 INFO - PROCESS | 16911 | 19:14:25 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-ext.html (next: http://localhost:35707/tests/dromaeo/cssquery-jquery.html) 19:14:26 INFO - PROCESS | 16911 | RSS: Main: 208060416 19:14:26 INFO - PROCESS | 16911 | 19:17:28 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35707/tests/dromaeo/cssquery-mootools.html) 19:17:29 INFO - PROCESS | 16911 | RSS: Main: 202940416 19:17:29 INFO - PROCESS | 16911 | 19:20:31 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35707/tests/dromaeo/cssquery-prototype.html) 19:20:31 INFO - PROCESS | 16911 | RSS: Main: 196141056 19:20:31 INFO - PROCESS | 16911 | 19:23:34 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35707/tests/dromaeo/cssquery-yui.html) 19:23:35 INFO - PROCESS | 16911 | RSS: Main: 197873664 19:23:35 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | Cycle 1(1): loaded http://localhost:35707/tests/dromaeo/cssquery-yui.html (next: http://localhost:35707/tests/dromaeo/cssquery-dojo.html) 19:26:38 INFO - PROCESS | 16911 | RSS: Main: 198066176 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | __start_tp_report 19:26:38 INFO - PROCESS | 16911 | _x_x_mozilla_page_load 19:26:38 INFO - PROCESS | 16911 | _x_x_mozilla_page_load_details 19:26:38 INFO - PROCESS | 16911 | |i|pagename|runs| 19:26:38 INFO - PROCESS | 16911 | |0;dojo.html;2676.3041609181614;2695.3665888516184;2699.1632593895893;2719.9320016999573;2734.5898115282716;4730.0303437795255;4847.612191024718;4906.607471402283;4956.677815941961;4984.25236214568;4808.927866082012;4850.587700045491;4851.854444366666;4892;4912.828051018215;4407.382966384709;4475.820967161309;4495.752733599651;4599.977000115012;4637.1189474;4528.592426681615;4563.452385713703;4576.519465456129;4591.494935557086;4595.195840727876;4385.386045953569;4460.888477788081;4467.218236808546;4490.3488994096;4501.212287849646;4449.0879369729455;4452.844150454718;4466.865994020184;4562.338460923181;4590.0590378972565;4455.888602784957;4475.731456112644;4496.235639941217;4499.797509112098;4542.068875880436;4800.831970881038;4866.124097662455;4878.634102442331;4895.755212239409;4914.04176185644;5234.790608375661;5235.240890070956;5239.3712754469325;5263.894722105575;5267.26258323835;5264.447233040552;5267.789288428458;5287.894242115136;5288.497592728685;5345.251664766935;4794.640401969831;4824.49342818999;4833.685810422382;4844.588210002119;4963.826266080742;5342.75957581902;5378;5390.54180394663;5396.406395296514;5406.324209473816;5156;5164.948350516447;5171.3277273954145;5196;5254.054270231395;5049.065922804293;5159.303494028258;5231.973840130775;5236.633435659467;5290.047791397508;5185.688858668492;5195.766190521435;5200.583953283728;5209.557187639018;5223.2948551945765;5152.613553983466;5155.587552995751;5165.096108181053;5177.326947496801;5214.504622060898;4273.18809426208;4313.180495705806;4349.3041113421705;4367.235733746646;4400.22995975703;3791.734578579473;3799.810009499514;3810.161764411825;3839.4816699745734;3840.4047372657283;4462.843800466968;4497.752623605667;4519.344695019204;4521.253993091169;4582.793774280165;5153.2270159476375;5193.792248310101;5208.322918020633;5264.578833693296;5309.814156504503;4489.7979590918485;4525.841595544206;4527.3435351873795;4544.590986811203;4611.354410382549;4693.812247510062;4705.223638099744;4708.81164753406;4709.599684026896;4777.140114779373;4771.021940502189;4863.076015557032;4879.951200488092;4951.306817045544;4988.850334489971;5238.214267859851;5261.473852614861;5266.473352664856;5267.920981185362;5269.998700247094;4765.0469906019625;4908.950910490849;4915.066137433876;4919.3604831371695;4969.428515720594;5139.511746384088;5157.535821776059;5215.217717342429;5220.086484865209;5281.762320695655;5275.788968441219;5276.788928442819;5281.023010743025;5284.550813180923;5288.233206185158;4934.111859865258;5131.076406246912;5138.3577052868395;5159.948400515947;5176.042432150064;4977.576905962889;5045.394552653705;5062.190049592047;5062.240663900445;5065.062963351792;4909.975450122726;4923.778429970588;4991.201407774739;5006.123928312603;5023.045621331935;5061.772220250024;5066.746662666926;5110.693358398508;5180.844574662766;5182.689038657692;4998.975005124951;5004.3994720633755;5010.749462526932;5014.147594908947;5065.240213967934 19:26:38 INFO - PROCESS | 16911 | |1;ext.html;545.8062387852312;548.202365558113;569.2912324156426;585.3414908228245;586.5395664403444;34767.47848782267;36046.639533604655;38448.80775596125;38581.421278680806;38587.22825543487;37638.811805941;38679.61320386795;38748.22503549927;38760;38855.41716874249;7455.739049133282;7670.386369090459;7673.462857599942;7682.270184332508;7698.499597526171;7543.886841697379;7653.540787552764;7661;7661.463697541174;7667.5782831944225;7601.23987601241;7621.161672216052;7649.502782319159;7678.46250762444;7683.346915512188;7531.2092230315575;7558.093028836574;7567.999999999973;7572.091349038095;7617.733379331752;7502.887456688154;7575.242475752436;7602.50583712057;7610.7336243231775;7650.005499285057;36038.81980590107;36276.63723362759;36538.26923461516;36691.81654091739;36730.4490432641;2982.7464665503458;3103.20868178613;3130.8591113399953;3235.983820080908;3457.533233013536;28339.14982550527;28621.28446788826;29169.708302917123;29255.122346329645;30090.39819203604;3465.8960231193105;3482.3905816482015;3501.5272938153535;3523.361636838882;3535.063208249816;179671;180398;181026.9999999987;181376;181829;51484.485155148715;52178.5648219898;52338.73830630899;52353.47646523486;52356.73821630867;28670.569941450896;29248.853755731085;29358.853205733834;29395.11814645564;29417.55873661897;15269.618259543378;15381.307841147176;15477.613059673373;15506.844931550766;15515.534533963999;11552.6534203974;11637.069034477221;11654.18420710559;11666.241694289844;11666.241694289844;17717.911410442866;17753.822461775475;17795.73306400405;17841.7323740144;17926.641467170582;6595;6647.434968027772;6704.4301234395625;6748.29142939994;6996.300369962963;782.4053719173469;854.2141230068228;876.6099085906837;928.6146249306462;983.9127763821018;26755.866220668773;27876.581851272247;27907.162785116478;28286.85856570745;28833.27916802055;935.2190920581255;943.9716808495756;965.6475386484024;966.9613215471302;971.489967766928;13931.791023134661;14798.630034249014;14818.62953426173;14946.775798363033;15089.396424142911;382464;385161;386341;386458;386595;48850;49204.015919681406;49290.507094928595;49340.25989610159;49430.25854612184;1104.094642393246;1140.680609429361;1162.953481860716;1165.9825102623468;1182.3142577305143;25544.23367298984;26225;27698;27810.72189278162;28033.299167520974;43226.1354772909;43472.130557389304;43558.56441435545;43618.56381436145;43667.126657467306;328065;329105;329599;330079;331129;25058.874705627084;25207.621885671364;25484.23547293584;25489;25490.745092548837;41586.792066039474;41771;41813.163736725706;42148.1570368597;42174.78912605417;34471;34996.65003349934;35413.46879796857;35858;35922.28155436929;35094.82452587721;35385.82307088448;35502.644973549934;35667.821660892565;35877.28245435129;26940.86529567418;34555.48166777551;34638;35012.29975400529;37158;29559.704402955696;32862.507062393604;32904.177395565304;32918.177045574055;32984.835075825424;24893.62659560072;25206;25279.87360063188;25526.744732552437;25700.614490782278 19:26:38 INFO - PROCESS | 16911 | |2;jquery.html;359.9982000089999;366.3808164202498;372.5027088836403;376.39400565090216;386.0753495378568;16158;16436.83563164368;16846.157692115376;16846.15769211541;16938.40715574955;16231.675366492664;17027.40404085857;17055.658886822257;17163.399281025166;17168.570785730364;4853.272009198613;5137.229415587654;5161.587073034167;5186.481351864821;5188.066148093341;3719;5045.772940217699;5687.971560142214;5993.610415323012;6045.516358691294;6090.634561926277;6101.14583958244;6106.664133472657;6112.8471788205425;6116.113163591277;5103.8468845934685;5313.707746073984;5369.5167434930845;5437.619366644337;5472.179173124063;5111.2333150027425;5238.319018527605;5246.501582349671;5257.263983042377;5283.524482796528;12152.088593355533;12510.061745369043;12512.249265044127;12529.874701252962;12572.685682857911;1758.7361895715617;1890.3856246719733;1936.2642195965584;1953.4139758072663;2401.279616115176;9189.127032931861;9274.95362523183;9496.525173741355;9552.570134343901;13432.462701491928;1689.6705142497217;1746.956326091845;1808.7829460464698;1839.9264029438807;1854.573448106943;67935.32064679339;72492.27507724961;72613.27386726171;73936.63031684807;74238;10015.899841001643;10040.14658754014;10072.949635251924;10122.240831937634;10491.842622360671;14012.509562165274;14039.50861719835;14047;14069.507567235098;14079.648008799657;7256.637168141572;7442.18136005039;7494.6627401767055;7523.548587084792;7626.42801789868;6851.520393572402;7058.929410705828;7281.1262648482525;7285.490015698956;7300.4159667226495;4257.574242575718;4259.7231179973205;4355.912881742411;4363.890902727458;4456.866294011184;1486.524312220079;1610.5973506623345;1611.6454380036373;1800.4973087408512;1850.5558665920082;776.3129630277245;827.2389401750404;870.1559487297311;881.581248906777;897.4525539420948;15959.36162553508;16117.67764644724;16744.330226790793;17090.48728538146;17540.473785786446;834.7161964931952;835.1731785532401;844.594594594598;865.312076898867;894.9776255593532;9135.543222838964;9412.482313472688;9437.905620943702;9560.856587151198;9700.126988571063;386300.0274979388;391284;396611;398091;398554.072296384;59360.40639593635;76192;79190.6040469794;79568;80809.59595202105;868.0321441592705;871.7297930495826;895.0780695883251;895.5029958373166;901.2339511415245;14552;14630.926845365704;14823.629409264424;15241.771373429629;15468;36639;37289.440658389605;37525.6247437533;38083.809580951915;38596;48111;48969.510304896496;49182.13085906238;51270.48729512657;52399.476005240984;7337.633118344168;7657.4256930731535;7818.413618978486;7830.177831327856;7887.802804929923;9860.457674827954;11015.83476247873;11016.17378696617;11076.335419874833;12031.518739250681;9676.516174191122;10065.949670251603;10147.594096236364;10383.948080259852;10726.51730672106;9937.950310248403;10472.10987066108;10603.840942386025;10688.144948403953;10690.305130166515;10026.849597256192;10191;10204.693859184237;10272.845907311546;10696.732581685521;6506.25178104524;6681.599104053578;6700.262971073081;7104.928950710633;7892.68429262846;7720.459567830198;9747.805043899225;10084.949575252076;10088.596456141671;10399.792004159723 19:26:38 INFO - PROCESS | 16911 | |3;mootools.html;1317.6771690935718;1379.6895698467847;1406.9507567235148;1582.272154808788;1622.9188540572968;6778.932210677892;7277.199508054123;7403.888941665872;8009.839803203932;8028.839423211532;7334.743283985062;7609.467337286392;7612.200718924516;7614.923850761491;7628.732994345199;2166.230987999265;2187.9343619691354;2197.824174066071;2199.604071267171;2200.5048864005553;2111.577684463106;2139.743230812305;2211.3918672365066;2213.6790165426005;2215.9335219943428;2160.243914629875;2160.5030842906062;2162.2540223622823;2167.468970102327;2200.1529411176653;2133.5412886229456;2141.6573348264283;2143.7534683511362;2145.656694928804;2151.225558798831;2051.917923283067;2099.9790002099935;2108.5888251790907;2108.8312934965165;2145.7103291055664;7757.301842834172;7921.841563168762;7932.603369831543;7937.729963205859;7945.801354966115;4400.603945644875;4473.552644735533;4479.417675702138;4479.664025198091;4499.977500112511;2801.439712057597;2896.203544025389;2898.521743912252;2938.8824447022093;2970.4059188162237;885.6501681835639;952.4904176265734;952.5237381309346;975.9658411955547;989.5101924547395;9795.412275263507;9799.706008819747;9827.606895724233;9863.358881672668;9871.90128098717;3849.8075096245075;3960.663343615825;4076.3274059779806;4135.400366946776;4142.937855932163;8472.915270847212;8510.936132983377;8524.616392262364;8535;8554.78613034679;4483.529229430863;4497.910041799146;4499.280115181556;4507.706999045052;4509.684322097487;3593.8921832345072;4094.4267802507675;4119.011437255037;4142.399352093929;4245.532991370947;3663.4687970244167;3695.2609478104487;3709.3694072007825;3713.6843368313994;3796.259729352805;1220.2251570252777;1233.8334324866028;1247.4012474012525;1249.77504049272;1254.404158024931;661.3353579652419;768.8885111658778;769.6075001749036;773.2267732267733;794.8450052239758;5022.648414610942;5128.564072053917;5257.973710131425;5266.262723218752;5442.782288708487;383.70454749842463;394.9269385163754;401.27569736625674;402.7623702015825;422.44870444070784;3455.378031954222;3458.723302135823;3513.2797776455764;3531.770434921722;3652.8538858445363;9416.62333506652;9842.360246583949;9888.159506441889;9899.703008909744;9921.454320012468;9825.803483930282;9831.36096153762;9853.06395892389;9865.950670246602;9870.407775533491;7384;7427.665755041036;7462.10454745434;7485.7754267372065;7546;5074.16276314404;5162.612804039637;5168.405633352062;5263.973680131728;5355.70543620089;8825.073367296598;8913.955430222808;8930.419522731001;8994.460332379816;9029.142231487998;9036.502992335485;9099.31755118382;9117.316201284797;9157.358984870994;9188;5837.94162058374;6454.548181627429;6678.332166783282;6699.799006029827;6778;7242.927570724225;7308.415326773952;7308.744193953186;7315.451341149329;7319.5242309249725;6555.901661475177;6666.899996500153;6703.899441508479;6804.183497980274;6918.930810691829;6452.645104519296;6535.248446428532;6560.44236239925;6640.800775976729;6847.828804279933;6397.104405383343;6520.250171230179;6524.445422139172;6528.151340325728;6552.934470655423;4551.271796512542;4574.588287054181;4630.930536041895;4638.397008388888;4671.813127474863;4683.812647494062;4780.402449693788;4792.161371759998;4811.759412029454;4861.465238823797 19:26:38 INFO - PROCESS | 16911 | |4;prototype.html;295.17645768306426;296.1589086992941;305.12885711294257;309.27783625235077;315.1286692295804;4902.60779137669;4905.890467099146;5083.771230294637;5114.462981386957;5118.513741194585;4938.308636790844;4995.425526064504;5008.323876276701;5015.272785446108;5025.7235852028125;3982.800859957005;3985.8007099645047;3993.3410987187226;3996.3406038003695;4000.3797512629276;3886.844526218948;3960;3991.44119823225;3992.3213053780783;4018.276710192164;3906.1797022625283;3935.3900145477355;3940.4089386592095;3941.645251927326;3960.574193290413;3934.8622798201927;3944.704147188958;3951.1702542465973;3951.229510245503;3955.8219880105466;3494.213801894579;3504.9474257886154;3506.2987402519598;3506.6142724300307;3517.085557755002;4608.1705293047235;4857.368542089541;4892.412910450768;4938.2839488274;4938.975305123451;4391.49497807753;4407.779611019469;4417.337399390085;4421.778911054466;4429.9114017719785;5232.2733497945965;5245.632805703603;5248.501392367757;5298.92051619226;5307.867303317448;3447.9828450607133;3641.890743277706;3700.685441737429;3717.5910649828497;3725.5470366557065;5345.492178243061;5408.215808707755;5414.972925135349;5437.586227580818;5440.183972404131;3730.2912446635596;3763.849446022183;3764.3412402829395;3776.5090538229856;3783.4135708965155;3821.8280177392085;3841.961580384216;3852.6339997700175;3854.49891514107;3861.571218649118;4185.560516145761;4308.3968244445805;4327.0480494291205;4341.739495630272;4343.849794351753;5206.646271969315;5220.817271395483;5235.450277720861;5238.982991548205;5246.816361427332;1247.382545639914;1286.7876800328029;1306.8301120854228;1308.1562392256942;1312.8096426018174;858.4205661178804;888.2272422992038;907.7458311672742;915.3455279475207;918.5395221597691;4534.523874993144;4541.704789188759;4563.718140929535;4594.356790049395;4611.239145541015;5288.7091209983055;5294.179402192666;5295.7087360195555;5330.840074797762;5343.332083489564;4453.35426363182;4588.371128249423;4590.793414296365;4603.49361570227;4623.838165664186;2448.8775561222224;2499.9250022499355;2525.482276133388;2535.4422027153996;2540.4030052937546;4462.9107417851465;4488.496353721474;4488.675840627023;4492.595666390041;4496.965697889504;4762.904322098335;4771.594414474739;4778.641601879873;4781.904361912742;4843.878903027382;4651.906961860744;5013.172826483662;5041.369828771403;5050.267711181858;5065.290859279778;5412.107002344726;5434;5456.290682211287;5475.986942415666;5498.670079795225;5189.273501709839;5305.495977882095;5346.25152478661;5368.9463105370005;5369.48989845964;5041.521055499722;5061.39263288393;5072;5080.872978175576;5083.542481176712;3768.717346199101;3808.2002779416634;3824.1778017726324;3838.3858582626644;3858.1126340941178;5332.746804501016;5436.510714035756;5494.725263736717;5499.2677306648275;5521.641093328921;5216.843494695166;5221;5233.502817232356;5240.659357141773;5278.340207474066;5245.763940622757;5255.6058295628745;5271.288376069181;5273.209018647233;5291.867703307448;5056.367954005749;5163.122269214167;5175.275461435477;5179.249008893765;5212.869678258074;5263.578913686973;5265.868353291198;5269.552088072557;5296.708681022426;5303.443138470405;5165.147750621106;5178.663386879841;5191.169412893919;5206.2667099772925;5207.3751149862255 19:26:38 INFO - PROCESS | 16911 | |5;yui.html;631.3087169549343;658.5159907468012;672.7880717573961;720.5892641194521;727.1710250314642;13079.869201307984;14175.929120354383;14178.858211417883;14256.786148207771;14340.067895586793;12871;13174.209547427161;13239.80140297894;13325.866741332584;13345.666358341046;596.8627215740382;729.4674887332251;746.138210367027;746.6453434618567;748.3003391828657;715.9463040271975;744.240874308208;752.3229093815582;754.3211110000988;754.592520039181;784.0238902566313;785.5954183595453;787.283571949526;788.03072221168;788.4953629677011;775.4223103787714;780.3523075847033;781.3592853859838;781.5740421470284;781.5935713428985;567.6906086182998;570.0850135532452;573.020135568179;573.237593999979;574.873527823878;12376;12427.44076516559;12468.376581170905;12484.375781210994;12485.126041177122;12854.935725321313;13426.664333391645;13677.31613419325;13777.380017899219;13930.860691393058;10536.315139515908;10581.788364232749;10685.198610104195;10744.516496757664;10794.2444028918;3273.165342837585;3308.123347312964;3318.867245310209;3421.674940880612;3457.861685532576;65649;66545;66771.99999999952;68398.31601683969;68495.65752171207;9584.472853992958;9754.122129008281;9758.560864761102;9867.407955522547;9936.503174841373;16761.245743941552;17472.475825725247;20185.59628807445;20321.89839050795;20362.981850907396;6947.548409353376;7085;7113.324234197743;7148.213696493382;7227;3695.1131728384994;3725.3294407006997;3780;3810.256999884996;3817.0648191193336;2879.8848046077924;3034.666186719459;3038.1645047612083;3052.1759125036115;3092.6443459002053;512.8820371314544;523.2230138244704;524.5305451620778;524.5567495466324;529.4573062610855;459.38213103375904;519.4156573854414;541.8999431154762;555.38352428804;578.1674388880083;7462.962685186648;7566.205548417337;7846.979892613924;7860.331871790848;8113.716019939274;510.9233614957712;546.5873265684382;558.4806130298861;572.8081092833947;575.1938911816899;3626.8911932642063;3709.146896213886;3740.831662575191;3795.411711184771;3936.5866584008268;96752;99568;102153;102571.48714256381;103010;73656;85522.5723871389;88038.55980720055;89335;89430.55284723535;80121;80651;80922.59538702386;81742;83421.32629389635;7163.31948464895;7440.55356678601;7531.284527969834;7562.546247225184;7564.698075646989;38815.6118438812;46568;47447;47888;48440.27339589839;38015.239695206496;40253.79873100616;42564.5743542573;59760;59862.82332003657;9186;9534.141927226583;9732.75668108303;9744.12302892743;9975.301728878909;11485.368304743319;12130.636080917586;12422.813657794959;12599.118061735591;12647.747045058863;10483.947580262049;10789.136869050613;10903.12774977984;11195.160362972647;11281.32312061279;11031.944840275748;11606.651800446;11637.88362116368;11744.471498782405;11903.642890713292;11158.72103197394;11228;11625.76748465009;11634.301941883514;11719.531218751154;8907.287417006495;9151.679691210775;9301.256359256693;9579.9042009579;9784.510774461107;9341.439513629204;9797.412155270707;9857.507124643882;9876.555554999899;9898.10917017443 19:26:38 INFO - PROCESS | 16911 | __end_tp_report 19:26:38 INFO - PROCESS | 16911 | __start_cc_report 19:26:38 INFO - PROCESS | 16911 | _x_x_mozilla_cycle_collect,348 19:26:38 INFO - PROCESS | 16911 | __end_cc_report 19:26:38 INFO - PROCESS | 16911 | __startTimestamp1472783198430__endTimestamp 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | ------- Summary: start ------- 19:26:38 INFO - PROCESS | 16911 | Number of tests: 6 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | [#0] dojo.html Cycles:165 Average:4829.09 Median:4951.31 stddev:516.22 (10.4%) stddev-sans-first:489.40 19:26:38 INFO - PROCESS | 16911 | Values: 2676.3 2695.4 2699.2 2719.9 2734.6 4730.0 4847.6 4906.6 4956.7 4984.3 4808.9 4850.6 4851.9 4892.0 4912.8 4407.4 4475.8 4495.8 4600.0 4637.1 4528.6 4563.5 4576.5 4591.5 4595.2 4385.4 4460.9 4467.2 4490.3 4501.2 4449.1 4452.8 4466.9 4562.3 4590.1 4455.9 4475.7 4496.2 4499.8 4542.1 4800.8 4866.1 4878.6 4895.8 4914.0 5234.8 5235.2 5239.4 5263.9 5267.3 5264.4 5267.8 5287.9 5288.5 5345.3 4794.6 4824.5 4833.7 4844.6 4963.8 5342.8 5378.0 5390.5 5396.4 5406.3 5156.0 5164.9 5171.3 5196.0 5254.1 5049.1 5159.3 5232.0 5236.6 5290.0 5185.7 5195.8 5200.6 5209.6 5223.3 5152.6 5155.6 5165.1 5177.3 5214.5 4273.2 4313.2 4349.3 4367.2 4400.2 3791.7 3799.8 3810.2 3839.5 3840.4 4462.8 4497.8 4519.3 4521.3 4582.8 5153.2 5193.8 5208.3 5264.6 5309.8 4489.8 4525.8 4527.3 4544.6 4611.4 4693.8 4705.2 4708.8 4709.6 4777.1 4771.0 4863.1 4880.0 4951.3 4988.9 5238.2 5261.5 5266.5 5267.9 5270.0 4765.0 4909.0 4915.1 4919.4 4969.4 5139.5 5157.5 5215.2 5220.1 5281.8 5275.8 5276.8 5281.0 5284.6 5288.2 4934.1 5131.1 5138.4 5159.9 5176.0 4977.6 5045.4 5062.2 5062.2 5065.1 4910.0 4923.8 4991.2 5006.1 5023.0 5061.8 5066.7 5110.7 5180.8 5182.7 4999.0 5004.4 5010.7 5014.1 5065.2 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | [#1] ext.html Cycles:180 Average:44729.99 Median:35585.23 stddev:82101.69 (230.7%) stddev-sans-first:82264.98 19:26:38 INFO - PROCESS | 16911 | Values: 545.8 548.2 569.3 585.3 586.5 34767.5 36046.6 38448.8 38581.4 38587.2 37638.8 38679.6 38748.2 38760.0 38855.4 7455.7 7670.4 7673.5 7682.3 7698.5 7543.9 7653.5 7661.0 7661.5 7667.6 7601.2 7621.2 7649.5 7678.5 7683.3 7531.2 7558.1 7568.0 7572.1 7617.7 7502.9 7575.2 7602.5 7610.7 7650.0 36038.8 36276.6 36538.3 36691.8 36730.4 2982.7 3103.2 3130.9 3236.0 3457.5 28339.1 28621.3 29169.7 29255.1 30090.4 3465.9 3482.4 3501.5 3523.4 3535.1 179671.0 180398.0 181027.0 181376.0 181829.0 51484.5 52178.6 52338.7 52353.5 52356.7 28670.6 29248.9 29358.9 29395.1 29417.6 15269.6 15381.3 15477.6 15506.8 15515.5 11552.7 11637.1 11654.2 11666.2 11666.2 17717.9 17753.8 17795.7 17841.7 17926.6 6595.0 6647.4 6704.4 6748.3 6996.3 782.4 854.2 876.6 928.6 983.9 26755.9 27876.6 27907.2 28286.9 28833.3 935.2 944.0 965.6 967.0 971.5 13931.8 14798.6 14818.6 14946.8 15089.4 382464.0 385161.0 386341.0 386458.0 386595.0 48850.0 49204.0 49290.5 49340.3 49430.3 1104.1 1140.7 1163.0 1166.0 1182.3 25544.2 26225.0 27698.0 27810.7 28033.3 43226.1 43472.1 43558.6 43618.6 43667.1 328065.0 329105.0 329599.0 330079.0 331129.0 25058.9 25207.6 25484.2 25489.0 25490.7 41586.8 41771.0 41813.2 42148.2 42174.8 34471.0 34996.7 35413.5 35858.0 35922.3 35094.8 35385.8 35502.6 35667.8 35877.3 26940.9 34555.5 34638.0 35012.3 37158.0 29559.7 32862.5 32904.2 32918.2 32984.8 24893.6 25206.0 25279.9 25526.7 25700.6 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | [#2] jquery.html Cycles:180 Average:24201.35 Median:4410.38 stddev:65113.94 (1476.4%) stddev-sans-first:65272.00 19:26:38 INFO - PROCESS | 16911 | Values: 360.0 366.4 372.5 376.4 386.1 16158.0 16436.8 16846.2 16846.2 16938.4 16231.7 17027.4 17055.7 17163.4 17168.6 4853.3 5137.2 5161.6 5186.5 5188.1 3719.0 5045.8 5688.0 5993.6 6045.5 6090.6 6101.1 6106.7 6112.8 6116.1 5103.8 5313.7 5369.5 5437.6 5472.2 5111.2 5238.3 5246.5 5257.3 5283.5 12152.1 12510.1 12512.2 12529.9 12572.7 1758.7 1890.4 1936.3 1953.4 2401.3 9189.1 9275.0 9496.5 9552.6 13432.5 1689.7 1747.0 1808.8 1839.9 1854.6 67935.3 72492.3 72613.3 73936.6 74238.0 10015.9 10040.1 10072.9 10122.2 10491.8 14012.5 14039.5 14047.0 14069.5 14079.6 7256.6 7442.2 7494.7 7523.5 7626.4 6851.5 7058.9 7281.1 7285.5 7300.4 4257.6 4259.7 4355.9 4363.9 4456.9 1486.5 1610.6 1611.6 1800.5 1850.6 776.3 827.2 870.2 881.6 897.5 15959.4 16117.7 16744.3 17090.5 17540.5 834.7 835.2 844.6 865.3 895.0 9135.5 9412.5 9437.9 9560.9 9700.1 386300.0 391284.0 396611.0 398091.0 398554.1 59360.4 76192.0 79190.6 79568.0 80809.6 868.0 871.7 895.1 895.5 901.2 14552.0 14630.9 14823.6 15241.8 15468.0 36639.0 37289.4 37525.6 38083.8 38596.0 48111.0 48969.5 49182.1 51270.5 52399.5 7337.6 7657.4 7818.4 7830.2 7887.8 9860.5 11015.8 11016.2 11076.3 12031.5 9676.5 10065.9 10147.6 10383.9 10726.5 9938.0 10472.1 10603.8 10688.1 10690.3 10026.8 10191.0 10204.7 10272.8 10696.7 6506.3 6681.6 6700.3 7104.9 7892.7 7720.5 9747.8 10084.9 10088.6 10399.8 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | [#3] mootools.html Cycles:180 Average:5075.07 Median:5260.97 stddev:2852.30 (54.2%) stddev-sans-first:2846.32 19:26:38 INFO - PROCESS | 16911 | Values: 1317.7 1379.7 1407.0 1582.3 1622.9 6778.9 7277.2 7403.9 8009.8 8028.8 7334.7 7609.5 7612.2 7614.9 7628.7 2166.2 2187.9 2197.8 2199.6 2200.5 2111.6 2139.7 2211.4 2213.7 2215.9 2160.2 2160.5 2162.3 2167.5 2200.2 2133.5 2141.7 2143.8 2145.7 2151.2 2051.9 2100.0 2108.6 2108.8 2145.7 7757.3 7921.8 7932.6 7937.7 7945.8 4400.6 4473.6 4479.4 4479.7 4500.0 2801.4 2896.2 2898.5 2938.9 2970.4 885.7 952.5 952.5 976.0 989.5 9795.4 9799.7 9827.6 9863.4 9871.9 3849.8 3960.7 4076.3 4135.4 4142.9 8472.9 8510.9 8524.6 8535.0 8554.8 4483.5 4497.9 4499.3 4507.7 4509.7 3593.9 4094.4 4119.0 4142.4 4245.5 3663.5 3695.3 3709.4 3713.7 3796.3 1220.2 1233.8 1247.4 1249.8 1254.4 661.3 768.9 769.6 773.2 794.8 5022.6 5128.6 5258.0 5266.3 5442.8 383.7 394.9 401.3 402.8 422.4 3455.4 3458.7 3513.3 3531.8 3652.9 9416.6 9842.4 9888.2 9899.7 9921.5 9825.8 9831.4 9853.1 9866.0 9870.4 7384.0 7427.7 7462.1 7485.8 7546.0 5074.2 5162.6 5168.4 5264.0 5355.7 8825.1 8914.0 8930.4 8994.5 9029.1 9036.5 9099.3 9117.3 9157.4 9188.0 5837.9 6454.5 6678.3 6699.8 6778.0 7242.9 7308.4 7308.7 7315.5 7319.5 6555.9 6666.9 6703.9 6804.2 6918.9 6452.6 6535.2 6560.4 6640.8 6847.8 6397.1 6520.3 6524.4 6528.2 6552.9 4551.3 4574.6 4630.9 4638.4 4671.8 4683.8 4780.4 4792.2 4811.8 4861.5 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | [#4] prototype.html Cycles:180 Average:4306.67 Median:4812.89 stddev:1261.36 (26.2%) stddev-sans-first:1228.44 19:26:38 INFO - PROCESS | 16911 | Values: 295.2 296.2 305.1 309.3 315.1 4902.6 4905.9 5083.8 5114.5 5118.5 4938.3 4995.4 5008.3 5015.3 5025.7 3982.8 3985.8 3993.3 3996.3 4000.4 3886.8 3960.0 3991.4 3992.3 4018.3 3906.2 3935.4 3940.4 3941.6 3960.6 3934.9 3944.7 3951.2 3951.2 3955.8 3494.2 3504.9 3506.3 3506.6 3517.1 4608.2 4857.4 4892.4 4938.3 4939.0 4391.5 4407.8 4417.3 4421.8 4429.9 5232.3 5245.6 5248.5 5298.9 5307.9 3448.0 3641.9 3700.7 3717.6 3725.5 5345.5 5408.2 5415.0 5437.6 5440.2 3730.3 3763.8 3764.3 3776.5 3783.4 3821.8 3842.0 3852.6 3854.5 3861.6 4185.6 4308.4 4327.0 4341.7 4343.8 5206.6 5220.8 5235.5 5239.0 5246.8 1247.4 1286.8 1306.8 1308.2 1312.8 858.4 888.2 907.7 915.3 918.5 4534.5 4541.7 4563.7 4594.4 4611.2 5288.7 5294.2 5295.7 5330.8 5343.3 4453.4 4588.4 4590.8 4603.5 4623.8 2448.9 2499.9 2525.5 2535.4 2540.4 4462.9 4488.5 4488.7 4492.6 4497.0 4762.9 4771.6 4778.6 4781.9 4843.9 4651.9 5013.2 5041.4 5050.3 5065.3 5412.1 5434.0 5456.3 5476.0 5498.7 5189.3 5305.5 5346.3 5368.9 5369.5 5041.5 5061.4 5072.0 5080.9 5083.5 3768.7 3808.2 3824.2 3838.4 3858.1 5332.7 5436.5 5494.7 5499.3 5521.6 5216.8 5221.0 5233.5 5240.7 5278.3 5245.8 5255.6 5271.3 5273.2 5291.9 5056.4 5163.1 5175.3 5179.2 5212.9 5263.6 5265.9 5269.6 5296.7 5303.4 5165.1 5178.7 5191.2 5206.3 5207.4 19:26:38 INFO - PROCESS | 16911 | 19:26:38 INFO - PROCESS | 16911 | [#5] yui.html Cycles:180 Average:17728.24 Median:550.99 stddev:25954.59 (4710.6%) stddev-sans-first:25995.65 19:26:38 INFO - PROCESS | 16911 | Values: 631.3 658.5 672.8 720.6 727.2 13079.9 14175.9 14178.9 14256.8 14340.1 12871.0 13174.2 13239.8 13325.9 13345.7 596.9 729.5 746.1 746.6 748.3 715.9 744.2 752.3 754.3 754.6 784.0 785.6 787.3 788.0 788.5 775.4 780.4 781.4 781.6 781.6 567.7 570.1 573.0 573.2 574.9 12376.0 12427.4 12468.4 12484.4 12485.1 12854.9 13426.7 13677.3 13777.4 13930.9 10536.3 10581.8 10685.2 10744.5 10794.2 3273.2 3308.1 3318.9 3421.7 3457.9 65649.0 66545.0 66772.0 68398.3 68495.7 9584.5 9754.1 9758.6 9867.4 9936.5 16761.2 17472.5 20185.6 20321.9 20363.0 6947.5 7085.0 7113.3 7148.2 7227.0 3695.1 3725.3 3780.0 3810.3 3817.1 2879.9 3034.7 3038.2 3052.2 3092.6 512.9 523.2 524.5 524.6 529.5 459.4 519.4 541.9 555.4 578.2 7463.0 7566.2 7847.0 7860.3 8113.7 510.9 546.6 558.5 572.8 575.2 3626.9 3709.1 3740.8 3795.4 3936.6 96752.0 99568.0 102153.0 102571.5 103010.0 73656.0 85522.6 88038.6 89335.0 89430.6 80121.0 80651.0 80922.6 81742.0 83421.3 7163.3 7440.6 7531.3 7562.5 7564.7 38815.6 46568.0 47447.0 47888.0 48440.3 38015.2 40253.8 42564.6 59760.0 59862.8 9186.0 9534.1 9732.8 9744.1 9975.3 11485.4 12130.6 12422.8 12599.1 12647.7 10483.9 10789.1 10903.1 11195.2 11281.3 11031.9 11606.7 11637.9 11744.5 11903.6 11158.7 11228.0 11625.8 11634.3 11719.5 8907.3 9151.7 9301.3 9579.9 9784.5 9341.4 9797.4 9857.5 9876.6 9898.1 19:26:38 INFO - PROCESS | 16911 | -------- Summary: end -------- 19:26:38 INFO - PROCESS | 16911 | 19:26:39 INFO - TEST-INFO | 16911: exit 0 19:26:39 INFO - TEST-OK | dromaeo_css | took 1118998ms 19:26:39 INFO - TEST-START | kraken 19:26:39 INFO - operating with platform_type : linux_ 19:26:39 INFO - Initialising browser for kraken test... 19:26:39 INFO - TEST-INFO | started process 17270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiLjlG0/profile http://localhost:35707/getInfo.html) 19:26:44 INFO - PROCESS | 17270 | __metrics Screen width/height:1600/1200 19:26:44 INFO - PROCESS | 17270 | colorDepth:24 19:26:44 INFO - PROCESS | 17270 | Browser inner width/height: 1024/697 19:26:44 INFO - PROCESS | 17270 | __metrics 19:26:45 ERROR - PROCESS | 17270 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 19:26:46 INFO - TEST-INFO | 17270: exit 0 19:26:46 INFO - Browser initialized. 19:26:46 INFO - Running cycle 1/1 for kraken test... 19:26:46 INFO - TEST-INFO | started process 17391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiLjlG0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:58 INFO - PROCESS | 17391 | RSS: Main: 193286144 19:26:58 INFO - PROCESS | 17391 | 19:27:01 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:02 INFO - PROCESS | 17391 | RSS: Main: 206188544 19:27:02 INFO - PROCESS | 17391 | 19:27:05 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-dft) 19:27:05 INFO - PROCESS | 17391 | RSS: Main: 205500416 19:27:05 INFO - PROCESS | 17391 | 19:27:08 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-fft) 19:27:09 INFO - PROCESS | 17391 | RSS: Main: 195289088 19:27:09 INFO - PROCESS | 17391 | 19:27:11 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35707/tests/kraken/driver.html?testName=audio-oscillator) 19:27:12 INFO - PROCESS | 17391 | RSS: Main: 196022272 19:27:12 INFO - PROCESS | 17391 | 19:27:14 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35707/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:14 INFO - PROCESS | 17391 | RSS: Main: 196243456 19:27:14 INFO - PROCESS | 17391 | 19:27:18 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35707/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:18 INFO - PROCESS | 17391 | RSS: Main: 198623232 19:27:18 INFO - PROCESS | 17391 | 19:27:22 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35707/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:23 INFO - PROCESS | 17391 | RSS: Main: 194662400 19:27:23 INFO - PROCESS | 17391 | 19:27:26 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35707/tests/kraken/driver.html?testName=json-parse-financial) 19:27:26 INFO - PROCESS | 17391 | RSS: Main: 196747264 19:27:26 INFO - PROCESS | 17391 | 19:27:28 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35707/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:29 INFO - PROCESS | 17391 | RSS: Main: 196722688 19:27:29 INFO - PROCESS | 17391 | 19:27:30 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:31 INFO - PROCESS | 17391 | RSS: Main: 196763648 19:27:31 INFO - PROCESS | 17391 | 19:27:33 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:27:34 INFO - PROCESS | 17391 | RSS: Main: 197500928 19:27:34 INFO - PROCESS | 17391 | 19:27:37 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:38 INFO - PROCESS | 17391 | RSS: Main: 197558272 19:27:38 INFO - PROCESS | 17391 | 19:27:41 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:41 INFO - PROCESS | 17391 | RSS: Main: 197496832 19:27:41 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | Cycle 1(1): loaded http://localhost:35707/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35707/tests/kraken/driver.html?testName=ai-astar) 19:27:43 INFO - PROCESS | 17391 | RSS: Main: 200167424 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | __start_tp_report 19:27:43 INFO - PROCESS | 17391 | _x_x_mozilla_page_load 19:27:43 INFO - PROCESS | 17391 | _x_x_mozilla_page_load_details 19:27:43 INFO - PROCESS | 17391 | |i|pagename|runs| 19:27:43 INFO - PROCESS | 17391 | |0;ai-astar;110;116;114;116;115;115;114;117;115;132 19:27:43 INFO - PROCESS | 17391 | |1;audio-beat-detection;154;129;148;189;126;159;161;126;188;134 19:27:43 INFO - PROCESS | 17391 | |2;audio-dft;182;167;165;163;163;164;162;164;164;165 19:27:43 INFO - PROCESS | 17391 | |3;audio-fft;76;78;78;172;78;77;75;76;159;79 19:27:43 INFO - PROCESS | 17391 | |4;audio-oscillator;83;84;147;89;85;85;150;84;86;130 19:27:43 INFO - PROCESS | 17391 | |5;imaging-gaussian-blur;119;118;119;118;119;119;119;118;119;118 19:27:43 INFO - PROCESS | 17391 | |6;imaging-darkroom;148;148;149;148;150;148;148;148;148;150 19:27:43 INFO - PROCESS | 17391 | |7;imaging-desaturate;96;95;95;96;96;98;96;97;97;97 19:27:43 INFO - PROCESS | 17391 | |8;json-parse-financial;68;70;71;68;67;68;70;67;69;68 19:27:43 INFO - PROCESS | 17391 | |9;json-stringify-tinderbox;66;66;66;66;67;65;66;65;67;66 19:27:43 INFO - PROCESS | 17391 | |10;stanford-crypto-aes;84;91;85;90;84;83;83;82;86;82 19:27:43 INFO - PROCESS | 17391 | |11;stanford-crypto-ccm;136;150;146;147;144;154;134;131;176;136 19:27:43 INFO - PROCESS | 17391 | |12;stanford-crypto-pbkdf2;178;176;176;178;178;172;174;173;177;181 19:27:43 INFO - PROCESS | 17391 | |13;stanford-crypto-sha256-iterative;70;70;73;71;75;70;69;70;68;70 19:27:43 INFO - PROCESS | 17391 | __end_tp_report 19:27:43 INFO - PROCESS | 17391 | __start_cc_report 19:27:43 INFO - PROCESS | 17391 | _x_x_mozilla_cycle_collect,887 19:27:43 INFO - PROCESS | 17391 | __end_cc_report 19:27:43 INFO - PROCESS | 17391 | __startTimestamp1472783263755__endTimestamp 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | ------- Summary: start ------- 19:27:43 INFO - PROCESS | 17391 | Number of tests: 14 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#0] ai-astar Cycles:10 Average:116.40 Median:115.50 stddev:5.80 (5.0%) stddev-sans-first:5.67 19:27:43 INFO - PROCESS | 17391 | Values: 110.0 116.0 114.0 116.0 115.0 115.0 114.0 117.0 115.0 132.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:156.50 stddev:23.61 (15.1%) stddev-sans-first:25.02 19:27:43 INFO - PROCESS | 17391 | Values: 154.0 129.0 148.0 189.0 126.0 159.0 161.0 126.0 188.0 134.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#2] audio-dft Cycles:10 Average:165.90 Median:164.50 stddev:5.82 (3.5%) stddev-sans-first:1.45 19:27:43 INFO - PROCESS | 17391 | Values: 182.0 167.0 165.0 163.0 163.0 164.0 162.0 164.0 164.0 165.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.50 stddev:37.41 (48.3%) stddev-sans-first:39.05 19:27:43 INFO - PROCESS | 17391 | Values: 76.0 78.0 78.0 172.0 78.0 77.0 75.0 76.0 159.0 79.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.50 stddev:28.13 (33.3%) stddev-sans-first:28.96 19:27:43 INFO - PROCESS | 17391 | Values: 83.0 84.0 147.0 89.0 85.0 85.0 150.0 84.0 86.0 130.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:27:43 INFO - PROCESS | 17391 | Values: 119.0 118.0 119.0 118.0 119.0 119.0 119.0 118.0 119.0 118.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 19:27:43 INFO - PROCESS | 17391 | Values: 148.0 148.0 149.0 148.0 150.0 148.0 148.0 148.0 148.0 150.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:1.00 19:27:43 INFO - PROCESS | 17391 | Values: 96.0 95.0 95.0 96.0 96.0 98.0 96.0 97.0 97.0 97.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 19:27:43 INFO - PROCESS | 17391 | Values: 68.0 70.0 71.0 68.0 67.0 68.0 70.0 67.0 69.0 68.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 19:27:43 INFO - PROCESS | 17391 | Values: 66.0 66.0 66.0 66.0 67.0 65.0 66.0 65.0 67.0 66.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:3.16 (3.7%) stddev-sans-first:3.33 19:27:43 INFO - PROCESS | 17391 | Values: 84.0 91.0 85.0 90.0 84.0 83.0 83.0 82.0 86.0 82.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:146.50 stddev:13.13 (9.0%) stddev-sans-first:13.47 19:27:43 INFO - PROCESS | 17391 | Values: 136.0 150.0 146.0 147.0 144.0 154.0 134.0 131.0 176.0 136.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:177.50 stddev:2.71 (1.5%) stddev-sans-first:2.80 19:27:43 INFO - PROCESS | 17391 | Values: 178.0 176.0 176.0 178.0 178.0 172.0 174.0 173.0 177.0 181.0 19:27:43 INFO - PROCESS | 17391 | 19:27:43 INFO - PROCESS | 17391 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:2.01 (2.9%) stddev-sans-first:2.12 19:27:43 INFO - PROCESS | 17391 | Values: 70.0 70.0 73.0 71.0 75.0 70.0 69.0 70.0 68.0 70.0 19:27:43 INFO - PROCESS | 17391 | -------- Summary: end -------- 19:27:43 INFO - PROCESS | 17391 | 19:27:44 INFO - TEST-INFO | 17391: exit 0 19:27:45 INFO - TEST-OK | kraken | took 65564ms 19:27:45 INFO - SUITE-END | took 1184s 19:27:45 INFO - Completed test suite (00:19:44) 19:27:45 INFO - javascript benchmark 19:27:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6355.382880614549, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.3041609181614, 2695.3665888516184, 2699.1632593895893, 2719.9320016999573, 2734.5898115282716, 4730.0303437795255, 4847.612191024718, 4906.607471402283, 4956.677815941961, 4984.25236214568, 4808.927866082012, 4850.587700045491, 4851.854444366666, 4892.0, 4912.828051018215, 4407.382966384709, 4475.820967161309, 4495.752733599651, 4599.977000115012, 4637.1189474, 4528.592426681615, 4563.452385713703, 4576.519465456129, 4591.494935557086, 4595.195840727876, 4385.386045953569, 4460.888477788081, 4467.218236808546, 4490.3488994096, 4501.212287849646, 4449.0879369729455, 4452.844150454718, 4466.865994020184, 4562.338460923181, 4590.0590378972565, 4455.888602784957, 4475.731456112644, 4496.235639941217, 4499.797509112098, 4542.068875880436, 4800.831970881038, 4866.124097662455, 4878.634102442331, 4895.755212239409, 4914.04176185644, 5234.790608375661, 5235.240890070956, 5239.3712754469325, 5263.894722105575, 5267.26258323835, 5264.447233040552, 5267.789288428458, 5287.894242115136, 5288.497592728685, 5345.251664766935, 4794.640401969831, 4824.49342818999, 4833.685810422382, 4844.588210002119, 4963.826266080742, 5342.75957581902, 5378.0, 5390.54180394663, 5396.406395296514, 5406.324209473816, 5156.0, 5164.948350516447, 5171.3277273954145, 5196.0, 5254.054270231395, 5049.065922804293, 5159.303494028258, 5231.973840130775, 5236.633435659467, 5290.047791397508, 5185.688858668492, 5195.766190521435, 5200.583953283728, 5209.557187639018, 5223.2948551945765, 5152.613553983466, 5155.587552995751, 5165.096108181053, 5177.326947496801, 5214.504622060898, 4273.18809426208, 4313.180495705806, 4349.3041113421705, 4367.235733746646, 4400.22995975703, 3791.734578579473, 3799.810009499514, 3810.161764411825, 3839.4816699745734, 3840.4047372657283, 4462.843800466968, 4497.752623605667, 4519.344695019204, 4521.253993091169, 4582.793774280165, 5153.2270159476375, 5193.792248310101, 5208.322918020633, 5264.578833693296, 5309.814156504503, 4489.7979590918485, 4525.841595544206, 4527.3435351873795, 4544.590986811203, 4611.354410382549, 4693.812247510062, 4705.223638099744, 4708.81164753406, 4709.599684026896, 4777.140114779373, 4771.021940502189, 4863.076015557032, 4879.951200488092, 4951.306817045544, 4988.850334489971, 5238.214267859851, 5261.473852614861, 5266.473352664856, 5267.920981185362, 5269.998700247094, 4765.0469906019625, 4908.950910490849, 4915.066137433876, 4919.3604831371695, 4969.428515720594, 5139.511746384088, 5157.535821776059, 5215.217717342429, 5220.086484865209, 5281.762320695655, 5275.788968441219, 5276.788928442819, 5281.023010743025, 5284.550813180923, 5288.233206185158, 4934.111859865258, 5131.076406246912, 5138.3577052868395, 5159.948400515947, 5176.042432150064, 4977.576905962889, 5045.394552653705, 5062.190049592047, 5062.240663900445, 5065.062963351792, 4909.975450122726, 4923.778429970588, 4991.201407774739, 5006.123928312603, 5023.045621331935, 5061.772220250024, 5066.746662666926, 5110.693358398508, 5180.844574662766, 5182.689038657692, 4998.975005124951, 5004.3994720633755, 5010.749462526932, 5014.147594908947, 5065.240213967934], "value": 4795.408335368031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.8062387852312, 548.202365558113, 569.2912324156426, 585.3414908228245, 586.5395664403444, 34767.47848782267, 36046.639533604655, 38448.80775596125, 38581.421278680806, 38587.22825543487, 37638.811805941, 38679.61320386795, 38748.22503549927, 38760.0, 38855.41716874249, 7455.739049133282, 7670.386369090459, 7673.462857599942, 7682.270184332508, 7698.499597526171, 7543.886841697379, 7653.540787552764, 7661.0, 7661.463697541174, 7667.5782831944225, 7601.23987601241, 7621.161672216052, 7649.502782319159, 7678.46250762444, 7683.346915512188, 7531.2092230315575, 7558.093028836574, 7567.999999999973, 7572.091349038095, 7617.733379331752, 7502.887456688154, 7575.242475752436, 7602.50583712057, 7610.7336243231775, 7650.005499285057, 36038.81980590107, 36276.63723362759, 36538.26923461516, 36691.81654091739, 36730.4490432641, 2982.7464665503458, 3103.20868178613, 3130.8591113399953, 3235.983820080908, 3457.533233013536, 28339.14982550527, 28621.28446788826, 29169.708302917123, 29255.122346329645, 30090.39819203604, 3465.8960231193105, 3482.3905816482015, 3501.5272938153535, 3523.361636838882, 3535.063208249816, 179671.0, 180398.0, 181026.9999999987, 181376.0, 181829.0, 51484.485155148715, 52178.5648219898, 52338.73830630899, 52353.47646523486, 52356.73821630867, 28670.569941450896, 29248.853755731085, 29358.853205733834, 29395.11814645564, 29417.55873661897, 15269.618259543378, 15381.307841147176, 15477.613059673373, 15506.844931550766, 15515.534533963999, 11552.6534203974, 11637.069034477221, 11654.18420710559, 11666.241694289844, 11666.241694289844, 17717.911410442866, 17753.822461775475, 17795.73306400405, 17841.7323740144, 17926.641467170582, 6595.0, 6647.434968027772, 6704.4301234395625, 6748.29142939994, 6996.300369962963, 782.4053719173469, 854.2141230068228, 876.6099085906837, 928.6146249306462, 983.9127763821018, 26755.866220668773, 27876.581851272247, 27907.162785116478, 28286.85856570745, 28833.27916802055, 935.2190920581255, 943.9716808495756, 965.6475386484024, 966.9613215471302, 971.489967766928, 13931.791023134661, 14798.630034249014, 14818.62953426173, 14946.775798363033, 15089.396424142911, 382464.0, 385161.0, 386341.0, 386458.0, 386595.0, 48850.0, 49204.015919681406, 49290.507094928595, 49340.25989610159, 49430.25854612184, 1104.094642393246, 1140.680609429361, 1162.953481860716, 1165.9825102623468, 1182.3142577305143, 25544.23367298984, 26225.0, 27698.0, 27810.72189278162, 28033.299167520974, 43226.1354772909, 43472.130557389304, 43558.56441435545, 43618.56381436145, 43667.126657467306, 328065.0, 329105.0, 329599.0, 330079.0, 331129.0, 25058.874705627084, 25207.621885671364, 25484.23547293584, 25489.0, 25490.745092548837, 41586.792066039474, 41771.0, 41813.163736725706, 42148.1570368597, 42174.78912605417, 34471.0, 34996.65003349934, 35413.46879796857, 35858.0, 35922.28155436929, 35094.82452587721, 35385.82307088448, 35502.644973549934, 35667.821660892565, 35877.28245435129, 26940.86529567418, 34555.48166777551, 34638.0, 35012.29975400529, 37158.0, 29559.704402955696, 32862.507062393604, 32904.177395565304, 32918.177045574055, 32984.835075825424, 24893.62659560072, 25206.0, 25279.87360063188, 25526.744732552437, 25700.614490782278], "value": 16897.07174091917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.9982000089999, 366.3808164202498, 372.5027088836403, 376.39400565090216, 386.0753495378568, 16158.0, 16436.83563164368, 16846.157692115376, 16846.15769211541, 16938.40715574955, 16231.675366492664, 17027.40404085857, 17055.658886822257, 17163.399281025166, 17168.570785730364, 4853.272009198613, 5137.229415587654, 5161.587073034167, 5186.481351864821, 5188.066148093341, 3719.0, 5045.772940217699, 5687.971560142214, 5993.610415323012, 6045.516358691294, 6090.634561926277, 6101.14583958244, 6106.664133472657, 6112.8471788205425, 6116.113163591277, 5103.8468845934685, 5313.707746073984, 5369.5167434930845, 5437.619366644337, 5472.179173124063, 5111.2333150027425, 5238.319018527605, 5246.501582349671, 5257.263983042377, 5283.524482796528, 12152.088593355533, 12510.061745369043, 12512.249265044127, 12529.874701252962, 12572.685682857911, 1758.7361895715617, 1890.3856246719733, 1936.2642195965584, 1953.4139758072663, 2401.279616115176, 9189.127032931861, 9274.95362523183, 9496.525173741355, 9552.570134343901, 13432.462701491928, 1689.6705142497217, 1746.956326091845, 1808.7829460464698, 1839.9264029438807, 1854.573448106943, 67935.32064679339, 72492.27507724961, 72613.27386726171, 73936.63031684807, 74238.0, 10015.899841001643, 10040.14658754014, 10072.949635251924, 10122.240831937634, 10491.842622360671, 14012.509562165274, 14039.50861719835, 14047.0, 14069.507567235098, 14079.648008799657, 7256.637168141572, 7442.18136005039, 7494.6627401767055, 7523.548587084792, 7626.42801789868, 6851.520393572402, 7058.929410705828, 7281.1262648482525, 7285.490015698956, 7300.4159667226495, 4257.574242575718, 4259.7231179973205, 4355.912881742411, 4363.890902727458, 4456.866294011184, 1486.524312220079, 1610.5973506623345, 1611.6454380036373, 1800.4973087408512, 1850.5558665920082, 776.3129630277245, 827.2389401750404, 870.1559487297311, 881.581248906777, 897.4525539420948, 15959.36162553508, 16117.67764644724, 16744.330226790793, 17090.48728538146, 17540.473785786446, 834.7161964931952, 835.1731785532401, 844.594594594598, 865.312076898867, 894.9776255593532, 9135.543222838964, 9412.482313472688, 9437.905620943702, 9560.856587151198, 9700.126988571063, 386300.0274979388, 391284.0, 396611.0, 398091.0, 398554.072296384, 59360.40639593635, 76192.0, 79190.6040469794, 79568.0, 80809.59595202105, 868.0321441592705, 871.7297930495826, 895.0780695883251, 895.5029958373166, 901.2339511415245, 14552.0, 14630.926845365704, 14823.629409264424, 15241.771373429629, 15468.0, 36639.0, 37289.440658389605, 37525.6247437533, 38083.809580951915, 38596.0, 48111.0, 48969.510304896496, 49182.13085906238, 51270.48729512657, 52399.476005240984, 7337.633118344168, 7657.4256930731535, 7818.413618978486, 7830.177831327856, 7887.802804929923, 9860.457674827954, 11015.83476247873, 11016.17378696617, 11076.335419874833, 12031.518739250681, 9676.516174191122, 10065.949670251603, 10147.594096236364, 10383.948080259852, 10726.51730672106, 9937.950310248403, 10472.10987066108, 10603.840942386025, 10688.144948403953, 10690.305130166515, 10026.849597256192, 10191.0, 10204.693859184237, 10272.845907311546, 10696.732581685521, 6506.25178104524, 6681.599104053578, 6700.262971073081, 7104.928950710633, 7892.68429262846, 7720.459567830198, 9747.805043899225, 10084.949575252076, 10088.596456141671, 10399.792004159723], "value": 8079.06108896922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.6771690935718, 1379.6895698467847, 1406.9507567235148, 1582.272154808788, 1622.9188540572968, 6778.932210677892, 7277.199508054123, 7403.888941665872, 8009.839803203932, 8028.839423211532, 7334.743283985062, 7609.467337286392, 7612.200718924516, 7614.923850761491, 7628.732994345199, 2166.230987999265, 2187.9343619691354, 2197.824174066071, 2199.604071267171, 2200.5048864005553, 2111.577684463106, 2139.743230812305, 2211.3918672365066, 2213.6790165426005, 2215.9335219943428, 2160.243914629875, 2160.5030842906062, 2162.2540223622823, 2167.468970102327, 2200.1529411176653, 2133.5412886229456, 2141.6573348264283, 2143.7534683511362, 2145.656694928804, 2151.225558798831, 2051.917923283067, 2099.9790002099935, 2108.5888251790907, 2108.8312934965165, 2145.7103291055664, 7757.301842834172, 7921.841563168762, 7932.603369831543, 7937.729963205859, 7945.801354966115, 4400.603945644875, 4473.552644735533, 4479.417675702138, 4479.664025198091, 4499.977500112511, 2801.439712057597, 2896.203544025389, 2898.521743912252, 2938.8824447022093, 2970.4059188162237, 885.6501681835639, 952.4904176265734, 952.5237381309346, 975.9658411955547, 989.5101924547395, 9795.412275263507, 9799.706008819747, 9827.606895724233, 9863.358881672668, 9871.90128098717, 3849.8075096245075, 3960.663343615825, 4076.3274059779806, 4135.400366946776, 4142.937855932163, 8472.915270847212, 8510.936132983377, 8524.616392262364, 8535.0, 8554.78613034679, 4483.529229430863, 4497.910041799146, 4499.280115181556, 4507.706999045052, 4509.684322097487, 3593.8921832345072, 4094.4267802507675, 4119.011437255037, 4142.399352093929, 4245.532991370947, 3663.4687970244167, 3695.2609478104487, 3709.3694072007825, 3713.6843368313994, 3796.259729352805, 1220.2251570252777, 1233.8334324866028, 1247.4012474012525, 1249.77504049272, 1254.404158024931, 661.3353579652419, 768.8885111658778, 769.6075001749036, 773.2267732267733, 794.8450052239758, 5022.648414610942, 5128.564072053917, 5257.973710131425, 5266.262723218752, 5442.782288708487, 383.70454749842463, 394.9269385163754, 401.27569736625674, 402.7623702015825, 422.44870444070784, 3455.378031954222, 3458.723302135823, 3513.2797776455764, 3531.770434921722, 3652.8538858445363, 9416.62333506652, 9842.360246583949, 9888.159506441889, 9899.703008909744, 9921.454320012468, 9825.803483930282, 9831.36096153762, 9853.06395892389, 9865.950670246602, 9870.407775533491, 7384.0, 7427.665755041036, 7462.10454745434, 7485.7754267372065, 7546.0, 5074.16276314404, 5162.612804039637, 5168.405633352062, 5263.973680131728, 5355.70543620089, 8825.073367296598, 8913.955430222808, 8930.419522731001, 8994.460332379816, 9029.142231487998, 9036.502992335485, 9099.31755118382, 9117.316201284797, 9157.358984870994, 9188.0, 5837.94162058374, 6454.548181627429, 6678.332166783282, 6699.799006029827, 6778.0, 7242.927570724225, 7308.415326773952, 7308.744193953186, 7315.451341149329, 7319.5242309249725, 6555.901661475177, 6666.899996500153, 6703.899441508479, 6804.183497980274, 6918.930810691829, 6452.645104519296, 6535.248446428532, 6560.44236239925, 6640.800775976729, 6847.828804279933, 6397.104405383343, 6520.250171230179, 6524.445422139172, 6528.151340325728, 6552.934470655423, 4551.271796512542, 4574.588287054181, 4630.930536041895, 4638.397008388888, 4671.813127474863, 4683.812647494062, 4780.402449693788, 4792.161371759998, 4811.759412029454, 4861.465238823797], "value": 4016.9983452919255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.17645768306426, 296.1589086992941, 305.12885711294257, 309.27783625235077, 315.1286692295804, 4902.60779137669, 4905.890467099146, 5083.771230294637, 5114.462981386957, 5118.513741194585, 4938.308636790844, 4995.425526064504, 5008.323876276701, 5015.272785446108, 5025.7235852028125, 3982.800859957005, 3985.8007099645047, 3993.3410987187226, 3996.3406038003695, 4000.3797512629276, 3886.844526218948, 3960.0, 3991.44119823225, 3992.3213053780783, 4018.276710192164, 3906.1797022625283, 3935.3900145477355, 3940.4089386592095, 3941.645251927326, 3960.574193290413, 3934.8622798201927, 3944.704147188958, 3951.1702542465973, 3951.229510245503, 3955.8219880105466, 3494.213801894579, 3504.9474257886154, 3506.2987402519598, 3506.6142724300307, 3517.085557755002, 4608.1705293047235, 4857.368542089541, 4892.412910450768, 4938.2839488274, 4938.975305123451, 4391.49497807753, 4407.779611019469, 4417.337399390085, 4421.778911054466, 4429.9114017719785, 5232.2733497945965, 5245.632805703603, 5248.501392367757, 5298.92051619226, 5307.867303317448, 3447.9828450607133, 3641.890743277706, 3700.685441737429, 3717.5910649828497, 3725.5470366557065, 5345.492178243061, 5408.215808707755, 5414.972925135349, 5437.586227580818, 5440.183972404131, 3730.2912446635596, 3763.849446022183, 3764.3412402829395, 3776.5090538229856, 3783.4135708965155, 3821.8280177392085, 3841.961580384216, 3852.6339997700175, 3854.49891514107, 3861.571218649118, 4185.560516145761, 4308.3968244445805, 4327.0480494291205, 4341.739495630272, 4343.849794351753, 5206.646271969315, 5220.817271395483, 5235.450277720861, 5238.982991548205, 5246.816361427332, 1247.382545639914, 1286.7876800328029, 1306.8301120854228, 1308.1562392256942, 1312.8096426018174, 858.4205661178804, 888.2272422992038, 907.7458311672742, 915.3455279475207, 918.5395221597691, 4534.523874993144, 4541.704789188759, 4563.718140929535, 4594.356790049395, 4611.239145541015, 5288.7091209983055, 5294.179402192666, 5295.7087360195555, 5330.840074797762, 5343.332083489564, 4453.35426363182, 4588.371128249423, 4590.793414296365, 4603.49361570227, 4623.838165664186, 2448.8775561222224, 2499.9250022499355, 2525.482276133388, 2535.4422027153996, 2540.4030052937546, 4462.9107417851465, 4488.496353721474, 4488.675840627023, 4492.595666390041, 4496.965697889504, 4762.904322098335, 4771.594414474739, 4778.641601879873, 4781.904361912742, 4843.878903027382, 4651.906961860744, 5013.172826483662, 5041.369828771403, 5050.267711181858, 5065.290859279778, 5412.107002344726, 5434.0, 5456.290682211287, 5475.986942415666, 5498.670079795225, 5189.273501709839, 5305.495977882095, 5346.25152478661, 5368.9463105370005, 5369.48989845964, 5041.521055499722, 5061.39263288393, 5072.0, 5080.872978175576, 5083.542481176712, 3768.717346199101, 3808.2002779416634, 3824.1778017726324, 3838.3858582626644, 3858.1126340941178, 5332.746804501016, 5436.510714035756, 5494.725263736717, 5499.2677306648275, 5521.641093328921, 5216.843494695166, 5221.0, 5233.502817232356, 5240.659357141773, 5278.340207474066, 5245.763940622757, 5255.6058295628745, 5271.288376069181, 5273.209018647233, 5291.867703307448, 5056.367954005749, 5163.122269214167, 5175.275461435477, 5179.249008893765, 5212.869678258074, 5263.578913686973, 5265.868353291198, 5269.552088072557, 5296.708681022426, 5303.443138470405, 5165.147750621106, 5178.663386879841, 5191.169412893919, 5206.2667099772925, 5207.3751149862255], "value": 3904.02546200636, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.3087169549343, 658.5159907468012, 672.7880717573961, 720.5892641194521, 727.1710250314642, 13079.869201307984, 14175.929120354383, 14178.858211417883, 14256.786148207771, 14340.067895586793, 12871.0, 13174.209547427161, 13239.80140297894, 13325.866741332584, 13345.666358341046, 596.8627215740382, 729.4674887332251, 746.138210367027, 746.6453434618567, 748.3003391828657, 715.9463040271975, 744.240874308208, 752.3229093815582, 754.3211110000988, 754.592520039181, 784.0238902566313, 785.5954183595453, 787.283571949526, 788.03072221168, 788.4953629677011, 775.4223103787714, 780.3523075847033, 781.3592853859838, 781.5740421470284, 781.5935713428985, 567.6906086182998, 570.0850135532452, 573.020135568179, 573.237593999979, 574.873527823878, 12376.0, 12427.44076516559, 12468.376581170905, 12484.375781210994, 12485.126041177122, 12854.935725321313, 13426.664333391645, 13677.31613419325, 13777.380017899219, 13930.860691393058, 10536.315139515908, 10581.788364232749, 10685.198610104195, 10744.516496757664, 10794.2444028918, 3273.165342837585, 3308.123347312964, 3318.867245310209, 3421.674940880612, 3457.861685532576, 65649.0, 66545.0, 66771.99999999952, 68398.31601683969, 68495.65752171207, 9584.472853992958, 9754.122129008281, 9758.560864761102, 9867.407955522547, 9936.503174841373, 16761.245743941552, 17472.475825725247, 20185.59628807445, 20321.89839050795, 20362.981850907396, 6947.548409353376, 7085.0, 7113.324234197743, 7148.213696493382, 7227.0, 3695.1131728384994, 3725.3294407006997, 3780.0, 3810.256999884996, 3817.0648191193336, 2879.8848046077924, 3034.666186719459, 3038.1645047612083, 3052.1759125036115, 3092.6443459002053, 512.8820371314544, 523.2230138244704, 524.5305451620778, 524.5567495466324, 529.4573062610855, 459.38213103375904, 519.4156573854414, 541.8999431154762, 555.38352428804, 578.1674388880083, 7462.962685186648, 7566.205548417337, 7846.979892613924, 7860.331871790848, 8113.716019939274, 510.9233614957712, 546.5873265684382, 558.4806130298861, 572.8081092833947, 575.1938911816899, 3626.8911932642063, 3709.146896213886, 3740.831662575191, 3795.411711184771, 3936.5866584008268, 96752.0, 99568.0, 102153.0, 102571.48714256381, 103010.0, 73656.0, 85522.5723871389, 88038.55980720055, 89335.0, 89430.55284723535, 80121.0, 80651.0, 80922.59538702386, 81742.0, 83421.32629389635, 7163.31948464895, 7440.55356678601, 7531.284527969834, 7562.546247225184, 7564.698075646989, 38815.6118438812, 46568.0, 47447.0, 47888.0, 48440.27339589839, 38015.239695206496, 40253.79873100616, 42564.5743542573, 59760.0, 59862.82332003657, 9186.0, 9534.141927226583, 9732.75668108303, 9744.12302892743, 9975.301728878909, 11485.368304743319, 12130.636080917586, 12422.813657794959, 12599.118061735591, 12647.747045058863, 10483.947580262049, 10789.136869050613, 10903.12774977984, 11195.160362972647, 11281.32312061279, 11031.944840275748, 11606.651800446, 11637.88362116368, 11744.471498782405, 11903.642890713292, 11158.72103197394, 11228.0, 11625.76748465009, 11634.301941883514, 11719.531218751154, 8907.287417006495, 9151.679691210775, 9301.256359256693, 9579.9042009579, 9784.510774461107, 9341.439513629204, 9797.412155270707, 9857.507124643882, 9876.555554999899, 9898.10917017443], "value": 6417.8722082732675, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1606.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 114.0, 116.0, 115.0, 115.0, 114.0, 117.0, 115.0, 132.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 148.0, 189.0, 126.0, 159.0, 161.0, 126.0, 188.0, 134.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 167.0, 165.0, 163.0, 163.0, 164.0, 162.0, 164.0, 164.0, 165.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 172.0, 78.0, 77.0, 75.0, 76.0, 159.0, 79.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 147.0, 89.0, 85.0, 85.0, 150.0, 84.0, 86.0, 130.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 118.0, 119.0, 119.0, 119.0, 118.0, 119.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 150.0, 148.0, 148.0, 148.0, 148.0, 150.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 98.0, 96.0, 97.0, 97.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 68.0, 67.0, 68.0, 70.0, 67.0, 69.0, 68.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 65.0, 67.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 85.0, 90.0, 84.0, 83.0, 83.0, 82.0, 86.0, 82.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 150.0, 146.0, 147.0, 144.0, 154.0, 134.0, 131.0, 176.0, 136.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 176.0, 178.0, 178.0, 172.0, 174.0, 173.0, 177.0, 181.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 71.0, 75.0, 70.0, 69.0, 70.0, 68.0, 70.0], "value": 70.6, "unit": "score"}]}]} 19:27:45 INFO - Return code: 0 19:27:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:27:45 ERROR - # TBPL SUCCESS # 19:27:45 INFO - Running post-action listener: _resource_record_post_action 19:27:45 INFO - [mozharness: 2016-09-02 02:27:45.537625Z] Finished run-tests step (success) 19:27:45 INFO - Running post-run listener: _resource_record_post_run 19:27:45 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 406413312; Read time: 128; Write time: 323016 19:27:45 INFO - TinderboxPrint: CPU usage
13.4% 19:27:45 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 128 19:27:45 INFO - TinderboxPrint: I/O write bytes / time
406,413,312 / 323,016 19:27:45 INFO - TinderboxPrint: CPU idle
8,292.8 (86.6%) 19:27:45 INFO - TinderboxPrint: CPU user
1,223.3 (12.8%) 19:27:45 INFO - TinderboxPrint: Swap in / out
0 / 0 19:27:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113668096; Read time: 0; Write time: 86952 19:27:45 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292745216; Read time: 116; Write time: 236064 19:27:46 INFO - Running post-run listener: _upload_blobber_files 19:27:46 INFO - Blob upload gear active. 19:27:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:27:46 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 19:27:46 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:27:46 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:27:46 INFO - (blobuploader) - INFO - Open directory for files ... 19:27:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:27:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:27:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:47 INFO - (blobuploader) - INFO - Done attempting. 19:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:27:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:48 INFO - (blobuploader) - INFO - Done attempting. 19:27:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:27:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:52 INFO - (blobuploader) - INFO - Done attempting. 19:27:52 INFO - (blobuploader) - INFO - Iteration through files over. 19:27:52 INFO - Return code: 0 19:27:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:27:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:27:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0c7b553fadce35790140a48e9603e84443ef4292995b1eb80073fbee590cfbc1b999789ae38be3fc9845568ef465ca9cae153e364e62072693a8a8a5fc954e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8088b98f20794438565f051636a258ef8d4c21053221702ea76097d8f60140146b80b3b2590c3cdef7d8a2635ac64976cc47e8b2358a2ccbdb261e87eb6e48e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/861b37dd9c8c2fc1562fbdfb241ee661f29d2ab7beec03544d8442ca4597b1afe3c877349d638c52720d9494d6bdd064b3816d6b2bf2a45f04d2b0ae820ae85a"} 19:27:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:27:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:27:52 INFO - Contents: 19:27:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0c7b553fadce35790140a48e9603e84443ef4292995b1eb80073fbee590cfbc1b999789ae38be3fc9845568ef465ca9cae153e364e62072693a8a8a5fc954e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8088b98f20794438565f051636a258ef8d4c21053221702ea76097d8f60140146b80b3b2590c3cdef7d8a2635ac64976cc47e8b2358a2ccbdb261e87eb6e48e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/861b37dd9c8c2fc1562fbdfb241ee661f29d2ab7beec03544d8442ca4597b1afe3c877349d638c52720d9494d6bdd064b3816d6b2bf2a45f04d2b0ae820ae85a"} 19:27:52 INFO - Running post-run listener: copy_logs_to_upload_dir 19:27:52 INFO - Copying logs to upload dir... 19:27:52 INFO - mkdir: /builds/slave/test/build/upload/logs 19:27:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.719335 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-01 19:27:51.870222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 19:27:51.873626) ========= 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=db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0c7b553fadce35790140a48e9603e84443ef4292995b1eb80073fbee590cfbc1b999789ae38be3fc9845568ef465ca9cae153e364e62072693a8a8a5fc954e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8088b98f20794438565f051636a258ef8d4c21053221702ea76097d8f60140146b80b3b2590c3cdef7d8a2635ac64976cc47e8b2358a2ccbdb261e87eb6e48e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/861b37dd9c8c2fc1562fbdfb241ee661f29d2ab7beec03544d8442ca4597b1afe3c877349d638c52720d9494d6bdd064b3816d6b2bf2a45f04d2b0ae820ae85a"} build_url:https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/TLfxt7vuT2iwW0Oqb2khtA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0c7b553fadce35790140a48e9603e84443ef4292995b1eb80073fbee590cfbc1b999789ae38be3fc9845568ef465ca9cae153e364e62072693a8a8a5fc954e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8088b98f20794438565f051636a258ef8d4c21053221702ea76097d8f60140146b80b3b2590c3cdef7d8a2635ac64976cc47e8b2358a2ccbdb261e87eb6e48e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/861b37dd9c8c2fc1562fbdfb241ee661f29d2ab7beec03544d8442ca4597b1afe3c877349d638c52720d9494d6bdd064b3816d6b2bf2a45f04d2b0ae820ae85a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 19:27:51.902764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:27:51.903089) ========= 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=db7e7c15f3ca076d53731445000001ba-1472781346.399037-1443356288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:27:51.987875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 19:27:51.988199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 19:27:51.988495) ========= ========= Total master_lag: 0.18 =========