builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1471884868.18 results: success (0) buildid: 20160822082914 builduid: 830706a6bcc241b5825947e4ac06976e revision: 78b89cc4c3d3f09f73077d02cb6cae7bae0e07c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.185236) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.185764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.186079) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.204414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.204796) ========= 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=920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 09:54:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-22 09:54:30 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.317237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.317616) ========= 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=920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017909 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.369815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.370383) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 78b89cc4c3d3f09f73077d02cb6cae7bae0e07c3 --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 78b89cc4c3d3f09f73077d02cb6cae7bae0e07c3 --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=920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 09:54:30,142 truncating revision to first 12 chars 2016-08-22 09:54:30,142 Setting DEBUG logging. 2016-08-22 09:54:30,142 attempt 1/10 2016-08-22 09:54:30,142 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/78b89cc4c3d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 09:54:30,400 unpacking tar archive at: mozilla-central-78b89cc4c3d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.924577) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.924976) ========= script_repo_revision: 78b89cc4c3d3f09f73077d02cb6cae7bae0e07c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.925417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.925755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:54:28.937284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-22 09:54:28.937605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:54:30 INFO - MultiFileLogger online at 20160822 09:54:30 in /builds/slave/test 09:54:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:54:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:54:30 INFO - {'append_to_log': False, 09:54:30 INFO - 'base_work_dir': '/builds/slave/test', 09:54:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:54:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:54:30 INFO - 'branch': 'Firefox-Non-PGO', 09:54:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:54:30 INFO - 'config_files': ('talos/linux_config.py',), 09:54:30 INFO - 'default_actions': ('clobber', 09:54:30 INFO - 'read-buildbot-config', 09:54:30 INFO - 'download-and-extract', 09:54:30 INFO - 'populate-webroot', 09:54:30 INFO - 'create-virtualenv', 09:54:30 INFO - 'install', 09:54:30 INFO - 'run-tests'), 09:54:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:54:30 INFO - 'download_minidump_stackwalk': True, 09:54:30 INFO - 'download_symbols': 'ondemand', 09:54:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:54:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:54:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:54:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:54:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:54:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:54:30 INFO - 'installer_path': 'installer.exe', 09:54:30 INFO - 'log_level': 'info', 09:54:30 INFO - 'log_name': 'talos', 09:54:30 INFO - 'log_to_console': True, 09:54:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:54:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:54:30 INFO - 'opt_config_files': (), 09:54:30 INFO - 'pip_index': False, 09:54:30 INFO - 'sps_profile': False, 09:54:30 INFO - 'sps_profile_interval': 0, 09:54:30 INFO - 'suite': 'dromaeojs', 09:54:30 INFO - 'system_bits': '32', 09:54:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:54:30 INFO - 'title': 'talos-linux64-ix-053', 09:54:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:54:30 INFO - 'use_talos_json': True, 09:54:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:54:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:54:30 INFO - 'work_dir': 'build'} 09:54:30 INFO - [mozharness: 2016-08-22 16:54:30.798202Z] Running clobber step. 09:54:30 INFO - Running pre-action listener: _resource_record_pre_action 09:54:30 INFO - Running main action method: clobber 09:54:30 INFO - rmtree: /builds/slave/test/build 09:54:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:54:31 INFO - Running post-action listener: _resource_record_post_action 09:54:31 INFO - [mozharness: 2016-08-22 16:54:31.773210Z] Finished clobber step (success) 09:54:31 INFO - [mozharness: 2016-08-22 16:54:31.773309Z] Running read-buildbot-config step. 09:54:31 INFO - Running pre-action listener: _resource_record_pre_action 09:54:31 INFO - Running main action method: read_buildbot_config 09:54:31 INFO - Using buildbot properties: 09:54:31 INFO - { 09:54:31 INFO - "project": "", 09:54:31 INFO - "product": "firefox", 09:54:31 INFO - "script_repo_revision": "production", 09:54:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:54:31 INFO - "repository": "", 09:54:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:54:31 INFO - "buildid": "20160822082914", 09:54:31 INFO - "pgo_build": "False", 09:54:31 INFO - "basedir": "/builds/slave/test", 09:54:31 INFO - "buildnumber": 689, 09:54:31 INFO - "slavename": "talos-linux64-ix-053", 09:54:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:54:31 INFO - "platform": "ubuntu64_hw", 09:54:31 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:54:31 INFO - "branch": "mozilla-central", 09:54:31 INFO - "repo_path": "mozilla-central", 09:54:31 INFO - "revision": "78b89cc4c3d3f09f73077d02cb6cae7bae0e07c3", 09:54:31 INFO - "stage_platform": "linux64", 09:54:31 INFO - "builduid": "830706a6bcc241b5825947e4ac06976e", 09:54:31 INFO - "slavebuilddir": "test" 09:54:31 INFO - } 09:54:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:54:31 INFO - Running post-action listener: _resource_record_post_action 09:54:31 INFO - [mozharness: 2016-08-22 16:54:31.775737Z] Finished read-buildbot-config step (success) 09:54:31 INFO - [mozharness: 2016-08-22 16:54:31.775826Z] Running download-and-extract step. 09:54:31 INFO - Running pre-action listener: _resource_record_pre_action 09:54:31 INFO - Running main action method: download_and_extract 09:54:31 INFO - mkdir: /builds/slave/test/build/tests 09:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:31 INFO - trying https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:54:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:32 INFO - Downloaded 1361 bytes. 09:54:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:54:32 INFO - Using the following test package requirements: 09:54:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:54:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:54:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:54:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'jsshell-linux-x86_64.zip'], 09:54:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:54:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:54:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:54:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:54:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:54:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:54:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:54:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:54: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')]} 09:54:32 INFO - trying https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:54:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:33 INFO - Downloaded 20330673 bytes. 09:54:33 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 09:54:37 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 09:54:37 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')]} 09:54:37 INFO - trying https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:54:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:38 INFO - Downloaded 20330673 bytes. 09:54:38 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 09:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:43 INFO - trying https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:54:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:44 INFO - Downloaded 14413981 bytes. 09:54:44 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 09:54:44 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')]} 09:54:44 INFO - trying https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:54:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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 09:54:45 INFO - Downloaded 55766555 bytes. 09:54:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:54:45 INFO - mkdir: /builds/slave/test/properties 09:54:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:54:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:54:45 INFO - Contents: 09:54:45 INFO - build_url:https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:54:46 INFO - Running post-action listener: _resource_record_post_action 09:54:46 INFO - Running post-action listener: set_extra_try_arguments 09:54:46 INFO - [mozharness: 2016-08-22 16:54:46.230193Z] Finished download-and-extract step (success) 09:54:46 INFO - [mozharness: 2016-08-22 16:54:46.230418Z] Running populate-webroot step. 09:54:46 INFO - Running pre-action listener: _resource_record_pre_action 09:54:46 INFO - Running main action method: populate_webroot 09:54:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:54:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:54:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:54:46 INFO - '--tppagecycles', 09:54:46 INFO - '7'], 09:54:46 INFO - 'tests': ['tsvgm']}}, 09:54:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:54:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:54:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:54:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:54:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['damp', 'tps']}, 09:54:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'tests': ['damp', 'tps']}, 09:54:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['dromaeo_dom']}, 09:54:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:54:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['basic_compositor_video']}, 09:54:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:54:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['a11yr', 09:54:46 INFO - 'ts_paint', 09:54:46 INFO - 'tpaint', 09:54:46 INFO - 'sessionrestore', 09:54:46 INFO - 'sessionrestore_no_auto_restore', 09:54:46 INFO - 'tabpaint']}, 09:54:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:54:46 INFO - 'ts_paint', 09:54:46 INFO - 'tpaint', 09:54:46 INFO - 'sessionrestore', 09:54:46 INFO - 'sessionrestore_no_auto_restore', 09:54:46 INFO - 'tabpaint']}, 09:54:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:54:46 INFO - 'ts_paint', 09:54:46 INFO - 'tpaint', 09:54:46 INFO - 'sessionrestore', 09:54:46 INFO - 'sessionrestore_no_auto_restore', 09:54:46 INFO - 'tabpaint']}, 09:54:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:54:46 INFO - 'ts_paint', 09:54:46 INFO - 'tpaint', 09:54:46 INFO - 'sessionrestore', 09:54:46 INFO - 'sessionrestore_no_auto_restore', 09:54:46 INFO - 'tabpaint']}, 09:54:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['a11yr', 09:54:46 INFO - 'ts_paint', 09:54:46 INFO - 'tpaint', 09:54:46 INFO - 'sessionrestore', 09:54:46 INFO - 'sessionrestore_no_auto_restore', 09:54:46 INFO - 'tabpaint']}, 09:54:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['a11yr', 09:54:46 INFO - 'ts_paint', 09:54:46 INFO - 'tpaint', 09:54:46 INFO - 'sessionrestore', 09:54:46 INFO - 'sessionrestore_no_auto_restore', 09:54:46 INFO - 'tabpaint']}, 09:54:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['tsvgx', 09:54:46 INFO - 'tsvgr_opacity', 09:54:46 INFO - 'tart', 09:54:46 INFO - 'tscrollx', 09:54:46 INFO - 'cart']}, 09:54:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:54:46 INFO - 'tsvgr_opacity', 09:54:46 INFO - 'tart', 09:54:46 INFO - 'tscrollx', 09:54:46 INFO - 'cart']}, 09:54:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'talos_options': ['--disable-e10s'], 09:54:46 INFO - 'tests': ['tp5o']}, 09:54:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'tests': ['tp5o']}, 09:54:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'talos_options': ['--disable-e10s', 09:54:46 INFO - '--xperf_path', 09:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:46 INFO - 'tests': ['tp5n']}, 09:54:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:46 INFO - 'talos_options': ['--xperf_path', 09:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:46 INFO - 'tests': ['tp5n']}}, 09:54:46 INFO - 'talos.zip': {'path': '', 09:54:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:54:46 INFO - Running post-action listener: _resource_record_post_action 09:54:46 INFO - [mozharness: 2016-08-22 16:54:46.248356Z] Finished populate-webroot step (success) 09:54:46 INFO - [mozharness: 2016-08-22 16:54:46.248444Z] Running create-virtualenv step. 09:54:46 INFO - Running pre-action listener: _resource_record_pre_action 09:54:46 INFO - Running main action method: create_virtualenv 09:54:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:54:46 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 09:54:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:54:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:54:46 INFO - Using real prefix '/usr' 09:54:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:54:48 INFO - Installing pip.................done. 09:54:48 INFO - Return code: 0 09:54:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:48 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:54:48 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 09:54:48 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 09:54:48 INFO - Using env: {'DISPLAY': ':0', 09:54:48 INFO - 'HOME': '/home/cltbld', 09:54:48 INFO - 'LANG': 'en_US.UTF-8', 09:54:48 INFO - 'LANGUAGE': 'en_US:en', 09:54:48 INFO - 'LOGNAME': 'cltbld', 09:54:48 INFO - 'MAIL': '/var/mail/cltbld', 09:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:48 INFO - 'MOZ_NO_REMOTE': '1', 09:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:48 INFO - 'NO_EM_RESTART': '1', 09:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:48 INFO - 'PWD': '/builds/slave/test', 09:54:48 INFO - 'SHELL': '/bin/bash', 09:54:48 INFO - 'SHLVL': '1', 09:54:48 INFO - 'TERM': 'linux', 09:54:48 INFO - 'TMOUT': '86400', 09:54:48 INFO - 'USER': 'cltbld', 09:54:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:48 INFO - '_': '/tools/buildbot/bin/python'} 09:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:49 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 09:54:49 INFO - Cleaning up... 09:54:49 INFO - Return code: 0 09:54:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:54:49 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')]} 09:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:49 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')]} 09:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:49 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:54:49 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 09:54:49 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 09:54:49 INFO - Using env: {'DISPLAY': ':0', 09:54:49 INFO - 'HOME': '/home/cltbld', 09:54:49 INFO - 'LANG': 'en_US.UTF-8', 09:54:49 INFO - 'LANGUAGE': 'en_US:en', 09:54:49 INFO - 'LOGNAME': 'cltbld', 09:54:49 INFO - 'MAIL': '/var/mail/cltbld', 09:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:49 INFO - 'MOZ_NO_REMOTE': '1', 09:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:49 INFO - 'NO_EM_RESTART': '1', 09:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:49 INFO - 'PWD': '/builds/slave/test', 09:54:49 INFO - 'SHELL': '/bin/bash', 09:54:49 INFO - 'SHLVL': '1', 09:54:49 INFO - 'TERM': 'linux', 09:54:49 INFO - 'TMOUT': '86400', 09:54:49 INFO - 'USER': 'cltbld', 09:54:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:49 INFO - '_': '/tools/buildbot/bin/python'} 09:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:49 INFO - Downloading/unpacking psutil>=3.1.1 09:54:49 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 09:54:49 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 09:54:49 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 09:54:49 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 09:54:49 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 09:54:49 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 09:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:51 INFO - Installing collected packages: psutil 09:54:51 INFO - Running setup.py install for psutil 09:54:51 INFO - building 'psutil._psutil_linux' extension 09:54:51 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 09:54:51 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 09:54:51 INFO - building 'psutil._psutil_posix' extension 09:54:51 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 09:54:51 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 09:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:51 INFO - Successfully installed psutil 09:54:51 INFO - Cleaning up... 09:54:51 INFO - Return code: 0 09:54:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:54:51 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')]} 09:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:51 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')]} 09:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:51 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:54:51 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 09:54:51 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 09:54:51 INFO - Using env: {'DISPLAY': ':0', 09:54:51 INFO - 'HOME': '/home/cltbld', 09:54:51 INFO - 'LANG': 'en_US.UTF-8', 09:54:51 INFO - 'LANGUAGE': 'en_US:en', 09:54:51 INFO - 'LOGNAME': 'cltbld', 09:54:51 INFO - 'MAIL': '/var/mail/cltbld', 09:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:51 INFO - 'MOZ_NO_REMOTE': '1', 09:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:51 INFO - 'NO_EM_RESTART': '1', 09:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:51 INFO - 'PWD': '/builds/slave/test', 09:54:51 INFO - 'SHELL': '/bin/bash', 09:54:51 INFO - 'SHLVL': '1', 09:54:51 INFO - 'TERM': 'linux', 09:54:51 INFO - 'TMOUT': '86400', 09:54:51 INFO - 'USER': 'cltbld', 09:54:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:51 INFO - '_': '/tools/buildbot/bin/python'} 09:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:54:52 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 09:54:52 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 09:54:52 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 09:54:52 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 09:54:52 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 09:54:52 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 09:54:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:54:53 INFO - Installing collected packages: mozsystemmonitor 09:54:53 INFO - Running setup.py install for mozsystemmonitor 09:54:54 INFO - Successfully installed mozsystemmonitor 09:54:54 INFO - Cleaning up... 09:54:54 INFO - Return code: 0 09:54:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:54 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:54:54 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 09:54:54 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 09:54:54 INFO - Using env: {'DISPLAY': ':0', 09:54:54 INFO - 'HOME': '/home/cltbld', 09:54:54 INFO - 'LANG': 'en_US.UTF-8', 09:54:54 INFO - 'LANGUAGE': 'en_US:en', 09:54:54 INFO - 'LOGNAME': 'cltbld', 09:54:54 INFO - 'MAIL': '/var/mail/cltbld', 09:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:54 INFO - 'MOZ_NO_REMOTE': '1', 09:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:54 INFO - 'NO_EM_RESTART': '1', 09:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:54 INFO - 'PWD': '/builds/slave/test', 09:54:54 INFO - 'SHELL': '/bin/bash', 09:54:54 INFO - 'SHLVL': '1', 09:54:54 INFO - 'TERM': 'linux', 09:54:54 INFO - 'TMOUT': '86400', 09:54:54 INFO - 'USER': 'cltbld', 09:54:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:54 INFO - '_': '/tools/buildbot/bin/python'} 09:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:54:54 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 09:54:54 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 09:54:54 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 09:54:54 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 09:54:54 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 09:54:54 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 09:54:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:54:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:54:56 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 09:54:56 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 09:54:56 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 09:54:56 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 09:54:56 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 09:54:56 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 09:54:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:54:56 INFO - warning: no files found matching '*.txt' 09:54:56 INFO - no previously-included directories found matching 'build' 09:54:56 INFO - no previously-included directories found matching 'dist' 09:54:56 INFO - no previously-included directories found matching '.git*' 09:54:56 INFO - Installing collected packages: jsonschema, functools32 09:54:56 INFO - Running setup.py install for functools32 09:54:56 INFO - warning: no files found matching '*.txt' 09:54:56 INFO - no previously-included directories found matching 'build' 09:54:56 INFO - no previously-included directories found matching 'dist' 09:54:56 INFO - no previously-included directories found matching '.git*' 09:54:56 INFO - Successfully installed jsonschema functools32 09:54:56 INFO - Cleaning up... 09:54:56 INFO - Return code: 0 09:54:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:54:56 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 09:54:56 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 09:54:56 INFO - Using env: {'DISPLAY': ':0', 09:54:56 INFO - 'HOME': '/home/cltbld', 09:54:56 INFO - 'LANG': 'en_US.UTF-8', 09:54:56 INFO - 'LANGUAGE': 'en_US:en', 09:54:56 INFO - 'LOGNAME': 'cltbld', 09:54:56 INFO - 'MAIL': '/var/mail/cltbld', 09:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:56 INFO - 'MOZ_NO_REMOTE': '1', 09:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:56 INFO - 'NO_EM_RESTART': '1', 09:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:56 INFO - 'PWD': '/builds/slave/test', 09:54:56 INFO - 'SHELL': '/bin/bash', 09:54:56 INFO - 'SHLVL': '1', 09:54:56 INFO - 'TERM': 'linux', 09:54:56 INFO - 'TMOUT': '86400', 09:54:56 INFO - 'USER': 'cltbld', 09:54:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:56 INFO - '_': '/tools/buildbot/bin/python'} 09:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:54:56 INFO - Cleaning up... 09:54:56 INFO - Return code: 0 09:54:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:56 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:54:56 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 09:54:56 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 09:54:56 INFO - Using env: {'DISPLAY': ':0', 09:54:56 INFO - 'HOME': '/home/cltbld', 09:54:56 INFO - 'LANG': 'en_US.UTF-8', 09:54:56 INFO - 'LANGUAGE': 'en_US:en', 09:54:56 INFO - 'LOGNAME': 'cltbld', 09:54:56 INFO - 'MAIL': '/var/mail/cltbld', 09:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:56 INFO - 'MOZ_NO_REMOTE': '1', 09:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:56 INFO - 'NO_EM_RESTART': '1', 09:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:56 INFO - 'PWD': '/builds/slave/test', 09:54:56 INFO - 'SHELL': '/bin/bash', 09:54:56 INFO - 'SHLVL': '1', 09:54:56 INFO - 'TERM': 'linux', 09:54:56 INFO - 'TMOUT': '86400', 09:54:56 INFO - 'USER': 'cltbld', 09:54:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:56 INFO - '_': '/tools/buildbot/bin/python'} 09:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:54:57 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 09:54:57 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 09:54:57 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 09:54:57 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 09:54:57 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 09:54:57 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 09:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:54:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:54:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 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 09:54:59 INFO - Downloading docopt-0.6.1.tar.gz 09:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:54:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:54:59 INFO - Running setup.py install for blobuploader 09:54:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:54:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:54:59 INFO - Running setup.py install for requests 09:55:00 INFO - Running setup.py install for docopt 09:55:00 INFO - Successfully installed blobuploader requests docopt 09:55:00 INFO - Cleaning up... 09:55:00 INFO - Return code: 0 09:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:00 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:55:00 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 09:55:00 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 09:55:00 INFO - Using env: {'DISPLAY': ':0', 09:55:00 INFO - 'HOME': '/home/cltbld', 09:55:00 INFO - 'LANG': 'en_US.UTF-8', 09:55:00 INFO - 'LANGUAGE': 'en_US:en', 09:55:00 INFO - 'LOGNAME': 'cltbld', 09:55:00 INFO - 'MAIL': '/var/mail/cltbld', 09:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:00 INFO - 'MOZ_NO_REMOTE': '1', 09:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:00 INFO - 'NO_EM_RESTART': '1', 09:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:00 INFO - 'PWD': '/builds/slave/test', 09:55:00 INFO - 'SHELL': '/bin/bash', 09:55:00 INFO - 'SHLVL': '1', 09:55:00 INFO - 'TERM': 'linux', 09:55:00 INFO - 'TMOUT': '86400', 09:55:00 INFO - 'USER': 'cltbld', 09:55:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:00 INFO - '_': '/tools/buildbot/bin/python'} 09:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:00 INFO - Running setup.py (path:/tmp/pip-tJGqHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:00 INFO - Running setup.py (path:/tmp/pip-_ytwKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:00 INFO - Running setup.py (path:/tmp/pip-ZM0u_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:00 INFO - Running setup.py (path:/tmp/pip-Nn_G4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:00 INFO - Running setup.py (path:/tmp/pip-ypwq7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:00 INFO - Running setup.py (path:/tmp/pip-zJjf2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:00 INFO - Running setup.py (path:/tmp/pip-UyCEQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:01 INFO - Running setup.py (path:/tmp/pip-ILjI6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:01 INFO - Running setup.py (path:/tmp/pip-_m6E_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:01 INFO - Running setup.py (path:/tmp/pip-xYVUX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:01 INFO - Running setup.py (path:/tmp/pip-CnmEO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:01 INFO - Running setup.py (path:/tmp/pip-wPAEtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:01 INFO - Running setup.py (path:/tmp/pip-LGpfNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:01 INFO - Running setup.py (path:/tmp/pip-NAFt6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:01 INFO - Running setup.py (path:/tmp/pip-vQsKOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:01 INFO - Running setup.py (path:/tmp/pip-rRIBpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:01 INFO - Running setup.py (path:/tmp/pip-3odxkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:55:01 INFO - Running setup.py install for manifestparser 09:55:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:55:01 INFO - Running setup.py install for mozcrash 09:55:01 INFO - Running setup.py install for mozdebug 09:55:02 INFO - Running setup.py install for mozdevice 09:55:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Running setup.py install for mozfile 09:55:02 INFO - Running setup.py install for mozhttpd 09:55:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Running setup.py install for mozinfo 09:55:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Running setup.py install for mozInstall 09:55:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Running setup.py install for mozleak 09:55:02 INFO - Running setup.py install for mozlog 09:55:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Running setup.py install for moznetwork 09:55:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:55:02 INFO - Running setup.py install for mozprocess 09:55:02 INFO - Running setup.py install for mozprofile 09:55:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:55:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:55:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:55:03 INFO - Running setup.py install for mozrunner 09:55:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:55:03 INFO - Running setup.py install for mozscreenshot 09:55:03 INFO - Running setup.py install for moztest 09:55:03 INFO - Running setup.py install for mozversion 09:55:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:55:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:55:03 INFO - Cleaning up... 09:55:03 INFO - Return code: 0 09:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:03 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')]} 09:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:03 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')]} 09:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:03 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:55:03 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 09:55:03 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 09:55:03 INFO - Using env: {'DISPLAY': ':0', 09:55:03 INFO - 'HOME': '/home/cltbld', 09:55:03 INFO - 'LANG': 'en_US.UTF-8', 09:55:03 INFO - 'LANGUAGE': 'en_US:en', 09:55:03 INFO - 'LOGNAME': 'cltbld', 09:55:03 INFO - 'MAIL': '/var/mail/cltbld', 09:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:03 INFO - 'MOZ_NO_REMOTE': '1', 09:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:03 INFO - 'NO_EM_RESTART': '1', 09:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:03 INFO - 'PWD': '/builds/slave/test', 09:55:03 INFO - 'SHELL': '/bin/bash', 09:55:03 INFO - 'SHLVL': '1', 09:55:03 INFO - 'TERM': 'linux', 09:55:03 INFO - 'TMOUT': '86400', 09:55:03 INFO - 'USER': 'cltbld', 09:55:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:03 INFO - '_': '/tools/buildbot/bin/python'} 09:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:03 INFO - Running setup.py (path:/tmp/pip-3SyXe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:03 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)) 09:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:03 INFO - Running setup.py (path:/tmp/pip-8R1lFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:03 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)) 09:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:03 INFO - Running setup.py (path:/tmp/pip-yymfmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:03 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)) 09:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:04 INFO - Running setup.py (path:/tmp/pip-FKUuxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:04 INFO - Running setup.py (path:/tmp/pip-Q5cjCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:04 INFO - Running setup.py (path:/tmp/pip-gYpEh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:04 INFO - Running setup.py (path:/tmp/pip-DMX7em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:04 INFO - Running setup.py (path:/tmp/pip-7SkLu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:04 INFO - Running setup.py (path:/tmp/pip-Vsnsib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:04 INFO - Running setup.py (path:/tmp/pip-ETNbwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:04 INFO - Running setup.py (path:/tmp/pip-uMvDC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:04 INFO - Running setup.py (path:/tmp/pip-m0_bgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:04 INFO - Running setup.py (path:/tmp/pip-tYUffW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:04 INFO - Running setup.py (path:/tmp/pip-ITNEjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:04 INFO - Running setup.py (path:/tmp/pip-Uq5BTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:04 INFO - Running setup.py (path:/tmp/pip-aZEM9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:04 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)) 09:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:04 INFO - Running setup.py (path:/tmp/pip-gDlKVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:05 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)) 09:55:05 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)) 09:55:05 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)) 09:55:05 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)) 09:55:05 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)) 09:55:05 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)) 09:55:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:07 INFO - Downloading blessings-1.6.tar.gz 09:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:55:07 INFO - Installing collected packages: blessings 09:55:07 INFO - Running setup.py install for blessings 09:55:07 INFO - Successfully installed blessings 09:55:07 INFO - Cleaning up... 09:55:07 INFO - Return code: 0 09:55:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:55:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:07 INFO - Reading from file tmpfile_stdout 09:55:07 INFO - Current package versions: 09:55:07 INFO - argparse == 1.2.1 09:55:07 INFO - blessings == 1.6 09:55:07 INFO - blobuploader == 1.2.4 09:55:07 INFO - docopt == 0.6.1 09:55:07 INFO - functools32 == 3.2.3-2 09:55:07 INFO - jsonschema == 2.5.1 09:55:07 INFO - manifestparser == 1.1 09:55:07 INFO - mozInstall == 1.12 09:55:07 INFO - mozcrash == 0.17 09:55:07 INFO - mozdebug == 0.1 09:55:07 INFO - mozdevice == 0.48 09:55:07 INFO - mozfile == 1.2 09:55:07 INFO - mozhttpd == 0.7 09:55:07 INFO - mozinfo == 0.9 09:55:07 INFO - mozleak == 0.1 09:55:07 INFO - mozlog == 3.3 09:55:07 INFO - moznetwork == 0.27 09:55:07 INFO - mozprocess == 0.23 09:55:07 INFO - mozprofile == 0.28 09:55:07 INFO - mozrunner == 6.12 09:55:07 INFO - mozscreenshot == 0.1 09:55:07 INFO - mozsystemmonitor == 0.3 09:55:07 INFO - moztest == 0.7 09:55:07 INFO - mozversion == 1.4 09:55:07 INFO - psutil == 3.1.1 09:55:07 INFO - requests == 1.2.3 09:55:07 INFO - wsgiref == 0.1.2 09:55:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:07 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 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:55:07 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 09:55:07 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 09:55:07 INFO - Using env: {'DISPLAY': ':0', 09:55:07 INFO - 'HOME': '/home/cltbld', 09:55:07 INFO - 'LANG': 'en_US.UTF-8', 09:55:07 INFO - 'LANGUAGE': 'en_US:en', 09:55:07 INFO - 'LOGNAME': 'cltbld', 09:55:07 INFO - 'MAIL': '/var/mail/cltbld', 09:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:07 INFO - 'MOZ_NO_REMOTE': '1', 09:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:07 INFO - 'NO_EM_RESTART': '1', 09:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:07 INFO - 'PWD': '/builds/slave/test', 09:55:07 INFO - 'SHELL': '/bin/bash', 09:55:07 INFO - 'SHLVL': '1', 09:55:07 INFO - 'TERM': 'linux', 09:55:07 INFO - 'TMOUT': '86400', 09:55:07 INFO - 'USER': 'cltbld', 09:55:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:07 INFO - '_': '/tools/buildbot/bin/python'} 09:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 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)) 09:55:07 INFO - Cleaning up... 09:55:07 INFO - Return code: 0 09:55:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f528f670f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2765230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, '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': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', '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 09:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:55:07 INFO - Using env: {'DISPLAY': ':0', 09:55:07 INFO - 'HOME': '/home/cltbld', 09:55:07 INFO - 'LANG': 'en_US.UTF-8', 09:55:07 INFO - 'LANGUAGE': 'en_US:en', 09:55:07 INFO - 'LOGNAME': 'cltbld', 09:55:07 INFO - 'MAIL': '/var/mail/cltbld', 09:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:07 INFO - 'MOZ_NO_REMOTE': '1', 09:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:07 INFO - 'NO_EM_RESTART': '1', 09:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:07 INFO - 'PWD': '/builds/slave/test', 09:55:07 INFO - 'SHELL': '/bin/bash', 09:55:07 INFO - 'SHLVL': '1', 09:55:07 INFO - 'TERM': 'linux', 09:55:07 INFO - 'TMOUT': '86400', 09:55:07 INFO - 'USER': 'cltbld', 09:55:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:07 INFO - '_': '/tools/buildbot/bin/python'} 09:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:55:07 INFO - Cleaning up... 09:55:07 INFO - Return code: 0 09:55:07 INFO - Running post-action listener: _resource_record_post_action 09:55:07 INFO - Running post-action listener: _start_resource_monitoring 09:55:08 INFO - Starting resource monitoring. 09:55:08 INFO - [mozharness: 2016-08-22 16:55:08.007351Z] Finished create-virtualenv step (success) 09:55:08 INFO - [mozharness: 2016-08-22 16:55:08.007813Z] Running install step. 09:55:08 INFO - Running pre-action listener: _resource_record_pre_action 09:55:08 INFO - Running main action method: install 09:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:08 INFO - Reading from file tmpfile_stdout 09:55:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:55:08 INFO - Reading from file tmpfile_stdout 09:55:08 INFO - Output received: 09:55:08 INFO - Usage: mozinstall [options] installer 09:55:08 INFO - Options: 09:55:08 INFO - -h, --help show this help message and exit 09:55:08 INFO - -d DEST, --destination=DEST 09:55:08 INFO - Directory to install application into. [default: 09:55:08 INFO - "/builds/slave/test"] 09:55:08 INFO - --app=APP Application being installed. [default: firefox] 09:55:08 INFO - mkdir: /builds/slave/test/build/application 09:55:08 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'] 09:55:08 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 09:55:24 INFO - Reading from file tmpfile_stdout 09:55:24 INFO - Output received: 09:55:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:55:24 INFO - Running post-action listener: _resource_record_post_action 09:55:24 INFO - [mozharness: 2016-08-22 16:55:24.398289Z] Finished install step (success) 09:55:24 INFO - [mozharness: 2016-08-22 16:55:24.398534Z] Running run-tests step. 09:55:24 INFO - Running pre-action listener: _resource_record_pre_action 09:55:24 INFO - Running main action method: run_tests 09:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:55:24 INFO - Python 2.7.3 09:55:24 INFO - Return code: 0 09:55:24 INFO - grabbing minidump binary from tooltool 09:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:24 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 0x275f090>, '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 0x27629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2762e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:55:24 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 09:55:24 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 09:55:24 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 09:55:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:55:24 INFO - Return code: 0 09:55:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:55:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:55:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:55:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:55:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 09:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 09:55:24 INFO - Using env: {'DISPLAY': ':0', 09:55:24 INFO - 'HOME': '/home/cltbld', 09:55:24 INFO - 'LANG': 'en_US.UTF-8', 09:55:24 INFO - 'LANGUAGE': 'en_US:en', 09:55:24 INFO - 'LOGNAME': 'cltbld', 09:55:24 INFO - 'MAIL': '/var/mail/cltbld', 09:55:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:55:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:24 INFO - 'MOZ_NO_REMOTE': '1', 09:55:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:55:24 INFO - 'NO_EM_RESTART': '1', 09:55:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:24 INFO - 'PWD': '/builds/slave/test', 09:55:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:55:24 INFO - 'SHELL': '/bin/bash', 09:55:24 INFO - 'SHLVL': '1', 09:55:24 INFO - 'TERM': 'linux', 09:55:24 INFO - 'TMOUT': '86400', 09:55:24 INFO - 'USER': 'cltbld', 09:55:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981', 09:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:24 INFO - '_': '/tools/buildbot/bin/python'} 09:55:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 09:55:24 INFO - mozversion application_buildid: 20160822082914 09:55:24 INFO - mozversion application_changeset: 78b89cc4c3d3f09f73077d02cb6cae7bae0e07c3 09:55:24 INFO - mozversion application_display_name: Nightly 09:55:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:55:24 INFO - mozversion application_name: Firefox 09:55:24 INFO - mozversion application_remotingname: firefox 09:55:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:55:24 INFO - mozversion application_vendor: Mozilla 09:55:24 INFO - mozversion application_version: 51.0a1 09:55:24 INFO - mozversion platform_buildid: 20160822082914 09:55:24 INFO - mozversion platform_changeset: 78b89cc4c3d3f09f73077d02cb6cae7bae0e07c3 09:55:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:55:24 INFO - mozversion platform_version: 51.0a1 09:55:24 INFO - using testdate: 1471884924 09:55:24 INFO - actual date: 1471884924 09:55:24 INFO - starting webserver on 'localhost:39606' 09:55:24 INFO - SUITE-START | Running 2 tests 09:55:24 INFO - TEST-START | dromaeo_css 09:55:24 INFO - operating with platform_type : linux_ 09:55:24 INFO - Initialising browser for dromaeo_css test... 09:55:24 INFO - TEST-INFO | started process 14766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0umAXk/profile http://localhost:39606/getInfo.html) 09:55:29 INFO - PROCESS | 14766 | __metrics Screen width/height:1600/1200 09:55:29 INFO - PROCESS | 14766 | colorDepth:24 09:55:29 INFO - PROCESS | 14766 | Browser inner width/height: 1024/697 09:55:29 INFO - PROCESS | 14766 | __metrics 09:55:29 INFO - PROCESS | 14766 | 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" 09:55:29 INFO - PROCESS | 14766 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:55:30 INFO - PROCESS | 14766 | console.error: PushService: 09:55:30 INFO - PROCESS | 14766 | stateChangeProcessEnqueue: Error transitioning state 09:55:30 INFO - PROCESS | 14766 | UnknownError 09:55:31 INFO - TEST-INFO | 14766: exit 0 09:55:31 INFO - Browser initialized. 09:55:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:55:31 INFO - TEST-INFO | started process 14844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0umAXk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:43 INFO - PROCESS | 14844 | RSS: Main: 176136192 09:55:43 INFO - PROCESS | 14844 | 09:56:35 INFO - PROCESS | 14844 | 1471884995490 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] 09:58:47 INFO - PROCESS | 14844 | Cycle 1(1): loaded http://localhost:39606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39606/tests/dromaeo/cssquery-ext.html) 09:58:48 INFO - PROCESS | 14844 | RSS: Main: 275210240 09:58:48 INFO - PROCESS | 14844 | 10:01:51 INFO - PROCESS | 14844 | Cycle 1(1): loaded http://localhost:39606/tests/dromaeo/cssquery-ext.html (next: http://localhost:39606/tests/dromaeo/cssquery-jquery.html) 10:01:52 INFO - PROCESS | 14844 | RSS: Main: 278093824 10:01:52 INFO - PROCESS | 14844 | 10:04:54 INFO - PROCESS | 14844 | Cycle 1(1): loaded http://localhost:39606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39606/tests/dromaeo/cssquery-mootools.html) 10:04:55 INFO - PROCESS | 14844 | RSS: Main: 218689536 10:04:55 INFO - PROCESS | 14844 | 10:07:57 INFO - PROCESS | 14844 | Cycle 1(1): loaded http://localhost:39606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39606/tests/dromaeo/cssquery-prototype.html) 10:07:58 INFO - PROCESS | 14844 | RSS: Main: 219627520 10:07:58 INFO - PROCESS | 14844 | 10:11:01 INFO - PROCESS | 14844 | Cycle 1(1): loaded http://localhost:39606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39606/tests/dromaeo/cssquery-yui.html) 10:11:02 INFO - PROCESS | 14844 | RSS: Main: 219361280 10:11:02 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | Cycle 1(1): loaded http://localhost:39606/tests/dromaeo/cssquery-yui.html (next: http://localhost:39606/tests/dromaeo/cssquery-dojo.html) 10:14:05 INFO - PROCESS | 14844 | RSS: Main: 310943744 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | __start_tp_report 10:14:05 INFO - PROCESS | 14844 | _x_x_mozilla_page_load 10:14:05 INFO - PROCESS | 14844 | _x_x_mozilla_page_load_details 10:14:05 INFO - PROCESS | 14844 | |i|pagename|runs| 10:14:05 INFO - PROCESS | 14844 | |0;dojo.html;2579.9484010319793;2627.829191102578;2630.355562887093;2641.722619124993;2654.5354562951493;4619.7921093550785;4647.60495357895;4774.331593576898;4865.124277630025;4869.805207791688;4733.8579842604695;4745.952540474595;4752.643551733617;4788.712677239359;4814.2297232442725;4384.912301753963;4385.802638881242;4453.732776033432;4469.776511174428;4495.527969563198;4460.933086003713;4482.417285752847;4495.775211239425;4498.100379924012;4500.39244701966;4255.0426154115385;4273.29490634045;4421.38100665907;4425.380446737459;4481.193385190681;4268.338407546835;4343.131373725268;4352.651787856964;4370.475542934868;4375.5405682403525;4313.28830742927;4332.068605249855;4333.934990975138;4335.544767799367;4344.02259491615;4605.792739326738;4699.2481203007355;4702.224133018048;4713.5522125398375;4729.196036673774;5063.822766203165;5119.87200319995;5151.5621172200035;5152.819651312224;5155.072087024334;5168.5089916458255;5176.145935920568;5176.9223461647725;5177.094008548489;5189.792408303663;4577.908441831211;4675.812967481331;4809.567138957475;4818.349522814446;4825.227963525819;5136.075506408808;5221.164613661872;5227.581793456515;5233.215017747369;5233.947660523346;4963.404391472975;5007.549320561094;5007.799688012438;5015.598752099823;5018.222175562793;4916.901661966741;4982.153033984231;5095.184770436712;5106.514881086291;5111.5655169310285;5039.118154322979;5112.284280200774;5127.8718032048755;5141;5141.871453213699;5099.515546023122;5111;5119.923201151985;5120.129577971679;5122.564582010571;4224.936625950613;4271.850485233064;4414.3157810539415;4420.31485119807;4436.134953684065;3772.07584141887;3803.3344164771056;3824.3116239077235;3834.6357096075826;3850.422436634471;4423.933640995388;4424.203643344164;4426.75652839097;4426.9778651106535;4434.3348497724955;4925.335079764186;5027;5133.307003554547;5135.845924622267;5142.254373115878;4387.4954380246045;4440.222960981815;4444.82220711168;4450.376947227391;4453.4433195850515;4623.283391074388;4648.953510464919;4649.256119020941;4659.394278743742;4660.207764680013;4613.19269127908;4723.6929599575915;4810.56704896547;4830.347903033045;4831.033793241366;5091.236314552847;5150.9227361588855;5173.379194496684;5203.92194117081;5205.531502164823;4816.4220293564995;4832.347633069631;4834.468208496992;4839.540243676845;4849.393825771778;4864.3189953405845;4948.678335908155;5069.493050694901;5076.898462030813;5084.3644544431945;5096.949030509648;5137.8201762938115;5162.845114646567;5178.042062218502;5179.533841954242;5028.723420211923;5032.496750324938;5041.546260836542;5041.747912604282;5046.520580544842;4834.178189707688;4922.114019476386;5024.321716568216;5028.572571331331;5041.319421878;4909.484504127158;5000.124978128885;5003.924941125959;5005.749712514433;5014.222795466709;5078.542931136216;5098.643094983316;5111.156659151198;5112.795488180431;5115.769790359368;4766.213574760126;4820.758962051954;4993.900121997467;5005.974970125126;5006.974965125151 10:14:05 INFO - PROCESS | 14844 | |1;ext.html;545.3510322715969;565.683217398257;569.3822202909843;570.3896830391482;574.9166370876223;28482.585199294117;38256.42615360772;39609.20781584366;39625.40561891574;42479.36280955788;39484.210315793665;39787.80106099466;40042.59957400425;40049.39925901114;40093;7240.855182896339;7412.18465968743;7429.219931907153;7446.29260220281;7457.440691948099;7657.349125324354;7737.071551413838;7747.457677962545;7748.496347737379;7749.263819937125;7766.728164514243;7813.140554538996;7813.804654883645;7818.609069546528;7819.296263336299;7719.536827790294;7747.3027427531515;7763.650635721406;7773.922260777376;7784.805379865492;7639.083310002779;7723.227677232288;7731.110922243957;7735.535867847947;7736.497127686739;37661.81169094164;38041.23917521634;38048.80975595132;38052.619473805185;38057.42913856294;2498.7001559812757;2514.2331588865572;2528.4184637533285;2868.067877939678;2954.1686933561;27857;28209.717902820914;28528.572071418945;28882.855585722147;29286.560701589493;3140.5289206618963;3211.550382946389;3228.4834426491648;3244.23760416302;3289.259916518788;244719;245548;246342;246467;246591;49376.25935610969;49691.25463118056;49795.751021244665;49946.75026624843;49957.50042499601;31865.10495558329;52760;52819;52959;53008.469915301124;12481;13032.087753857328;13092.279924604049;13105.934470327587;13128.671783205496;9554.570044348022;9639.614415423444;9642.855357169648;9686.515674216262;9697.418154910587;17486;17495.912520437316;17500.387486437914;17657.55856103582;17707.54702832935;6458.192725909262;6530.640814755139;6553.377429144223;6574.441172500391;6718.563293386012;802.4623502253504;868.4832524647825;947.6777895515557;1003.6236411345745;1021.3514418344256;27412;27820.16539503818;27825.582616260774;28042.579361309596;28538.571921421197;904.9547522623974;907.2741806554861;975.3562648651997;975.9072888075622;1000.2947921715319;14366.56900292993;14511.346989385504;14575.562733118024;15025.849741502663;15088.622784430258;368257;371147;371332;372367;373504;33215.83392083072;33493.83253083719;33553;48635.75682121567;48977;1038.55342202852;1106.4246591772394;1125.859267591551;1129.768397478515;1130.8756036835941;26444.735552644226;28556;28701;29306.853465732536;29434.852825735736;47221.7638911817;47633.76183119062;48029;48052.5194748048;48055.279170811766;354737;359704;360473;360775;361840;31668.5249721259;36016.4597531032;37809;37835.64890037681;38828.22343553056;40598.39102413407;41147;41406.79296603498;41436.37845432261;42225.78887105545;35407.645923541466;35701.64298356983;35722.285554288246;36199.27601448009;36507.452388213664;34557.654423455446;35189.12027199341;35322.64677353194;36070.27859442744;36214.45678314775;34442.31115377628;34946.30107397889;35090.824545877105;35267.647323526435;35451.64548354483;29937.251568710955;32175.678243218204;32247.51628725524;32346.35307293888;32717.509237360984;24056;24154.275371738877;24318.02960786069;24598.631020534347;24791.50416991686 10:14:05 INFO - PROCESS | 14844 | |2;jquery.html;333.10062830358027;338.6478062814673;339.9660033996599;341.47412984004626;360.51690734415877;12751.808722869153;16627.501174964757;17425.65148697027;18734.531636709056;18883.52791180221;14762.778558321634;14900.552983410487;15352.155631440266;15631;16274;4942.901141977167;5137.178051511759;6496.447801936841;6781.4574834013165;6830.760923367683;4018.57804930481;5086.008228395464;6928.16861976561;6985;6993.300669932992;6873.862522749542;6987.0916780818425;6992.965035174817;6996.8950465743055;6998.370146686797;6900.102986611709;6954.79135625932;6963;7002.859942801116;7038.859222815566;6510.869782604322;6591.835204119935;6773.254941956381;6773.254941956381;6778.694958726869;23342.7665723344;23690.526189476113;23774.64338034931;23987.640185397235;24083.02630066037;1837.6232872261155;1889.5653999580175;1937.1670181821812;2269.807066399358;2357.9174728884577;14008.439662413593;14329.78505322421;14338.56984290473;14449.566513004627;15703.528894133195;1749.9737503937451;1770.3184274054581;1854.8516118710606;1881.2569035231145;1935.6902895536787;71707;76779.61610191913;77600.22399776043;78094.21905780926;81245;16798.328066877188;16974.405895793836;17091.48725538236;17395.47813565595;17451.127443628022;28565.28586785347;28690.426191476054;28786.840986926065;28823.85588072046;28829;8163.836723265502;8335.291500222549;8516.815872247831;8636.654533818702;8760.211580957744;6783.287754785676;6788.422984046312;6831.04365388846;6974.476914231453;7003.824904377431;8383.538905360141;8437.746867593982;8519.233269005696;8633.69782057625;8668.696595619249;3018.2019413409666;3224.129485039073;3379.425497665403;3384.983075084609;3469.687728104432;682.8122266376786;694.6214313199318;710.847391817292;758.6320634492267;862.8101817600243;16279.674406511804;16347.34610615586;16545.172741363123;17475.38836140729;17548.561285967953;848.1476116502998;850.6299759604592;855.2858363266741;890.25663570919;935.6070450410843;8803.295736341077;9876.950615246878;9879.555420006118;9936.900630993598;10053.587139086567;389096;392190;394063;410031;412525;49374.50625493771;56612;79405.20594793979;85771;88715;891.3760367742476;921.7695576106107;946.6544711180508;949.1173208915636;951.3863558005048;15352.539423817303;15836.366545338518;16136.193190340202;16671.249793759067;16967.575810604834;28578;38161.6183838158;38471.422928656655;39027.41458878176;39673.603263966994;53318.200226997404;53871;55307.72346138243;56332.718336408056;56654.43345566492;7287.307705767944;7303.671334789841;7376.188619251985;7555.357794587302;7561.357284630868;8530.195514835763;11590.536378544764;12002.879971200176;12586.307753073668;12611.30637814929;10058.698239052841;10166.796664066826;10294.485275736333;10547.789044219226;10758.139348851917;10211.948940255252;10241.590336386462;10350.264781134048;10761;10883.183761217782;9681.564329605326;10080.747981300527;10209.285350025428;10627.574897004033;11022.834657479983;7316.561006339637;7341.926580734124;7451.068616422947;7545;7639.694412223449;8423.5788210588;9101.362904596615;9157.954210229173;9643.662471813454;9947.204223661945 10:14:05 INFO - PROCESS | 14844 | |3;mootools.html;1334.6463187255379;1373.6085215713522;1433;1653.5783375239312;1672.0051569316252;6699;6982.685779139938;7439.256074392558;8066.1530539293335;8081.111077781439;7321.450891183156;7598.31615154636;7644.885326720104;7869.763907082783;7881.960590197055;2134.423705599483;2155.568886222754;2160.773118822525;2165.5344101018277;2166.772488888668;1806.4129158023695;2033.9593208135827;2116.9153233870625;2128.968065479019;2160.5354848707525;2141.453929248047;2151.075037733774;2166.4042388343173;2168.27362833451;2170.4573856535867;2052.0457987036025;2070.2960993262286;2143.9464013399634;2146.1093646136833;2146.710194123789;2052.5381789097482;2082.750069991611;2086.5096702274955;2091.059023439443;2123.946901327464;7850.646720897574;7905.328047116002;7917.287444129998;7918.881216781753;7925.3263472604895;4260.786960651986;4287.421198138242;4309.784510774449;4311.698181127323;4316.093620339732;2821.7601503871992;2941.3234955960247;2953.719396657314;2979.1509419815247;2989.3124581346196;863.8013256950874;904.7150147703518;905.0858632780938;906.2795077913075;922.6493932305681;10642.361458312525;10674;10674.09270212033;10678.412687302196;10679.038886500251;3745.157339598623;3929.371300591949;3982.561918188997;4059.3099173140045;4077.164181342877;9187.356885017985;9211.585478653476;9214.539273036455;9228.676996305097;9229.307801914883;4377.934330985037;4389.956100438954;4393.890152746207;4394.384786129945;4399.670024748157;3983.0042489377656;3992.161646054361;4004.9599504004586;4005.839766409311;4007.8396864125693;3375.8649654014057;3499.9825000875344;3577;3621.6921561667555;3625.800580968072;1039.838824982129;1111.9833202501968;1133.3766428464312;1133.631569739838;1178.1752773058722;720.6684924934589;725.3037084398931;739.8113481062295;759.1876691939682;771.0593076446726;4896.3352460163715;5091.439941606421;5132.1788513838355;5202.826693454899;5318.202269659582;807.8667019941761;825.9297959673495;835.678263868415;837.250660658707;856.1310270075878;3299.736021118305;3303.653116422741;3358.815265160391;3397.643247458981;3426.194844211608;9176.08239176077;9196.494192819326;9341.766455838522;9354.111359420844;9359.064093590723;7888.447808653454;9446.622135114518;9588.424694518351;9670.032996700274;9674.693916321346;7235.602041887747;7468.925310746931;7484.513506622052;7487.064116985268;7487.7004919803685;5143.0999575073465;5228.9738551307;5231;5309.2301616266195;5490.286262785812;8753.693620723245;8789.560521973748;8823.911760882309;8879;8944.150305720947;8837.204651581389;8936.151065648754;9098.863517047383;9129.087091290818;9140.542972851465;6225.408586184305;6416.13382193398;6422.743090276524;6425.839354016187;6426.871462570816;7249.601271930094;7280.745173918887;7321.926780732338;7330.45021623391;7341.853162936818;6478.773242936474;6553.770618028346;6631;6633.867322653617;6713.798586042427;6426.100345951664;6484.837879053061;6533.18335208099;6534.150560427304;6543.312952140147;6007.639541627516;6037.758489660365;6115.266168059861;6118.051701986199;6190.597611155261;4540.5686459787585;4550.567696068868;4573.039661670953;4665.20691482442;4772.188727916193;4463.598276155161;4530.637548996138;4587.197240482836;4596.264597664358;4607.815687372602 10:14:05 INFO - PROCESS | 14844 | |4;prototype.html;290.1079181516836;295.1617406565355;297.9612650355454;304.8826201912263;307.8953155926984;4857.4413942396595;4894.388201474816;4903.534164254399;4924.975375123124;4939.789137060912;4835.371401717781;4842.6440596633;4851.902961940767;4852.2479015752615;4865.68373055752;3639.6542328478818;3760.3231418344685;3794.848206071754;3809.2381523695235;3869.361555343365;3814.692111272682;3819.751716138442;3829.885103446901;3873.2253549290253;3883.0874744435037;3803.296390167814;3806.1626442182815;3812.2184952084895;3821.197548514815;3821.9044523886846;3586.246888153478;3707.9443808342626;3805.847766089381;3806.847726090953;3815.866444674437;3376.9493457598155;3377.544031555733;3379.4086034944035;3383.374075795961;3397.3375191837604;4732.905341893177;4746.1931471649905;4748.216544270192;4760.547747963938;4762.261849413347;4039.858604948842;4237.364395340693;4345.739255644671;4351.804168812379;4357.1721372939355;5090.898182036339;5094.821681241176;5098.2018396294625;5102.668326558799;5107.540321371057;3535.3207226567433;3541.220931395089;3550.8934731958084;3551.4672799080085;3563.55455568054;5118.104331741967;5286.180642000496;5303.8408847734245;5327.227552004938;5342.946570534284;3650.68969137621;3652.4886515887797;3654.250878569887;3658.4512323151207;3671.192337685705;3697.9815100924325;3708.9443658345144;3710.5157936825485;3714.9412417460894;3716.3124821907495;4132.380142978577;4212.936805947913;4255.638270746959;4275.358696195595;4276;5043.293938848564;5082.881766011472;5087.872803179876;5088.6946783193125;5098.260752190911;1265.778488764481;1285.884270415667;1290.4773566705499;1290.9478774798508;1293.3145432920567;781.9257170568787;798.5967086621336;824.6660102658433;833.2084519706303;838.5681374092347;4330.350447432847;4445.622122119591;4447.2439685253585;4448.977755111268;4453.77731113443;5103.366922584812;5164.225366195025;5240.764165612481;5257.815976440883;5285.392179899361;4499.662525310615;4501.212287849613;4523.117991991596;4524.343970124313;4536.911141326058;2639.8680065996623;2765.820221685584;2769.2661444717164;2774.5422005368887;2792.9301767455977;4890.505842020524;4911.68074075184;4914.213725803854;4928.4475390251955;4932;5059.283010198452;5280.656757310762;5287.3126493556365;5322.2282768998275;5327.9733601331745;4841.9031619367415;4848.539388758062;4858.732769697701;4878.36581244443;4889.46215916256;5173.22401639757;5179.870503237449;5255.3168088148295;5255.369355677343;5362.678239305654;4981.551660350586;5136;5141.974290128525;5153.175491921274;5178.611604129781;4880.194767863263;4882.633802464758;4888.6577939543895;4889.63327750413;4895.534924182197;3647.2705458908854;3651.214988777426;3670.632936706308;3672.412414013745;3717.665410113103;5008.57427118699;5226.921596175985;5235.1623740201385;5235.581153507786;5237.428771368651;5069.645124841373;5092.261622064854;5099.5410413063;5105.693658380509;5112.488751124858;5094.694318340911;5106.387233532;5107.974460127824;5111.744412779271;5206.375234971828;4865.270209468608;5020.447750747342;5035.622328325464;5044.344235249394;5045.394552653705;4834.250691142878;5044.293798868088;5080.949190508048;5099;5119.48805119485;4984.900301993867;4990.476000019946;5019.3976722793495;5020.322256495327;5031.415104242298 10:14:05 INFO - PROCESS | 14844 | |5;yui.html;597.8505373656586;612.2071916867656;635.140482785912;641.5380925733471;646.0438550944602;11580.65258042258;12018.218815776969;12457.688557786048;13717.245551494663;13909.443622255123;12672;12689.873101268984;12694.555690550833;12753.808692869614;12774.93612531936;613.9293981192153;745.5936514599529;763.5571368606195;764.6406189091118;765.3073968058916;735.6836560279078;764.8623247815391;764.9732259370924;767.9769606911801;768.4697558684518;808.6522795198063;809.9595020248964;810.8540462716709;810.9675612975474;811.1847593168857;639.1180171363535;803.6825453945717;807.8828569857337;808.0545761459077;808.2039191396499;561.2927711084063;580.3268208877723;581.714959669763;582.4961408381762;582.7057336045312;12398.380080995914;12399.380030998414;12431.067669924792;12439.75120497585;12473.064520160933;12111.636650900487;12674.493020279178;12705.682357941034;12742.29917354545;13192.340382980812;9682.177014953737;9765.755856103655;10038.548265328078;10076.596936122547;11808.527658893634;4093.488313960755;4101.876943691694;4105;4118.402831589433;4118.485189351331;59628;60177.39822601806;60885.391146088856;61124.38875611231;62329.37670623281;9080.40977336471;9347;9401.10689484498;9465.574049167666;9542.33203675736;17562.94622322665;17594.560135996704;17603.823961760474;17610.559736006446;17637.118144092743;6086.02623580225;6212.316645169028;6245.063240513869;6550.672466376662;6650.135482387259;3327.3678001179696;3342.3649506594156;3344.6153692325693;3359.479280711445;3465.5841299044278;2578.845269283849;2693.9865300673373;2695.986520067387;2698.649175607198;2701.905433309864;469.53516019140807;469.85434515300364;476.2784381661785;480.86295405809875;487.39806339171093;424.0120519190279;482.2452861272098;483.96854204476597;491.48885159433786;532.9573634109262;7010.439164866799;7059.541129826544;7251.782446526613;7347.926520734831;7647.694092236248;419.71039982412645;441.28511810866604;448.8272015274143;455.68102328370276;466.51482458243726;3307.3219989902013;3423.4180189367867;3439.810810405452;3461.0828130545424;3552.0587044433246;87732.1226787724;101009.49495252623;102148.48925755324;102734.48632756788;103102;84274.5786271077;88445;89139.55430222937;90295.54852225697;91622;78083.60958195286;78114.6094269525;78552.60723696345;79273;80149.5992520022;6574.53978221539;6689.874676745612;6695.196576410862;6852.5203235773015;6881.3806757390075;46502.53497464982;47127.344227131434;47652;48813.75593122012;50710.49289507058;60152.69923650354;66888.6655566719;67283.3271667277;68160.6591967037;70208.64895675489;8547.230749232598;8845.203931646183;9165.495897725688;10434.37393756377;10619.893801061891;12151.453184606537;12241.69395765113;12513.249205047727;12975.545855894998;13337.710920088819;11291.604793832177;11551.306921584732;11699.766004680028;11787.469563869818;12188.57339993096;10976.176786741185;11069.93006993007;11222.382768947786;11752.001079908303;11762.117841161777;10915.23593348458;11004.229703920648;11149.665510034712;11157.68752279557;11340.716482088013;9630.566624501775;9767.402704803995;9820.803583928424;9916.107550320507;10159.390436573829;9765.218782497524;9786.657466988621;9832.360896541702;10031.849522257025;10120.443375614117 10:14:05 INFO - PROCESS | 14844 | __end_tp_report 10:14:05 INFO - PROCESS | 14844 | __start_cc_report 10:14:05 INFO - PROCESS | 14844 | _x_x_mozilla_cycle_collect,1008 10:14:05 INFO - PROCESS | 14844 | __end_cc_report 10:14:05 INFO - PROCESS | 14844 | __startTimestamp1471886045415__endTimestamp 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | ------- Summary: start ------- 10:14:05 INFO - PROCESS | 14844 | Number of tests: 6 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | [#0] dojo.html Cycles:165 Average:4728.24 Median:4834.18 stddev:502.82 (10.4%) stddev-sans-first:475.28 10:14:05 INFO - PROCESS | 14844 | Values: 2579.9 2627.8 2630.4 2641.7 2654.5 4619.8 4647.6 4774.3 4865.1 4869.8 4733.9 4746.0 4752.6 4788.7 4814.2 4384.9 4385.8 4453.7 4469.8 4495.5 4460.9 4482.4 4495.8 4498.1 4500.4 4255.0 4273.3 4421.4 4425.4 4481.2 4268.3 4343.1 4352.7 4370.5 4375.5 4313.3 4332.1 4333.9 4335.5 4344.0 4605.8 4699.2 4702.2 4713.6 4729.2 5063.8 5119.9 5151.6 5152.8 5155.1 5168.5 5176.1 5176.9 5177.1 5189.8 4577.9 4675.8 4809.6 4818.3 4825.2 5136.1 5221.2 5227.6 5233.2 5233.9 4963.4 5007.5 5007.8 5015.6 5018.2 4916.9 4982.2 5095.2 5106.5 5111.6 5039.1 5112.3 5127.9 5141.0 5141.9 5099.5 5111.0 5119.9 5120.1 5122.6 4224.9 4271.9 4414.3 4420.3 4436.1 3772.1 3803.3 3824.3 3834.6 3850.4 4423.9 4424.2 4426.8 4427.0 4434.3 4925.3 5027.0 5133.3 5135.8 5142.3 4387.5 4440.2 4444.8 4450.4 4453.4 4623.3 4649.0 4649.3 4659.4 4660.2 4613.2 4723.7 4810.6 4830.3 4831.0 5091.2 5150.9 5173.4 5203.9 5205.5 4816.4 4832.3 4834.5 4839.5 4849.4 4864.3 4948.7 5069.5 5076.9 5084.4 5096.9 5137.8 5162.8 5178.0 5179.5 5028.7 5032.5 5041.5 5041.7 5046.5 4834.2 4922.1 5024.3 5028.6 5041.3 4909.5 5000.1 5003.9 5005.7 5014.2 5078.5 5098.6 5111.2 5112.8 5115.8 4766.2 4820.8 4993.9 5006.0 5007.0 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | [#1] ext.html Cycles:180 Average:47580.23 Median:369702.00 stddev:87069.84 (23.6%) stddev-sans-first:87242.48 10:14:05 INFO - PROCESS | 14844 | Values: 545.4 565.7 569.4 570.4 574.9 28482.6 38256.4 39609.2 39625.4 42479.4 39484.2 39787.8 40042.6 40049.4 40093.0 7240.9 7412.2 7429.2 7446.3 7457.4 7657.3 7737.1 7747.5 7748.5 7749.3 7766.7 7813.1 7813.8 7818.6 7819.3 7719.5 7747.3 7763.7 7773.9 7784.8 7639.1 7723.2 7731.1 7735.5 7736.5 37661.8 38041.2 38048.8 38052.6 38057.4 2498.7 2514.2 2528.4 2868.1 2954.2 27857.0 28209.7 28528.6 28882.9 29286.6 3140.5 3211.6 3228.5 3244.2 3289.3 244719.0 245548.0 246342.0 246467.0 246591.0 49376.3 49691.3 49795.8 49946.8 49957.5 31865.1 52760.0 52819.0 52959.0 53008.5 12481.0 13032.1 13092.3 13105.9 13128.7 9554.6 9639.6 9642.9 9686.5 9697.4 17486.0 17495.9 17500.4 17657.6 17707.5 6458.2 6530.6 6553.4 6574.4 6718.6 802.5 868.5 947.7 1003.6 1021.4 27412.0 27820.2 27825.6 28042.6 28538.6 905.0 907.3 975.4 975.9 1000.3 14366.6 14511.3 14575.6 15025.8 15088.6 368257.0 371147.0 371332.0 372367.0 373504.0 33215.8 33493.8 33553.0 48635.8 48977.0 1038.6 1106.4 1125.9 1129.8 1130.9 26444.7 28556.0 28701.0 29306.9 29434.9 47221.8 47633.8 48029.0 48052.5 48055.3 354737.0 359704.0 360473.0 360775.0 361840.0 31668.5 36016.5 37809.0 37835.6 38828.2 40598.4 41147.0 41406.8 41436.4 42225.8 35407.6 35701.6 35722.3 36199.3 36507.5 34557.7 35189.1 35322.6 36070.3 36214.5 34442.3 34946.3 35090.8 35267.6 35451.6 29937.3 32175.7 32247.5 32346.4 32717.5 24056.0 24154.3 24318.0 24598.6 24791.5 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | [#2] jquery.html Cycles:180 Average:25921.33 Median:27158.70 stddev:65908.84 (242.7%) stddev-sans-first:66065.73 10:14:05 INFO - PROCESS | 14844 | Values: 333.1 338.6 340.0 341.5 360.5 12751.8 16627.5 17425.7 18734.5 18883.5 14762.8 14900.6 15352.2 15631.0 16274.0 4942.9 5137.2 6496.4 6781.5 6830.8 4018.6 5086.0 6928.2 6985.0 6993.3 6873.9 6987.1 6993.0 6996.9 6998.4 6900.1 6954.8 6963.0 7002.9 7038.9 6510.9 6591.8 6773.3 6773.3 6778.7 23342.8 23690.5 23774.6 23987.6 24083.0 1837.6 1889.6 1937.2 2269.8 2357.9 14008.4 14329.8 14338.6 14449.6 15703.5 1750.0 1770.3 1854.9 1881.3 1935.7 71707.0 76779.6 77600.2 78094.2 81245.0 16798.3 16974.4 17091.5 17395.5 17451.1 28565.3 28690.4 28786.8 28823.9 28829.0 8163.8 8335.3 8516.8 8636.7 8760.2 6783.3 6788.4 6831.0 6974.5 7003.8 8383.5 8437.7 8519.2 8633.7 8668.7 3018.2 3224.1 3379.4 3385.0 3469.7 682.8 694.6 710.8 758.6 862.8 16279.7 16347.3 16545.2 17475.4 17548.6 848.1 850.6 855.3 890.3 935.6 8803.3 9877.0 9879.6 9936.9 10053.6 389096.0 392190.0 394063.0 410031.0 412525.0 49374.5 56612.0 79405.2 85771.0 88715.0 891.4 921.8 946.7 949.1 951.4 15352.5 15836.4 16136.2 16671.2 16967.6 28578.0 38161.6 38471.4 39027.4 39673.6 53318.2 53871.0 55307.7 56332.7 56654.4 7287.3 7303.7 7376.2 7555.4 7561.4 8530.2 11590.5 12002.9 12586.3 12611.3 10058.7 10166.8 10294.5 10547.8 10758.1 10211.9 10241.6 10350.3 10761.0 10883.2 9681.6 10080.7 10209.3 10627.6 11022.8 7316.6 7341.9 7451.1 7545.0 7639.7 8423.6 9101.4 9158.0 9643.7 9947.2 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | [#3] mootools.html Cycles:180 Average:5037.54 Median:5229.99 stddev:2859.82 (54.7%) stddev-sans-first:2854.30 10:14:05 INFO - PROCESS | 14844 | Values: 1334.6 1373.6 1433.0 1653.6 1672.0 6699.0 6982.7 7439.3 8066.2 8081.1 7321.5 7598.3 7644.9 7869.8 7882.0 2134.4 2155.6 2160.8 2165.5 2166.8 1806.4 2034.0 2116.9 2129.0 2160.5 2141.5 2151.1 2166.4 2168.3 2170.5 2052.0 2070.3 2143.9 2146.1 2146.7 2052.5 2082.8 2086.5 2091.1 2123.9 7850.6 7905.3 7917.3 7918.9 7925.3 4260.8 4287.4 4309.8 4311.7 4316.1 2821.8 2941.3 2953.7 2979.2 2989.3 863.8 904.7 905.1 906.3 922.6 10642.4 10674.0 10674.1 10678.4 10679.0 3745.2 3929.4 3982.6 4059.3 4077.2 9187.4 9211.6 9214.5 9228.7 9229.3 4377.9 4390.0 4393.9 4394.4 4399.7 3983.0 3992.2 4005.0 4005.8 4007.8 3375.9 3500.0 3577.0 3621.7 3625.8 1039.8 1112.0 1133.4 1133.6 1178.2 720.7 725.3 739.8 759.2 771.1 4896.3 5091.4 5132.2 5202.8 5318.2 807.9 825.9 835.7 837.3 856.1 3299.7 3303.7 3358.8 3397.6 3426.2 9176.1 9196.5 9341.8 9354.1 9359.1 7888.4 9446.6 9588.4 9670.0 9674.7 7235.6 7468.9 7484.5 7487.1 7487.7 5143.1 5229.0 5231.0 5309.2 5490.3 8753.7 8789.6 8823.9 8879.0 8944.2 8837.2 8936.2 9098.9 9129.1 9140.5 6225.4 6416.1 6422.7 6425.8 6426.9 7249.6 7280.7 7321.9 7330.5 7341.9 6478.8 6553.8 6631.0 6633.9 6713.8 6426.1 6484.8 6533.2 6534.2 6543.3 6007.6 6037.8 6115.3 6118.1 6190.6 4540.6 4550.6 4573.0 4665.2 4772.2 4463.6 4530.6 4587.2 4596.3 4607.8 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | [#4] prototype.html Cycles:180 Average:4212.37 Median:4852.08 stddev:1230.23 (25.4%) stddev-sans-first:1197.93 10:14:05 INFO - PROCESS | 14844 | Values: 290.1 295.2 298.0 304.9 307.9 4857.4 4894.4 4903.5 4925.0 4939.8 4835.4 4842.6 4851.9 4852.2 4865.7 3639.7 3760.3 3794.8 3809.2 3869.4 3814.7 3819.8 3829.9 3873.2 3883.1 3803.3 3806.2 3812.2 3821.2 3821.9 3586.2 3707.9 3805.8 3806.8 3815.9 3376.9 3377.5 3379.4 3383.4 3397.3 4732.9 4746.2 4748.2 4760.5 4762.3 4039.9 4237.4 4345.7 4351.8 4357.2 5090.9 5094.8 5098.2 5102.7 5107.5 3535.3 3541.2 3550.9 3551.5 3563.6 5118.1 5286.2 5303.8 5327.2 5342.9 3650.7 3652.5 3654.3 3658.5 3671.2 3698.0 3708.9 3710.5 3714.9 3716.3 4132.4 4212.9 4255.6 4275.4 4276.0 5043.3 5082.9 5087.9 5088.7 5098.3 1265.8 1285.9 1290.5 1290.9 1293.3 781.9 798.6 824.7 833.2 838.6 4330.4 4445.6 4447.2 4449.0 4453.8 5103.4 5164.2 5240.8 5257.8 5285.4 4499.7 4501.2 4523.1 4524.3 4536.9 2639.9 2765.8 2769.3 2774.5 2792.9 4890.5 4911.7 4914.2 4928.4 4932.0 5059.3 5280.7 5287.3 5322.2 5328.0 4841.9 4848.5 4858.7 4878.4 4889.5 5173.2 5179.9 5255.3 5255.4 5362.7 4981.6 5136.0 5142.0 5153.2 5178.6 4880.2 4882.6 4888.7 4889.6 4895.5 3647.3 3651.2 3670.6 3672.4 3717.7 5008.6 5226.9 5235.2 5235.6 5237.4 5069.6 5092.3 5099.5 5105.7 5112.5 5094.7 5106.4 5108.0 5111.7 5206.4 4865.3 5020.4 5035.6 5044.3 5045.4 4834.3 5044.3 5080.9 5099.0 5119.5 4984.9 4990.5 5019.4 5020.3 5031.4 10:14:05 INFO - PROCESS | 14844 | 10:14:05 INFO - PROCESS | 14844 | [#5] yui.html Cycles:180 Average:17944.54 Median:483.11 stddev:26448.26 (5474.6%) stddev-sans-first:26490.38 10:14:05 INFO - PROCESS | 14844 | Values: 597.9 612.2 635.1 641.5 646.0 11580.7 12018.2 12457.7 13717.2 13909.4 12672.0 12689.9 12694.6 12753.8 12774.9 613.9 745.6 763.6 764.6 765.3 735.7 764.9 765.0 768.0 768.5 808.7 810.0 810.9 811.0 811.2 639.1 803.7 807.9 808.1 808.2 561.3 580.3 581.7 582.5 582.7 12398.4 12399.4 12431.1 12439.8 12473.1 12111.6 12674.5 12705.7 12742.3 13192.3 9682.2 9765.8 10038.5 10076.6 11808.5 4093.5 4101.9 4105.0 4118.4 4118.5 59628.0 60177.4 60885.4 61124.4 62329.4 9080.4 9347.0 9401.1 9465.6 9542.3 17562.9 17594.6 17603.8 17610.6 17637.1 6086.0 6212.3 6245.1 6550.7 6650.1 3327.4 3342.4 3344.6 3359.5 3465.6 2578.8 2694.0 2696.0 2698.6 2701.9 469.5 469.9 476.3 480.9 487.4 424.0 482.2 484.0 491.5 533.0 7010.4 7059.5 7251.8 7347.9 7647.7 419.7 441.3 448.8 455.7 466.5 3307.3 3423.4 3439.8 3461.1 3552.1 87732.1 101009.5 102148.5 102734.5 103102.0 84274.6 88445.0 89139.6 90295.5 91622.0 78083.6 78114.6 78552.6 79273.0 80149.6 6574.5 6689.9 6695.2 6852.5 6881.4 46502.5 47127.3 47652.0 48813.8 50710.5 60152.7 66888.7 67283.3 68160.7 70208.6 8547.2 8845.2 9165.5 10434.4 10619.9 12151.5 12241.7 12513.2 12975.5 13337.7 11291.6 11551.3 11699.8 11787.5 12188.6 10976.2 11069.9 11222.4 11752.0 11762.1 10915.2 11004.2 11149.7 11157.7 11340.7 9630.6 9767.4 9820.8 9916.1 10159.4 9765.2 9786.7 9832.4 10031.8 10120.4 10:14:05 INFO - PROCESS | 14844 | -------- Summary: end -------- 10:14:05 INFO - PROCESS | 14844 | 10:14:06 INFO - TEST-INFO | 14844: exit 0 10:14:06 INFO - TEST-OK | dromaeo_css | took 1121744ms 10:14:06 INFO - TEST-START | kraken 10:14:06 INFO - operating with platform_type : linux_ 10:14:06 INFO - Initialising browser for kraken test... 10:14:06 INFO - TEST-INFO | started process 15153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcFn33l/profile http://localhost:39606/getInfo.html) 10:14:11 INFO - PROCESS | 15153 | __metrics Screen width/height:1600/1200 10:14:11 INFO - PROCESS | 15153 | colorDepth:24 10:14:11 INFO - PROCESS | 15153 | Browser inner width/height: 1024/697 10:14:11 INFO - PROCESS | 15153 | __metrics 10:14:11 INFO - PROCESS | 15153 | 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" 10:14:11 INFO - PROCESS | 15153 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:12 INFO - PROCESS | 15153 | console.error: PushService: 10:14:12 INFO - PROCESS | 15153 | stateChangeProcessEnqueue: Error transitioning state 10:14:12 INFO - PROCESS | 15153 | UnknownError 10:14:12 INFO - TEST-INFO | 15153: exit 0 10:14:12 INFO - Browser initialized. 10:14:12 INFO - Running cycle 1/1 for kraken test... 10:14:12 INFO - TEST-INFO | started process 15234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcFn33l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:25 INFO - PROCESS | 15234 | RSS: Main: 175607808 10:14:25 INFO - PROCESS | 15234 | 10:14:27 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39606/tests/kraken/driver.html?testName=audio-beat-detection) 10:14:28 INFO - PROCESS | 15234 | RSS: Main: 235933696 10:14:28 INFO - PROCESS | 15234 | 10:14:31 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39606/tests/kraken/driver.html?testName=audio-dft) 10:14:32 INFO - PROCESS | 15234 | RSS: Main: 226545664 10:14:32 INFO - PROCESS | 15234 | 10:14:35 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39606/tests/kraken/driver.html?testName=audio-fft) 10:14:36 INFO - PROCESS | 15234 | RSS: Main: 300986368 10:14:36 INFO - PROCESS | 15234 | 10:14:38 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39606/tests/kraken/driver.html?testName=audio-oscillator) 10:14:38 INFO - PROCESS | 15234 | RSS: Main: 209969152 10:14:38 INFO - PROCESS | 15234 | 10:14:41 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:14:41 INFO - PROCESS | 15234 | RSS: Main: 214093824 10:14:41 INFO - PROCESS | 15234 | 10:14:44 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39606/tests/kraken/driver.html?testName=imaging-darkroom) 10:14:45 INFO - PROCESS | 15234 | RSS: Main: 250404864 10:14:45 INFO - PROCESS | 15234 | 10:14:49 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39606/tests/kraken/driver.html?testName=imaging-desaturate) 10:14:49 INFO - PROCESS | 15234 | RSS: Main: 244400128 10:14:49 INFO - PROCESS | 15234 | 10:14:52 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39606/tests/kraken/driver.html?testName=json-parse-financial) 10:14:53 INFO - PROCESS | 15234 | RSS: Main: 247672832 10:14:53 INFO - PROCESS | 15234 | 10:14:55 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:14:55 INFO - PROCESS | 15234 | RSS: Main: 211619840 10:14:55 INFO - PROCESS | 15234 | 10:14:57 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:58 INFO - PROCESS | 15234 | RSS: Main: 219348992 10:14:58 INFO - PROCESS | 15234 | 10:15:00 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:15:01 INFO - PROCESS | 15234 | RSS: Main: 223461376 10:15:01 INFO - PROCESS | 15234 | 10:15:03 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:15:04 INFO - PROCESS | 15234 | RSS: Main: 218562560 10:15:04 INFO - PROCESS | 15234 | 10:15:07 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:15:08 INFO - PROCESS | 15234 | RSS: Main: 221270016 10:15:08 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | Cycle 1(1): loaded http://localhost:39606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39606/tests/kraken/driver.html?testName=ai-astar) 10:15:10 INFO - PROCESS | 15234 | RSS: Main: 271880192 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | __start_tp_report 10:15:10 INFO - PROCESS | 15234 | _x_x_mozilla_page_load 10:15:10 INFO - PROCESS | 15234 | _x_x_mozilla_page_load_details 10:15:10 INFO - PROCESS | 15234 | |i|pagename|runs| 10:15:10 INFO - PROCESS | 15234 | |0;ai-astar;105;116;110;114;116;115;119;113;112;111 10:15:10 INFO - PROCESS | 15234 | |1;audio-beat-detection;146;121;156;184;122;153;143;128;187;125 10:15:10 INFO - PROCESS | 15234 | |2;audio-dft;162;161;161;161;160;161;162;162;162;162 10:15:10 INFO - PROCESS | 15234 | |3;audio-fft;76;76;114;117;77;77;76;120;108;77 10:15:10 INFO - PROCESS | 15234 | |4;audio-oscillator;87;88;156;88;87;86;144;86;86;143 10:15:10 INFO - PROCESS | 15234 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;116;116 10:15:10 INFO - PROCESS | 15234 | |6;imaging-darkroom;146;148;147;146;146;147;146;146;146;146 10:15:10 INFO - PROCESS | 15234 | |7;imaging-desaturate;94;95;94;94;95;95;95;95;95;95 10:15:10 INFO - PROCESS | 15234 | |8;json-parse-financial;65;64;66;67;66;64;66;66;66;66 10:15:10 INFO - PROCESS | 15234 | |9;json-stringify-tinderbox;67;67;67;67;68;67;66;70;68;67 10:15:10 INFO - PROCESS | 15234 | |10;stanford-crypto-aes;82;82;81;82;85;82;83;83;83;82 10:15:10 INFO - PROCESS | 15234 | |11;stanford-crypto-ccm;136;139;135;134;135;136;134;132;153;131 10:15:10 INFO - PROCESS | 15234 | |12;stanford-crypto-pbkdf2;174;172;173;176;176;173;180;179;181;177 10:15:10 INFO - PROCESS | 15234 | |13;stanford-crypto-sha256-iterative;74;76;73;70;69;69;75;68;68;68 10:15:10 INFO - PROCESS | 15234 | __end_tp_report 10:15:10 INFO - PROCESS | 15234 | __start_cc_report 10:15:10 INFO - PROCESS | 15234 | _x_x_mozilla_cycle_collect,1989 10:15:10 INFO - PROCESS | 15234 | __end_cc_report 10:15:10 INFO - PROCESS | 15234 | __startTimestamp1471886110276__endTimestamp 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | ------- Summary: start ------- 10:15:10 INFO - PROCESS | 15234 | Number of tests: 14 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.50 stddev:3.90 (3.4%) stddev-sans-first:2.83 10:15:10 INFO - PROCESS | 15234 | Values: 105.0 116.0 110.0 114.0 116.0 115.0 119.0 113.0 112.0 111.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:149.50 stddev:24.14 (16.1%) stddev-sans-first:25.61 10:15:10 INFO - PROCESS | 15234 | Values: 146.0 121.0 156.0 184.0 122.0 153.0 143.0 128.0 187.0 125.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 10:15:10 INFO - PROCESS | 15234 | Values: 162.0 161.0 161.0 161.0 160.0 161.0 162.0 162.0 162.0 162.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.00 stddev:19.98 (26.3%) stddev-sans-first:20.35 10:15:10 INFO - PROCESS | 15234 | Values: 76.0 76.0 114.0 117.0 77.0 77.0 76.0 120.0 108.0 77.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:86.50 stddev:29.58 (34.2%) stddev-sans-first:30.64 10:15:10 INFO - PROCESS | 15234 | Values: 87.0 88.0 156.0 88.0 87.0 86.0 144.0 86.0 86.0 143.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:15:10 INFO - PROCESS | 15234 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:15:10 INFO - PROCESS | 15234 | Values: 146.0 148.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 10:15:10 INFO - PROCESS | 15234 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 10:15:10 INFO - PROCESS | 15234 | Values: 65.0 64.0 66.0 67.0 66.0 64.0 66.0 66.0 66.0 66.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 10:15:10 INFO - PROCESS | 15234 | Values: 67.0 67.0 67.0 67.0 68.0 67.0 66.0 70.0 68.0 67.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:1.08 (1.3%) stddev-sans-first:1.13 10:15:10 INFO - PROCESS | 15234 | Values: 82.0 82.0 81.0 82.0 85.0 82.0 83.0 83.0 83.0 82.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:135.50 stddev:6.20 (4.6%) stddev-sans-first:6.58 10:15:10 INFO - PROCESS | 15234 | Values: 136.0 139.0 135.0 134.0 135.0 136.0 134.0 132.0 153.0 131.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:176.50 stddev:3.14 (1.8%) stddev-sans-first:3.24 10:15:10 INFO - PROCESS | 15234 | Values: 174.0 172.0 173.0 176.0 176.0 173.0 180.0 179.0 181.0 177.0 10:15:10 INFO - PROCESS | 15234 | 10:15:10 INFO - PROCESS | 15234 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.50 stddev:3.16 (4.4%) stddev-sans-first:3.16 10:15:10 INFO - PROCESS | 15234 | Values: 74.0 76.0 73.0 70.0 69.0 69.0 75.0 68.0 68.0 68.0 10:15:10 INFO - PROCESS | 15234 | -------- Summary: end -------- 10:15:10 INFO - PROCESS | 15234 | 10:15:11 INFO - TEST-INFO | 15234: exit 0 10:15:11 INFO - TEST-OK | kraken | took 65133ms 10:15:11 INFO - SUITE-END | took 1186s 10:15:11 INFO - Completed test suite (00:19:47) 10:15:11 INFO - javascript benchmark 10:15:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.9484010319793, 2627.829191102578, 2630.355562887093, 2641.722619124993, 2654.5354562951493, 4619.7921093550785, 4647.60495357895, 4774.331593576898, 4865.124277630025, 4869.805207791688, 4733.8579842604695, 4745.952540474595, 4752.643551733617, 4788.712677239359, 4814.2297232442725, 4384.912301753963, 4385.802638881242, 4453.732776033432, 4469.776511174428, 4495.527969563198, 4460.933086003713, 4482.417285752847, 4495.775211239425, 4498.100379924012, 4500.39244701966, 4255.0426154115385, 4273.29490634045, 4421.38100665907, 4425.380446737459, 4481.193385190681, 4268.338407546835, 4343.131373725268, 4352.651787856964, 4370.475542934868, 4375.5405682403525, 4313.28830742927, 4332.068605249855, 4333.934990975138, 4335.544767799367, 4344.02259491615, 4605.792739326738, 4699.2481203007355, 4702.224133018048, 4713.5522125398375, 4729.196036673774, 5063.822766203165, 5119.87200319995, 5151.5621172200035, 5152.819651312224, 5155.072087024334, 5168.5089916458255, 5176.145935920568, 5176.9223461647725, 5177.094008548489, 5189.792408303663, 4577.908441831211, 4675.812967481331, 4809.567138957475, 4818.349522814446, 4825.227963525819, 5136.075506408808, 5221.164613661872, 5227.581793456515, 5233.215017747369, 5233.947660523346, 4963.404391472975, 5007.549320561094, 5007.799688012438, 5015.598752099823, 5018.222175562793, 4916.901661966741, 4982.153033984231, 5095.184770436712, 5106.514881086291, 5111.5655169310285, 5039.118154322979, 5112.284280200774, 5127.8718032048755, 5141.0, 5141.871453213699, 5099.515546023122, 5111.0, 5119.923201151985, 5120.129577971679, 5122.564582010571, 4224.936625950613, 4271.850485233064, 4414.3157810539415, 4420.31485119807, 4436.134953684065, 3772.07584141887, 3803.3344164771056, 3824.3116239077235, 3834.6357096075826, 3850.422436634471, 4423.933640995388, 4424.203643344164, 4426.75652839097, 4426.9778651106535, 4434.3348497724955, 4925.335079764186, 5027.0, 5133.307003554547, 5135.845924622267, 5142.254373115878, 4387.4954380246045, 4440.222960981815, 4444.82220711168, 4450.376947227391, 4453.4433195850515, 4623.283391074388, 4648.953510464919, 4649.256119020941, 4659.394278743742, 4660.207764680013, 4613.19269127908, 4723.6929599575915, 4810.56704896547, 4830.347903033045, 4831.033793241366, 5091.236314552847, 5150.9227361588855, 5173.379194496684, 5203.92194117081, 5205.531502164823, 4816.4220293564995, 4832.347633069631, 4834.468208496992, 4839.540243676845, 4849.393825771778, 4864.3189953405845, 4948.678335908155, 5069.493050694901, 5076.898462030813, 5084.3644544431945, 5096.949030509648, 5137.8201762938115, 5162.845114646567, 5178.042062218502, 5179.533841954242, 5028.723420211923, 5032.496750324938, 5041.546260836542, 5041.747912604282, 5046.520580544842, 4834.178189707688, 4922.114019476386, 5024.321716568216, 5028.572571331331, 5041.319421878, 4909.484504127158, 5000.124978128885, 5003.924941125959, 5005.749712514433, 5014.222795466709, 5078.542931136216, 5098.643094983316, 5111.156659151198, 5112.795488180431, 5115.769790359368, 4766.213574760126, 4820.758962051954, 4993.900121997467, 5005.974970125126, 5006.974965125151], "value": 4695.509383892415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.3510322715969, 565.683217398257, 569.3822202909843, 570.3896830391482, 574.9166370876223, 28482.585199294117, 38256.42615360772, 39609.20781584366, 39625.40561891574, 42479.36280955788, 39484.210315793665, 39787.80106099466, 40042.59957400425, 40049.39925901114, 40093.0, 7240.855182896339, 7412.18465968743, 7429.219931907153, 7446.29260220281, 7457.440691948099, 7657.349125324354, 7737.071551413838, 7747.457677962545, 7748.496347737379, 7749.263819937125, 7766.728164514243, 7813.140554538996, 7813.804654883645, 7818.609069546528, 7819.296263336299, 7719.536827790294, 7747.3027427531515, 7763.650635721406, 7773.922260777376, 7784.805379865492, 7639.083310002779, 7723.227677232288, 7731.110922243957, 7735.535867847947, 7736.497127686739, 37661.81169094164, 38041.23917521634, 38048.80975595132, 38052.619473805185, 38057.42913856294, 2498.7001559812757, 2514.2331588865572, 2528.4184637533285, 2868.067877939678, 2954.1686933561, 27857.0, 28209.717902820914, 28528.572071418945, 28882.855585722147, 29286.560701589493, 3140.5289206618963, 3211.550382946389, 3228.4834426491648, 3244.23760416302, 3289.259916518788, 244719.0, 245548.0, 246342.0, 246467.0, 246591.0, 49376.25935610969, 49691.25463118056, 49795.751021244665, 49946.75026624843, 49957.50042499601, 31865.10495558329, 52760.0, 52819.0, 52959.0, 53008.469915301124, 12481.0, 13032.087753857328, 13092.279924604049, 13105.934470327587, 13128.671783205496, 9554.570044348022, 9639.614415423444, 9642.855357169648, 9686.515674216262, 9697.418154910587, 17486.0, 17495.912520437316, 17500.387486437914, 17657.55856103582, 17707.54702832935, 6458.192725909262, 6530.640814755139, 6553.377429144223, 6574.441172500391, 6718.563293386012, 802.4623502253504, 868.4832524647825, 947.6777895515557, 1003.6236411345745, 1021.3514418344256, 27412.0, 27820.16539503818, 27825.582616260774, 28042.579361309596, 28538.571921421197, 904.9547522623974, 907.2741806554861, 975.3562648651997, 975.9072888075622, 1000.2947921715319, 14366.56900292993, 14511.346989385504, 14575.562733118024, 15025.849741502663, 15088.622784430258, 368257.0, 371147.0, 371332.0, 372367.0, 373504.0, 33215.83392083072, 33493.83253083719, 33553.0, 48635.75682121567, 48977.0, 1038.55342202852, 1106.4246591772394, 1125.859267591551, 1129.768397478515, 1130.8756036835941, 26444.735552644226, 28556.0, 28701.0, 29306.853465732536, 29434.852825735736, 47221.7638911817, 47633.76183119062, 48029.0, 48052.5194748048, 48055.279170811766, 354737.0, 359704.0, 360473.0, 360775.0, 361840.0, 31668.5249721259, 36016.4597531032, 37809.0, 37835.64890037681, 38828.22343553056, 40598.39102413407, 41147.0, 41406.79296603498, 41436.37845432261, 42225.78887105545, 35407.645923541466, 35701.64298356983, 35722.285554288246, 36199.27601448009, 36507.452388213664, 34557.654423455446, 35189.12027199341, 35322.64677353194, 36070.27859442744, 36214.45678314775, 34442.31115377628, 34946.30107397889, 35090.824545877105, 35267.647323526435, 35451.64548354483, 29937.251568710955, 32175.678243218204, 32247.51628725524, 32346.35307293888, 32717.509237360984, 24056.0, 24154.275371738877, 24318.02960786069, 24598.631020534347, 24791.50416991686], "value": 17159.775172001344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.10062830358027, 338.6478062814673, 339.9660033996599, 341.47412984004626, 360.51690734415877, 12751.808722869153, 16627.501174964757, 17425.65148697027, 18734.531636709056, 18883.52791180221, 14762.778558321634, 14900.552983410487, 15352.155631440266, 15631.0, 16274.0, 4942.901141977167, 5137.178051511759, 6496.447801936841, 6781.4574834013165, 6830.760923367683, 4018.57804930481, 5086.008228395464, 6928.16861976561, 6985.0, 6993.300669932992, 6873.862522749542, 6987.0916780818425, 6992.965035174817, 6996.8950465743055, 6998.370146686797, 6900.102986611709, 6954.79135625932, 6963.0, 7002.859942801116, 7038.859222815566, 6510.869782604322, 6591.835204119935, 6773.254941956381, 6773.254941956381, 6778.694958726869, 23342.7665723344, 23690.526189476113, 23774.64338034931, 23987.640185397235, 24083.02630066037, 1837.6232872261155, 1889.5653999580175, 1937.1670181821812, 2269.807066399358, 2357.9174728884577, 14008.439662413593, 14329.78505322421, 14338.56984290473, 14449.566513004627, 15703.528894133195, 1749.9737503937451, 1770.3184274054581, 1854.8516118710606, 1881.2569035231145, 1935.6902895536787, 71707.0, 76779.61610191913, 77600.22399776043, 78094.21905780926, 81245.0, 16798.328066877188, 16974.405895793836, 17091.48725538236, 17395.47813565595, 17451.127443628022, 28565.28586785347, 28690.426191476054, 28786.840986926065, 28823.85588072046, 28829.0, 8163.836723265502, 8335.291500222549, 8516.815872247831, 8636.654533818702, 8760.211580957744, 6783.287754785676, 6788.422984046312, 6831.04365388846, 6974.476914231453, 7003.824904377431, 8383.538905360141, 8437.746867593982, 8519.233269005696, 8633.69782057625, 8668.696595619249, 3018.2019413409666, 3224.129485039073, 3379.425497665403, 3384.983075084609, 3469.687728104432, 682.8122266376786, 694.6214313199318, 710.847391817292, 758.6320634492267, 862.8101817600243, 16279.674406511804, 16347.34610615586, 16545.172741363123, 17475.38836140729, 17548.561285967953, 848.1476116502998, 850.6299759604592, 855.2858363266741, 890.25663570919, 935.6070450410843, 8803.295736341077, 9876.950615246878, 9879.555420006118, 9936.900630993598, 10053.587139086567, 389096.0, 392190.0, 394063.0, 410031.0, 412525.0, 49374.50625493771, 56612.0, 79405.20594793979, 85771.0, 88715.0, 891.3760367742476, 921.7695576106107, 946.6544711180508, 949.1173208915636, 951.3863558005048, 15352.539423817303, 15836.366545338518, 16136.193190340202, 16671.249793759067, 16967.575810604834, 28578.0, 38161.6183838158, 38471.422928656655, 39027.41458878176, 39673.603263966994, 53318.200226997404, 53871.0, 55307.72346138243, 56332.718336408056, 56654.43345566492, 7287.307705767944, 7303.671334789841, 7376.188619251985, 7555.357794587302, 7561.357284630868, 8530.195514835763, 11590.536378544764, 12002.879971200176, 12586.307753073668, 12611.30637814929, 10058.698239052841, 10166.796664066826, 10294.485275736333, 10547.789044219226, 10758.139348851917, 10211.948940255252, 10241.590336386462, 10350.264781134048, 10761.0, 10883.183761217782, 9681.564329605326, 10080.747981300527, 10209.285350025428, 10627.574897004033, 11022.834657479983, 7316.561006339637, 7341.926580734124, 7451.068616422947, 7545.0, 7639.694412223449, 8423.5788210588, 9101.362904596615, 9157.954210229173, 9643.662471813454, 9947.204223661945], "value": 9216.490784254309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.6463187255379, 1373.6085215713522, 1433.0, 1653.5783375239312, 1672.0051569316252, 6699.0, 6982.685779139938, 7439.256074392558, 8066.1530539293335, 8081.111077781439, 7321.450891183156, 7598.31615154636, 7644.885326720104, 7869.763907082783, 7881.960590197055, 2134.423705599483, 2155.568886222754, 2160.773118822525, 2165.5344101018277, 2166.772488888668, 1806.4129158023695, 2033.9593208135827, 2116.9153233870625, 2128.968065479019, 2160.5354848707525, 2141.453929248047, 2151.075037733774, 2166.4042388343173, 2168.27362833451, 2170.4573856535867, 2052.0457987036025, 2070.2960993262286, 2143.9464013399634, 2146.1093646136833, 2146.710194123789, 2052.5381789097482, 2082.750069991611, 2086.5096702274955, 2091.059023439443, 2123.946901327464, 7850.646720897574, 7905.328047116002, 7917.287444129998, 7918.881216781753, 7925.3263472604895, 4260.786960651986, 4287.421198138242, 4309.784510774449, 4311.698181127323, 4316.093620339732, 2821.7601503871992, 2941.3234955960247, 2953.719396657314, 2979.1509419815247, 2989.3124581346196, 863.8013256950874, 904.7150147703518, 905.0858632780938, 906.2795077913075, 922.6493932305681, 10642.361458312525, 10674.0, 10674.09270212033, 10678.412687302196, 10679.038886500251, 3745.157339598623, 3929.371300591949, 3982.561918188997, 4059.3099173140045, 4077.164181342877, 9187.356885017985, 9211.585478653476, 9214.539273036455, 9228.676996305097, 9229.307801914883, 4377.934330985037, 4389.956100438954, 4393.890152746207, 4394.384786129945, 4399.670024748157, 3983.0042489377656, 3992.161646054361, 4004.9599504004586, 4005.839766409311, 4007.8396864125693, 3375.8649654014057, 3499.9825000875344, 3577.0, 3621.6921561667555, 3625.800580968072, 1039.838824982129, 1111.9833202501968, 1133.3766428464312, 1133.631569739838, 1178.1752773058722, 720.6684924934589, 725.3037084398931, 739.8113481062295, 759.1876691939682, 771.0593076446726, 4896.3352460163715, 5091.439941606421, 5132.1788513838355, 5202.826693454899, 5318.202269659582, 807.8667019941761, 825.9297959673495, 835.678263868415, 837.250660658707, 856.1310270075878, 3299.736021118305, 3303.653116422741, 3358.815265160391, 3397.643247458981, 3426.194844211608, 9176.08239176077, 9196.494192819326, 9341.766455838522, 9354.111359420844, 9359.064093590723, 7888.447808653454, 9446.622135114518, 9588.424694518351, 9670.032996700274, 9674.693916321346, 7235.602041887747, 7468.925310746931, 7484.513506622052, 7487.064116985268, 7487.7004919803685, 5143.0999575073465, 5228.9738551307, 5231.0, 5309.2301616266195, 5490.286262785812, 8753.693620723245, 8789.560521973748, 8823.911760882309, 8879.0, 8944.150305720947, 8837.204651581389, 8936.151065648754, 9098.863517047383, 9129.087091290818, 9140.542972851465, 6225.408586184305, 6416.13382193398, 6422.743090276524, 6425.839354016187, 6426.871462570816, 7249.601271930094, 7280.745173918887, 7321.926780732338, 7330.45021623391, 7341.853162936818, 6478.773242936474, 6553.770618028346, 6631.0, 6633.867322653617, 6713.798586042427, 6426.100345951664, 6484.837879053061, 6533.18335208099, 6534.150560427304, 6543.312952140147, 6007.639541627516, 6037.758489660365, 6115.266168059861, 6118.051701986199, 6190.597611155261, 4540.5686459787585, 4550.567696068868, 4573.039661670953, 4665.20691482442, 4772.188727916193, 4463.598276155161, 4530.637548996138, 4587.197240482836, 4596.264597664358, 4607.815687372602], "value": 4034.8148423028438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.1079181516836, 295.1617406565355, 297.9612650355454, 304.8826201912263, 307.8953155926984, 4857.4413942396595, 4894.388201474816, 4903.534164254399, 4924.975375123124, 4939.789137060912, 4835.371401717781, 4842.6440596633, 4851.902961940767, 4852.2479015752615, 4865.68373055752, 3639.6542328478818, 3760.3231418344685, 3794.848206071754, 3809.2381523695235, 3869.361555343365, 3814.692111272682, 3819.751716138442, 3829.885103446901, 3873.2253549290253, 3883.0874744435037, 3803.296390167814, 3806.1626442182815, 3812.2184952084895, 3821.197548514815, 3821.9044523886846, 3586.246888153478, 3707.9443808342626, 3805.847766089381, 3806.847726090953, 3815.866444674437, 3376.9493457598155, 3377.544031555733, 3379.4086034944035, 3383.374075795961, 3397.3375191837604, 4732.905341893177, 4746.1931471649905, 4748.216544270192, 4760.547747963938, 4762.261849413347, 4039.858604948842, 4237.364395340693, 4345.739255644671, 4351.804168812379, 4357.1721372939355, 5090.898182036339, 5094.821681241176, 5098.2018396294625, 5102.668326558799, 5107.540321371057, 3535.3207226567433, 3541.220931395089, 3550.8934731958084, 3551.4672799080085, 3563.55455568054, 5118.104331741967, 5286.180642000496, 5303.8408847734245, 5327.227552004938, 5342.946570534284, 3650.68969137621, 3652.4886515887797, 3654.250878569887, 3658.4512323151207, 3671.192337685705, 3697.9815100924325, 3708.9443658345144, 3710.5157936825485, 3714.9412417460894, 3716.3124821907495, 4132.380142978577, 4212.936805947913, 4255.638270746959, 4275.358696195595, 4276.0, 5043.293938848564, 5082.881766011472, 5087.872803179876, 5088.6946783193125, 5098.260752190911, 1265.778488764481, 1285.884270415667, 1290.4773566705499, 1290.9478774798508, 1293.3145432920567, 781.9257170568787, 798.5967086621336, 824.6660102658433, 833.2084519706303, 838.5681374092347, 4330.350447432847, 4445.622122119591, 4447.2439685253585, 4448.977755111268, 4453.77731113443, 5103.366922584812, 5164.225366195025, 5240.764165612481, 5257.815976440883, 5285.392179899361, 4499.662525310615, 4501.212287849613, 4523.117991991596, 4524.343970124313, 4536.911141326058, 2639.8680065996623, 2765.820221685584, 2769.2661444717164, 2774.5422005368887, 2792.9301767455977, 4890.505842020524, 4911.68074075184, 4914.213725803854, 4928.4475390251955, 4932.0, 5059.283010198452, 5280.656757310762, 5287.3126493556365, 5322.2282768998275, 5327.9733601331745, 4841.9031619367415, 4848.539388758062, 4858.732769697701, 4878.36581244443, 4889.46215916256, 5173.22401639757, 5179.870503237449, 5255.3168088148295, 5255.369355677343, 5362.678239305654, 4981.551660350586, 5136.0, 5141.974290128525, 5153.175491921274, 5178.611604129781, 4880.194767863263, 4882.633802464758, 4888.6577939543895, 4889.63327750413, 4895.534924182197, 3647.2705458908854, 3651.214988777426, 3670.632936706308, 3672.412414013745, 3717.665410113103, 5008.57427118699, 5226.921596175985, 5235.1623740201385, 5235.581153507786, 5237.428771368651, 5069.645124841373, 5092.261622064854, 5099.5410413063, 5105.693658380509, 5112.488751124858, 5094.694318340911, 5106.387233532, 5107.974460127824, 5111.744412779271, 5206.375234971828, 4865.270209468608, 5020.447750747342, 5035.622328325464, 5044.344235249394, 5045.394552653705, 4834.250691142878, 5044.293798868088, 5080.949190508048, 5099.0, 5119.48805119485, 4984.900301993867, 4990.476000019946, 5019.3976722793495, 5020.322256495327, 5031.415104242298], "value": 3817.1804612857545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.8505373656586, 612.2071916867656, 635.140482785912, 641.5380925733471, 646.0438550944602, 11580.65258042258, 12018.218815776969, 12457.688557786048, 13717.245551494663, 13909.443622255123, 12672.0, 12689.873101268984, 12694.555690550833, 12753.808692869614, 12774.93612531936, 613.9293981192153, 745.5936514599529, 763.5571368606195, 764.6406189091118, 765.3073968058916, 735.6836560279078, 764.8623247815391, 764.9732259370924, 767.9769606911801, 768.4697558684518, 808.6522795198063, 809.9595020248964, 810.8540462716709, 810.9675612975474, 811.1847593168857, 639.1180171363535, 803.6825453945717, 807.8828569857337, 808.0545761459077, 808.2039191396499, 561.2927711084063, 580.3268208877723, 581.714959669763, 582.4961408381762, 582.7057336045312, 12398.380080995914, 12399.380030998414, 12431.067669924792, 12439.75120497585, 12473.064520160933, 12111.636650900487, 12674.493020279178, 12705.682357941034, 12742.29917354545, 13192.340382980812, 9682.177014953737, 9765.755856103655, 10038.548265328078, 10076.596936122547, 11808.527658893634, 4093.488313960755, 4101.876943691694, 4105.0, 4118.402831589433, 4118.485189351331, 59628.0, 60177.39822601806, 60885.391146088856, 61124.38875611231, 62329.37670623281, 9080.40977336471, 9347.0, 9401.10689484498, 9465.574049167666, 9542.33203675736, 17562.94622322665, 17594.560135996704, 17603.823961760474, 17610.559736006446, 17637.118144092743, 6086.02623580225, 6212.316645169028, 6245.063240513869, 6550.672466376662, 6650.135482387259, 3327.3678001179696, 3342.3649506594156, 3344.6153692325693, 3359.479280711445, 3465.5841299044278, 2578.845269283849, 2693.9865300673373, 2695.986520067387, 2698.649175607198, 2701.905433309864, 469.53516019140807, 469.85434515300364, 476.2784381661785, 480.86295405809875, 487.39806339171093, 424.0120519190279, 482.2452861272098, 483.96854204476597, 491.48885159433786, 532.9573634109262, 7010.439164866799, 7059.541129826544, 7251.782446526613, 7347.926520734831, 7647.694092236248, 419.71039982412645, 441.28511810866604, 448.8272015274143, 455.68102328370276, 466.51482458243726, 3307.3219989902013, 3423.4180189367867, 3439.810810405452, 3461.0828130545424, 3552.0587044433246, 87732.1226787724, 101009.49495252623, 102148.48925755324, 102734.48632756788, 103102.0, 84274.5786271077, 88445.0, 89139.55430222937, 90295.54852225697, 91622.0, 78083.60958195286, 78114.6094269525, 78552.60723696345, 79273.0, 80149.5992520022, 6574.53978221539, 6689.874676745612, 6695.196576410862, 6852.5203235773015, 6881.3806757390075, 46502.53497464982, 47127.344227131434, 47652.0, 48813.75593122012, 50710.49289507058, 60152.69923650354, 66888.6655566719, 67283.3271667277, 68160.6591967037, 70208.64895675489, 8547.230749232598, 8845.203931646183, 9165.495897725688, 10434.37393756377, 10619.893801061891, 12151.453184606537, 12241.69395765113, 12513.249205047727, 12975.545855894998, 13337.710920088819, 11291.604793832177, 11551.306921584732, 11699.766004680028, 11787.469563869818, 12188.57339993096, 10976.176786741185, 11069.93006993007, 11222.382768947786, 11752.001079908303, 11762.117841161777, 10915.23593348458, 11004.229703920648, 11149.665510034712, 11157.68752279557, 11340.716482088013, 9630.566624501775, 9767.402704803995, 9820.803583928424, 9916.107550320507, 10159.390436573829, 9765.218782497524, 9786.657466988621, 9832.360896541702, 10031.849522257025, 10120.443375614117], "value": 6278.234780959833, "unit": "score"}], "name": "dromaeo_css", "value": 6447.170844962937, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 110.0, 114.0, 116.0, 115.0, 119.0, 113.0, 112.0, 111.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 156.0, 184.0, 122.0, 153.0, 143.0, 128.0, 187.0, 125.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 114.0, 117.0, 77.0, 77.0, 76.0, 120.0, 108.0, 77.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 156.0, 88.0, 87.0, 86.0, 144.0, 86.0, 86.0, 143.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 67.0, 66.0, 64.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 70.0, 68.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 82.0, 85.0, 82.0, 83.0, 83.0, 83.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 135.0, 134.0, 135.0, 136.0, 134.0, 132.0, 153.0, 131.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 173.0, 176.0, 176.0, 173.0, 180.0, 179.0, 181.0, 177.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 70.0, 69.0, 69.0, 75.0, 68.0, 68.0, 68.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1574.7, "alertThreshold": 2.0}]} 10:15:12 INFO - Return code: 0 10:15:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:15:12 INFO - # TBPL SUCCESS # 10:15:12 INFO - Running post-action listener: _resource_record_post_action 10:15:12 INFO - [mozharness: 2016-08-22 17:15:12.079578Z] Finished run-tests step (success) 10:15:12 INFO - Running post-run listener: _resource_record_post_run 10:15:12 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 421556224; Read time: 0; Write time: 292572 10:15:12 INFO - TinderboxPrint: CPU usage
13.2% 10:15:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:15:12 INFO - TinderboxPrint: I/O write bytes / time
421,556,224 / 292,572 10:15:12 INFO - TinderboxPrint: CPU idle
8,332.2 (86.7%) 10:15:12 INFO - TinderboxPrint: CPU user
1,205.8 (12.6%) 10:15:12 INFO - TinderboxPrint: Swap in / out
0 / 0 10:15:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130265088; Read time: 0; Write time: 91200 10:15:12 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290746368; Read time: 0; Write time: 201344 10:15:12 INFO - Running post-run listener: _upload_blobber_files 10:15:12 INFO - Blob upload gear active. 10:15:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:15:12 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 10:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:15:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:15:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:15:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:15:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:13 INFO - (blobuploader) - INFO - Done attempting. 10:15:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:15:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:15:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:19 INFO - (blobuploader) - INFO - Done attempting. 10:15:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:15:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:15:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:19 INFO - (blobuploader) - INFO - Done attempting. 10:15:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:15:19 INFO - Return code: 0 10:15:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:15:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:15:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/084dea8d5d65c1fe96a5d80ea30e08dfedfe5df8b311efabbc8f12bc530c2f62bc0332ed3609afc103cad5b70e96552379ada4a135061a9a5f43713e889e765c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5007a3c980611e642336bb1cdae057d9d08c9cd33d55e2e6b8e4e342646f776d247f7c9cdba8963094c5f34f7396ba564e07284f69ff3d28cfc7d21f0c1149e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a735a060de7d43ebd974f49aba4fbd8f180569ba517ad334a25a8bfa8c0fc4905fc114e9d6a81f66adfdb68403b662b65177c0da65314436e7daf3e5ff1a41b9"} 10:15:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:15:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:15:19 INFO - Contents: 10:15:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/084dea8d5d65c1fe96a5d80ea30e08dfedfe5df8b311efabbc8f12bc530c2f62bc0332ed3609afc103cad5b70e96552379ada4a135061a9a5f43713e889e765c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5007a3c980611e642336bb1cdae057d9d08c9cd33d55e2e6b8e4e342646f776d247f7c9cdba8963094c5f34f7396ba564e07284f69ff3d28cfc7d21f0c1149e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a735a060de7d43ebd974f49aba4fbd8f180569ba517ad334a25a8bfa8c0fc4905fc114e9d6a81f66adfdb68403b662b65177c0da65314436e7daf3e5ff1a41b9"} 10:15:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:15:19 INFO - Copying logs to upload dir... 10:15:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:15:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.318947 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-22 10:15:18.447590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 10:15:18.453570) ========= 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=920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981 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-Non-PGO/sha512/084dea8d5d65c1fe96a5d80ea30e08dfedfe5df8b311efabbc8f12bc530c2f62bc0332ed3609afc103cad5b70e96552379ada4a135061a9a5f43713e889e765c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5007a3c980611e642336bb1cdae057d9d08c9cd33d55e2e6b8e4e342646f776d247f7c9cdba8963094c5f34f7396ba564e07284f69ff3d28cfc7d21f0c1149e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a735a060de7d43ebd974f49aba4fbd8f180569ba517ad334a25a8bfa8c0fc4905fc114e9d6a81f66adfdb68403b662b65177c0da65314436e7daf3e5ff1a41b9"} build_url:https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/ByjLjJFdQz6YUprKHD_trA/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-Non-PGO/sha512/084dea8d5d65c1fe96a5d80ea30e08dfedfe5df8b311efabbc8f12bc530c2f62bc0332ed3609afc103cad5b70e96552379ada4a135061a9a5f43713e889e765c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5007a3c980611e642336bb1cdae057d9d08c9cd33d55e2e6b8e4e342646f776d247f7c9cdba8963094c5f34f7396ba564e07284f69ff3d28cfc7d21f0c1149e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a735a060de7d43ebd974f49aba4fbd8f180569ba517ad334a25a8bfa8c0fc4905fc114e9d6a81f66adfdb68403b662b65177c0da65314436e7daf3e5ff1a41b9"}' ========= master_lag: 0.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 10:15:18.770726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 10:15:18.771053) ========= 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=920470bf432669ad7e3a5387000001ca-1471882386.708864-974624981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 1.75 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 10:15:20.527524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 10:15:20.527852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 10:15:20.698505) ========= ========= Total master_lag: 2.32 =========