builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1472521433.9 results: success (0) buildid: 20160829175429 builduid: 670acda1c49c4a198e0dfb8e17b77267 revision: fecb1018cdcbf931db0892b6fba2e8348286f1d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:53.902418) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:53.906149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:53.906441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:53.957152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:53.957433) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 18:43:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.9M=0s 2016-08-29 18:43:54 (81.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.123151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.123467) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015579 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.172924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.173609) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fecb1018cdcbf931db0892b6fba2e8348286f1d8 --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 fecb1018cdcbf931db0892b6fba2e8348286f1d8 --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=c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 18:43:54,575 truncating revision to first 12 chars 2016-08-29 18:43:54,575 Setting DEBUG logging. 2016-08-29 18:43:54,575 attempt 1/10 2016-08-29 18:43:54,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fecb1018cdcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 18:43:54,877 unpacking tar archive at: mozilla-central-fecb1018cdcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646693 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.834833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.835157) ========= script_repo_revision: fecb1018cdcbf931db0892b6fba2e8348286f1d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.835551) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.835819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 18:43:54.843821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-29 18:43:54.844143) ========= /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=c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:43:55 INFO - MultiFileLogger online at 20160829 18:43:55 in /builds/slave/test 18:43:55 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 18:43:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:43:55 INFO - {'append_to_log': False, 18:43:55 INFO - 'base_work_dir': '/builds/slave/test', 18:43:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:43:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:43:55 INFO - 'branch': 'Firefox-Non-PGO', 18:43:55 INFO - 'buildbot_json_path': 'buildprops.json', 18:43:55 INFO - 'config_files': ('talos/linux_config.py',), 18:43:55 INFO - 'default_actions': ('clobber', 18:43:55 INFO - 'read-buildbot-config', 18:43:55 INFO - 'download-and-extract', 18:43:55 INFO - 'populate-webroot', 18:43:55 INFO - 'create-virtualenv', 18:43:55 INFO - 'install', 18:43:55 INFO - 'run-tests'), 18:43:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:43:55 INFO - 'download_minidump_stackwalk': True, 18:43:55 INFO - 'download_symbols': 'ondemand', 18:43:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:43:55 INFO - 'tooltool.py': '/tools/tooltool.py', 18:43:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:43:55 INFO - '/tools/misc-python/virtualenv.py')}, 18:43:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:43:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:43:55 INFO - 'installer_path': 'installer.exe', 18:43:55 INFO - 'log_level': 'info', 18:43:55 INFO - 'log_name': 'talos', 18:43:55 INFO - 'log_to_console': True, 18:43:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:43:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:43:55 INFO - 'opt_config_files': (), 18:43:55 INFO - 'pip_index': False, 18:43:55 INFO - 'sps_profile': False, 18:43:55 INFO - 'sps_profile_interval': 0, 18:43:55 INFO - 'suite': 'dromaeojs-e10s', 18:43:55 INFO - 'system_bits': '32', 18:43:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:43:55 INFO - 'title': 'talos-linux64-ix-004', 18:43:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:43:55 INFO - 'use_talos_json': True, 18:43:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:43:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:43:55 INFO - 'work_dir': 'build'} 18:43:55 INFO - [mozharness: 2016-08-30 01:43:55.334897Z] Running clobber step. 18:43:55 INFO - Running pre-action listener: _resource_record_pre_action 18:43:55 INFO - Running main action method: clobber 18:43:55 INFO - rmtree: /builds/slave/test/build 18:43:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:43:55 INFO - Running post-action listener: _resource_record_post_action 18:43:55 INFO - [mozharness: 2016-08-30 01:43:55.798634Z] Finished clobber step (success) 18:43:55 INFO - [mozharness: 2016-08-30 01:43:55.798736Z] Running read-buildbot-config step. 18:43:55 INFO - Running pre-action listener: _resource_record_pre_action 18:43:55 INFO - Running main action method: read_buildbot_config 18:43:55 INFO - Using buildbot properties: 18:43:55 INFO - { 18:43:55 INFO - "project": "", 18:43:55 INFO - "product": "firefox", 18:43:55 INFO - "script_repo_revision": "production", 18:43:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:43:55 INFO - "repository": "", 18:43:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:43:55 INFO - "buildid": "20160829175429", 18:43:55 INFO - "pgo_build": "False", 18:43:55 INFO - "basedir": "/builds/slave/test", 18:43:55 INFO - "buildnumber": 181, 18:43:55 INFO - "slavename": "talos-linux64-ix-004", 18:43:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:43:55 INFO - "platform": "ubuntu64_hw", 18:43:55 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:43:55 INFO - "branch": "mozilla-central", 18:43:55 INFO - "repo_path": "mozilla-central", 18:43:55 INFO - "revision": "fecb1018cdcbf931db0892b6fba2e8348286f1d8", 18:43:55 INFO - "stage_platform": "linux64", 18:43:55 INFO - "builduid": "670acda1c49c4a198e0dfb8e17b77267", 18:43:55 INFO - "slavebuilddir": "test" 18:43:55 INFO - } 18:43:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:43:55 INFO - Running post-action listener: _resource_record_post_action 18:43:55 INFO - [mozharness: 2016-08-30 01:43:55.801195Z] Finished read-buildbot-config step (success) 18:43:55 INFO - [mozharness: 2016-08-30 01:43:55.801287Z] Running download-and-extract step. 18:43:55 INFO - Running pre-action listener: _resource_record_pre_action 18:43:55 INFO - Running main action method: download_and_extract 18:43:55 INFO - mkdir: /builds/slave/test/build/tests 18:43:55 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')]} 18:43:55 INFO - trying https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:43:55 INFO - Downloading https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:43:56 INFO - Downloaded 1361 bytes. 18:43:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:43:56 INFO - Using the following test package requirements: 18:43:56 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:43:56 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:43:56 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:43:56 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'jsshell-linux-x86_64.zip'], 18:43:56 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:43:56 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:43:56 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:43:56 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:43:56 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:43:56 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:43:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:43:56 INFO - trying https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:43:56 INFO - Downloading https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:43:57 INFO - Downloaded 20315589 bytes. 18:43:57 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 18:44:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:01 INFO - trying https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:44:01 INFO - Downloading https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:44:02 INFO - Downloaded 20315589 bytes. 18:44:02 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 18:44:06 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')]} 18:44:06 INFO - trying https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:06 INFO - Downloading https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:44:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:44:08 INFO - Downloaded 14413998 bytes. 18:44:08 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 18:44: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')]} 18:44:08 INFO - trying https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:44:08 INFO - Downloading https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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 18:44:09 INFO - Downloaded 55841142 bytes. 18:44:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:44:09 INFO - mkdir: /builds/slave/test/properties 18:44:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:44:09 INFO - Writing to file /builds/slave/test/properties/build_url 18:44:09 INFO - Contents: 18:44:09 INFO - build_url:https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:44:10 INFO - Running post-action listener: _resource_record_post_action 18:44:10 INFO - Running post-action listener: set_extra_try_arguments 18:44:10 INFO - [mozharness: 2016-08-30 01:44:10.557944Z] Finished download-and-extract step (success) 18:44:10 INFO - [mozharness: 2016-08-30 01:44:10.558171Z] Running populate-webroot step. 18:44:10 INFO - Running pre-action listener: _resource_record_pre_action 18:44:10 INFO - Running main action method: populate_webroot 18:44:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:10 INFO - '--tppagecycles', 18:44:10 INFO - '7'], 18:44:10 INFO - 'tests': ['tsvgm']}}, 18:44:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:44:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:44:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['damp', 'tps']}, 18:44:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'tests': ['damp', 'tps']}, 18:44:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['dromaeo_dom']}, 18:44:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['basic_compositor_video']}, 18:44:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:44:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['a11yr', 18:44:10 INFO - 'ts_paint', 18:44:10 INFO - 'tpaint', 18:44:10 INFO - 'sessionrestore', 18:44:10 INFO - 'sessionrestore_no_auto_restore', 18:44:10 INFO - 'tabpaint']}, 18:44:10 INFO - 'other-e10s': {'tests': ['a11yr', 18:44:10 INFO - 'ts_paint', 18:44:10 INFO - 'tpaint', 18:44:10 INFO - 'sessionrestore', 18:44:10 INFO - 'sessionrestore_no_auto_restore', 18:44:10 INFO - 'tabpaint']}, 18:44:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:44:10 INFO - 'ts_paint', 18:44:10 INFO - 'tpaint', 18:44:10 INFO - 'sessionrestore', 18:44:10 INFO - 'sessionrestore_no_auto_restore', 18:44:10 INFO - 'tabpaint']}, 18:44:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:44:10 INFO - 'ts_paint', 18:44:10 INFO - 'tpaint', 18:44:10 INFO - 'sessionrestore', 18:44:10 INFO - 'sessionrestore_no_auto_restore', 18:44:10 INFO - 'tabpaint']}, 18:44:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['a11yr', 18:44:10 INFO - 'ts_paint', 18:44:10 INFO - 'tpaint', 18:44:10 INFO - 'sessionrestore', 18:44:10 INFO - 'sessionrestore_no_auto_restore', 18:44:10 INFO - 'tabpaint']}, 18:44:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['a11yr', 18:44:10 INFO - 'ts_paint', 18:44:10 INFO - 'tpaint', 18:44:10 INFO - 'sessionrestore', 18:44:10 INFO - 'sessionrestore_no_auto_restore', 18:44:10 INFO - 'tabpaint']}, 18:44:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['tsvgx', 18:44:10 INFO - 'tsvgr_opacity', 18:44:10 INFO - 'tart', 18:44:10 INFO - 'tscrollx', 18:44:10 INFO - 'cart']}, 18:44:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:44:10 INFO - 'tsvgr_opacity', 18:44:10 INFO - 'tart', 18:44:10 INFO - 'tscrollx', 18:44:10 INFO - 'cart']}, 18:44:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'talos_options': ['--disable-e10s'], 18:44:10 INFO - 'tests': ['tp5o']}, 18:44:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'tests': ['tp5o']}, 18:44:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'talos_options': ['--disable-e10s', 18:44:10 INFO - '--xperf_path', 18:44:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:10 INFO - 'tests': ['tp5n']}, 18:44:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:10 INFO - 'talos_options': ['--xperf_path', 18:44:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:10 INFO - 'tests': ['tp5n']}}, 18:44:10 INFO - 'talos.zip': {'path': '', 18:44:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:10 INFO - Running post-action listener: _resource_record_post_action 18:44:10 INFO - [mozharness: 2016-08-30 01:44:10.580692Z] Finished populate-webroot step (success) 18:44:10 INFO - [mozharness: 2016-08-30 01:44:10.580782Z] Running create-virtualenv step. 18:44:10 INFO - Running pre-action listener: _resource_record_pre_action 18:44:10 INFO - Running main action method: create_virtualenv 18:44:10 INFO - Creating virtualenv /builds/slave/test/build/venv 18:44:10 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 18:44:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:44:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:10 INFO - Using real prefix '/usr' 18:44:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:44:11 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:13 INFO - Installing pip.................done. 18:44:13 INFO - Return code: 0 18:44:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:44:13 INFO - Using env: {'DISPLAY': ':0', 18:44:13 INFO - 'HOME': '/home/cltbld', 18:44:13 INFO - 'LANG': 'en_US.UTF-8', 18:44:13 INFO - 'LANGUAGE': 'en_US:en', 18:44:13 INFO - 'LOGNAME': 'cltbld', 18:44:13 INFO - 'MAIL': '/var/mail/cltbld', 18:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:13 INFO - 'MOZ_NO_REMOTE': '1', 18:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:13 INFO - 'NO_EM_RESTART': '1', 18:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:13 INFO - 'PWD': '/builds/slave/test', 18:44:13 INFO - 'SHELL': '/bin/bash', 18:44:13 INFO - 'SHLVL': '1', 18:44:13 INFO - 'TERM': 'linux', 18:44:13 INFO - 'TMOUT': '86400', 18:44:13 INFO - 'USER': 'cltbld', 18:44:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:13 INFO - '_': '/tools/buildbot/bin/python'} 18:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:13 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 18:44:13 INFO - Cleaning up... 18:44:13 INFO - Return code: 0 18:44:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:44:13 INFO - Using env: {'DISPLAY': ':0', 18:44:13 INFO - 'HOME': '/home/cltbld', 18:44:13 INFO - 'LANG': 'en_US.UTF-8', 18:44:13 INFO - 'LANGUAGE': 'en_US:en', 18:44:13 INFO - 'LOGNAME': 'cltbld', 18:44:13 INFO - 'MAIL': '/var/mail/cltbld', 18:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:13 INFO - 'MOZ_NO_REMOTE': '1', 18:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:13 INFO - 'NO_EM_RESTART': '1', 18:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:13 INFO - 'PWD': '/builds/slave/test', 18:44:13 INFO - 'SHELL': '/bin/bash', 18:44:13 INFO - 'SHLVL': '1', 18:44:13 INFO - 'TERM': 'linux', 18:44:13 INFO - 'TMOUT': '86400', 18:44:13 INFO - 'USER': 'cltbld', 18:44:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:13 INFO - '_': '/tools/buildbot/bin/python'} 18:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:13 INFO - Downloading/unpacking psutil>=3.1.1 18:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:15 INFO - Installing collected packages: psutil 18:44:15 INFO - Running setup.py install for psutil 18:44:15 INFO - building 'psutil._psutil_linux' extension 18:44:15 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 18:44:15 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 18:44:15 INFO - building 'psutil._psutil_posix' extension 18:44:15 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 18:44:15 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 18:44:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:16 INFO - Successfully installed psutil 18:44:16 INFO - Cleaning up... 18:44:16 INFO - Return code: 0 18:44:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:16 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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:16 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 18:44:16 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 18:44:16 INFO - Using env: {'DISPLAY': ':0', 18:44:16 INFO - 'HOME': '/home/cltbld', 18:44:16 INFO - 'LANG': 'en_US.UTF-8', 18:44:16 INFO - 'LANGUAGE': 'en_US:en', 18:44:16 INFO - 'LOGNAME': 'cltbld', 18:44:16 INFO - 'MAIL': '/var/mail/cltbld', 18:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:16 INFO - 'MOZ_NO_REMOTE': '1', 18:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:16 INFO - 'NO_EM_RESTART': '1', 18:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:16 INFO - 'PWD': '/builds/slave/test', 18:44:16 INFO - 'SHELL': '/bin/bash', 18:44:16 INFO - 'SHLVL': '1', 18:44:16 INFO - 'TERM': 'linux', 18:44:16 INFO - 'TMOUT': '86400', 18:44:16 INFO - 'USER': 'cltbld', 18:44:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:16 INFO - '_': '/tools/buildbot/bin/python'} 18:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:44:18 INFO - Installing collected packages: mozsystemmonitor 18:44:18 INFO - Running setup.py install for mozsystemmonitor 18:44:18 INFO - Successfully installed mozsystemmonitor 18:44:18 INFO - Cleaning up... 18:44:18 INFO - Return code: 0 18:44:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:44:18 INFO - Using env: {'DISPLAY': ':0', 18:44:18 INFO - 'HOME': '/home/cltbld', 18:44:18 INFO - 'LANG': 'en_US.UTF-8', 18:44:18 INFO - 'LANGUAGE': 'en_US:en', 18:44:18 INFO - 'LOGNAME': 'cltbld', 18:44:18 INFO - 'MAIL': '/var/mail/cltbld', 18:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:18 INFO - 'MOZ_NO_REMOTE': '1', 18:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:18 INFO - 'NO_EM_RESTART': '1', 18:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:18 INFO - 'PWD': '/builds/slave/test', 18:44:18 INFO - 'SHELL': '/bin/bash', 18:44:18 INFO - 'SHLVL': '1', 18:44:18 INFO - 'TERM': 'linux', 18:44:18 INFO - 'TMOUT': '86400', 18:44:18 INFO - 'USER': 'cltbld', 18:44:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:18 INFO - '_': '/tools/buildbot/bin/python'} 18:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:18 INFO - Downloading/unpacking jsonschema==2.5.1 18:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:44:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:20 INFO - Downloading functools32-3.2.3-2.tar.gz 18:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:44:20 INFO - warning: no files found matching '*.txt' 18:44:20 INFO - no previously-included directories found matching 'build' 18:44:20 INFO - no previously-included directories found matching 'dist' 18:44:20 INFO - no previously-included directories found matching '.git*' 18:44:20 INFO - Installing collected packages: jsonschema, functools32 18:44:20 INFO - Running setup.py install for functools32 18:44:20 INFO - warning: no files found matching '*.txt' 18:44:20 INFO - no previously-included directories found matching 'build' 18:44:20 INFO - no previously-included directories found matching 'dist' 18:44:20 INFO - no previously-included directories found matching '.git*' 18:44:20 INFO - Successfully installed jsonschema functools32 18:44:20 INFO - Cleaning up... 18:44:20 INFO - Return code: 0 18:44:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:20 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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:20 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 18:44:20 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 18:44:20 INFO - Using env: {'DISPLAY': ':0', 18:44:20 INFO - 'HOME': '/home/cltbld', 18:44:20 INFO - 'LANG': 'en_US.UTF-8', 18:44:20 INFO - 'LANGUAGE': 'en_US:en', 18:44:20 INFO - 'LOGNAME': 'cltbld', 18:44:20 INFO - 'MAIL': '/var/mail/cltbld', 18:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:20 INFO - 'MOZ_NO_REMOTE': '1', 18:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:21 INFO - 'NO_EM_RESTART': '1', 18:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:21 INFO - 'PWD': '/builds/slave/test', 18:44:21 INFO - 'SHELL': '/bin/bash', 18:44:21 INFO - 'SHLVL': '1', 18:44:21 INFO - 'TERM': 'linux', 18:44:21 INFO - 'TMOUT': '86400', 18:44:21 INFO - 'USER': 'cltbld', 18:44:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:21 INFO - '_': '/tools/buildbot/bin/python'} 18:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:44:21 INFO - Cleaning up... 18:44:21 INFO - Return code: 0 18:44:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:21 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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:21 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 18:44:21 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 18:44:21 INFO - Using env: {'DISPLAY': ':0', 18:44:21 INFO - 'HOME': '/home/cltbld', 18:44:21 INFO - 'LANG': 'en_US.UTF-8', 18:44:21 INFO - 'LANGUAGE': 'en_US:en', 18:44:21 INFO - 'LOGNAME': 'cltbld', 18:44:21 INFO - 'MAIL': '/var/mail/cltbld', 18:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:21 INFO - 'MOZ_NO_REMOTE': '1', 18:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:21 INFO - 'NO_EM_RESTART': '1', 18:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:21 INFO - 'PWD': '/builds/slave/test', 18:44:21 INFO - 'SHELL': '/bin/bash', 18:44:21 INFO - 'SHLVL': '1', 18:44:21 INFO - 'TERM': 'linux', 18:44:21 INFO - 'TMOUT': '86400', 18:44:21 INFO - 'USER': 'cltbld', 18:44:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:21 INFO - '_': '/tools/buildbot/bin/python'} 18:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:21 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:23 INFO - Downloading blobuploader-1.2.4.tar.gz 18:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:44:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:44:23 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 18:44:23 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 18:44:23 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 18:44:23 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 18:44:23 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 18:44:23 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 18:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:44:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:44:24 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 18:44:24 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 18:44:24 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 18:44:24 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 18:44:24 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 18:44:24 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 18:44:24 INFO - Downloading docopt-0.6.1.tar.gz 18:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:44:24 INFO - Installing collected packages: blobuploader, requests, docopt 18:44:24 INFO - Running setup.py install for blobuploader 18:44:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:44:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:44:24 INFO - Running setup.py install for requests 18:44:24 INFO - Running setup.py install for docopt 18:44:24 INFO - Successfully installed blobuploader requests docopt 18:44:24 INFO - Cleaning up... 18:44:24 INFO - Return code: 0 18:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:24 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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:24 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 18:44:24 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 18:44:24 INFO - Using env: {'DISPLAY': ':0', 18:44:24 INFO - 'HOME': '/home/cltbld', 18:44:24 INFO - 'LANG': 'en_US.UTF-8', 18:44:24 INFO - 'LANGUAGE': 'en_US:en', 18:44:24 INFO - 'LOGNAME': 'cltbld', 18:44:24 INFO - 'MAIL': '/var/mail/cltbld', 18:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:24 INFO - 'MOZ_NO_REMOTE': '1', 18:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:24 INFO - 'NO_EM_RESTART': '1', 18:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:24 INFO - 'PWD': '/builds/slave/test', 18:44:24 INFO - 'SHELL': '/bin/bash', 18:44:24 INFO - 'SHLVL': '1', 18:44:24 INFO - 'TERM': 'linux', 18:44:24 INFO - 'TMOUT': '86400', 18:44:24 INFO - 'USER': 'cltbld', 18:44:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:24 INFO - '_': '/tools/buildbot/bin/python'} 18:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:25 INFO - Running setup.py (path:/tmp/pip-X4v0p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:25 INFO - Running setup.py (path:/tmp/pip-bmhDQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:25 INFO - Running setup.py (path:/tmp/pip-VCboPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:25 INFO - Running setup.py (path:/tmp/pip-jwjoSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:25 INFO - Running setup.py (path:/tmp/pip-KEhOHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:25 INFO - Running setup.py (path:/tmp/pip-Zgltu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:25 INFO - Running setup.py (path:/tmp/pip-edtlDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:25 INFO - Running setup.py (path:/tmp/pip-H2mfUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:25 INFO - Running setup.py (path:/tmp/pip-Qum6T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:25 INFO - Running setup.py (path:/tmp/pip-xcrgte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:25 INFO - Running setup.py (path:/tmp/pip-EOdtXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:25 INFO - Running setup.py (path:/tmp/pip-SceZnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:25 INFO - Running setup.py (path:/tmp/pip-_7kPes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:26 INFO - Running setup.py (path:/tmp/pip-4lnGtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:26 INFO - Running setup.py (path:/tmp/pip-AcljFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:26 INFO - Running setup.py (path:/tmp/pip-rImMPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:26 INFO - Running setup.py (path:/tmp/pip-81AadL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:44:26 INFO - Running setup.py install for manifestparser 18:44:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:44:26 INFO - Running setup.py install for mozcrash 18:44:26 INFO - Running setup.py install for mozdebug 18:44:26 INFO - Running setup.py install for mozdevice 18:44:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:44:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:44:26 INFO - Running setup.py install for mozfile 18:44:26 INFO - Running setup.py install for mozhttpd 18:44:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:44:26 INFO - Running setup.py install for mozinfo 18:44:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Running setup.py install for mozInstall 18:44:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Running setup.py install for mozleak 18:44:27 INFO - Running setup.py install for mozlog 18:44:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Running setup.py install for moznetwork 18:44:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Running setup.py install for mozprocess 18:44:27 INFO - Running setup.py install for mozprofile 18:44:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Running setup.py install for mozrunner 18:44:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Running setup.py install for mozscreenshot 18:44:27 INFO - Running setup.py install for moztest 18:44:28 INFO - Running setup.py install for mozversion 18:44:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:44:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:44:28 INFO - Cleaning up... 18:44:28 INFO - Return code: 0 18:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:28 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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:28 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 18:44:28 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 18:44:28 INFO - Using env: {'DISPLAY': ':0', 18:44:28 INFO - 'HOME': '/home/cltbld', 18:44:28 INFO - 'LANG': 'en_US.UTF-8', 18:44:28 INFO - 'LANGUAGE': 'en_US:en', 18:44:28 INFO - 'LOGNAME': 'cltbld', 18:44:28 INFO - 'MAIL': '/var/mail/cltbld', 18:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:28 INFO - 'MOZ_NO_REMOTE': '1', 18:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:28 INFO - 'NO_EM_RESTART': '1', 18:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:28 INFO - 'PWD': '/builds/slave/test', 18:44:28 INFO - 'SHELL': '/bin/bash', 18:44:28 INFO - 'SHLVL': '1', 18:44:28 INFO - 'TERM': 'linux', 18:44:28 INFO - 'TMOUT': '86400', 18:44:28 INFO - 'USER': 'cltbld', 18:44:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:28 INFO - '_': '/tools/buildbot/bin/python'} 18:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:28 INFO - Running setup.py (path:/tmp/pip-YQpXIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:28 INFO - Running setup.py (path:/tmp/pip-c5xJAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:28 INFO - Running setup.py (path:/tmp/pip-rMmaQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:28 INFO - Running setup.py (path:/tmp/pip-mGUJOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:28 INFO - Running setup.py (path:/tmp/pip-Tp5VtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:28 INFO - Running setup.py (path:/tmp/pip-GQXhYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:28 INFO - Running setup.py (path:/tmp/pip-dbTrdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:28 INFO - Running setup.py (path:/tmp/pip-2mtGkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:28 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)) 18:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:28 INFO - Running setup.py (path:/tmp/pip-b_s5sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:29 INFO - Running setup.py (path:/tmp/pip-dGOqsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:29 INFO - Running setup.py (path:/tmp/pip-AUDi8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:29 INFO - Running setup.py (path:/tmp/pip-Bkb9oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:29 INFO - Running setup.py (path:/tmp/pip-Due75y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:29 INFO - Running setup.py (path:/tmp/pip-PVS4c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:29 INFO - Running setup.py (path:/tmp/pip-8BYvM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:29 INFO - Running setup.py (path:/tmp/pip-nwmGZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:29 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)) 18:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:29 INFO - Running setup.py (path:/tmp/pip-W6GXyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:29 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)) 18:44:29 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)) 18:44:29 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)) 18:44:29 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)) 18:44:29 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)) 18:44:29 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)) 18:44:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:29 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 18:44:29 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 18:44:29 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 18:44:29 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 18:44:29 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 18:44:29 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 18:44:31 INFO - Downloading blessings-1.6.tar.gz 18:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:44:31 INFO - Installing collected packages: blessings 18:44:31 INFO - Running setup.py install for blessings 18:44:31 INFO - Successfully installed blessings 18:44:31 INFO - Cleaning up... 18:44:31 INFO - Return code: 0 18:44:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:44:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:31 INFO - Reading from file tmpfile_stdout 18:44:31 INFO - Current package versions: 18:44:31 INFO - argparse == 1.2.1 18:44:31 INFO - blessings == 1.6 18:44:31 INFO - blobuploader == 1.2.4 18:44:31 INFO - docopt == 0.6.1 18:44:31 INFO - functools32 == 3.2.3-2 18:44:31 INFO - jsonschema == 2.5.1 18:44:31 INFO - manifestparser == 1.1 18:44:31 INFO - mozInstall == 1.12 18:44:31 INFO - mozcrash == 0.17 18:44:31 INFO - mozdebug == 0.1 18:44:31 INFO - mozdevice == 0.48 18:44:31 INFO - mozfile == 1.2 18:44:31 INFO - mozhttpd == 0.7 18:44:31 INFO - mozinfo == 0.9 18:44:31 INFO - mozleak == 0.1 18:44:31 INFO - mozlog == 3.3 18:44:31 INFO - moznetwork == 0.27 18:44:31 INFO - mozprocess == 0.23 18:44:31 INFO - mozprofile == 0.28 18:44:31 INFO - mozrunner == 6.12 18:44:31 INFO - mozscreenshot == 0.1 18:44:31 INFO - mozsystemmonitor == 0.3 18:44:31 INFO - moztest == 0.7 18:44:31 INFO - mozversion == 1.4 18:44:31 INFO - psutil == 3.1.1 18:44:31 INFO - requests == 1.2.3 18:44:31 INFO - wsgiref == 0.1.2 18:44:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:31 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')]} 18:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:31 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')]} 18:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:31 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 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44:31 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 18:44:31 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 18:44:31 INFO - Using env: {'DISPLAY': ':0', 18:44:31 INFO - 'HOME': '/home/cltbld', 18:44:31 INFO - 'LANG': 'en_US.UTF-8', 18:44:31 INFO - 'LANGUAGE': 'en_US:en', 18:44:31 INFO - 'LOGNAME': 'cltbld', 18:44:31 INFO - 'MAIL': '/var/mail/cltbld', 18:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:31 INFO - 'MOZ_NO_REMOTE': '1', 18:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:31 INFO - 'NO_EM_RESTART': '1', 18:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:31 INFO - 'PWD': '/builds/slave/test', 18:44:31 INFO - 'SHELL': '/bin/bash', 18:44:31 INFO - 'SHLVL': '1', 18:44:31 INFO - 'TERM': 'linux', 18:44:31 INFO - 'TMOUT': '86400', 18:44:31 INFO - 'USER': 'cltbld', 18:44:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:31 INFO - '_': '/tools/buildbot/bin/python'} 18:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 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)) 18:44:32 INFO - Cleaning up... 18:44:32 INFO - Return code: 0 18:44:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e280e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', '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 18:44: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', 'jsonschema'] in /builds/slave/test/build 18:44: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 jsonschema 18:44:32 INFO - Using env: {'DISPLAY': ':0', 18:44:32 INFO - 'HOME': '/home/cltbld', 18:44:32 INFO - 'LANG': 'en_US.UTF-8', 18:44:32 INFO - 'LANGUAGE': 'en_US:en', 18:44:32 INFO - 'LOGNAME': 'cltbld', 18:44:32 INFO - 'MAIL': '/var/mail/cltbld', 18:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:32 INFO - 'MOZ_NO_REMOTE': '1', 18:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:32 INFO - 'NO_EM_RESTART': '1', 18:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:32 INFO - 'PWD': '/builds/slave/test', 18:44:32 INFO - 'SHELL': '/bin/bash', 18:44:32 INFO - 'SHLVL': '1', 18:44:32 INFO - 'TERM': 'linux', 18:44:32 INFO - 'TMOUT': '86400', 18:44:32 INFO - 'USER': 'cltbld', 18:44:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:32 INFO - '_': '/tools/buildbot/bin/python'} 18:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:44:32 INFO - Cleaning up... 18:44:32 INFO - Return code: 0 18:44:32 INFO - Running post-action listener: _resource_record_post_action 18:44:32 INFO - Running post-action listener: _start_resource_monitoring 18:44:32 INFO - Starting resource monitoring. 18:44:32 INFO - [mozharness: 2016-08-30 01:44:32.430414Z] Finished create-virtualenv step (success) 18:44:32 INFO - [mozharness: 2016-08-30 01:44:32.430865Z] Running install step. 18:44:32 INFO - Running pre-action listener: _resource_record_pre_action 18:44:32 INFO - Running main action method: install 18:44:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:32 INFO - Reading from file tmpfile_stdout 18:44:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:44:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:44:32 INFO - Reading from file tmpfile_stdout 18:44:32 INFO - Output received: 18:44:32 INFO - Usage: mozinstall [options] installer 18:44:32 INFO - Options: 18:44:32 INFO - -h, --help show this help message and exit 18:44:32 INFO - -d DEST, --destination=DEST 18:44:32 INFO - Directory to install application into. [default: 18:44:32 INFO - "/builds/slave/test"] 18:44:32 INFO - --app=APP Application being installed. [default: firefox] 18:44:32 INFO - mkdir: /builds/slave/test/build/application 18:44:32 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'] 18:44:32 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 18:44:48 INFO - Reading from file tmpfile_stdout 18:44:48 INFO - Output received: 18:44:48 INFO - /builds/slave/test/build/application/firefox/firefox 18:44:48 INFO - Running post-action listener: _resource_record_post_action 18:44:48 INFO - [mozharness: 2016-08-30 01:44:48.840495Z] Finished install step (success) 18:44:48 INFO - [mozharness: 2016-08-30 01:44:48.840777Z] Running run-tests step. 18:44:48 INFO - Running pre-action listener: _resource_record_pre_action 18:44:48 INFO - Running main action method: run_tests 18:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:44:48 INFO - Python 2.7.3 18:44:48 INFO - Return code: 0 18:44:48 INFO - grabbing minidump binary from tooltool 18:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:44:48 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 0xe01090>, '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 0xe049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:44:48 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 18:44:48 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 18:44:48 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 18:44:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:44:48 INFO - Return code: 0 18:44:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:44:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:44:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:44:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:44:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:44:48 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/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 18:44:48 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/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 18:44:48 INFO - Using env: {'DISPLAY': ':0', 18:44:48 INFO - 'HOME': '/home/cltbld', 18:44:48 INFO - 'LANG': 'en_US.UTF-8', 18:44:48 INFO - 'LANGUAGE': 'en_US:en', 18:44:48 INFO - 'LOGNAME': 'cltbld', 18:44:48 INFO - 'MAIL': '/var/mail/cltbld', 18:44:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:44:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:48 INFO - 'MOZ_NO_REMOTE': '1', 18:44:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:48 INFO - 'NO_EM_RESTART': '1', 18:44:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:48 INFO - 'PWD': '/builds/slave/test', 18:44:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:44:48 INFO - 'SHELL': '/bin/bash', 18:44:48 INFO - 'SHLVL': '1', 18:44:48 INFO - 'TERM': 'linux', 18:44:48 INFO - 'TMOUT': '86400', 18:44:48 INFO - 'USER': 'cltbld', 18:44:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665', 18:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:48 INFO - '_': '/tools/buildbot/bin/python'} 18:44:48 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/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 18:44:49 INFO - mozversion application_buildid: 20160829175429 18:44:49 INFO - mozversion application_changeset: fecb1018cdcbf931db0892b6fba2e8348286f1d8 18:44:49 INFO - mozversion application_display_name: Nightly 18:44:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:44:49 INFO - mozversion application_name: Firefox 18:44:49 INFO - mozversion application_remotingname: firefox 18:44:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:44:49 INFO - mozversion application_vendor: Mozilla 18:44:49 INFO - mozversion application_version: 51.0a1 18:44:49 INFO - mozversion platform_buildid: 20160829175429 18:44:49 INFO - mozversion platform_changeset: fecb1018cdcbf931db0892b6fba2e8348286f1d8 18:44:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:44:49 INFO - mozversion platform_version: 51.0a1 18:44:49 INFO - using testdate: 1472521489 18:44:49 INFO - actual date: 1472521489 18:44:49 INFO - starting webserver on 'localhost:40852' 18:44:49 INFO - SUITE-START | Running 2 tests 18:44:49 INFO - TEST-START | dromaeo_css 18:44:49 INFO - operating with platform_type : linux_ 18:44:49 INFO - Initialising browser for dromaeo_css test... 18:44:49 INFO - TEST-INFO | started process 17312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TSH8y/profile http://localhost:40852/getInfo.html) 18:44:53 INFO - PROCESS | 17312 | __metrics Screen width/height:1600/1200 18:44:53 INFO - PROCESS | 17312 | colorDepth:24 18:44:53 INFO - PROCESS | 17312 | Browser inner width/height: 1024/697 18:44:53 INFO - PROCESS | 17312 | __metrics 18:44:54 ERROR - PROCESS | 17312 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 18:44:55 INFO - TEST-INFO | 17312: exit 0 18:44:55 INFO - Browser initialized. 18:44:55 INFO - Running cycle 1/1 for dromaeo_css test... 18:44:55 INFO - TEST-INFO | started process 17432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TSH8y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:07 INFO - PROCESS | 17432 | RSS: Main: 193306624 18:45:07 INFO - PROCESS | 17432 | 18:45:57 INFO - PROCESS | 17432 | 1472521557466 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] 18:48:10 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:40852/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40852/tests/dromaeo/cssquery-ext.html) 18:48:11 INFO - PROCESS | 17432 | RSS: Main: 210911232 18:48:11 INFO - PROCESS | 17432 | 18:51:13 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:40852/tests/dromaeo/cssquery-ext.html (next: http://localhost:40852/tests/dromaeo/cssquery-jquery.html) 18:51:14 INFO - PROCESS | 17432 | RSS: Main: 206249984 18:51:14 INFO - PROCESS | 17432 | 18:54:16 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:40852/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40852/tests/dromaeo/cssquery-mootools.html) 18:54:17 INFO - PROCESS | 17432 | RSS: Main: 201105408 18:54:17 INFO - PROCESS | 17432 | 18:57:19 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:40852/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40852/tests/dromaeo/cssquery-prototype.html) 18:57:20 INFO - PROCESS | 17432 | RSS: Main: 195481600 18:57:20 INFO - PROCESS | 17432 | 19:00:22 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:40852/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40852/tests/dromaeo/cssquery-yui.html) 19:00:23 INFO - PROCESS | 17432 | RSS: Main: 199393280 19:00:23 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | Cycle 1(1): loaded http://localhost:40852/tests/dromaeo/cssquery-yui.html (next: http://localhost:40852/tests/dromaeo/cssquery-dojo.html) 19:03:26 INFO - PROCESS | 17432 | RSS: Main: 200781824 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | __start_tp_report 19:03:26 INFO - PROCESS | 17432 | _x_x_mozilla_page_load 19:03:26 INFO - PROCESS | 17432 | _x_x_mozilla_page_load_details 19:03:26 INFO - PROCESS | 17432 | |i|pagename|runs| 19:03:26 INFO - PROCESS | 17432 | |0;dojo.html;2547.1849008317336;2592.1445922845464;2622.5017246723132;2628.947421051579;2656.3359160209934;4731.692439991398;4794.113089078519;4811.807527698892;4835.371401717776;4872.975635121828;4789.497102804207;4804.375431193948;4820.903581928359;4871.658983871131;4883.6093112551;4382.999999999992;4441.111777644468;4461.174682683714;4563;4586.12863555925;4487.19230538503;4566.20091483989;4573.7713114344315;4578.679492435531;4597.5172606876295;4388.71473354231;4426.667999900021;4431.8448854289945;4491.483479399878;4510.571495707903;4420.911581768379;4427.380166776654;4435.911281774379;4517.548245175489;4564.863054108382;4427.778611069466;4437.844675436377;4449.332600109977;4468.106378724236;4514.255147900592;4815.181419158752;4845.70925744453;4848.927266091011;4876.878078048042;4887.535684110004;5149.536541711264;5177.974110129463;5194.766235519411;5197.922031169535;5218.452062533455;5258.947410525884;5262.105442074818;5286.867828304285;5287.41838397776;5312.495312945264;4755.310479980383;4760.6429517785955;4779.617630589614;4786.593139583105;4910.459849416561;5300.602454815904;5308.973455132699;5335;5342.278792362981;5342.759575819097;5034.244863270465;5076.923846142311;5087.949120508822;5090.389153301628;5129.076766182123;5124.615653825978;5160.354955630546;5179.585633149339;5181;5191.532762051358;5171.663841850343;5179.2749015137915;5185.455527169668;5229.320188375486;5248.160294352885;5156.819511317086;5160.329157209539;5166.095933211673;5168.147255702842;5232.215167724872;4297.39836422901;4337.6963612546815;4377.759223242752;4402;4416.072624748775;3832.7508711934192;3836.616338366141;3878.2825177342283;3880.1463677990796;3905.336092864163;4461.420015397977;4463.285874260103;4494.977525112419;4497.775111244425;4548.4541854977615;5061.468545802712;5184.896302074013;5205.141151709925;5237.8428647140645;5310.468953104736;4468.4414448193975;4485.48416932057;4541.886452838639;4543.068670922453;4545.136424079415;4703;4709.576138147515;4711.340412342275;4712.081144176921;4766.976165119152;4679.227927391942;4727.598154156935;4737.763111844463;4881.8535443936735;4897.9510204898925;5169.974150129226;5206.375234971828;5209.505097015777;5233.502817232356;5295.973520132375;4825.638077144298;4885.389326334208;4885.95114048855;4896.143174944442;4929.507049295042;4978.029284289529;5080.644354895122;5106.565941894981;5119.769610367617;5160.458151893997;5267.2889159962915;5271.578273738169;5274.050670879278;5278.102722537101;5325.7070861101465;5040.6219533534395;5048.3941926969;5052.747362631781;5054;5108.642395032312;4942.332785073969;4987.451380348086;5002.074616196015;5044.571211447068;5051.924221136759;4889.63327750413;4947.851564453073;4961.08219979305;5001.599872010303;5007.949920500749;5036.974815125901;5069.569086627531;5080.618953578422;5118.360204974379;5171.3018742469285;4806.399200099988;4936.358273424576;4944.381952255968;4986.650934434555;5002.924956125734 19:03:26 INFO - PROCESS | 17432 | |1;ext.html;548.7146683724463;550.9393966663666;555.4251349852904;563.8139413993382;573.5325709546717;33652.495212571834;38049;38104.42843357352;38158.42762358563;38167.427488587695;39307.606923930754;39875.800620996924;40001.79999100001;40114.59885401145;40391.19217615646;7317.41460683144;7593.658285377143;7605.695772169107;7633.5419874807685;7655.617219139049;7614.847703045935;7676.692932282702;7725.304722574967;7744.845103097935;7751.844963100734;7715.8071048223965;7758.6896524138965;7766.883496747553;7775.533467991911;7780.533168009909;7692.730754423596;7693.576853273068;7725.6523456444875;7731.149573546905;7770.184130666312;7662.808429789244;7729.07251129868;7739.806504837367;7756.069271687377;7769.067711874554;37202.023838092886;37380;37551.624483755084;37803.4329485058;37824.05439863998;2624.8031397645254;2645.8941642334476;2697.986510067457;2761.226856480189;3226.9189821409623;28410.715892841014;28654.426911461862;28896.27759306013;28914.27714307138;29525;2941.4117176564773;2951.2031751427207;2961.896333628334;2984.925376865574;3028.651705053925;241246;241315;241501;241507;243264;51941.7402912983;52212.21681674778;52286.73856630692;52300;52367.73816130895;28982.42035159327;29564.852175738983;29634.110976670734;55757.44242557604;55866;12311.4459849307;12600.81098783519;12622.179558328678;12663.493460261487;12746.107772456024;10656.307340022873;10709.839352409721;10712.46437678113;10713.142948564097;10750.516226769814;18059.367922122663;18137;18247;18310.81689183118;18316.908415457838;6725.63009034498;6867.802303262908;6872.896906546406;6915;7175;742.5804420502399;888.8800011998297;889.4485419040236;934.0985948559672;945.9148676619137;27030.864845675645;28117.297067573476;29086.272843178667;29760.2559935999;30933.989290696034;856.2037305306001;894.9418287811271;900.5542256582902;927.3045216087934;929.3076657889916;14697.26513674312;15054.322555485029;15205.847941520664;15300.770488442682;15365.615859603377;394697;394962;398044;398472;398932;48478.27282590764;48571.271430928566;48582;48844;48997.75501122543;1079.8488211650376;1125.5272785430138;1128.0918860317688;1134.325076579434;1138.4649214868998;26127.216183513763;26901.461970760083;27812.44375112527;28468;28611.13471738247;42773;43352.56647433485;43354.56645433632;43372.783136084116;43377.783111085504;321207;323744;324634;325066;325244;24908.252752417455;25093;25332.240032799047;25481.745182547937;25496.872515637304;40639.593604064765;41211.587884120774;41430.792846035576;41502.377464338664;42008.789956051245;34921.47617785786;36093.0976725584;36508.63491365052;36655;36665;35728.64271357357;36269.27461450809;36418.03825512052;36480.63519364772;37331.253374932894;34836.477452837724;35753.82123089368;35856.820715897295;36323.63676363308;36622.8168859154;30872.382552349278;32689.836550818047;33099.66900331062;33204;33282;25126.748732512442;25147.87426062858;25303.493930121662;25351.112711055026;25624.871875640503 19:03:26 INFO - PROCESS | 17432 | |2;jquery.html;335.9395308844407;346.71915748243924;346.75726991106217;346.82658670664665;376.33201068104114;15970.361185552578;16664.500064998054;17814.376496822613;17935.551611209725;18135.546611334725;15970.76043859343;16084.437044703409;16698;17081.14594270288;17322.56693582661;4878.780454879539;5128.307678463416;5133.82031628893;5133.871653208681;5138.229265610151;3712.851485940559;5028.044671512419;5122.974385128069;5669.9433005670035;5913.379095195007;5977.282726072877;5979.22270104888;5983.341832398432;5984.461398474136;5986.910196347058;4975.2039673652225;5211.45279745627;5240.580753539708;5312.893742125136;5983.1025346197985;5115.258287548322;5122.564582010534;5123.948760512421;5137.537621614036;5140.820071297524;11086.889131108746;11123.55505779768;11406.600768973047;11476.196666233367;11499.712507187303;1948.6589846776758;1996.7104769808298;2305.976940230593;2332.521833024243;2365;8322.292605128572;8413;8545.401821872472;8570.957145214297;11410.771784564346;1723.913804309792;1727.464486009341;1728.5332960100827;1761.4539492757285;1821.4918225801548;62912;66635.66682166558;67541.66229168871;68099.31900681028;68243;9784.853227201598;10049.69850904474;10050.849237261447;10240.64157754475;10258.897411025944;13389.598312050653;13441.46234150623;13509.59471215865;13529.526466573623;13567.25380104084;6626.56927299724;6983.89524157138;7086.858262834818;7231.240719724458;7253;6650.800475985729;6664.366885145903;6823.624700641512;6885.345892140339;6903.792886213421;4097.262492751273;4207.915841683149;4243.957560424418;4338.58783415575;4405.052913623586;1633.4364644197733;1633.8121116071566;1663.7753903223152;1719.9226034828462;1783.6700210461106;737.3179808676953;783.122902349361;805.279275048828;818.4598165210932;872.7076429396224;15274.77087843661;16440.917795411187;16639;16902.154892255337;17482;775.2518819339365;797.2067792546453;805.3195050182703;825.6037102190862;852.4203541591653;8879.644814207359;9581.185599224144;9615.471149086727;9686.128248457673;9688.273379496424;370898;371236;371607;372695;373199;71512;74556.25443745601;76624.23375766282;76995.23004769992;77198.61400692961;847.1909326593088;869.3740506835195;883.0727735877304;884.2704768565959;885.455444901381;14409.351579179172;14769.630759231106;15672.92163539175;15893.966892151973;16475.752863706814;34458.483122752674;36167.45748813823;37666;39143.41284880786;40170.1965960685;49145.262821057;51718;51999.220011700614;52461.7376913113;53170.202446962554;6293.433590976834;6485.77299794505;6559.967200163968;6767.593944363354;7028.9648551758955;8463.957680211559;11827.704307392383;12080.335581543099;12100;12424.316662583644;10314.226433017404;10373.26410515766;10410.1671866249;10417;10970.670879873298;10248.333858299187;10302.536385862804;10330.638427654996;10369.63706270307;10383.428911409945;10463.58145674195;10566.577336906437;10578.947105264424;10689.51897164614;10881.401522916316;6412.583182093149;6425.518086143465;6660.100886380276;7036.331548502884;7317.817054573678;8967.417117887317;10589.92634002941;10599.311044782064;10680.359178449318;11172.60342457193 19:03:26 INFO - PROCESS | 17432 | |3;mootools.html;1358.911670741402;1405.7539930512162;1483.1175450606886;1666.6166781640216;1684.9241784119713;6482.902756458657;7262.128544574658;7322.816929576763;7710.267524585162;7722.420818438619;7535.660895259713;7649.770506884803;7661.272179142987;7671.6547755351;7704.730334438295;2193.1008286602496;2220.0675716199153;2221.8224341099244;2222.0445208560313;2230.888455577223;2130.137294395772;2154.9030293636747;2164.6861205125247;2167.729033870766;2170.8263338932848;2152.763196048433;2169.739631244253;2174.195547647365;2181.5745929543746;2184.126349460221;2140.646793279107;2144.4317255927035;2144.731908511436;2146.785321467856;2153.9784602153936;2107.2519255664324;2144.7533533643673;2146.527763891941;2149.1940522304135;2152.3435352217566;7484.588347640877;7534.660940257701;7656.3874890008665;7659.923400765977;7676.654550545239;4430.977845110786;4522.7286362818;4530.116627257686;4533.184026875161;4543.931841022388;2808.5365914624062;2877.84171870547;2884.2212602597183;2913.1988703106604;2957.9260518486994;847.5804476783969;899.4198741811495;906.1618003346944;911.813078318943;934.1685899549407;10187.54156062979;10194.286399952007;10220.744481388025;10284.640037598723;10286.27996040285;3820.331441997639;3910.589388114264;4079.204555111725;4110.506739191316;4119.032027473541;8660.826783464296;8672.739817805475;8685.002449436664;8751.56242187888;8766.868496972551;4428.623566996777;4496.033352829092;4499.662525310549;4514.074614703978;4527.388802511618;3605.2428989912414;3970.68234541236;4070.287699652549;4118.485189351331;4121.62905338521;3562.750607457453;3587.982060089683;3670.834812433447;3681.5333726402837;3718.6467285607823;1186.1993154620598;1202.852907560001;1207.8067509198486;1211.8000529912465;1222.7921253386946;629.2386212682613;718.3678363040491;744.9366803821628;746.8842329438945;767.3745897093851;4710.69380490267;4794.976025119852;4884.36244428012;4916.8770780730765;4950.430700469492;360.59253044060046;384.34661076170624;389.43920754113987;390.5937824662376;391.5282085087463;3311.3542859142235;3321.285923526405;3345.6654334566347;3381.188514756441;3425.646869486539;8907.287417006624;9425.858612120825;9459.24326053914;9485.193758530464;9501.477418741897;9251.352405331561;9377.999999999864;9412.95293523528;9441.669541566012;9464.95267523658;7110.537815042006;7148.606826624586;7171.497995140395;7176.210616832144;7196.388306993859;4818.71087734737;4848.466668666373;4882.755862206946;5023.321851549994;5120.257562653469;8323.875141872755;8501.404901656824;8545.401821872409;8643.82712345737;8646.265067469336;8517.531535765593;8698.130186981505;8705.8694119587;8706.216440520384;8863.601137948937;5661.858453538694;5934.940650593611;6068;6408.423241908251;6529.934700652932;6798.626075565891;6803.965980170067;6809.761658341934;6830.59016459014;6870.3473170048765;6196.318404975539;6296.370362963667;6420.229572451336;6422.325655806073;6507.12153859223;6222.751089956351;6235.407636274546;6264.154339164154;6295.307516173126;6318.241810982711;5768.451997060272;5854.531637469077;5855.736491857791;5856.267966504187;5884.823455296348;4410.514843367163;4453.977730111329;4503.189425903369;4543.818966895975;4545.318202269554;4393.780310984374;4434.977825110854;4455.910881782411;4485.349624304523;4507.188706032945 19:03:26 INFO - PROCESS | 17432 | |4;prototype.html;270.31610026632626;270.52657848764665;276.34230531335425;277.3842070603261;279.5415518549578;5052.469490703478;5060.924086138711;5073.746312684365;5093.7198454085055;5098.9745051274695;4931.482194369593;4941.407031156266;4958.578520825725;4964.826231081904;5019.472955339692;3903.9024024399473;3909.377608292555;3921.176552923875;3930.8034598270115;3932.115274063327;3933.6656384207236;3941.960580394188;3943.515585181346;3944.0731428114514;3962.7424217425773;3706.388445906422;3812.237552489499;3844.942325865114;3861.9613803861885;3887.669548088416;3851.9422208667033;3855.245863132268;3861.9806900965596;3864.9227015459815;3871.632194941476;3147.7324427423696;3348.2299071213756;3394.7793393429347;3399.2521645238007;3400.625931147572;4698.953010469886;4858.29554714568;4869.2957464887;4888.388951381077;4891.046245982035;4404.471463424377;4414.249577571821;4415.227335216325;4432.844850430251;4451.154280686692;5158.465224050563;5186.5850731941355;5311.167647161723;5317.229001794718;5330.413654498002;3644.16184277615;3651.8721844735305;3655.1958569114754;3662.304162209172;3684.171061511165;5464.508194262496;5469.398366179717;5474.835754927359;5547.25112109864;5582.665040097567;3760.9811950940616;3764.981175094107;3773.8490460381827;3779.7543159695083;3783.5838057813617;3511.3855075361707;3700.3154416433044;3724.4413337999517;3756.567994680592;3821.140243445258;4331.6318112960125;4338.154059958278;4342.131573685276;4360.4767427908855;4398.252297109499;5274.446183150791;5300.9734951325;5334.973325133427;5338.8932221356135;5343.129904533383;1259.4080782032431;1280.5838102616688;1281.7564662714055;1284.1396264502805;1294.210531575738;792.6670798264743;795.7824528471448;801.5992003998001;802.2338666573409;807.5719868469721;3948.309045916953;4135.441715368387;4152.91694166115;4170.395292682544;4213.683973701924;4809.831655892027;4810.8797280068275;4819.349387832668;4834.129856625841;4859.8411032828235;4138.441310423054;4162.229987452331;4191;4205.558416366238;4230.2174097792;2502.749725027519;2575.896964121414;2591.157873691058;2591.313301974978;2597.8701064947054;4537.705049171794;4864.270359446041;4944.208926571803;5074.06129865976;5085.669431486942;5535.308086489189;5571.9442805572235;5594.328680558359;5601.887962240732;5619.438056194348;4942.431620363561;5092.388913330424;5104.081265372269;5105.489451054939;5111.881752131197;5405.72971351423;5413.864653383697;5423.48142520095;5437.211604317273;5460.426655201147;5315.920261196008;5355.169948657965;5356.303680521507;5357.928414317074;5369.27514785499;4901.5588597026435;5047.924281135859;5072.4420313766195;5087.4149472811105;5095.541401273903;3656.8171591420855;3663.1391622969113;3670.596234414266;3686.9631303687693;3692.390755525308;5364.812231572032;5393.002294575516;5414.648047876875;5454.727263636882;5467.234587157881;4999.750012499288;5244.9737751310995;5248.448912864094;5288.418273989935;5288.709120998382;5234.319538459976;5246.76389562463;5248.9475105249985;5252.7898884045735;5260.395579348336;5139.280500729826;5225.895482090413;5240.921386179287;5250.711210883438;5263.841954769944;4990.4011518618;5250.976059668328;5297.894042119059;5324.387695414922;5326.98787230425;5127.794888204579;5140.948590514047;5148.227765835155;5166.664166829144;5195.92206116901 19:03:26 INFO - PROCESS | 17432 | |5;yui.html;542.8208691131925;560.8990381731287;570.7488704969816;635.4185919883308;661.8907880199764;11847.22993005454;13253.602391928258;13268.00489963253;13272.867271327284;14137.434502619883;13222.206667599927;13342.533011344605;13351.0654254202;13360.665983350422;13401.46394144233;738.8670039392907;761.4669731188163;763.5838468034907;764.4190415284396;765.8621448139332;614.9538784591151;743.8995735575683;759.6391713935891;763.1833937686649;769.3768047881206;810.2626609785096;815.9673613055501;818.2594751749676;818.3575892924056;818.6193420059672;805.3557154276556;805.6696754330726;806.0971711682894;806.5563939833069;810.1574362662824;588.6173986908501;591.7189335065852;593.0392763722754;595.4194660206308;595.9165716799652;12888.871111288954;12949.870501295054;12954.676133096653;12988.935055324662;13004;12386.009119270437;12674.683132921658;12819.35903204836;12886.969042476672;13134.146280491834;10008.39949603026;10037.447940363278;10194.796104077877;10283.48582570876;10465.110465610433;3250.9187270318193;3264.2492226787735;3294.390537750524;3326.268220991378;3331.0340001399563;68108.31891681069;70295.64852175706;70555.64722176407;71251;71851.28148718551;9419.199368053654;9435.117391455713;9849.113579777855;9940.602375904882;10201.897981020244;18503.444896653124;18520.81479185218;18526.814731852777;18585.44243672692;18649.53376165607;5699.943000569941;5926.911096333559;5951.613145145551;6030.33666296707;6217.782377616762;3620.87326943561;3719.256148770203;3737.4020156775327;3764.3600587900123;3775.6224377562025;2932.398858234057;3033.7421319187674;3038.0582019574003;3039.08827351798;3040.1031695649835;481.00672112088427;484.10440684733663;495.67780942387736;501.24812780828756;502.8943921776395;452.3215177234149;457.98327712478243;501.4884817486144;525.9027079990137;532.6697447582446;7259.782206533812;7442.702291908371;7780.727674531364;7931.325837303893;8006.239407256301;481.6989381636477;490.673701988181;501.5310684509995;504.33679711179684;514.9227615857651;3501.124718820295;3509.6139424663265;4199.328107502785;4230.513490948519;4438.822447102079;56735.43264567384;57609.711951439975;72268;99543.2250001241;100908;83975.580122099;84147.5792621033;85639.57180214184;85893.57053214694;87451;46351;75956;76017.9999999989;76592.74516077401;78145.2185478138;8157.510549367057;8544.273736732199;8578.699745508877;8789.560521974003;8822.955885220534;46866.53133468622;47773.522264776904;47916;48365;49204.01591968212;67705;69363.65318173377;70615.64692176506;70641;70649.64675176592;9926.205903527845;10491.527881245209;10728;10984.725381865197;11163.88836111661;12185.39073046362;12237.877621223673;12275.263484190977;12387.19483233587;13065.477380904656;10631.681049568526;10769.353838769699;10939.343639381663;11102.833457497982;11594.188406811441;11426.48580813882;11585;11655.592054278399;12126.211796233216;12172.208806427554;11581.420928953687;11922.105842062054;11922.105842062054;11986.101042421678;12437.564685235973;9554.235661147231;9892.901070989197;10021.203881557729;10141.477655513256;10329.32859364169;8937.865932011155;9092.725020973812;9739.659111931049;10154.238432117769;10174.745631359276 19:03:26 INFO - PROCESS | 17432 | __end_tp_report 19:03:26 INFO - PROCESS | 17432 | __start_cc_report 19:03:26 INFO - PROCESS | 17432 | _x_x_mozilla_cycle_collect,361 19:03:26 INFO - PROCESS | 17432 | __end_cc_report 19:03:26 INFO - PROCESS | 17432 | __startTimestamp1472522606588__endTimestamp 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | ------- Summary: start ------- 19:03:26 INFO - PROCESS | 17432 | Number of tests: 6 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | [#0] dojo.html Cycles:165 Average:4795.43 Median:4889.63 stddev:514.76 (10.5%) stddev-sans-first:485.19 19:03:26 INFO - PROCESS | 17432 | Values: 2547.2 2592.1 2622.5 2628.9 2656.3 4731.7 4794.1 4811.8 4835.4 4873.0 4789.5 4804.4 4820.9 4871.7 4883.6 4383.0 4441.1 4461.2 4563.0 4586.1 4487.2 4566.2 4573.8 4578.7 4597.5 4388.7 4426.7 4431.8 4491.5 4510.6 4420.9 4427.4 4435.9 4517.5 4564.9 4427.8 4437.8 4449.3 4468.1 4514.3 4815.2 4845.7 4848.9 4876.9 4887.5 5149.5 5178.0 5194.8 5197.9 5218.5 5258.9 5262.1 5286.9 5287.4 5312.5 4755.3 4760.6 4779.6 4786.6 4910.5 5300.6 5309.0 5335.0 5342.3 5342.8 5034.2 5076.9 5087.9 5090.4 5129.1 5124.6 5160.4 5179.6 5181.0 5191.5 5171.7 5179.3 5185.5 5229.3 5248.2 5156.8 5160.3 5166.1 5168.1 5232.2 4297.4 4337.7 4377.8 4402.0 4416.1 3832.8 3836.6 3878.3 3880.1 3905.3 4461.4 4463.3 4495.0 4497.8 4548.5 5061.5 5184.9 5205.1 5237.8 5310.5 4468.4 4485.5 4541.9 4543.1 4545.1 4703.0 4709.6 4711.3 4712.1 4767.0 4679.2 4727.6 4737.8 4881.9 4898.0 5170.0 5206.4 5209.5 5233.5 5296.0 4825.6 4885.4 4886.0 4896.1 4929.5 4978.0 5080.6 5106.6 5119.8 5160.5 5267.3 5271.6 5274.1 5278.1 5325.7 5040.6 5048.4 5052.7 5054.0 5108.6 4942.3 4987.5 5002.1 5044.6 5051.9 4889.6 4947.9 4961.1 5001.6 5007.9 5037.0 5069.6 5080.6 5118.4 5171.3 4806.4 4936.4 4944.4 4986.7 5002.9 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | [#1] ext.html Cycles:180 Average:46982.31 Median:36638.91 stddev:86250.95 (235.4%) stddev-sans-first:86422.44 19:03:26 INFO - PROCESS | 17432 | Values: 548.7 550.9 555.4 563.8 573.5 33652.5 38049.0 38104.4 38158.4 38167.4 39307.6 39875.8 40001.8 40114.6 40391.2 7317.4 7593.7 7605.7 7633.5 7655.6 7614.8 7676.7 7725.3 7744.8 7751.8 7715.8 7758.7 7766.9 7775.5 7780.5 7692.7 7693.6 7725.7 7731.1 7770.2 7662.8 7729.1 7739.8 7756.1 7769.1 37202.0 37380.0 37551.6 37803.4 37824.1 2624.8 2645.9 2698.0 2761.2 3226.9 28410.7 28654.4 28896.3 28914.3 29525.0 2941.4 2951.2 2961.9 2984.9 3028.7 241246.0 241315.0 241501.0 241507.0 243264.0 51941.7 52212.2 52286.7 52300.0 52367.7 28982.4 29564.9 29634.1 55757.4 55866.0 12311.4 12600.8 12622.2 12663.5 12746.1 10656.3 10709.8 10712.5 10713.1 10750.5 18059.4 18137.0 18247.0 18310.8 18316.9 6725.6 6867.8 6872.9 6915.0 7175.0 742.6 888.9 889.4 934.1 945.9 27030.9 28117.3 29086.3 29760.3 30934.0 856.2 894.9 900.6 927.3 929.3 14697.3 15054.3 15205.8 15300.8 15365.6 394697.0 394962.0 398044.0 398472.0 398932.0 48478.3 48571.3 48582.0 48844.0 48997.8 1079.8 1125.5 1128.1 1134.3 1138.5 26127.2 26901.5 27812.4 28468.0 28611.1 42773.0 43352.6 43354.6 43372.8 43377.8 321207.0 323744.0 324634.0 325066.0 325244.0 24908.3 25093.0 25332.2 25481.7 25496.9 40639.6 41211.6 41430.8 41502.4 42008.8 34921.5 36093.1 36508.6 36655.0 36665.0 35728.6 36269.3 36418.0 36480.6 37331.3 34836.5 35753.8 35856.8 36323.6 36622.8 30872.4 32689.8 33099.7 33204.0 33282.0 25126.7 25147.9 25303.5 25351.1 25624.9 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | [#2] jquery.html Cycles:180 Average:23399.39 Median:4225.94 stddev:61510.11 (1455.5%) stddev-sans-first:61658.29 19:03:26 INFO - PROCESS | 17432 | Values: 335.9 346.7 346.8 346.8 376.3 15970.4 16664.5 17814.4 17935.6 18135.5 15970.8 16084.4 16698.0 17081.1 17322.6 4878.8 5128.3 5133.8 5133.9 5138.2 3712.9 5028.0 5123.0 5669.9 5913.4 5977.3 5979.2 5983.3 5984.5 5986.9 4975.2 5211.5 5240.6 5312.9 5983.1 5115.3 5122.6 5123.9 5137.5 5140.8 11086.9 11123.6 11406.6 11476.2 11499.7 1948.7 1996.7 2306.0 2332.5 2365.0 8322.3 8413.0 8545.4 8571.0 11410.8 1723.9 1727.5 1728.5 1761.5 1821.5 62912.0 66635.7 67541.7 68099.3 68243.0 9784.9 10049.7 10050.8 10240.6 10258.9 13389.6 13441.5 13509.6 13529.5 13567.3 6626.6 6983.9 7086.9 7231.2 7253.0 6650.8 6664.4 6823.6 6885.3 6903.8 4097.3 4207.9 4244.0 4338.6 4405.1 1633.4 1633.8 1663.8 1719.9 1783.7 737.3 783.1 805.3 818.5 872.7 15274.8 16440.9 16639.0 16902.2 17482.0 775.3 797.2 805.3 825.6 852.4 8879.6 9581.2 9615.5 9686.1 9688.3 370898.0 371236.0 371607.0 372695.0 373199.0 71512.0 74556.3 76624.2 76995.2 77198.6 847.2 869.4 883.1 884.3 885.5 14409.4 14769.6 15672.9 15894.0 16475.8 34458.5 36167.5 37666.0 39143.4 40170.2 49145.3 51718.0 51999.2 52461.7 53170.2 6293.4 6485.8 6560.0 6767.6 7029.0 8464.0 11827.7 12080.3 12100.0 12424.3 10314.2 10373.3 10410.2 10417.0 10970.7 10248.3 10302.5 10330.6 10369.6 10383.4 10463.6 10566.6 10578.9 10689.5 10881.4 6412.6 6425.5 6660.1 7036.3 7317.8 8967.4 10589.9 10599.3 10680.4 11172.6 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | [#3] mootools.html Cycles:180 Average:4923.07 Median:4752.83 stddev:2764.13 (58.2%) stddev-sans-first:2758.91 19:03:26 INFO - PROCESS | 17432 | Values: 1358.9 1405.8 1483.1 1666.6 1684.9 6482.9 7262.1 7322.8 7710.3 7722.4 7535.7 7649.8 7661.3 7671.7 7704.7 2193.1 2220.1 2221.8 2222.0 2230.9 2130.1 2154.9 2164.7 2167.7 2170.8 2152.8 2169.7 2174.2 2181.6 2184.1 2140.6 2144.4 2144.7 2146.8 2154.0 2107.3 2144.8 2146.5 2149.2 2152.3 7484.6 7534.7 7656.4 7659.9 7676.7 4431.0 4522.7 4530.1 4533.2 4543.9 2808.5 2877.8 2884.2 2913.2 2957.9 847.6 899.4 906.2 911.8 934.2 10187.5 10194.3 10220.7 10284.6 10286.3 3820.3 3910.6 4079.2 4110.5 4119.0 8660.8 8672.7 8685.0 8751.6 8766.9 4428.6 4496.0 4499.7 4514.1 4527.4 3605.2 3970.7 4070.3 4118.5 4121.6 3562.8 3588.0 3670.8 3681.5 3718.6 1186.2 1202.9 1207.8 1211.8 1222.8 629.2 718.4 744.9 746.9 767.4 4710.7 4795.0 4884.4 4916.9 4950.4 360.6 384.3 389.4 390.6 391.5 3311.4 3321.3 3345.7 3381.2 3425.6 8907.3 9425.9 9459.2 9485.2 9501.5 9251.4 9378.0 9413.0 9441.7 9465.0 7110.5 7148.6 7171.5 7176.2 7196.4 4818.7 4848.5 4882.8 5023.3 5120.3 8323.9 8501.4 8545.4 8643.8 8646.3 8517.5 8698.1 8705.9 8706.2 8863.6 5661.9 5934.9 6068.0 6408.4 6529.9 6798.6 6804.0 6809.8 6830.6 6870.3 6196.3 6296.4 6420.2 6422.3 6507.1 6222.8 6235.4 6264.2 6295.3 6318.2 5768.5 5854.5 5855.7 5856.3 5884.8 4410.5 4454.0 4503.2 4543.8 4545.3 4393.8 4435.0 4455.9 4485.3 4507.2 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | [#4] prototype.html Cycles:180 Average:4288.34 Median:4889.72 stddev:1292.68 (26.4%) stddev-sans-first:1260.63 19:03:26 INFO - PROCESS | 17432 | Values: 270.3 270.5 276.3 277.4 279.5 5052.5 5060.9 5073.7 5093.7 5099.0 4931.5 4941.4 4958.6 4964.8 5019.5 3903.9 3909.4 3921.2 3930.8 3932.1 3933.7 3942.0 3943.5 3944.1 3962.7 3706.4 3812.2 3844.9 3862.0 3887.7 3851.9 3855.2 3862.0 3864.9 3871.6 3147.7 3348.2 3394.8 3399.3 3400.6 4699.0 4858.3 4869.3 4888.4 4891.0 4404.5 4414.2 4415.2 4432.8 4451.2 5158.5 5186.6 5311.2 5317.2 5330.4 3644.2 3651.9 3655.2 3662.3 3684.2 5464.5 5469.4 5474.8 5547.3 5582.7 3761.0 3765.0 3773.8 3779.8 3783.6 3511.4 3700.3 3724.4 3756.6 3821.1 4331.6 4338.2 4342.1 4360.5 4398.3 5274.4 5301.0 5335.0 5338.9 5343.1 1259.4 1280.6 1281.8 1284.1 1294.2 792.7 795.8 801.6 802.2 807.6 3948.3 4135.4 4152.9 4170.4 4213.7 4809.8 4810.9 4819.3 4834.1 4859.8 4138.4 4162.2 4191.0 4205.6 4230.2 2502.7 2575.9 2591.2 2591.3 2597.9 4537.7 4864.3 4944.2 5074.1 5085.7 5535.3 5571.9 5594.3 5601.9 5619.4 4942.4 5092.4 5104.1 5105.5 5111.9 5405.7 5413.9 5423.5 5437.2 5460.4 5315.9 5355.2 5356.3 5357.9 5369.3 4901.6 5047.9 5072.4 5087.4 5095.5 3656.8 3663.1 3670.6 3687.0 3692.4 5364.8 5393.0 5414.6 5454.7 5467.2 4999.8 5245.0 5248.4 5288.4 5288.7 5234.3 5246.8 5248.9 5252.8 5260.4 5139.3 5225.9 5240.9 5250.7 5263.8 4990.4 5251.0 5297.9 5324.4 5327.0 5127.8 5140.9 5148.2 5166.7 5195.9 19:03:26 INFO - PROCESS | 17432 | 19:03:26 INFO - PROCESS | 17432 | [#5] yui.html Cycles:180 Average:17553.40 Median:487.39 stddev:24881.33 (5105.0%) stddev-sans-first:24918.34 19:03:26 INFO - PROCESS | 17432 | Values: 542.8 560.9 570.7 635.4 661.9 11847.2 13253.6 13268.0 13272.9 14137.4 13222.2 13342.5 13351.1 13360.7 13401.5 738.9 761.5 763.6 764.4 765.9 615.0 743.9 759.6 763.2 769.4 810.3 816.0 818.3 818.4 818.6 805.4 805.7 806.1 806.6 810.2 588.6 591.7 593.0 595.4 595.9 12888.9 12949.9 12954.7 12988.9 13004.0 12386.0 12674.7 12819.4 12887.0 13134.1 10008.4 10037.4 10194.8 10283.5 10465.1 3250.9 3264.2 3294.4 3326.3 3331.0 68108.3 70295.6 70555.6 71251.0 71851.3 9419.2 9435.1 9849.1 9940.6 10201.9 18503.4 18520.8 18526.8 18585.4 18649.5 5699.9 5926.9 5951.6 6030.3 6217.8 3620.9 3719.3 3737.4 3764.4 3775.6 2932.4 3033.7 3038.1 3039.1 3040.1 481.0 484.1 495.7 501.2 502.9 452.3 458.0 501.5 525.9 532.7 7259.8 7442.7 7780.7 7931.3 8006.2 481.7 490.7 501.5 504.3 514.9 3501.1 3509.6 4199.3 4230.5 4438.8 56735.4 57609.7 72268.0 99543.2 100908.0 83975.6 84147.6 85639.6 85893.6 87451.0 46351.0 75956.0 76018.0 76592.7 78145.2 8157.5 8544.3 8578.7 8789.6 8823.0 46866.5 47773.5 47916.0 48365.0 49204.0 67705.0 69363.7 70615.6 70641.0 70649.6 9926.2 10491.5 10728.0 10984.7 11163.9 12185.4 12237.9 12275.3 12387.2 13065.5 10631.7 10769.4 10939.3 11102.8 11594.2 11426.5 11585.0 11655.6 12126.2 12172.2 11581.4 11922.1 11922.1 11986.1 12437.6 9554.2 9892.9 10021.2 10141.5 10329.3 8937.9 9092.7 9739.7 10154.2 10174.7 19:03:26 INFO - PROCESS | 17432 | -------- Summary: end -------- 19:03:26 INFO - PROCESS | 17432 | 19:03:27 INFO - TEST-INFO | 17432: exit 0 19:03:27 INFO - TEST-OK | dromaeo_css | took 1118555ms 19:03:27 INFO - TEST-START | kraken 19:03:27 INFO - operating with platform_type : linux_ 19:03:27 INFO - Initialising browser for kraken test... 19:03:27 INFO - TEST-INFO | started process 17792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ0YTzS/profile http://localhost:40852/getInfo.html) 19:03:32 INFO - PROCESS | 17792 | __metrics Screen width/height:1600/1200 19:03:32 INFO - PROCESS | 17792 | colorDepth:24 19:03:32 INFO - PROCESS | 17792 | Browser inner width/height: 1024/697 19:03:32 INFO - PROCESS | 17792 | __metrics 19:03:32 ERROR - PROCESS | 17792 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 19:03:33 INFO - TEST-INFO | 17792: exit 0 19:03:33 INFO - Browser initialized. 19:03:33 INFO - Running cycle 1/1 for kraken test... 19:03:33 INFO - TEST-INFO | started process 17909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ0YTzS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:46 INFO - PROCESS | 17909 | RSS: Main: 192884736 19:03:46 INFO - PROCESS | 17909 | 19:03:49 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40852/tests/kraken/driver.html?testName=audio-beat-detection) 19:03:50 INFO - PROCESS | 17909 | RSS: Main: 205271040 19:03:50 INFO - PROCESS | 17909 | 19:03:52 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40852/tests/kraken/driver.html?testName=audio-dft) 19:03:53 INFO - PROCESS | 17909 | RSS: Main: 204906496 19:03:53 INFO - PROCESS | 17909 | 19:03:56 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40852/tests/kraken/driver.html?testName=audio-fft) 19:03:57 INFO - PROCESS | 17909 | RSS: Main: 197279744 19:03:57 INFO - PROCESS | 17909 | 19:03:59 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40852/tests/kraken/driver.html?testName=audio-oscillator) 19:03:59 INFO - PROCESS | 17909 | RSS: Main: 197791744 19:03:59 INFO - PROCESS | 17909 | 19:04:02 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40852/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:02 INFO - PROCESS | 17909 | RSS: Main: 197824512 19:04:02 INFO - PROCESS | 17909 | 19:04:05 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40852/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:06 INFO - PROCESS | 17909 | RSS: Main: 198148096 19:04:06 INFO - PROCESS | 17909 | 19:04:10 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40852/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:10 INFO - PROCESS | 17909 | RSS: Main: 195375104 19:04:10 INFO - PROCESS | 17909 | 19:04:13 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40852/tests/kraken/driver.html?testName=json-parse-financial) 19:04:14 INFO - PROCESS | 17909 | RSS: Main: 197320704 19:04:14 INFO - PROCESS | 17909 | 19:04:16 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40852/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:16 INFO - PROCESS | 17909 | RSS: Main: 197447680 19:04:16 INFO - PROCESS | 17909 | 19:04:18 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:19 INFO - PROCESS | 17909 | RSS: Main: 197279744 19:04:19 INFO - PROCESS | 17909 | 19:04:21 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:22 INFO - PROCESS | 17909 | RSS: Main: 198279168 19:04:22 INFO - PROCESS | 17909 | 19:04:25 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:25 INFO - PROCESS | 17909 | RSS: Main: 198258688 19:04:25 INFO - PROCESS | 17909 | 19:04:28 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:29 INFO - PROCESS | 17909 | RSS: Main: 198131712 19:04:29 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | Cycle 1(1): loaded http://localhost:40852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40852/tests/kraken/driver.html?testName=ai-astar) 19:04:31 INFO - PROCESS | 17909 | RSS: Main: 201072640 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | __start_tp_report 19:04:31 INFO - PROCESS | 17909 | _x_x_mozilla_page_load 19:04:31 INFO - PROCESS | 17909 | _x_x_mozilla_page_load_details 19:04:31 INFO - PROCESS | 17909 | |i|pagename|runs| 19:04:31 INFO - PROCESS | 17909 | |0;ai-astar;112;116;117;115;124;117;116;117;116;133 19:04:31 INFO - PROCESS | 17909 | |1;audio-beat-detection;160;126;152;193;131;155;151;131;183;130 19:04:31 INFO - PROCESS | 17909 | |2;audio-dft;166;171;165;163;163;166;164;168;171;165 19:04:31 INFO - PROCESS | 17909 | |3;audio-fft;77;77;77;180;77;77;76;77;162;78 19:04:31 INFO - PROCESS | 17909 | |4;audio-oscillator;85;85;147;90;86;86;132;83;83;137 19:04:31 INFO - PROCESS | 17909 | |5;imaging-gaussian-blur;117;118;118;119;118;118;119;118;118;118 19:04:31 INFO - PROCESS | 17909 | |6;imaging-darkroom;150;150;147;148;148;148;149;148;148;150 19:04:31 INFO - PROCESS | 17909 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;97;96 19:04:31 INFO - PROCESS | 17909 | |8;json-parse-financial;65;67;66;67;69;72;69;67;68;65 19:04:31 INFO - PROCESS | 17909 | |9;json-stringify-tinderbox;67;67;67;67;68;67;66;67;68;67 19:04:31 INFO - PROCESS | 17909 | |10;stanford-crypto-aes;87;94;83;83;83;84;82;89;88;84 19:04:31 INFO - PROCESS | 17909 | |11;stanford-crypto-ccm;140;136;140;133;132;136;147;147;174;136 19:04:31 INFO - PROCESS | 17909 | |12;stanford-crypto-pbkdf2;174;179;172;180;178;170;177;172;176;172 19:04:31 INFO - PROCESS | 17909 | |13;stanford-crypto-sha256-iterative;73;72;70;69;73;71;70;70;68;68 19:04:31 INFO - PROCESS | 17909 | __end_tp_report 19:04:31 INFO - PROCESS | 17909 | __start_cc_report 19:04:31 INFO - PROCESS | 17909 | _x_x_mozilla_cycle_collect,903 19:04:31 INFO - PROCESS | 17909 | __end_cc_report 19:04:31 INFO - PROCESS | 17909 | __startTimestamp1472522671443__endTimestamp 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | ------- Summary: start ------- 19:04:31 INFO - PROCESS | 17909 | Number of tests: 14 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#0] ai-astar Cycles:10 Average:118.30 Median:117.00 stddev:5.96 (5.1%) stddev-sans-first:5.87 19:04:31 INFO - PROCESS | 17909 | Values: 112.0 116.0 117.0 115.0 124.0 117.0 116.0 117.0 116.0 133.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:153.50 stddev:22.98 (15.0%) stddev-sans-first:24.15 19:04:31 INFO - PROCESS | 17909 | Values: 160.0 126.0 152.0 193.0 131.0 155.0 151.0 131.0 183.0 130.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:2.94 (1.8%) stddev-sans-first:3.11 19:04:31 INFO - PROCESS | 17909 | Values: 166.0 171.0 165.0 163.0 163.0 166.0 164.0 168.0 171.0 165.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#3] audio-fft Cycles:10 Average:95.80 Median:77.00 stddev:39.86 (51.8%) stddev-sans-first:41.70 19:04:31 INFO - PROCESS | 17909 | Values: 77.0 77.0 77.0 180.0 77.0 77.0 76.0 77.0 162.0 78.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:85.00 stddev:26.04 (30.6%) stddev-sans-first:26.93 19:04:31 INFO - PROCESS | 17909 | Values: 85.0 85.0 147.0 90.0 86.0 86.0 132.0 83.0 83.0 137.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 19:04:31 INFO - PROCESS | 17909 | Values: 117.0 118.0 118.0 119.0 118.0 118.0 119.0 118.0 118.0 118.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 19:04:31 INFO - PROCESS | 17909 | Values: 150.0 150.0 147.0 148.0 148.0 148.0 149.0 148.0 148.0 150.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:04:31 INFO - PROCESS | 17909 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.50 stddev:2.12 (3.1%) stddev-sans-first:2.05 19:04:31 INFO - PROCESS | 17909 | Values: 65.0 67.0 66.0 67.0 69.0 72.0 69.0 67.0 68.0 65.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 19:04:31 INFO - PROCESS | 17909 | Values: 67.0 67.0 67.0 67.0 68.0 67.0 66.0 67.0 68.0 67.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:3.77 (4.4%) stddev-sans-first:3.97 19:04:31 INFO - PROCESS | 17909 | Values: 87.0 94.0 83.0 83.0 83.0 84.0 82.0 89.0 88.0 84.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:140.00 stddev:12.34 (8.8%) stddev-sans-first:13.07 19:04:31 INFO - PROCESS | 17909 | Values: 140.0 136.0 140.0 133.0 132.0 136.0 147.0 147.0 174.0 136.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.50 stddev:3.46 (2.0%) stddev-sans-first:3.66 19:04:31 INFO - PROCESS | 17909 | Values: 174.0 179.0 172.0 180.0 178.0 170.0 177.0 172.0 176.0 172.0 19:04:31 INFO - PROCESS | 17909 | 19:04:31 INFO - PROCESS | 17909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.84 (2.6%) stddev-sans-first:1.69 19:04:31 INFO - PROCESS | 17909 | Values: 73.0 72.0 70.0 69.0 73.0 71.0 70.0 70.0 68.0 68.0 19:04:31 INFO - PROCESS | 17909 | -------- Summary: end -------- 19:04:31 INFO - PROCESS | 17909 | 19:04:32 INFO - TEST-INFO | 17909: exit 0 19:04:32 INFO - TEST-OK | kraken | took 65025ms 19:04:32 INFO - SUITE-END | took 1183s 19:04:33 INFO - Completed test suite (00:19:43) 19:04:33 INFO - javascript benchmark 19:04:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6293.850871152488, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2547.1849008317336, 2592.1445922845464, 2622.5017246723132, 2628.947421051579, 2656.3359160209934, 4731.692439991398, 4794.113089078519, 4811.807527698892, 4835.371401717776, 4872.975635121828, 4789.497102804207, 4804.375431193948, 4820.903581928359, 4871.658983871131, 4883.6093112551, 4382.999999999992, 4441.111777644468, 4461.174682683714, 4563.0, 4586.12863555925, 4487.19230538503, 4566.20091483989, 4573.7713114344315, 4578.679492435531, 4597.5172606876295, 4388.71473354231, 4426.667999900021, 4431.8448854289945, 4491.483479399878, 4510.571495707903, 4420.911581768379, 4427.380166776654, 4435.911281774379, 4517.548245175489, 4564.863054108382, 4427.778611069466, 4437.844675436377, 4449.332600109977, 4468.106378724236, 4514.255147900592, 4815.181419158752, 4845.70925744453, 4848.927266091011, 4876.878078048042, 4887.535684110004, 5149.536541711264, 5177.974110129463, 5194.766235519411, 5197.922031169535, 5218.452062533455, 5258.947410525884, 5262.105442074818, 5286.867828304285, 5287.41838397776, 5312.495312945264, 4755.310479980383, 4760.6429517785955, 4779.617630589614, 4786.593139583105, 4910.459849416561, 5300.602454815904, 5308.973455132699, 5335.0, 5342.278792362981, 5342.759575819097, 5034.244863270465, 5076.923846142311, 5087.949120508822, 5090.389153301628, 5129.076766182123, 5124.615653825978, 5160.354955630546, 5179.585633149339, 5181.0, 5191.532762051358, 5171.663841850343, 5179.2749015137915, 5185.455527169668, 5229.320188375486, 5248.160294352885, 5156.819511317086, 5160.329157209539, 5166.095933211673, 5168.147255702842, 5232.215167724872, 4297.39836422901, 4337.6963612546815, 4377.759223242752, 4402.0, 4416.072624748775, 3832.7508711934192, 3836.616338366141, 3878.2825177342283, 3880.1463677990796, 3905.336092864163, 4461.420015397977, 4463.285874260103, 4494.977525112419, 4497.775111244425, 4548.4541854977615, 5061.468545802712, 5184.896302074013, 5205.141151709925, 5237.8428647140645, 5310.468953104736, 4468.4414448193975, 4485.48416932057, 4541.886452838639, 4543.068670922453, 4545.136424079415, 4703.0, 4709.576138147515, 4711.340412342275, 4712.081144176921, 4766.976165119152, 4679.227927391942, 4727.598154156935, 4737.763111844463, 4881.8535443936735, 4897.9510204898925, 5169.974150129226, 5206.375234971828, 5209.505097015777, 5233.502817232356, 5295.973520132375, 4825.638077144298, 4885.389326334208, 4885.95114048855, 4896.143174944442, 4929.507049295042, 4978.029284289529, 5080.644354895122, 5106.565941894981, 5119.769610367617, 5160.458151893997, 5267.2889159962915, 5271.578273738169, 5274.050670879278, 5278.102722537101, 5325.7070861101465, 5040.6219533534395, 5048.3941926969, 5052.747362631781, 5054.0, 5108.642395032312, 4942.332785073969, 4987.451380348086, 5002.074616196015, 5044.571211447068, 5051.924221136759, 4889.63327750413, 4947.851564453073, 4961.08219979305, 5001.599872010303, 5007.949920500749, 5036.974815125901, 5069.569086627531, 5080.618953578422, 5118.360204974379, 5171.3018742469285, 4806.399200099988, 4936.358273424576, 4944.381952255968, 4986.650934434555, 5002.924956125734], "value": 4761.03253015484, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7146683724463, 550.9393966663666, 555.4251349852904, 563.8139413993382, 573.5325709546717, 33652.495212571834, 38049.0, 38104.42843357352, 38158.42762358563, 38167.427488587695, 39307.606923930754, 39875.800620996924, 40001.79999100001, 40114.59885401145, 40391.19217615646, 7317.41460683144, 7593.658285377143, 7605.695772169107, 7633.5419874807685, 7655.617219139049, 7614.847703045935, 7676.692932282702, 7725.304722574967, 7744.845103097935, 7751.844963100734, 7715.8071048223965, 7758.6896524138965, 7766.883496747553, 7775.533467991911, 7780.533168009909, 7692.730754423596, 7693.576853273068, 7725.6523456444875, 7731.149573546905, 7770.184130666312, 7662.808429789244, 7729.07251129868, 7739.806504837367, 7756.069271687377, 7769.067711874554, 37202.023838092886, 37380.0, 37551.624483755084, 37803.4329485058, 37824.05439863998, 2624.8031397645254, 2645.8941642334476, 2697.986510067457, 2761.226856480189, 3226.9189821409623, 28410.715892841014, 28654.426911461862, 28896.27759306013, 28914.27714307138, 29525.0, 2941.4117176564773, 2951.2031751427207, 2961.896333628334, 2984.925376865574, 3028.651705053925, 241246.0, 241315.0, 241501.0, 241507.0, 243264.0, 51941.7402912983, 52212.21681674778, 52286.73856630692, 52300.0, 52367.73816130895, 28982.42035159327, 29564.852175738983, 29634.110976670734, 55757.44242557604, 55866.0, 12311.4459849307, 12600.81098783519, 12622.179558328678, 12663.493460261487, 12746.107772456024, 10656.307340022873, 10709.839352409721, 10712.46437678113, 10713.142948564097, 10750.516226769814, 18059.367922122663, 18137.0, 18247.0, 18310.81689183118, 18316.908415457838, 6725.63009034498, 6867.802303262908, 6872.896906546406, 6915.0, 7175.0, 742.5804420502399, 888.8800011998297, 889.4485419040236, 934.0985948559672, 945.9148676619137, 27030.864845675645, 28117.297067573476, 29086.272843178667, 29760.2559935999, 30933.989290696034, 856.2037305306001, 894.9418287811271, 900.5542256582902, 927.3045216087934, 929.3076657889916, 14697.26513674312, 15054.322555485029, 15205.847941520664, 15300.770488442682, 15365.615859603377, 394697.0, 394962.0, 398044.0, 398472.0, 398932.0, 48478.27282590764, 48571.271430928566, 48582.0, 48844.0, 48997.75501122543, 1079.8488211650376, 1125.5272785430138, 1128.0918860317688, 1134.325076579434, 1138.4649214868998, 26127.216183513763, 26901.461970760083, 27812.44375112527, 28468.0, 28611.13471738247, 42773.0, 43352.56647433485, 43354.56645433632, 43372.783136084116, 43377.783111085504, 321207.0, 323744.0, 324634.0, 325066.0, 325244.0, 24908.252752417455, 25093.0, 25332.240032799047, 25481.745182547937, 25496.872515637304, 40639.593604064765, 41211.587884120774, 41430.792846035576, 41502.377464338664, 42008.789956051245, 34921.47617785786, 36093.0976725584, 36508.63491365052, 36655.0, 36665.0, 35728.64271357357, 36269.27461450809, 36418.03825512052, 36480.63519364772, 37331.253374932894, 34836.477452837724, 35753.82123089368, 35856.820715897295, 36323.63676363308, 36622.8168859154, 30872.382552349278, 32689.836550818047, 33099.66900331062, 33204.0, 33282.0, 25126.748732512442, 25147.87426062858, 25303.493930121662, 25351.112711055026, 25624.871875640503], "value": 17020.315843708544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.9395308844407, 346.71915748243924, 346.75726991106217, 346.82658670664665, 376.33201068104114, 15970.361185552578, 16664.500064998054, 17814.376496822613, 17935.551611209725, 18135.546611334725, 15970.76043859343, 16084.437044703409, 16698.0, 17081.14594270288, 17322.56693582661, 4878.780454879539, 5128.307678463416, 5133.82031628893, 5133.871653208681, 5138.229265610151, 3712.851485940559, 5028.044671512419, 5122.974385128069, 5669.9433005670035, 5913.379095195007, 5977.282726072877, 5979.22270104888, 5983.341832398432, 5984.461398474136, 5986.910196347058, 4975.2039673652225, 5211.45279745627, 5240.580753539708, 5312.893742125136, 5983.1025346197985, 5115.258287548322, 5122.564582010534, 5123.948760512421, 5137.537621614036, 5140.820071297524, 11086.889131108746, 11123.55505779768, 11406.600768973047, 11476.196666233367, 11499.712507187303, 1948.6589846776758, 1996.7104769808298, 2305.976940230593, 2332.521833024243, 2365.0, 8322.292605128572, 8413.0, 8545.401821872472, 8570.957145214297, 11410.771784564346, 1723.913804309792, 1727.464486009341, 1728.5332960100827, 1761.4539492757285, 1821.4918225801548, 62912.0, 66635.66682166558, 67541.66229168871, 68099.31900681028, 68243.0, 9784.853227201598, 10049.69850904474, 10050.849237261447, 10240.64157754475, 10258.897411025944, 13389.598312050653, 13441.46234150623, 13509.59471215865, 13529.526466573623, 13567.25380104084, 6626.56927299724, 6983.89524157138, 7086.858262834818, 7231.240719724458, 7253.0, 6650.800475985729, 6664.366885145903, 6823.624700641512, 6885.345892140339, 6903.792886213421, 4097.262492751273, 4207.915841683149, 4243.957560424418, 4338.58783415575, 4405.052913623586, 1633.4364644197733, 1633.8121116071566, 1663.7753903223152, 1719.9226034828462, 1783.6700210461106, 737.3179808676953, 783.122902349361, 805.279275048828, 818.4598165210932, 872.7076429396224, 15274.77087843661, 16440.917795411187, 16639.0, 16902.154892255337, 17482.0, 775.2518819339365, 797.2067792546453, 805.3195050182703, 825.6037102190862, 852.4203541591653, 8879.644814207359, 9581.185599224144, 9615.471149086727, 9686.128248457673, 9688.273379496424, 370898.0, 371236.0, 371607.0, 372695.0, 373199.0, 71512.0, 74556.25443745601, 76624.23375766282, 76995.23004769992, 77198.61400692961, 847.1909326593088, 869.3740506835195, 883.0727735877304, 884.2704768565959, 885.455444901381, 14409.351579179172, 14769.630759231106, 15672.92163539175, 15893.966892151973, 16475.752863706814, 34458.483122752674, 36167.45748813823, 37666.0, 39143.41284880786, 40170.1965960685, 49145.262821057, 51718.0, 51999.220011700614, 52461.7376913113, 53170.202446962554, 6293.433590976834, 6485.77299794505, 6559.967200163968, 6767.593944363354, 7028.9648551758955, 8463.957680211559, 11827.704307392383, 12080.335581543099, 12100.0, 12424.316662583644, 10314.226433017404, 10373.26410515766, 10410.1671866249, 10417.0, 10970.670879873298, 10248.333858299187, 10302.536385862804, 10330.638427654996, 10369.63706270307, 10383.428911409945, 10463.58145674195, 10566.577336906437, 10578.947105264424, 10689.51897164614, 10881.401522916316, 6412.583182093149, 6425.518086143465, 6660.100886380276, 7036.331548502884, 7317.817054573678, 8967.417117887317, 10589.92634002941, 10599.311044782064, 10680.359178449318, 11172.60342457193], "value": 7935.186352839328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.911670741402, 1405.7539930512162, 1483.1175450606886, 1666.6166781640216, 1684.9241784119713, 6482.902756458657, 7262.128544574658, 7322.816929576763, 7710.267524585162, 7722.420818438619, 7535.660895259713, 7649.770506884803, 7661.272179142987, 7671.6547755351, 7704.730334438295, 2193.1008286602496, 2220.0675716199153, 2221.8224341099244, 2222.0445208560313, 2230.888455577223, 2130.137294395772, 2154.9030293636747, 2164.6861205125247, 2167.729033870766, 2170.8263338932848, 2152.763196048433, 2169.739631244253, 2174.195547647365, 2181.5745929543746, 2184.126349460221, 2140.646793279107, 2144.4317255927035, 2144.731908511436, 2146.785321467856, 2153.9784602153936, 2107.2519255664324, 2144.7533533643673, 2146.527763891941, 2149.1940522304135, 2152.3435352217566, 7484.588347640877, 7534.660940257701, 7656.3874890008665, 7659.923400765977, 7676.654550545239, 4430.977845110786, 4522.7286362818, 4530.116627257686, 4533.184026875161, 4543.931841022388, 2808.5365914624062, 2877.84171870547, 2884.2212602597183, 2913.1988703106604, 2957.9260518486994, 847.5804476783969, 899.4198741811495, 906.1618003346944, 911.813078318943, 934.1685899549407, 10187.54156062979, 10194.286399952007, 10220.744481388025, 10284.640037598723, 10286.27996040285, 3820.331441997639, 3910.589388114264, 4079.204555111725, 4110.506739191316, 4119.032027473541, 8660.826783464296, 8672.739817805475, 8685.002449436664, 8751.56242187888, 8766.868496972551, 4428.623566996777, 4496.033352829092, 4499.662525310549, 4514.074614703978, 4527.388802511618, 3605.2428989912414, 3970.68234541236, 4070.287699652549, 4118.485189351331, 4121.62905338521, 3562.750607457453, 3587.982060089683, 3670.834812433447, 3681.5333726402837, 3718.6467285607823, 1186.1993154620598, 1202.852907560001, 1207.8067509198486, 1211.8000529912465, 1222.7921253386946, 629.2386212682613, 718.3678363040491, 744.9366803821628, 746.8842329438945, 767.3745897093851, 4710.69380490267, 4794.976025119852, 4884.36244428012, 4916.8770780730765, 4950.430700469492, 360.59253044060046, 384.34661076170624, 389.43920754113987, 390.5937824662376, 391.5282085087463, 3311.3542859142235, 3321.285923526405, 3345.6654334566347, 3381.188514756441, 3425.646869486539, 8907.287417006624, 9425.858612120825, 9459.24326053914, 9485.193758530464, 9501.477418741897, 9251.352405331561, 9377.999999999864, 9412.95293523528, 9441.669541566012, 9464.95267523658, 7110.537815042006, 7148.606826624586, 7171.497995140395, 7176.210616832144, 7196.388306993859, 4818.71087734737, 4848.466668666373, 4882.755862206946, 5023.321851549994, 5120.257562653469, 8323.875141872755, 8501.404901656824, 8545.401821872409, 8643.82712345737, 8646.265067469336, 8517.531535765593, 8698.130186981505, 8705.8694119587, 8706.216440520384, 8863.601137948937, 5661.858453538694, 5934.940650593611, 6068.0, 6408.423241908251, 6529.934700652932, 6798.626075565891, 6803.965980170067, 6809.761658341934, 6830.59016459014, 6870.3473170048765, 6196.318404975539, 6296.370362963667, 6420.229572451336, 6422.325655806073, 6507.12153859223, 6222.751089956351, 6235.407636274546, 6264.154339164154, 6295.307516173126, 6318.241810982711, 5768.451997060272, 5854.531637469077, 5855.736491857791, 5856.267966504187, 5884.823455296348, 4410.514843367163, 4453.977730111329, 4503.189425903369, 4543.818966895975, 4545.318202269554, 4393.780310984374, 4434.977825110854, 4455.910881782411, 4485.349624304523, 4507.188706032945], "value": 3908.8280897590544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.31610026632626, 270.52657848764665, 276.34230531335425, 277.3842070603261, 279.5415518549578, 5052.469490703478, 5060.924086138711, 5073.746312684365, 5093.7198454085055, 5098.9745051274695, 4931.482194369593, 4941.407031156266, 4958.578520825725, 4964.826231081904, 5019.472955339692, 3903.9024024399473, 3909.377608292555, 3921.176552923875, 3930.8034598270115, 3932.115274063327, 3933.6656384207236, 3941.960580394188, 3943.515585181346, 3944.0731428114514, 3962.7424217425773, 3706.388445906422, 3812.237552489499, 3844.942325865114, 3861.9613803861885, 3887.669548088416, 3851.9422208667033, 3855.245863132268, 3861.9806900965596, 3864.9227015459815, 3871.632194941476, 3147.7324427423696, 3348.2299071213756, 3394.7793393429347, 3399.2521645238007, 3400.625931147572, 4698.953010469886, 4858.29554714568, 4869.2957464887, 4888.388951381077, 4891.046245982035, 4404.471463424377, 4414.249577571821, 4415.227335216325, 4432.844850430251, 4451.154280686692, 5158.465224050563, 5186.5850731941355, 5311.167647161723, 5317.229001794718, 5330.413654498002, 3644.16184277615, 3651.8721844735305, 3655.1958569114754, 3662.304162209172, 3684.171061511165, 5464.508194262496, 5469.398366179717, 5474.835754927359, 5547.25112109864, 5582.665040097567, 3760.9811950940616, 3764.981175094107, 3773.8490460381827, 3779.7543159695083, 3783.5838057813617, 3511.3855075361707, 3700.3154416433044, 3724.4413337999517, 3756.567994680592, 3821.140243445258, 4331.6318112960125, 4338.154059958278, 4342.131573685276, 4360.4767427908855, 4398.252297109499, 5274.446183150791, 5300.9734951325, 5334.973325133427, 5338.8932221356135, 5343.129904533383, 1259.4080782032431, 1280.5838102616688, 1281.7564662714055, 1284.1396264502805, 1294.210531575738, 792.6670798264743, 795.7824528471448, 801.5992003998001, 802.2338666573409, 807.5719868469721, 3948.309045916953, 4135.441715368387, 4152.91694166115, 4170.395292682544, 4213.683973701924, 4809.831655892027, 4810.8797280068275, 4819.349387832668, 4834.129856625841, 4859.8411032828235, 4138.441310423054, 4162.229987452331, 4191.0, 4205.558416366238, 4230.2174097792, 2502.749725027519, 2575.896964121414, 2591.157873691058, 2591.313301974978, 2597.8701064947054, 4537.705049171794, 4864.270359446041, 4944.208926571803, 5074.06129865976, 5085.669431486942, 5535.308086489189, 5571.9442805572235, 5594.328680558359, 5601.887962240732, 5619.438056194348, 4942.431620363561, 5092.388913330424, 5104.081265372269, 5105.489451054939, 5111.881752131197, 5405.72971351423, 5413.864653383697, 5423.48142520095, 5437.211604317273, 5460.426655201147, 5315.920261196008, 5355.169948657965, 5356.303680521507, 5357.928414317074, 5369.27514785499, 4901.5588597026435, 5047.924281135859, 5072.4420313766195, 5087.4149472811105, 5095.541401273903, 3656.8171591420855, 3663.1391622969113, 3670.596234414266, 3686.9631303687693, 3692.390755525308, 5364.812231572032, 5393.002294575516, 5414.648047876875, 5454.727263636882, 5467.234587157881, 4999.750012499288, 5244.9737751310995, 5248.448912864094, 5288.418273989935, 5288.709120998382, 5234.319538459976, 5246.76389562463, 5248.9475105249985, 5252.7898884045735, 5260.395579348336, 5139.280500729826, 5225.895482090413, 5240.921386179287, 5250.711210883438, 5263.841954769944, 4990.4011518618, 5250.976059668328, 5297.894042119059, 5324.387695414922, 5326.98787230425, 5127.794888204579, 5140.948590514047, 5148.227765835155, 5166.664166829144, 5195.92206116901], "value": 3861.916160062135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.8208691131925, 560.8990381731287, 570.7488704969816, 635.4185919883308, 661.8907880199764, 11847.22993005454, 13253.602391928258, 13268.00489963253, 13272.867271327284, 14137.434502619883, 13222.206667599927, 13342.533011344605, 13351.0654254202, 13360.665983350422, 13401.46394144233, 738.8670039392907, 761.4669731188163, 763.5838468034907, 764.4190415284396, 765.8621448139332, 614.9538784591151, 743.8995735575683, 759.6391713935891, 763.1833937686649, 769.3768047881206, 810.2626609785096, 815.9673613055501, 818.2594751749676, 818.3575892924056, 818.6193420059672, 805.3557154276556, 805.6696754330726, 806.0971711682894, 806.5563939833069, 810.1574362662824, 588.6173986908501, 591.7189335065852, 593.0392763722754, 595.4194660206308, 595.9165716799652, 12888.871111288954, 12949.870501295054, 12954.676133096653, 12988.935055324662, 13004.0, 12386.009119270437, 12674.683132921658, 12819.35903204836, 12886.969042476672, 13134.146280491834, 10008.39949603026, 10037.447940363278, 10194.796104077877, 10283.48582570876, 10465.110465610433, 3250.9187270318193, 3264.2492226787735, 3294.390537750524, 3326.268220991378, 3331.0340001399563, 68108.31891681069, 70295.64852175706, 70555.64722176407, 71251.0, 71851.28148718551, 9419.199368053654, 9435.117391455713, 9849.113579777855, 9940.602375904882, 10201.897981020244, 18503.444896653124, 18520.81479185218, 18526.814731852777, 18585.44243672692, 18649.53376165607, 5699.943000569941, 5926.911096333559, 5951.613145145551, 6030.33666296707, 6217.782377616762, 3620.87326943561, 3719.256148770203, 3737.4020156775327, 3764.3600587900123, 3775.6224377562025, 2932.398858234057, 3033.7421319187674, 3038.0582019574003, 3039.08827351798, 3040.1031695649835, 481.00672112088427, 484.10440684733663, 495.67780942387736, 501.24812780828756, 502.8943921776395, 452.3215177234149, 457.98327712478243, 501.4884817486144, 525.9027079990137, 532.6697447582446, 7259.782206533812, 7442.702291908371, 7780.727674531364, 7931.325837303893, 8006.239407256301, 481.6989381636477, 490.673701988181, 501.5310684509995, 504.33679711179684, 514.9227615857651, 3501.124718820295, 3509.6139424663265, 4199.328107502785, 4230.513490948519, 4438.822447102079, 56735.43264567384, 57609.711951439975, 72268.0, 99543.2250001241, 100908.0, 83975.580122099, 84147.5792621033, 85639.57180214184, 85893.57053214694, 87451.0, 46351.0, 75956.0, 76017.9999999989, 76592.74516077401, 78145.2185478138, 8157.510549367057, 8544.273736732199, 8578.699745508877, 8789.560521974003, 8822.955885220534, 46866.53133468622, 47773.522264776904, 47916.0, 48365.0, 49204.01591968212, 67705.0, 69363.65318173377, 70615.64692176506, 70641.0, 70649.64675176592, 9926.205903527845, 10491.527881245209, 10728.0, 10984.725381865197, 11163.88836111661, 12185.39073046362, 12237.877621223673, 12275.263484190977, 12387.19483233587, 13065.477380904656, 10631.681049568526, 10769.353838769699, 10939.343639381663, 11102.833457497982, 11594.188406811441, 11426.48580813882, 11585.0, 11655.592054278399, 12126.211796233216, 12172.208806427554, 11581.420928953687, 11922.105842062054, 11922.105842062054, 11986.101042421678, 12437.564685235973, 9554.235661147231, 9892.901070989197, 10021.203881557729, 10141.477655513256, 10329.32859364169, 8937.865932011155, 9092.725020973812, 9739.659111931049, 10154.238432117769, 10174.745631359276], "value": 6402.8681997092035, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 117.0, 115.0, 124.0, 117.0, 116.0, 117.0, 116.0, 133.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 152.0, 193.0, 131.0, 155.0, 151.0, 131.0, 183.0, 130.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 165.0, 163.0, 163.0, 166.0, 164.0, 168.0, 171.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 180.0, 77.0, 77.0, 76.0, 77.0, 162.0, 78.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 90.0, 86.0, 86.0, 132.0, 83.0, 83.0, 137.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 150.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 69.0, 72.0, 69.0, 67.0, 68.0, 65.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 94.0, 83.0, 83.0, 83.0, 84.0, 82.0, 89.0, 88.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 140.0, 133.0, 132.0, 136.0, 147.0, 147.0, 174.0, 136.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 172.0, 180.0, 178.0, 170.0, 177.0, 172.0, 176.0, 172.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 70.0, 69.0, 73.0, 71.0, 70.0, 70.0, 68.0, 68.0], "value": 70.4, "unit": "score"}]}]} 19:04:33 INFO - Return code: 0 19:04:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:04:33 ERROR - # TBPL SUCCESS # 19:04:33 INFO - Running post-action listener: _resource_record_post_action 19:04:33 INFO - [mozharness: 2016-08-30 02:04:33.279357Z] Finished run-tests step (success) 19:04:33 INFO - Running post-run listener: _resource_record_post_run 19:04:33 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418299904; Read time: 4; Write time: 374888 19:04:33 INFO - TinderboxPrint: CPU usage
13.4% 19:04:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 19:04:33 INFO - TinderboxPrint: I/O write bytes / time
418,299,904 / 374,888 19:04:33 INFO - TinderboxPrint: CPU idle
8,283.1 (86.5%) 19:04:33 INFO - TinderboxPrint: CPU user
1,225.3 (12.8%) 19:04:33 INFO - TinderboxPrint: Swap in / out
0 / 0 19:04:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125014016; Read time: 0; Write time: 104136 19:04:33 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 292700160; Read time: 0; Write time: 270704 19:04:33 INFO - Running post-run listener: _upload_blobber_files 19:04:33 INFO - Blob upload gear active. 19:04:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:04:33 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:04:33 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:04:33 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:04:34 INFO - (blobuploader) - INFO - Open directory for files ... 19:04:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:04:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:04:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:35 INFO - (blobuploader) - INFO - Done attempting. 19:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:04:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:35 INFO - (blobuploader) - INFO - Done attempting. 19:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:04:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:40 INFO - (blobuploader) - INFO - Done attempting. 19:04:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:04:40 INFO - Return code: 0 19:04:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:04:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:04:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa2d6fd4f15684474bb254f5e7273d6668cffd809abad081e3f8406f526d0d0060d991a833754f01cded675a08d979077f6f034d31521e10e62edc936bc9b169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/964d39da1702c928ebb6959245d6e95ecac19001060d7d09daa1cbf7582b59962c4c069773dba29ffdede035357f206b106a726fe2b31ddad6ac5724ea56dc4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0e52f8ed6d888837e7cce76081298bf6964217422bbbf861021f6b2606781674a0469ac7305cb84a5b756c348142dd6864473a9aff2e30473b43afbefca687"} 19:04:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:04:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:04:40 INFO - Contents: 19:04:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa2d6fd4f15684474bb254f5e7273d6668cffd809abad081e3f8406f526d0d0060d991a833754f01cded675a08d979077f6f034d31521e10e62edc936bc9b169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/964d39da1702c928ebb6959245d6e95ecac19001060d7d09daa1cbf7582b59962c4c069773dba29ffdede035357f206b106a726fe2b31ddad6ac5724ea56dc4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0e52f8ed6d888837e7cce76081298bf6964217422bbbf861021f6b2606781674a0469ac7305cb84a5b756c348142dd6864473a9aff2e30473b43afbefca687"} 19:04:40 INFO - Running post-run listener: copy_logs_to_upload_dir 19:04:40 INFO - Copying logs to upload dir... 19:04:40 INFO - mkdir: /builds/slave/test/build/upload/logs 19:04:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.071175 ========= master_lag: 35.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-29 19:05:15.427468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 19:05:15.432186) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665 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/fa2d6fd4f15684474bb254f5e7273d6668cffd809abad081e3f8406f526d0d0060d991a833754f01cded675a08d979077f6f034d31521e10e62edc936bc9b169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/964d39da1702c928ebb6959245d6e95ecac19001060d7d09daa1cbf7582b59962c4c069773dba29ffdede035357f206b106a726fe2b31ddad6ac5724ea56dc4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0e52f8ed6d888837e7cce76081298bf6964217422bbbf861021f6b2606781674a0469ac7305cb84a5b756c348142dd6864473a9aff2e30473b43afbefca687"} build_url:https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/H1ZrjPmkSvG9XeEowLypcA/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/fa2d6fd4f15684474bb254f5e7273d6668cffd809abad081e3f8406f526d0d0060d991a833754f01cded675a08d979077f6f034d31521e10e62edc936bc9b169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/964d39da1702c928ebb6959245d6e95ecac19001060d7d09daa1cbf7582b59962c4c069773dba29ffdede035357f206b106a726fe2b31ddad6ac5724ea56dc4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d0e52f8ed6d888837e7cce76081298bf6964217422bbbf861021f6b2606781674a0469ac7305cb84a5b756c348142dd6864473a9aff2e30473b43afbefca687"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 19:05:15.519245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-29 19:05:15.519670) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472520815.74647-54176665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 3.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-29 19:05:18.536670) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-08-29 19:05:18.537052) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-08-29 19:05:20.559918) ========= ========= Total master_lag: 38.67 =========