builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1451390929.61 results: success (0) buildid: 20151229025539 builduid: 82282dec139346d0bdfe9866b843d8de revision: 7d6ddcd2bbb47871f04edd3c7e10c6e30ad98896 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.608526) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.609091) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.609397) ========= 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=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005040 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.632190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.632514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.646307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.646781) ========= 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=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.700575) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.700898) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.701274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.701559) ========= 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=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 04:08:50-- 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.5M=0s 2015-12-29 04:08:50 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.879454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.879780) ========= 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=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.929629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:49.930011) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d6ddcd2bbb47871f04edd3c7e10c6e30ad98896 --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 7d6ddcd2bbb47871f04edd3c7e10c6e30ad98896 --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=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 04:08:50,897 truncating revision to first 12 chars 2015-12-29 04:08:50,897 Setting DEBUG logging. 2015-12-29 04:08:50,897 attempt 1/10 2015-12-29 04:08:50,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d6ddcd2bbb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 04:08:51,255 unpacking tar archive at: mozilla-central-7d6ddcd2bbb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:50.585711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:50.586013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:50.595227) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:50.595502) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:50.595890) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-29 04:08:50.596176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:51 INFO - MultiFileLogger online at 20151229 04:08:51 in /builds/slave/test 04:08:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:08:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:51 INFO - {'append_to_log': False, 04:08:51 INFO - 'base_work_dir': '/builds/slave/test', 04:08:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:08:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:51 INFO - 'branch': 'Firefox-Non-PGO', 04:08:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:51 INFO - 'config_files': ('talos/linux_config.py',), 04:08:51 INFO - 'default_actions': ('clobber', 04:08:51 INFO - 'read-buildbot-config', 04:08:51 INFO - 'download-and-extract', 04:08:51 INFO - 'populate-webroot', 04:08:51 INFO - 'create-virtualenv', 04:08:51 INFO - 'install', 04:08:51 INFO - 'run-tests'), 04:08:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:51 INFO - 'download_minidump_stackwalk': True, 04:08:51 INFO - 'download_symbols': 'ondemand', 04:08:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:51 INFO - 'installer_path': 'installer.exe', 04:08:51 INFO - 'log_level': 'info', 04:08:51 INFO - 'log_name': 'talos', 04:08:51 INFO - 'log_to_console': True, 04:08:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:51 INFO - 'opt_config_files': (), 04:08:51 INFO - 'pip_index': False, 04:08:51 INFO - 'sps_profile': False, 04:08:51 INFO - 'sps_profile_interval': 0, 04:08:51 INFO - 'suite': 'dromaeojs-e10s', 04:08:51 INFO - 'system_bits': '32', 04:08:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:51 INFO - 'title': 'talos-linux64-ix-048', 04:08:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:51 INFO - 'use_talos_json': True, 04:08:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:51 INFO - 'work_dir': 'build'} 04:08:51 INFO - ##### 04:08:51 INFO - ##### Running clobber step. 04:08:51 INFO - ##### 04:08:51 INFO - Running pre-action listener: _resource_record_pre_action 04:08:51 INFO - Running main action method: clobber 04:08:51 INFO - rmtree: /builds/slave/test/build 04:08:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:52 INFO - Running post-action listener: _resource_record_post_action 04:08:52 INFO - ##### 04:08:52 INFO - ##### Running read-buildbot-config step. 04:08:52 INFO - ##### 04:08:52 INFO - Running pre-action listener: _resource_record_pre_action 04:08:52 INFO - Running main action method: read_buildbot_config 04:08:52 INFO - Using buildbot properties: 04:08:52 INFO - { 04:08:52 INFO - "project": "", 04:08:52 INFO - "product": "firefox", 04:08:52 INFO - "script_repo_revision": "production", 04:08:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:08:52 INFO - "repository": "", 04:08:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:08:52 INFO - "buildid": "20151229025539", 04:08:52 INFO - "pgo_build": "False", 04:08:52 INFO - "basedir": "/builds/slave/test", 04:08:52 INFO - "buildnumber": 154, 04:08:52 INFO - "slavename": "talos-linux64-ix-048", 04:08:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:08:52 INFO - "platform": "ubuntu64_hw", 04:08:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:08:52 INFO - "branch": "mozilla-central", 04:08:52 INFO - "repo_path": "mozilla-central", 04:08:52 INFO - "revision": "7d6ddcd2bbb47871f04edd3c7e10c6e30ad98896", 04:08:52 INFO - "stage_platform": "linux64", 04:08:52 INFO - "builduid": "82282dec139346d0bdfe9866b843d8de", 04:08:52 INFO - "slavebuilddir": "test" 04:08:52 INFO - } 04:08:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:08:52 INFO - Running post-action listener: _resource_record_post_action 04:08:52 INFO - ##### 04:08:52 INFO - ##### Running download-and-extract step. 04:08:52 INFO - ##### 04:08:52 INFO - Running pre-action listener: _resource_record_pre_action 04:08:52 INFO - Running main action method: download_and_extract 04:08:52 INFO - mkdir: /builds/slave/test/build/tests 04:08:52 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')]} 04:08:52 INFO - https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/test_packages.json 04:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/test_packages.json 04:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:08:55 INFO - Downloaded 1302 bytes. 04:08:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:08:55 INFO - Using the following test package requirements: 04:08:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:55 INFO - u'jsshell-linux-x86_64.zip'], 04:08:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08: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')]} 04:08:55 INFO - https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:08:57 INFO - Downloaded 21942092 bytes. 04:08:57 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 04:08:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:57 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 04:08:58 INFO - Return code: 0 04:08:58 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 04:08:58 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')]} 04:08:58 INFO - https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:09:00 INFO - Downloaded 21942092 bytes. 04:09:00 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 04:09:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:09:00 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 04:09:02 INFO - Return code: 0 04:09: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')]} 04:09:02 INFO - https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:09:02 INFO - Downloaded 11132270 bytes. 04:09:02 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 04:09:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:02 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 04:09:03 INFO - Return code: 0 04:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:03 INFO - https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ixTYz5umQjySXKr8Ws7S7w/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 04:09:04 INFO - Downloaded 53335327 bytes. 04:09:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:09:04 INFO - mkdir: /builds/slave/test/properties 04:09:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:04 INFO - Contents: 04:09:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:09:04 INFO - Running post-action listener: _resource_record_post_action 04:09:04 INFO - Running post-action listener: set_extra_try_arguments 04:09:04 INFO - ##### 04:09:04 INFO - ##### Running populate-webroot step. 04:09:04 INFO - ##### 04:09:04 INFO - Running pre-action listener: _resource_record_pre_action 04:09:04 INFO - Running main action method: populate_webroot 04:09:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:04 INFO - '--tppagecycles', 04:09:04 INFO - '7'], 04:09:04 INFO - 'tests': ['tsvgm']}}, 04:09:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:09:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'tests': ['damp', 'tps']}, 04:09:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['damp', 'tps']}, 04:09:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:09:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:04 INFO - 'other': {'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore']}, 04:09:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore']}, 04:09:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore']}, 04:09:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore']}, 04:09:04 INFO - 'other_l64': {'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore']}, 04:09:04 INFO - 'other_nol64': {'tests': ['a11yr', 04:09:04 INFO - 'ts_paint', 04:09:04 INFO - 'tpaint', 04:09:04 INFO - 'sessionrestore', 04:09:04 INFO - 'sessionrestore_no_auto_restore']}, 04:09:04 INFO - 'svgr': {'tests': ['tsvgx', 04:09:04 INFO - 'tsvgr_opacity', 04:09:04 INFO - 'tart', 04:09:04 INFO - 'tscrollx', 04:09:04 INFO - 'cart']}, 04:09:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['tsvgx', 04:09:04 INFO - 'tsvgr_opacity', 04:09:04 INFO - 'tart', 04:09:04 INFO - 'tscrollx', 04:09:04 INFO - 'cart']}, 04:09:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'tests': ['tp5o']}, 04:09:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--e10s'], 04:09:04 INFO - 'tests': ['tp5o']}, 04:09:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--xperf_path', 04:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:04 INFO - 'tests': ['tp5n']}, 04:09:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:04 INFO - 'talos_options': ['--e10s', 04:09:04 INFO - '--xperf_path', 04:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:04 INFO - 'tests': ['tp5n']}}, 04:09:04 INFO - 'talos.zip': {'path': '', 04:09:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:04 INFO - Running post-action listener: _resource_record_post_action 04:09:04 INFO - ##### 04:09:04 INFO - ##### Running create-virtualenv step. 04:09:04 INFO - ##### 04:09:04 INFO - Running pre-action listener: _resource_record_pre_action 04:09:04 INFO - Running main action method: create_virtualenv 04:09:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:09:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:04 INFO - Using real prefix '/usr' 04:09:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:04 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:07 INFO - Installing pip.................done. 04:09:07 INFO - Return code: 0 04:09:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:07 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 04:09:07 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 04:09:07 INFO - Using env: {'DISPLAY': ':0', 04:09:07 INFO - 'HOME': '/home/cltbld', 04:09:07 INFO - 'LANG': 'en_US.UTF-8', 04:09:07 INFO - 'LANGUAGE': 'en_US:en', 04:09:07 INFO - 'LOGNAME': 'cltbld', 04:09:07 INFO - 'MAIL': '/var/mail/cltbld', 04:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:07 INFO - 'MOZ_NO_REMOTE': '1', 04:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:07 INFO - 'NO_EM_RESTART': '1', 04:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:07 INFO - 'PWD': '/builds/slave/test', 04:09:07 INFO - 'SHELL': '/bin/bash', 04:09:07 INFO - 'SHLVL': '1', 04:09:07 INFO - 'TERM': 'linux', 04:09:07 INFO - 'TMOUT': '86400', 04:09:07 INFO - 'USER': 'cltbld', 04:09:07 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:07 INFO - '_': '/tools/buildbot/bin/python'} 04:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:09:07 INFO - Cleaning up... 04:09:07 INFO - Return code: 0 04:09:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:07 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:07 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 04:09:07 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 04:09:07 INFO - Using env: {'DISPLAY': ':0', 04:09:07 INFO - 'HOME': '/home/cltbld', 04:09:07 INFO - 'LANG': 'en_US.UTF-8', 04:09:07 INFO - 'LANGUAGE': 'en_US:en', 04:09:07 INFO - 'LOGNAME': 'cltbld', 04:09:07 INFO - 'MAIL': '/var/mail/cltbld', 04:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:07 INFO - 'MOZ_NO_REMOTE': '1', 04:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:07 INFO - 'NO_EM_RESTART': '1', 04:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:07 INFO - 'PWD': '/builds/slave/test', 04:09:07 INFO - 'SHELL': '/bin/bash', 04:09:07 INFO - 'SHLVL': '1', 04:09:07 INFO - 'TERM': 'linux', 04:09:07 INFO - 'TMOUT': '86400', 04:09:07 INFO - 'USER': 'cltbld', 04:09:07 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:07 INFO - '_': '/tools/buildbot/bin/python'} 04:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:07 INFO - Downloading/unpacking psutil>=0.7.1 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:09 INFO - Installing collected packages: psutil 04:09:09 INFO - Running setup.py install for psutil 04:09:09 INFO - building 'psutil._psutil_linux' extension 04:09:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:09:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:09:09 INFO - building 'psutil._psutil_posix' extension 04:09:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:09:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:09 INFO - Successfully installed psutil 04:09:09 INFO - Cleaning up... 04:09:09 INFO - Return code: 0 04:09:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:09:09 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')]} 04:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:09 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')]} 04:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:09 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:09 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 04:09:09 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 04:09:09 INFO - Using env: {'DISPLAY': ':0', 04:09:09 INFO - 'HOME': '/home/cltbld', 04:09:09 INFO - 'LANG': 'en_US.UTF-8', 04:09:09 INFO - 'LANGUAGE': 'en_US:en', 04:09:09 INFO - 'LOGNAME': 'cltbld', 04:09:09 INFO - 'MAIL': '/var/mail/cltbld', 04:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:09 INFO - 'MOZ_NO_REMOTE': '1', 04:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:09 INFO - 'NO_EM_RESTART': '1', 04:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:09 INFO - 'PWD': '/builds/slave/test', 04:09:09 INFO - 'SHELL': '/bin/bash', 04:09:09 INFO - 'SHLVL': '1', 04:09:09 INFO - 'TERM': 'linux', 04:09:09 INFO - 'TMOUT': '86400', 04:09:09 INFO - 'USER': 'cltbld', 04:09:09 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:09 INFO - '_': '/tools/buildbot/bin/python'} 04:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:11 INFO - Installing collected packages: mozsystemmonitor 04:09:11 INFO - Running setup.py install for mozsystemmonitor 04:09:11 INFO - Successfully installed mozsystemmonitor 04:09:11 INFO - Cleaning up... 04:09:11 INFO - Return code: 0 04:09:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:11 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 04:09:11 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 04:09:11 INFO - Using env: {'DISPLAY': ':0', 04:09:11 INFO - 'HOME': '/home/cltbld', 04:09:11 INFO - 'LANG': 'en_US.UTF-8', 04:09:11 INFO - 'LANGUAGE': 'en_US:en', 04:09:11 INFO - 'LOGNAME': 'cltbld', 04:09:11 INFO - 'MAIL': '/var/mail/cltbld', 04:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:11 INFO - 'MOZ_NO_REMOTE': '1', 04:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:11 INFO - 'NO_EM_RESTART': '1', 04:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:11 INFO - 'PWD': '/builds/slave/test', 04:09:11 INFO - 'SHELL': '/bin/bash', 04:09:11 INFO - 'SHLVL': '1', 04:09:11 INFO - 'TERM': 'linux', 04:09:11 INFO - 'TMOUT': '86400', 04:09:11 INFO - 'USER': 'cltbld', 04:09:11 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:11 INFO - '_': '/tools/buildbot/bin/python'} 04:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:12 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:13 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:14 INFO - Downloading docopt-0.6.1.tar.gz 04:09:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:14 INFO - Running setup.py install for blobuploader 04:09:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:14 INFO - Running setup.py install for requests 04:09:14 INFO - Running setup.py install for docopt 04:09:15 INFO - Successfully installed blobuploader requests docopt 04:09:15 INFO - Cleaning up... 04:09:15 INFO - Return code: 0 04:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:15 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')]} 04:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:15 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')]} 04:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:15 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:15 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 04:09:15 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 04:09:15 INFO - Using env: {'DISPLAY': ':0', 04:09:15 INFO - 'HOME': '/home/cltbld', 04:09:15 INFO - 'LANG': 'en_US.UTF-8', 04:09:15 INFO - 'LANGUAGE': 'en_US:en', 04:09:15 INFO - 'LOGNAME': 'cltbld', 04:09:15 INFO - 'MAIL': '/var/mail/cltbld', 04:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:15 INFO - 'MOZ_NO_REMOTE': '1', 04:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:15 INFO - 'NO_EM_RESTART': '1', 04:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:15 INFO - 'PWD': '/builds/slave/test', 04:09:15 INFO - 'SHELL': '/bin/bash', 04:09:15 INFO - 'SHLVL': '1', 04:09:15 INFO - 'TERM': 'linux', 04:09:15 INFO - 'TMOUT': '86400', 04:09:15 INFO - 'USER': 'cltbld', 04:09:15 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:15 INFO - '_': '/tools/buildbot/bin/python'} 04:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:15 INFO - Running setup.py (path:/tmp/pip-2KuG5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:15 INFO - Running setup.py (path:/tmp/pip-D6GS1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:15 INFO - Running setup.py (path:/tmp/pip-MEnqT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:15 INFO - Running setup.py (path:/tmp/pip-PryAc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:15 INFO - Running setup.py (path:/tmp/pip-8H9jNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:15 INFO - Running setup.py (path:/tmp/pip-YfVu2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:15 INFO - Running setup.py (path:/tmp/pip-adImX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:15 INFO - Running setup.py (path:/tmp/pip-txCIK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:15 INFO - Running setup.py (path:/tmp/pip-5JYeQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:15 INFO - Running setup.py (path:/tmp/pip-04GvHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:15 INFO - Running setup.py (path:/tmp/pip-xzUFEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:16 INFO - Running setup.py (path:/tmp/pip-qkrKRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:16 INFO - Running setup.py (path:/tmp/pip-iFojAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:16 INFO - Running setup.py (path:/tmp/pip-Hl4BnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:16 INFO - Running setup.py (path:/tmp/pip-raJNIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:16 INFO - Running setup.py (path:/tmp/pip-3ZQzQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:16 INFO - Running setup.py (path:/tmp/pip-jdKNe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:16 INFO - Running setup.py install for manifestparser 04:09:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:16 INFO - Running setup.py install for mozcrash 04:09:16 INFO - Running setup.py install for mozdebug 04:09:16 INFO - Running setup.py install for mozdevice 04:09:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:16 INFO - Running setup.py install for mozfile 04:09:17 INFO - Running setup.py install for mozhttpd 04:09:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Running setup.py install for mozinfo 04:09:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Running setup.py install for mozInstall 04:09:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Running setup.py install for mozleak 04:09:17 INFO - Running setup.py install for mozlog 04:09:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Running setup.py install for moznetwork 04:09:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Running setup.py install for mozprocess 04:09:17 INFO - Running setup.py install for mozprofile 04:09:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Running setup.py install for mozrunner 04:09:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:17 INFO - Running setup.py install for mozscreenshot 04:09:18 INFO - Running setup.py install for moztest 04:09:18 INFO - Running setup.py install for mozversion 04:09:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:18 INFO - Cleaning up... 04:09:18 INFO - Return code: 0 04:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:18 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:18 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 04:09:18 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 04:09:18 INFO - Using env: {'DISPLAY': ':0', 04:09:18 INFO - 'HOME': '/home/cltbld', 04:09:18 INFO - 'LANG': 'en_US.UTF-8', 04:09:18 INFO - 'LANGUAGE': 'en_US:en', 04:09:18 INFO - 'LOGNAME': 'cltbld', 04:09:18 INFO - 'MAIL': '/var/mail/cltbld', 04:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:18 INFO - 'MOZ_NO_REMOTE': '1', 04:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:18 INFO - 'NO_EM_RESTART': '1', 04:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:18 INFO - 'PWD': '/builds/slave/test', 04:09:18 INFO - 'SHELL': '/bin/bash', 04:09:18 INFO - 'SHLVL': '1', 04:09:18 INFO - 'TERM': 'linux', 04:09:18 INFO - 'TMOUT': '86400', 04:09:18 INFO - 'USER': 'cltbld', 04:09:18 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:18 INFO - '_': '/tools/buildbot/bin/python'} 04:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:18 INFO - Running setup.py (path:/tmp/pip-Slw1Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:18 INFO - Running setup.py (path:/tmp/pip-NxS78R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:18 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)) 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:18 INFO - Running setup.py (path:/tmp/pip-_A3Xgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:18 INFO - Running setup.py (path:/tmp/pip-2o0ZPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:18 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)) 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:18 INFO - Running setup.py (path:/tmp/pip-aY481l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:18 INFO - Running setup.py (path:/tmp/pip-buMiXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:18 INFO - Running setup.py (path:/tmp/pip-rJbYti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:19 INFO - Running setup.py (path:/tmp/pip-rJcMDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:19 INFO - Running setup.py (path:/tmp/pip-PMvzrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:19 INFO - Running setup.py (path:/tmp/pip-eI0MWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:19 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)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:19 INFO - Running setup.py (path:/tmp/pip-4t1wen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:19 INFO - Running setup.py (path:/tmp/pip-X0T77O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:19 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)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:19 INFO - Running setup.py (path:/tmp/pip-oWemSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:19 INFO - Running setup.py (path:/tmp/pip-zSbVpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:19 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)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:19 INFO - Running setup.py (path:/tmp/pip-_xhRVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:19 INFO - Running setup.py (path:/tmp/pip-zbtCfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:19 INFO - Running setup.py (path:/tmp/pip-yJuKj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:09:19 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)) 04:09:19 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)) 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:19 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)) 04:09:19 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)) 04:09:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 INFO - Downloading blessings-1.5.1.tar.gz 04:09:21 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 04:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:21 INFO - Installing collected packages: blessings 04:09:21 INFO - Running setup.py install for blessings 04:09:21 INFO - Successfully installed blessings 04:09:21 INFO - Cleaning up... 04:09:21 INFO - Return code: 0 04:09:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:21 INFO - Reading from file tmpfile_stdout 04:09:21 INFO - Current package versions: 04:09:21 INFO - argparse == 1.2.1 04:09:21 INFO - blessings == 1.5.1 04:09:21 INFO - blobuploader == 1.2.4 04:09:21 INFO - docopt == 0.6.1 04:09:21 INFO - manifestparser == 1.1 04:09:21 INFO - mozInstall == 1.12 04:09:21 INFO - mozcrash == 0.16 04:09:21 INFO - mozdebug == 0.1 04:09:21 INFO - mozdevice == 0.47 04:09:21 INFO - mozfile == 1.2 04:09:21 INFO - mozhttpd == 0.7 04:09:21 INFO - mozinfo == 0.9 04:09:21 INFO - mozleak == 0.1 04:09:21 INFO - mozlog == 3.1 04:09:21 INFO - moznetwork == 0.27 04:09:21 INFO - mozprocess == 0.22 04:09:21 INFO - mozprofile == 0.28 04:09:21 INFO - mozrunner == 6.11 04:09:21 INFO - mozscreenshot == 0.1 04:09:21 INFO - mozsystemmonitor == 0.0 04:09:21 INFO - moztest == 0.7 04:09:21 INFO - mozversion == 1.4 04:09:21 INFO - psutil == 3.1.1 04:09:21 INFO - requests == 1.2.3 04:09:21 INFO - wsgiref == 0.1.2 04:09:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:21 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:21 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 04:09:21 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 04:09:21 INFO - Using env: {'DISPLAY': ':0', 04:09:21 INFO - 'HOME': '/home/cltbld', 04:09:21 INFO - 'LANG': 'en_US.UTF-8', 04:09:21 INFO - 'LANGUAGE': 'en_US:en', 04:09:21 INFO - 'LOGNAME': 'cltbld', 04:09:21 INFO - 'MAIL': '/var/mail/cltbld', 04:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:21 INFO - 'MOZ_NO_REMOTE': '1', 04:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:21 INFO - 'NO_EM_RESTART': '1', 04:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:21 INFO - 'PWD': '/builds/slave/test', 04:09:21 INFO - 'SHELL': '/bin/bash', 04:09:21 INFO - 'SHLVL': '1', 04:09:21 INFO - 'TERM': 'linux', 04:09:21 INFO - 'TMOUT': '86400', 04:09:21 INFO - 'USER': 'cltbld', 04:09:21 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:21 INFO - '_': '/tools/buildbot/bin/python'} 04:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:22 INFO - Cleaning up... 04:09:22 INFO - Return code: 0 04:09:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:22 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:22 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 04:09:22 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 04:09:22 INFO - Using env: {'DISPLAY': ':0', 04:09:22 INFO - 'HOME': '/home/cltbld', 04:09:22 INFO - 'LANG': 'en_US.UTF-8', 04:09:22 INFO - 'LANGUAGE': 'en_US:en', 04:09:22 INFO - 'LOGNAME': 'cltbld', 04:09:22 INFO - 'MAIL': '/var/mail/cltbld', 04:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:22 INFO - 'MOZ_NO_REMOTE': '1', 04:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:22 INFO - 'NO_EM_RESTART': '1', 04:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:22 INFO - 'PWD': '/builds/slave/test', 04:09:22 INFO - 'SHELL': '/bin/bash', 04:09:22 INFO - 'SHLVL': '1', 04:09:22 INFO - 'TERM': 'linux', 04:09:22 INFO - 'TMOUT': '86400', 04:09:22 INFO - 'USER': 'cltbld', 04:09:22 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:22 INFO - '_': '/tools/buildbot/bin/python'} 04:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:22 INFO - Downloading/unpacking jsonschema 04:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:23 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 04:09:23 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:24 INFO - warning: no files found matching '*.txt' 04:09:24 INFO - no previously-included directories found matching 'build' 04:09:24 INFO - no previously-included directories found matching 'dist' 04:09:24 INFO - no previously-included directories found matching '.git*' 04:09:24 INFO - Installing collected packages: jsonschema, functools32 04:09:24 INFO - Running setup.py install for functools32 04:09:24 INFO - warning: no files found matching '*.txt' 04:09:24 INFO - no previously-included directories found matching 'build' 04:09:24 INFO - no previously-included directories found matching 'dist' 04:09:24 INFO - no previously-included directories found matching '.git*' 04:09:24 INFO - Successfully installed jsonschema functools32 04:09:24 INFO - Cleaning up... 04:09:24 INFO - Return code: 0 04:09:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:24 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 0x7f367ba5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, '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': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:24 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 04:09:24 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 04:09:24 INFO - Using env: {'DISPLAY': ':0', 04:09:24 INFO - 'HOME': '/home/cltbld', 04:09:24 INFO - 'LANG': 'en_US.UTF-8', 04:09:24 INFO - 'LANGUAGE': 'en_US:en', 04:09:24 INFO - 'LOGNAME': 'cltbld', 04:09:24 INFO - 'MAIL': '/var/mail/cltbld', 04:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:24 INFO - 'MOZ_NO_REMOTE': '1', 04:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:24 INFO - 'NO_EM_RESTART': '1', 04:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:24 INFO - 'PWD': '/builds/slave/test', 04:09:24 INFO - 'SHELL': '/bin/bash', 04:09:24 INFO - 'SHLVL': '1', 04:09:24 INFO - 'TERM': 'linux', 04:09:24 INFO - 'TMOUT': '86400', 04:09:24 INFO - 'USER': 'cltbld', 04:09:24 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:24 INFO - '_': '/tools/buildbot/bin/python'} 04:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:24 INFO - Downloading/unpacking flake8 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:26 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 04:09:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:26 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 04:09:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 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 04:09:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:26 INFO - no previously-included directories found matching 'docs/_build' 04:09:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:27 INFO - Running setup.py install for pep8 04:09:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:27 INFO - no previously-included directories found matching 'docs/_build' 04:09:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:27 INFO - Cleaning up... 04:09:27 INFO - Return code: 0 04:09:27 INFO - Running post-action listener: _resource_record_post_action 04:09:27 INFO - Running post-action listener: _start_resource_monitoring 04:09:27 INFO - Starting resource monitoring. 04:09:27 INFO - ##### 04:09:27 INFO - ##### Running install step. 04:09:27 INFO - ##### 04:09:27 INFO - Running pre-action listener: _resource_record_pre_action 04:09:27 INFO - Running main action method: install 04:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:27 INFO - Reading from file tmpfile_stdout 04:09:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:27 INFO - Reading from file tmpfile_stdout 04:09:27 INFO - Output received: 04:09:27 INFO - Usage: mozinstall [options] installer 04:09:27 INFO - Options: 04:09:27 INFO - -h, --help show this help message and exit 04:09:27 INFO - -d DEST, --destination=DEST 04:09:27 INFO - Directory to install application into. [default: 04:09:27 INFO - "/builds/slave/test"] 04:09:27 INFO - --app=APP Application being installed. [default: firefox] 04:09:27 INFO - mkdir: /builds/slave/test/build/application 04:09:27 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'] 04:09:27 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 04:09:43 INFO - Reading from file tmpfile_stdout 04:09:43 INFO - Output received: 04:09:43 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:43 INFO - Running post-action listener: _resource_record_post_action 04:09:43 INFO - ##### 04:09:43 INFO - ##### Running run-tests step. 04:09:43 INFO - ##### 04:09:43 INFO - Running pre-action listener: _resource_record_pre_action 04:09:43 INFO - Running main action method: run_tests 04:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:43 INFO - Python 2.7.3 04:09:43 INFO - Return code: 0 04:09:43 INFO - grabbing minidump binary from tooltool 04:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:09:43 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 0x11553d0>, '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 0x10c0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:09:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:09:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:43 INFO - Return code: 0 04:09:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:44 INFO - Return code: 0 04:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:09:44 INFO - Using env: {'DISPLAY': ':0', 04:09:44 INFO - 'HOME': '/home/cltbld', 04:09:44 INFO - 'LANG': 'en_US.UTF-8', 04:09:44 INFO - 'LANGUAGE': 'en_US:en', 04:09:44 INFO - 'LOGNAME': 'cltbld', 04:09:44 INFO - 'MAIL': '/var/mail/cltbld', 04:09:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:44 INFO - 'MOZ_NO_REMOTE': '1', 04:09:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:44 INFO - 'NO_EM_RESTART': '1', 04:09:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:44 INFO - 'PWD': '/builds/slave/test', 04:09:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:44 INFO - 'SHELL': '/bin/bash', 04:09:44 INFO - 'SHLVL': '1', 04:09:44 INFO - 'TERM': 'linux', 04:09:44 INFO - 'TMOUT': '86400', 04:09:44 INFO - 'USER': 'cltbld', 04:09:44 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829', 04:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:44 INFO - '_': '/tools/buildbot/bin/python'} 04:09:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:09:44 INFO - mozversion application_buildid: 20151229025539 04:09:44 INFO - mozversion application_changeset: 7d6ddcd2bbb47871f04edd3c7e10c6e30ad98896 04:09:44 INFO - mozversion application_display_name: Nightly 04:09:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:44 INFO - mozversion application_name: Firefox 04:09:44 INFO - mozversion application_remotingname: firefox 04:09:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:44 INFO - mozversion application_vendor: Mozilla 04:09:44 INFO - mozversion application_version: 46.0a1 04:09:44 INFO - mozversion platform_buildid: 20151229025539 04:09:44 INFO - mozversion platform_changeset: 7d6ddcd2bbb47871f04edd3c7e10c6e30ad98896 04:09:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:44 INFO - mozversion platform_version: 46.0a1 04:09:44 INFO - using testdate: 1451390984 04:09:44 INFO - actual date: 1451390984 04:09:44 INFO - starting webserver on 'localhost:34896' 04:09:44 INFO - SUITE-START | Running 3 tests 04:09:44 INFO - TEST-START | dromaeo_css 04:09:44 INFO - operating with platform_type : linux_ 04:09:44 INFO - Initialising browser for dromaeo_css test... 04:09:44 INFO - TEST-INFO | started process 24228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI4WjWP/profile http://localhost:34896/getInfo.html) 04:09:49 INFO - PROCESS | 24228 | __metrics Screen width/height:1600/1200 04:09:49 INFO - PROCESS | 24228 | colorDepth:24 04:09:49 INFO - PROCESS | 24228 | Browser inner width/height: 1024/697 04:09:49 INFO - PROCESS | 24228 | __metrics 04:09:49 INFO - PROCESS | 24228 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:09:50 INFO - TEST-INFO | 24228: exit 0 04:09:50 INFO - Browser initialized. 04:09:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:50 INFO - TEST-INFO | started process 24359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI4WjWP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:01 INFO - PROCESS | 24359 | RSS: Main: 149544960 04:10:01 INFO - PROCESS | 24359 | 04:10:51 INFO - PROCESS | 24359 | 1451391051562 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:13:02 INFO - PROCESS | 24359 | Cycle 1(1): loaded http://localhost:34896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34896/tests/dromaeo/cssquery-ext.html) 04:13:04 INFO - PROCESS | 24359 | RSS: Main: 154861568 04:13:04 INFO - PROCESS | 24359 | 04:16:06 INFO - PROCESS | 24359 | Cycle 1(1): loaded http://localhost:34896/tests/dromaeo/cssquery-ext.html (next: http://localhost:34896/tests/dromaeo/cssquery-jquery.html) 04:16:06 INFO - PROCESS | 24359 | RSS: Main: 155123712 04:16:06 INFO - PROCESS | 24359 | 04:19:08 INFO - PROCESS | 24359 | Cycle 1(1): loaded http://localhost:34896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34896/tests/dromaeo/cssquery-mootools.html) 04:19:09 INFO - PROCESS | 24359 | RSS: Main: 152641536 04:19:09 INFO - PROCESS | 24359 | 04:22:11 INFO - PROCESS | 24359 | Cycle 1(1): loaded http://localhost:34896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34896/tests/dromaeo/cssquery-prototype.html) 04:22:11 INFO - PROCESS | 24359 | RSS: Main: 152195072 04:22:11 INFO - PROCESS | 24359 | 04:25:14 INFO - PROCESS | 24359 | Cycle 1(1): loaded http://localhost:34896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34896/tests/dromaeo/cssquery-yui.html) 04:25:15 INFO - PROCESS | 24359 | RSS: Main: 152240128 04:25:15 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | Cycle 1(1): loaded http://localhost:34896/tests/dromaeo/cssquery-yui.html (next: http://localhost:34896/tests/dromaeo/cssquery-dojo.html) 04:28:17 INFO - PROCESS | 24359 | RSS: Main: 155111424 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | __start_tp_report 04:28:17 INFO - PROCESS | 24359 | _x_x_mozilla_page_load 04:28:17 INFO - PROCESS | 24359 | _x_x_mozilla_page_load_details 04:28:17 INFO - PROCESS | 24359 | |i|pagename|runs| 04:28:17 INFO - PROCESS | 24359 | |0;dojo.html;2663.1477927063343;2714.538528450163;2754.2012816283277;2760.875760590773;2769.4461107778443;4622.514635963226;4779.498152693965;4807.783649735761;4817.638677099214;4851.296561998508;4722.8583142505695;4750.406199225097;4767.451743049551;4827.8793030174265;4841.782119804609;4424.225760491917;4428.911421771562;4441.489228738696;4502.752348620825;4521.706089104197;4483.730976141442;4492.932606010912;4540.160070386973;4556.97721511392;4590.472095709003;4288.849890253841;4369;4397;4451.554844515555;4473.575010374042;4413.249747542925;4414.205443020255;4419.491758447787;4423.955760442386;4453.688241823073;4225.154969006211;4399.340098985146;4401.295792673189;4414.3157810539415;4433.423654924839;4570.817167313304;4603.539646035403;4703.412073490814;4712.151812673717;4714.387129673155;5162.483751624845;5168.819091331786;5173.663711858717;5173.76718047685;5198.2722418861385;4938.38270216223;5076;5138.511841375101;5192.71440070796;5213.322268105122;4725.054989002213;4757.476677565534;4766.142094422968;4784.545468180518;4844.079624871299;5274.367075950834;5283.286756287929;5301.416844147141;5303.416624171338;5306.495882891119;4849.393825771778;4959.925601115986;4964.255361695775;5076.111680455905;5082.949170508247;5056.191009438472;5058.291839142523;5061.44324124346;5068.062408454374;5069.6451248413;4947.703137811743;5006.374203224597;5006.874828129326;5080.720560369141;5217.530422262014;5043.747812609355;5065.822696205615;5070.721110338893;5078.5937125029905;5125.666831655931;4257.914841703148;4258.233517966796;4265.594768496988;4274.166537525215;4299.613034826881;3650.1969566695284;3694.8152592370275;3772.641599048086;3776.3013842439236;3811.714121440903;4428.13651337986;4455.465344158657;4459.509453960127;4482.5069242383315;4500.302453119772;4955.925661115086;5124.666896651705;5174.042802081627;5179.48205179479;5183.714895680699;4372.147431250875;4416.690831641754;4476.239039363316;4491.775411229425;4524.7511386873375;4604.58558729716;4623.606993405599;4626.097910907408;4647.047355292225;4668.253079507263;4749.216379297515;4864.659473836798;4987.900241995212;4990.900181996412;4992.5756310714;5070.619703522177;5156;5162.716050617252;5165.199394093921;5219.243209734491;4909.26361045846;4920.704757714549;4921.31101645777;4928;4948.628852836124;4889.975550122369;4994.775235114501;5007.424146223231;5072.82245121419;5077.238414237746;5098.107831129611;5107.514786095315;5109.6678715883345;5127.769250383667;5129.076766182123;4941.258811178352;4949.282354058713;4957.206846904478;5050.823221187241;5071.315372424823;5023.346964894687;5041.915988062584;5047.2429135629945;5055.16589762685;5098.923516147335;4900.8774780630765;4920.72935988524;4955.132851751001;4960.826371076995;4967.9006419870675;4811.591014763784;4925.901481970269;4990.326305948651;5030.4718004608985;5096.949030509796;4888.706677599355;4930.827421040246;4936.160852654985;4954.677945933503;4970.055689418999 04:28:17 INFO - PROCESS | 24359 | |1;ext.html;550.8264896557585;565.1579147070864;570.7003822992929;575.3239943066895;575.5194412665425;33200.83399583002;33592.83203583978;33601.49597756036;33636;33758;36495.4525682115;36721.81639091807;36831.26337473256;36987;37016.25967480649;7415.073115860531;7483.962580187092;7514.286142816451;7520.135184453776;7527.623618819037;7434.814129646748;7643.159252482223;7664.041994750656;7845.137034926153;7859.8821017684495;7786.610669466532;7805.024371953506;7811.648475818602;7851.332636725885;7868.095169055575;7719;7813.609319534029;7813.882791758099;7884.566348850811;7897.131315555342;7635.198304178092;7718.343940765042;7730.265624765639;7754.534727916343;7766.805829854299;37096.629033709585;37563.62436375629;37572;37580;37647.24705505902;2675.317793962527;2747.189579074178;2813.831170129799;2829.0381270367966;2848.245215018001;28355.432891342058;28900.710992890014;28990.420191596262;29141;29352;3110.937781244385;3111.797733147338;3134.2164458885277;3140;3159.1786135604907;214460;215482;215700;215719;215852;39791.80104099461;40217;40511;50918.23622645663;51211;37408;37549.62450375461;37552;37820.81089594589;37913.81043094767;12181.269123852597;12185.573504927284;12280.692982675326;12304.692382690504;12322.507099715911;10192;10199.18406527476;10290.536925838354;10310.793784124275;10342.224333175041;13344.199348038954;13557.86442135566;13856.237906915216;13878.306084695725;13918.791218131737;5433.701146436905;5521.779128834882;5540;5551.72241387929;5628.240187574625;911.2391153386864;919.839052972605;932.8554074118387;969.60730903984;980.07872599756;26568.601470977952;27018.1894543164;27061;27134.728652713617;27236.59145112825;943.580106852444;946.0019679238331;969.147150507563;983.8425851863667;1003.6286573967678;13905.930470347583;14021.579352619437;14174.433022678977;14325.426982920566;14329.35517901697;263077;264475;266061;267619;268196;45743.77128114338;46172.307415388794;46435.767821160676;46497.53502464932;46504;1176.670532250971;1180.2859270141612;1193.8985186259265;1194.098455665984;1311.9540816071392;25560.10539631104;26153.346166345993;26203.868980655738;26516.337091572866;26542.469150617264;40641.1871762569;41044;41062.79468602638;41071.589284106776;41120;250095;250738;250819;251847;252401;25432.872835635702;25942.48115037651;29517.852410737807;29728.878467760573;30053.098407047823;43209.35185972276;43572.78213608912;43649.78175109104;43953.78023109864;44029.55970440255;30871.854652697613;31145.532817007308;33328.33343333168;34912.127196820285;35104.64895351116;33690.663093368756;33933.830330848185;34113.658863411045;34167.82916085503;34224.14439639029;33427.83286083554;34105;34567.4814877772;34654.65345346615;34721.47917781286;30012;31226.531602026444;31285;31432.214194645316;31584.684153158174;24037.278881633578;24304.878475607507;24314.51370972606;24441.144559940316;24686.753132468446 04:28:17 INFO - PROCESS | 24359 | |2;jquery.html;326.5412096005112;331.52757320817835;332.89513803152005;334.79912052768327;335.6660123177439;14920.328585213665;15438.922805385972;15691.215439228035;15712.371505139809;16194.109323987175;9788.755281117976;10082.193424526038;12816.23102613844;14642.194679292634;14710;4366.345048242773;4385.868423947287;4444.311131774564;4524.479684836253;4535.954640453603;4422.181896349186;4435.223835828733;4435.756033418161;4439.089986552765;4445.733256004634;4398.670099742532;4415.050764085721;5269.2886460327745;5444.482774136451;5448.019356515825;5088.465711100355;5466.098093814516;5478.671279723209;5493.340799104133;5508.6970216638065;5000.574951129159;5016.147254966664;5047.848564543069;5051.52010559;5067.290579318898;11019.449027548671;11155.219134660578;15486.380544778196;19137.13882875274;19281.903590481958;1656.6189776351387;1691.5432833134985;1775.2366482412558;1795.8293962073712;1898.8670793044491;8880.8667869982;8880.911190888137;9107.180353768194;10517.789644207149;12838.871611283861;1738.1830539646346;1755.2013833705632;1775.5117342730853;1801.675698374292;1841.558026073746;53955.46044539544;54781.45218547803;55591.72204138994;57556;57666.42333576652;9552.235821134293;9931.155851752537;9935.552900119512;9942.204623630092;9996.150327222267;12501.187422817487;12506.499740010298;12522.123451358317;12540;12545.12184147101;6724.798256052326;6754.5947243165565;6774.45804335652;6793.252742198354;6804.4216241620015;6055.909161362583;6080.4527592516;6085.4523092921845;6122.785702500391;6160.537959653044;3793.279276937373;3799.430085487144;4039.313316736103;4144.91710165795;4200.243956087934;1604.7111519926525;1708.880378373502;1739.8347157020062;1772.8670349723823;1784.857211423083;706.2443185791257;783.561205724796;823.9906115009186;877.2587163846539;926.1479438916078;9895.158911492459;9984.500774961369;14281.214533200566;14746.262686865613;14943.402263909322;369.8908821897547;379.08829265616237;381.0492820413087;386.26416676231264;386.47825435661633;5092.668976516515;5253.369595648546;5343.946560534423;5376.220448035013;5447.836564903059;496342;500138;501128;501543;523252;76460.61769691228;77327;77660.83508747374;77903.61048194836;79135;420.6928941872389;423.267746798035;424.4249042547304;425.98296068156924;426.0881713133896;9184.770380740534;9342.112499312554;9437.669681561387;9491.715248542554;9517.048295170427;33531.32937341288;34377.31245375029;35896.28207435889;36300.81849590841;36723;45456;47022.82442938954;48089.27866082082;48220.27669584889;50048.49951500438;8543.145685431407;8802.735917922473;8866.911330886609;8896.555172241233;8904.777380565538;10179.643712470324;10312.742181445525;12015.819762703391;16665.833341666912;16913.66172676564;13200.273984930922;13255.469781208643;13865.930670346585;13886.444542218198;13920;12962.67593310137;13132.606021819362;13640.727185456433;13741.519046833313;13897.51358702481;13630.795538067136;13763.931180344034;14054.227017513726;14215.857841421453;14327.856721432652;8492.915070849212;8629.8705519416;9316.813663726824;9363.578638961399;9385.343025988388;13725.794113088112;14022;14273.57179284623;14300;14319.642008949859 04:28:17 INFO - PROCESS | 24359 | |3;mootools.html;1364.1814911053366;1377.2149874571494;1497.1915165810462;1691.036109417631;1708.1032457959577;5874.412558744123;5969;7070.4343652507805;7190.245024272454;7193.24470930552;6618.470522358211;6669.19969603647;6719.49603779716;6786.694598743056;6802.523823332369;2016.4555569996128;2048.0783647358676;2051.466618679139;2051.774304826468;2053.7227474291003;1972.4871533401347;1986.5927484865567;1992.6114407690507;2003.7495313085865;2005.3282150479533;2017.3746138696977;2053.5892821435773;2066.070268379235;2070.8032736890045;2076.563921576471;2049.3646969439446;2050.6821442676483;2061.8762874227596;2066.3697572240612;2073.8237249833783;2060.6908963655424;2085.8748475091543;2089.958200835975;2093.9476513087293;2099.496120930981;7088.362047415706;7098.929010709879;7143.392811611019;7143.749968751069;7194.604296763676;4225.830966761357;4328.567143285646;4340.045190058182;4340.65274778017;4342.109867477159;2617.5550156473255;2633.868306584663;2655.8406495610325;2695.7573818356245;2707.2284398946404;839.890814194157;846.7417437681505;861.4917198852708;862.4351050062219;867.8871746672892;9533;9606.375585586984;9612.327137100407;9620.278479114095;9683.515824208762;3918.5101862267215;3931.233409485123;3932.311845427039;3944.3886197639413;3990.082281075369;8181.159239171139;8261.421700480909;8269.338452923752;8274.793130171673;8294;4338.110687309094;4348.7390756554705;4370.278903980808;4372.978135109368;4374.147041326974;3207.5990501187352;3272.689094536015;3824.808759562011;3920.5883382245024;3960.663343615767;3437.329720704439;3438.329525742506;3468.5490886184634;3480.129967508123;3516.507688923553;1099.455769394139;1102.1788767368362;1107.7175320293275;1111.8332250162541;1120.9215354925077;909.663424532927;966.3187452845727;1154.7979103656826;1164.6564263542275;1188.423614546944;6628.072069910217;6681.365270299314;6681.832954176088;6697.598144111369;6707.765228216989;1006.3257617396362;1013.6148263659762;1021.7956408718286;1030.8402197659375;1032.695354870315;5306.336707911511;5317.813876514303;5320.388155362183;5363.919541206885;5370.731463426891;8167.714130005421;8194.34445244391;8305.792355191168;8328.875066874001;8557.614907329185;8157.265846073882;8172.264496195252;8208.876866847002;8219.54792486407;8240.958795205986;6559.672016399161;6604.2074951005225;6680.465562754968;6697.531172817953;6706.128203333633;6638.90041649366;6692.1969363674725;6695.631740254138;6700.162479690039;6719.126513553207;7465.850682986418;7467.514611550232;7750.147483776667;7794.2985131338455;7889.053313602175;7762.8447431049935;7915.762527124196;7953;7968.880466793119;8062.516249025077;5277.2875661785165;5364.4099149094345;5925.259342582177;6085.391460853879;6086.239220097488;6468.579542329921;6506.674666266573;6533.575317604341;6539.411452969255;6539.803805885831;5987.401259873977;6116.816495505142;6175.4750846176785;6186.938130618636;6213.099100630474;6137.1101190328045;6178.289496707756;6191.907121393273;6294.0558916162945;6305.117283580211;6224.657643829451;6331.493480521639;6335.239771227482;6338.207724034496;6340.1123842661145;5794.101914203306;5807.448292412214;5828.388019258086;5835.94164058354;5846.181534585076;5857.882842343044;5859.326177489473;5868.618539794899;5873.911891321548;5932.139839723302 04:28:17 INFO - PROCESS | 24359 | |4;prototype.html;292.35389788567267;298.4121281076279;306.33678086941774;306.49581438533613;311.16297160637896;5501.724913754317;5556.361018482876;5599.216109744629;5600.355959064709;5676.858078548038;5558.833235002946;5560.749766260518;5578;5583.134614134816;5584.385717571064;4112.465379500661;4268.701190916637;4271.829126834923;4278.871633850989;4293.463317085364;4159.292920203573;4175;4176.60322269384;4187.51843537994;4194.517630472489;4131.7934103294865;4132.090939993212;4135.565765594614;4136.048708796979;4143;4155.58444155585;4171.311733563958;4173.97913010433;4181.435506206669;4192.916141677179;3617.3127105850067;3629.691476224524;3629.7096232301615;3633.6003039665616;3637.8726744563814;5109.156989096795;5174.353205849269;5215.322008138955;5237.292965449654;5297.231901374279;4761.880952976168;4792.904141917177;4803.543663351976;4808.711477311373;4811.975940120312;5809.3609702932645;5811.476967072941;5818.854528636775;5834.154047663107;5845.503132233765;3867.091233560111;3931.174453364797;3944.684425245973;3945.9802700986597;3947.5262968443685;6031.698415079272;6113.847153821145;6150.477209437203;6160.969195154041;6164.630122192682;4036.798160091984;4073.572274911151;4075.286824805647;4078.163976384834;4082.6937979651643;4093.406456063854;4122;4129.091599848029;4135.731177473454;4149.232392007489;4689.015306785614;4785.808567657325;4793.832215872428;4797.304390863305;4798.760061996886;5810.157527158538;5823.505002074871;5829.475347218686;5831.154482599999;5839.270091238595;1436.3249272841747;1454.8763355114934;1455.8325792533994;1460.3574427251974;1462.992685036568;949.8432758594754;971.2861047130353;971.7522031881825;981.6073570571829;988.5452691761726;5010.749462526859;5023.572996295283;5086;5087.389513258433;5093.643444958817;5985.880282394415;6049.001914684116;6061.212042434543;6062.969685151546;6100.779844031212;5076.74616269185;5081.23781432788;5081.5426611605135;5095.617828662865;5098.056859481007;3206.8717251310154;3256.348730253959;3272.590926134233;3288.93422131556;3299.4390953537954;5782.855428614234;5803.216565763652;5819.79630712923;5824.912626310609;5826.329972053183;6000.549958753111;6033.3966603340195;6090.299615544181;6229.314775374705;6235.251769787655;5818.069108942549;5818.44724751148;5860.267466566679;5868.559858010581;5871.882562348729;6087.36082711309;6124.326324104256;6133.815985520441;6139.969300153471;6152.969235153795;5734.111212762028;5896.70516474166;5936.228290322403;5939.792107276225;5994.460498555151;5827.970860145672;5840.737166827418;5870.090136028923;5878.29460464747;5881.5588830837005;4011.9799401003975;4060.5127384714024;4063.7764922929523;4066.877993660195;4086.407470916641;6006.819795406145;6114.113453549299;6130.877382452415;6138.294096178996;6152.200213972155;5858.297004359504;5890.528757699288;5892.499137573354;5903.763849445974;5909.6158749681135;5886.293644762656;5888.882222355614;5909.556783241188;5910.468057874812;5914.053751399755;5621.80323688669;5739.139129130664;5761.683107429131;5779.479846813807;5789.2763404574425;5923.614965027259;5936.851578710567;5937.821865344046;5950.5239580834295;5951.642901425928;5787.9710601448405;5794.5364370851075;5800.738966746591;5806;5809.153514777813 04:28:17 INFO - PROCESS | 24359 | |5;yui.html;714.4177495341296;718.1489934427703;740.8296091898864;770.8959290495785;790.8418316336727;10578.418186999712;10827.891721082806;10864.022237998579;10882.945585272062;10892.074173695235;11416.771664566704;11430.199886007982;11453.083753299738;11465.713357166074;11504.769904601924;759.8822182561684;768.6848392159216;778.7546922719354;781.7889169924117;782.538302401583;767.2404319723489;767.7619937819294;770.8458308338327;772.5789444752595;777.1296148313868;810.7973006748313;813.8860559521672;820.0159808230147;821.5727821532829;824.9752507424787;807.9717209897655;810.266708628692;812.0134037144838;814.9022117345957;815.2581151152452;609.6860117039728;613.6256883301182;613.9478144357735;614.0788816774838;614.2230078950132;11640.06879449642;11666.708332291675;11693.181477296592;11716;11810.822837657443;10987.890121098846;11063.502142403611;11180.832287515694;11550.191486595942;11796.174267801258;8536.530490823003;8748.212660860552;9123.726288211365;9126.543672816399;9166.541672916328;3085.197848559391;3124.4844600640868;3125.343677827659;3132.843357832099;3182.3635272945503;39888.20223595541;40276;40334.79832600818;40363.394549081786;40456.797716011526;8846.867296990551;8945.776355591162;9142.588583513758;9149.588268527932;9250.768730781785;15952.20238988046;15998.120103394192;16008.439704610515;16020.439284625216;16035.358585656442;5774.451427114417;5883.529317654577;5901.29184497863;6059.484943779828;6101.298350689639;3445.2937147884622;3497.965020349764;3558.893233203008;3585.8027808470783;3600.567931848195;2734.917952461429;2739.9589006164924;2758.544840101361;2766.5573508238585;2770.293575138367;472.84396149271345;477.067333363274;485.3084354794404;485.4562889563711;485.50721018166587;482.8599706085196;537.9273798037215;545.7762317449906;566.8894565559759;583.4369833110983;6863.519553631198;6935.306469353024;6958.686859091353;7055.400290975324;7072.68172932209;584.3171665603036;587.9441453061952;590.5570821883588;596.1415561591381;607.3683369295971;3311.430226287756;3376.409128402569;3421.863125474953;3425.8972230833115;3526.400511912981;48875;49285.26072108921;49478.257826132634;49557.50442495601;49611.25583116256;43562.346564801555;43777.781111094875;44558.55441445544;44836.3274550882;45012.54987450149;40063.79968100199;40180.598194017686;40572;41851.58148418477;41923;6635.966820165868;6651.368120028589;6813.829654258683;8068.919310807051;8164.795880102807;29990;30674.233144171576;30847;30896.845515773177;31205.53191702081;37737.05657358588;38110;38623;38636.61363386443;38910.80544597259;9909.55407006672;10228.948855255676;10299.536520856429;10401.895981040092;10600.787984240425;11265.831012534654;11399.544018239178;11415.37215453158;11780.882191178322;12144.453499592362;10576.312539684895;10697.786044279226;10898.50956706966;10973.067289280181;11073.944630276797;10799.892001079888;10988.615398461016;11293.7741245173;11498.25261358009;11562.595309164139;9153.816923661623;10624.946875265574;10717.9464102679;10815.789997809234;10879.456027198767;7257.854842903007;8408.621612027351;8668.263197628272;8685.913140868763;8740.60667269987;8995.910040899507;9017.09829017093;9139.954300228455;9148.451092934445;9174 04:28:17 INFO - PROCESS | 24359 | __end_tp_report 04:28:17 INFO - PROCESS | 24359 | __start_cc_report 04:28:17 INFO - PROCESS | 24359 | _x_x_mozilla_cycle_collect,329 04:28:17 INFO - PROCESS | 24359 | __end_cc_report 04:28:17 INFO - PROCESS | 24359 | __startTimestamp1451392097722__endTimestamp 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | ------- Summary: start ------- 04:28:17 INFO - PROCESS | 24359 | Number of tests: 6 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | [#0] dojo.html Cycles:165 Average:4738.94 Median:4909.26 stddev:490.78 (10.0%) stddev-sans-first:464.49 04:28:17 INFO - PROCESS | 24359 | Values: 2663.1 2714.5 2754.2 2760.9 2769.4 4622.5 4779.5 4807.8 4817.6 4851.3 4722.9 4750.4 4767.5 4827.9 4841.8 4424.2 4428.9 4441.5 4502.8 4521.7 4483.7 4492.9 4540.2 4557.0 4590.5 4288.8 4369.0 4397.0 4451.6 4473.6 4413.2 4414.2 4419.5 4424.0 4453.7 4225.2 4399.3 4401.3 4414.3 4433.4 4570.8 4603.5 4703.4 4712.2 4714.4 5162.5 5168.8 5173.7 5173.8 5198.3 4938.4 5076.0 5138.5 5192.7 5213.3 4725.1 4757.5 4766.1 4784.5 4844.1 5274.4 5283.3 5301.4 5303.4 5306.5 4849.4 4959.9 4964.3 5076.1 5082.9 5056.2 5058.3 5061.4 5068.1 5069.6 4947.7 5006.4 5006.9 5080.7 5217.5 5043.7 5065.8 5070.7 5078.6 5125.7 4257.9 4258.2 4265.6 4274.2 4299.6 3650.2 3694.8 3772.6 3776.3 3811.7 4428.1 4455.5 4459.5 4482.5 4500.3 4955.9 5124.7 5174.0 5179.5 5183.7 4372.1 4416.7 4476.2 4491.8 4524.8 4604.6 4623.6 4626.1 4647.0 4668.3 4749.2 4864.7 4987.9 4990.9 4992.6 5070.6 5156.0 5162.7 5165.2 5219.2 4909.3 4920.7 4921.3 4928.0 4948.6 4890.0 4994.8 5007.4 5072.8 5077.2 5098.1 5107.5 5109.7 5127.8 5129.1 4941.3 4949.3 4957.2 5050.8 5071.3 5023.3 5041.9 5047.2 5055.2 5098.9 4900.9 4920.7 4955.1 4960.8 4967.9 4811.6 4925.9 4990.3 5030.5 5096.9 4888.7 4930.8 4936.2 4954.7 4970.1 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | [#1] ext.html Cycles:180 Average:39575.18 Median:33845.92 stddev:63839.84 (188.6%) stddev-sans-first:63951.68 04:28:17 INFO - PROCESS | 24359 | Values: 550.8 565.2 570.7 575.3 575.5 33200.8 33592.8 33601.5 33636.0 33758.0 36495.5 36721.8 36831.3 36987.0 37016.3 7415.1 7484.0 7514.3 7520.1 7527.6 7434.8 7643.2 7664.0 7845.1 7859.9 7786.6 7805.0 7811.6 7851.3 7868.1 7719.0 7813.6 7813.9 7884.6 7897.1 7635.2 7718.3 7730.3 7754.5 7766.8 37096.6 37563.6 37572.0 37580.0 37647.2 2675.3 2747.2 2813.8 2829.0 2848.2 28355.4 28900.7 28990.4 29141.0 29352.0 3110.9 3111.8 3134.2 3140.0 3159.2 214460.0 215482.0 215700.0 215719.0 215852.0 39791.8 40217.0 40511.0 50918.2 51211.0 37408.0 37549.6 37552.0 37820.8 37913.8 12181.3 12185.6 12280.7 12304.7 12322.5 10192.0 10199.2 10290.5 10310.8 10342.2 13344.2 13557.9 13856.2 13878.3 13918.8 5433.7 5521.8 5540.0 5551.7 5628.2 911.2 919.8 932.9 969.6 980.1 26568.6 27018.2 27061.0 27134.7 27236.6 943.6 946.0 969.1 983.8 1003.6 13905.9 14021.6 14174.4 14325.4 14329.4 263077.0 264475.0 266061.0 267619.0 268196.0 45743.8 46172.3 46435.8 46497.5 46504.0 1176.7 1180.3 1193.9 1194.1 1312.0 25560.1 26153.3 26203.9 26516.3 26542.5 40641.2 41044.0 41062.8 41071.6 41120.0 250095.0 250738.0 250819.0 251847.0 252401.0 25432.9 25942.5 29517.9 29728.9 30053.1 43209.4 43572.8 43649.8 43953.8 44029.6 30871.9 31145.5 33328.3 34912.1 35104.6 33690.7 33933.8 34113.7 34167.8 34224.1 33427.8 34105.0 34567.5 34654.7 34721.5 30012.0 31226.5 31285.0 31432.2 31584.7 24037.3 24304.9 24314.5 24441.1 24686.8 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | [#2] jquery.html Cycles:180 Average:26640.29 Median:4392.27 stddev:82619.23 (1881.0%) stddev-sans-first:82827.37 04:28:17 INFO - PROCESS | 24359 | Values: 326.5 331.5 332.9 334.8 335.7 14920.3 15438.9 15691.2 15712.4 16194.1 9788.8 10082.2 12816.2 14642.2 14710.0 4366.3 4385.9 4444.3 4524.5 4536.0 4422.2 4435.2 4435.8 4439.1 4445.7 4398.7 4415.1 5269.3 5444.5 5448.0 5088.5 5466.1 5478.7 5493.3 5508.7 5000.6 5016.1 5047.8 5051.5 5067.3 11019.4 11155.2 15486.4 19137.1 19281.9 1656.6 1691.5 1775.2 1795.8 1898.9 8880.9 8880.9 9107.2 10517.8 12838.9 1738.2 1755.2 1775.5 1801.7 1841.6 53955.5 54781.5 55591.7 57556.0 57666.4 9552.2 9931.2 9935.6 9942.2 9996.2 12501.2 12506.5 12522.1 12540.0 12545.1 6724.8 6754.6 6774.5 6793.3 6804.4 6055.9 6080.5 6085.5 6122.8 6160.5 3793.3 3799.4 4039.3 4144.9 4200.2 1604.7 1708.9 1739.8 1772.9 1784.9 706.2 783.6 824.0 877.3 926.1 9895.2 9984.5 14281.2 14746.3 14943.4 369.9 379.1 381.0 386.3 386.5 5092.7 5253.4 5343.9 5376.2 5447.8 496342.0 500138.0 501128.0 501543.0 523252.0 76460.6 77327.0 77660.8 77903.6 79135.0 420.7 423.3 424.4 426.0 426.1 9184.8 9342.1 9437.7 9491.7 9517.0 33531.3 34377.3 35896.3 36300.8 36723.0 45456.0 47022.8 48089.3 48220.3 50048.5 8543.1 8802.7 8866.9 8896.6 8904.8 10179.6 10312.7 12015.8 16665.8 16913.7 13200.3 13255.5 13865.9 13886.4 13920.0 12962.7 13132.6 13640.7 13741.5 13897.5 13630.8 13763.9 14054.2 14215.9 14327.9 8492.9 8629.9 9316.8 9363.6 9385.3 13725.8 14022.0 14273.6 14300.0 14319.6 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | [#3] mootools.html Cycles:180 Average:4908.44 Median:5928.70 stddev:2521.82 (42.5%) stddev-sans-first:2514.82 04:28:17 INFO - PROCESS | 24359 | Values: 1364.2 1377.2 1497.2 1691.0 1708.1 5874.4 5969.0 7070.4 7190.2 7193.2 6618.5 6669.2 6719.5 6786.7 6802.5 2016.5 2048.1 2051.5 2051.8 2053.7 1972.5 1986.6 1992.6 2003.7 2005.3 2017.4 2053.6 2066.1 2070.8 2076.6 2049.4 2050.7 2061.9 2066.4 2073.8 2060.7 2085.9 2090.0 2093.9 2099.5 7088.4 7098.9 7143.4 7143.7 7194.6 4225.8 4328.6 4340.0 4340.7 4342.1 2617.6 2633.9 2655.8 2695.8 2707.2 839.9 846.7 861.5 862.4 867.9 9533.0 9606.4 9612.3 9620.3 9683.5 3918.5 3931.2 3932.3 3944.4 3990.1 8181.2 8261.4 8269.3 8274.8 8294.0 4338.1 4348.7 4370.3 4373.0 4374.1 3207.6 3272.7 3824.8 3920.6 3960.7 3437.3 3438.3 3468.5 3480.1 3516.5 1099.5 1102.2 1107.7 1111.8 1120.9 909.7 966.3 1154.8 1164.7 1188.4 6628.1 6681.4 6681.8 6697.6 6707.8 1006.3 1013.6 1021.8 1030.8 1032.7 5306.3 5317.8 5320.4 5363.9 5370.7 8167.7 8194.3 8305.8 8328.9 8557.6 8157.3 8172.3 8208.9 8219.5 8241.0 6559.7 6604.2 6680.5 6697.5 6706.1 6638.9 6692.2 6695.6 6700.2 6719.1 7465.9 7467.5 7750.1 7794.3 7889.1 7762.8 7915.8 7953.0 7968.9 8062.5 5277.3 5364.4 5925.3 6085.4 6086.2 6468.6 6506.7 6533.6 6539.4 6539.8 5987.4 6116.8 6175.5 6186.9 6213.1 6137.1 6178.3 6191.9 6294.1 6305.1 6224.7 6331.5 6335.2 6338.2 6340.1 5794.1 5807.4 5828.4 5835.9 5846.2 5857.9 5859.3 5868.6 5873.9 5932.1 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | [#4] prototype.html Cycles:180 Average:4819.21 Median:5583.76 stddev:1455.70 (26.1%) stddev-sans-first:1419.58 04:28:17 INFO - PROCESS | 24359 | Values: 292.4 298.4 306.3 306.5 311.2 5501.7 5556.4 5599.2 5600.4 5676.9 5558.8 5560.7 5578.0 5583.1 5584.4 4112.5 4268.7 4271.8 4278.9 4293.5 4159.3 4175.0 4176.6 4187.5 4194.5 4131.8 4132.1 4135.6 4136.0 4143.0 4155.6 4171.3 4174.0 4181.4 4192.9 3617.3 3629.7 3629.7 3633.6 3637.9 5109.2 5174.4 5215.3 5237.3 5297.2 4761.9 4792.9 4803.5 4808.7 4812.0 5809.4 5811.5 5818.9 5834.2 5845.5 3867.1 3931.2 3944.7 3946.0 3947.5 6031.7 6113.8 6150.5 6161.0 6164.6 4036.8 4073.6 4075.3 4078.2 4082.7 4093.4 4122.0 4129.1 4135.7 4149.2 4689.0 4785.8 4793.8 4797.3 4798.8 5810.2 5823.5 5829.5 5831.2 5839.3 1436.3 1454.9 1455.8 1460.4 1463.0 949.8 971.3 971.8 981.6 988.5 5010.7 5023.6 5086.0 5087.4 5093.6 5985.9 6049.0 6061.2 6063.0 6100.8 5076.7 5081.2 5081.5 5095.6 5098.1 3206.9 3256.3 3272.6 3288.9 3299.4 5782.9 5803.2 5819.8 5824.9 5826.3 6000.5 6033.4 6090.3 6229.3 6235.3 5818.1 5818.4 5860.3 5868.6 5871.9 6087.4 6124.3 6133.8 6140.0 6153.0 5734.1 5896.7 5936.2 5939.8 5994.5 5828.0 5840.7 5870.1 5878.3 5881.6 4012.0 4060.5 4063.8 4066.9 4086.4 6006.8 6114.1 6130.9 6138.3 6152.2 5858.3 5890.5 5892.5 5903.8 5909.6 5886.3 5888.9 5909.6 5910.5 5914.1 5621.8 5739.1 5761.7 5779.5 5789.3 5923.6 5936.9 5937.8 5950.5 5951.6 5788.0 5794.5 5800.7 5806.0 5809.2 04:28:17 INFO - PROCESS | 24359 | 04:28:17 INFO - PROCESS | 24359 | [#5] yui.html Cycles:180 Average:12064.93 Median:44697.44 stddev:13721.20 (30.7%) stddev-sans-first:13733.21 04:28:17 INFO - PROCESS | 24359 | Values: 714.4 718.1 740.8 770.9 790.8 10578.4 10827.9 10864.0 10882.9 10892.1 11416.8 11430.2 11453.1 11465.7 11504.8 759.9 768.7 778.8 781.8 782.5 767.2 767.8 770.8 772.6 777.1 810.8 813.9 820.0 821.6 825.0 808.0 810.3 812.0 814.9 815.3 609.7 613.6 613.9 614.1 614.2 11640.1 11666.7 11693.2 11716.0 11810.8 10987.9 11063.5 11180.8 11550.2 11796.2 8536.5 8748.2 9123.7 9126.5 9166.5 3085.2 3124.5 3125.3 3132.8 3182.4 39888.2 40276.0 40334.8 40363.4 40456.8 8846.9 8945.8 9142.6 9149.6 9250.8 15952.2 15998.1 16008.4 16020.4 16035.4 5774.5 5883.5 5901.3 6059.5 6101.3 3445.3 3498.0 3558.9 3585.8 3600.6 2734.9 2740.0 2758.5 2766.6 2770.3 472.8 477.1 485.3 485.5 485.5 482.9 537.9 545.8 566.9 583.4 6863.5 6935.3 6958.7 7055.4 7072.7 584.3 587.9 590.6 596.1 607.4 3311.4 3376.4 3421.9 3425.9 3526.4 48875.0 49285.3 49478.3 49557.5 49611.3 43562.3 43777.8 44558.6 44836.3 45012.5 40063.8 40180.6 40572.0 41851.6 41923.0 6636.0 6651.4 6813.8 8068.9 8164.8 29990.0 30674.2 30847.0 30896.8 31205.5 37737.1 38110.0 38623.0 38636.6 38910.8 9909.6 10228.9 10299.5 10401.9 10600.8 11265.8 11399.5 11415.4 11780.9 12144.5 10576.3 10697.8 10898.5 10973.1 11073.9 10799.9 10988.6 11293.8 11498.3 11562.6 9153.8 10624.9 10717.9 10815.8 10879.5 7257.9 8408.6 8668.3 8685.9 8740.6 8995.9 9017.1 9140.0 9148.5 9174.0 04:28:17 INFO - PROCESS | 24359 | -------- Summary: end -------- 04:28:17 INFO - PROCESS | 24359 | 04:28:18 INFO - TEST-INFO | 24359: exit 0 04:28:18 INFO - TEST-OK | dromaeo_css | took 1114147ms 04:28:18 INFO - TEST-START | kraken 04:28:18 INFO - operating with platform_type : linux_ 04:28:18 INFO - Initialising browser for kraken test... 04:28:18 INFO - TEST-INFO | started process 24599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPuuAES/profile http://localhost:34896/getInfo.html) 04:28:22 INFO - PROCESS | 24599 | __metrics Screen width/height:1600/1200 04:28:22 INFO - PROCESS | 24599 | colorDepth:24 04:28:22 INFO - PROCESS | 24599 | Browser inner width/height: 1024/697 04:28:22 INFO - PROCESS | 24599 | __metrics 04:28:23 INFO - PROCESS | 24599 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:28:23 INFO - TEST-INFO | 24599: exit 0 04:28:23 INFO - Browser initialized. 04:28:23 INFO - Running cycle 1/1 for kraken test... 04:28:23 INFO - TEST-INFO | started process 24719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPuuAES/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:35 INFO - PROCESS | 24719 | RSS: Main: 149155840 04:28:35 INFO - PROCESS | 24719 | 04:28:38 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34896/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:39 INFO - PROCESS | 24719 | RSS: Main: 150638592 04:28:39 INFO - PROCESS | 24719 | 04:28:41 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34896/tests/kraken/driver.html?testName=audio-dft) 04:28:42 INFO - PROCESS | 24719 | RSS: Main: 150925312 04:28:42 INFO - PROCESS | 24719 | 04:28:45 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34896/tests/kraken/driver.html?testName=audio-fft) 04:28:45 INFO - PROCESS | 24719 | RSS: Main: 145653760 04:28:45 INFO - PROCESS | 24719 | 04:28:48 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34896/tests/kraken/driver.html?testName=audio-oscillator) 04:28:48 INFO - PROCESS | 24719 | RSS: Main: 146595840 04:28:48 INFO - PROCESS | 24719 | 04:28:50 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:51 INFO - PROCESS | 24719 | RSS: Main: 147066880 04:28:51 INFO - PROCESS | 24719 | 04:28:54 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34896/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:55 INFO - PROCESS | 24719 | RSS: Main: 145256448 04:28:55 INFO - PROCESS | 24719 | 04:28:58 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34896/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:59 INFO - PROCESS | 24719 | RSS: Main: 147369984 04:28:59 INFO - PROCESS | 24719 | 04:29:02 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34896/tests/kraken/driver.html?testName=json-parse-financial) 04:29:02 INFO - PROCESS | 24719 | RSS: Main: 147095552 04:29:02 INFO - PROCESS | 24719 | 04:29:04 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:05 INFO - PROCESS | 24719 | RSS: Main: 148393984 04:29:05 INFO - PROCESS | 24719 | 04:29:06 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:07 INFO - PROCESS | 24719 | RSS: Main: 148725760 04:29:07 INFO - PROCESS | 24719 | 04:29:09 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:10 INFO - PROCESS | 24719 | RSS: Main: 149004288 04:29:10 INFO - PROCESS | 24719 | 04:29:12 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:13 INFO - PROCESS | 24719 | RSS: Main: 147308544 04:29:13 INFO - PROCESS | 24719 | 04:29:16 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:16 INFO - PROCESS | 24719 | RSS: Main: 148025344 04:29:16 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | Cycle 1(1): loaded http://localhost:34896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34896/tests/kraken/driver.html?testName=ai-astar) 04:29:18 INFO - PROCESS | 24719 | RSS: Main: 148762624 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | __start_tp_report 04:29:18 INFO - PROCESS | 24719 | _x_x_mozilla_page_load 04:29:18 INFO - PROCESS | 24719 | _x_x_mozilla_page_load_details 04:29:18 INFO - PROCESS | 24719 | |i|pagename|runs| 04:29:18 INFO - PROCESS | 24719 | |0;ai-astar;115;108;113;113;112;125;113;111;111;112 04:29:18 INFO - PROCESS | 24719 | |1;audio-beat-detection;157;128;156;161;130;164;162;140;174;130 04:29:18 INFO - PROCESS | 24719 | |2;audio-dft;163;161;161;161;163;165;163;166;163;162 04:29:18 INFO - PROCESS | 24719 | |3;audio-fft;72;73;71;72;72;72;140;72;73;71 04:29:18 INFO - PROCESS | 24719 | |4;audio-oscillator;97;97;134;98;98;98;130;98;97;129 04:29:18 INFO - PROCESS | 24719 | |5;imaging-gaussian-blur;110;109;110;110;110;110;110;111;110;110 04:29:18 INFO - PROCESS | 24719 | |6;imaging-darkroom;147;147;147;148;149;147;148;147;147;148 04:29:18 INFO - PROCESS | 24719 | |7;imaging-desaturate;97;96;101;96;96;96;95;96;96;98 04:29:18 INFO - PROCESS | 24719 | |8;json-parse-financial;70;72;71;70;74;71;70;70;69;70 04:29:18 INFO - PROCESS | 24719 | |9;json-stringify-tinderbox;68;68;68;68;69;69;69;67;70;68 04:29:18 INFO - PROCESS | 24719 | |10;stanford-crypto-aes;85;84;84;84;84;85;87;85;86;93 04:29:18 INFO - PROCESS | 24719 | |11;stanford-crypto-ccm;122;125;119;129;144;128;123;125;134;131 04:29:18 INFO - PROCESS | 24719 | |12;stanford-crypto-pbkdf2;141;140;151;144;147;135;151;147;147;149 04:29:18 INFO - PROCESS | 24719 | |13;stanford-crypto-sha256-iterative;69;69;71;72;72;69;69;70;68;69 04:29:18 INFO - PROCESS | 24719 | __end_tp_report 04:29:18 INFO - PROCESS | 24719 | __start_cc_report 04:29:18 INFO - PROCESS | 24719 | _x_x_mozilla_cycle_collect,820 04:29:18 INFO - PROCESS | 24719 | __end_cc_report 04:29:18 INFO - PROCESS | 24719 | __startTimestamp1451392158651__endTimestamp 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | ------- Summary: start ------- 04:29:18 INFO - PROCESS | 24719 | Number of tests: 14 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.50 (4.0%) stddev-sans-first:4.73 04:29:18 INFO - PROCESS | 24719 | Values: 115.0 108.0 113.0 113.0 112.0 125.0 113.0 111.0 111.0 112.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:159.00 stddev:16.69 (10.5%) stddev-sans-first:17.52 04:29:18 INFO - PROCESS | 24719 | Values: 157.0 128.0 156.0 161.0 130.0 164.0 162.0 140.0 174.0 130.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.69 (1.0%) stddev-sans-first:1.79 04:29:18 INFO - PROCESS | 24719 | Values: 163.0 161.0 161.0 161.0 163.0 165.0 163.0 166.0 163.0 162.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#3] audio-fft Cycles:10 Average:78.80 Median:72.00 stddev:21.51 (29.9%) stddev-sans-first:22.68 04:29:18 INFO - PROCESS | 24719 | Values: 72.0 73.0 71.0 72.0 72.0 72.0 140.0 72.0 73.0 71.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:97.50 stddev:16.20 (16.6%) stddev-sans-first:16.72 04:29:18 INFO - PROCESS | 24719 | Values: 97.0 97.0 134.0 98.0 98.0 98.0 130.0 98.0 97.0 129.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:29:18 INFO - PROCESS | 24719 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:29:18 INFO - PROCESS | 24719 | Values: 147.0 147.0 147.0 148.0 149.0 147.0 148.0 147.0 147.0 148.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.70 (1.8%) stddev-sans-first:1.80 04:29:18 INFO - PROCESS | 24719 | Values: 97.0 96.0 101.0 96.0 96.0 96.0 95.0 96.0 96.0 98.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.50 stddev:1.42 (2.0%) stddev-sans-first:1.48 04:29:18 INFO - PROCESS | 24719 | Values: 70.0 72.0 71.0 70.0 74.0 71.0 70.0 70.0 69.0 70.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 04:29:18 INFO - PROCESS | 24719 | Values: 68.0 68.0 68.0 68.0 69.0 69.0 69.0 67.0 70.0 68.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.75 (3.2%) stddev-sans-first:2.91 04:29:18 INFO - PROCESS | 24719 | Values: 85.0 84.0 84.0 84.0 84.0 85.0 87.0 85.0 86.0 93.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:128.50 stddev:7.16 (5.6%) stddev-sans-first:7.26 04:29:18 INFO - PROCESS | 24719 | Values: 122.0 125.0 119.0 129.0 144.0 128.0 123.0 125.0 134.0 131.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:147.00 stddev:5.18 (3.5%) stddev-sans-first:5.27 04:29:18 INFO - PROCESS | 24719 | Values: 141.0 140.0 151.0 144.0 147.0 135.0 151.0 147.0 147.0 149.0 04:29:18 INFO - PROCESS | 24719 | 04:29:18 INFO - PROCESS | 24719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:1.40 (2.0%) stddev-sans-first:1.45 04:29:18 INFO - PROCESS | 24719 | Values: 69.0 69.0 71.0 72.0 72.0 69.0 69.0 70.0 68.0 69.0 04:29:18 INFO - PROCESS | 24719 | -------- Summary: end -------- 04:29:18 INFO - PROCESS | 24719 | 04:29:19 INFO - TEST-INFO | 24719: exit 0 04:29:19 INFO - TEST-OK | kraken | took 61189ms 04:29:19 INFO - TEST-START | v8_7 04:29:19 INFO - operating with platform_type : linux_ 04:29:19 INFO - Initialising browser for v8_7 test... 04:29:19 INFO - TEST-INFO | started process 25004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZS1p52/profile http://localhost:34896/getInfo.html) 04:29:24 INFO - PROCESS | 25004 | __metrics Screen width/height:1600/1200 04:29:24 INFO - PROCESS | 25004 | colorDepth:24 04:29:24 INFO - PROCESS | 25004 | Browser inner width/height: 1024/697 04:29:24 INFO - PROCESS | 25004 | __metrics 04:29:24 INFO - PROCESS | 25004 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:29:25 INFO - TEST-INFO | 25004: exit 0 04:29:25 INFO - Browser initialized. 04:29:25 INFO - Running cycle 1/1 for v8_7 test... 04:29:25 INFO - TEST-INFO | started process 25124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZS1p52/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:36 INFO - PROCESS | 25124 | RSS: Main: 149184512 04:29:36 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | Cycle 1(1): loaded http://localhost:34896/tests/v8_7/run.html (next: http://localhost:34896/tests/v8_7/run.html) 04:29:58 INFO - PROCESS | 25124 | RSS: Main: 145125376 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | __start_tp_report 04:29:58 INFO - PROCESS | 25124 | _x_x_mozilla_page_load 04:29:58 INFO - PROCESS | 25124 | _x_x_mozilla_page_load_details 04:29:58 INFO - PROCESS | 25124 | |i|pagename|runs| 04:29:58 INFO - PROCESS | 25124 | |0;Richards;167.897918065816 04:29:58 INFO - PROCESS | 25124 | |1;DeltaBlue;186.01190476190476 04:29:58 INFO - PROCESS | 25124 | |2;Encrypt;278.1641168289291 04:29:58 INFO - PROCESS | 25124 | |3;Decrypt;5240.837696335078 04:29:58 INFO - PROCESS | 25124 | |4;RayTrace;1066.0980810234541 04:29:58 INFO - PROCESS | 25124 | |5;Earley;734.4093910491563 04:29:58 INFO - PROCESS | 25124 | |6;Boyer;12365.853658536585 04:29:58 INFO - PROCESS | 25124 | |7;RegExp;26076.923076923078 04:29:58 INFO - PROCESS | 25124 | |8;Splay;606.4281382656155 04:29:58 INFO - PROCESS | 25124 | |9;NavierStokes;4830.917874396136 04:29:58 INFO - PROCESS | 25124 | __end_tp_report 04:29:58 INFO - PROCESS | 25124 | __startTimestamp1451392198696__endTimestamp 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | ------- Summary: start ------- 04:29:58 INFO - PROCESS | 25124 | Number of tests: 10 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 167.9 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#1] DeltaBlue Cycles:1 Average:186.01 Median:186.01 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 186.0 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 278.2 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 5240.8 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 1066.1 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#5] Earley Cycles:1 Average:734.41 Median:734.41 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 734.4 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 12365.9 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 26076.9 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#8] Splay Cycles:1 Average:606.43 Median:606.43 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 606.4 04:29:58 INFO - PROCESS | 25124 | 04:29:58 INFO - PROCESS | 25124 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:29:58 INFO - PROCESS | 25124 | Values: 4830.9 04:29:58 INFO - PROCESS | 25124 | -------- Summary: end -------- 04:29:58 INFO - PROCESS | 25124 | 04:29:59 INFO - TEST-INFO | 25124: exit 0 04:29:59 INFO - TEST-OK | v8_7 | took 39961ms 04:29:59 INFO - SUITE-END | took 1215s 04:29:59 INFO - Completed test suite (00:20:15) 04:29:59 INFO - Working with test: dromaeo_css 04:29:59 INFO - Generating results file: dromaeo_css 04:29:59 INFO - Working with test: kraken 04:29:59 INFO - Generating results file: kraken 04:29:59 INFO - javascript benchmark 04:29:59 INFO - Working with test: v8_7 04:29:59 INFO - Generating results file: v8_7 04:29:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:29:59 INFO - process_Request line: dromaeo_css 6194.57 graph.html#tests=[[72,94,43]] 04:29:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:59 INFO - process_Request line: kraken 1534.70 graph.html#tests=[[232,94,43]] 04:29:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:59 INFO - process_Request line: v8_7 21221.47 graph.html#tests=[[230,94,43]] 04:29:59 INFO - RETURN: dromaeo_css: 6194.57 04:29:59 INFO - RETURN: kraken: 1534.70 04:29:59 INFO - RETURN: v8_7: 21221.47 04:29:59 INFO - javascript benchmark 04:29:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2663.1477927063343, 2714.538528450163, 2754.2012816283277, 2760.875760590773, 2769.4461107778443, 4622.514635963226, 4779.498152693965, 4807.783649735761, 4817.638677099214, 4851.296561998508, 4722.8583142505695, 4750.406199225097, 4767.451743049551, 4827.8793030174265, 4841.782119804609, 4424.225760491917, 4428.911421771562, 4441.489228738696, 4502.752348620825, 4521.706089104197, 4483.730976141442, 4492.932606010912, 4540.160070386973, 4556.97721511392, 4590.472095709003, 4288.849890253841, 4369.0, 4397.0, 4451.554844515555, 4473.575010374042, 4413.249747542925, 4414.205443020255, 4419.491758447787, 4423.955760442386, 4453.688241823073, 4225.154969006211, 4399.340098985146, 4401.295792673189, 4414.3157810539415, 4433.423654924839, 4570.817167313304, 4603.539646035403, 4703.412073490814, 4712.151812673717, 4714.387129673155, 5162.483751624845, 5168.819091331786, 5173.663711858717, 5173.76718047685, 5198.2722418861385, 4938.38270216223, 5076.0, 5138.511841375101, 5192.71440070796, 5213.322268105122, 4725.054989002213, 4757.476677565534, 4766.142094422968, 4784.545468180518, 4844.079624871299, 5274.367075950834, 5283.286756287929, 5301.416844147141, 5303.416624171338, 5306.495882891119, 4849.393825771778, 4959.925601115986, 4964.255361695775, 5076.111680455905, 5082.949170508247, 5056.191009438472, 5058.291839142523, 5061.44324124346, 5068.062408454374, 5069.6451248413, 4947.703137811743, 5006.374203224597, 5006.874828129326, 5080.720560369141, 5217.530422262014, 5043.747812609355, 5065.822696205615, 5070.721110338893, 5078.5937125029905, 5125.666831655931, 4257.914841703148, 4258.233517966796, 4265.594768496988, 4274.166537525215, 4299.613034826881, 3650.1969566695284, 3694.8152592370275, 3772.641599048086, 3776.3013842439236, 3811.714121440903, 4428.13651337986, 4455.465344158657, 4459.509453960127, 4482.5069242383315, 4500.302453119772, 4955.925661115086, 5124.666896651705, 5174.042802081627, 5179.48205179479, 5183.714895680699, 4372.147431250875, 4416.690831641754, 4476.239039363316, 4491.775411229425, 4524.7511386873375, 4604.58558729716, 4623.606993405599, 4626.097910907408, 4647.047355292225, 4668.253079507263, 4749.216379297515, 4864.659473836798, 4987.900241995212, 4990.900181996412, 4992.5756310714, 5070.619703522177, 5156.0, 5162.716050617252, 5165.199394093921, 5219.243209734491, 4909.26361045846, 4920.704757714549, 4921.31101645777, 4928.0, 4948.628852836124, 4889.975550122369, 4994.775235114501, 5007.424146223231, 5072.82245121419, 5077.238414237746, 5098.107831129611, 5107.514786095315, 5109.6678715883345, 5127.769250383667, 5129.076766182123, 4941.258811178352, 4949.282354058713, 4957.206846904478, 5050.823221187241, 5071.315372424823, 5023.346964894687, 5041.915988062584, 5047.2429135629945, 5055.16589762685, 5098.923516147335, 4900.8774780630765, 4920.72935988524, 4955.132851751001, 4960.826371076995, 4967.9006419870675, 4811.591014763784, 4925.901481970269, 4990.326305948651, 5030.4718004608985, 5096.949030509796, 4888.706677599355, 4930.827421040246, 4936.160852654985, 4954.677945933503, 4970.055689418999], "unit": "score", "name": "dojo.html", "value": 4708.343216298086}, {"lowerIsBetter": false, "replicates": [550.8264896557585, 565.1579147070864, 570.7003822992929, 575.3239943066895, 575.5194412665425, 33200.83399583002, 33592.83203583978, 33601.49597756036, 33636.0, 33758.0, 36495.4525682115, 36721.81639091807, 36831.26337473256, 36987.0, 37016.25967480649, 7415.073115860531, 7483.962580187092, 7514.286142816451, 7520.135184453776, 7527.623618819037, 7434.814129646748, 7643.159252482223, 7664.041994750656, 7845.137034926153, 7859.8821017684495, 7786.610669466532, 7805.024371953506, 7811.648475818602, 7851.332636725885, 7868.095169055575, 7719.0, 7813.609319534029, 7813.882791758099, 7884.566348850811, 7897.131315555342, 7635.198304178092, 7718.343940765042, 7730.265624765639, 7754.534727916343, 7766.805829854299, 37096.629033709585, 37563.62436375629, 37572.0, 37580.0, 37647.24705505902, 2675.317793962527, 2747.189579074178, 2813.831170129799, 2829.0381270367966, 2848.245215018001, 28355.432891342058, 28900.710992890014, 28990.420191596262, 29141.0, 29352.0, 3110.937781244385, 3111.797733147338, 3134.2164458885277, 3140.0, 3159.1786135604907, 214460.0, 215482.0, 215700.0, 215719.0, 215852.0, 39791.80104099461, 40217.0, 40511.0, 50918.23622645663, 51211.0, 37408.0, 37549.62450375461, 37552.0, 37820.81089594589, 37913.81043094767, 12181.269123852597, 12185.573504927284, 12280.692982675326, 12304.692382690504, 12322.507099715911, 10192.0, 10199.18406527476, 10290.536925838354, 10310.793784124275, 10342.224333175041, 13344.199348038954, 13557.86442135566, 13856.237906915216, 13878.306084695725, 13918.791218131737, 5433.701146436905, 5521.779128834882, 5540.0, 5551.72241387929, 5628.240187574625, 911.2391153386864, 919.839052972605, 932.8554074118387, 969.60730903984, 980.07872599756, 26568.601470977952, 27018.1894543164, 27061.0, 27134.728652713617, 27236.59145112825, 943.580106852444, 946.0019679238331, 969.147150507563, 983.8425851863667, 1003.6286573967678, 13905.930470347583, 14021.579352619437, 14174.433022678977, 14325.426982920566, 14329.35517901697, 263077.0, 264475.0, 266061.0, 267619.0, 268196.0, 45743.77128114338, 46172.307415388794, 46435.767821160676, 46497.53502464932, 46504.0, 1176.670532250971, 1180.2859270141612, 1193.8985186259265, 1194.098455665984, 1311.9540816071392, 25560.10539631104, 26153.346166345993, 26203.868980655738, 26516.337091572866, 26542.469150617264, 40641.1871762569, 41044.0, 41062.79468602638, 41071.589284106776, 41120.0, 250095.0, 250738.0, 250819.0, 251847.0, 252401.0, 25432.872835635702, 25942.48115037651, 29517.852410737807, 29728.878467760573, 30053.098407047823, 43209.35185972276, 43572.78213608912, 43649.78175109104, 43953.78023109864, 44029.55970440255, 30871.854652697613, 31145.532817007308, 33328.33343333168, 34912.127196820285, 35104.64895351116, 33690.663093368756, 33933.830330848185, 34113.658863411045, 34167.82916085503, 34224.14439639029, 33427.83286083554, 34105.0, 34567.4814877772, 34654.65345346615, 34721.47917781286, 30012.0, 31226.531602026444, 31285.0, 31432.214194645316, 31584.684153158174, 24037.278881633578, 24304.878475607507, 24314.51370972606, 24441.144559940316, 24686.753132468446], "unit": "score", "name": "ext.html", "value": 16155.103307660207}, {"lowerIsBetter": false, "replicates": [326.5412096005112, 331.52757320817835, 332.89513803152005, 334.79912052768327, 335.6660123177439, 14920.328585213665, 15438.922805385972, 15691.215439228035, 15712.371505139809, 16194.109323987175, 9788.755281117976, 10082.193424526038, 12816.23102613844, 14642.194679292634, 14710.0, 4366.345048242773, 4385.868423947287, 4444.311131774564, 4524.479684836253, 4535.954640453603, 4422.181896349186, 4435.223835828733, 4435.756033418161, 4439.089986552765, 4445.733256004634, 4398.670099742532, 4415.050764085721, 5269.2886460327745, 5444.482774136451, 5448.019356515825, 5088.465711100355, 5466.098093814516, 5478.671279723209, 5493.340799104133, 5508.6970216638065, 5000.574951129159, 5016.147254966664, 5047.848564543069, 5051.52010559, 5067.290579318898, 11019.449027548671, 11155.219134660578, 15486.380544778196, 19137.13882875274, 19281.903590481958, 1656.6189776351387, 1691.5432833134985, 1775.2366482412558, 1795.8293962073712, 1898.8670793044491, 8880.8667869982, 8880.911190888137, 9107.180353768194, 10517.789644207149, 12838.871611283861, 1738.1830539646346, 1755.2013833705632, 1775.5117342730853, 1801.675698374292, 1841.558026073746, 53955.46044539544, 54781.45218547803, 55591.72204138994, 57556.0, 57666.42333576652, 9552.235821134293, 9931.155851752537, 9935.552900119512, 9942.204623630092, 9996.150327222267, 12501.187422817487, 12506.499740010298, 12522.123451358317, 12540.0, 12545.12184147101, 6724.798256052326, 6754.5947243165565, 6774.45804335652, 6793.252742198354, 6804.4216241620015, 6055.909161362583, 6080.4527592516, 6085.4523092921845, 6122.785702500391, 6160.537959653044, 3793.279276937373, 3799.430085487144, 4039.313316736103, 4144.91710165795, 4200.243956087934, 1604.7111519926525, 1708.880378373502, 1739.8347157020062, 1772.8670349723823, 1784.857211423083, 706.2443185791257, 783.561205724796, 823.9906115009186, 877.2587163846539, 926.1479438916078, 9895.158911492459, 9984.500774961369, 14281.214533200566, 14746.262686865613, 14943.402263909322, 369.8908821897547, 379.08829265616237, 381.0492820413087, 386.26416676231264, 386.47825435661633, 5092.668976516515, 5253.369595648546, 5343.946560534423, 5376.220448035013, 5447.836564903059, 496342.0, 500138.0, 501128.0, 501543.0, 523252.0, 76460.61769691228, 77327.0, 77660.83508747374, 77903.61048194836, 79135.0, 420.6928941872389, 423.267746798035, 424.4249042547304, 425.98296068156924, 426.0881713133896, 9184.770380740534, 9342.112499312554, 9437.669681561387, 9491.715248542554, 9517.048295170427, 33531.32937341288, 34377.31245375029, 35896.28207435889, 36300.81849590841, 36723.0, 45456.0, 47022.82442938954, 48089.27866082082, 48220.27669584889, 50048.49951500438, 8543.145685431407, 8802.735917922473, 8866.911330886609, 8896.555172241233, 8904.777380565538, 10179.643712470324, 10312.742181445525, 12015.819762703391, 16665.833341666912, 16913.66172676564, 13200.273984930922, 13255.469781208643, 13865.930670346585, 13886.444542218198, 13920.0, 12962.67593310137, 13132.606021819362, 13640.727185456433, 13741.519046833313, 13897.51358702481, 13630.795538067136, 13763.931180344034, 14054.227017513726, 14215.857841421453, 14327.856721432652, 8492.915070849212, 8629.8705519416, 9316.813663726824, 9363.578638961399, 9385.343025988388, 13725.794113088112, 14022.0, 14273.57179284623, 14300.0, 14319.642008949859], "unit": "score", "name": "jquery.html", "value": 7521.071392833936}, {"lowerIsBetter": false, "replicates": [1364.1814911053366, 1377.2149874571494, 1497.1915165810462, 1691.036109417631, 1708.1032457959577, 5874.412558744123, 5969.0, 7070.4343652507805, 7190.245024272454, 7193.24470930552, 6618.470522358211, 6669.19969603647, 6719.49603779716, 6786.694598743056, 6802.523823332369, 2016.4555569996128, 2048.0783647358676, 2051.466618679139, 2051.774304826468, 2053.7227474291003, 1972.4871533401347, 1986.5927484865567, 1992.6114407690507, 2003.7495313085865, 2005.3282150479533, 2017.3746138696977, 2053.5892821435773, 2066.070268379235, 2070.8032736890045, 2076.563921576471, 2049.3646969439446, 2050.6821442676483, 2061.8762874227596, 2066.3697572240612, 2073.8237249833783, 2060.6908963655424, 2085.8748475091543, 2089.958200835975, 2093.9476513087293, 2099.496120930981, 7088.362047415706, 7098.929010709879, 7143.392811611019, 7143.749968751069, 7194.604296763676, 4225.830966761357, 4328.567143285646, 4340.045190058182, 4340.65274778017, 4342.109867477159, 2617.5550156473255, 2633.868306584663, 2655.8406495610325, 2695.7573818356245, 2707.2284398946404, 839.890814194157, 846.7417437681505, 861.4917198852708, 862.4351050062219, 867.8871746672892, 9533.0, 9606.375585586984, 9612.327137100407, 9620.278479114095, 9683.515824208762, 3918.5101862267215, 3931.233409485123, 3932.311845427039, 3944.3886197639413, 3990.082281075369, 8181.159239171139, 8261.421700480909, 8269.338452923752, 8274.793130171673, 8294.0, 4338.110687309094, 4348.7390756554705, 4370.278903980808, 4372.978135109368, 4374.147041326974, 3207.5990501187352, 3272.689094536015, 3824.808759562011, 3920.5883382245024, 3960.663343615767, 3437.329720704439, 3438.329525742506, 3468.5490886184634, 3480.129967508123, 3516.507688923553, 1099.455769394139, 1102.1788767368362, 1107.7175320293275, 1111.8332250162541, 1120.9215354925077, 909.663424532927, 966.3187452845727, 1154.7979103656826, 1164.6564263542275, 1188.423614546944, 6628.072069910217, 6681.365270299314, 6681.832954176088, 6697.598144111369, 6707.765228216989, 1006.3257617396362, 1013.6148263659762, 1021.7956408718286, 1030.8402197659375, 1032.695354870315, 5306.336707911511, 5317.813876514303, 5320.388155362183, 5363.919541206885, 5370.731463426891, 8167.714130005421, 8194.34445244391, 8305.792355191168, 8328.875066874001, 8557.614907329185, 8157.265846073882, 8172.264496195252, 8208.876866847002, 8219.54792486407, 8240.958795205986, 6559.672016399161, 6604.2074951005225, 6680.465562754968, 6697.531172817953, 6706.128203333633, 6638.90041649366, 6692.1969363674725, 6695.631740254138, 6700.162479690039, 6719.126513553207, 7465.850682986418, 7467.514611550232, 7750.147483776667, 7794.2985131338455, 7889.053313602175, 7762.8447431049935, 7915.762527124196, 7953.0, 7968.880466793119, 8062.516249025077, 5277.2875661785165, 5364.4099149094345, 5925.259342582177, 6085.391460853879, 6086.239220097488, 6468.579542329921, 6506.674666266573, 6533.575317604341, 6539.411452969255, 6539.803805885831, 5987.401259873977, 6116.816495505142, 6175.4750846176785, 6186.938130618636, 6213.099100630474, 6137.1101190328045, 6178.289496707756, 6191.907121393273, 6294.0558916162945, 6305.117283580211, 6224.657643829451, 6331.493480521639, 6335.239771227482, 6338.207724034496, 6340.1123842661145, 5794.101914203306, 5807.448292412214, 5828.388019258086, 5835.94164058354, 5846.181534585076, 5857.882842343044, 5859.326177489473, 5868.618539794899, 5873.911891321548, 5932.139839723302], "unit": "score", "name": "mootools.html", "value": 4049.8729574022555}, {"lowerIsBetter": false, "replicates": [292.35389788567267, 298.4121281076279, 306.33678086941774, 306.49581438533613, 311.16297160637896, 5501.724913754317, 5556.361018482876, 5599.216109744629, 5600.355959064709, 5676.858078548038, 5558.833235002946, 5560.749766260518, 5578.0, 5583.134614134816, 5584.385717571064, 4112.465379500661, 4268.701190916637, 4271.829126834923, 4278.871633850989, 4293.463317085364, 4159.292920203573, 4175.0, 4176.60322269384, 4187.51843537994, 4194.517630472489, 4131.7934103294865, 4132.090939993212, 4135.565765594614, 4136.048708796979, 4143.0, 4155.58444155585, 4171.311733563958, 4173.97913010433, 4181.435506206669, 4192.916141677179, 3617.3127105850067, 3629.691476224524, 3629.7096232301615, 3633.6003039665616, 3637.8726744563814, 5109.156989096795, 5174.353205849269, 5215.322008138955, 5237.292965449654, 5297.231901374279, 4761.880952976168, 4792.904141917177, 4803.543663351976, 4808.711477311373, 4811.975940120312, 5809.3609702932645, 5811.476967072941, 5818.854528636775, 5834.154047663107, 5845.503132233765, 3867.091233560111, 3931.174453364797, 3944.684425245973, 3945.9802700986597, 3947.5262968443685, 6031.698415079272, 6113.847153821145, 6150.477209437203, 6160.969195154041, 6164.630122192682, 4036.798160091984, 4073.572274911151, 4075.286824805647, 4078.163976384834, 4082.6937979651643, 4093.406456063854, 4122.0, 4129.091599848029, 4135.731177473454, 4149.232392007489, 4689.015306785614, 4785.808567657325, 4793.832215872428, 4797.304390863305, 4798.760061996886, 5810.157527158538, 5823.505002074871, 5829.475347218686, 5831.154482599999, 5839.270091238595, 1436.3249272841747, 1454.8763355114934, 1455.8325792533994, 1460.3574427251974, 1462.992685036568, 949.8432758594754, 971.2861047130353, 971.7522031881825, 981.6073570571829, 988.5452691761726, 5010.749462526859, 5023.572996295283, 5086.0, 5087.389513258433, 5093.643444958817, 5985.880282394415, 6049.001914684116, 6061.212042434543, 6062.969685151546, 6100.779844031212, 5076.74616269185, 5081.23781432788, 5081.5426611605135, 5095.617828662865, 5098.056859481007, 3206.8717251310154, 3256.348730253959, 3272.590926134233, 3288.93422131556, 3299.4390953537954, 5782.855428614234, 5803.216565763652, 5819.79630712923, 5824.912626310609, 5826.329972053183, 6000.549958753111, 6033.3966603340195, 6090.299615544181, 6229.314775374705, 6235.251769787655, 5818.069108942549, 5818.44724751148, 5860.267466566679, 5868.559858010581, 5871.882562348729, 6087.36082711309, 6124.326324104256, 6133.815985520441, 6139.969300153471, 6152.969235153795, 5734.111212762028, 5896.70516474166, 5936.228290322403, 5939.792107276225, 5994.460498555151, 5827.970860145672, 5840.737166827418, 5870.090136028923, 5878.29460464747, 5881.5588830837005, 4011.9799401003975, 4060.5127384714024, 4063.7764922929523, 4066.877993660195, 4086.407470916641, 6006.819795406145, 6114.113453549299, 6130.877382452415, 6138.294096178996, 6152.200213972155, 5858.297004359504, 5890.528757699288, 5892.499137573354, 5903.763849445974, 5909.6158749681135, 5886.293644762656, 5888.882222355614, 5909.556783241188, 5910.468057874812, 5914.053751399755, 5621.80323688669, 5739.139129130664, 5761.683107429131, 5779.479846813807, 5789.2763404574425, 5923.614965027259, 5936.851578710567, 5937.821865344046, 5950.5239580834295, 5951.642901425928, 5787.9710601448405, 5794.5364370851075, 5800.738966746591, 5806.0, 5809.153514777813], "unit": "score", "name": "prototype.html", "value": 4344.895309523617}, {"lowerIsBetter": false, "replicates": [714.4177495341296, 718.1489934427703, 740.8296091898864, 770.8959290495785, 790.8418316336727, 10578.418186999712, 10827.891721082806, 10864.022237998579, 10882.945585272062, 10892.074173695235, 11416.771664566704, 11430.199886007982, 11453.083753299738, 11465.713357166074, 11504.769904601924, 759.8822182561684, 768.6848392159216, 778.7546922719354, 781.7889169924117, 782.538302401583, 767.2404319723489, 767.7619937819294, 770.8458308338327, 772.5789444752595, 777.1296148313868, 810.7973006748313, 813.8860559521672, 820.0159808230147, 821.5727821532829, 824.9752507424787, 807.9717209897655, 810.266708628692, 812.0134037144838, 814.9022117345957, 815.2581151152452, 609.6860117039728, 613.6256883301182, 613.9478144357735, 614.0788816774838, 614.2230078950132, 11640.06879449642, 11666.708332291675, 11693.181477296592, 11716.0, 11810.822837657443, 10987.890121098846, 11063.502142403611, 11180.832287515694, 11550.191486595942, 11796.174267801258, 8536.530490823003, 8748.212660860552, 9123.726288211365, 9126.543672816399, 9166.541672916328, 3085.197848559391, 3124.4844600640868, 3125.343677827659, 3132.843357832099, 3182.3635272945503, 39888.20223595541, 40276.0, 40334.79832600818, 40363.394549081786, 40456.797716011526, 8846.867296990551, 8945.776355591162, 9142.588583513758, 9149.588268527932, 9250.768730781785, 15952.20238988046, 15998.120103394192, 16008.439704610515, 16020.439284625216, 16035.358585656442, 5774.451427114417, 5883.529317654577, 5901.29184497863, 6059.484943779828, 6101.298350689639, 3445.2937147884622, 3497.965020349764, 3558.893233203008, 3585.8027808470783, 3600.567931848195, 2734.917952461429, 2739.9589006164924, 2758.544840101361, 2766.5573508238585, 2770.293575138367, 472.84396149271345, 477.067333363274, 485.3084354794404, 485.4562889563711, 485.50721018166587, 482.8599706085196, 537.9273798037215, 545.7762317449906, 566.8894565559759, 583.4369833110983, 6863.519553631198, 6935.306469353024, 6958.686859091353, 7055.400290975324, 7072.68172932209, 584.3171665603036, 587.9441453061952, 590.5570821883588, 596.1415561591381, 607.3683369295971, 3311.430226287756, 3376.409128402569, 3421.863125474953, 3425.8972230833115, 3526.400511912981, 48875.0, 49285.26072108921, 49478.257826132634, 49557.50442495601, 49611.25583116256, 43562.346564801555, 43777.781111094875, 44558.55441445544, 44836.3274550882, 45012.54987450149, 40063.79968100199, 40180.598194017686, 40572.0, 41851.58148418477, 41923.0, 6635.966820165868, 6651.368120028589, 6813.829654258683, 8068.919310807051, 8164.795880102807, 29990.0, 30674.233144171576, 30847.0, 30896.845515773177, 31205.53191702081, 37737.05657358588, 38110.0, 38623.0, 38636.61363386443, 38910.80544597259, 9909.55407006672, 10228.948855255676, 10299.536520856429, 10401.895981040092, 10600.787984240425, 11265.831012534654, 11399.544018239178, 11415.37215453158, 11780.882191178322, 12144.453499592362, 10576.312539684895, 10697.786044279226, 10898.50956706966, 10973.067289280181, 11073.944630276797, 10799.892001079888, 10988.615398461016, 11293.7741245173, 11498.25261358009, 11562.595309164139, 9153.816923661623, 10624.946875265574, 10717.9464102679, 10815.789997809234, 10879.456027198767, 7257.854842903007, 8408.621612027351, 8668.263197628272, 8685.913140868763, 8740.60667269987, 8995.910040899507, 9017.09829017093, 9139.954300228455, 9148.451092934445, 9174.0], "unit": "score", "name": "yui.html", "value": 5612.421399608352}], "name": "dromaeo_css", "value": 6194.575553491688}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 113.0, 113.0, 112.0, 125.0, 113.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [157.0, 128.0, 156.0, 161.0, 130.0, 164.0, 162.0, 140.0, 174.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 161.0, 163.0, 165.0, 163.0, 166.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 72.0, 72.0, 72.0, 140.0, 72.0, 73.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 134.0, 98.0, 98.0, 98.0, 130.0, 98.0, 97.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 101.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 70.0, 74.0, 71.0, 70.0, 70.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 67.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 87.0, 85.0, 86.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 119.0, 129.0, 144.0, 128.0, 123.0, 125.0, 134.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.0}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 151.0, 144.0, 147.0, 135.0, 151.0, 147.0, 147.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 72.0, 72.0, 69.0, 69.0, 70.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1534.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [186.01190476190476], "unit": "score", "name": "DeltaBlue", "value": 355.4503679999999}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [734.4093910491563], "unit": "score", "name": "Earley", "value": 907.4815874125878}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [26076.923076923078], "unit": "score", "name": "RegExp", "value": 34.934528023598794}, {"lowerIsBetter": false, "replicates": [606.4281382656155], "unit": "score", "name": "Splay", "value": 134.37865900000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21221.4671863158}]} 04:29:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21221.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1534.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6194.57"}}} 04:29:59 INFO - Return code: 0 04:29:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:59 INFO - # TBPL SUCCESS # 04:29:59 INFO - Running post-action listener: _resource_record_post_action 04:29:59 INFO - Running post-run listener: _resource_record_post_run 04:30:01 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555819008; Read time: 60; Write time: 547440 04:30:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238592000; Read time: 0; Write time: 315300 04:30:01 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8192; Write bytes: 316362752; Read time: 60; Write time: 231868 04:30:01 INFO - Running post-run listener: _upload_blobber_files 04:30:01 INFO - Blob upload gear active. 04:30:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:01 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 04:30:01 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'] 04:30:01 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 04:30:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:30:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:02 INFO - (blobuploader) - INFO - Done attempting. 04:30:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:30:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:30:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:03 INFO - (blobuploader) - INFO - Done attempting. 04:30:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:03 INFO - Return code: 0 04:30:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2ae2db9cd49e482216dfd5aa624ff8bc4f1893ec887931ed3a6ee7f0ad868c496ea87204d3ddd02b98274d2a637ccd9fd8d6eccb1ca813994fb5e0b4fcc41b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f497278fa5bb7584fcb477c747e00aa1f9af7c64d9ec9cd465fe9001f176d8141ad2363597c7ec18b8419b99ef1d07a13fc802df97c16ac343d640e3b08a150"} 04:30:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:03 INFO - Contents: 04:30:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2ae2db9cd49e482216dfd5aa624ff8bc4f1893ec887931ed3a6ee7f0ad868c496ea87204d3ddd02b98274d2a637ccd9fd8d6eccb1ca813994fb5e0b4fcc41b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f497278fa5bb7584fcb477c747e00aa1f9af7c64d9ec9cd465fe9001f176d8141ad2363597c7ec18b8419b99ef1d07a13fc802df97c16ac343d640e3b08a150"} 04:30:03 INFO - Copying logs to upload dir... 04:30:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.846861 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-29 04:30:02.732087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 04:30:02.739831) ========= 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=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2ae2db9cd49e482216dfd5aa624ff8bc4f1893ec887931ed3a6ee7f0ad868c496ea87204d3ddd02b98274d2a637ccd9fd8d6eccb1ca813994fb5e0b4fcc41b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f497278fa5bb7584fcb477c747e00aa1f9af7c64d9ec9cd465fe9001f176d8141ad2363597c7ec18b8419b99ef1d07a13fc802df97c16ac343d640e3b08a150"} build_url:https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/ixTYz5umQjySXKr8Ws7S7w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2ae2db9cd49e482216dfd5aa624ff8bc4f1893ec887931ed3a6ee7f0ad868c496ea87204d3ddd02b98274d2a637ccd9fd8d6eccb1ca813994fb5e0b4fcc41b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f497278fa5bb7584fcb477c747e00aa1f9af7c64d9ec9cd465fe9001f176d8141ad2363597c7ec18b8419b99ef1d07a13fc802df97c16ac343d640e3b08a150"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 04:30:02.763462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:30:02.763773) ========= 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=fdc9337702648c539b2c5dbe000001aa-1451390835.412191-2005148829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:30:02.815110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 04:30:02.815412) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 04:30:02.817726) ========= ========= Total master_lag: 0.47 =========