builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1451529809.1 results: success (0) buildid: 20151230172838 builduid: 1ecb66783ff147ab8c69179b60b552b3 revision: ec3eeea80a5e844869e9897dd496ef312ef17dfe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.100129) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.100540) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.100819) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006512 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.125967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.126250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.166001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.166283) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.243132) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.243414) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.243785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.244054) ========= 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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 18:43: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% 40.4M=0s 2015-12-30 18:43:29 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.360038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.360348) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021865 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.426824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:29.427128) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec3eeea80a5e844869e9897dd496ef312ef17dfe --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 ec3eeea80a5e844869e9897dd496ef312ef17dfe --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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 18:43:29,516 truncating revision to first 12 chars 2015-12-30 18:43:29,516 Setting DEBUG logging. 2015-12-30 18:43:29,516 attempt 1/10 2015-12-30 18:43:29,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec3eeea80a5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 18:43:30,097 unpacking tar archive at: mozilla-central-ec3eeea80a5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.885628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:30.329406) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:30.329937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:30.344667) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:30.345205) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:43:30.345896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-30 18:43:30.346418) ========= /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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:43:30 INFO - MultiFileLogger online at 20151230 18:43:30 in /builds/slave/test 18:43: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 18:43:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:43:30 INFO - {'append_to_log': False, 18:43:30 INFO - 'base_work_dir': '/builds/slave/test', 18:43:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:43:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:43:30 INFO - 'branch': 'Firefox-Non-PGO', 18:43:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:43:30 INFO - 'config_files': ('talos/linux_config.py',), 18:43:30 INFO - 'default_actions': ('clobber', 18:43:30 INFO - 'read-buildbot-config', 18:43:30 INFO - 'download-and-extract', 18:43:30 INFO - 'populate-webroot', 18:43:30 INFO - 'create-virtualenv', 18:43:30 INFO - 'install', 18:43:30 INFO - 'run-tests'), 18:43:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:43:30 INFO - 'download_minidump_stackwalk': True, 18:43:30 INFO - 'download_symbols': 'ondemand', 18:43:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:43:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:43:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:43:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:43:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:43:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:43:30 INFO - 'installer_path': 'installer.exe', 18:43:30 INFO - 'log_level': 'info', 18:43:30 INFO - 'log_name': 'talos', 18:43:30 INFO - 'log_to_console': True, 18:43:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:43:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:43:30 INFO - 'opt_config_files': (), 18:43:30 INFO - 'pip_index': False, 18:43:30 INFO - 'sps_profile': False, 18:43:30 INFO - 'sps_profile_interval': 0, 18:43:30 INFO - 'suite': 'dromaeojs', 18:43:30 INFO - 'system_bits': '32', 18:43:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:43:30 INFO - 'title': 'talos-linux64-ix-047', 18:43:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:43:30 INFO - 'use_talos_json': True, 18:43:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:43:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:43:30 INFO - 'work_dir': 'build'} 18:43:30 INFO - ##### 18:43:30 INFO - ##### Running clobber step. 18:43:30 INFO - ##### 18:43:30 INFO - Running pre-action listener: _resource_record_pre_action 18:43:30 INFO - Running main action method: clobber 18:43:30 INFO - rmtree: /builds/slave/test/build 18:43:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:43:30 INFO - Running post-action listener: _resource_record_post_action 18:43:30 INFO - ##### 18:43:30 INFO - ##### Running read-buildbot-config step. 18:43:30 INFO - ##### 18:43:30 INFO - Running pre-action listener: _resource_record_pre_action 18:43:30 INFO - Running main action method: read_buildbot_config 18:43:30 INFO - Using buildbot properties: 18:43:30 INFO - { 18:43:30 INFO - "project": "", 18:43:30 INFO - "product": "firefox", 18:43:30 INFO - "script_repo_revision": "production", 18:43:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:43:30 INFO - "repository": "", 18:43:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:43:30 INFO - "buildid": "20151230172838", 18:43:30 INFO - "pgo_build": "False", 18:43:30 INFO - "basedir": "/builds/slave/test", 18:43:30 INFO - "buildnumber": 359, 18:43:30 INFO - "slavename": "talos-linux64-ix-047", 18:43:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:43:30 INFO - "platform": "ubuntu64_hw", 18:43:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:43:30 INFO - "branch": "mozilla-central", 18:43:30 INFO - "repo_path": "mozilla-central", 18:43:30 INFO - "revision": "ec3eeea80a5e844869e9897dd496ef312ef17dfe", 18:43:30 INFO - "stage_platform": "linux64", 18:43:30 INFO - "builduid": "1ecb66783ff147ab8c69179b60b552b3", 18:43:30 INFO - "slavebuilddir": "test" 18:43:30 INFO - } 18:43:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:43:30 INFO - Running post-action listener: _resource_record_post_action 18:43:30 INFO - ##### 18:43:30 INFO - ##### Running download-and-extract step. 18:43:30 INFO - ##### 18:43:30 INFO - Running pre-action listener: _resource_record_pre_action 18:43:30 INFO - Running main action method: download_and_extract 18:43:30 INFO - mkdir: /builds/slave/test/build/tests 18:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:30 INFO - https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:43:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/test_packages.json 18:43:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/test_packages.json 18:43:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:43:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:43:32 INFO - Downloaded 1302 bytes. 18:43:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:43:32 INFO - Using the following test package requirements: 18:43:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:43:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:43:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:32 INFO - u'jsshell-linux-x86_64.zip'], 18:43:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:43:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:43:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:43:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:43:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:43:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:43:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:43:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:43: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:32 INFO - https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:43:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:43:35 INFO - Downloaded 21953081 bytes. 18:43:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:43:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:43:36 INFO - Return code: 0 18:43:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:36 INFO - https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:43:39 INFO - Downloaded 21953081 bytes. 18:43:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:43:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:43:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:43:40 INFO - Return code: 0 18:43:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:40 INFO - https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:43:46 INFO - Downloaded 11132285 bytes. 18:43:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:43:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:43:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:43:46 INFO - Return code: 0 18:43:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:46 INFO - https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:43:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:43:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:43:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:43:48 INFO - Downloaded 53372838 bytes. 18:43:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:43:48 INFO - mkdir: /builds/slave/test/properties 18:43:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:43:48 INFO - Writing to file /builds/slave/test/properties/build_url 18:43:48 INFO - Contents: 18:43:48 INFO - build_url:https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:43:48 INFO - Running post-action listener: _resource_record_post_action 18:43:48 INFO - Running post-action listener: set_extra_try_arguments 18:43:48 INFO - ##### 18:43:48 INFO - ##### Running populate-webroot step. 18:43:48 INFO - ##### 18:43:48 INFO - Running pre-action listener: _resource_record_pre_action 18:43:48 INFO - Running main action method: populate_webroot 18:43:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:43:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:43:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:43:48 INFO - '--tppagecycles', 18:43:48 INFO - '7'], 18:43:48 INFO - 'tests': ['tsvgm']}}, 18:43:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:43:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:43:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:43:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:43:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'tests': ['damp', 'tps']}, 18:43:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['damp', 'tps']}, 18:43:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:43:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:43:48 INFO - 'other': {'tests': ['a11yr', 18:43:48 INFO - 'ts_paint', 18:43:48 INFO - 'tpaint', 18:43:48 INFO - 'sessionrestore', 18:43:48 INFO - 'sessionrestore_no_auto_restore']}, 18:43:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['a11yr', 18:43:48 INFO - 'ts_paint', 18:43:48 INFO - 'tpaint', 18:43:48 INFO - 'sessionrestore', 18:43:48 INFO - 'sessionrestore_no_auto_restore']}, 18:43:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['a11yr', 18:43:48 INFO - 'ts_paint', 18:43:48 INFO - 'tpaint', 18:43:48 INFO - 'sessionrestore', 18:43:48 INFO - 'sessionrestore_no_auto_restore']}, 18:43:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['a11yr', 18:43:48 INFO - 'ts_paint', 18:43:48 INFO - 'tpaint', 18:43:48 INFO - 'sessionrestore', 18:43:48 INFO - 'sessionrestore_no_auto_restore']}, 18:43:48 INFO - 'other_l64': {'tests': ['a11yr', 18:43:48 INFO - 'ts_paint', 18:43:48 INFO - 'tpaint', 18:43:48 INFO - 'sessionrestore', 18:43:48 INFO - 'sessionrestore_no_auto_restore']}, 18:43:48 INFO - 'other_nol64': {'tests': ['a11yr', 18:43:48 INFO - 'ts_paint', 18:43:48 INFO - 'tpaint', 18:43:48 INFO - 'sessionrestore', 18:43:48 INFO - 'sessionrestore_no_auto_restore']}, 18:43:48 INFO - 'svgr': {'tests': ['tsvgx', 18:43:48 INFO - 'tsvgr_opacity', 18:43:48 INFO - 'tart', 18:43:48 INFO - 'tscrollx', 18:43:48 INFO - 'cart']}, 18:43:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['tsvgx', 18:43:48 INFO - 'tsvgr_opacity', 18:43:48 INFO - 'tart', 18:43:48 INFO - 'tscrollx', 18:43:48 INFO - 'cart']}, 18:43:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'tests': ['tp5o']}, 18:43:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'talos_options': ['--e10s'], 18:43:48 INFO - 'tests': ['tp5o']}, 18:43:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'talos_options': ['--xperf_path', 18:43:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:48 INFO - 'tests': ['tp5n']}, 18:43:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:48 INFO - 'talos_options': ['--e10s', 18:43:48 INFO - '--xperf_path', 18:43:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:48 INFO - 'tests': ['tp5n']}}, 18:43:48 INFO - 'talos.zip': {'path': '', 18:43:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:43:48 INFO - Running post-action listener: _resource_record_post_action 18:43:48 INFO - ##### 18:43:48 INFO - ##### Running create-virtualenv step. 18:43:48 INFO - ##### 18:43:48 INFO - Running pre-action listener: _resource_record_pre_action 18:43:48 INFO - Running main action method: create_virtualenv 18:43:48 INFO - Creating virtualenv /builds/slave/test/build/venv 18:43:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:43:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:43:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:43:48 INFO - Using real prefix '/usr' 18:43:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:43:49 INFO - Installing distribute.............................................................................................................................................................................................done. 18:43:50 INFO - Installing pip.................done. 18:43:51 INFO - Return code: 0 18:43:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:43: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:43:51 INFO - Using env: {'DISPLAY': ':0', 18:43:51 INFO - 'HOME': '/home/cltbld', 18:43:51 INFO - 'LANG': 'en_US.UTF-8', 18:43:51 INFO - 'LANGUAGE': 'en_US:en', 18:43:51 INFO - 'LOGNAME': 'cltbld', 18:43:51 INFO - 'MAIL': '/var/mail/cltbld', 18:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:51 INFO - 'MOZ_NO_REMOTE': '1', 18:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:51 INFO - 'NO_EM_RESTART': '1', 18:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:51 INFO - 'PWD': '/builds/slave/test', 18:43:51 INFO - 'SHELL': '/bin/bash', 18:43:51 INFO - 'SHLVL': '1', 18:43:51 INFO - 'TERM': 'linux', 18:43:51 INFO - 'TMOUT': '86400', 18:43:51 INFO - 'USER': 'cltbld', 18:43:51 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:51 INFO - '_': '/tools/buildbot/bin/python'} 18:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:43:51 INFO - Cleaning up... 18:43:51 INFO - Return code: 0 18:43:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:43: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 18:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 18:43:51 INFO - Using env: {'DISPLAY': ':0', 18:43:51 INFO - 'HOME': '/home/cltbld', 18:43:51 INFO - 'LANG': 'en_US.UTF-8', 18:43:51 INFO - 'LANGUAGE': 'en_US:en', 18:43:51 INFO - 'LOGNAME': 'cltbld', 18:43:51 INFO - 'MAIL': '/var/mail/cltbld', 18:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:51 INFO - 'MOZ_NO_REMOTE': '1', 18:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:51 INFO - 'NO_EM_RESTART': '1', 18:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:51 INFO - 'PWD': '/builds/slave/test', 18:43:51 INFO - 'SHELL': '/bin/bash', 18:43:51 INFO - 'SHLVL': '1', 18:43:51 INFO - 'TERM': 'linux', 18:43:51 INFO - 'TMOUT': '86400', 18:43:51 INFO - 'USER': 'cltbld', 18:43:51 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:51 INFO - '_': '/tools/buildbot/bin/python'} 18:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:51 INFO - Downloading/unpacking psutil>=0.7.1 18:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:43:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:43:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:53 INFO - Installing collected packages: psutil 18:43:53 INFO - Running setup.py install for psutil 18:43:53 INFO - building 'psutil._psutil_linux' extension 18:43:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:43:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:43:53 INFO - building 'psutil._psutil_posix' extension 18:43:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:43:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:43:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:53 INFO - Successfully installed psutil 18:43:53 INFO - Cleaning up... 18:43:53 INFO - Return code: 0 18:43:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 18:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 18:43:53 INFO - Using env: {'DISPLAY': ':0', 18:43:53 INFO - 'HOME': '/home/cltbld', 18:43:53 INFO - 'LANG': 'en_US.UTF-8', 18:43:53 INFO - 'LANGUAGE': 'en_US:en', 18:43:53 INFO - 'LOGNAME': 'cltbld', 18:43:53 INFO - 'MAIL': '/var/mail/cltbld', 18:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:53 INFO - 'MOZ_NO_REMOTE': '1', 18:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:53 INFO - 'NO_EM_RESTART': '1', 18:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:53 INFO - 'PWD': '/builds/slave/test', 18:43:53 INFO - 'SHELL': '/bin/bash', 18:43:53 INFO - 'SHLVL': '1', 18:43:53 INFO - 'TERM': 'linux', 18:43:53 INFO - 'TMOUT': '86400', 18:43:53 INFO - 'USER': 'cltbld', 18:43:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:53 INFO - '_': '/tools/buildbot/bin/python'} 18:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:43:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:43:55 INFO - Installing collected packages: mozsystemmonitor 18:43:55 INFO - Running setup.py install for mozsystemmonitor 18:43:55 INFO - Successfully installed mozsystemmonitor 18:43:55 INFO - Cleaning up... 18:43:55 INFO - Return code: 0 18:43:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:43:55 INFO - Using env: {'DISPLAY': ':0', 18:43:55 INFO - 'HOME': '/home/cltbld', 18:43:55 INFO - 'LANG': 'en_US.UTF-8', 18:43:55 INFO - 'LANGUAGE': 'en_US:en', 18:43:55 INFO - 'LOGNAME': 'cltbld', 18:43:55 INFO - 'MAIL': '/var/mail/cltbld', 18:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:55 INFO - 'MOZ_NO_REMOTE': '1', 18:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:55 INFO - 'NO_EM_RESTART': '1', 18:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:55 INFO - 'PWD': '/builds/slave/test', 18:43:55 INFO - 'SHELL': '/bin/bash', 18:43:55 INFO - 'SHLVL': '1', 18:43:55 INFO - 'TERM': 'linux', 18:43:55 INFO - 'TMOUT': '86400', 18:43:55 INFO - 'USER': 'cltbld', 18:43:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:55 INFO - '_': '/tools/buildbot/bin/python'} 18:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:56 INFO - Downloading/unpacking blobuploader==1.2.4 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:57 INFO - Downloading blobuploader-1.2.4.tar.gz 18:43:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:43:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:43:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:58 INFO - Downloading docopt-0.6.1.tar.gz 18:43:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:43:58 INFO - Installing collected packages: blobuploader, requests, docopt 18:43:58 INFO - Running setup.py install for blobuploader 18:43:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:43:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:43:58 INFO - Running setup.py install for requests 18:43:58 INFO - Running setup.py install for docopt 18:43:59 INFO - Successfully installed blobuploader requests docopt 18:43:59 INFO - Cleaning up... 18:43:59 INFO - Return code: 0 18:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:43:59 INFO - Using env: {'DISPLAY': ':0', 18:43:59 INFO - 'HOME': '/home/cltbld', 18:43:59 INFO - 'LANG': 'en_US.UTF-8', 18:43:59 INFO - 'LANGUAGE': 'en_US:en', 18:43:59 INFO - 'LOGNAME': 'cltbld', 18:43:59 INFO - 'MAIL': '/var/mail/cltbld', 18:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:59 INFO - 'MOZ_NO_REMOTE': '1', 18:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:59 INFO - 'NO_EM_RESTART': '1', 18:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:59 INFO - 'PWD': '/builds/slave/test', 18:43:59 INFO - 'SHELL': '/bin/bash', 18:43:59 INFO - 'SHLVL': '1', 18:43:59 INFO - 'TERM': 'linux', 18:43:59 INFO - 'TMOUT': '86400', 18:43:59 INFO - 'USER': 'cltbld', 18:43:59 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:59 INFO - '_': '/tools/buildbot/bin/python'} 18:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:59 INFO - Running setup.py (path:/tmp/pip-poTTSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:59 INFO - Running setup.py (path:/tmp/pip-GgCLhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:59 INFO - Running setup.py (path:/tmp/pip-TIt8nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:59 INFO - Running setup.py (path:/tmp/pip-B_wjqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:59 INFO - Running setup.py (path:/tmp/pip-K7qwyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:59 INFO - Running setup.py (path:/tmp/pip-JjFGws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:59 INFO - Running setup.py (path:/tmp/pip-UZQjxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:59 INFO - Running setup.py (path:/tmp/pip-x5uTVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:59 INFO - Running setup.py (path:/tmp/pip-eL2Ax8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:59 INFO - Running setup.py (path:/tmp/pip-p0WCnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:59 INFO - Running setup.py (path:/tmp/pip-mQKik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:00 INFO - Running setup.py (path:/tmp/pip-EBElen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:00 INFO - Running setup.py (path:/tmp/pip-Cub0ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:00 INFO - Running setup.py (path:/tmp/pip-MsZg9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:00 INFO - Running setup.py (path:/tmp/pip-pAJRHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:00 INFO - Running setup.py (path:/tmp/pip-0bOJo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:00 INFO - Running setup.py (path:/tmp/pip-jZKVnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:44:00 INFO - Running setup.py install for manifestparser 18:44:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:44:00 INFO - Running setup.py install for mozcrash 18:44:00 INFO - Running setup.py install for mozdebug 18:44:00 INFO - Running setup.py install for mozdevice 18:44:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:44:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:44:00 INFO - Running setup.py install for mozfile 18:44:01 INFO - Running setup.py install for mozhttpd 18:44:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Running setup.py install for mozinfo 18:44:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Running setup.py install for mozInstall 18:44:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Running setup.py install for mozleak 18:44:01 INFO - Running setup.py install for mozlog 18:44:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Running setup.py install for moznetwork 18:44:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Running setup.py install for mozprocess 18:44:01 INFO - Running setup.py install for mozprofile 18:44:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Running setup.py install for mozrunner 18:44:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:44:01 INFO - Running setup.py install for mozscreenshot 18:44:02 INFO - Running setup.py install for moztest 18:44:02 INFO - Running setup.py install for mozversion 18:44:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:44:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:44:02 INFO - Cleaning up... 18:44:02 INFO - Return code: 0 18:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:44:02 INFO - Using env: {'DISPLAY': ':0', 18:44:02 INFO - 'HOME': '/home/cltbld', 18:44:02 INFO - 'LANG': 'en_US.UTF-8', 18:44:02 INFO - 'LANGUAGE': 'en_US:en', 18:44:02 INFO - 'LOGNAME': 'cltbld', 18:44:02 INFO - 'MAIL': '/var/mail/cltbld', 18:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:02 INFO - 'MOZ_NO_REMOTE': '1', 18:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:02 INFO - 'NO_EM_RESTART': '1', 18:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:02 INFO - 'PWD': '/builds/slave/test', 18:44:02 INFO - 'SHELL': '/bin/bash', 18:44:02 INFO - 'SHLVL': '1', 18:44:02 INFO - 'TERM': 'linux', 18:44:02 INFO - 'TMOUT': '86400', 18:44:02 INFO - 'USER': 'cltbld', 18:44:02 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:02 INFO - '_': '/tools/buildbot/bin/python'} 18:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:02 INFO - Running setup.py (path:/tmp/pip-QJjCBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:02 INFO - Running setup.py (path:/tmp/pip-I4kh_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:02 INFO - Running setup.py (path:/tmp/pip-JaVaM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:02 INFO - Running setup.py (path:/tmp/pip-egF9aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:02 INFO - Running setup.py (path:/tmp/pip-L9yuVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:02 INFO - Running setup.py (path:/tmp/pip-MHikS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:02 INFO - Running setup.py (path:/tmp/pip-_QBbYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:44:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:03 INFO - Running setup.py (path:/tmp/pip-gBlBMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:03 INFO - Running setup.py (path:/tmp/pip-8fhG44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:03 INFO - Running setup.py (path:/tmp/pip-6McRhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:03 INFO - Running setup.py (path:/tmp/pip-pxcI2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:03 INFO - Running setup.py (path:/tmp/pip-9XKwio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:03 INFO - Running setup.py (path:/tmp/pip-DDVJJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:03 INFO - Running setup.py (path:/tmp/pip-YY2Q5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:03 INFO - Running setup.py (path:/tmp/pip-jFuhoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:03 INFO - Running setup.py (path:/tmp/pip-J1bnya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:03 INFO - Running setup.py (path:/tmp/pip-P_GF29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:44:03 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:44:03 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:44:03 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:44:03 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:44:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:05 INFO - Downloading blessings-1.5.1.tar.gz 18:44:05 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:44:05 INFO - Installing collected packages: blessings 18:44:05 INFO - Running setup.py install for blessings 18:44:05 INFO - Successfully installed blessings 18:44:05 INFO - Cleaning up... 18:44:05 INFO - Return code: 0 18:44:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:05 INFO - Reading from file tmpfile_stdout 18:44:05 INFO - Current package versions: 18:44:05 INFO - argparse == 1.2.1 18:44:05 INFO - blessings == 1.5.1 18:44:05 INFO - blobuploader == 1.2.4 18:44:05 INFO - docopt == 0.6.1 18:44:05 INFO - manifestparser == 1.1 18:44:05 INFO - mozInstall == 1.12 18:44:05 INFO - mozcrash == 0.16 18:44:05 INFO - mozdebug == 0.1 18:44:05 INFO - mozdevice == 0.47 18:44:05 INFO - mozfile == 1.2 18:44:05 INFO - mozhttpd == 0.7 18:44:05 INFO - mozinfo == 0.9 18:44:05 INFO - mozleak == 0.1 18:44:05 INFO - mozlog == 3.1 18:44:05 INFO - moznetwork == 0.27 18:44:05 INFO - mozprocess == 0.22 18:44:05 INFO - mozprofile == 0.28 18:44:05 INFO - mozrunner == 6.11 18:44:05 INFO - mozscreenshot == 0.1 18:44:05 INFO - mozsystemmonitor == 0.0 18:44:05 INFO - moztest == 0.7 18:44:05 INFO - mozversion == 1.4 18:44:05 INFO - psutil == 3.1.1 18:44:05 INFO - requests == 1.2.3 18:44:05 INFO - wsgiref == 0.1.2 18:44:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:44:05 INFO - Using env: {'DISPLAY': ':0', 18:44:05 INFO - 'HOME': '/home/cltbld', 18:44:05 INFO - 'LANG': 'en_US.UTF-8', 18:44:05 INFO - 'LANGUAGE': 'en_US:en', 18:44:05 INFO - 'LOGNAME': 'cltbld', 18:44:05 INFO - 'MAIL': '/var/mail/cltbld', 18:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:05 INFO - 'MOZ_NO_REMOTE': '1', 18:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:05 INFO - 'NO_EM_RESTART': '1', 18:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:05 INFO - 'PWD': '/builds/slave/test', 18:44:05 INFO - 'SHELL': '/bin/bash', 18:44:05 INFO - 'SHLVL': '1', 18:44:05 INFO - 'TERM': 'linux', 18:44:05 INFO - 'TMOUT': '86400', 18:44:05 INFO - 'USER': 'cltbld', 18:44:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:05 INFO - '_': '/tools/buildbot/bin/python'} 18:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:44:06 INFO - Cleaning up... 18:44:06 INFO - Return code: 0 18:44:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:44:06 INFO - Using env: {'DISPLAY': ':0', 18:44:06 INFO - 'HOME': '/home/cltbld', 18:44:06 INFO - 'LANG': 'en_US.UTF-8', 18:44:06 INFO - 'LANGUAGE': 'en_US:en', 18:44:06 INFO - 'LOGNAME': 'cltbld', 18:44:06 INFO - 'MAIL': '/var/mail/cltbld', 18:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:06 INFO - 'MOZ_NO_REMOTE': '1', 18:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:06 INFO - 'NO_EM_RESTART': '1', 18:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:06 INFO - 'PWD': '/builds/slave/test', 18:44:06 INFO - 'SHELL': '/bin/bash', 18:44:06 INFO - 'SHLVL': '1', 18:44:06 INFO - 'TERM': 'linux', 18:44:06 INFO - 'TMOUT': '86400', 18:44:06 INFO - 'USER': 'cltbld', 18:44:06 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:06 INFO - '_': '/tools/buildbot/bin/python'} 18:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:06 INFO - Downloading/unpacking jsonschema 18:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:44:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:44:07 INFO - Downloading/unpacking functools32 (from jsonschema) 18:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:08 INFO - Downloading functools32-3.2.3-2.tar.gz 18:44:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:44:08 INFO - warning: no files found matching '*.txt' 18:44:08 INFO - no previously-included directories found matching 'build' 18:44:08 INFO - no previously-included directories found matching 'dist' 18:44:08 INFO - no previously-included directories found matching '.git*' 18:44:08 INFO - Installing collected packages: jsonschema, functools32 18:44:08 INFO - Running setup.py install for functools32 18:44:08 INFO - warning: no files found matching '*.txt' 18:44:08 INFO - no previously-included directories found matching 'build' 18:44:08 INFO - no previously-included directories found matching 'dist' 18:44:08 INFO - no previously-included directories found matching '.git*' 18:44:08 INFO - Successfully installed jsonschema functools32 18:44:08 INFO - Cleaning up... 18:44:08 INFO - Return code: 0 18:44:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62aa59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, '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': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8'] in /builds/slave/test/build 18:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 flake8 18:44:08 INFO - Using env: {'DISPLAY': ':0', 18:44:08 INFO - 'HOME': '/home/cltbld', 18:44:08 INFO - 'LANG': 'en_US.UTF-8', 18:44:08 INFO - 'LANGUAGE': 'en_US:en', 18:44:08 INFO - 'LOGNAME': 'cltbld', 18:44:08 INFO - 'MAIL': '/var/mail/cltbld', 18:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:08 INFO - 'MOZ_NO_REMOTE': '1', 18:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:08 INFO - 'NO_EM_RESTART': '1', 18:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:08 INFO - 'PWD': '/builds/slave/test', 18:44:08 INFO - 'SHELL': '/bin/bash', 18:44:08 INFO - 'SHLVL': '1', 18:44:08 INFO - 'TERM': 'linux', 18:44:08 INFO - 'TMOUT': '86400', 18:44:08 INFO - 'USER': 'cltbld', 18:44:08 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:08 INFO - '_': '/tools/buildbot/bin/python'} 18:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:08 INFO - Downloading/unpacking flake8 18:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:44:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:44:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:44:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:44:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:10 INFO - no previously-included directories found matching 'docs/_build' 18:44:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:44:11 INFO - Running setup.py install for pep8 18:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:11 INFO - no previously-included directories found matching 'docs/_build' 18:44:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:44:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:44:11 INFO - Cleaning up... 18:44:11 INFO - Return code: 0 18:44:11 INFO - Running post-action listener: _resource_record_post_action 18:44:11 INFO - Running post-action listener: _start_resource_monitoring 18:44:11 INFO - Starting resource monitoring. 18:44:11 INFO - ##### 18:44:11 INFO - ##### Running install step. 18:44:11 INFO - ##### 18:44:11 INFO - Running pre-action listener: _resource_record_pre_action 18:44:11 INFO - Running main action method: install 18:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:11 INFO - Reading from file tmpfile_stdout 18:44:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:44:11 INFO - Reading from file tmpfile_stdout 18:44:11 INFO - Output received: 18:44:11 INFO - Usage: mozinstall [options] installer 18:44:11 INFO - Options: 18:44:11 INFO - -h, --help show this help message and exit 18:44:11 INFO - -d DEST, --destination=DEST 18:44:11 INFO - Directory to install application into. [default: 18:44:11 INFO - "/builds/slave/test"] 18:44:11 INFO - --app=APP Application being installed. [default: firefox] 18:44:11 INFO - mkdir: /builds/slave/test/build/application 18:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:44:27 INFO - Reading from file tmpfile_stdout 18:44:27 INFO - Output received: 18:44:27 INFO - /builds/slave/test/build/application/firefox/firefox 18:44:27 INFO - Running post-action listener: _resource_record_post_action 18:44:27 INFO - ##### 18:44:27 INFO - ##### Running run-tests step. 18:44:27 INFO - ##### 18:44:27 INFO - Running pre-action listener: _resource_record_pre_action 18:44:27 INFO - Running main action method: run_tests 18:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:44:27 INFO - Python 2.7.3 18:44:27 INFO - Return code: 0 18:44:27 INFO - grabbing minidump binary from tooltool 18:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:27 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b33d0>, '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 0x211eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:44:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:44:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:44:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:44:27 INFO - Return code: 0 18:44:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:44:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:44:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:44:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:44:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:44:28 INFO - Return code: 0 18:44:28 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/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:44:28 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/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 18:44:28 INFO - Using env: {'DISPLAY': ':0', 18:44:28 INFO - 'HOME': '/home/cltbld', 18:44:28 INFO - 'LANG': 'en_US.UTF-8', 18:44:28 INFO - 'LANGUAGE': 'en_US:en', 18:44:28 INFO - 'LOGNAME': 'cltbld', 18:44:28 INFO - 'MAIL': '/var/mail/cltbld', 18:44:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:44:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:28 INFO - 'MOZ_NO_REMOTE': '1', 18:44:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:28 INFO - 'NO_EM_RESTART': '1', 18:44:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:28 INFO - 'PWD': '/builds/slave/test', 18:44:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:44:28 INFO - 'SHELL': '/bin/bash', 18:44:28 INFO - 'SHLVL': '1', 18:44:28 INFO - 'TERM': 'linux', 18:44:28 INFO - 'TMOUT': '86400', 18:44:28 INFO - 'USER': 'cltbld', 18:44:28 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971', 18:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:28 INFO - '_': '/tools/buildbot/bin/python'} 18:44:28 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/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:44:28 INFO - mozversion application_buildid: 20151230172838 18:44:28 INFO - mozversion application_changeset: ec3eeea80a5e844869e9897dd496ef312ef17dfe 18:44:28 INFO - mozversion application_display_name: Nightly 18:44:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:44:28 INFO - mozversion application_name: Firefox 18:44:28 INFO - mozversion application_remotingname: firefox 18:44:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:44:28 INFO - mozversion application_vendor: Mozilla 18:44:28 INFO - mozversion application_version: 46.0a1 18:44:28 INFO - mozversion platform_buildid: 20151230172838 18:44:28 INFO - mozversion platform_changeset: ec3eeea80a5e844869e9897dd496ef312ef17dfe 18:44:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:44:28 INFO - mozversion platform_version: 46.0a1 18:44:28 INFO - using testdate: 1451529868 18:44:28 INFO - actual date: 1451529868 18:44:28 INFO - starting webserver on 'localhost:55537' 18:44:28 INFO - SUITE-START | Running 3 tests 18:44:28 INFO - TEST-START | dromaeo_css 18:44:28 INFO - operating with platform_type : linux_ 18:44:28 INFO - Initialising browser for dromaeo_css test... 18:44:28 INFO - TEST-INFO | started process 8580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54iBSv/profile http://localhost:55537/getInfo.html) 18:44:32 INFO - PROCESS | 8580 | __metrics Screen width/height:1600/1200 18:44:32 INFO - PROCESS | 8580 | colorDepth:24 18:44:32 INFO - PROCESS | 8580 | Browser inner width/height: 1024/697 18:44:32 INFO - PROCESS | 8580 | __metrics 18:44:32 INFO - PROCESS | 8580 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:44:32 INFO - PROCESS | 8580 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:44:33 INFO - TEST-INFO | 8580: exit 0 18:44:33 INFO - Browser initialized. 18:44:33 INFO - Running cycle 1/1 for dromaeo_css test... 18:44:33 INFO - TEST-INFO | started process 8673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54iBSv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:45 INFO - PROCESS | 8673 | RSS: Main: 149082112 18:44:45 INFO - PROCESS | 8673 | 18:45:36 INFO - PROCESS | 8673 | 1451529936943 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:47:48 INFO - PROCESS | 8673 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55537/tests/dromaeo/cssquery-ext.html) 18:47:49 INFO - PROCESS | 8673 | RSS: Main: 236490752 18:47:49 INFO - PROCESS | 8673 | 18:50:52 INFO - PROCESS | 8673 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-ext.html (next: http://localhost:55537/tests/dromaeo/cssquery-jquery.html) 18:50:52 INFO - PROCESS | 8673 | RSS: Main: 228155392 18:50:52 INFO - PROCESS | 8673 | 18:53:55 INFO - PROCESS | 8673 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55537/tests/dromaeo/cssquery-mootools.html) 18:53:55 INFO - PROCESS | 8673 | RSS: Main: 216289280 18:53:55 INFO - PROCESS | 8673 | 18:56:57 INFO - PROCESS | 8673 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55537/tests/dromaeo/cssquery-prototype.html) 18:56:58 INFO - PROCESS | 8673 | RSS: Main: 210923520 18:56:58 INFO - PROCESS | 8673 | 19:00:01 INFO - PROCESS | 8673 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55537/tests/dromaeo/cssquery-yui.html) 19:00:01 INFO - PROCESS | 8673 | RSS: Main: 210776064 19:00:01 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-yui.html (next: http://localhost:55537/tests/dromaeo/cssquery-dojo.html) 19:03:04 INFO - PROCESS | 8673 | RSS: Main: 284983296 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | __start_tp_report 19:03:04 INFO - PROCESS | 8673 | _x_x_mozilla_page_load 19:03:04 INFO - PROCESS | 8673 | _x_x_mozilla_page_load_details 19:03:04 INFO - PROCESS | 8673 | |i|pagename|runs| 19:03:04 INFO - PROCESS | 8673 | |0;dojo.html;2600.1029644772552;2684.9328766780814;2695.770859476944;2699.4196247806717;2704.743049410306;4365.58526939941;4475.9481521842345;4517.616002639776;4576.199165146103;4581.518940511244;4537.500874903766;4548.636109111271;4602.516735742749;4605.884852878679;4658.184817656914;4202.054537729002;4228.978855105728;4250.872473825775;4337.175936572057;4358.629516491102;4052.3921411788174;4303.415109150347;4312.094460163369;4365.607095361417;4391.099824535962;4118.6499147572495;4173.4157217989505;4263.381809637585;4265.786710664454;4279.251131052085;4208.726432781859;4223.598758117974;4226.598473145046;4245.448091748084;4270.636995855356;4214.2414365414215;4217.746935183868;4233.597808208216;4235.767032813194;4278.914421711548;4322.978385108086;4445.088756804847;4455.6658250631335;4484.5291244419195;4573.954260457386;4890.339804126433;4905.877353066202;4911.140550403701;4912.70523768575;4955.033768415161;4920.458749537584;4927.113119638464;4939.283803848458;4939.629527785431;4944.307796908436;4393.472783265996;4446.599806017474;4500.594946454835;4501.617362524222;4574.222382195035;4913;4923.556879880828;4927.063857866994;4927.827526036572;4931.679440836334;4718.598919091847;4732.976335118371;4735.289706544046;4738.573528382462;4800.903981920342;4686.297055441642;4798.4001999750035;4799.952000480021;4815.374001379798;4946.653734238641;4799.832005879777;4824.831130910471;4825.30033145192;4827;4869.026194761062;4797.808087676523;4798.568128868418;4801.5438533339275;4807.711537307773;4851.078295123915;3899.980500097538;3984.820683069269;3989.780562069056;3991.3613821788376;4023.5775243599587;3631.5823680276576;3637.381645120336;3652.4703917932284;3685.244524872395;3694.5012423322505;4283.378910058086;4302.419173411612;4304.956950430455;4308.138372325548;4342.283523218697;4674.836380726726;4791.257355109894;4928.67963582366;4955.851324460272;5025.673331233458;4150.107726838744;4152.086540961044;4228.217779710763;4248.915021699549;4257.02088519636;4322.956770432255;4324.783760811947;4330.848420305274;4371.213181627274;4375.649948004152;4488.5287044859815;4655.231886738786;4656.534346565317;4665.440147182292;4701.130290896195;4755.667103302736;4759.881002974953;4834.347363105936;4947.455779864284;4961.627877909099;4690.835820746394;4703.576678098988;4710.8351207707565;4714.292856071616;4745.33565300865;4861.270809378621;4862.367892173995;4863.4650188479945;4866.245731911559;4911.901761964812;4613.515580863961;4736.478987311324;4748.145333839942;4750.14497390473;4825.879353016203;4769.403824521934;4772.952270477251;4778.808847646194;4800.591949684316;4820.8794780130775;4767.404074490689;4768.976155119202;4769.093872164278;4769.4753577107185;4803.063402636452;4414.3157810539415;4479.46246450415;4533.954660453353;4675.3220782986955;4715.198416269174;4717.551832575899;4820.4456487502985;4823.0353929215;4828.275758636232;4831.057943701085;4624.052069325848;4631.8378856739855;4662.2307319293295;4664;4712.505186955457 19:03:04 INFO - PROCESS | 8673 | |1;ext.html;487.07698910564505;509.1980131293214;517.4876871896821;523.5209783048509;534.3134072716557;22503.774962250372;22894.54210915783;32856.34287314255;32923.67076329236;33133.66866331336;35639;36020.09949751257;36073.63926360736;36074.45888311677;36086.458703119475;6475;7574.2047085055965;7727.343175830061;7735.961320193391;7775.066991960973;6846.315368463163;6927.896081558755;6946.47901407394;6947.374736273734;9881.665975093378;9615;9709.90290097097;9726.027397260288;9728.951355243214;9730.756731081708;9646.469444180568;9848.310618256724;9857.211423086135;9863.605455781795;9875.753106172331;6911.412529934962;7081.681324340366;9791.559379827924;9984.55069521866;10039.799204015879;36394.27211455756;37022.44466333007;37043;37050.814745926094;37078.8146059268;2674.277944954851;2742.80800343976;2749.8900043998415;2794.203651959202;3086.1975886269506;28328.858355708297;28374;28455.430891382264;28464.573031404547;29044.564331535043;3465.1163953192026;3485.686288234071;3503.544539209912;3521.2605352875926;3620.746547741659;222133;222756;223650;223653;224865;37874.62125378766;54072.45927540753;54393.45606543884;54448.36654900359;54541.45458545364;36393.45409818855;57047.71476142593;58226.708866455396;58317.12524312139;58350;12466.189697669623;12587.87412125867;12699.682507937376;12715.491380344683;12715.55495557651;9487.478188699688;9516.095970882756;9533.570989305497;9562.61749530025;9569.138777510057;18121.818781812275;18230.179641916147;18272.177752001193;18334.633307333777;19110.904445477685;7391.186969433358;7639.809004774814;7673.117591477052;7682.270184332479;7793.2596403341595;832.6877420967137;902.1069141549949;905.1310741688053;918.7840857398506;972.0910948263396;25585;26592.33519161998;26887.327816804343;27010.5948410774;27021.189364319103;912.8128733609594;974.1962880623372;1028.3521381529738;1048.5425258890148;1096.0738176241064;12717.427715752814;12744.490220391266;12820.80768788469;12839.358032098358;12871.549495767604;273575;277829;278332;278400;278703;45275.09449811051;45479.545204548194;45585.63243102712;45598.772006139756;45634.771826140655;1177.756374107327;1190.4285942747356;1219.603628820637;1220.5911019808286;1221.4808706299787;21655;25061.373465663506;25290.494190115725;25956.35109122287;28957;40156.19687606173;40412.393814092226;40632;40698.59301406948;40698.79650601728;199327;199850;201257;201423;201526;22316.330510084725;22380.104795807987;22687.432814179778;23180.304590862303;23348.533029338978;24942.12702555402;24993.375165621004;25151.87424062868;30937.381252375275;33267.833660831544;27526;28365.71634283713;28980.420391592474;31969.360612788078;32804.34391312208;29027.85486072556;29567.55648665315;30293.69706302909;32217.35565288728;32237.838810805795;31713;32312;32522.186945326557;32639.87840790341;32669;27391.467346479876;28803.27991800222;28985.56521652219;28988.565171522867;29138.417231655672;22764.544709106056;22804.657930131394;22921.696533453432;22962.540749184587;23056.654150188097 19:03:04 INFO - PROCESS | 8673 | |2;jquery.html;333.9699427051565;334.8442974017082;335.56711841724194;337.77031618499416;338.8424382662065;11689;12191.390430478485;15034.849651503482;15401;15718.764218536731;9474.384165029269;9492.050794920504;9630.951845240765;9764.365316254438;9826.459544725038;4529.569690879362;4668.906621867561;4673.22891722867;4676.462206846222;4678.111158879819;3021.1993821637284;3128.71841534263;3684.410494320909;4601.447826260854;5203.375594928614;5143.717095559743;5178.896422071556;5200.167973124301;5205.349331333583;5208.322918020652;5084.949150508484;5150.845474635767;5767.019606666856;5793.913091303634;5793.913091303634;5132.358455193101;5137.075326441239;5138.434772175057;5144;5144.176931690949;12016.579419720269;16417.67164656712;18234.541236701163;18529.62940741191;18558.164882580182;1792.3905872003581;1806.801251862294;1807.4306593423162;1827.6424705507752;1842.134196927442;8916.509591972439;9119.81760364789;10102.989701029912;12062.69843253917;12323.568675096418;1643.0716645095483;1742.712452445345;1752.255291501107;1791.811859754733;1795.7485951966735;55315.446845531435;55827.441725582634;56424.15363769505;56429.71785141089;57069.71465142689;9341.532923353805;9505.477198753997;9588.808223835484;9632.27757918159;9669.9033009669;12241.081918855944;12251.632451026484;12288.201266917622;12326.81509777354;12345.259284442962;6520.119783829217;6569.441597464269;6580.374864387875;6650.401463868178;6684.331566843277;6210.099535567318;6215.844603884939;6243.750249989949;6273.811785646438;6275.8075965566395;3992.540857801332;4012.29784787661;4041.9797901010306;4048.838046478108;4094.3653733671326;1519.8860085493632;1600.199900049975;1636.9099699516642;1649.2083799776174;1680.2186983052939;570.7317560746443;839.9496030238205;847.8770578266117;871.2681347667989;967.9159341537523;15590.610234744223;15896.284667190004;16563.254653540618;16698.332066717438;17303.74044389335;710.8755967705631;835.7268230413266;854.3250831842774;861.9482831030158;874.7987962768599;7972.641231144612;8470.364722645703;8544.829103417896;8634.222919937236;8998.920129584361;312743;318620;319683;321516;494997;70872.64563677149;76652.61673691595;77182;77284;77788;1029.5881647341123;1031.4120951057826;1035.6323505155713;1037.3361048928691;1039.2569312941284;13966.301684915918;14392.784108238175;14439.639009024439;14461.13233206011;14872.182029988455;32298.639683642406;32643.18392040218;32913.83543082269;33932.151696207795;33969.830150849084;42341;42414.78792606017;42655.36016959686;42794.78602606967;46584.301235480816;8233.629486673233;8557.957210214157;8561.058283588676;8630.136986301319;8662.090480499457;10099.293049486465;10112.342697724624;10156.18750499973;10210.795784084128;10243;9607.663731769355;12973.54592589255;13195;13274.336283185996;13378.264195469343;12888.871111288767;13020.47918083266;13227.66930826737;13778.448862045407;13884.236366999912;10262.538185781508;10554.261201715806;13430.19418834873;13621.35975340382;14003.789943151065;7370.520916140434;8618.65525379003;8877.49082655963;8967.192952634294;8987.056359082202;12072.33602151855;13410;13447.193168409927;13535.390907408993;14045.859541404456 19:03:04 INFO - PROCESS | 8673 | |3;mootools.html;1090.7327704712347;1329.0231679715407;1336.1381908668907;1425.4796999095333;1709.5384246253511;5715.685637289947;6456.548041637087;6563.1796025496815;6574.8685026299445;6587.901181482275;6545.541812073145;6699.229588597313;6704.731810727565;6714.395704386604;6716.697748601312;1619.8137214220399;1657.370199324255;2018.677011678128;2024.1093918675808;2055.835533157344;2085.2493102483095;2092.748870135586;2095.465656257652;2095.706601075851;2095.779943105975;2007.7791442941266;2011.406635042666;2051.5589148333106;2053.5790163016545;2055.14711394771;2008.4577164165594;2026.0275067967311;2036.9592608147755;2055.6710926251803;2056;2073.9274125405536;2115.2913773885766;2118.5868755592664;2119.862208956413;2123.98938005309;6921.48088893335;7034.507584469089;7041.612711300876;7045.506814522985;7052.541584796972;3977.423273625308;4021;4022.7988600569856;4028.3554631258858;4043.5349934757587;2557.7698007179442;2653.3764565327133;2668.3062403774966;2673.8128331016837;2693.3266683329166;783.1033466680676;787.3976408047848;810.4691427115249;814.1614137438448;815.759350991459;9187.586558604879;9189.862152067724;9197.264218862409;9201.079892010812;9229;3751.4935483709896;3825.3879379299733;3891.552471465761;3899.999999999943;3906.843726250975;8005.039395272604;8013.038435387791;8015.358771298283;8022.4785388950695;8044.879326809985;3955.050787810962;3960.980195099006;3967.285888540033;3968.722189446769;3970.0471886746973;3533.452314891196;3555.182308069107;3557.0395993081725;3568.2149927016017;3573.0888623400865;2734.917952461429;2783.707710690389;3306.1073510152605;3311.5529403530695;3385.3906296866307;1057.8677665291839;1070.5343175718588;1078.665613659768;1080.0225795654944;1083.4745148602922;856.3919617071824;880.9075047120089;885.2342723544087;1085.2837127495816;1196.2702751321688;6394.1687580614225;6432;6459;6468.288488266287;6474.223093228843;1045.895410458948;1113.4989254835357;1123.4438952718456;1124.3872089711126;1148.465963327057;5128.871778205575;5184.248283998874;5205.869853253624;5207.6875387476875;5216;7920.683172673029;8056.8388632227025;8236.546989915492;8318.417710760188;8334.12491688364;8345.707900223462;8427.452215606088;8459.746207613782;8485.660573577112;8513;6251.843703907439;6450.0647406125845;6492.448141907897;6532.6733663316645;6574.7507973485845;6552.967235163794;6621.867562648817;6622.735090596515;6624.470042396693;6626.801195964129;7346.96326518364;7529.73645922412;7623.9326494289735;7626.970359001464;7629.694812207449;7558.1686014539455;7746.0317460317465;7832.373410127062;7840.176781437867;7847.607619619111;6193.566450348432;6235.812925612239;6257.4994000480765;6274.058891166362;6276.968615156895;6580.440662543738;6709.127813384229;6716.899246511404;6725.159355080615;6732.057511948233;6256.186695729526;6289.433950944437;6354.1104245406605;6414.871702566016;6482.902756458562;6255.093011513214;6264.59280146789;6270.310265870842;6280.874382512233;6432.614043157426;6125.601835880653;6234.376562343729;6248.656323902229;6249.843753906189;6265;5732.3121225453215;5757.568182386254;5765.91351129725;5772.5959182856795;5783.971080144741;5775.6823374714795;5820.941790582209;5833.0375488044;5839.15332276809;5861.706914654165 19:03:04 INFO - PROCESS | 8673 | |4;prototype.html;299.1190942673826;303.14059640918;310.39937720510807;312.29265713159697;312.7826160818232;5223.294855194547;5298.4436634153435;5356.999999999995;5359.1425371940495;5408.35099788025;5173.723561632888;5242.449542798008;5273.947260527393;5276.445973172809;5299.443558426367;3893.8637147699837;3980;4134.4831896013;4156.376543518481;4156.729812562181;4039.1719697462095;4062.106336605942;4113.506379234496;4116.814743336557;4117.4441450404265;4060.4112403701447;4064.0855807443236;4064.2074795414906;4069.511658600972;4071.9185616287655;3856.267309211255;3936.566977632458;3993.301172294866;4064.532578753422;4068.9796551017203;3584.910377240564;3596.5863925648623;3600.459931010343;3603.6756691897594;3617.1318883468043;5018.5985121190215;5075.314832497603;5075.847724568269;5076.6192535559985;5077.086124497589;4715.504871988461;4718.8584342469785;4720.221163508017;4722.952770472286;4724.669273150881;5323.840284791462;5510.91733623996;5515.365732940683;5519.586031047687;5521.1442226454965;3924.646781789624;3928.0572662561067;3931.154801717616;3935.4293627423863;3936.6653834423823;5736.3403208631125;5794.62334948227;5812.128180772876;5814.3313518945015;5820.767169313222;4067.28822456069;4072.6131017553284;4072.6538244249573;4075.7962101894786;4076.286649836267;3937.2716047530726;4063.6139566741704;4121.855735049259;4124.752514849119;4132.524759652679;4585.449746030431;4587.7017993830295;4588.747618880927;4619.422572178478;4652;5480.260164877691;5490.368607610096;5495.697736624444;5497.175423686479;5498.367687715884;1436.6049336432566;1450.166154461189;1458.540559723705;1459.2339022013316;1460.2990564529086;996.2627655534852;1001.5593139018808;1006.7684432580547;1010.1968934696934;1021.0351218098974;4857.611391088704;4866.075445665312;4869.659123861366;4869.756512174377;4870.732109733928;5673.914891276634;5714.171445140431;5719.370869204384;5731;5736.13957906309;4869.756512174377;4869.780859861315;4871.415430148334;4877.609791216694;4880.097182021337;2827.180117765825;2941.058861164407;3027.3188532579993;3052.3132295233395;3082.1832214463184;5470.152126420411;5569.610127291051;5578.41426650204;5584.162375643686;5584.246126772915;5935.73289201987;5954.612950158225;5959.225300710967;5960.85097872548;5961.046232602763;5470.206820011076;5501.174823776466;5505.614606977473;5507.531859791882;5514.503694667579;5561.805336813192;5728.684922329146;5778.537716982715;5785.334686510937;5791.333996590446;5640.520555752807;5640.520555752807;5641.210230567806;5641.802536911188;5649.830505084854;5490.6431081979545;5491.093969494988;5495.2856128703015;5497.202905578749;5505.476979686923;3856.4600955866763;3913.92172156561;3951.881443556698;3953.4069889516804;3954.2486927483687;5758.395368486249;5758.942410576008;5763.7982670606325;5767.163761254678;5775.306963164279;5570.832875013756;5571.359293681278;5575.804846830341;5576.1356989666665;5579.163125531203;5571.582131340085;5571.777128914798;5572.080606699849;5572.247746554325;5573;5274.920876186783;5435.130379139318;5439.156930675752;5446.700431476307;5457.672539647634;5613.810613860516;5616.69108199053;5617.269754931833;5624.437556244343;5624.606277560531;5175.353080864892;5348.930213957146;5356.250124982584;5357.142857142839;5358.946410535845 19:03:04 INFO - PROCESS | 8673 | |5;yui.html;697.4315932515003;698.7205117952818;704.8414106825961;705.6330708031827;733.6368497593692;11318.490667919943;11494.885051149507;11519.539218431262;11523.942380288086;12544.874551254485;12912.935435322834;13024.088313818036;13031.348432578357;13045.80431293529;13049.73900521989;535.8472835241956;541.41256736441;782.503110524818;789.1083076124;798.1818635898222;751.1962200445525;787.1184273613561;797.8364435290752;799.5482552357928;807.3863863463752;547.6385585513561;833.3166803221361;837.7570504553672;838.279079991207;839.0267289943666;557.2310211907562;814.3729328417115;821.0229826506438;831.8377916306323;832.5254604875223;614.4592758372648;614.6527212125135;614.7540983606549;615.2893408113591;616.7132283488199;10886.455677216107;11000.284981476178;11008.889911100867;11011.174161937886;11015.559377624886;10513.211509136845;11193.776124477547;11200.943995280053;11207.08066574941;11249.381284029376;9015.36892417531;9213.355065145442;9258.814823703555;9528.428294302365;9759.365641233368;3139.5290706393994;3247.1232767152737;3266.738660907122;3266.852991615383;3282.097423208613;41033.79483102595;41583.584164158274;41629.375559366636;41753.582464175575;41950.79024604888;8449.788755281168;8457.492550446992;8513.702020429255;8676.219140277406;8850.468971861581;16000.439984600484;16079.839201608069;16191.433299834449;16192.352305907867;16248;5643.633163844337;5814.331351894586;5875.471207591338;5935.258092738408;6081.118237855486;3253.4143854106487;3370.410178218802;3454.844531996016;3492.7729697569575;3496.3881320768764;2575.2016874768883;2623.0556999480173;2625.763681268695;2629.7107318194985;2630.118910165116;469.0993292877683;471.067286772193;474.24594894117826;475.36301356182884;479.101684341859;417.09906601740704;427.3568279738973;438.0778461338899;454.51140024473824;497.55717411503065;6999.405050570758;7167.4266058715175;7295.927040729631;7325;7442.590657513889;406.9776162311101;429.5382463851372;440.3109134204959;488.33098654843093;526.3420724094882;3456.3087382523595;3490.8254587271044;3535.5227044348685;3537.964620353815;3562.5546806649168;44654.553454465036;44765.776171119585;44786.32820507695;44849.32726009112;45167.77416112898;43507.34738978918;43560.56439435628;43638.78180609077;44156;44308.3353749694;36642;37626.247475050346;37944.62055379466;38027.957763378865;38902;7456.440766942393;7563.470557060953;7567.432442566939;7622.771316860281;7735.497192682457;30457.54313685341;30671.079867604007;32454.675453245167;33593;33982.66017339795;40593.1881362377;40932;41889;45472.54527454683;45523.77238113788;9617.807643847224;10054.29619926598;10395.32430392022;10519.789604208027;10555.52500137511;10699.786004280026;10720.35677859331;10894.782104358026;12464.252144871336;12475.875241247471;9409.623615055321;9535.284853635867;9636.71089867305;9823.803523929624;10850.78298434011;10407.427591482541;10876.347419154876;10964.396958167377;10977;10987.066099381642;10104.494775261355;10422.374657520573;10897.56409743633;10898.18263630215;10908.672739817817;7863.52818830872;7948.84102317962;8041.758747237593;8327.541985190872;8501.702440414556;8664.436811607226;8724.072160852074;9188.173064424234;9209.447433154031;9248.075192480697 19:03:04 INFO - PROCESS | 8673 | __end_tp_report 19:03:04 INFO - PROCESS | 8673 | __start_cc_report 19:03:04 INFO - PROCESS | 8673 | _x_x_mozilla_cycle_collect,761 19:03:04 INFO - PROCESS | 8673 | __end_cc_report 19:03:04 INFO - PROCESS | 8673 | __startTimestamp1451530984644__endTimestamp 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | ------- Summary: start ------- 19:03:04 INFO - PROCESS | 8673 | Number of tests: 6 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | [#0] dojo.html Cycles:165 Average:4506.12 Median:4656.53 stddev:448.09 (9.6%) stddev-sans-first:423.79 19:03:04 INFO - PROCESS | 8673 | Values: 2600.1 2684.9 2695.8 2699.4 2704.7 4365.6 4475.9 4517.6 4576.2 4581.5 4537.5 4548.6 4602.5 4605.9 4658.2 4202.1 4229.0 4250.9 4337.2 4358.6 4052.4 4303.4 4312.1 4365.6 4391.1 4118.6 4173.4 4263.4 4265.8 4279.3 4208.7 4223.6 4226.6 4245.4 4270.6 4214.2 4217.7 4233.6 4235.8 4278.9 4323.0 4445.1 4455.7 4484.5 4574.0 4890.3 4905.9 4911.1 4912.7 4955.0 4920.5 4927.1 4939.3 4939.6 4944.3 4393.5 4446.6 4500.6 4501.6 4574.2 4913.0 4923.6 4927.1 4927.8 4931.7 4718.6 4733.0 4735.3 4738.6 4800.9 4686.3 4798.4 4800.0 4815.4 4946.7 4799.8 4824.8 4825.3 4827.0 4869.0 4797.8 4798.6 4801.5 4807.7 4851.1 3900.0 3984.8 3989.8 3991.4 4023.6 3631.6 3637.4 3652.5 3685.2 3694.5 4283.4 4302.4 4305.0 4308.1 4342.3 4674.8 4791.3 4928.7 4955.9 5025.7 4150.1 4152.1 4228.2 4248.9 4257.0 4323.0 4324.8 4330.8 4371.2 4375.6 4488.5 4655.2 4656.5 4665.4 4701.1 4755.7 4759.9 4834.3 4947.5 4961.6 4690.8 4703.6 4710.8 4714.3 4745.3 4861.3 4862.4 4863.5 4866.2 4911.9 4613.5 4736.5 4748.1 4750.1 4825.9 4769.4 4773.0 4778.8 4800.6 4820.9 4767.4 4769.0 4769.1 4769.5 4803.1 4414.3 4479.5 4534.0 4675.3 4715.2 4717.6 4820.4 4823.0 4828.3 4831.1 4624.1 4631.8 4662.2 4664.0 4712.5 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | [#1] ext.html Cycles:180 Average:38442.47 Median:32417.09 stddev:61565.34 (189.9%) stddev-sans-first:61672.09 19:03:04 INFO - PROCESS | 8673 | Values: 487.1 509.2 517.5 523.5 534.3 22503.8 22894.5 32856.3 32923.7 33133.7 35639.0 36020.1 36073.6 36074.5 36086.5 6475.0 7574.2 7727.3 7736.0 7775.1 6846.3 6927.9 6946.5 6947.4 9881.7 9615.0 9709.9 9726.0 9729.0 9730.8 9646.5 9848.3 9857.2 9863.6 9875.8 6911.4 7081.7 9791.6 9984.6 10039.8 36394.3 37022.4 37043.0 37050.8 37078.8 2674.3 2742.8 2749.9 2794.2 3086.2 28328.9 28374.0 28455.4 28464.6 29044.6 3465.1 3485.7 3503.5 3521.3 3620.7 222133.0 222756.0 223650.0 223653.0 224865.0 37874.6 54072.5 54393.5 54448.4 54541.5 36393.5 57047.7 58226.7 58317.1 58350.0 12466.2 12587.9 12699.7 12715.5 12715.6 9487.5 9516.1 9533.6 9562.6 9569.1 18121.8 18230.2 18272.2 18334.6 19110.9 7391.2 7639.8 7673.1 7682.3 7793.3 832.7 902.1 905.1 918.8 972.1 25585.0 26592.3 26887.3 27010.6 27021.2 912.8 974.2 1028.4 1048.5 1096.1 12717.4 12744.5 12820.8 12839.4 12871.5 273575.0 277829.0 278332.0 278400.0 278703.0 45275.1 45479.5 45585.6 45598.8 45634.8 1177.8 1190.4 1219.6 1220.6 1221.5 21655.0 25061.4 25290.5 25956.4 28957.0 40156.2 40412.4 40632.0 40698.6 40698.8 199327.0 199850.0 201257.0 201423.0 201526.0 22316.3 22380.1 22687.4 23180.3 23348.5 24942.1 24993.4 25151.9 30937.4 33267.8 27526.0 28365.7 28980.4 31969.4 32804.3 29027.9 29567.6 30293.7 32217.4 32237.8 31713.0 32312.0 32522.2 32639.9 32669.0 27391.5 28803.3 28985.6 28988.6 29138.4 22764.5 22804.7 22921.7 22962.5 23056.7 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | [#2] jquery.html Cycles:180 Average:22293.52 Median:4027.14 stddev:59477.62 (1476.9%) stddev-sans-first:59621.62 19:03:04 INFO - PROCESS | 8673 | Values: 334.0 334.8 335.6 337.8 338.8 11689.0 12191.4 15034.8 15401.0 15718.8 9474.4 9492.1 9631.0 9764.4 9826.5 4529.6 4668.9 4673.2 4676.5 4678.1 3021.2 3128.7 3684.4 4601.4 5203.4 5143.7 5178.9 5200.2 5205.3 5208.3 5084.9 5150.8 5767.0 5793.9 5793.9 5132.4 5137.1 5138.4 5144.0 5144.2 12016.6 16417.7 18234.5 18529.6 18558.2 1792.4 1806.8 1807.4 1827.6 1842.1 8916.5 9119.8 10103.0 12062.7 12323.6 1643.1 1742.7 1752.3 1791.8 1795.7 55315.4 55827.4 56424.2 56429.7 57069.7 9341.5 9505.5 9588.8 9632.3 9669.9 12241.1 12251.6 12288.2 12326.8 12345.3 6520.1 6569.4 6580.4 6650.4 6684.3 6210.1 6215.8 6243.8 6273.8 6275.8 3992.5 4012.3 4042.0 4048.8 4094.4 1519.9 1600.2 1636.9 1649.2 1680.2 570.7 839.9 847.9 871.3 967.9 15590.6 15896.3 16563.3 16698.3 17303.7 710.9 835.7 854.3 861.9 874.8 7972.6 8470.4 8544.8 8634.2 8998.9 312743.0 318620.0 319683.0 321516.0 494997.0 70872.6 76652.6 77182.0 77284.0 77788.0 1029.6 1031.4 1035.6 1037.3 1039.3 13966.3 14392.8 14439.6 14461.1 14872.2 32298.6 32643.2 32913.8 33932.2 33969.8 42341.0 42414.8 42655.4 42794.8 46584.3 8233.6 8558.0 8561.1 8630.1 8662.1 10099.3 10112.3 10156.2 10210.8 10243.0 9607.7 12973.5 13195.0 13274.3 13378.3 12888.9 13020.5 13227.7 13778.4 13884.2 10262.5 10554.3 13430.2 13621.4 14003.8 7370.5 8618.7 8877.5 8967.2 8987.1 12072.3 13410.0 13447.2 13535.4 14045.9 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | [#3] mootools.html Cycles:180 Average:4833.24 Median:6235.09 stddev:2505.50 (40.2%) stddev-sans-first:2496.73 19:03:04 INFO - PROCESS | 8673 | Values: 1090.7 1329.0 1336.1 1425.5 1709.5 5715.7 6456.5 6563.2 6574.9 6587.9 6545.5 6699.2 6704.7 6714.4 6716.7 1619.8 1657.4 2018.7 2024.1 2055.8 2085.2 2092.7 2095.5 2095.7 2095.8 2007.8 2011.4 2051.6 2053.6 2055.1 2008.5 2026.0 2037.0 2055.7 2056.0 2073.9 2115.3 2118.6 2119.9 2124.0 6921.5 7034.5 7041.6 7045.5 7052.5 3977.4 4021.0 4022.8 4028.4 4043.5 2557.8 2653.4 2668.3 2673.8 2693.3 783.1 787.4 810.5 814.2 815.8 9187.6 9189.9 9197.3 9201.1 9229.0 3751.5 3825.4 3891.6 3900.0 3906.8 8005.0 8013.0 8015.4 8022.5 8044.9 3955.1 3961.0 3967.3 3968.7 3970.0 3533.5 3555.2 3557.0 3568.2 3573.1 2734.9 2783.7 3306.1 3311.6 3385.4 1057.9 1070.5 1078.7 1080.0 1083.5 856.4 880.9 885.2 1085.3 1196.3 6394.2 6432.0 6459.0 6468.3 6474.2 1045.9 1113.5 1123.4 1124.4 1148.5 5128.9 5184.2 5205.9 5207.7 5216.0 7920.7 8056.8 8236.5 8318.4 8334.1 8345.7 8427.5 8459.7 8485.7 8513.0 6251.8 6450.1 6492.4 6532.7 6574.8 6553.0 6621.9 6622.7 6624.5 6626.8 7347.0 7529.7 7623.9 7627.0 7629.7 7558.2 7746.0 7832.4 7840.2 7847.6 6193.6 6235.8 6257.5 6274.1 6277.0 6580.4 6709.1 6716.9 6725.2 6732.1 6256.2 6289.4 6354.1 6414.9 6482.9 6255.1 6264.6 6270.3 6280.9 6432.6 6125.6 6234.4 6248.7 6249.8 6265.0 5732.3 5757.6 5765.9 5772.6 5784.0 5775.7 5820.9 5833.0 5839.2 5861.7 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | [#4] prototype.html Cycles:180 Average:4608.35 Median:5199.32 stddev:1350.97 (26.0%) stddev-sans-first:1315.48 19:03:04 INFO - PROCESS | 8673 | Values: 299.1 303.1 310.4 312.3 312.8 5223.3 5298.4 5357.0 5359.1 5408.4 5173.7 5242.4 5273.9 5276.4 5299.4 3893.9 3980.0 4134.5 4156.4 4156.7 4039.2 4062.1 4113.5 4116.8 4117.4 4060.4 4064.1 4064.2 4069.5 4071.9 3856.3 3936.6 3993.3 4064.5 4069.0 3584.9 3596.6 3600.5 3603.7 3617.1 5018.6 5075.3 5075.8 5076.6 5077.1 4715.5 4718.9 4720.2 4723.0 4724.7 5323.8 5510.9 5515.4 5519.6 5521.1 3924.6 3928.1 3931.2 3935.4 3936.7 5736.3 5794.6 5812.1 5814.3 5820.8 4067.3 4072.6 4072.7 4075.8 4076.3 3937.3 4063.6 4121.9 4124.8 4132.5 4585.4 4587.7 4588.7 4619.4 4652.0 5480.3 5490.4 5495.7 5497.2 5498.4 1436.6 1450.2 1458.5 1459.2 1460.3 996.3 1001.6 1006.8 1010.2 1021.0 4857.6 4866.1 4869.7 4869.8 4870.7 5673.9 5714.2 5719.4 5731.0 5736.1 4869.8 4869.8 4871.4 4877.6 4880.1 2827.2 2941.1 3027.3 3052.3 3082.2 5470.2 5569.6 5578.4 5584.2 5584.2 5935.7 5954.6 5959.2 5960.9 5961.0 5470.2 5501.2 5505.6 5507.5 5514.5 5561.8 5728.7 5778.5 5785.3 5791.3 5640.5 5640.5 5641.2 5641.8 5649.8 5490.6 5491.1 5495.3 5497.2 5505.5 3856.5 3913.9 3951.9 3953.4 3954.2 5758.4 5758.9 5763.8 5767.2 5775.3 5570.8 5571.4 5575.8 5576.1 5579.2 5571.6 5571.8 5572.1 5572.2 5573.0 5274.9 5435.1 5439.2 5446.7 5457.7 5613.8 5616.7 5617.3 5624.4 5624.6 5175.4 5348.9 5356.3 5357.1 5358.9 19:03:04 INFO - PROCESS | 8673 | 19:03:04 INFO - PROCESS | 8673 | [#5] yui.html Cycles:180 Average:12039.88 Median:439.19 stddev:13612.38 (3099.4%) stddev-sans-first:13623.92 19:03:04 INFO - PROCESS | 8673 | Values: 697.4 698.7 704.8 705.6 733.6 11318.5 11494.9 11519.5 11523.9 12544.9 12912.9 13024.1 13031.3 13045.8 13049.7 535.8 541.4 782.5 789.1 798.2 751.2 787.1 797.8 799.5 807.4 547.6 833.3 837.8 838.3 839.0 557.2 814.4 821.0 831.8 832.5 614.5 614.7 614.8 615.3 616.7 10886.5 11000.3 11008.9 11011.2 11015.6 10513.2 11193.8 11200.9 11207.1 11249.4 9015.4 9213.4 9258.8 9528.4 9759.4 3139.5 3247.1 3266.7 3266.9 3282.1 41033.8 41583.6 41629.4 41753.6 41950.8 8449.8 8457.5 8513.7 8676.2 8850.5 16000.4 16079.8 16191.4 16192.4 16248.0 5643.6 5814.3 5875.5 5935.3 6081.1 3253.4 3370.4 3454.8 3492.8 3496.4 2575.2 2623.1 2625.8 2629.7 2630.1 469.1 471.1 474.2 475.4 479.1 417.1 427.4 438.1 454.5 497.6 6999.4 7167.4 7295.9 7325.0 7442.6 407.0 429.5 440.3 488.3 526.3 3456.3 3490.8 3535.5 3538.0 3562.6 44654.6 44765.8 44786.3 44849.3 45167.8 43507.3 43560.6 43638.8 44156.0 44308.3 36642.0 37626.2 37944.6 38028.0 38902.0 7456.4 7563.5 7567.4 7622.8 7735.5 30457.5 30671.1 32454.7 33593.0 33982.7 40593.2 40932.0 41889.0 45472.5 45523.8 9617.8 10054.3 10395.3 10519.8 10555.5 10699.8 10720.4 10894.8 12464.3 12475.9 9409.6 9535.3 9636.7 9823.8 10850.8 10407.4 10876.3 10964.4 10977.0 10987.1 10104.5 10422.4 10897.6 10898.2 10908.7 7863.5 7948.8 8041.8 8327.5 8501.7 8664.4 8724.1 9188.2 9209.4 9248.1 19:03:04 INFO - PROCESS | 8673 | -------- Summary: end -------- 19:03:04 INFO - PROCESS | 8673 | 19:03:05 INFO - TEST-INFO | 8673: exit 0 19:03:05 INFO - TEST-OK | dromaeo_css | took 1117151ms 19:03:05 INFO - TEST-START | kraken 19:03:05 INFO - operating with platform_type : linux_ 19:03:05 INFO - Initialising browser for kraken test... 19:03:05 INFO - TEST-INFO | started process 8859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppktus4/profile http://localhost:55537/getInfo.html) 19:03:09 INFO - PROCESS | 8859 | __metrics Screen width/height:1600/1200 19:03:09 INFO - PROCESS | 8859 | colorDepth:24 19:03:09 INFO - PROCESS | 8859 | Browser inner width/height: 1024/697 19:03:09 INFO - PROCESS | 8859 | __metrics 19:03:09 INFO - PROCESS | 8859 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:03:09 INFO - PROCESS | 8859 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:03:10 INFO - TEST-INFO | 8859: exit 0 19:03:10 INFO - Browser initialized. 19:03:10 INFO - Running cycle 1/1 for kraken test... 19:03:10 INFO - TEST-INFO | started process 8941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppktus4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:22 INFO - PROCESS | 8941 | RSS: Main: 150188032 19:03:22 INFO - PROCESS | 8941 | 19:03:25 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-beat-detection) 19:03:26 INFO - PROCESS | 8941 | RSS: Main: 186646528 19:03:26 INFO - PROCESS | 8941 | 19:03:28 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-dft) 19:03:29 INFO - PROCESS | 8941 | RSS: Main: 176451584 19:03:29 INFO - PROCESS | 8941 | 19:03:32 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-fft) 19:03:32 INFO - PROCESS | 8941 | RSS: Main: 160620544 19:03:32 INFO - PROCESS | 8941 | 19:03:35 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-oscillator) 19:03:35 INFO - PROCESS | 8941 | RSS: Main: 163971072 19:03:35 INFO - PROCESS | 8941 | 19:03:37 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:03:38 INFO - PROCESS | 8941 | RSS: Main: 163807232 19:03:38 INFO - PROCESS | 8941 | 19:03:41 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-darkroom) 19:03:42 INFO - PROCESS | 8941 | RSS: Main: 164352000 19:03:42 INFO - PROCESS | 8941 | 19:03:45 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-desaturate) 19:03:46 INFO - PROCESS | 8941 | RSS: Main: 167387136 19:03:46 INFO - PROCESS | 8941 | 19:03:48 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55537/tests/kraken/driver.html?testName=json-parse-financial) 19:03:49 INFO - PROCESS | 8941 | RSS: Main: 164519936 19:03:49 INFO - PROCESS | 8941 | 19:03:51 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55537/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:03:51 INFO - PROCESS | 8941 | RSS: Main: 174800896 19:03:51 INFO - PROCESS | 8941 | 19:03:53 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:03:54 INFO - PROCESS | 8941 | RSS: Main: 174317568 19:03:54 INFO - PROCESS | 8941 | 19:03:56 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:03:57 INFO - PROCESS | 8941 | RSS: Main: 187736064 19:03:57 INFO - PROCESS | 8941 | 19:03:59 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:00 INFO - PROCESS | 8941 | RSS: Main: 189083648 19:04:00 INFO - PROCESS | 8941 | 19:04:02 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:03 INFO - PROCESS | 8941 | RSS: Main: 187744256 19:04:03 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55537/tests/kraken/driver.html?testName=ai-astar) 19:04:05 INFO - PROCESS | 8941 | RSS: Main: 244367360 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | __start_tp_report 19:04:05 INFO - PROCESS | 8941 | _x_x_mozilla_page_load 19:04:05 INFO - PROCESS | 8941 | _x_x_mozilla_page_load_details 19:04:05 INFO - PROCESS | 8941 | |i|pagename|runs| 19:04:05 INFO - PROCESS | 8941 | |0;ai-astar;113;115;108;113;115;114;105;113;112;104 19:04:05 INFO - PROCESS | 8941 | |1;audio-beat-detection;157;140;151;170;133;155;163;136;178;133 19:04:05 INFO - PROCESS | 8941 | |2;audio-dft;161;160;160;161;159;161;164;161;161;162 19:04:05 INFO - PROCESS | 8941 | |3;audio-fft;74;72;81;99;74;74;73;92;94;75 19:04:05 INFO - PROCESS | 8941 | |4;audio-oscillator;97;97;134;97;97;98;138;96;97;132 19:04:05 INFO - PROCESS | 8941 | |5;imaging-gaussian-blur;110;109;109;109;110;109;110;109;109;111 19:04:05 INFO - PROCESS | 8941 | |6;imaging-darkroom;148;146;146;147;146;147;146;146;147;147 19:04:05 INFO - PROCESS | 8941 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;96 19:04:05 INFO - PROCESS | 8941 | |8;json-parse-financial;73;73;73;74;72;73;72;86;69;70 19:04:05 INFO - PROCESS | 8941 | |9;json-stringify-tinderbox;67;67;67;67;68;73;68;68;67;67 19:04:05 INFO - PROCESS | 8941 | |10;stanford-crypto-aes;85;86;85;84;85;85;86;86;87;86 19:04:05 INFO - PROCESS | 8941 | |11;stanford-crypto-ccm;122;126;121;119;128;127;129;119;121;121 19:04:05 INFO - PROCESS | 8941 | |12;stanford-crypto-pbkdf2;139;155;152;151;146;141;151;149;149;139 19:04:05 INFO - PROCESS | 8941 | |13;stanford-crypto-sha256-iterative;72;71;74;71;72;73;71;72;70;73 19:04:05 INFO - PROCESS | 8941 | __end_tp_report 19:04:05 INFO - PROCESS | 8941 | __start_cc_report 19:04:05 INFO - PROCESS | 8941 | _x_x_mozilla_cycle_collect,981 19:04:05 INFO - PROCESS | 8941 | __end_cc_report 19:04:05 INFO - PROCESS | 8941 | __startTimestamp1451531045347__endTimestamp 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | ------- Summary: start ------- 19:04:05 INFO - PROCESS | 8941 | Number of tests: 14 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:4.05 (3.6%) stddev-sans-first:4.24 19:04:05 INFO - PROCESS | 8941 | Values: 113.0 115.0 108.0 113.0 115.0 114.0 105.0 113.0 112.0 104.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.00 stddev:15.90 (10.2%) stddev-sans-first:16.75 19:04:05 INFO - PROCESS | 8941 | Values: 157.0 140.0 151.0 170.0 133.0 155.0 163.0 136.0 178.0 133.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 19:04:05 INFO - PROCESS | 8941 | Values: 161.0 160.0 160.0 161.0 159.0 161.0 164.0 161.0 161.0 162.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#3] audio-fft Cycles:10 Average:80.80 Median:78.00 stddev:10.23 (13.1%) stddev-sans-first:10.55 19:04:05 INFO - PROCESS | 8941 | Values: 74.0 72.0 81.0 99.0 74.0 74.0 73.0 92.0 94.0 75.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:97.00 stddev:18.26 (18.8%) stddev-sans-first:18.90 19:04:05 INFO - PROCESS | 8941 | Values: 97.0 97.0 134.0 97.0 97.0 98.0 138.0 96.0 97.0 132.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:04:05 INFO - PROCESS | 8941 | Values: 110.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 111.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 19:04:05 INFO - PROCESS | 8941 | Values: 148.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:04:05 INFO - PROCESS | 8941 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#8] json-parse-financial Cycles:10 Average:73.50 Median:73.00 stddev:4.65 (6.4%) stddev-sans-first:4.93 19:04:05 INFO - PROCESS | 8941 | Values: 73.0 73.0 73.0 74.0 72.0 73.0 72.0 86.0 69.0 70.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:1.85 (2.7%) stddev-sans-first:1.94 19:04:05 INFO - PROCESS | 8941 | Values: 67.0 67.0 67.0 67.0 68.0 73.0 68.0 68.0 67.0 67.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 19:04:05 INFO - PROCESS | 8941 | Values: 85.0 86.0 85.0 84.0 85.0 85.0 86.0 86.0 87.0 86.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:124.00 stddev:3.80 (3.1%) stddev-sans-first:4.00 19:04:05 INFO - PROCESS | 8941 | Values: 122.0 126.0 121.0 119.0 128.0 127.0 129.0 119.0 121.0 121.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:150.00 stddev:5.71 (3.8%) stddev-sans-first:5.23 19:04:05 INFO - PROCESS | 8941 | Values: 139.0 155.0 152.0 151.0 146.0 141.0 151.0 149.0 149.0 139.0 19:04:05 INFO - PROCESS | 8941 | 19:04:05 INFO - PROCESS | 8941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 19:04:05 INFO - PROCESS | 8941 | Values: 72.0 71.0 74.0 71.0 72.0 73.0 71.0 72.0 70.0 73.0 19:04:05 INFO - PROCESS | 8941 | -------- Summary: end -------- 19:04:05 INFO - PROCESS | 8941 | 19:04:06 INFO - TEST-INFO | 8941: exit 0 19:04:06 INFO - TEST-OK | kraken | took 60882ms 19:04:06 INFO - TEST-START | v8_7 19:04:06 INFO - operating with platform_type : linux_ 19:04:06 INFO - Initialising browser for v8_7 test... 19:04:06 INFO - TEST-INFO | started process 9189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBmPF5v/profile http://localhost:55537/getInfo.html) 19:04:10 INFO - PROCESS | 9189 | __metrics Screen width/height:1600/1200 19:04:10 INFO - PROCESS | 9189 | colorDepth:24 19:04:10 INFO - PROCESS | 9189 | Browser inner width/height: 1024/697 19:04:10 INFO - PROCESS | 9189 | __metrics 19:04:10 INFO - PROCESS | 9189 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:04:10 INFO - PROCESS | 9189 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:11 INFO - TEST-INFO | 9189: exit 0 19:04:11 INFO - Browser initialized. 19:04:11 INFO - Running cycle 1/1 for v8_7 test... 19:04:11 INFO - TEST-INFO | started process 9272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBmPF5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:23 INFO - PROCESS | 9272 | RSS: Main: 149090304 19:04:23 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | Cycle 1(1): loaded http://localhost:55537/tests/v8_7/run.html (next: http://localhost:55537/tests/v8_7/run.html) 19:04:45 INFO - PROCESS | 9272 | RSS: Main: 447586304 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | __start_tp_report 19:04:45 INFO - PROCESS | 9272 | _x_x_mozilla_page_load 19:04:45 INFO - PROCESS | 9272 | _x_x_mozilla_page_load_details 19:04:45 INFO - PROCESS | 9272 | |i|pagename|runs| 19:04:45 INFO - PROCESS | 9272 | |0;Richards;167.47613465081227 19:04:45 INFO - PROCESS | 9272 | |1;DeltaBlue;188.25301204819277 19:04:45 INFO - PROCESS | 9272 | |2;Encrypt;279.56388034665923 19:04:45 INFO - PROCESS | 9272 | |3;Decrypt;5208.333333333333 19:04:45 INFO - PROCESS | 9272 | |4;RayTrace;2016.1290322580646 19:04:45 INFO - PROCESS | 9272 | |5;Earley;804.5052292839904 19:04:45 INFO - PROCESS | 9272 | |6;Boyer;12365.853658536585 19:04:45 INFO - PROCESS | 9272 | |7;RegExp;26947.36842105263 19:04:45 INFO - PROCESS | 9272 | |8;Splay;598.3412322274881 19:04:45 INFO - PROCESS | 9272 | |9;NavierStokes;4840.579710144928 19:04:45 INFO - PROCESS | 9272 | __end_tp_report 19:04:45 INFO - PROCESS | 9272 | __startTimestamp1451531085434__endTimestamp 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | ------- Summary: start ------- 19:04:45 INFO - PROCESS | 9272 | Number of tests: 10 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 167.5 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 188.3 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 279.6 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 5208.3 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#4] RayTrace Cycles:1 Average:2016.13 Median:2016.13 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 2016.1 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#5] Earley Cycles:1 Average:804.51 Median:804.51 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 804.5 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 12365.9 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 26947.4 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#8] Splay Cycles:1 Average:598.34 Median:598.34 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 598.3 19:04:45 INFO - PROCESS | 9272 | 19:04:45 INFO - PROCESS | 9272 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 19:04:45 INFO - PROCESS | 9272 | Values: 4840.6 19:04:45 INFO - PROCESS | 9272 | -------- Summary: end -------- 19:04:45 INFO - PROCESS | 9272 | 19:04:46 INFO - TEST-INFO | 9272: exit 0 19:04:46 INFO - TEST-OK | v8_7 | took 40134ms 19:04:46 INFO - SUITE-END | took 1218s 19:04:46 INFO - Completed test suite (00:20:18) 19:04:46 INFO - Working with test: dromaeo_css 19:04:46 INFO - Generating results file: dromaeo_css 19:04:46 INFO - Working with test: kraken 19:04:46 INFO - Generating results file: kraken 19:04:46 INFO - javascript benchmark 19:04:46 INFO - Working with test: v8_7 19:04:46 INFO - Generating results file: v8_7 19:04:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 19:04:46 INFO - process_Request line: dromaeo_css 6102.53 graph.html#tests=[[72,94,35]] 19:04:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:46 INFO - process_Request line: kraken 1533.50 graph.html#tests=[[232,94,35]] 19:04:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:46 INFO - process_Request line: v8_7 19669.24 graph.html#tests=[[230,94,35]] 19:04:46 INFO - RETURN: dromaeo_css: 6102.53 19:04:46 INFO - RETURN: kraken: 1533.50 19:04:46 INFO - RETURN: v8_7: 19669.24 19:04:46 INFO - javascript benchmark 19:04:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2600.1029644772552, 2684.9328766780814, 2695.770859476944, 2699.4196247806717, 2704.743049410306, 4365.58526939941, 4475.9481521842345, 4517.616002639776, 4576.199165146103, 4581.518940511244, 4537.500874903766, 4548.636109111271, 4602.516735742749, 4605.884852878679, 4658.184817656914, 4202.054537729002, 4228.978855105728, 4250.872473825775, 4337.175936572057, 4358.629516491102, 4052.3921411788174, 4303.415109150347, 4312.094460163369, 4365.607095361417, 4391.099824535962, 4118.6499147572495, 4173.4157217989505, 4263.381809637585, 4265.786710664454, 4279.251131052085, 4208.726432781859, 4223.598758117974, 4226.598473145046, 4245.448091748084, 4270.636995855356, 4214.2414365414215, 4217.746935183868, 4233.597808208216, 4235.767032813194, 4278.914421711548, 4322.978385108086, 4445.088756804847, 4455.6658250631335, 4484.5291244419195, 4573.954260457386, 4890.339804126433, 4905.877353066202, 4911.140550403701, 4912.70523768575, 4955.033768415161, 4920.458749537584, 4927.113119638464, 4939.283803848458, 4939.629527785431, 4944.307796908436, 4393.472783265996, 4446.599806017474, 4500.594946454835, 4501.617362524222, 4574.222382195035, 4913.0, 4923.556879880828, 4927.063857866994, 4927.827526036572, 4931.679440836334, 4718.598919091847, 4732.976335118371, 4735.289706544046, 4738.573528382462, 4800.903981920342, 4686.297055441642, 4798.4001999750035, 4799.952000480021, 4815.374001379798, 4946.653734238641, 4799.832005879777, 4824.831130910471, 4825.30033145192, 4827.0, 4869.026194761062, 4797.808087676523, 4798.568128868418, 4801.5438533339275, 4807.711537307773, 4851.078295123915, 3899.980500097538, 3984.820683069269, 3989.780562069056, 3991.3613821788376, 4023.5775243599587, 3631.5823680276576, 3637.381645120336, 3652.4703917932284, 3685.244524872395, 3694.5012423322505, 4283.378910058086, 4302.419173411612, 4304.956950430455, 4308.138372325548, 4342.283523218697, 4674.836380726726, 4791.257355109894, 4928.67963582366, 4955.851324460272, 5025.673331233458, 4150.107726838744, 4152.086540961044, 4228.217779710763, 4248.915021699549, 4257.02088519636, 4322.956770432255, 4324.783760811947, 4330.848420305274, 4371.213181627274, 4375.649948004152, 4488.5287044859815, 4655.231886738786, 4656.534346565317, 4665.440147182292, 4701.130290896195, 4755.667103302736, 4759.881002974953, 4834.347363105936, 4947.455779864284, 4961.627877909099, 4690.835820746394, 4703.576678098988, 4710.8351207707565, 4714.292856071616, 4745.33565300865, 4861.270809378621, 4862.367892173995, 4863.4650188479945, 4866.245731911559, 4911.901761964812, 4613.515580863961, 4736.478987311324, 4748.145333839942, 4750.14497390473, 4825.879353016203, 4769.403824521934, 4772.952270477251, 4778.808847646194, 4800.591949684316, 4820.8794780130775, 4767.404074490689, 4768.976155119202, 4769.093872164278, 4769.4753577107185, 4803.063402636452, 4414.3157810539415, 4479.46246450415, 4533.954660453353, 4675.3220782986955, 4715.198416269174, 4717.551832575899, 4820.4456487502985, 4823.0353929215, 4828.275758636232, 4831.057943701085, 4624.052069325848, 4631.8378856739855, 4662.2307319293295, 4664.0, 4712.505186955457], "unit": "score", "name": "dojo.html", "value": 4479.766553608049}, {"lowerIsBetter": false, "replicates": [487.07698910564505, 509.1980131293214, 517.4876871896821, 523.5209783048509, 534.3134072716557, 22503.774962250372, 22894.54210915783, 32856.34287314255, 32923.67076329236, 33133.66866331336, 35639.0, 36020.09949751257, 36073.63926360736, 36074.45888311677, 36086.458703119475, 6475.0, 7574.2047085055965, 7727.343175830061, 7735.961320193391, 7775.066991960973, 6846.315368463163, 6927.896081558755, 6946.47901407394, 6947.374736273734, 9881.665975093378, 9615.0, 9709.90290097097, 9726.027397260288, 9728.951355243214, 9730.756731081708, 9646.469444180568, 9848.310618256724, 9857.211423086135, 9863.605455781795, 9875.753106172331, 6911.412529934962, 7081.681324340366, 9791.559379827924, 9984.55069521866, 10039.799204015879, 36394.27211455756, 37022.44466333007, 37043.0, 37050.814745926094, 37078.8146059268, 2674.277944954851, 2742.80800343976, 2749.8900043998415, 2794.203651959202, 3086.1975886269506, 28328.858355708297, 28374.0, 28455.430891382264, 28464.573031404547, 29044.564331535043, 3465.1163953192026, 3485.686288234071, 3503.544539209912, 3521.2605352875926, 3620.746547741659, 222133.0, 222756.0, 223650.0, 223653.0, 224865.0, 37874.62125378766, 54072.45927540753, 54393.45606543884, 54448.36654900359, 54541.45458545364, 36393.45409818855, 57047.71476142593, 58226.708866455396, 58317.12524312139, 58350.0, 12466.189697669623, 12587.87412125867, 12699.682507937376, 12715.491380344683, 12715.55495557651, 9487.478188699688, 9516.095970882756, 9533.570989305497, 9562.61749530025, 9569.138777510057, 18121.818781812275, 18230.179641916147, 18272.177752001193, 18334.633307333777, 19110.904445477685, 7391.186969433358, 7639.809004774814, 7673.117591477052, 7682.270184332479, 7793.2596403341595, 832.6877420967137, 902.1069141549949, 905.1310741688053, 918.7840857398506, 972.0910948263396, 25585.0, 26592.33519161998, 26887.327816804343, 27010.5948410774, 27021.189364319103, 912.8128733609594, 974.1962880623372, 1028.3521381529738, 1048.5425258890148, 1096.0738176241064, 12717.427715752814, 12744.490220391266, 12820.80768788469, 12839.358032098358, 12871.549495767604, 273575.0, 277829.0, 278332.0, 278400.0, 278703.0, 45275.09449811051, 45479.545204548194, 45585.63243102712, 45598.772006139756, 45634.771826140655, 1177.756374107327, 1190.4285942747356, 1219.603628820637, 1220.5911019808286, 1221.4808706299787, 21655.0, 25061.373465663506, 25290.494190115725, 25956.35109122287, 28957.0, 40156.19687606173, 40412.393814092226, 40632.0, 40698.59301406948, 40698.79650601728, 199327.0, 199850.0, 201257.0, 201423.0, 201526.0, 22316.330510084725, 22380.104795807987, 22687.432814179778, 23180.304590862303, 23348.533029338978, 24942.12702555402, 24993.375165621004, 25151.87424062868, 30937.381252375275, 33267.833660831544, 27526.0, 28365.71634283713, 28980.420391592474, 31969.360612788078, 32804.34391312208, 29027.85486072556, 29567.55648665315, 30293.69706302909, 32217.35565288728, 32237.838810805795, 31713.0, 32312.0, 32522.186945326557, 32639.87840790341, 32669.0, 27391.467346479876, 28803.27991800222, 28985.56521652219, 28988.565171522867, 29138.417231655672, 22764.544709106056, 22804.657930131394, 22921.696533453432, 22962.540749184587, 23056.654150188097], "unit": "score", "name": "ext.html", "value": 16174.260426659865}, {"lowerIsBetter": false, "replicates": [333.9699427051565, 334.8442974017082, 335.56711841724194, 337.77031618499416, 338.8424382662065, 11689.0, 12191.390430478485, 15034.849651503482, 15401.0, 15718.764218536731, 9474.384165029269, 9492.050794920504, 9630.951845240765, 9764.365316254438, 9826.459544725038, 4529.569690879362, 4668.906621867561, 4673.22891722867, 4676.462206846222, 4678.111158879819, 3021.1993821637284, 3128.71841534263, 3684.410494320909, 4601.447826260854, 5203.375594928614, 5143.717095559743, 5178.896422071556, 5200.167973124301, 5205.349331333583, 5208.322918020652, 5084.949150508484, 5150.845474635767, 5767.019606666856, 5793.913091303634, 5793.913091303634, 5132.358455193101, 5137.075326441239, 5138.434772175057, 5144.0, 5144.176931690949, 12016.579419720269, 16417.67164656712, 18234.541236701163, 18529.62940741191, 18558.164882580182, 1792.3905872003581, 1806.801251862294, 1807.4306593423162, 1827.6424705507752, 1842.134196927442, 8916.509591972439, 9119.81760364789, 10102.989701029912, 12062.69843253917, 12323.568675096418, 1643.0716645095483, 1742.712452445345, 1752.255291501107, 1791.811859754733, 1795.7485951966735, 55315.446845531435, 55827.441725582634, 56424.15363769505, 56429.71785141089, 57069.71465142689, 9341.532923353805, 9505.477198753997, 9588.808223835484, 9632.27757918159, 9669.9033009669, 12241.081918855944, 12251.632451026484, 12288.201266917622, 12326.81509777354, 12345.259284442962, 6520.119783829217, 6569.441597464269, 6580.374864387875, 6650.401463868178, 6684.331566843277, 6210.099535567318, 6215.844603884939, 6243.750249989949, 6273.811785646438, 6275.8075965566395, 3992.540857801332, 4012.29784787661, 4041.9797901010306, 4048.838046478108, 4094.3653733671326, 1519.8860085493632, 1600.199900049975, 1636.9099699516642, 1649.2083799776174, 1680.2186983052939, 570.7317560746443, 839.9496030238205, 847.8770578266117, 871.2681347667989, 967.9159341537523, 15590.610234744223, 15896.284667190004, 16563.254653540618, 16698.332066717438, 17303.74044389335, 710.8755967705631, 835.7268230413266, 854.3250831842774, 861.9482831030158, 874.7987962768599, 7972.641231144612, 8470.364722645703, 8544.829103417896, 8634.222919937236, 8998.920129584361, 312743.0, 318620.0, 319683.0, 321516.0, 494997.0, 70872.64563677149, 76652.61673691595, 77182.0, 77284.0, 77788.0, 1029.5881647341123, 1031.4120951057826, 1035.6323505155713, 1037.3361048928691, 1039.2569312941284, 13966.301684915918, 14392.784108238175, 14439.639009024439, 14461.13233206011, 14872.182029988455, 32298.639683642406, 32643.18392040218, 32913.83543082269, 33932.151696207795, 33969.830150849084, 42341.0, 42414.78792606017, 42655.36016959686, 42794.78602606967, 46584.301235480816, 8233.629486673233, 8557.957210214157, 8561.058283588676, 8630.136986301319, 8662.090480499457, 10099.293049486465, 10112.342697724624, 10156.18750499973, 10210.795784084128, 10243.0, 9607.663731769355, 12973.54592589255, 13195.0, 13274.336283185996, 13378.264195469343, 12888.871111288767, 13020.47918083266, 13227.66930826737, 13778.448862045407, 13884.236366999912, 10262.538185781508, 10554.261201715806, 13430.19418834873, 13621.35975340382, 14003.789943151065, 7370.520916140434, 8618.65525379003, 8877.49082655963, 8967.192952634294, 8987.056359082202, 12072.33602151855, 13410.0, 13447.193168409927, 13535.390907408993, 14045.859541404456], "unit": "score", "name": "jquery.html", "value": 7807.809339298489}, {"lowerIsBetter": false, "replicates": [1090.7327704712347, 1329.0231679715407, 1336.1381908668907, 1425.4796999095333, 1709.5384246253511, 5715.685637289947, 6456.548041637087, 6563.1796025496815, 6574.8685026299445, 6587.901181482275, 6545.541812073145, 6699.229588597313, 6704.731810727565, 6714.395704386604, 6716.697748601312, 1619.8137214220399, 1657.370199324255, 2018.677011678128, 2024.1093918675808, 2055.835533157344, 2085.2493102483095, 2092.748870135586, 2095.465656257652, 2095.706601075851, 2095.779943105975, 2007.7791442941266, 2011.406635042666, 2051.5589148333106, 2053.5790163016545, 2055.14711394771, 2008.4577164165594, 2026.0275067967311, 2036.9592608147755, 2055.6710926251803, 2056.0, 2073.9274125405536, 2115.2913773885766, 2118.5868755592664, 2119.862208956413, 2123.98938005309, 6921.48088893335, 7034.507584469089, 7041.612711300876, 7045.506814522985, 7052.541584796972, 3977.423273625308, 4021.0, 4022.7988600569856, 4028.3554631258858, 4043.5349934757587, 2557.7698007179442, 2653.3764565327133, 2668.3062403774966, 2673.8128331016837, 2693.3266683329166, 783.1033466680676, 787.3976408047848, 810.4691427115249, 814.1614137438448, 815.759350991459, 9187.586558604879, 9189.862152067724, 9197.264218862409, 9201.079892010812, 9229.0, 3751.4935483709896, 3825.3879379299733, 3891.552471465761, 3899.999999999943, 3906.843726250975, 8005.039395272604, 8013.038435387791, 8015.358771298283, 8022.4785388950695, 8044.879326809985, 3955.050787810962, 3960.980195099006, 3967.285888540033, 3968.722189446769, 3970.0471886746973, 3533.452314891196, 3555.182308069107, 3557.0395993081725, 3568.2149927016017, 3573.0888623400865, 2734.917952461429, 2783.707710690389, 3306.1073510152605, 3311.5529403530695, 3385.3906296866307, 1057.8677665291839, 1070.5343175718588, 1078.665613659768, 1080.0225795654944, 1083.4745148602922, 856.3919617071824, 880.9075047120089, 885.2342723544087, 1085.2837127495816, 1196.2702751321688, 6394.1687580614225, 6432.0, 6459.0, 6468.288488266287, 6474.223093228843, 1045.895410458948, 1113.4989254835357, 1123.4438952718456, 1124.3872089711126, 1148.465963327057, 5128.871778205575, 5184.248283998874, 5205.869853253624, 5207.6875387476875, 5216.0, 7920.683172673029, 8056.8388632227025, 8236.546989915492, 8318.417710760188, 8334.12491688364, 8345.707900223462, 8427.452215606088, 8459.746207613782, 8485.660573577112, 8513.0, 6251.843703907439, 6450.0647406125845, 6492.448141907897, 6532.6733663316645, 6574.7507973485845, 6552.967235163794, 6621.867562648817, 6622.735090596515, 6624.470042396693, 6626.801195964129, 7346.96326518364, 7529.73645922412, 7623.9326494289735, 7626.970359001464, 7629.694812207449, 7558.1686014539455, 7746.0317460317465, 7832.373410127062, 7840.176781437867, 7847.607619619111, 6193.566450348432, 6235.812925612239, 6257.4994000480765, 6274.058891166362, 6276.968615156895, 6580.440662543738, 6709.127813384229, 6716.899246511404, 6725.159355080615, 6732.057511948233, 6256.186695729526, 6289.433950944437, 6354.1104245406605, 6414.871702566016, 6482.902756458562, 6255.093011513214, 6264.59280146789, 6270.310265870842, 6280.874382512233, 6432.614043157426, 6125.601835880653, 6234.376562343729, 6248.656323902229, 6249.843753906189, 6265.0, 5732.3121225453215, 5757.568182386254, 5765.91351129725, 5772.5959182856795, 5783.971080144741, 5775.6823374714795, 5820.941790582209, 5833.0375488044, 5839.15332276809, 5861.706914654165], "unit": "score", "name": "mootools.html", "value": 3969.2310160905354}, {"lowerIsBetter": false, "replicates": [299.1190942673826, 303.14059640918, 310.39937720510807, 312.29265713159697, 312.7826160818232, 5223.294855194547, 5298.4436634153435, 5356.999999999995, 5359.1425371940495, 5408.35099788025, 5173.723561632888, 5242.449542798008, 5273.947260527393, 5276.445973172809, 5299.443558426367, 3893.8637147699837, 3980.0, 4134.4831896013, 4156.376543518481, 4156.729812562181, 4039.1719697462095, 4062.106336605942, 4113.506379234496, 4116.814743336557, 4117.4441450404265, 4060.4112403701447, 4064.0855807443236, 4064.2074795414906, 4069.511658600972, 4071.9185616287655, 3856.267309211255, 3936.566977632458, 3993.301172294866, 4064.532578753422, 4068.9796551017203, 3584.910377240564, 3596.5863925648623, 3600.459931010343, 3603.6756691897594, 3617.1318883468043, 5018.5985121190215, 5075.314832497603, 5075.847724568269, 5076.6192535559985, 5077.086124497589, 4715.504871988461, 4718.8584342469785, 4720.221163508017, 4722.952770472286, 4724.669273150881, 5323.840284791462, 5510.91733623996, 5515.365732940683, 5519.586031047687, 5521.1442226454965, 3924.646781789624, 3928.0572662561067, 3931.154801717616, 3935.4293627423863, 3936.6653834423823, 5736.3403208631125, 5794.62334948227, 5812.128180772876, 5814.3313518945015, 5820.767169313222, 4067.28822456069, 4072.6131017553284, 4072.6538244249573, 4075.7962101894786, 4076.286649836267, 3937.2716047530726, 4063.6139566741704, 4121.855735049259, 4124.752514849119, 4132.524759652679, 4585.449746030431, 4587.7017993830295, 4588.747618880927, 4619.422572178478, 4652.0, 5480.260164877691, 5490.368607610096, 5495.697736624444, 5497.175423686479, 5498.367687715884, 1436.6049336432566, 1450.166154461189, 1458.540559723705, 1459.2339022013316, 1460.2990564529086, 996.2627655534852, 1001.5593139018808, 1006.7684432580547, 1010.1968934696934, 1021.0351218098974, 4857.611391088704, 4866.075445665312, 4869.659123861366, 4869.756512174377, 4870.732109733928, 5673.914891276634, 5714.171445140431, 5719.370869204384, 5731.0, 5736.13957906309, 4869.756512174377, 4869.780859861315, 4871.415430148334, 4877.609791216694, 4880.097182021337, 2827.180117765825, 2941.058861164407, 3027.3188532579993, 3052.3132295233395, 3082.1832214463184, 5470.152126420411, 5569.610127291051, 5578.41426650204, 5584.162375643686, 5584.246126772915, 5935.73289201987, 5954.612950158225, 5959.225300710967, 5960.85097872548, 5961.046232602763, 5470.206820011076, 5501.174823776466, 5505.614606977473, 5507.531859791882, 5514.503694667579, 5561.805336813192, 5728.684922329146, 5778.537716982715, 5785.334686510937, 5791.333996590446, 5640.520555752807, 5640.520555752807, 5641.210230567806, 5641.802536911188, 5649.830505084854, 5490.6431081979545, 5491.093969494988, 5495.2856128703015, 5497.202905578749, 5505.476979686923, 3856.4600955866763, 3913.92172156561, 3951.881443556698, 3953.4069889516804, 3954.2486927483687, 5758.395368486249, 5758.942410576008, 5763.7982670606325, 5767.163761254678, 5775.306963164279, 5570.832875013756, 5571.359293681278, 5575.804846830341, 5576.1356989666665, 5579.163125531203, 5571.582131340085, 5571.777128914798, 5572.080606699849, 5572.247746554325, 5573.0, 5274.920876186783, 5435.130379139318, 5439.156930675752, 5446.700431476307, 5457.672539647634, 5613.810613860516, 5616.69108199053, 5617.269754931833, 5624.437556244343, 5624.606277560531, 5175.353080864892, 5348.930213957146, 5356.250124982584, 5357.142857142839, 5358.946410535845], "unit": "score", "name": "prototype.html", "value": 4179.105843757274}, {"lowerIsBetter": false, "replicates": [697.4315932515003, 698.7205117952818, 704.8414106825961, 705.6330708031827, 733.6368497593692, 11318.490667919943, 11494.885051149507, 11519.539218431262, 11523.942380288086, 12544.874551254485, 12912.935435322834, 13024.088313818036, 13031.348432578357, 13045.80431293529, 13049.73900521989, 535.8472835241956, 541.41256736441, 782.503110524818, 789.1083076124, 798.1818635898222, 751.1962200445525, 787.1184273613561, 797.8364435290752, 799.5482552357928, 807.3863863463752, 547.6385585513561, 833.3166803221361, 837.7570504553672, 838.279079991207, 839.0267289943666, 557.2310211907562, 814.3729328417115, 821.0229826506438, 831.8377916306323, 832.5254604875223, 614.4592758372648, 614.6527212125135, 614.7540983606549, 615.2893408113591, 616.7132283488199, 10886.455677216107, 11000.284981476178, 11008.889911100867, 11011.174161937886, 11015.559377624886, 10513.211509136845, 11193.776124477547, 11200.943995280053, 11207.08066574941, 11249.381284029376, 9015.36892417531, 9213.355065145442, 9258.814823703555, 9528.428294302365, 9759.365641233368, 3139.5290706393994, 3247.1232767152737, 3266.738660907122, 3266.852991615383, 3282.097423208613, 41033.79483102595, 41583.584164158274, 41629.375559366636, 41753.582464175575, 41950.79024604888, 8449.788755281168, 8457.492550446992, 8513.702020429255, 8676.219140277406, 8850.468971861581, 16000.439984600484, 16079.839201608069, 16191.433299834449, 16192.352305907867, 16248.0, 5643.633163844337, 5814.331351894586, 5875.471207591338, 5935.258092738408, 6081.118237855486, 3253.4143854106487, 3370.410178218802, 3454.844531996016, 3492.7729697569575, 3496.3881320768764, 2575.2016874768883, 2623.0556999480173, 2625.763681268695, 2629.7107318194985, 2630.118910165116, 469.0993292877683, 471.067286772193, 474.24594894117826, 475.36301356182884, 479.101684341859, 417.09906601740704, 427.3568279738973, 438.0778461338899, 454.51140024473824, 497.55717411503065, 6999.405050570758, 7167.4266058715175, 7295.927040729631, 7325.0, 7442.590657513889, 406.9776162311101, 429.5382463851372, 440.3109134204959, 488.33098654843093, 526.3420724094882, 3456.3087382523595, 3490.8254587271044, 3535.5227044348685, 3537.964620353815, 3562.5546806649168, 44654.553454465036, 44765.776171119585, 44786.32820507695, 44849.32726009112, 45167.77416112898, 43507.34738978918, 43560.56439435628, 43638.78180609077, 44156.0, 44308.3353749694, 36642.0, 37626.247475050346, 37944.62055379466, 38027.957763378865, 38902.0, 7456.440766942393, 7563.470557060953, 7567.432442566939, 7622.771316860281, 7735.497192682457, 30457.54313685341, 30671.079867604007, 32454.675453245167, 33593.0, 33982.66017339795, 40593.1881362377, 40932.0, 41889.0, 45472.54527454683, 45523.77238113788, 9617.807643847224, 10054.29619926598, 10395.32430392022, 10519.789604208027, 10555.52500137511, 10699.786004280026, 10720.35677859331, 10894.782104358026, 12464.252144871336, 12475.875241247471, 9409.623615055321, 9535.284853635867, 9636.71089867305, 9823.803523929624, 10850.78298434011, 10407.427591482541, 10876.347419154876, 10964.396958167377, 10977.0, 10987.066099381642, 10104.494775261355, 10422.374657520573, 10897.56409743633, 10898.18263630215, 10908.672739817817, 7863.52818830872, 7948.84102317962, 8041.758747237593, 8327.541985190872, 8501.702440414556, 8664.436811607226, 8724.072160852074, 9188.173064424234, 9209.447433154031, 9248.075192480697], "unit": "score", "name": "yui.html", "value": 5503.204896071761}], "name": "dromaeo_css", "value": 6102.52898384018}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 108.0, 113.0, 115.0, 114.0, 105.0, 113.0, 112.0, 104.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [157.0, 140.0, 151.0, 170.0, 133.0, 155.0, 163.0, 136.0, 178.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 159.0, 161.0, 164.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 81.0, 99.0, 74.0, 74.0, 73.0, 92.0, 94.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 134.0, 97.0, 97.0, 98.0, 138.0, 96.0, 97.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 74.0, 72.0, 73.0, 72.0, 86.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 73.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 84.0, 85.0, 85.0, 86.0, 86.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 121.0, 119.0, 128.0, 127.0, 129.0, 119.0, 121.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [139.0, 155.0, 152.0, 151.0, 146.0, 141.0, 151.0, 149.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 74.0, 71.0, 72.0, 73.0, 71.0, 72.0, 70.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1533.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [2016.1290322580646], "unit": "score", "name": "RayTrace", "value": 367.03454399999987}, {"lowerIsBetter": false, "replicates": [804.5052292839904], "unit": "score", "name": "Earley", "value": 828.4135089999997}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [26947.36842105263], "unit": "score", "name": "RegExp", "value": 33.80608398437501}, {"lowerIsBetter": false, "replicates": [598.3412322274881], "unit": "score", "name": "Splay", "value": 136.19485940594063}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19669.241135270357}]} 19:04:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19669.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1533.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6102.53"}}} 19:04:46 INFO - Return code: 0 19:04:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:04:46 INFO - # TBPL SUCCESS # 19:04:46 INFO - Running post-action listener: _resource_record_post_action 19:04:46 INFO - Running post-run listener: _resource_record_post_run 19:04:47 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 589824; Write bytes: 547500032; Read time: 184; Write time: 468828 19:04:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 212398080; Read time: 0; Write time: 239860 19:04:47 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 589824; Write bytes: 312832000; Read time: 184; Write time: 213056 19:04:47 INFO - Running post-run listener: _upload_blobber_files 19:04:47 INFO - Blob upload gear active. 19:04:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:04:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:04:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:04:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:04:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:04:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:49 INFO - (blobuploader) - INFO - Done attempting. 19:04:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:04:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:04:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:49 INFO - (blobuploader) - INFO - Done attempting. 19:04:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:04:49 INFO - Return code: 0 19:04:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:04:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:04:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33c35e5a2850de8de4b018ba33d7321320c84e0d3436e37973486f12fdf295c769b1a1c0abb50edf44e8c4671560a2d0c97de28f3f7a898041027a2ac05b934", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11b6f25bba1f8c6757f17252be755e7152b9efd7df58f2f94d534ca796305b809903526187f720cfd07d7fbdbbe8dd4f9f482d032f59af8272c44c20167f94aa"} 19:04:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:04:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:04:49 INFO - Contents: 19:04:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33c35e5a2850de8de4b018ba33d7321320c84e0d3436e37973486f12fdf295c769b1a1c0abb50edf44e8c4671560a2d0c97de28f3f7a898041027a2ac05b934", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11b6f25bba1f8c6757f17252be755e7152b9efd7df58f2f94d534ca796305b809903526187f720cfd07d7fbdbbe8dd4f9f482d032f59af8272c44c20167f94aa"} 19:04:49 INFO - Copying logs to upload dir... 19:04:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.604738 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-30 19:04:49.983623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:04:49.986789) ========= 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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 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/e33c35e5a2850de8de4b018ba33d7321320c84e0d3436e37973486f12fdf295c769b1a1c0abb50edf44e8c4671560a2d0c97de28f3f7a898041027a2ac05b934", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11b6f25bba1f8c6757f17252be755e7152b9efd7df58f2f94d534ca796305b809903526187f720cfd07d7fbdbbe8dd4f9f482d032f59af8272c44c20167f94aa"} build_url:https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/TcPzvwlPT4eAdYC5E51Jiw/artifacts/public/build/firefox-46.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/e33c35e5a2850de8de4b018ba33d7321320c84e0d3436e37973486f12fdf295c769b1a1c0abb50edf44e8c4671560a2d0c97de28f3f7a898041027a2ac05b934", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11b6f25bba1f8c6757f17252be755e7152b9efd7df58f2f94d534ca796305b809903526187f720cfd07d7fbdbbe8dd4f9f482d032f59af8272c44c20167f94aa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:04:50.012275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:04:50.012673) ========= 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=f5f5a079460e1a9be8676904000001c1-1451528805.874056-609771971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:04:50.096643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:04:50.097022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:04:50.097380) ========= ========= Total master_lag: 0.30 =========