builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1470397557.52 results: success (0) buildid: 20160805030444 builduid: fe7cb5cae3594b2ab093ea67739b408d revision: d320ef56876f52db9bc0eb79554c7332d4793769 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.517724) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.518260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.518583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.543304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.543797) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 04:45:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-05 04:45:57 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.645062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.645425) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018500 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:57.703424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 04:45:57.703776) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d320ef56876f52db9bc0eb79554c7332d4793769 --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 d320ef56876f52db9bc0eb79554c7332d4793769 --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=31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 04:45:58,047 truncating revision to first 12 chars 2016-08-05 04:45:58,047 Setting DEBUG logging. 2016-08-05 04:45:58,047 attempt 1/10 2016-08-05 04:45:58,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d320ef56876f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 04:45:59,268 unpacking tar archive at: mozilla-central-d320ef56876f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572285 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 04:45:59.304399) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:59.304714) ========= script_repo_revision: d320ef56876f52db9bc0eb79554c7332d4793769 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:59.305113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:59.305414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 04:45:59.314402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-05 04:45:59.314723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:59 INFO - MultiFileLogger online at 20160805 04:45:59 in /builds/slave/test 04:45:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:45:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:59 INFO - {'append_to_log': False, 04:45:59 INFO - 'base_work_dir': '/builds/slave/test', 04:45:59 INFO - 'blob_upload_branch': 'Firefox', 04:45:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:59 INFO - 'branch': 'Firefox', 04:45:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:59 INFO - 'config_files': ('talos/linux_config.py',), 04:45:59 INFO - 'default_actions': ('clobber', 04:45:59 INFO - 'read-buildbot-config', 04:45:59 INFO - 'download-and-extract', 04:45:59 INFO - 'populate-webroot', 04:45:59 INFO - 'create-virtualenv', 04:45:59 INFO - 'install', 04:45:59 INFO - 'run-tests'), 04:45:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:59 INFO - 'download_minidump_stackwalk': True, 04:45:59 INFO - 'download_symbols': 'ondemand', 04:45:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:59 INFO - 'installer_path': 'installer.exe', 04:45:59 INFO - 'log_level': 'info', 04:45:59 INFO - 'log_name': 'talos', 04:45:59 INFO - 'log_to_console': True, 04:45:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:59 INFO - 'opt_config_files': (), 04:45:59 INFO - 'pip_index': False, 04:45:59 INFO - 'sps_profile': False, 04:45:59 INFO - 'sps_profile_interval': 0, 04:45:59 INFO - 'suite': 'dromaeojs', 04:45:59 INFO - 'system_bits': '32', 04:45:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:59 INFO - 'title': 'talos-linux64-ix-014', 04:45:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:59 INFO - 'use_talos_json': True, 04:45:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:59 INFO - 'work_dir': 'build'} 04:45:59 INFO - [mozharness: 2016-08-05 11:45:59.727481Z] Running clobber step. 04:45:59 INFO - Running pre-action listener: _resource_record_pre_action 04:45:59 INFO - Running main action method: clobber 04:45:59 INFO - rmtree: /builds/slave/test/build 04:45:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:00 INFO - Running post-action listener: _resource_record_post_action 04:46:00 INFO - [mozharness: 2016-08-05 11:46:00.183482Z] Finished clobber step (success) 04:46:00 INFO - [mozharness: 2016-08-05 11:46:00.183582Z] Running read-buildbot-config step. 04:46:00 INFO - Running pre-action listener: _resource_record_pre_action 04:46:00 INFO - Running main action method: read_buildbot_config 04:46:00 INFO - Using buildbot properties: 04:46:00 INFO - { 04:46:00 INFO - "project": "", 04:46:00 INFO - "product": "firefox", 04:46:00 INFO - "script_repo_revision": "production", 04:46:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:46:00 INFO - "repository": "", 04:46:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:46:00 INFO - "buildid": "20160805030444", 04:46:00 INFO - "stage_platform": "linux64-pgo", 04:46:00 INFO - "basedir": "/builds/slave/test", 04:46:00 INFO - "nightly_build": "True", 04:46:00 INFO - "buildnumber": 824, 04:46:00 INFO - "slavename": "talos-linux64-ix-014", 04:46:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:46:00 INFO - "platform": "ubuntu64_hw", 04:46:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:46:00 INFO - "branch": "mozilla-central", 04:46:00 INFO - "repo_path": "mozilla-central", 04:46:00 INFO - "revision": "d320ef56876f52db9bc0eb79554c7332d4793769", 04:46:00 INFO - "pgo_build": "True", 04:46:00 INFO - "builduid": "fe7cb5cae3594b2ab093ea67739b408d", 04:46:00 INFO - "slavebuilddir": "test" 04:46:00 INFO - } 04:46:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:46:00 INFO - Running post-action listener: _resource_record_post_action 04:46:00 INFO - [mozharness: 2016-08-05 11:46:00.186108Z] Finished read-buildbot-config step (success) 04:46:00 INFO - [mozharness: 2016-08-05 11:46:00.186197Z] Running download-and-extract step. 04:46:00 INFO - Running pre-action listener: _resource_record_pre_action 04:46:00 INFO - Running main action method: download_and_extract 04:46:00 INFO - mkdir: /builds/slave/test/build/tests 04:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:00 INFO - trying https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:46:00 INFO - Downloading https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:00 INFO - Downloaded 1361 bytes. 04:46:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:46:00 INFO - Using the following test package requirements: 04:46:00 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'jsshell-linux-x86_64.zip'], 04:46:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:00 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:00 INFO - trying https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:46:00 INFO - Downloading https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:01 INFO - Downloaded 21825493 bytes. 04:46:01 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 04:46:05 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 04:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:05 INFO - trying https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:46:05 INFO - Downloading https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:06 INFO - Downloaded 21825493 bytes. 04:46:06 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 04:46:11 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')]} 04:46:11 INFO - trying https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:11 INFO - Downloading https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:12 INFO - Downloaded 14413723 bytes. 04:46:12 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 04:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:12 INFO - trying https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:46:12 INFO - Downloading https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/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 04:46:14 INFO - Downloaded 59373469 bytes. 04:46:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:46:14 INFO - mkdir: /builds/slave/test/properties 04:46:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:14 INFO - Contents: 04:46:14 INFO - build_url:https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:46:14 INFO - Running post-action listener: _resource_record_post_action 04:46:14 INFO - Running post-action listener: set_extra_try_arguments 04:46:14 INFO - [mozharness: 2016-08-05 11:46:14.826786Z] Finished download-and-extract step (success) 04:46:14 INFO - [mozharness: 2016-08-05 11:46:14.827009Z] Running populate-webroot step. 04:46:14 INFO - Running pre-action listener: _resource_record_pre_action 04:46:14 INFO - Running main action method: populate_webroot 04:46:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:14 INFO - '--tppagecycles', 04:46:14 INFO - '7'], 04:46:14 INFO - 'tests': ['tsvgm']}}, 04:46:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['damp', 'tps']}, 04:46:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'tests': ['damp', 'tps']}, 04:46:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['dromaeo_dom']}, 04:46:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['basic_compositor_video']}, 04:46:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['a11yr', 04:46:14 INFO - 'ts_paint', 04:46:14 INFO - 'tpaint', 04:46:14 INFO - 'sessionrestore', 04:46:14 INFO - 'sessionrestore_no_auto_restore', 04:46:14 INFO - 'tabpaint']}, 04:46:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:14 INFO - 'ts_paint', 04:46:14 INFO - 'tpaint', 04:46:14 INFO - 'sessionrestore', 04:46:14 INFO - 'sessionrestore_no_auto_restore', 04:46:14 INFO - 'tabpaint']}, 04:46:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:14 INFO - 'ts_paint', 04:46:14 INFO - 'tpaint', 04:46:14 INFO - 'sessionrestore', 04:46:14 INFO - 'sessionrestore_no_auto_restore', 04:46:14 INFO - 'tabpaint']}, 04:46:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:14 INFO - 'ts_paint', 04:46:14 INFO - 'tpaint', 04:46:14 INFO - 'sessionrestore', 04:46:14 INFO - 'sessionrestore_no_auto_restore', 04:46:14 INFO - 'tabpaint']}, 04:46:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['a11yr', 04:46:14 INFO - 'ts_paint', 04:46:14 INFO - 'tpaint', 04:46:14 INFO - 'sessionrestore', 04:46:14 INFO - 'sessionrestore_no_auto_restore', 04:46:14 INFO - 'tabpaint']}, 04:46:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['a11yr', 04:46:14 INFO - 'ts_paint', 04:46:14 INFO - 'tpaint', 04:46:14 INFO - 'sessionrestore', 04:46:14 INFO - 'sessionrestore_no_auto_restore', 04:46:14 INFO - 'tabpaint']}, 04:46:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['tsvgx', 04:46:14 INFO - 'tsvgr_opacity', 04:46:14 INFO - 'tart', 04:46:14 INFO - 'tscrollx', 04:46:14 INFO - 'cart']}, 04:46:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:14 INFO - 'tsvgr_opacity', 04:46:14 INFO - 'tart', 04:46:14 INFO - 'tscrollx', 04:46:14 INFO - 'cart']}, 04:46:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'talos_options': ['--disable-e10s'], 04:46:14 INFO - 'tests': ['tp5o']}, 04:46:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'tests': ['tp5o']}, 04:46:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'talos_options': ['--disable-e10s', 04:46:14 INFO - '--xperf_path', 04:46:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:14 INFO - 'tests': ['tp5n']}, 04:46:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:14 INFO - 'talos_options': ['--xperf_path', 04:46:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:14 INFO - 'tests': ['tp5n']}}, 04:46:14 INFO - 'talos.zip': {'path': '', 04:46:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:14 INFO - Running post-action listener: _resource_record_post_action 04:46:14 INFO - [mozharness: 2016-08-05 11:46:14.844370Z] Finished populate-webroot step (success) 04:46:14 INFO - [mozharness: 2016-08-05 11:46:14.844459Z] Running create-virtualenv step. 04:46:14 INFO - Running pre-action listener: _resource_record_pre_action 04:46:14 INFO - Running main action method: create_virtualenv 04:46:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:14 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 04:46:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:14 INFO - Using real prefix '/usr' 04:46:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:15 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:17 INFO - Installing pip.................done. 04:46:17 INFO - Return code: 0 04:46:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:17 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')]} 04:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:17 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')]} 04:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:17 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:17 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 04:46:17 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 04:46:17 INFO - Using env: {'DISPLAY': ':0', 04:46:17 INFO - 'HOME': '/home/cltbld', 04:46:17 INFO - 'LANG': 'en_US.UTF-8', 04:46:17 INFO - 'LANGUAGE': 'en_US:en', 04:46:17 INFO - 'LOGNAME': 'cltbld', 04:46:17 INFO - 'MAIL': '/var/mail/cltbld', 04:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:17 INFO - 'MOZ_NO_REMOTE': '1', 04:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:17 INFO - 'NO_EM_RESTART': '1', 04:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:17 INFO - 'PWD': '/builds/slave/test', 04:46:17 INFO - 'SHELL': '/bin/bash', 04:46:17 INFO - 'SHLVL': '1', 04:46:17 INFO - 'TERM': 'linux', 04:46:17 INFO - 'TMOUT': '86400', 04:46:17 INFO - 'USER': 'cltbld', 04:46:17 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:17 INFO - '_': '/tools/buildbot/bin/python'} 04:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:17 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 04:46:17 INFO - Cleaning up... 04:46:17 INFO - Return code: 0 04:46:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:17 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')]} 04:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:17 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')]} 04:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:17 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:17 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 04:46:17 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 04:46:17 INFO - Using env: {'DISPLAY': ':0', 04:46:17 INFO - 'HOME': '/home/cltbld', 04:46:17 INFO - 'LANG': 'en_US.UTF-8', 04:46:17 INFO - 'LANGUAGE': 'en_US:en', 04:46:17 INFO - 'LOGNAME': 'cltbld', 04:46:17 INFO - 'MAIL': '/var/mail/cltbld', 04:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:17 INFO - 'MOZ_NO_REMOTE': '1', 04:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:17 INFO - 'NO_EM_RESTART': '1', 04:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:17 INFO - 'PWD': '/builds/slave/test', 04:46:17 INFO - 'SHELL': '/bin/bash', 04:46:17 INFO - 'SHLVL': '1', 04:46:17 INFO - 'TERM': 'linux', 04:46:17 INFO - 'TMOUT': '86400', 04:46:17 INFO - 'USER': 'cltbld', 04:46:17 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:17 INFO - '_': '/tools/buildbot/bin/python'} 04:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:17 INFO - Downloading/unpacking psutil>=3.1.1 04:46:17 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 04:46:17 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 04:46:17 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 04:46:17 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 04:46:17 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 04:46:17 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 04:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:19 INFO - Installing collected packages: psutil 04:46:19 INFO - Running setup.py install for psutil 04:46:19 INFO - building 'psutil._psutil_linux' extension 04:46:19 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 04:46:20 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 04:46:20 INFO - building 'psutil._psutil_posix' extension 04:46:20 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 04:46:20 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 04:46:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:20 INFO - Successfully installed psutil 04:46:20 INFO - Cleaning up... 04:46:20 INFO - Return code: 0 04:46:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:46: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 mozsystemmonitor==0.3 04:46:20 INFO - Using env: {'DISPLAY': ':0', 04:46:20 INFO - 'HOME': '/home/cltbld', 04:46:20 INFO - 'LANG': 'en_US.UTF-8', 04:46:20 INFO - 'LANGUAGE': 'en_US:en', 04:46:20 INFO - 'LOGNAME': 'cltbld', 04:46:20 INFO - 'MAIL': '/var/mail/cltbld', 04:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:20 INFO - 'MOZ_NO_REMOTE': '1', 04:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:20 INFO - 'NO_EM_RESTART': '1', 04:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:20 INFO - 'PWD': '/builds/slave/test', 04:46:20 INFO - 'SHELL': '/bin/bash', 04:46:20 INFO - 'SHLVL': '1', 04:46:20 INFO - 'TERM': 'linux', 04:46:20 INFO - 'TMOUT': '86400', 04:46:20 INFO - 'USER': 'cltbld', 04:46:20 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:20 INFO - '_': '/tools/buildbot/bin/python'} 04:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:22 INFO - Installing collected packages: mozsystemmonitor 04:46:22 INFO - Running setup.py install for mozsystemmonitor 04:46:22 INFO - Successfully installed mozsystemmonitor 04:46:22 INFO - Cleaning up... 04:46:22 INFO - Return code: 0 04:46:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:22 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:22 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 04:46:22 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 04:46:22 INFO - Using env: {'DISPLAY': ':0', 04:46:22 INFO - 'HOME': '/home/cltbld', 04:46:22 INFO - 'LANG': 'en_US.UTF-8', 04:46:22 INFO - 'LANGUAGE': 'en_US:en', 04:46:22 INFO - 'LOGNAME': 'cltbld', 04:46:22 INFO - 'MAIL': '/var/mail/cltbld', 04:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:22 INFO - 'MOZ_NO_REMOTE': '1', 04:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:22 INFO - 'NO_EM_RESTART': '1', 04:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:22 INFO - 'PWD': '/builds/slave/test', 04:46:22 INFO - 'SHELL': '/bin/bash', 04:46:22 INFO - 'SHLVL': '1', 04:46:22 INFO - 'TERM': 'linux', 04:46:22 INFO - 'TMOUT': '86400', 04:46:22 INFO - 'USER': 'cltbld', 04:46:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:22 INFO - '_': '/tools/buildbot/bin/python'} 04:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:22 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:22 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 04:46:22 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 04:46:22 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 04:46:22 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 04:46:22 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 04:46:22 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 04:46:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:25 INFO - warning: no files found matching '*.txt' 04:46:25 INFO - no previously-included directories found matching 'build' 04:46:25 INFO - no previously-included directories found matching 'dist' 04:46:25 INFO - no previously-included directories found matching '.git*' 04:46:25 INFO - Installing collected packages: jsonschema, functools32 04:46:25 INFO - Running setup.py install for functools32 04:46:25 INFO - warning: no files found matching '*.txt' 04:46:25 INFO - no previously-included directories found matching 'build' 04:46:25 INFO - no previously-included directories found matching 'dist' 04:46:25 INFO - no previously-included directories found matching '.git*' 04:46:25 INFO - Successfully installed jsonschema functools32 04:46:25 INFO - Cleaning up... 04:46:25 INFO - Return code: 0 04:46:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:25 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 04:46:25 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 04:46:25 INFO - Using env: {'DISPLAY': ':0', 04:46:25 INFO - 'HOME': '/home/cltbld', 04:46:25 INFO - 'LANG': 'en_US.UTF-8', 04:46:25 INFO - 'LANGUAGE': 'en_US:en', 04:46:25 INFO - 'LOGNAME': 'cltbld', 04:46:25 INFO - 'MAIL': '/var/mail/cltbld', 04:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:25 INFO - 'MOZ_NO_REMOTE': '1', 04:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:25 INFO - 'NO_EM_RESTART': '1', 04:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:25 INFO - 'PWD': '/builds/slave/test', 04:46:25 INFO - 'SHELL': '/bin/bash', 04:46:25 INFO - 'SHLVL': '1', 04:46:25 INFO - 'TERM': 'linux', 04:46:25 INFO - 'TMOUT': '86400', 04:46:25 INFO - 'USER': 'cltbld', 04:46:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:25 INFO - '_': '/tools/buildbot/bin/python'} 04:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:46:25 INFO - Cleaning up... 04:46:25 INFO - Return code: 0 04:46:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:25 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:25 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 04:46:25 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 04:46:25 INFO - Using env: {'DISPLAY': ':0', 04:46:25 INFO - 'HOME': '/home/cltbld', 04:46:25 INFO - 'LANG': 'en_US.UTF-8', 04:46:25 INFO - 'LANGUAGE': 'en_US:en', 04:46:25 INFO - 'LOGNAME': 'cltbld', 04:46:25 INFO - 'MAIL': '/var/mail/cltbld', 04:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:25 INFO - 'MOZ_NO_REMOTE': '1', 04:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:25 INFO - 'NO_EM_RESTART': '1', 04:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:25 INFO - 'PWD': '/builds/slave/test', 04:46:25 INFO - 'SHELL': '/bin/bash', 04:46:25 INFO - 'SHLVL': '1', 04:46:25 INFO - 'TERM': 'linux', 04:46:25 INFO - 'TMOUT': '86400', 04:46:25 INFO - 'USER': 'cltbld', 04:46:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:25 INFO - '_': '/tools/buildbot/bin/python'} 04:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:28 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 04:46:28 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 04:46:28 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 04:46:28 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 04:46:28 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 04:46:28 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 04:46:28 INFO - Downloading docopt-0.6.1.tar.gz 04:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:28 INFO - Running setup.py install for blobuploader 04:46:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:28 INFO - Running setup.py install for requests 04:46:28 INFO - Running setup.py install for docopt 04:46:28 INFO - Successfully installed blobuploader requests docopt 04:46:28 INFO - Cleaning up... 04:46:28 INFO - Return code: 0 04:46:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:28 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:28 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 04:46:28 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 04:46:28 INFO - Using env: {'DISPLAY': ':0', 04:46:28 INFO - 'HOME': '/home/cltbld', 04:46:28 INFO - 'LANG': 'en_US.UTF-8', 04:46:28 INFO - 'LANGUAGE': 'en_US:en', 04:46:28 INFO - 'LOGNAME': 'cltbld', 04:46:28 INFO - 'MAIL': '/var/mail/cltbld', 04:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:28 INFO - 'MOZ_NO_REMOTE': '1', 04:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:28 INFO - 'NO_EM_RESTART': '1', 04:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:28 INFO - 'PWD': '/builds/slave/test', 04:46:28 INFO - 'SHELL': '/bin/bash', 04:46:28 INFO - 'SHLVL': '1', 04:46:28 INFO - 'TERM': 'linux', 04:46:28 INFO - 'TMOUT': '86400', 04:46:28 INFO - 'USER': 'cltbld', 04:46:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:28 INFO - '_': '/tools/buildbot/bin/python'} 04:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:29 INFO - Running setup.py (path:/tmp/pip-7EPMiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:29 INFO - Running setup.py (path:/tmp/pip-AqPNhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:29 INFO - Running setup.py (path:/tmp/pip-7YlcX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:29 INFO - Running setup.py (path:/tmp/pip-z7f0vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:29 INFO - Running setup.py (path:/tmp/pip-Ky6ixd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:29 INFO - Running setup.py (path:/tmp/pip-Vtb8u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:29 INFO - Running setup.py (path:/tmp/pip-q2jiWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:29 INFO - Running setup.py (path:/tmp/pip-UTfEQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:29 INFO - Running setup.py (path:/tmp/pip-dkxjyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:29 INFO - Running setup.py (path:/tmp/pip-4fd7NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:29 INFO - Running setup.py (path:/tmp/pip-elF7CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:29 INFO - Running setup.py (path:/tmp/pip-v1B4Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:30 INFO - Running setup.py (path:/tmp/pip-rYgqsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:30 INFO - Running setup.py (path:/tmp/pip-NnNC_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:30 INFO - Running setup.py (path:/tmp/pip-_Se0C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:30 INFO - Running setup.py (path:/tmp/pip-bO2fx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:30 INFO - Running setup.py (path:/tmp/pip-inwalg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:30 INFO - Running setup.py install for manifestparser 04:46:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:30 INFO - Running setup.py install for mozcrash 04:46:30 INFO - Running setup.py install for mozdebug 04:46:30 INFO - Running setup.py install for mozdevice 04:46:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:30 INFO - Running setup.py install for mozfile 04:46:30 INFO - Running setup.py install for mozhttpd 04:46:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:30 INFO - Running setup.py install for mozinfo 04:46:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Running setup.py install for mozInstall 04:46:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Running setup.py install for mozleak 04:46:31 INFO - Running setup.py install for mozlog 04:46:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Running setup.py install for moznetwork 04:46:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Running setup.py install for mozprocess 04:46:31 INFO - Running setup.py install for mozprofile 04:46:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Running setup.py install for mozrunner 04:46:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:31 INFO - Running setup.py install for mozscreenshot 04:46:31 INFO - Running setup.py install for moztest 04:46:32 INFO - Running setup.py install for mozversion 04:46:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:32 INFO - Cleaning up... 04:46:32 INFO - Return code: 0 04:46:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:32 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:32 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 04:46:32 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 04:46:32 INFO - Using env: {'DISPLAY': ':0', 04:46:32 INFO - 'HOME': '/home/cltbld', 04:46:32 INFO - 'LANG': 'en_US.UTF-8', 04:46:32 INFO - 'LANGUAGE': 'en_US:en', 04:46:32 INFO - 'LOGNAME': 'cltbld', 04:46:32 INFO - 'MAIL': '/var/mail/cltbld', 04:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:32 INFO - 'MOZ_NO_REMOTE': '1', 04:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:32 INFO - 'NO_EM_RESTART': '1', 04:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:32 INFO - 'PWD': '/builds/slave/test', 04:46:32 INFO - 'SHELL': '/bin/bash', 04:46:32 INFO - 'SHLVL': '1', 04:46:32 INFO - 'TERM': 'linux', 04:46:32 INFO - 'TMOUT': '86400', 04:46:32 INFO - 'USER': 'cltbld', 04:46:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:32 INFO - '_': '/tools/buildbot/bin/python'} 04:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:32 INFO - Running setup.py (path:/tmp/pip-kutHkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:32 INFO - Running setup.py (path:/tmp/pip-vKsLL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:32 INFO - Running setup.py (path:/tmp/pip-5jcCuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:32 INFO - Running setup.py (path:/tmp/pip-9zw2XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:32 INFO - Running setup.py (path:/tmp/pip-srv4Ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:32 INFO - Running setup.py (path:/tmp/pip-_y2vC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:32 INFO - Running setup.py (path:/tmp/pip-__5UbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:32 INFO - Running setup.py (path:/tmp/pip-aIhK8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:32 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)) 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:32 INFO - Running setup.py (path:/tmp/pip-Eje_v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:33 INFO - Running setup.py (path:/tmp/pip-eRcsaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:33 INFO - Running setup.py (path:/tmp/pip-RLZpSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:33 INFO - Running setup.py (path:/tmp/pip-fBsw3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:33 INFO - Running setup.py (path:/tmp/pip-NZL9oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:33 INFO - Running setup.py (path:/tmp/pip-rqp7qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:33 INFO - Running setup.py (path:/tmp/pip-zMsBYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:33 INFO - Running setup.py (path:/tmp/pip-9g2TRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:33 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)) 04:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:33 INFO - Running setup.py (path:/tmp/pip-QNqjdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:33 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)) 04:46:33 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)) 04:46:33 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)) 04:46:33 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)) 04:46:33 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)) 04:46:33 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)) 04:46:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:33 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 04:46:33 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 04:46:33 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 04:46:33 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 04:46:33 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 04:46:33 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 04:46:35 INFO - Downloading blessings-1.6.tar.gz 04:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:35 INFO - Installing collected packages: blessings 04:46:35 INFO - Running setup.py install for blessings 04:46:35 INFO - Successfully installed blessings 04:46:35 INFO - Cleaning up... 04:46:35 INFO - Return code: 0 04:46:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:35 INFO - Reading from file tmpfile_stdout 04:46:35 INFO - Current package versions: 04:46:35 INFO - argparse == 1.2.1 04:46:35 INFO - blessings == 1.6 04:46:35 INFO - blobuploader == 1.2.4 04:46:35 INFO - docopt == 0.6.1 04:46:35 INFO - functools32 == 3.2.3-2 04:46:35 INFO - jsonschema == 2.5.1 04:46:35 INFO - manifestparser == 1.1 04:46:35 INFO - mozInstall == 1.12 04:46:35 INFO - mozcrash == 0.17 04:46:35 INFO - mozdebug == 0.1 04:46:35 INFO - mozdevice == 0.48 04:46:35 INFO - mozfile == 1.2 04:46:35 INFO - mozhttpd == 0.7 04:46:35 INFO - mozinfo == 0.9 04:46:35 INFO - mozleak == 0.1 04:46:35 INFO - mozlog == 3.3 04:46:35 INFO - moznetwork == 0.27 04:46:35 INFO - mozprocess == 0.23 04:46:35 INFO - mozprofile == 0.28 04:46:35 INFO - mozrunner == 6.12 04:46:35 INFO - mozscreenshot == 0.1 04:46:35 INFO - mozsystemmonitor == 0.3 04:46:35 INFO - moztest == 0.7 04:46:35 INFO - mozversion == 1.4 04:46:35 INFO - psutil == 3.1.1 04:46:35 INFO - requests == 1.2.3 04:46:35 INFO - wsgiref == 0.1.2 04:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:35 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')]} 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 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')]} 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:35 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 04:46:35 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 04:46:35 INFO - Using env: {'DISPLAY': ':0', 04:46:35 INFO - 'HOME': '/home/cltbld', 04:46:35 INFO - 'LANG': 'en_US.UTF-8', 04:46:35 INFO - 'LANGUAGE': 'en_US:en', 04:46:35 INFO - 'LOGNAME': 'cltbld', 04:46:35 INFO - 'MAIL': '/var/mail/cltbld', 04:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:35 INFO - 'MOZ_NO_REMOTE': '1', 04:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:35 INFO - 'NO_EM_RESTART': '1', 04:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:35 INFO - 'PWD': '/builds/slave/test', 04:46:35 INFO - 'SHELL': '/bin/bash', 04:46:35 INFO - 'SHLVL': '1', 04:46:35 INFO - 'TERM': 'linux', 04:46:35 INFO - 'TMOUT': '86400', 04:46:35 INFO - 'USER': 'cltbld', 04:46:35 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:35 INFO - '_': '/tools/buildbot/bin/python'} 04:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 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)) 04:46:36 INFO - Cleaning up... 04:46:36 INFO - Return code: 0 04:46:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:36 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 0x1594030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1855180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, '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': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', '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 04:46:36 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 04:46:36 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 04:46:36 INFO - Using env: {'DISPLAY': ':0', 04:46:36 INFO - 'HOME': '/home/cltbld', 04:46:36 INFO - 'LANG': 'en_US.UTF-8', 04:46:36 INFO - 'LANGUAGE': 'en_US:en', 04:46:36 INFO - 'LOGNAME': 'cltbld', 04:46:36 INFO - 'MAIL': '/var/mail/cltbld', 04:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:36 INFO - 'MOZ_NO_REMOTE': '1', 04:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:36 INFO - 'NO_EM_RESTART': '1', 04:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:36 INFO - 'PWD': '/builds/slave/test', 04:46:36 INFO - 'SHELL': '/bin/bash', 04:46:36 INFO - 'SHLVL': '1', 04:46:36 INFO - 'TERM': 'linux', 04:46:36 INFO - 'TMOUT': '86400', 04:46:36 INFO - 'USER': 'cltbld', 04:46:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:36 INFO - '_': '/tools/buildbot/bin/python'} 04:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:36 INFO - Cleaning up... 04:46:36 INFO - Return code: 0 04:46:36 INFO - Running post-action listener: _resource_record_post_action 04:46:36 INFO - Running post-action listener: _start_resource_monitoring 04:46:36 INFO - Starting resource monitoring. 04:46:36 INFO - [mozharness: 2016-08-05 11:46:36.427649Z] Finished create-virtualenv step (success) 04:46:36 INFO - [mozharness: 2016-08-05 11:46:36.428112Z] Running install step. 04:46:36 INFO - Running pre-action listener: _resource_record_pre_action 04:46:36 INFO - Running main action method: install 04:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:36 INFO - Reading from file tmpfile_stdout 04:46:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:36 INFO - Reading from file tmpfile_stdout 04:46:36 INFO - Output received: 04:46:36 INFO - Usage: mozinstall [options] installer 04:46:36 INFO - Options: 04:46:36 INFO - -h, --help show this help message and exit 04:46:36 INFO - -d DEST, --destination=DEST 04:46:36 INFO - Directory to install application into. [default: 04:46:36 INFO - "/builds/slave/test"] 04:46:36 INFO - --app=APP Application being installed. [default: firefox] 04:46:36 INFO - mkdir: /builds/slave/test/build/application 04:46:36 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'] 04:46:36 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 04:46:53 INFO - Reading from file tmpfile_stdout 04:46:53 INFO - Output received: 04:46:53 INFO - /builds/slave/test/build/application/firefox/firefox 04:46:53 INFO - Running post-action listener: _resource_record_post_action 04:46:53 INFO - [mozharness: 2016-08-05 11:46:53.591305Z] Finished install step (success) 04:46:53 INFO - [mozharness: 2016-08-05 11:46:53.591549Z] Running run-tests step. 04:46:53 INFO - Running pre-action listener: _resource_record_pre_action 04:46:53 INFO - Running main action method: run_tests 04:46:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:53 INFO - Python 2.7.3 04:46:53 INFO - Return code: 0 04:46:53 INFO - grabbing minidump binary from tooltool 04:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:53 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 0x18533b0>, '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 0x18542b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1854740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:53 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 04:46:53 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 04:46:53 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 04:46:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:53 INFO - Return code: 0 04:46:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:46:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:46:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:46:53 INFO - Using env: {'DISPLAY': ':0', 04:46:53 INFO - 'HOME': '/home/cltbld', 04:46:53 INFO - 'LANG': 'en_US.UTF-8', 04:46:53 INFO - 'LANGUAGE': 'en_US:en', 04:46:53 INFO - 'LOGNAME': 'cltbld', 04:46:53 INFO - 'MAIL': '/var/mail/cltbld', 04:46:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:53 INFO - 'MOZ_NO_REMOTE': '1', 04:46:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:53 INFO - 'NO_EM_RESTART': '1', 04:46:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:53 INFO - 'PWD': '/builds/slave/test', 04:46:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:53 INFO - 'SHELL': '/bin/bash', 04:46:53 INFO - 'SHLVL': '1', 04:46:53 INFO - 'TERM': 'linux', 04:46:53 INFO - 'TMOUT': '86400', 04:46:53 INFO - 'USER': 'cltbld', 04:46:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859', 04:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:53 INFO - '_': '/tools/buildbot/bin/python'} 04:46:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:46:53 INFO - mozversion application_buildid: 20160805030444 04:46:53 INFO - mozversion application_changeset: d320ef56876f52db9bc0eb79554c7332d4793769 04:46:53 INFO - mozversion application_display_name: Nightly 04:46:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:53 INFO - mozversion application_name: Firefox 04:46:53 INFO - mozversion application_remotingname: firefox 04:46:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:46:53 INFO - mozversion application_vendor: Mozilla 04:46:53 INFO - mozversion application_version: 51.0a1 04:46:53 INFO - mozversion platform_buildid: 20160805030444 04:46:53 INFO - mozversion platform_changeset: d320ef56876f52db9bc0eb79554c7332d4793769 04:46:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:46:53 INFO - mozversion platform_version: 51.0a1 04:46:53 INFO - using testdate: 1470397613 04:46:53 INFO - actual date: 1470397613 04:46:53 INFO - starting webserver on 'localhost:37711' 04:46:53 INFO - SUITE-START | Running 2 tests 04:46:53 INFO - TEST-START | dromaeo_css 04:46:53 INFO - operating with platform_type : linux_ 04:46:53 INFO - Initialising browser for dromaeo_css test... 04:46:53 INFO - TEST-INFO | started process 15890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0k2jz9/profile http://localhost:37711/getInfo.html) 04:46:57 INFO - PROCESS | 15890 | __metrics Screen width/height:1600/1200 04:46:57 INFO - PROCESS | 15890 | colorDepth:24 04:46:57 INFO - PROCESS | 15890 | Browser inner width/height: 1024/697 04:46:57 INFO - PROCESS | 15890 | __metrics 04:46:58 INFO - PROCESS | 15890 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:46:58 INFO - PROCESS | 15890 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:59 INFO - TEST-INFO | 15890: exit 0 04:46:59 INFO - Browser initialized. 04:46:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:59 INFO - TEST-INFO | started process 15969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0k2jz9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:11 INFO - PROCESS | 15969 | RSS: Main: 156991488 04:47:11 INFO - PROCESS | 15969 | 04:48:03 INFO - PROCESS | 15969 | 1470397683022 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] 04:50:12 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:37711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37711/tests/dromaeo/cssquery-ext.html) 04:50:13 INFO - PROCESS | 15969 | RSS: Main: 261296128 04:50:13 INFO - PROCESS | 15969 | 04:53:15 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:37711/tests/dromaeo/cssquery-ext.html (next: http://localhost:37711/tests/dromaeo/cssquery-jquery.html) 04:53:16 INFO - PROCESS | 15969 | RSS: Main: 243765248 04:53:16 INFO - PROCESS | 15969 | 04:56:18 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:37711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37711/tests/dromaeo/cssquery-mootools.html) 04:56:19 INFO - PROCESS | 15969 | RSS: Main: 185397248 04:56:19 INFO - PROCESS | 15969 | 04:59:21 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:37711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37711/tests/dromaeo/cssquery-prototype.html) 04:59:21 INFO - PROCESS | 15969 | RSS: Main: 218185728 04:59:21 INFO - PROCESS | 15969 | 05:02:24 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:37711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37711/tests/dromaeo/cssquery-yui.html) 05:02:25 INFO - PROCESS | 15969 | RSS: Main: 187297792 05:02:25 INFO - PROCESS | 15969 | 05:05:27 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:37711/tests/dromaeo/cssquery-yui.html (next: http://localhost:37711/tests/dromaeo/cssquery-dojo.html) 05:05:28 INFO - PROCESS | 15969 | RSS: Main: 277999616 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | __start_tp_report 05:05:28 INFO - PROCESS | 15969 | _x_x_mozilla_page_load 05:05:28 INFO - PROCESS | 15969 | _x_x_mozilla_page_load_details 05:05:28 INFO - PROCESS | 15969 | |i|pagename|runs| 05:05:28 INFO - PROCESS | 15969 | |0;dojo.html;3026.6216722909635;3050.557669137974;3068.171593669709;3077.322988942432;3085.043636472694;5203.947960520393;5246.475352464761;5286.709230992299;5353.250544923709;5384.6769193848395;5253.763580638871;5312.973435132819;5320.893582128355;5345.893082138355;5407.729613519328;4741.620670346372;4802.303665968432;4828.686135401205;4829.468758436569;5028.396592408916;4937.456879743226;4944.678595891273;4973.154563724175;4991.401031876162;4993.375828021497;4709.952900470986;4819.325294458778;4874.65877388583;4884.438289596671;4891.926621100686;4754.66717329787;4781.043791241731;4788.042391521675;4795.832145874912;4875.488073752241;4805.495422980606;4828.927566086511;4830.130576496229;4835.709857408531;4890.682105663121;5153.201253805666;5242.135047717122;5253.474652534755;5278.551323137538;5325.254464374991;5613.578981576357;5676.176954341598;5682.943170568283;5687.601867869251;5704.429557044304;5721.227634269362;5725.112607545837;5726.4273572642405;5726.570507211975;5744.195812586241;5148.279240906276;5183.714895680736;5202.895942081137;5215.713135777492;5288.444713305124;5745.827625171251;5750;5756.7121643917635;5761.48146666802;5764.538836893039;5519.061759500894;5539.2522009529;5548.140038294071;5557.5553955683445;5572.498475137257;5458.153986132076;5601.047821870292;5661.235733176051;5675.262215911905;5745.080787074048;5664.291963504562;5668.489835914705;5673.404292549306;5678.14827775837;5678.290213723285;5634.126710359901;5668.121441176624;5674.914876276859;5685.772569097273;5687.857803554944;4208.831646734157;4272.209641216385;4276.657867370603;4310.892227694333;4321.9135617287475;3891.4357418174204;3923.489946306962;3937.27160475313;3939.862104826317;3971.860984865516;5455.890882182334;5467.9453205467435;5468.535174510212;5472.699001554953;5520.696361700065;5529.502344788988;5627.212190293362;5766.509846662997;5781.132830075522;5787.045137552257;5329.307190065267;5362.839114826562;5382.650127741685;5414.18787181918;5424;4951.183054795991;4960.553550180501;4962.627802914796;4964.528369804862;4972.204447288416;5646.604737668488;5743.511801496919;5912.17229587858;5921.763129474859;5924.081767325985;5561.610687252015;5567;5577.330720313588;5611.438856114356;5632.971835140798;5735.053716136791;5742.425757424224;5743.339515955551;5744.999999999833;5766.279215098113;5371.677699338053;5481.095619222943;5517.2275881377445;5532.30846144232;5544.500994910478;5660.349059858005;5713.342965559014;5730.283714535683;5742.16738572913;5742.28221472316;5543.667379957215;5584.553235741212;5594.1608758686525;5594.916076258941;5597.076482380362;5329.7068661224;5463.945360546502;5551.389347171888;5552.611317207757;5557.194206840067;5410.080286351251;5483.287172667528;5484.232207491034;5521.585881058856;5535.335759708861;5564.693941833238;5577.916331254954;5606.439356064361;5619.381867994599;5625.493705566519;5324.068288049499;5343.211595355983;5455.9454405455435;5464.043792336404;5470.507654311131 05:05:28 INFO - PROCESS | 15969 | |1;ext.html;571.9113537401703;572.1841567496093;592.8903152916708;603.78263825023;607.8510764862609;43380.56619433805;45002;45038.54961450385;45070.32394514085;49082.263766043536;46026.539734602644;46489.535104648945;46577.53422465774;46579.06841863161;46613.30080048802;9063.27493800496;9216.815663686722;9221.769455763593;9224.30817688676;9226.446413215195;9118.635254589808;9198.03420640833;9205.493697846616;9210.769730756718;9216.861747073799;9202.907970920272;9236.3996340238;9246.491442970633;9258.72223833286;9263.536823158849;9181.357304988653;9217.986021537625;9223.492707901063;9227.584758685874;9263.166315031613;8504.659813607448;8573.228409443118;8574.228319451217;8575.313974881994;8582.270507006911;43893.341599876025;44308.77845610784;44312.11375772499;44358.778206108764;44397;3534.734894882894;3718.9442158367647;3760.2667479841443;3940.6059394060367;4225.450691410128;33132.3373532528;34205;34315.313693725984;34706.65293347085;34949.82525087384;4432.734035957853;4475.619572336355;4514.074614703978;4519.141363140992;4673;253808;254559;255137;255170.72414637994;255494;57886.71056644774;57977.710111449174;58426.41573584295;58456.41543584595;58497.12254316189;60958;61344.079838802456;61397.693011534655;61426.692866535384;61486.38513614896;15302.770458443132;15392.538223853302;15396.846031539766;15471.458498952483;15473.22633868302;12028.037756979596;12073.758524829454;12082.093842961638;12109.455074521667;12111.87888121125;13365.465381384636;16286.51140465788;16529.586760330847;16568.6686266274;16604.58488537796;5748.425157484218;6597.406233439014;6680.6993685283305;6708.865822683519;6800.93199068003;1014.3052009373603;1088.2817340555196;1128.8983991440646;1199.7942068221382;1205.4153735438306;33243;33979.66020339815;34110.317793644484;34237.828810856285;34303.828480857934;1168.5092261250295;1170.5434880396651;1199.412287978884;1231.858336291338;1257.4278703190027;17509;17707.291708331522;17905.820941790415;17908.9104554479;17951.371701990367;607336;609246;609496;609911;611590;59785.40214597798;59909;60171.09743353853;60171.69914150401;60287.397126028176;1217.9086568507398;1342.5770882172085;1354.5597680753795;1360.9523666671619;1366.719822436418;33087;34628.65371346355;34736.478952815225;34844.30311393707;35047.824760876036;50105.74947125241;50814.74592627013;50831.491685084155;50869.236961446346;50913.745431272604;331159;333353;333536;333668;333959;27375.452490949672;28722;28769.424611507235;30420.84789576038;30481.695183047887;49386;49412;49610.75194624004;49932.750336248086;51223.48776512187;40144.79927600343;40823;40897.18205635811;41891.581084188765;42718;40434.59565404426;41264.1747165061;41482.37776433295;42639.786801067035;43149.352759709254;40849.795751021054;41985.58014419817;42099.158016838875;42453.787731061144;42679;35549;37933.24133517369;38012.23975520419;38347.65783197686;39013.21973560569;29139.417211655225;29381.559276611297;29555.55666665045;29670;29928.70071299259 05:05:28 INFO - PROCESS | 15969 | |2;jquery.html;374.1936127644926;389.29148948912973;398.34472293077886;399.7661368099662;420.64665680828097;14390.352434140463;18230.544236394082;20126.59746805063;20149.294774682872;20437.591248175027;19394.90302548485;19578.314758983437;19869;19869.10589023494;20032.49918752032;5596.776128954837;5703.800366987167;5789.363170051291;5894.823155305347;5895.498882594985;5752;5828.737706803204;5838.182654428383;5846.795362162326;5848.590598658096;5647.43525647434;5794.130880367937;5801.53587712982;5812;5833.82498525045;5793.217915581406;5826.796062137805;5837.299524057098;5838.503727183194;5842.853928651775;5083;5151.484851514856;5166.664166829181;5193.610479214036;5202.76587553561;23223.53552928932;23462.061517539278;23513.41216469585;23574.76425235743;23748.406289842893;2320.9651855222187;2359.893804778789;2379.202967006055;2399.712034555847;2428.805695544352;14341.354639041163;14641.121532708072;14732.705345893022;14998.47505337308;15267.923660381739;1928.4600311912686;1974.2103158736477;2023.5345870449733;2025.5037515808574;2035.9592808143902;78057.21942780557;85078;85244.57377713072;85574;86529.13470865274;11342.376169310766;11462.140339474572;11617.767644647229;11664.591739289084;11806.822897656542;16260.268287927072;16275.186240687919;16291.511254662379;16303.83696163047;16310.429134980219;7680.34717049046;8097.595120243965;8124.471909325875;8211.87948579536;8281.95859020701;7639.083310002835;7683.846323073507;7751.612419379008;7831.295183433518;7914.881276780853;4793.9280910786365;4805.687630304089;4866.6350023747655;4888.828890988798;4980.228064649985;1930.8744931579402;1988.1351612048804;1989.532459871929;2032.1160295271604;2093.1836583732356;921.9308551858637;939.6335429182624;953.8092381523584;954.2795189631784;1039.9948000259951;19200.423987280403;20821.479463013548;20917;21118.316285524565;21146.577068458853;959.3828136262224;964.4695417520336;993.2054356514759;1014.5789497358661;1062.697131317571;10956.397398143019;11494.662803081095;11581.594644187413;11662.94168529152;11704.70738231534;533690;540013;540232;543224;543540;87416.562917185;91042;92088;97994;105379.473102634;977.1498796047484;987.0918754745651;1006.4565134827258;1032.5250384822916;1033.7312298802365;18075.638487230444;18348.90825545864;18756.343527976456;18867.245310187438;19236.326728564993;30703.539446908762;32694.50958235676;33994.490082648284;45104.323435147846;45751.77124114491;60060;63849.6807515978;64882;65259.02111468237;66160;8550.444221125606;8633.525156116222;8823.955880220814;8982.101789820965;9003.684871029482;9856.605735770489;12492.937535312265;13668.179909205479;13952.441902323793;14042.578722638336;11154.16343774204;11607.941960290145;12062.336571488653;12176.208546444454;12639;11745.354005529778;11776.646700598996;11945.761084778082;11958.162928594915;12179.147459677737;11266.324020558794;12002.339871307162;12130.33283169434;12415.62753117408;12537.122401431812;7641.847163056596;8673.34949878749;8806.603702833516;8884.511351875708;9115.817683646423;11430.371329576954;11621.88378116208;11866.82199766987;12126.514939402325;12505.249265103075 05:05:28 INFO - PROCESS | 15969 | |3;mootools.html;1293.7865252233382;1432.0977783996084;1498.6403263216826;1618.7167245731994;1769.796473405558;8401.621927013284;8760.518171500566;8795.516246606441;8926.107389261071;8966;8784.1655042771;8881.289496840254;8887.822243555125;8899.377043606934;8912.598933048028;2110.124298416163;2347.0611755297846;2371.762823717623;2395.9281221563383;2400.063975049732;2451.460678650694;2461;2467.0255249176566;2467.5064987002584;2467.8889449974704;2373.1100837186054;2405.8556486610773;2416.2992732107755;2425.818063645225;2426.5510880487077;2303.4126297794123;2339.122828939148;2350.118705485443;2350.917717879866;2389.390705370137;2420.0803694596116;2421.61254199329;2422.2733180045916;2428.9271321860374;2436.6466862304865;9019.098090190993;9068.591913363849;9087.681931132378;9095.045020272843;9108.453492790388;5201.297824793643;5227.529522342969;5261.684298942076;5338.172583249602;5340.786368545292;3120.8595613197235;3313.2545177335146;3347.9497807532907;3350.5811773528308;3421.298633780069;1129.779692959873;1196.425715656481;1201.891829735328;1202.2485946283573;1207.3118322556147;12037.518499260019;12106;12500.124991250615;12541.247525148521;12607.11750177488;4363.869083927487;4472.686911916199;4616.3998680172035;4672.976635116803;4703.129920964564;9964.850527242097;9969.651062212788;9970.900290997142;9974.451405172786;9991;5280.102382594968;5283.181106928432;5287.9735601321745;5288.286081378965;5289.576833853283;4358.063016451478;4726.929096063562;4842.903141937141;4912.189488734391;4935.975320123448;3899.2786334528205;3989.1849208610015;4036.3138266494766;4065.2276067547073;4097.8770636880945;1192.522990803668;1218.8537375514995;1222.743223922986;1226.7975783995719;1229.8524177098805;975.9658411955547;990.6879333010223;993.1607791416242;994.5027486256871;999.6051559633904;6054.636721796706;6070.028795392716;6088.756449742049;6091.390860913962;6260.624362538262;474.25305144397714;479.84644913627307;486.868545492715;494.42646530024996;495.65799598277073;4125.97937010319;4231.386448964883;4272.230998420252;4377.124575084996;4492.011757413364;10815.40515271652;10888.564457421615;10974.725631859108;10987.670369888916;11022.779544409066;10864.565417383215;10870.239083264096;10881.727956800985;10921.344719316867;10935.781284374269;8087.838243235103;8376.874346884802;8397.034341050858;8414.747557573282;8567.74296771098;6208.968955155376;6404.135441715495;6500.707468164039;6514.4788416925585;6583.934160658524;10289.897101029193;10318.845217321596;10440.477976101316;10678.679639610824;10705.732356691145;10466.372017678963;10510.348246375015;10561.841572376574;10586;10598.20513461478;7797.103333116765;7829.647665855164;7837.098733645704;7887.526748395115;7901.288884000468;8293.62678679473;8343.54110523927;8348.248657620843;8359.414840961075;8395.202455766692;7448.685614028058;7587.127480339832;7603.581803000888;7615.276548728084;7793.610319484116;7372.2627737227995;7376.409887209118;7378.4466165036765;7535.773926782205;7675.4243431741725;6753.459723222229;6850.075239842757;6854.383105520527;6863.931360686529;6878.209005964378;5230.372355317386;5292.7353632319;5342.278792362981;5450.809221677222;5525.392206857162;5332.413434522122;5347.705876176848;5375.865603359947;5379.462053794589;5652.293463317085 05:05:28 INFO - PROCESS | 15969 | |4;prototype.html;314.10010320431957;323.18073683213055;326.4287496880459;330.2519792669604;331.92199833039217;5091.567216786569;5185.118529849925;5190.029627335091;5269.156934890419;5310.4955029272205;5131.255967884655;5165.63840531163;5211.817586384477;5214.973925130378;5223.869403264911;4063.7764922929227;4118.773467459288;4120.464339635843;4127.463429754128;4130.793460326987;3923.784191869446;4093.89765255868;4148.191102734968;4155.127423241108;4156.418101465797;4071.694622903279;4071.7149799514045;4075.042365044227;4078.327076032466;4089.1208390196102;4055.1078762672314;4058.756474611518;4065.4105154752397;4075.673946084306;4101.5488296287385;3609.314230296235;3621.981890090559;3630.1832087780303;3640.4721315409383;3643.4899114124046;5033.7734801934;5057.69653820772;5059.494050594948;5072.442031376546;5082.74586270685;4584.541545845389;4588.518205588432;4617.168909596271;4617.468991066037;4619.838305659319;5392.245085688007;5393.83818485446;5395.811146609889;5400.108982017962;5408.864778380533;3795.1460921292764;3887.3974533947285;3891.1828516011387;3896.902577435558;3902.1415288636454;5589;5622.746976386073;5628.465295796893;5633.746481408305;5643.492085712305;3993.940090898639;3996.900077498086;4004.6996475264473;4013.8795836124377;4025.959740402617;3817.408301713239;4041.131156801302;4045.554988951213;4070.206309769626;4075.1645912587846;4597.103564804831;4630.6758526902795;4631.444226692818;4638.582527572535;4642.210824159901;5486.259354987105;5486.945130548724;5493.972530137324;5508.504234618904;5527.972360138254;1322.3983087695076;1343.7715588350004;1367.9658008549866;1382.5783136143373;1394.4770710983382;935.4854829843558;946.990530094704;958.1568219966385;963.0706368354431;974.4056125763278;5210.869728256748;5226.320578324793;5262.684238945675;5271.71005594696;5283.788648454096;5529.3364796223905;5548.889022219533;5554.833354999357;5570.3315602127195;5571.860703482364;5051.595872330205;5249.370075590953;5293.206019097166;5301.6818990860675;5304.92042619361;2957.275467510474;2964.2293003819163;2984.731374176291;2990.5813186153955;2998.7001299870276;5876.177335173079;5889.440503152194;5890.764369425175;5891.764329426861;5898.587098903122;5556.749731310423;5700.230468886647;5706.9714651426475;5714.485696287354;5750.482456578928;5795.768169273182;5796.913046304308;5816.651000939957;5817.022212447619;5826.883462330645;5363.329583802025;5552.278203833637;5620.718964051863;5632.5212356950115;5658.717064146858;5576.219329293983;5579.191017302387;5581.962583657018;5582.748776304995;5603.271574695426;5827.668932427063;5854.326752423526;5861.238039054895;5865.94134058654;5878.470937615635;3916.706247031427;4012.378081397388;4021.6782657387926;4026.1947610478605;4042.4744783178;5345.819237553649;5546.389897111395;5564.415736347625;5575.832725018256;5603.831885043455;5315;5441.918371224356;5457.781688732565;5467.425920278472;5502.972485137549;5443.210734443404;5451;5462.453754624665;5463.480969308069;5489.58828087887;5191.870203244949;5360.544353729977;5389.730513474389;5392.433794451683;5397.190421436816;5419.241306217212;5431.511163995259;5440.564754819684;5460;5475.315585551806;5379.919301210563;5385.8114965977575;5406.297181366397;5413.754836387574;5421.2681288025615 05:05:28 INFO - PROCESS | 15969 | |5;yui.html;766.9769906902792;781.4764108047608;784.4113182191475;790.4585359029065;857.0957639690124;15845.603859903495;17493.650126997454;17503.82496175038;17511.562210944718;17528.824711752877;15691.37234510621;15700.685986280267;15853.128077955736;15861.682766344666;15875.36498540057;666.8399584099806;785.4972817396871;805.512664837772;806.238104990781;822.724387330242;808.3775492870486;818.2880893622527;818.5825229133155;819.1439945257191;820.1634332980357;863.1842908451516;864.5417928497906;864.9524276164808;865.446114486729;867.5575456517158;696.613379574336;834.6995081770558;854.8076682746395;855.3072011670566;856.5203486047833;633.96196228226;635.428114696772;635.5487603801307;635.5900444213503;635.8187916443837;14365.209913454755;14414.495492657707;14429.639259018504;14447.855521444757;14491.347889345005;13718.38267277975;14263.358148883326;14797.630059248497;14843.703125937422;15090.773638395432;12782.936085319514;12948.741025179444;13016.219026858418;13053.804192937114;13250.3374831259;4457.77711114443;4545.906299071736;4551.067031258584;4561.156186105548;4753.809847606126;81246.18753812504;82292;82516;84168;85543;10899.1280697544;11144.554217831359;11426.714332141762;11475.483603237873;11646.126540509496;21253.68119478178;21521.78478215198;21561.137554497956;21562.78437215608;21616.567668646538;8118.188181181835;8270.545120018336;8311.667533298722;8540.23137917578;8825.955870220609;4694.859154225379;4736.4316282046375;4743;4847.660663753574;4886.877828054327;3592.2815436912724;3679.392900171495;3699.6855267302044;3715.3869611514338;3723.106454450912;613.4540259169343;620.5935112501319;630.1461519640912;636.1507387637463;646.0954663471178;602.7860109661007;640.7308930249307;647.3009150117862;656.3600489522772;681.5842336174929;9835.75410614726;10074.496275186211;10216.540255688511;10268.794624107475;10555.525001374803;611.5199568338833;632.6046221111806;640.4780104215143;688.0985908459834;698.9021536984826;4578.725276483355;4716.198246298069;4792.616590672737;4822.590079843182;4828.111087344743;71072;94468.0553194473;127042.36478817547;128867;134278;65588;71190.64404677943;105157;106393.4680326609;108332.45833770938;97333.51333243288;100327.49836250771;101388;101724;102792;9503.239740820856;9769.902300976899;9870.062344077302;9921.603135874484;9936;57158;57267.42732572621;57338.13992790028;59104;60261.39738602733;75278.87081693669;85620;86280;86598;86897;10466.424346661006;10938.130514275581;11030.613928512463;11208.215424920178;11368.147388946027;12828.935855320664;12844.678883027998;13099.934500327437;13946.651333716738;13971.371288291848;12716.237025778482;12881.742365152832;13336.733010364;13380;13387.330633468093;11696.239744416585;12652.557160499338;12830.615081547568;12950.158239714388;12964.157329773912;11899.345535995257;11970.46132924038;12302.630921072383;12808.359582020676;12822.67943301425;9538.85691714611;9866;10143.34068285559;10339.172866170538;10419.254271106123;9366.250699944125;9903.356281841658;10481.842772358574;10521.579136834442;11689.649310520697 05:05:28 INFO - PROCESS | 15969 | __end_tp_report 05:05:28 INFO - PROCESS | 15969 | __start_cc_report 05:05:28 INFO - PROCESS | 15969 | _x_x_mozilla_cycle_collect,1043 05:05:28 INFO - PROCESS | 15969 | __end_cc_report 05:05:28 INFO - PROCESS | 15969 | __startTimestamp1470398728133__endTimestamp 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | ------- Summary: start ------- 05:05:28 INFO - PROCESS | 15969 | Number of tests: 6 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | [#0] dojo.html Cycles:165 Average:5266.10 Median:5470.51 stddev:586.85 (10.7%) stddev-sans-first:561.74 05:05:28 INFO - PROCESS | 15969 | Values: 3026.6 3050.6 3068.2 3077.3 3085.0 5203.9 5246.5 5286.7 5353.3 5384.7 5253.8 5313.0 5320.9 5345.9 5407.7 4741.6 4802.3 4828.7 4829.5 5028.4 4937.5 4944.7 4973.2 4991.4 4993.4 4710.0 4819.3 4874.7 4884.4 4891.9 4754.7 4781.0 4788.0 4795.8 4875.5 4805.5 4828.9 4830.1 4835.7 4890.7 5153.2 5242.1 5253.5 5278.6 5325.3 5613.6 5676.2 5682.9 5687.6 5704.4 5721.2 5725.1 5726.4 5726.6 5744.2 5148.3 5183.7 5202.9 5215.7 5288.4 5745.8 5750.0 5756.7 5761.5 5764.5 5519.1 5539.3 5548.1 5557.6 5572.5 5458.2 5601.0 5661.2 5675.3 5745.1 5664.3 5668.5 5673.4 5678.1 5678.3 5634.1 5668.1 5674.9 5685.8 5687.9 4208.8 4272.2 4276.7 4310.9 4321.9 3891.4 3923.5 3937.3 3939.9 3971.9 5455.9 5467.9 5468.5 5472.7 5520.7 5529.5 5627.2 5766.5 5781.1 5787.0 5329.3 5362.8 5382.7 5414.2 5424.0 4951.2 4960.6 4962.6 4964.5 4972.2 5646.6 5743.5 5912.2 5921.8 5924.1 5561.6 5567.0 5577.3 5611.4 5633.0 5735.1 5742.4 5743.3 5745.0 5766.3 5371.7 5481.1 5517.2 5532.3 5544.5 5660.3 5713.3 5730.3 5742.2 5742.3 5543.7 5584.6 5594.2 5594.9 5597.1 5329.7 5463.9 5551.4 5552.6 5557.2 5410.1 5483.3 5484.2 5521.6 5535.3 5564.7 5577.9 5606.4 5619.4 5625.5 5324.1 5343.2 5455.9 5464.0 5470.5 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | [#1] ext.html Cycles:180 Average:57330.97 Median:42546.79 stddev:113902.24 (267.7%) stddev-sans-first:114142.05 05:05:28 INFO - PROCESS | 15969 | Values: 571.9 572.2 592.9 603.8 607.9 43380.6 45002.0 45038.5 45070.3 49082.3 46026.5 46489.5 46577.5 46579.1 46613.3 9063.3 9216.8 9221.8 9224.3 9226.4 9118.6 9198.0 9205.5 9210.8 9216.9 9202.9 9236.4 9246.5 9258.7 9263.5 9181.4 9218.0 9223.5 9227.6 9263.2 8504.7 8573.2 8574.2 8575.3 8582.3 43893.3 44308.8 44312.1 44358.8 44397.0 3534.7 3718.9 3760.3 3940.6 4225.5 33132.3 34205.0 34315.3 34706.7 34949.8 4432.7 4475.6 4514.1 4519.1 4673.0 253808.0 254559.0 255137.0 255170.7 255494.0 57886.7 57977.7 58426.4 58456.4 58497.1 60958.0 61344.1 61397.7 61426.7 61486.4 15302.8 15392.5 15396.8 15471.5 15473.2 12028.0 12073.8 12082.1 12109.5 12111.9 13365.5 16286.5 16529.6 16568.7 16604.6 5748.4 6597.4 6680.7 6708.9 6800.9 1014.3 1088.3 1128.9 1199.8 1205.4 33243.0 33979.7 34110.3 34237.8 34303.8 1168.5 1170.5 1199.4 1231.9 1257.4 17509.0 17707.3 17905.8 17908.9 17951.4 607336.0 609246.0 609496.0 609911.0 611590.0 59785.4 59909.0 60171.1 60171.7 60287.4 1217.9 1342.6 1354.6 1361.0 1366.7 33087.0 34628.7 34736.5 34844.3 35047.8 50105.7 50814.7 50831.5 50869.2 50913.7 331159.0 333353.0 333536.0 333668.0 333959.0 27375.5 28722.0 28769.4 30420.8 30481.7 49386.0 49412.0 49610.8 49932.8 51223.5 40144.8 40823.0 40897.2 41891.6 42718.0 40434.6 41264.2 41482.4 42639.8 43149.4 40849.8 41985.6 42099.2 42453.8 42679.0 35549.0 37933.2 38012.2 38347.7 39013.2 29139.4 29381.6 29555.6 29670.0 29928.7 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | [#2] jquery.html Cycles:180 Average:30915.27 Median:16566.17 stddev:88920.62 (536.8%) stddev-sans-first:89140.50 05:05:28 INFO - PROCESS | 15969 | Values: 374.2 389.3 398.3 399.8 420.6 14390.4 18230.5 20126.6 20149.3 20437.6 19394.9 19578.3 19869.0 19869.1 20032.5 5596.8 5703.8 5789.4 5894.8 5895.5 5752.0 5828.7 5838.2 5846.8 5848.6 5647.4 5794.1 5801.5 5812.0 5833.8 5793.2 5826.8 5837.3 5838.5 5842.9 5083.0 5151.5 5166.7 5193.6 5202.8 23223.5 23462.1 23513.4 23574.8 23748.4 2321.0 2359.9 2379.2 2399.7 2428.8 14341.4 14641.1 14732.7 14998.5 15267.9 1928.5 1974.2 2023.5 2025.5 2036.0 78057.2 85078.0 85244.6 85574.0 86529.1 11342.4 11462.1 11617.8 11664.6 11806.8 16260.3 16275.2 16291.5 16303.8 16310.4 7680.3 8097.6 8124.5 8211.9 8282.0 7639.1 7683.8 7751.6 7831.3 7914.9 4793.9 4805.7 4866.6 4888.8 4980.2 1930.9 1988.1 1989.5 2032.1 2093.2 921.9 939.6 953.8 954.3 1040.0 19200.4 20821.5 20917.0 21118.3 21146.6 959.4 964.5 993.2 1014.6 1062.7 10956.4 11494.7 11581.6 11662.9 11704.7 533690.0 540013.0 540232.0 543224.0 543540.0 87416.6 91042.0 92088.0 97994.0 105379.5 977.1 987.1 1006.5 1032.5 1033.7 18075.6 18348.9 18756.3 18867.2 19236.3 30703.5 32694.5 33994.5 45104.3 45751.8 60060.0 63849.7 64882.0 65259.0 66160.0 8550.4 8633.5 8824.0 8982.1 9003.7 9856.6 12492.9 13668.2 13952.4 14042.6 11154.2 11607.9 12062.3 12176.2 12639.0 11745.4 11776.6 11945.8 11958.2 12179.1 11266.3 12002.3 12130.3 12415.6 12537.1 7641.8 8673.3 8806.6 8884.5 9115.8 11430.4 11621.9 11866.8 12126.5 12505.2 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | [#3] mootools.html Cycles:180 Average:5850.71 Median:2699.53 stddev:3328.19 (123.3%) stddev-sans-first:3319.90 05:05:28 INFO - PROCESS | 15969 | Values: 1293.8 1432.1 1498.6 1618.7 1769.8 8401.6 8760.5 8795.5 8926.1 8966.0 8784.2 8881.3 8887.8 8899.4 8912.6 2110.1 2347.1 2371.8 2395.9 2400.1 2451.5 2461.0 2467.0 2467.5 2467.9 2373.1 2405.9 2416.3 2425.8 2426.6 2303.4 2339.1 2350.1 2350.9 2389.4 2420.1 2421.6 2422.3 2428.9 2436.6 9019.1 9068.6 9087.7 9095.0 9108.5 5201.3 5227.5 5261.7 5338.2 5340.8 3120.9 3313.3 3347.9 3350.6 3421.3 1129.8 1196.4 1201.9 1202.2 1207.3 12037.5 12106.0 12500.1 12541.2 12607.1 4363.9 4472.7 4616.4 4673.0 4703.1 9964.9 9969.7 9970.9 9974.5 9991.0 5280.1 5283.2 5288.0 5288.3 5289.6 4358.1 4726.9 4842.9 4912.2 4936.0 3899.3 3989.2 4036.3 4065.2 4097.9 1192.5 1218.9 1222.7 1226.8 1229.9 976.0 990.7 993.2 994.5 999.6 6054.6 6070.0 6088.8 6091.4 6260.6 474.3 479.8 486.9 494.4 495.7 4126.0 4231.4 4272.2 4377.1 4492.0 10815.4 10888.6 10974.7 10987.7 11022.8 10864.6 10870.2 10881.7 10921.3 10935.8 8087.8 8376.9 8397.0 8414.7 8567.7 6209.0 6404.1 6500.7 6514.5 6583.9 10289.9 10318.8 10440.5 10678.7 10705.7 10466.4 10510.3 10561.8 10586.0 10598.2 7797.1 7829.6 7837.1 7887.5 7901.3 8293.6 8343.5 8348.2 8359.4 8395.2 7448.7 7587.1 7603.6 7615.3 7793.6 7372.3 7376.4 7378.4 7535.8 7675.4 6753.5 6850.1 6854.4 6863.9 6878.2 5230.4 5292.7 5342.3 5450.8 5525.4 5332.4 5347.7 5375.9 5379.5 5652.3 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | [#4] prototype.html Cycles:180 Average:4604.94 Median:5277.75 stddev:1352.57 (25.6%) stddev-sans-first:1317.46 05:05:28 INFO - PROCESS | 15969 | Values: 314.1 323.2 326.4 330.3 331.9 5091.6 5185.1 5190.0 5269.2 5310.5 5131.3 5165.6 5211.8 5215.0 5223.9 4063.8 4118.8 4120.5 4127.5 4130.8 3923.8 4093.9 4148.2 4155.1 4156.4 4071.7 4071.7 4075.0 4078.3 4089.1 4055.1 4058.8 4065.4 4075.7 4101.5 3609.3 3622.0 3630.2 3640.5 3643.5 5033.8 5057.7 5059.5 5072.4 5082.7 4584.5 4588.5 4617.2 4617.5 4619.8 5392.2 5393.8 5395.8 5400.1 5408.9 3795.1 3887.4 3891.2 3896.9 3902.1 5589.0 5622.7 5628.5 5633.7 5643.5 3993.9 3996.9 4004.7 4013.9 4026.0 3817.4 4041.1 4045.6 4070.2 4075.2 4597.1 4630.7 4631.4 4638.6 4642.2 5486.3 5486.9 5494.0 5508.5 5528.0 1322.4 1343.8 1368.0 1382.6 1394.5 935.5 947.0 958.2 963.1 974.4 5210.9 5226.3 5262.7 5271.7 5283.8 5529.3 5548.9 5554.8 5570.3 5571.9 5051.6 5249.4 5293.2 5301.7 5304.9 2957.3 2964.2 2984.7 2990.6 2998.7 5876.2 5889.4 5890.8 5891.8 5898.6 5556.7 5700.2 5707.0 5714.5 5750.5 5795.8 5796.9 5816.7 5817.0 5826.9 5363.3 5552.3 5620.7 5632.5 5658.7 5576.2 5579.2 5582.0 5582.7 5603.3 5827.7 5854.3 5861.2 5865.9 5878.5 3916.7 4012.4 4021.7 4026.2 4042.5 5345.8 5546.4 5564.4 5575.8 5603.8 5315.0 5441.9 5457.8 5467.4 5503.0 5443.2 5451.0 5462.5 5463.5 5489.6 5191.9 5360.5 5389.7 5392.4 5397.2 5419.2 5431.5 5440.6 5460.0 5475.3 5379.9 5385.8 5406.3 5413.8 5421.3 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - PROCESS | 15969 | [#5] yui.html Cycles:180 Average:21450.70 Median:4705.53 stddev:31583.41 (671.2%) stddev-sans-first:31633.82 05:05:28 INFO - PROCESS | 15969 | Values: 767.0 781.5 784.4 790.5 857.1 15845.6 17493.7 17503.8 17511.6 17528.8 15691.4 15700.7 15853.1 15861.7 15875.4 666.8 785.5 805.5 806.2 822.7 808.4 818.3 818.6 819.1 820.2 863.2 864.5 865.0 865.4 867.6 696.6 834.7 854.8 855.3 856.5 634.0 635.4 635.5 635.6 635.8 14365.2 14414.5 14429.6 14447.9 14491.3 13718.4 14263.4 14797.6 14843.7 15090.8 12782.9 12948.7 13016.2 13053.8 13250.3 4457.8 4545.9 4551.1 4561.2 4753.8 81246.2 82292.0 82516.0 84168.0 85543.0 10899.1 11144.6 11426.7 11475.5 11646.1 21253.7 21521.8 21561.1 21562.8 21616.6 8118.2 8270.5 8311.7 8540.2 8826.0 4694.9 4736.4 4743.0 4847.7 4886.9 3592.3 3679.4 3699.7 3715.4 3723.1 613.5 620.6 630.1 636.2 646.1 602.8 640.7 647.3 656.4 681.6 9835.8 10074.5 10216.5 10268.8 10555.5 611.5 632.6 640.5 688.1 698.9 4578.7 4716.2 4792.6 4822.6 4828.1 71072.0 94468.1 127042.4 128867.0 134278.0 65588.0 71190.6 105157.0 106393.5 108332.5 97333.5 100327.5 101388.0 101724.0 102792.0 9503.2 9769.9 9870.1 9921.6 9936.0 57158.0 57267.4 57338.1 59104.0 60261.4 75278.9 85620.0 86280.0 86598.0 86897.0 10466.4 10938.1 11030.6 11208.2 11368.1 12828.9 12844.7 13099.9 13946.7 13971.4 12716.2 12881.7 13336.7 13380.0 13387.3 11696.2 12652.6 12830.6 12950.2 12964.2 11899.3 11970.5 12302.6 12808.4 12822.7 9538.9 9866.0 10143.3 10339.2 10419.3 9366.3 9903.4 10481.8 10521.6 11689.6 05:05:28 INFO - PROCESS | 15969 | -------- Summary: end -------- 05:05:28 INFO - PROCESS | 15969 | 05:05:28 INFO - TEST-INFO | 15969: exit 0 05:05:28 INFO - TEST-OK | dromaeo_css | took 1115010ms 05:05:28 INFO - TEST-START | kraken 05:05:28 INFO - operating with platform_type : linux_ 05:05:28 INFO - Initialising browser for kraken test... 05:05:28 INFO - TEST-INFO | started process 16276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwDwX5M/profile http://localhost:37711/getInfo.html) 05:05:32 INFO - PROCESS | 16276 | __metrics Screen width/height:1600/1200 05:05:32 INFO - PROCESS | 16276 | colorDepth:24 05:05:32 INFO - PROCESS | 16276 | Browser inner width/height: 1024/697 05:05:32 INFO - PROCESS | 16276 | __metrics 05:05:33 INFO - PROCESS | 16276 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:33 INFO - PROCESS | 16276 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:33 INFO - PROCESS | 16276 | console.error: PushService: 05:05:33 INFO - PROCESS | 16276 | stateChangeProcessEnqueue: Error transitioning state 05:05:33 INFO - PROCESS | 16276 | UnknownError 05:05:34 INFO - TEST-INFO | 16276: exit 0 05:05:34 INFO - Browser initialized. 05:05:34 INFO - Running cycle 1/1 for kraken test... 05:05:34 INFO - TEST-INFO | started process 16358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwDwX5M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:46 INFO - PROCESS | 16358 | RSS: Main: 156557312 05:05:46 INFO - PROCESS | 16358 | 05:05:48 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37711/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:49 INFO - PROCESS | 16358 | RSS: Main: 213520384 05:05:49 INFO - PROCESS | 16358 | 05:05:52 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37711/tests/kraken/driver.html?testName=audio-dft) 05:05:52 INFO - PROCESS | 16358 | RSS: Main: 191983616 05:05:52 INFO - PROCESS | 16358 | 05:05:55 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37711/tests/kraken/driver.html?testName=audio-fft) 05:05:56 INFO - PROCESS | 16358 | RSS: Main: 268734464 05:05:56 INFO - PROCESS | 16358 | 05:05:58 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37711/tests/kraken/driver.html?testName=audio-oscillator) 05:05:58 INFO - PROCESS | 16358 | RSS: Main: 180121600 05:05:58 INFO - PROCESS | 16358 | 05:06:01 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:01 INFO - PROCESS | 16358 | RSS: Main: 184160256 05:06:01 INFO - PROCESS | 16358 | 05:06:04 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37711/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:05 INFO - PROCESS | 16358 | RSS: Main: 220790784 05:06:05 INFO - PROCESS | 16358 | 05:06:08 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37711/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:09 INFO - PROCESS | 16358 | RSS: Main: 220581888 05:06:09 INFO - PROCESS | 16358 | 05:06:11 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37711/tests/kraken/driver.html?testName=json-parse-financial) 05:06:12 INFO - PROCESS | 16358 | RSS: Main: 220041216 05:06:12 INFO - PROCESS | 16358 | 05:06:14 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:14 INFO - PROCESS | 16358 | RSS: Main: 184209408 05:06:14 INFO - PROCESS | 16358 | 05:06:16 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:17 INFO - PROCESS | 16358 | RSS: Main: 189943808 05:06:17 INFO - PROCESS | 16358 | 05:06:19 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:19 INFO - PROCESS | 16358 | RSS: Main: 195051520 05:06:19 INFO - PROCESS | 16358 | 05:06:22 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:22 INFO - PROCESS | 16358 | RSS: Main: 190439424 05:06:22 INFO - PROCESS | 16358 | 05:06:25 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:26 INFO - PROCESS | 16358 | RSS: Main: 193150976 05:06:26 INFO - PROCESS | 16358 | 05:06:27 INFO - PROCESS | 16358 | Cycle 1(1): loaded http://localhost:37711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37711/tests/kraken/driver.html?testName=ai-astar) 05:06:28 INFO - PROCESS | 16358 | RSS: Main: 243204096 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | __start_tp_report 05:06:28 INFO - PROCESS | 16358 | _x_x_mozilla_page_load 05:06:28 INFO - PROCESS | 16358 | _x_x_mozilla_page_load_details 05:06:28 INFO - PROCESS | 16358 | |i|pagename|runs| 05:06:28 INFO - PROCESS | 16358 | |0;ai-astar;104;112;111;111;114;113;111;112;111;112 05:06:28 INFO - PROCESS | 16358 | |1;audio-beat-detection;156;116;118;174;123;125;142;117;154;117 05:06:28 INFO - PROCESS | 16358 | |2;audio-dft;161;161;161;160;160;160;160;162;160;160 05:06:28 INFO - PROCESS | 16358 | |3;audio-fft;76;75;74;132;75;75;74;76;98;75 05:06:28 INFO - PROCESS | 16358 | |4;audio-oscillator;83;83;125;84;84;84;118;85;84;135 05:06:28 INFO - PROCESS | 16358 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;117 05:06:28 INFO - PROCESS | 16358 | |6;imaging-darkroom;146;146;145;145;145;145;146;146;145;145 05:06:28 INFO - PROCESS | 16358 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;94;95 05:06:28 INFO - PROCESS | 16358 | |8;json-parse-financial;50;49;48;49;49;50;55;49;49;49 05:06:28 INFO - PROCESS | 16358 | |9;json-stringify-tinderbox;61;61;60;61;62;59;60;60;60;62 05:06:28 INFO - PROCESS | 16358 | |10;stanford-crypto-aes;76;76;77;75;76;76;76;77;76;81 05:06:28 INFO - PROCESS | 16358 | |11;stanford-crypto-ccm;122;122;121;128;123;120;129;121;155;139 05:06:28 INFO - PROCESS | 16358 | |12;stanford-crypto-pbkdf2;163;158;166;161;158;157;162;162;157;158 05:06:28 INFO - PROCESS | 16358 | |13;stanford-crypto-sha256-iterative;66;62;63;62;63;62;62;65;61;61 05:06:28 INFO - PROCESS | 16358 | __end_tp_report 05:06:28 INFO - PROCESS | 16358 | __start_cc_report 05:06:28 INFO - PROCESS | 16358 | _x_x_mozilla_cycle_collect,1640 05:06:28 INFO - PROCESS | 16358 | __end_cc_report 05:06:28 INFO - PROCESS | 16358 | __startTimestamp1470398788039__endTimestamp 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | ------- Summary: start ------- 05:06:28 INFO - PROCESS | 16358 | Number of tests: 14 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.69 (2.4%) stddev-sans-first:1.05 05:06:28 INFO - PROCESS | 16358 | Values: 104.0 112.0 111.0 111.0 114.0 113.0 111.0 112.0 111.0 112.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:133.50 stddev:20.84 (15.6%) stddev-sans-first:20.55 05:06:28 INFO - PROCESS | 16358 | Values: 156.0 116.0 118.0 174.0 123.0 125.0 142.0 117.0 154.0 117.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 05:06:28 INFO - PROCESS | 16358 | Values: 161.0 161.0 161.0 160.0 160.0 160.0 160.0 162.0 160.0 160.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:18.68 (24.9%) stddev-sans-first:19.65 05:06:28 INFO - PROCESS | 16358 | Values: 76.0 75.0 74.0 132.0 75.0 75.0 74.0 76.0 98.0 75.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:84.00 stddev:20.76 (24.7%) stddev-sans-first:21.44 05:06:28 INFO - PROCESS | 16358 | Values: 83.0 83.0 125.0 84.0 84.0 84.0 118.0 85.0 84.0 135.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:06:28 INFO - PROCESS | 16358 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:06:28 INFO - PROCESS | 16358 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:06:28 INFO - PROCESS | 16358 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:49.00 stddev:1.95 (4.0%) stddev-sans-first:2.06 05:06:28 INFO - PROCESS | 16358 | Values: 50.0 49.0 48.0 49.0 49.0 50.0 55.0 49.0 49.0 49.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 05:06:28 INFO - PROCESS | 16358 | Values: 61.0 61.0 60.0 61.0 62.0 59.0 60.0 60.0 60.0 62.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:1.65 (2.2%) stddev-sans-first:1.73 05:06:28 INFO - PROCESS | 16358 | Values: 76.0 76.0 77.0 75.0 76.0 76.0 76.0 77.0 76.0 81.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:125.50 stddev:11.11 (8.8%) stddev-sans-first:11.57 05:06:28 INFO - PROCESS | 16358 | Values: 122.0 122.0 121.0 128.0 123.0 120.0 129.0 121.0 155.0 139.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.50 stddev:3.05 (1.9%) stddev-sans-first:3.06 05:06:28 INFO - PROCESS | 16358 | Values: 163.0 158.0 166.0 161.0 158.0 157.0 162.0 162.0 157.0 158.0 05:06:28 INFO - PROCESS | 16358 | 05:06:28 INFO - PROCESS | 16358 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.64 (2.6%) stddev-sans-first:1.22 05:06:28 INFO - PROCESS | 16358 | Values: 66.0 62.0 63.0 62.0 63.0 62.0 62.0 65.0 61.0 61.0 05:06:28 INFO - PROCESS | 16358 | -------- Summary: end -------- 05:06:28 INFO - PROCESS | 16358 | 05:06:29 INFO - TEST-INFO | 16358: exit 0 05:06:29 INFO - TEST-OK | kraken | took 60178ms 05:06:29 INFO - SUITE-END | took 1175s 05:06:29 INFO - Completed test suite (00:19:35) 05:06:29 INFO - javascript benchmark 05:06:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.6216722909635, 3050.557669137974, 3068.171593669709, 3077.322988942432, 3085.043636472694, 5203.947960520393, 5246.475352464761, 5286.709230992299, 5353.250544923709, 5384.6769193848395, 5253.763580638871, 5312.973435132819, 5320.893582128355, 5345.893082138355, 5407.729613519328, 4741.620670346372, 4802.303665968432, 4828.686135401205, 4829.468758436569, 5028.396592408916, 4937.456879743226, 4944.678595891273, 4973.154563724175, 4991.401031876162, 4993.375828021497, 4709.952900470986, 4819.325294458778, 4874.65877388583, 4884.438289596671, 4891.926621100686, 4754.66717329787, 4781.043791241731, 4788.042391521675, 4795.832145874912, 4875.488073752241, 4805.495422980606, 4828.927566086511, 4830.130576496229, 4835.709857408531, 4890.682105663121, 5153.201253805666, 5242.135047717122, 5253.474652534755, 5278.551323137538, 5325.254464374991, 5613.578981576357, 5676.176954341598, 5682.943170568283, 5687.601867869251, 5704.429557044304, 5721.227634269362, 5725.112607545837, 5726.4273572642405, 5726.570507211975, 5744.195812586241, 5148.279240906276, 5183.714895680736, 5202.895942081137, 5215.713135777492, 5288.444713305124, 5745.827625171251, 5750.0, 5756.7121643917635, 5761.48146666802, 5764.538836893039, 5519.061759500894, 5539.2522009529, 5548.140038294071, 5557.5553955683445, 5572.498475137257, 5458.153986132076, 5601.047821870292, 5661.235733176051, 5675.262215911905, 5745.080787074048, 5664.291963504562, 5668.489835914705, 5673.404292549306, 5678.14827775837, 5678.290213723285, 5634.126710359901, 5668.121441176624, 5674.914876276859, 5685.772569097273, 5687.857803554944, 4208.831646734157, 4272.209641216385, 4276.657867370603, 4310.892227694333, 4321.9135617287475, 3891.4357418174204, 3923.489946306962, 3937.27160475313, 3939.862104826317, 3971.860984865516, 5455.890882182334, 5467.9453205467435, 5468.535174510212, 5472.699001554953, 5520.696361700065, 5529.502344788988, 5627.212190293362, 5766.509846662997, 5781.132830075522, 5787.045137552257, 5329.307190065267, 5362.839114826562, 5382.650127741685, 5414.18787181918, 5424.0, 4951.183054795991, 4960.553550180501, 4962.627802914796, 4964.528369804862, 4972.204447288416, 5646.604737668488, 5743.511801496919, 5912.17229587858, 5921.763129474859, 5924.081767325985, 5561.610687252015, 5567.0, 5577.330720313588, 5611.438856114356, 5632.971835140798, 5735.053716136791, 5742.425757424224, 5743.339515955551, 5744.999999999833, 5766.279215098113, 5371.677699338053, 5481.095619222943, 5517.2275881377445, 5532.30846144232, 5544.500994910478, 5660.349059858005, 5713.342965559014, 5730.283714535683, 5742.16738572913, 5742.28221472316, 5543.667379957215, 5584.553235741212, 5594.1608758686525, 5594.916076258941, 5597.076482380362, 5329.7068661224, 5463.945360546502, 5551.389347171888, 5552.611317207757, 5557.194206840067, 5410.080286351251, 5483.287172667528, 5484.232207491034, 5521.585881058856, 5535.335759708861, 5564.693941833238, 5577.916331254954, 5606.439356064361, 5619.381867994599, 5625.493705566519, 5324.068288049499, 5343.211595355983, 5455.9454405455435, 5464.043792336404, 5470.507654311131], "value": 5226.997531922583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9113537401703, 572.1841567496093, 592.8903152916708, 603.78263825023, 607.8510764862609, 43380.56619433805, 45002.0, 45038.54961450385, 45070.32394514085, 49082.263766043536, 46026.539734602644, 46489.535104648945, 46577.53422465774, 46579.06841863161, 46613.30080048802, 9063.27493800496, 9216.815663686722, 9221.769455763593, 9224.30817688676, 9226.446413215195, 9118.635254589808, 9198.03420640833, 9205.493697846616, 9210.769730756718, 9216.861747073799, 9202.907970920272, 9236.3996340238, 9246.491442970633, 9258.72223833286, 9263.536823158849, 9181.357304988653, 9217.986021537625, 9223.492707901063, 9227.584758685874, 9263.166315031613, 8504.659813607448, 8573.228409443118, 8574.228319451217, 8575.313974881994, 8582.270507006911, 43893.341599876025, 44308.77845610784, 44312.11375772499, 44358.778206108764, 44397.0, 3534.734894882894, 3718.9442158367647, 3760.2667479841443, 3940.6059394060367, 4225.450691410128, 33132.3373532528, 34205.0, 34315.313693725984, 34706.65293347085, 34949.82525087384, 4432.734035957853, 4475.619572336355, 4514.074614703978, 4519.141363140992, 4673.0, 253808.0, 254559.0, 255137.0, 255170.72414637994, 255494.0, 57886.71056644774, 57977.710111449174, 58426.41573584295, 58456.41543584595, 58497.12254316189, 60958.0, 61344.079838802456, 61397.693011534655, 61426.692866535384, 61486.38513614896, 15302.770458443132, 15392.538223853302, 15396.846031539766, 15471.458498952483, 15473.22633868302, 12028.037756979596, 12073.758524829454, 12082.093842961638, 12109.455074521667, 12111.87888121125, 13365.465381384636, 16286.51140465788, 16529.586760330847, 16568.6686266274, 16604.58488537796, 5748.425157484218, 6597.406233439014, 6680.6993685283305, 6708.865822683519, 6800.93199068003, 1014.3052009373603, 1088.2817340555196, 1128.8983991440646, 1199.7942068221382, 1205.4153735438306, 33243.0, 33979.66020339815, 34110.317793644484, 34237.828810856285, 34303.828480857934, 1168.5092261250295, 1170.5434880396651, 1199.412287978884, 1231.858336291338, 1257.4278703190027, 17509.0, 17707.291708331522, 17905.820941790415, 17908.9104554479, 17951.371701990367, 607336.0, 609246.0, 609496.0, 609911.0, 611590.0, 59785.40214597798, 59909.0, 60171.09743353853, 60171.69914150401, 60287.397126028176, 1217.9086568507398, 1342.5770882172085, 1354.5597680753795, 1360.9523666671619, 1366.719822436418, 33087.0, 34628.65371346355, 34736.478952815225, 34844.30311393707, 35047.824760876036, 50105.74947125241, 50814.74592627013, 50831.491685084155, 50869.236961446346, 50913.745431272604, 331159.0, 333353.0, 333536.0, 333668.0, 333959.0, 27375.452490949672, 28722.0, 28769.424611507235, 30420.84789576038, 30481.695183047887, 49386.0, 49412.0, 49610.75194624004, 49932.750336248086, 51223.48776512187, 40144.79927600343, 40823.0, 40897.18205635811, 41891.581084188765, 42718.0, 40434.59565404426, 41264.1747165061, 41482.37776433295, 42639.786801067035, 43149.352759709254, 40849.795751021054, 41985.58014419817, 42099.158016838875, 42453.787731061144, 42679.0, 35549.0, 37933.24133517369, 38012.23975520419, 38347.65783197686, 39013.21973560569, 29139.417211655225, 29381.559276611297, 29555.55666665045, 29670.0, 29928.70071299259], "value": 20194.28885074105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1936127644926, 389.29148948912973, 398.34472293077886, 399.7661368099662, 420.64665680828097, 14390.352434140463, 18230.544236394082, 20126.59746805063, 20149.294774682872, 20437.591248175027, 19394.90302548485, 19578.314758983437, 19869.0, 19869.10589023494, 20032.49918752032, 5596.776128954837, 5703.800366987167, 5789.363170051291, 5894.823155305347, 5895.498882594985, 5752.0, 5828.737706803204, 5838.182654428383, 5846.795362162326, 5848.590598658096, 5647.43525647434, 5794.130880367937, 5801.53587712982, 5812.0, 5833.82498525045, 5793.217915581406, 5826.796062137805, 5837.299524057098, 5838.503727183194, 5842.853928651775, 5083.0, 5151.484851514856, 5166.664166829181, 5193.610479214036, 5202.76587553561, 23223.53552928932, 23462.061517539278, 23513.41216469585, 23574.76425235743, 23748.406289842893, 2320.9651855222187, 2359.893804778789, 2379.202967006055, 2399.712034555847, 2428.805695544352, 14341.354639041163, 14641.121532708072, 14732.705345893022, 14998.47505337308, 15267.923660381739, 1928.4600311912686, 1974.2103158736477, 2023.5345870449733, 2025.5037515808574, 2035.9592808143902, 78057.21942780557, 85078.0, 85244.57377713072, 85574.0, 86529.13470865274, 11342.376169310766, 11462.140339474572, 11617.767644647229, 11664.591739289084, 11806.822897656542, 16260.268287927072, 16275.186240687919, 16291.511254662379, 16303.83696163047, 16310.429134980219, 7680.34717049046, 8097.595120243965, 8124.471909325875, 8211.87948579536, 8281.95859020701, 7639.083310002835, 7683.846323073507, 7751.612419379008, 7831.295183433518, 7914.881276780853, 4793.9280910786365, 4805.687630304089, 4866.6350023747655, 4888.828890988798, 4980.228064649985, 1930.8744931579402, 1988.1351612048804, 1989.532459871929, 2032.1160295271604, 2093.1836583732356, 921.9308551858637, 939.6335429182624, 953.8092381523584, 954.2795189631784, 1039.9948000259951, 19200.423987280403, 20821.479463013548, 20917.0, 21118.316285524565, 21146.577068458853, 959.3828136262224, 964.4695417520336, 993.2054356514759, 1014.5789497358661, 1062.697131317571, 10956.397398143019, 11494.662803081095, 11581.594644187413, 11662.94168529152, 11704.70738231534, 533690.0, 540013.0, 540232.0, 543224.0, 543540.0, 87416.562917185, 91042.0, 92088.0, 97994.0, 105379.473102634, 977.1498796047484, 987.0918754745651, 1006.4565134827258, 1032.5250384822916, 1033.7312298802365, 18075.638487230444, 18348.90825545864, 18756.343527976456, 18867.245310187438, 19236.326728564993, 30703.539446908762, 32694.50958235676, 33994.490082648284, 45104.323435147846, 45751.77124114491, 60060.0, 63849.6807515978, 64882.0, 65259.02111468237, 66160.0, 8550.444221125606, 8633.525156116222, 8823.955880220814, 8982.101789820965, 9003.684871029482, 9856.605735770489, 12492.937535312265, 13668.179909205479, 13952.441902323793, 14042.578722638336, 11154.16343774204, 11607.941960290145, 12062.336571488653, 12176.208546444454, 12639.0, 11745.354005529778, 11776.646700598996, 11945.761084778082, 11958.162928594915, 12179.147459677737, 11266.324020558794, 12002.339871307162, 12130.33283169434, 12415.62753117408, 12537.122401431812, 7641.847163056596, 8673.34949878749, 8806.603702833516, 8884.511351875708, 9115.817683646423, 11430.371329576954, 11621.88378116208, 11866.82199766987, 12126.514939402325, 12505.249265103075], "value": 9477.049111321481, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.7865252233382, 1432.0977783996084, 1498.6403263216826, 1618.7167245731994, 1769.796473405558, 8401.621927013284, 8760.518171500566, 8795.516246606441, 8926.107389261071, 8966.0, 8784.1655042771, 8881.289496840254, 8887.822243555125, 8899.377043606934, 8912.598933048028, 2110.124298416163, 2347.0611755297846, 2371.762823717623, 2395.9281221563383, 2400.063975049732, 2451.460678650694, 2461.0, 2467.0255249176566, 2467.5064987002584, 2467.8889449974704, 2373.1100837186054, 2405.8556486610773, 2416.2992732107755, 2425.818063645225, 2426.5510880487077, 2303.4126297794123, 2339.122828939148, 2350.118705485443, 2350.917717879866, 2389.390705370137, 2420.0803694596116, 2421.61254199329, 2422.2733180045916, 2428.9271321860374, 2436.6466862304865, 9019.098090190993, 9068.591913363849, 9087.681931132378, 9095.045020272843, 9108.453492790388, 5201.297824793643, 5227.529522342969, 5261.684298942076, 5338.172583249602, 5340.786368545292, 3120.8595613197235, 3313.2545177335146, 3347.9497807532907, 3350.5811773528308, 3421.298633780069, 1129.779692959873, 1196.425715656481, 1201.891829735328, 1202.2485946283573, 1207.3118322556147, 12037.518499260019, 12106.0, 12500.124991250615, 12541.247525148521, 12607.11750177488, 4363.869083927487, 4472.686911916199, 4616.3998680172035, 4672.976635116803, 4703.129920964564, 9964.850527242097, 9969.651062212788, 9970.900290997142, 9974.451405172786, 9991.0, 5280.102382594968, 5283.181106928432, 5287.9735601321745, 5288.286081378965, 5289.576833853283, 4358.063016451478, 4726.929096063562, 4842.903141937141, 4912.189488734391, 4935.975320123448, 3899.2786334528205, 3989.1849208610015, 4036.3138266494766, 4065.2276067547073, 4097.8770636880945, 1192.522990803668, 1218.8537375514995, 1222.743223922986, 1226.7975783995719, 1229.8524177098805, 975.9658411955547, 990.6879333010223, 993.1607791416242, 994.5027486256871, 999.6051559633904, 6054.636721796706, 6070.028795392716, 6088.756449742049, 6091.390860913962, 6260.624362538262, 474.25305144397714, 479.84644913627307, 486.868545492715, 494.42646530024996, 495.65799598277073, 4125.97937010319, 4231.386448964883, 4272.230998420252, 4377.124575084996, 4492.011757413364, 10815.40515271652, 10888.564457421615, 10974.725631859108, 10987.670369888916, 11022.779544409066, 10864.565417383215, 10870.239083264096, 10881.727956800985, 10921.344719316867, 10935.781284374269, 8087.838243235103, 8376.874346884802, 8397.034341050858, 8414.747557573282, 8567.74296771098, 6208.968955155376, 6404.135441715495, 6500.707468164039, 6514.4788416925585, 6583.934160658524, 10289.897101029193, 10318.845217321596, 10440.477976101316, 10678.679639610824, 10705.732356691145, 10466.372017678963, 10510.348246375015, 10561.841572376574, 10586.0, 10598.20513461478, 7797.103333116765, 7829.647665855164, 7837.098733645704, 7887.526748395115, 7901.288884000468, 8293.62678679473, 8343.54110523927, 8348.248657620843, 8359.414840961075, 8395.202455766692, 7448.685614028058, 7587.127480339832, 7603.581803000888, 7615.276548728084, 7793.610319484116, 7372.2627737227995, 7376.409887209118, 7378.4466165036765, 7535.773926782205, 7675.4243431741725, 6753.459723222229, 6850.075239842757, 6854.383105520527, 6863.931360686529, 6878.209005964378, 5230.372355317386, 5292.7353632319, 5342.278792362981, 5450.809221677222, 5525.392206857162, 5332.413434522122, 5347.705876176848, 5375.865603359947, 5379.462053794589, 5652.293463317085], "value": 4614.6578720831085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.10010320431957, 323.18073683213055, 326.4287496880459, 330.2519792669604, 331.92199833039217, 5091.567216786569, 5185.118529849925, 5190.029627335091, 5269.156934890419, 5310.4955029272205, 5131.255967884655, 5165.63840531163, 5211.817586384477, 5214.973925130378, 5223.869403264911, 4063.7764922929227, 4118.773467459288, 4120.464339635843, 4127.463429754128, 4130.793460326987, 3923.784191869446, 4093.89765255868, 4148.191102734968, 4155.127423241108, 4156.418101465797, 4071.694622903279, 4071.7149799514045, 4075.042365044227, 4078.327076032466, 4089.1208390196102, 4055.1078762672314, 4058.756474611518, 4065.4105154752397, 4075.673946084306, 4101.5488296287385, 3609.314230296235, 3621.981890090559, 3630.1832087780303, 3640.4721315409383, 3643.4899114124046, 5033.7734801934, 5057.69653820772, 5059.494050594948, 5072.442031376546, 5082.74586270685, 4584.541545845389, 4588.518205588432, 4617.168909596271, 4617.468991066037, 4619.838305659319, 5392.245085688007, 5393.83818485446, 5395.811146609889, 5400.108982017962, 5408.864778380533, 3795.1460921292764, 3887.3974533947285, 3891.1828516011387, 3896.902577435558, 3902.1415288636454, 5589.0, 5622.746976386073, 5628.465295796893, 5633.746481408305, 5643.492085712305, 3993.940090898639, 3996.900077498086, 4004.6996475264473, 4013.8795836124377, 4025.959740402617, 3817.408301713239, 4041.131156801302, 4045.554988951213, 4070.206309769626, 4075.1645912587846, 4597.103564804831, 4630.6758526902795, 4631.444226692818, 4638.582527572535, 4642.210824159901, 5486.259354987105, 5486.945130548724, 5493.972530137324, 5508.504234618904, 5527.972360138254, 1322.3983087695076, 1343.7715588350004, 1367.9658008549866, 1382.5783136143373, 1394.4770710983382, 935.4854829843558, 946.990530094704, 958.1568219966385, 963.0706368354431, 974.4056125763278, 5210.869728256748, 5226.320578324793, 5262.684238945675, 5271.71005594696, 5283.788648454096, 5529.3364796223905, 5548.889022219533, 5554.833354999357, 5570.3315602127195, 5571.860703482364, 5051.595872330205, 5249.370075590953, 5293.206019097166, 5301.6818990860675, 5304.92042619361, 2957.275467510474, 2964.2293003819163, 2984.731374176291, 2990.5813186153955, 2998.7001299870276, 5876.177335173079, 5889.440503152194, 5890.764369425175, 5891.764329426861, 5898.587098903122, 5556.749731310423, 5700.230468886647, 5706.9714651426475, 5714.485696287354, 5750.482456578928, 5795.768169273182, 5796.913046304308, 5816.651000939957, 5817.022212447619, 5826.883462330645, 5363.329583802025, 5552.278203833637, 5620.718964051863, 5632.5212356950115, 5658.717064146858, 5576.219329293983, 5579.191017302387, 5581.962583657018, 5582.748776304995, 5603.271574695426, 5827.668932427063, 5854.326752423526, 5861.238039054895, 5865.94134058654, 5878.470937615635, 3916.706247031427, 4012.378081397388, 4021.6782657387926, 4026.1947610478605, 4042.4744783178, 5345.819237553649, 5546.389897111395, 5564.415736347625, 5575.832725018256, 5603.831885043455, 5315.0, 5441.918371224356, 5457.781688732565, 5467.425920278472, 5502.972485137549, 5443.210734443404, 5451.0, 5462.453754624665, 5463.480969308069, 5489.58828087887, 5191.870203244949, 5360.544353729977, 5389.730513474389, 5392.433794451683, 5397.190421436816, 5419.241306217212, 5431.511163995259, 5440.564754819684, 5460.0, 5475.315585551806, 5379.919301210563, 5385.8114965977575, 5406.297181366397, 5413.754836387574, 5421.2681288025615], "value": 4173.474137409104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.9769906902792, 781.4764108047608, 784.4113182191475, 790.4585359029065, 857.0957639690124, 15845.603859903495, 17493.650126997454, 17503.82496175038, 17511.562210944718, 17528.824711752877, 15691.37234510621, 15700.685986280267, 15853.128077955736, 15861.682766344666, 15875.36498540057, 666.8399584099806, 785.4972817396871, 805.512664837772, 806.238104990781, 822.724387330242, 808.3775492870486, 818.2880893622527, 818.5825229133155, 819.1439945257191, 820.1634332980357, 863.1842908451516, 864.5417928497906, 864.9524276164808, 865.446114486729, 867.5575456517158, 696.613379574336, 834.6995081770558, 854.8076682746395, 855.3072011670566, 856.5203486047833, 633.96196228226, 635.428114696772, 635.5487603801307, 635.5900444213503, 635.8187916443837, 14365.209913454755, 14414.495492657707, 14429.639259018504, 14447.855521444757, 14491.347889345005, 13718.38267277975, 14263.358148883326, 14797.630059248497, 14843.703125937422, 15090.773638395432, 12782.936085319514, 12948.741025179444, 13016.219026858418, 13053.804192937114, 13250.3374831259, 4457.77711114443, 4545.906299071736, 4551.067031258584, 4561.156186105548, 4753.809847606126, 81246.18753812504, 82292.0, 82516.0, 84168.0, 85543.0, 10899.1280697544, 11144.554217831359, 11426.714332141762, 11475.483603237873, 11646.126540509496, 21253.68119478178, 21521.78478215198, 21561.137554497956, 21562.78437215608, 21616.567668646538, 8118.188181181835, 8270.545120018336, 8311.667533298722, 8540.23137917578, 8825.955870220609, 4694.859154225379, 4736.4316282046375, 4743.0, 4847.660663753574, 4886.877828054327, 3592.2815436912724, 3679.392900171495, 3699.6855267302044, 3715.3869611514338, 3723.106454450912, 613.4540259169343, 620.5935112501319, 630.1461519640912, 636.1507387637463, 646.0954663471178, 602.7860109661007, 640.7308930249307, 647.3009150117862, 656.3600489522772, 681.5842336174929, 9835.75410614726, 10074.496275186211, 10216.540255688511, 10268.794624107475, 10555.525001374803, 611.5199568338833, 632.6046221111806, 640.4780104215143, 688.0985908459834, 698.9021536984826, 4578.725276483355, 4716.198246298069, 4792.616590672737, 4822.590079843182, 4828.111087344743, 71072.0, 94468.0553194473, 127042.36478817547, 128867.0, 134278.0, 65588.0, 71190.64404677943, 105157.0, 106393.4680326609, 108332.45833770938, 97333.51333243288, 100327.49836250771, 101388.0, 101724.0, 102792.0, 9503.239740820856, 9769.902300976899, 9870.062344077302, 9921.603135874484, 9936.0, 57158.0, 57267.42732572621, 57338.13992790028, 59104.0, 60261.39738602733, 75278.87081693669, 85620.0, 86280.0, 86598.0, 86897.0, 10466.424346661006, 10938.130514275581, 11030.613928512463, 11208.215424920178, 11368.147388946027, 12828.935855320664, 12844.678883027998, 13099.934500327437, 13946.651333716738, 13971.371288291848, 12716.237025778482, 12881.742365152832, 13336.733010364, 13380.0, 13387.330633468093, 11696.239744416585, 12652.557160499338, 12830.615081547568, 12950.158239714388, 12964.157329773912, 11899.345535995257, 11970.46132924038, 12302.630921072383, 12808.359582020676, 12822.67943301425, 9538.85691714611, 9866.0, 10143.34068285559, 10339.172866170538, 10419.254271106123, 9366.250699944125, 9903.356281841658, 10481.842772358574, 10521.579136834442, 11689.649310520697], "value": 7579.202992079891, "unit": "score"}], "name": "dromaeo_css", "value": 7256.773930375621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 111.0, 114.0, 113.0, 111.0, 112.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 116.0, 118.0, 174.0, 123.0, 125.0, 142.0, 117.0, 154.0, 117.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 132.0, 75.0, 75.0, 74.0, 76.0, 98.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 125.0, 84.0, 84.0, 84.0, 118.0, 85.0, 84.0, 135.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 48.0, 49.0, 49.0, 50.0, 55.0, 49.0, 49.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 59.0, 60.0, 60.0, 60.0, 62.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 75.0, 76.0, 76.0, 76.0, 77.0, 76.0, 81.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 121.0, 128.0, 123.0, 120.0, 129.0, 121.0, 155.0, 139.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 166.0, 161.0, 158.0, 157.0, 162.0, 162.0, 157.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 65.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1480.0, "alertThreshold": 2.0}]} 05:06:29 INFO - Return code: 0 05:06:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:06:29 INFO - # TBPL SUCCESS # 05:06:29 INFO - Running post-action listener: _resource_record_post_action 05:06:29 INFO - [mozharness: 2016-08-05 12:06:29.331790Z] Finished run-tests step (success) 05:06:29 INFO - Running post-run listener: _resource_record_post_run 05:06:29 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 420507648; Read time: 8; Write time: 274520 05:06:29 INFO - TinderboxPrint: CPU usage
13.0% 05:06:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:06:29 INFO - TinderboxPrint: I/O write bytes / time
420,507,648 / 274,520 05:06:29 INFO - TinderboxPrint: CPU idle
8,277.2 (87.0%) 05:06:29 INFO - TinderboxPrint: CPU user
1,193.8 (12.5%) 05:06:29 INFO - TinderboxPrint: Swap in / out
0 / 0 05:06:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 129298432; Read time: 0; Write time: 97132 05:06:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290779136; Read time: 0; Write time: 177288 05:06:29 INFO - Running post-run listener: _upload_blobber_files 05:06:29 INFO - Blob upload gear active. 05:06:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:29 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 05:06:29 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:06:29 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:06:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:31 INFO - (blobuploader) - INFO - Done attempting. 05:06:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:06:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:35 INFO - (blobuploader) - INFO - Done attempting. 05:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:06:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:36 INFO - (blobuploader) - INFO - Done attempting. 05:06:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:36 INFO - Return code: 0 05:06:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c1a8c34be560fbb03c41863627d1b37d2e31d990a3641a04cf7dde1abeed15f29247683a69ee86ea323c743a5c939f9870d6826227603929467585daf30a2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e20830644830a43d808ebed2aeaa6ab1ad88284a92f1bf265d64991e0a5848025a5154bd2445743fafd7a1ee2275e6ff071b71f92e9fc3341d94f04570bc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e4432335166a8f3afcbaecb6bc49473c120ffd68cf851c64388a6874304ef4414eabd24af68269e29d5535021bde118a9cea04350c027325d4aae1fa49d03cd"} 05:06:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:36 INFO - Contents: 05:06:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c1a8c34be560fbb03c41863627d1b37d2e31d990a3641a04cf7dde1abeed15f29247683a69ee86ea323c743a5c939f9870d6826227603929467585daf30a2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e20830644830a43d808ebed2aeaa6ab1ad88284a92f1bf265d64991e0a5848025a5154bd2445743fafd7a1ee2275e6ff071b71f92e9fc3341d94f04570bc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e4432335166a8f3afcbaecb6bc49473c120ffd68cf851c64388a6874304ef4414eabd24af68269e29d5535021bde118a9cea04350c027325d4aae1fa49d03cd"} 05:06:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:36 INFO - Copying logs to upload dir... 05:06:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.622748 ========= master_lag: 0.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-05 05:06:36.722444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 05:06:36.729451) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c1a8c34be560fbb03c41863627d1b37d2e31d990a3641a04cf7dde1abeed15f29247683a69ee86ea323c743a5c939f9870d6826227603929467585daf30a2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e20830644830a43d808ebed2aeaa6ab1ad88284a92f1bf265d64991e0a5848025a5154bd2445743fafd7a1ee2275e6ff071b71f92e9fc3341d94f04570bc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e4432335166a8f3afcbaecb6bc49473c120ffd68cf851c64388a6874304ef4414eabd24af68269e29d5535021bde118a9cea04350c027325d4aae1fa49d03cd"} build_url:https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/SpnpOKgAQ7W7V3ro7Spq8g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c1a8c34be560fbb03c41863627d1b37d2e31d990a3641a04cf7dde1abeed15f29247683a69ee86ea323c743a5c939f9870d6826227603929467585daf30a2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e20830644830a43d808ebed2aeaa6ab1ad88284a92f1bf265d64991e0a5848025a5154bd2445743fafd7a1ee2275e6ff071b71f92e9fc3341d94f04570bc9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e4432335166a8f3afcbaecb6bc49473c120ffd68cf851c64388a6874304ef4414eabd24af68269e29d5535021bde118a9cea04350c027325d4aae1fa49d03cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 05:06:36.758463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 05:06:36.758907) ========= 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=31acecf42b6a79ec49471d4a000001bb-1470397208.444335-1884924859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 05:06:37.035203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 05:06:37.035540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 05:06:37.035821) ========= ========= Total master_lag: 1.16 =========