builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1447647725.06 results: success (0) buildid: 20151115191231 builduid: 045a1cda90304457b30f4a23071b2f41 revision: bc74dbdea094059d5f1d353a2585b4f6352b6ec4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.059288) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.059852) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.060214) ========= 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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006414 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.081342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.081668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.109595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.109904) ========= 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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.166913) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.167250) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.167650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.167985) ========= 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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 20:22:06-- 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% 43.5M=0s 2015-11-15 20:22:06 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.357410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.357736) ========= 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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015167 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.407073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:05.407473) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc74dbdea094059d5f1d353a2585b4f6352b6ec4 --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 bc74dbdea094059d5f1d353a2585b4f6352b6ec4 --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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 20:22:06,527 truncating revision to first 12 chars 2015-11-15 20:22:06,527 Setting DEBUG logging. 2015-11-15 20:22:06,527 attempt 1/10 2015-11-15 20:22:06,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc74dbdea094?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 20:22:07,121 unpacking tar archive at: mozilla-central-bc74dbdea094/testing/mozharness/ program finished with exit code 0 elapsedTime=0.864756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:06.286646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:06.286997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:06.296590) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:06.296901) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 20:22:06.300050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-15 20:22:06.300404) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:22:07 INFO - MultiFileLogger online at 20151115 20:22:07 in /builds/slave/test 20:22:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:22:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:22:07 INFO - {'append_to_log': False, 20:22:07 INFO - 'base_work_dir': '/builds/slave/test', 20:22:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:22:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:22:07 INFO - 'branch': 'Firefox-Non-PGO', 20:22:07 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:07 INFO - 'config_files': ('talos/linux_config.py',), 20:22:07 INFO - 'default_actions': ('clobber', 20:22:07 INFO - 'read-buildbot-config', 20:22:07 INFO - 'download-and-extract', 20:22:07 INFO - 'populate-webroot', 20:22:07 INFO - 'create-virtualenv', 20:22:07 INFO - 'install', 20:22:07 INFO - 'run-tests'), 20:22:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:07 INFO - 'download_minidump_stackwalk': True, 20:22:07 INFO - 'download_symbols': 'ondemand', 20:22:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:07 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:07 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:07 INFO - 'installer_path': 'installer.exe', 20:22:07 INFO - 'log_level': 'info', 20:22:07 INFO - 'log_name': 'talos', 20:22:07 INFO - 'log_to_console': True, 20:22:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:22:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:22:07 INFO - 'opt_config_files': (), 20:22:07 INFO - 'pip_index': False, 20:22:07 INFO - 'sps_profile': False, 20:22:07 INFO - 'sps_profile_interval': 0, 20:22:07 INFO - 'suite': 'dromaeojs', 20:22:07 INFO - 'system_bits': '64', 20:22:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:07 INFO - 'title': 'talos-linux64-ix-048', 20:22:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:07 INFO - 'use_talos_json': True, 20:22:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:22:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:07 INFO - 'work_dir': 'build'} 20:22:07 INFO - ##### 20:22:07 INFO - ##### Running clobber step. 20:22:07 INFO - ##### 20:22:07 INFO - Running pre-action listener: _resource_record_pre_action 20:22:07 INFO - Running main action method: clobber 20:22:07 INFO - rmtree: /builds/slave/test/build 20:22:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:22:07 INFO - Running post-action listener: _resource_record_post_action 20:22:07 INFO - ##### 20:22:07 INFO - ##### Running read-buildbot-config step. 20:22:07 INFO - ##### 20:22:07 INFO - Running pre-action listener: _resource_record_pre_action 20:22:07 INFO - Running main action method: read_buildbot_config 20:22:07 INFO - Using buildbot properties: 20:22:07 INFO - { 20:22:07 INFO - "properties": { 20:22:07 INFO - "buildnumber": 214, 20:22:07 INFO - "product": "firefox", 20:22:07 INFO - "script_repo_revision": "production", 20:22:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:22:07 INFO - "repository": "", 20:22:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:22:07 INFO - "buildid": "20151115191231", 20:22:07 INFO - "slavename": "talos-linux64-ix-048", 20:22:07 INFO - "pgo_build": "False", 20:22:07 INFO - "basedir": "/builds/slave/test", 20:22:07 INFO - "project": "", 20:22:07 INFO - "platform": "ubuntu64_hw", 20:22:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:22:07 INFO - "slavebuilddir": "test", 20:22:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:22:07 INFO - "branch": "mozilla-central", 20:22:07 INFO - "repo_path": "mozilla-central", 20:22:07 INFO - "stage_platform": "linux64", 20:22:07 INFO - "builduid": "045a1cda90304457b30f4a23071b2f41", 20:22:07 INFO - "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4" 20:22:07 INFO - }, 20:22:07 INFO - "sourcestamp": { 20:22:07 INFO - "repository": "", 20:22:07 INFO - "hasPatch": false, 20:22:07 INFO - "project": "", 20:22:07 INFO - "branch": "mozilla-central-linux64-talos", 20:22:07 INFO - "changes": [ 20:22:07 INFO - { 20:22:07 INFO - "category": null, 20:22:07 INFO - "files": [ 20:22:07 INFO - { 20:22:07 INFO - "url": null, 20:22:07 INFO - "name": "https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:22:07 INFO - } 20:22:07 INFO - ], 20:22:07 INFO - "repository": "", 20:22:07 INFO - "rev": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4", 20:22:07 INFO - "who": "philringnalda@gmail.com", 20:22:07 INFO - "when": 1447647649, 20:22:07 INFO - "number": 6664613, 20:22:07 INFO - "comments": "Bug 1223394 - skip more failing webspeech tests on Mulet, a=tlast", 20:22:07 INFO - "project": "", 20:22:07 INFO - "at": "Sun 15 Nov 2015 20:20:49", 20:22:07 INFO - "branch": "mozilla-central-linux64-talos", 20:22:07 INFO - "revlink": "", 20:22:07 INFO - "properties": [ 20:22:07 INFO - [ 20:22:07 INFO - "buildid", 20:22:07 INFO - "20151115191231", 20:22:07 INFO - "Change" 20:22:07 INFO - ], 20:22:07 INFO - [ 20:22:07 INFO - "builduid", 20:22:07 INFO - "045a1cda90304457b30f4a23071b2f41", 20:22:07 INFO - "Change" 20:22:07 INFO - ], 20:22:07 INFO - [ 20:22:07 INFO - "pgo_build", 20:22:07 INFO - "False", 20:22:07 INFO - "Change" 20:22:07 INFO - ] 20:22:07 INFO - ], 20:22:07 INFO - "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4" 20:22:07 INFO - } 20:22:07 INFO - ], 20:22:07 INFO - "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4" 20:22:07 INFO - } 20:22:07 INFO - } 20:22:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:22:07 INFO - Running post-action listener: _resource_record_post_action 20:22:07 INFO - ##### 20:22:07 INFO - ##### Running download-and-extract step. 20:22:07 INFO - ##### 20:22:07 INFO - Running pre-action listener: _resource_record_pre_action 20:22:07 INFO - Running main action method: download_and_extract 20:22:07 INFO - mkdir: /builds/slave/test/build/tests 20:22: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')]} 20:22:07 INFO - https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/test_packages.json 20:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/test_packages.json 20:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:22:08 INFO - Downloaded 1302 bytes. 20:22:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:22:08 INFO - Using the following test package requirements: 20:22:08 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:08 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:22:08 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:08 INFO - u'jsshell-linux-x86_64.zip'], 20:22:08 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:22:08 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:08 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:22:08 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:22:08 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:22:08 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:08 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:08 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:22:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:08 INFO - https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:22:09 INFO - Downloaded 21278074 bytes. 20:22:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:22:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:22:10 INFO - Return code: 0 20:22:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:22:10 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')]} 20:22:10 INFO - https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:22:11 INFO - Downloaded 21278074 bytes. 20:22:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:22:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:22:12 INFO - Return code: 0 20:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:12 INFO - https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:22:13 INFO - Downloaded 11131693 bytes. 20:22:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 20:22:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:22:13 INFO - Return code: 0 20:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:13 INFO - https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:22:15 INFO - Downloaded 55595764 bytes. 20:22:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:15 INFO - mkdir: /builds/slave/test/properties 20:22:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:22:15 INFO - Writing to file /builds/slave/test/properties/build_url 20:22:15 INFO - Contents: 20:22:15 INFO - build_url:https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:15 INFO - Running post-action listener: _resource_record_post_action 20:22:15 INFO - Running post-action listener: set_extra_try_arguments 20:22:15 INFO - ##### 20:22:15 INFO - ##### Running populate-webroot step. 20:22:15 INFO - ##### 20:22:15 INFO - Running pre-action listener: _resource_record_pre_action 20:22:15 INFO - Running main action method: populate_webroot 20:22:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:22:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:22:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:22:15 INFO - '../fennec_ids.txt'], 20:22:15 INFO - 'tests': ['tcheck2']}, 20:22:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:22:15 INFO - '--tppagecycles', 20:22:15 INFO - '7'], 20:22:15 INFO - 'tests': ['tsvgm']}}, 20:22:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:22:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:22:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:22:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:22:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'tests': ['damp', 'tps']}, 20:22:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['damp', 'tps']}, 20:22:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:22:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:22:15 INFO - 'other': {'tests': ['a11yr', 20:22:15 INFO - 'ts_paint', 20:22:15 INFO - 'tpaint', 20:22:15 INFO - 'sessionrestore', 20:22:15 INFO - 'sessionrestore_no_auto_restore']}, 20:22:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['a11yr', 20:22:15 INFO - 'ts_paint', 20:22:15 INFO - 'tpaint', 20:22:15 INFO - 'sessionrestore', 20:22:15 INFO - 'sessionrestore_no_auto_restore']}, 20:22:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['a11yr', 20:22:15 INFO - 'ts_paint', 20:22:15 INFO - 'tpaint', 20:22:15 INFO - 'sessionrestore', 20:22:15 INFO - 'sessionrestore_no_auto_restore']}, 20:22:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['a11yr', 20:22:15 INFO - 'ts_paint', 20:22:15 INFO - 'tpaint', 20:22:15 INFO - 'sessionrestore', 20:22:15 INFO - 'sessionrestore_no_auto_restore']}, 20:22:15 INFO - 'other_l64': {'tests': ['a11yr', 20:22:15 INFO - 'ts_paint', 20:22:15 INFO - 'tpaint', 20:22:15 INFO - 'sessionrestore', 20:22:15 INFO - 'sessionrestore_no_auto_restore']}, 20:22:15 INFO - 'other_nol64': {'tests': ['a11yr', 20:22:15 INFO - 'ts_paint', 20:22:15 INFO - 'tpaint', 20:22:15 INFO - 'sessionrestore', 20:22:15 INFO - 'sessionrestore_no_auto_restore']}, 20:22:15 INFO - 'svgr': {'tests': ['tsvgx', 20:22:15 INFO - 'tsvgr_opacity', 20:22:15 INFO - 'tart', 20:22:15 INFO - 'tscrollx', 20:22:15 INFO - 'cart']}, 20:22:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['tsvgx', 20:22:15 INFO - 'tsvgr_opacity', 20:22:15 INFO - 'tart', 20:22:15 INFO - 'tscrollx', 20:22:15 INFO - 'cart']}, 20:22:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'tests': ['tp5o']}, 20:22:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'talos_options': ['--e10s'], 20:22:15 INFO - 'tests': ['tp5o']}, 20:22:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'talos_options': ['--xperf_path', 20:22:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:15 INFO - 'tests': ['tp5n']}, 20:22:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:15 INFO - 'talos_options': ['--e10s', 20:22:15 INFO - '--xperf_path', 20:22:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:15 INFO - 'tests': ['tp5n']}}, 20:22:15 INFO - 'talos.zip': {'path': '', 20:22:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:22:15 INFO - Running post-action listener: _resource_record_post_action 20:22:15 INFO - ##### 20:22:15 INFO - ##### Running create-virtualenv step. 20:22:15 INFO - ##### 20:22:15 INFO - Running pre-action listener: _resource_record_pre_action 20:22:15 INFO - Running main action method: create_virtualenv 20:22:15 INFO - Creating virtualenv /builds/slave/test/build/venv 20:22:15 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 20:22:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:22:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:22:15 INFO - Using real prefix '/usr' 20:22:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:22:15 INFO - Installing distribute.............................................................................................................................................................................................done. 20:22:17 INFO - Installing pip.................done. 20:22:17 INFO - Return code: 0 20:22:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:17 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 0x7f70e5787c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, '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-1447642009.609266-1255954101', '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 20:22:17 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 20:22:17 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 20:22:17 INFO - Using env: {'DISPLAY': ':0', 20:22:17 INFO - 'HOME': '/home/cltbld', 20:22:17 INFO - 'LANG': 'en_US.UTF-8', 20:22:17 INFO - 'LANGUAGE': 'en_US:en', 20:22:17 INFO - 'LOGNAME': 'cltbld', 20:22:17 INFO - 'MAIL': '/var/mail/cltbld', 20:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:17 INFO - 'MOZ_NO_REMOTE': '1', 20:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:17 INFO - 'NO_EM_RESTART': '1', 20:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:17 INFO - 'PWD': '/builds/slave/test', 20:22:17 INFO - 'SHELL': '/bin/bash', 20:22:17 INFO - 'SHLVL': '1', 20:22:17 INFO - 'TERM': 'linux', 20:22:17 INFO - 'TMOUT': '86400', 20:22:17 INFO - 'USER': 'cltbld', 20:22:17 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:17 INFO - '_': '/tools/buildbot/bin/python'} 20:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:18 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 20:22:18 INFO - Cleaning up... 20:22:18 INFO - Return code: 0 20:22:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:22: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')]} 20:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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', '--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 0x7f70e5787c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, '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-1447642009.609266-1255954101', '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 20:22:18 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 20:22:18 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 20:22:18 INFO - Using env: {'DISPLAY': ':0', 20:22:18 INFO - 'HOME': '/home/cltbld', 20:22:18 INFO - 'LANG': 'en_US.UTF-8', 20:22:18 INFO - 'LANGUAGE': 'en_US:en', 20:22:18 INFO - 'LOGNAME': 'cltbld', 20:22:18 INFO - 'MAIL': '/var/mail/cltbld', 20:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:18 INFO - 'MOZ_NO_REMOTE': '1', 20:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:18 INFO - 'NO_EM_RESTART': '1', 20:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:18 INFO - 'PWD': '/builds/slave/test', 20:22:18 INFO - 'SHELL': '/bin/bash', 20:22:18 INFO - 'SHLVL': '1', 20:22:18 INFO - 'TERM': 'linux', 20:22:18 INFO - 'TMOUT': '86400', 20:22:18 INFO - 'USER': 'cltbld', 20:22:18 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:18 INFO - '_': '/tools/buildbot/bin/python'} 20:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:18 INFO - Downloading/unpacking psutil>=0.7.1 20:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:22:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:22:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:20 INFO - Installing collected packages: psutil 20:22:20 INFO - Running setup.py install for psutil 20:22:20 INFO - building 'psutil._psutil_linux' extension 20:22:20 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 20:22:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:22:20 INFO - building 'psutil._psutil_posix' extension 20:22:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:22:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:22:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:20 INFO - Successfully installed psutil 20:22:20 INFO - Cleaning up... 20:22:20 INFO - Return code: 0 20:22:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:20 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 0x7f70e5787c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, '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-1447642009.609266-1255954101', '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 20:22:20 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 20:22:20 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 20:22:20 INFO - Using env: {'DISPLAY': ':0', 20:22:20 INFO - 'HOME': '/home/cltbld', 20:22:20 INFO - 'LANG': 'en_US.UTF-8', 20:22:20 INFO - 'LANGUAGE': 'en_US:en', 20:22:20 INFO - 'LOGNAME': 'cltbld', 20:22:20 INFO - 'MAIL': '/var/mail/cltbld', 20:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:20 INFO - 'MOZ_NO_REMOTE': '1', 20:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:20 INFO - 'NO_EM_RESTART': '1', 20:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:20 INFO - 'PWD': '/builds/slave/test', 20:22:20 INFO - 'SHELL': '/bin/bash', 20:22:20 INFO - 'SHLVL': '1', 20:22:20 INFO - 'TERM': 'linux', 20:22:20 INFO - 'TMOUT': '86400', 20:22:20 INFO - 'USER': 'cltbld', 20:22:20 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:20 INFO - '_': '/tools/buildbot/bin/python'} 20:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:22:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:22:22 INFO - Installing collected packages: mozsystemmonitor 20:22:22 INFO - Running setup.py install for mozsystemmonitor 20:22:22 INFO - Successfully installed mozsystemmonitor 20:22:22 INFO - Cleaning up... 20:22:22 INFO - Return code: 0 20:22:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:22: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')]} 20:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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', '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 0x7f70e5787c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, '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-1447642009.609266-1255954101', '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 20:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:22: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 blobuploader==1.2.4 20:22:22 INFO - Using env: {'DISPLAY': ':0', 20:22:22 INFO - 'HOME': '/home/cltbld', 20:22:22 INFO - 'LANG': 'en_US.UTF-8', 20:22:22 INFO - 'LANGUAGE': 'en_US:en', 20:22:22 INFO - 'LOGNAME': 'cltbld', 20:22:22 INFO - 'MAIL': '/var/mail/cltbld', 20:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:22 INFO - 'MOZ_NO_REMOTE': '1', 20:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:22 INFO - 'NO_EM_RESTART': '1', 20:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:22 INFO - 'PWD': '/builds/slave/test', 20:22:22 INFO - 'SHELL': '/bin/bash', 20:22:22 INFO - 'SHLVL': '1', 20:22:22 INFO - 'TERM': 'linux', 20:22:22 INFO - 'TMOUT': '86400', 20:22:22 INFO - 'USER': 'cltbld', 20:22:22 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:22 INFO - '_': '/tools/buildbot/bin/python'} 20:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:22 INFO - Downloading/unpacking blobuploader==1.2.4 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22:24 INFO - Downloading blobuploader-1.2.4.tar.gz 20:22:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:22:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:22:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22:25 INFO - Downloading docopt-0.6.1.tar.gz 20:22:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:22:25 INFO - Installing collected packages: blobuploader, requests, docopt 20:22:25 INFO - Running setup.py install for blobuploader 20:22:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:22:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:22:25 INFO - Running setup.py install for requests 20:22:25 INFO - Running setup.py install for docopt 20:22:25 INFO - Successfully installed blobuploader requests docopt 20:22:25 INFO - Cleaning up... 20:22:25 INFO - Return code: 0 20:22:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:25 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 0x7f70e5787c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, '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-1447642009.609266-1255954101', '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 20:22:25 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 20:22:25 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 20:22:25 INFO - Using env: {'DISPLAY': ':0', 20:22:25 INFO - 'HOME': '/home/cltbld', 20:22:25 INFO - 'LANG': 'en_US.UTF-8', 20:22:25 INFO - 'LANGUAGE': 'en_US:en', 20:22:25 INFO - 'LOGNAME': 'cltbld', 20:22:25 INFO - 'MAIL': '/var/mail/cltbld', 20:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:25 INFO - 'MOZ_NO_REMOTE': '1', 20:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:25 INFO - 'NO_EM_RESTART': '1', 20:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:25 INFO - 'PWD': '/builds/slave/test', 20:22:25 INFO - 'SHELL': '/bin/bash', 20:22:25 INFO - 'SHLVL': '1', 20:22:25 INFO - 'TERM': 'linux', 20:22:25 INFO - 'TMOUT': '86400', 20:22:25 INFO - 'USER': 'cltbld', 20:22:25 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:25 INFO - '_': '/tools/buildbot/bin/python'} 20:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:26 INFO - Running setup.py (path:/tmp/pip-w0lq53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:26 INFO - Running setup.py (path:/tmp/pip-IDeNRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:26 INFO - Running setup.py (path:/tmp/pip-4RTHwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:26 INFO - Running setup.py (path:/tmp/pip-5YGI3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:26 INFO - Running setup.py (path:/tmp/pip-GY9CjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:26 INFO - Running setup.py (path:/tmp/pip-HowYeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:26 INFO - Running setup.py (path:/tmp/pip-mcakqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:26 INFO - Running setup.py (path:/tmp/pip-AeyRmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:26 INFO - Running setup.py (path:/tmp/pip-kYXbUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:26 INFO - Running setup.py (path:/tmp/pip-ZmMbdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:26 INFO - Running setup.py (path:/tmp/pip-BoA_ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:26 INFO - Running setup.py (path:/tmp/pip-0JdmbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:26 INFO - Running setup.py (path:/tmp/pip-Pzl51y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:26 INFO - Running setup.py (path:/tmp/pip-xx_nJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:27 INFO - Running setup.py (path:/tmp/pip-wgykII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:27 INFO - Running setup.py (path:/tmp/pip-nYRpTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:27 INFO - Running setup.py (path:/tmp/pip-VpjfZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:22:27 INFO - Running setup.py install for manifestparser 20:22:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:22:27 INFO - Running setup.py install for mozcrash 20:22:27 INFO - Running setup.py install for mozdebug 20:22:27 INFO - Running setup.py install for mozdevice 20:22:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:22:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:22:27 INFO - Running setup.py install for mozfile 20:22:27 INFO - Running setup.py install for mozhttpd 20:22:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:22:27 INFO - Running setup.py install for mozinfo 20:22:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:22:27 INFO - Running setup.py install for mozInstall 20:22:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Running setup.py install for mozleak 20:22:28 INFO - Running setup.py install for mozlog 20:22:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Running setup.py install for moznetwork 20:22:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Running setup.py install for mozprocess 20:22:28 INFO - Running setup.py install for mozprofile 20:22:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Running setup.py install for mozrunner 20:22:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Running setup.py install for mozscreenshot 20:22:28 INFO - Running setup.py install for moztest 20:22:28 INFO - Running setup.py install for mozversion 20:22:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:22:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:22:28 INFO - Cleaning up... 20:22:28 INFO - Return code: 0 20:22:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:28 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 0x7f70e5787c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, '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-1447642009.609266-1255954101', '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 20:22:28 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 20:22:28 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 20:22:28 INFO - Using env: {'DISPLAY': ':0', 20:22:28 INFO - 'HOME': '/home/cltbld', 20:22:28 INFO - 'LANG': 'en_US.UTF-8', 20:22:28 INFO - 'LANGUAGE': 'en_US:en', 20:22:28 INFO - 'LOGNAME': 'cltbld', 20:22:28 INFO - 'MAIL': '/var/mail/cltbld', 20:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:28 INFO - 'MOZ_NO_REMOTE': '1', 20:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:28 INFO - 'NO_EM_RESTART': '1', 20:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:28 INFO - 'PWD': '/builds/slave/test', 20:22:28 INFO - 'SHELL': '/bin/bash', 20:22:28 INFO - 'SHLVL': '1', 20:22:28 INFO - 'TERM': 'linux', 20:22:29 INFO - 'TMOUT': '86400', 20:22:29 INFO - 'USER': 'cltbld', 20:22:29 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:29 INFO - '_': '/tools/buildbot/bin/python'} 20:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:29 INFO - Running setup.py (path:/tmp/pip-uRxmMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:29 INFO - Running setup.py (path:/tmp/pip-avpCe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:29 INFO - Running setup.py (path:/tmp/pip-yediQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:29 INFO - Running setup.py (path:/tmp/pip-yvJmNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:29 INFO - Running setup.py (path:/tmp/pip-zqrNTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:29 INFO - Running setup.py (path:/tmp/pip-ymVt59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:29 INFO - Running setup.py (path:/tmp/pip-9UT9qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:29 INFO - Running setup.py (path:/tmp/pip-uXMMPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22:29 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:29 INFO - Running setup.py (path:/tmp/pip-xGPnHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:29 INFO - Running setup.py (path:/tmp/pip-mDGw0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:29 INFO - Running setup.py (path:/tmp/pip-13Kerz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:30 INFO - Running setup.py (path:/tmp/pip-6uPwec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22:30 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)) 20:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:30 INFO - Running setup.py (path:/tmp/pip-gihvN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 20:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:30 INFO - Running setup.py (path:/tmp/pip-EompjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22:30 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)) 20:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:30 INFO - Running setup.py (path:/tmp/pip-6YJoX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:30 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)) 20:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:30 INFO - Running setup.py (path:/tmp/pip-HBJSK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22:30 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)) 20:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:30 INFO - Running setup.py (path:/tmp/pip-lLH6V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:30 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)) 20:22:30 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)) 20:22:30 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)) 20:22:30 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)) 20:22:30 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)) 20:22:30 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)) 20:22:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:22:30 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 20:22:30 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 20:22:30 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 20:22:30 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 20:22:30 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 20:22:30 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 20:22:32 INFO - Downloading blessings-1.5.1.tar.gz 20:22:32 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 20:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:22:32 INFO - Installing collected packages: blessings 20:22:32 INFO - Running setup.py install for blessings 20:22:32 INFO - Successfully installed blessings 20:22:32 INFO - Cleaning up... 20:22:32 INFO - Return code: 0 20:22:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:22:32 INFO - Reading from file tmpfile_stdout 20:22:32 INFO - Current package versions: 20:22:32 INFO - argparse == 1.2.1 20:22:32 INFO - blessings == 1.5.1 20:22:32 INFO - blobuploader == 1.2.4 20:22:32 INFO - docopt == 0.6.1 20:22:32 INFO - manifestparser == 1.1 20:22:32 INFO - mozInstall == 1.12 20:22:32 INFO - mozcrash == 0.16 20:22:32 INFO - mozdebug == 0.1 20:22:32 INFO - mozdevice == 0.47 20:22:32 INFO - mozfile == 1.2 20:22:32 INFO - mozhttpd == 0.7 20:22:32 INFO - mozinfo == 0.9 20:22:32 INFO - mozleak == 0.1 20:22:32 INFO - mozlog == 3.0 20:22:32 INFO - moznetwork == 0.27 20:22:32 INFO - mozprocess == 0.22 20:22:32 INFO - mozprofile == 0.27 20:22:32 INFO - mozrunner == 6.11 20:22:32 INFO - mozscreenshot == 0.1 20:22:32 INFO - mozsystemmonitor == 0.0 20:22:32 INFO - moztest == 0.7 20:22:32 INFO - mozversion == 1.4 20:22:32 INFO - psutil == 3.1.1 20:22:32 INFO - requests == 1.2.3 20:22:32 INFO - wsgiref == 0.1.2 20:22:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:32 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 0x7f70e5787c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, '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-1447642009.609266-1255954101', '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 20:22:32 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 20:22:32 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 20:22:32 INFO - Using env: {'DISPLAY': ':0', 20:22:32 INFO - 'HOME': '/home/cltbld', 20:22:32 INFO - 'LANG': 'en_US.UTF-8', 20:22:32 INFO - 'LANGUAGE': 'en_US:en', 20:22:32 INFO - 'LOGNAME': 'cltbld', 20:22:32 INFO - 'MAIL': '/var/mail/cltbld', 20:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:32 INFO - 'MOZ_NO_REMOTE': '1', 20:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:32 INFO - 'NO_EM_RESTART': '1', 20:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:32 INFO - 'PWD': '/builds/slave/test', 20:22:32 INFO - 'SHELL': '/bin/bash', 20:22:32 INFO - 'SHLVL': '1', 20:22:32 INFO - 'TERM': 'linux', 20:22:32 INFO - 'TMOUT': '86400', 20:22:32 INFO - 'USER': 'cltbld', 20:22:32 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:32 INFO - '_': '/tools/buildbot/bin/python'} 20:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:22:32 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:22:32 INFO - Cleaning up... 20:22:32 INFO - Return code: 0 20:22:32 INFO - Running post-action listener: _resource_record_post_action 20:22:32 INFO - Running post-action listener: _start_resource_monitoring 20:22:32 INFO - Starting resource monitoring. 20:22:32 INFO - ##### 20:22:32 INFO - ##### Running install step. 20:22:32 INFO - ##### 20:22:32 INFO - Running pre-action listener: _resource_record_pre_action 20:22:32 INFO - Running main action method: install 20:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:22:32 INFO - Reading from file tmpfile_stdout 20:22:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:22:33 INFO - Reading from file tmpfile_stdout 20:22:33 INFO - Output received: 20:22:33 INFO - Usage: mozinstall [options] installer 20:22:33 INFO - Options: 20:22:33 INFO - -h, --help show this help message and exit 20:22:33 INFO - -d DEST, --destination=DEST 20:22:33 INFO - Directory to install application into. [default: 20:22:33 INFO - "/builds/slave/test"] 20:22:33 INFO - --app=APP Application being installed. [default: firefox] 20:22:33 INFO - mkdir: /builds/slave/test/build/application 20:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:22:47 INFO - Reading from file tmpfile_stdout 20:22:47 INFO - Output received: 20:22:47 INFO - /builds/slave/test/build/application/firefox/firefox 20:22:47 INFO - Running post-action listener: _resource_record_post_action 20:22:47 INFO - ##### 20:22:47 INFO - ##### Running run-tests step. 20:22:47 INFO - ##### 20:22:47 INFO - Running pre-action listener: _resource_record_pre_action 20:22:47 INFO - Running main action method: run_tests 20:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:22:47 INFO - Python 2.7.3 20:22:47 INFO - Return code: 0 20:22:47 INFO - grabbing minidump binary from tooltool 20:22:47 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')]} 20:22:47 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 0x22aeac0>, '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 0x22af9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22afe50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:22:47 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 20:22:47 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 20:22:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:22:47 INFO - Return code: 0 20:22:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:22:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:22:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:22:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:22:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test/build 20:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 20:22:47 INFO - Using env: {'DISPLAY': ':0', 20:22:47 INFO - 'HOME': '/home/cltbld', 20:22:47 INFO - 'LANG': 'en_US.UTF-8', 20:22:47 INFO - 'LANGUAGE': 'en_US:en', 20:22:47 INFO - 'LOGNAME': 'cltbld', 20:22:47 INFO - 'MAIL': '/var/mail/cltbld', 20:22:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:22:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:47 INFO - 'MOZ_NO_REMOTE': '1', 20:22:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:47 INFO - 'NO_EM_RESTART': '1', 20:22:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:47 INFO - 'PWD': '/builds/slave/test', 20:22:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:22:47 INFO - 'SHELL': '/bin/bash', 20:22:47 INFO - 'SHLVL': '1', 20:22:47 INFO - 'TERM': 'linux', 20:22:47 INFO - 'TMOUT': '86400', 20:22:47 INFO - 'USER': 'cltbld', 20:22:47 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1447642009.609266-1255954101', 20:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:47 INFO - '_': '/tools/buildbot/bin/python'} 20:22:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 20:22:47 INFO - mozversion INFO | application_buildid: 20151115191231 20:22:47 INFO - mozversion INFO | application_changeset: bc74dbdea094059d5f1d353a2585b4f6352b6ec4 20:22:47 INFO - mozversion INFO | application_display_name: Nightly 20:22:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:22:47 INFO - mozversion INFO | application_name: Firefox 20:22:47 INFO - mozversion INFO | application_remotingname: firefox 20:22:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 20:22:47 INFO - mozversion INFO | application_vendor: Mozilla 20:22:47 INFO - mozversion INFO | application_version: 45.0a1 20:22:47 INFO - mozversion INFO | platform_buildid: 20151115191231 20:22:47 INFO - mozversion INFO | platform_changeset: bc74dbdea094059d5f1d353a2585b4f6352b6ec4 20:22:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 20:22:47 INFO - mozversion INFO | platform_version: 45.0a1 20:22:47 INFO - 2015-11-15 20:22:47,389 DEBUG : using testdate: 1447647767 20:22:47 INFO - 2015-11-15 20:22:47,389 DEBUG : actual date: 1447647767 20:22:47 INFO - 2015-11-15 20:22:47,397 INFO : starting webserver on 'localhost:58371' 20:22:47 INFO - 2015-11-15 20:22:47,398 INFO : Starting test suite talos-linux64-ix-048 20:22:47 INFO - 2015-11-15 20:22:47,398 INFO : Starting test dromaeo_css 20:22:47 INFO - 2015-11-15 20:22:47,398 DEBUG : operating with platform_type : linux_ 20:22:47 INFO - 2015-11-15 20:22:47,398 INFO : Initialising browser for dromaeo_css test... 20:22:47 INFO - 2015-11-15 20:22:47,405 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzu5wCp/profile http://localhost:58371/getInfo.html 20:22:53 INFO - 2015-11-15 20:22:53,923 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:22:53 INFO - 2015-11-15 20:22:53,923 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:22:53 INFO - 2015-11-15 20:22:53,923 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:22:53 INFO - 2015-11-15 20:22:53,923 DEBUG : BROWSER_OUTPUT: __metrics 20:22:54 INFO - 2015-11-15 20:22:54,026 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:22:55 INFO - 2015-11-15 20:22:55,524 INFO : Browser initialized. 20:22:55 INFO - 2015-11-15 20:22:55,524 INFO : Running cycle 1/1 for dromaeo_css test... 20:22:55 INFO - 2015-11-15 20:22:55,524 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzu5wCp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:23:07 INFO - 2015-11-15 20:23:07,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 141594624 20:23:07 INFO - 2015-11-15 20:23:07,502 DEBUG : BROWSER_OUTPUT: 20:23:58 INFO - 2015-11-15 20:23:58,584 DEBUG : BROWSER_OUTPUT: 1447647838582 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] 20:26:11 INFO - 2015-11-15 20:26:11,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58371/tests/dromaeo/cssquery-ext.html) 20:26:13 INFO - 2015-11-15 20:26:13,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 251166720 20:26:13 INFO - 2015-11-15 20:26:13,031 DEBUG : BROWSER_OUTPUT: 20:29:15 INFO - 2015-11-15 20:29:15,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/dromaeo/cssquery-ext.html (next: http://localhost:58371/tests/dromaeo/cssquery-jquery.html) 20:29:16 INFO - 2015-11-15 20:29:16,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 215760896 20:29:16 INFO - 2015-11-15 20:29:16,118 DEBUG : BROWSER_OUTPUT: 20:32:18 INFO - 2015-11-15 20:32:18,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58371/tests/dromaeo/cssquery-mootools.html) 20:32:18 INFO - 2015-11-15 20:32:18,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 211083264 20:32:18 INFO - 2015-11-15 20:32:18,651 DEBUG : BROWSER_OUTPUT: 20:35:20 INFO - 2015-11-15 20:35:20,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58371/tests/dromaeo/cssquery-prototype.html) 20:35:21 INFO - 2015-11-15 20:35:21,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 200450048 20:35:21 INFO - 2015-11-15 20:35:21,124 DEBUG : BROWSER_OUTPUT: 20:38:23 INFO - 2015-11-15 20:38:23,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58371/tests/dromaeo/cssquery-yui.html) 20:38:24 INFO - 2015-11-15 20:38:24,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 202096640 20:38:24 INFO - 2015-11-15 20:38:24,472 DEBUG : BROWSER_OUTPUT: 20:41:26 INFO - 2015-11-15 20:41:26,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/dromaeo/cssquery-yui.html (next: http://localhost:58371/tests/dromaeo/cssquery-dojo.html) 20:41:27 INFO - 2015-11-15 20:41:27,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 250970112 20:41:27 INFO - 2015-11-15 20:41:27,112 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,115 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:41:27 INFO - 2015-11-15 20:41:27,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:41:27 INFO - 2015-11-15 20:41:27,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:41:27 INFO - 2015-11-15 20:41:27,116 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:41:27 INFO - 2015-11-15 20:41:27,116 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2645.5767077267633;2734.1660793457986;2755.352492164341;2758.034687859248;2775.7640600548953;4623.052274283772;4756.405449318835;4803.375561177047;4825.155597770389;4846.418429788426;4690.530946905308;4774.904501909959;4835.178019736644;4854.101991131643;4870.196417591102;4398.890027749316;4411.095725376306;4416.690831641787;4529.977350113245;4567.680262381635;4484.282514797633;4501.999999999984;4556.179887620227;4575.153596584626;4600.884977875547;4257.638100761439;4301.37630043645;4378.999999999968;4379.08039311745;4381.9561804381865;4440.533743956903;4482.125985432842;4487.798049087799;4490.101979604092;4529.4791099023705;4254.340577210506;4472.619827314682;4476.597106260452;4478.171538265431;4484.103179364108;4631.560001799824;4679.9532004680195;4705.341252224691;4733.337332773414;4759.619230461555;5176.922346164811;5189.818356357547;5218.03466358721;5225.399079105913;5256.053910296145;4941.48114447985;5059.139946209153;5232.529072383504;5236.083685355047;5242.659227150223;4689.273162659793;4741.881452963704;4756.571908528214;4781.947971446276;4814.711117332971;5228.424873263938;5238.947610523846;5242.292290540804;5244.632875698664;5250.501202385767;4810.278458231293;4944.134776414113;5039.69761814285;5046.1926091825135;5083.796648134107;5066.138756411346;5135.4094279157625;5242.056429842665;5242.868928276824;5267.26258323835;5122.154844450624;5141.048905952336;5144.588432925357;5161.354830646169;5198.064348417245;4882.194437917775;5017.724025178577;5112.258722485219;5126.871828204325;5127.948720512822;4118.938215926763;4169;4212.620864122244;4220.2192594370135;4234.9364759528635;3672.926541469156;3680.9877283747182;3689.94465083024;3706.054955986206;3709.0727318170457;4412.691111622155;4414.3157810539415;4433.7118087324225;4438.489573699001;4458.398116254329;4906.656534042583;4986.775595098229;5018.774155163026;5029.321041659402;5176.120059589879;4370.278903980808;4423.248047831877;4444;4446.177457170434;4480.462344518679;4573.062522182944;4576.359309696645;4582.381378513925;4593.770311484413;4625.814967401334;4665.603423708955;4766.165920963748;4785;4791.496892826203;4888.071266459361;5162.406323272871;5195.298634684269;5208.427073021889;5209.661372010807;5210.400803907599;4921.729304888266;4922.630802689884;4925.088858561177;4930.852074437773;4931.16170251051;4839.2983017462975;4918.581920536794;4953.133201689618;4960.77676504551;5038.697678139323;5171.586273098068;5199;5202.817901373433;5204.739763011758;5207.791688332424;4999.200127979651;5004.974975125101;5007.023630392185;5009.949900500948;5032.094223039888;4792.880177995578;4914.410270767387;4919.188333925005;4923.926141107958;5034.421041580265;4892;4897.779599917941;4902.093112774148;4906.0433215522635;4935.457099718957;5001.57486613642;5002.774875130701;5025.547700706954;5028.823991160292;5062.316587260672;4621.584057434847;4730.101280756645;4750.168720473972;4757.524247575215;4856 20:41:27 INFO - 2015-11-15 20:41:27,116 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.4676184244047;575.6661136540806;579.1052823387865;582.1529674323857;582.1733138942701;25957.221283361505;36770.264594708126;37136.44295335572;37146.8142659287;37163.62836371636;39786;40298.395524067164;40314.395284070764;40315.79842100785;40334;7014.89477657833;7130.180029296645;7875.094364148111;8053.073896501889;8053.557054362008;9970.800583988315;10108.140808031327;10127.240456965757;10153.441560714158;10191.796164076713;10160.796784064314;10266.97330266971;10271.537780799845;10277;10283;7095.89356159658;7262.092238470192;10127.999999999964;10153.238507111997;10469.895301046969;9982.251331150193;10118.797624047478;10129.442880641562;10132.392056476636;10134.645287414905;36630.63369366299;37294.44058339127;37351.4397284041;37365.81317093397;37389.62610373888;2814.2401551581165;2841.1476557032806;2905.8111222770453;3288.19439237386;3314.933701325984;28338.14985550416;28397;28638.856805715837;28662.713372866212;29037.274068148465;3111.2532992081965;3115.376924615063;3166.1134882233014;3217.9863343046864;3273.7217336526423;221216;221494;222454;222906;224529;49846.252306215436;51077.74461127745;54049.72975135099;54146.45853541493;54460.72769636206;55558;55662.721686391305;55754.72122639361;55806.72096639491;55925;13761.724765504634;13915.860841391457;13968.720625587432;13984.51054213118;14040;10358.326708763907;10493.317934334244;10558.102561282378;10570.365778053341;10570.471476426148;18551.44345669632;18777;18788.71816922747;18829.435116946515;18904.432867014013;6943.722251109899;7198.712051517985;7209.747658831916;7324.37742791858;7327.530206573985;779.1896427715226;846.8052347959881;876.250805561236;896.6861598440624;971.3880255439028;26151.869240653676;26252.081177158707;27315.317117071834;27835.72164278372;28575;855.9657613695507;926.8841394825647;966.3670295956019;984.6799790068256;1063.2982231727024;13196.538121165713;13286.20282783036;13430.395632196574;13500.122492038183;13511.932440337736;269885.55400560884;274816;275341;275793;276456;44763;45110.77444612821;45149.548504515195;45153;45157.322640160426;1177.7666895566997;1189.6668932698858;1191.4042978510745;1193.2780667696093;1197.7903866823272;20388.694169587172;26002.479950401263;26304.736952630996;26581;26824.865875670497;36954;37258;37299.81350093232;37341.2531749358;37369.25261494701;175135;176768.1161594184;177352;178046;178887;24325.75674243235;24692.876535617925;26217.344566385993;28224.576631350137;28897.56653650239;33538;33630;34104.829475852464;34129.31741365109;34510.654893450745;30685.846570767004;31383.686163138078;31769;32037.519437207993;32198;25070.74929250757;29617.703822961495;31866.840665796524;32063;32270.515942261354;29645.407091858473;29775.553366699085;29892.70107298986;29987.250318742204;33209;25254.873725631252;26087.217383478524;26718.46563068689;26812.865935670197;27134.72865271322;21647.567048659253;21796.891015545454;21975.670364944857;21995.010224539616;22018.669719954534 20:41:27 INFO - 2015-11-15 20:41:27,117 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.66883778545883;339.7995182842124;345.12166536165455;345.21291455481503;345.7804294273136;12438.191517551353;12815.807762883564;15402.383904643815;15416.535429134228;16205.918970405131;9695.903040969588;9942.65200717975;9959.103680668739;14672.706545869076;15131.773023404658;4170.582941705836;4248.405223268729;4278.4438023056955;4278.807453664593;4284.97857510712;3168.8574014169417;3223.435898717715;4034.7982600869987;4556.270996640538;4700.036492519042;4649.814007439699;4656.115338085753;4659.044895796371;4659.650526210531;4665.253559430492;4495.325701144821;4608.723476591415;4610.077984403116;4610.723356598598;4618.330342100377;3986.222686576119;3994.2810294147043;4000.57993910641;4001.9399709004388;4002.2795896738576;12266.26402415858;12395.194312369757;12682.175658582162;12711.110222284444;12716.109872308849;1680.462252079335;1708.4276767282975;1758.8944663320242;1809.3215044358365;1813.9365122220659;9188.173064424234;9328.48693321867;9406.43561386319;9580.233581313478;9601.567929443192;1655.0731590309465;1658.5024492652155;1673.0881669490157;1699.699759608181;1722.3971609936548;52900.47099528994;55011.44988550103;55604.44395556074;55899;55931.44068559303;6533.705983230766;6593.6703164841565;6718.984304708666;6740.730370785113;6772.288909664513;7782.338501227346;7838.64726087316;7850.528968261922;7853.371730261565;7865.095514015961;5061.5950723942;5079.390473143247;5080.110980578384;5083.7203953782155;5136;4981.452040275567;5003.474635163256;5202.479752024843;5228.215767634885;5244.501772331622;3071.769617278713;3074.339017111332;3077.615298087739;3094.009916826594;3123.593932788723;1038.127972503101;1076.020821052838;1079.2499213046858;1097.4567589043475;1142.3716955674513;409.94875640544933;416.4877201042734;417.5365344467638;427.6407817433309;441.14858323435436;10890.782184356269;11176;11299.265547739371;11374.658760237206;11375.431228438545;393.79719444486113;429.4074177634844;430.67699225580816;449.3439578215841;463.9234526303122;4109.404136400265;5662;5970.432808883149;6381.361863813674;6440.967795161088;504247;512736;513809;521914;522700;67666;68593.31406685969;69052.65473672599;69323;69683.65158174177;498.9650724449254;508.29093414686304;509.7043714645497;510.535412774381;512.8000079968815;10472.790544189225;10528.736781580521;10605.522751476048;10652.467376631292;10676.46617669129;29486.852565737034;29718.851405742833;32562.837185813918;33065.338693226484;33379.49930750992;39698;40921.38617920674;41494;42907.7854610725;43283.783581081894;12982.870171298544;13052.934735326262;13497.325133743077;13501.054926155075;13531.391087400894;16754.832451675815;17033.74449383285;17268;17765;17920.551986199927;14318.212498312692;14654.706905861609;14824.925875370554;14880.107193568421;15151.621209469851;13805;13896.722065558835;14226.00417970732;14395.856041439452;14604.342804574033;10468.790624187626;14280.714385712436;14466.927665362027;15221.31504082341;15444.613884652974;13224.140430871963;13275.402606882906;13293.534726284533;13344.065915386218;13409.262490562722;9118.908810912071;14043.578692639237;14114.364853581408;14355.066920650124;14663.266836657911 20:41:27 INFO - 2015-11-15 20:41:27,120 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1019.7960407918418;1549.6125968507872;1618.2151656446624;1626.7153248181573;1660.5599516128227;6088.756449742011;6754.1894972603295;6848.589084654925;6849.178098628159;6853.657317134136;6701.832454188636;6892.517523773326;6912.205096413914;6915.273896240898;6920.273371296017;1739.5738044179193;1785.5803886086824;2027.7059826325174;2058.166442590753;2082.1046949811575;2053.8048885355865;2056.3728062940872;2061.989690051555;2062.113291284747;2063.515073957619;1967.2426115945393;1989.4230673104782;2039.9796002039939;2041.8876961767096;2044.2231951858273;2014.385612388221;2031.908564114611;2060.062671484471;2060.1965233558926;2061.9793802062013;2051.3743308290964;2066.966516741629;2069.6791997240452;2070.1615845582564;2073.284716772711;7008.474364422688;7043.753468628624;7051.506394552383;7067.611281379522;7075.610841403721;4172.833086676529;4243.639290660298;4250.086231460251;4257.787110644486;4281.443412356405;2331.4987277735368;2641.643378143945;2739.561670132789;2758.655168103987;2779.8471084090365;794.8330850521339;808.6765293882494;825.1954344514111;887.5828360670474;927.8608208768738;9658.468784216866;9686.660966866126;9708.90291097087;9713.56288966991;9716.368436051634;3932.2528719543197;3982;3994.800259986989;4007.479027726377;4072.3077076897;8284.875726864102;8293.046299675614;8321.583920803936;8330.541820199947;8340;4318.762468064224;4326.069894972596;4327.069680018811;4331.480222373272;4334.566543345641;3917.334053210961;3933.1543718100174;3938.03518138058;3945.723799334019;3946.2896678597554;2725.74105459981;2782.193163982463;3261.6575259597876;3350.212700015494;3416.4362880125;1041.3491567770143;1058.2327812335996;1063.239783554762;1065.7708592652616;1066.8453074304182;883.9513826739462;884.4118661090431;912.7809325761903;922.391221793613;1181.9645410637695;6593.40659340652;6629.303923088103;6642.701078451481;6644.335566443317;6647.501437392215;1012.5342342522522;1036.7252678040325;1039.0856046678873;1043.4052590023614;1060.9045185933148;4989.5758860496535;5036.84889453317;5048.596112311006;5056.898862022813;5057.898842023139;7849.8038296833865;8100.554469504234;8334.541600211925;8396.622152003174;8416.074231834493;8238.423310368336;8311.750647480585;8315.875261870955;8317.209865062809;8331.708390206313;6364.49084073273;6443.065755465431;6538.509611779041;6563.934360656428;6574.441172500296;6106.236720409949;6126.816195514141;6133;6136.110264011782;6139.754409823557;7199.3520583147765;7243.7464688735645;7251.311125443074;7330.083739532559;7339.9633001834645;7183.389411899838;7416.295451932057;7442.962785186256;7490.4007679386605;7491.475596708397;6559.934400656123;6640.933590664032;6658.434033107046;6664.033715111184;6669.399754022162;6636.170478690164;6695.029220763059;6714.630695311805;6719.596824190564;6725.293844146294;6336.08126821599;6435.871282574229;6481.643509607017;6542.574732642363;6586.4401525870835;6104.4505994460715;6232.626042437469;6298.433141017331;6399.136116624196;6507.73969041252;6446.4520515756685;6539.607623542603;6540.247871494648;6540.574862633914;6542;6008.969955150196;6025.939740602713;6043.516518678583;6044.57687961856;6046.27444706638;5906.114082887601;5919.852003699942;5921.259842519685;6052.122442245938;6085.847853803691 20:41:27 INFO - 2015-11-15 20:41:27,120 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.686160116681;312.72636443112276;317.71723166381923;322.24272958547414;322.37620204903527;5228.555572776314;5420.972895135528;5460.290162278908;5467.425920278373;5472.370677372103;5293.57651387889;5363.54409875161;5367.221752845845;5369.62412631115;5384.0847056000475;3878.709096817736;3952.1502876881464;3965.2069586082753;4113.156802855422;4121.536854416684;4006.6794656427414;4022.034711669193;4027.617376349242;4034.5965403459713;4035.172789578144;4002.6997975151835;4003.3794761811964;4005.459262999487;4016.7389119707273;4027.2146931348398;3862.1310205203745;3938.566757656641;3941.211757648453;4018.457508236409;4026.4966879140106;3457.0320310313155;3460.169559305774;3464.4110501214855;3466.5666791651042;3478.3217272631846;5101.234814777776;5108.259302401131;5123.718195499246;5129.256257842592;5139.0749665060275;4584.770761461914;4585.358049872987;4586.3579098926175;4592.357070010201;4601.033782905593;5437.8368648940195;5546.168074788774;5549.639273447213;5559.749811258463;5565.916511252334;3681.6134305897763;3698.31581157484;3699.3896007158787;3703.5926048134684;3704.9259014819822;5764.221830052973;5802.390748971339;5849.151872978437;5854.151148083504;5864.325602555718;3953.150072734376;3962.980185099114;3970.146418520032;3970.3250447424007;3983.183447393277;3610.656987586175;3733.4213196954515;3790.1093243087853;4027.0536423940353;4034.9798251008556;4394.340848872631;4489.663275254369;4547.3406356078185;4656.720596764205;4663.813447462064;5434.83695489136;5460.945390546044;5588.469095435927;5595.692236927008;5597.048501754712;1401.1453013661658;1402.2077526197666;1408.1339975914943;1409.6475881029742;1418.489343836218;901.9909800901906;948.6774496671165;954.8663187153804;961.9663311784054;970.1850445625568;4858.78135483904;4859.95140048602;4860.513948605111;4862.07620552094;4871.5128487151715;5760.567957403212;5765.135229715493;5772;5780.248567686174;5782.959067367914;4829.2997515360075;4839.782209800567;4849;4852.805887764521;4866.416030076342;2858.4140251248446;2974.078035808906;3044.9238769030508;3069.4628440022907;3102.503599424081;5386.811461598825;5402.432744561765;5414.8917021659345;5418.512333889968;5497.615166938356;5949.434803693729;5953.434423729739;5955.702214889238;5959.22530071088;5965.403459654087;5487.039768040657;5487.862803429946;5489.478499542537;5496.587755918322;5496.670199787945;5664.518515926193;5803.448672376117;5807.651540907559;5808.535317174531;5819.621724587888;5674.0354139797155;5691.117876729114;5696.060150075357;5699.287589051369;5699.800506982236;5498.3127109111365;5504.834854954358;5505.174223866452;5509.862253443696;5515.22786809855;3997.5802540732802;4003.5796241394232;4004.9199016020098;4006.8797936061965;4007.479027726377;5680.715964201856;5835.358110607915;5837.824865254049;5843.94156058451;5856.180134781219;5556.416576259435;5587.525060369914;5606.215129881738;5609.382967873612;5609.6073274872;5622.578306626938;5622.803201887914;5623.3533143689;5625.690587017753;5630.23991761107;5362.115250983544;5481.671099734029;5488.56091512686;5503.807366742145;5507.779688812563;5610.551155907436;5626.156076588544;5638.9436105638415;5642.492175704207;5648.15277708347;5302.840914772563;5493.6978466183145;5502.477264659851;5502.5597952164535;5509.752061157177 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: |5;yui.html;751.2412463411954;763.1529002806883;770.4529783853463;772.5480593852596;796.9521828690278;11199.328040317587;11418.200725949166;11475.713107172325;11508.424578771059;11518.424078796068;11167.274127181727;11248.718782030453;11287.49206285717;11318.603848865292;11322.15083868711;583.6702263221266;592.5703864698103;762.1349768013317;776.7397921696211;777.0442355902244;772.6291380137509;774.1445702498743;779.5790273252437;780.5667854340838;782.0927723840347;621.5059028072693;626.2078470734524;814.7515007922581;814.9837003259931;822.8930239068912;799.1209669363711;811.407672399149;814.7229941819751;814.7963009247688;815.4821688227988;599.8560345517088;602.2441835496423;602.4036204157896;603.6709993053796;604.1481511069371;11640.476178571984;11819.822702659467;11847.585334513336;11863.644090677293;11870.169088163746;8944.373893827435;8945.604152035414;9093.499857507835;10334.328268662588;10500.684979450629;8529.95735021321;8586.31309495239;8645.956770216171;8731.650733970633;9091.227245684058;2700.4464084862557;2700.9189724308303;2702.8918843246247;2727.440874620698;2777.8888844446196;38190.80904595487;38222;38303;39065.41401878974;39090.609093908985;6369.8726025480155;6400.615963042233;6483.7730679425995;6560.803175904731;6699.866002679919;10278.434686092336;10332.070113689804;10361.63734269297;10365.170786337076;10381.532831022621;5566.777328906798;5587.3015873015875;5587.525060369833;5610.551155907518;5665.3768085510565;3410.8635654574036;3493.825308734553;3497.772644778132;3567.7324200685052;3636.2727454509204;2327.3483424641126;2355.9293221203393;2363.988180059123;2364.47981444082;2366.278285123054;373.24045567270474;377.56391367970036;381.47356647825825;382.7875529081331;383.3176945037837;506.42014892947367;557.8382269141985;565.7963133272019;581.8109114537792;594.0643486508766;7244.637768111679;7326.084239470067;7566.1298950621385;7634.351080158138;7663.003809504728;518.7717404342077;572.7079189613244;586.2232541881938;600.6786369292407;620.7951376045984;3447.172678557128;3617.565892092966;3652.543432070991;3666.926661466756;3721.1999420124803;44584.3312350315;47735.283970740464;47784;47803.28295075577;47815.282770758466;42288.365674514906;42945;43177;43676.01928978521;46195.307070393974;39522;40119.598804011584;40287.99999999941;40966.38550421746;41332;7522.924770752223;7525.8494830102;7667.69329226847;7675.961620191863;7878.645460954156;30710;31063.378732425677;31203.68796312008;31926;32149.67850321467;38119.61880381161;38634.6136538631;38663.806680966416;40127.59872401239;40330.59669403268;6816.147981502312;6955.930440695528;6982.441404687715;7035.110598134452;7347.412207023318;11308.151888608223;11319.547218111513;11344.319340839576;11373.943130284295;11453.255538389978;10701.464926753786;10731.248812583044;10840;10852.240343175901;10965.177611679315;9571.760705982406;9697.224222062077;9870.802583948138;9905.504724763588;10272.126869216201;10768.946155269174;10774;10774.407407592658;10973.3964631946;11176.832347514632;9259.953700231456;9282.58228379711;9531.761705957406;9577.952110239683;9825.55784989663;8976.31970891931;9490.667826626312;9513.952430237805;9515.381500202464;9519.238460923249 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,895 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: __startTimestamp1447648887113__endTimestamp 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,124 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4727.87 Median:4839.30 stddev:498.14 (10.3%) stddev-sans-first:472.13 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: Values: 2645.6 2734.2 2755.4 2758.0 2775.8 4623.1 4756.4 4803.4 4825.2 4846.4 4690.5 4774.9 4835.2 4854.1 4870.2 4398.9 4411.1 4416.7 4530.0 4567.7 4484.3 4502.0 4556.2 4575.2 4600.9 4257.6 4301.4 4379.0 4379.1 4382.0 4440.5 4482.1 4487.8 4490.1 4529.5 4254.3 4472.6 4476.6 4478.2 4484.1 4631.6 4680.0 4705.3 4733.3 4759.6 5176.9 5189.8 5218.0 5225.4 5256.1 4941.5 5059.1 5232.5 5236.1 5242.7 4689.3 4741.9 4756.6 4781.9 4814.7 5228.4 5238.9 5242.3 5244.6 5250.5 4810.3 4944.1 5039.7 5046.2 5083.8 5066.1 5135.4 5242.1 5242.9 5267.3 5122.2 5141.0 5144.6 5161.4 5198.1 4882.2 5017.7 5112.3 5126.9 5127.9 4118.9 4169.0 4212.6 4220.2 4234.9 3672.9 3681.0 3689.9 3706.1 3709.1 4412.7 4414.3 4433.7 4438.5 4458.4 4906.7 4986.8 5018.8 5029.3 5176.1 4370.3 4423.2 4444.0 4446.2 4480.5 4573.1 4576.4 4582.4 4593.8 4625.8 4665.6 4766.2 4785.0 4791.5 4888.1 5162.4 5195.3 5208.4 5209.7 5210.4 4921.7 4922.6 4925.1 4930.9 4931.2 4839.3 4918.6 4953.1 4960.8 5038.7 5171.6 5199.0 5202.8 5204.7 5207.8 4999.2 5005.0 5007.0 5009.9 5032.1 4792.9 4914.4 4919.2 4923.9 5034.4 4892.0 4897.8 4902.1 4906.0 4935.5 5001.6 5002.8 5025.5 5028.8 5062.3 4621.6 4730.1 4750.2 4757.5 4856.0 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38334.76 Median:15971.54 stddev:59408.95 (372.0%) stddev-sans-first:59507.89 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: Values: 557.5 575.7 579.1 582.2 582.2 25957.2 36770.3 37136.4 37146.8 37163.6 39786.0 40298.4 40314.4 40315.8 40334.0 7014.9 7130.2 7875.1 8053.1 8053.6 9970.8 10108.1 10127.2 10153.4 10191.8 10160.8 10267.0 10271.5 10277.0 10283.0 7095.9 7262.1 10128.0 10153.2 10469.9 9982.3 10118.8 10129.4 10132.4 10134.6 36630.6 37294.4 37351.4 37365.8 37389.6 2814.2 2841.1 2905.8 3288.2 3314.9 28338.1 28397.0 28638.9 28662.7 29037.3 3111.3 3115.4 3166.1 3218.0 3273.7 221216.0 221494.0 222454.0 222906.0 224529.0 49846.3 51077.7 54049.7 54146.5 54460.7 55558.0 55662.7 55754.7 55806.7 55925.0 13761.7 13915.9 13968.7 13984.5 14040.0 10358.3 10493.3 10558.1 10570.4 10570.5 18551.4 18777.0 18788.7 18829.4 18904.4 6943.7 7198.7 7209.7 7324.4 7327.5 779.2 846.8 876.3 896.7 971.4 26151.9 26252.1 27315.3 27835.7 28575.0 856.0 926.9 966.4 984.7 1063.3 13196.5 13286.2 13430.4 13500.1 13511.9 269885.6 274816.0 275341.0 275793.0 276456.0 44763.0 45110.8 45149.5 45153.0 45157.3 1177.8 1189.7 1191.4 1193.3 1197.8 20388.7 26002.5 26304.7 26581.0 26824.9 36954.0 37258.0 37299.8 37341.3 37369.3 175135.0 176768.1 177352.0 178046.0 178887.0 24325.8 24692.9 26217.3 28224.6 28897.6 33538.0 33630.0 34104.8 34129.3 34510.7 30685.8 31383.7 31769.0 32037.5 32198.0 25070.7 29617.7 31866.8 32063.0 32270.5 29645.4 29775.6 29892.7 29987.3 33209.0 25254.9 26087.2 26718.5 26812.9 27134.7 21647.6 21796.9 21975.7 21995.0 22018.7 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26216.34 Median:3990.25 stddev:84186.61 (2109.8%) stddev-sans-first:84400.33 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: Values: 324.7 339.8 345.1 345.2 345.8 12438.2 12815.8 15402.4 15416.5 16205.9 9695.9 9942.7 9959.1 14672.7 15131.8 4170.6 4248.4 4278.4 4278.8 4285.0 3168.9 3223.4 4034.8 4556.3 4700.0 4649.8 4656.1 4659.0 4659.7 4665.3 4495.3 4608.7 4610.1 4610.7 4618.3 3986.2 3994.3 4000.6 4001.9 4002.3 12266.3 12395.2 12682.2 12711.1 12716.1 1680.5 1708.4 1758.9 1809.3 1813.9 9188.2 9328.5 9406.4 9580.2 9601.6 1655.1 1658.5 1673.1 1699.7 1722.4 52900.5 55011.4 55604.4 55899.0 55931.4 6533.7 6593.7 6719.0 6740.7 6772.3 7782.3 7838.6 7850.5 7853.4 7865.1 5061.6 5079.4 5080.1 5083.7 5136.0 4981.5 5003.5 5202.5 5228.2 5244.5 3071.8 3074.3 3077.6 3094.0 3123.6 1038.1 1076.0 1079.2 1097.5 1142.4 409.9 416.5 417.5 427.6 441.1 10890.8 11176.0 11299.3 11374.7 11375.4 393.8 429.4 430.7 449.3 463.9 4109.4 5662.0 5970.4 6381.4 6441.0 504247.0 512736.0 513809.0 521914.0 522700.0 67666.0 68593.3 69052.7 69323.0 69683.7 499.0 508.3 509.7 510.5 512.8 10472.8 10528.7 10605.5 10652.5 10676.5 29486.9 29718.9 32562.8 33065.3 33379.5 39698.0 40921.4 41494.0 42907.8 43283.8 12982.9 13052.9 13497.3 13501.1 13531.4 16754.8 17033.7 17268.0 17765.0 17920.6 14318.2 14654.7 14824.9 14880.1 15151.6 13805.0 13896.7 14226.0 14395.9 14604.3 10468.8 14280.7 14466.9 15221.3 15444.6 13224.1 13275.4 13293.5 13344.1 13409.3 9118.9 14043.6 14114.4 14355.1 14663.3 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,125 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4903.95 Median:6134.56 stddev:2531.64 (41.3%) stddev-sans-first:2521.90 20:41:27 INFO - 2015-11-15 20:41:27,126 DEBUG : BROWSER_OUTPUT: Values: 1019.8 1549.6 1618.2 1626.7 1660.6 6088.8 6754.2 6848.6 6849.2 6853.7 6701.8 6892.5 6912.2 6915.3 6920.3 1739.6 1785.6 2027.7 2058.2 2082.1 2053.8 2056.4 2062.0 2062.1 2063.5 1967.2 1989.4 2040.0 2041.9 2044.2 2014.4 2031.9 2060.1 2060.2 2062.0 2051.4 2067.0 2069.7 2070.2 2073.3 7008.5 7043.8 7051.5 7067.6 7075.6 4172.8 4243.6 4250.1 4257.8 4281.4 2331.5 2641.6 2739.6 2758.7 2779.8 794.8 808.7 825.2 887.6 927.9 9658.5 9686.7 9708.9 9713.6 9716.4 3932.3 3982.0 3994.8 4007.5 4072.3 8284.9 8293.0 8321.6 8330.5 8340.0 4318.8 4326.1 4327.1 4331.5 4334.6 3917.3 3933.2 3938.0 3945.7 3946.3 2725.7 2782.2 3261.7 3350.2 3416.4 1041.3 1058.2 1063.2 1065.8 1066.8 884.0 884.4 912.8 922.4 1182.0 6593.4 6629.3 6642.7 6644.3 6647.5 1012.5 1036.7 1039.1 1043.4 1060.9 4989.6 5036.8 5048.6 5056.9 5057.9 7849.8 8100.6 8334.5 8396.6 8416.1 8238.4 8311.8 8315.9 8317.2 8331.7 6364.5 6443.1 6538.5 6563.9 6574.4 6106.2 6126.8 6133.0 6136.1 6139.8 7199.4 7243.7 7251.3 7330.1 7340.0 7183.4 7416.3 7443.0 7490.4 7491.5 6559.9 6640.9 6658.4 6664.0 6669.4 6636.2 6695.0 6714.6 6719.6 6725.3 6336.1 6435.9 6481.6 6542.6 6586.4 6104.5 6232.6 6298.4 6399.1 6507.7 6446.5 6539.6 6540.2 6540.6 6542.0 6009.0 6025.9 6043.5 6044.6 6046.3 5906.1 5919.9 5921.3 6052.1 6085.8 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4597.33 Median:5368.42 stddev:1382.53 (25.8%) stddev-sans-first:1348.40 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: Values: 307.7 312.7 317.7 322.2 322.4 5228.6 5421.0 5460.3 5467.4 5472.4 5293.6 5363.5 5367.2 5369.6 5384.1 3878.7 3952.2 3965.2 4113.2 4121.5 4006.7 4022.0 4027.6 4034.6 4035.2 4002.7 4003.4 4005.5 4016.7 4027.2 3862.1 3938.6 3941.2 4018.5 4026.5 3457.0 3460.2 3464.4 3466.6 3478.3 5101.2 5108.3 5123.7 5129.3 5139.1 4584.8 4585.4 4586.4 4592.4 4601.0 5437.8 5546.2 5549.6 5559.7 5565.9 3681.6 3698.3 3699.4 3703.6 3704.9 5764.2 5802.4 5849.2 5854.2 5864.3 3953.2 3963.0 3970.1 3970.3 3983.2 3610.7 3733.4 3790.1 4027.1 4035.0 4394.3 4489.7 4547.3 4656.7 4663.8 5434.8 5460.9 5588.5 5595.7 5597.0 1401.1 1402.2 1408.1 1409.6 1418.5 902.0 948.7 954.9 962.0 970.2 4858.8 4860.0 4860.5 4862.1 4871.5 5760.6 5765.1 5772.0 5780.2 5783.0 4829.3 4839.8 4849.0 4852.8 4866.4 2858.4 2974.1 3044.9 3069.5 3102.5 5386.8 5402.4 5414.9 5418.5 5497.6 5949.4 5953.4 5955.7 5959.2 5965.4 5487.0 5487.9 5489.5 5496.6 5496.7 5664.5 5803.4 5807.7 5808.5 5819.6 5674.0 5691.1 5696.1 5699.3 5699.8 5498.3 5504.8 5505.2 5509.9 5515.2 3997.6 4003.6 4004.9 4006.9 4007.5 5680.7 5835.4 5837.8 5843.9 5856.2 5556.4 5587.5 5606.2 5609.4 5609.6 5622.6 5622.8 5623.4 5625.7 5630.2 5362.1 5481.7 5488.6 5503.8 5507.8 5610.6 5626.2 5638.9 5642.5 5648.2 5302.8 5493.7 5502.5 5502.6 5509.8 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11605.06 Median:47793.64 stddev:13498.85 (28.2%) stddev-sans-first:13512.11 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: Values: 751.2 763.2 770.5 772.5 797.0 11199.3 11418.2 11475.7 11508.4 11518.4 11167.3 11248.7 11287.5 11318.6 11322.2 583.7 592.6 762.1 776.7 777.0 772.6 774.1 779.6 780.6 782.1 621.5 626.2 814.8 815.0 822.9 799.1 811.4 814.7 814.8 815.5 599.9 602.2 602.4 603.7 604.1 11640.5 11819.8 11847.6 11863.6 11870.2 8944.4 8945.6 9093.5 10334.3 10500.7 8530.0 8586.3 8646.0 8731.7 9091.2 2700.4 2700.9 2702.9 2727.4 2777.9 38190.8 38222.0 38303.0 39065.4 39090.6 6369.9 6400.6 6483.8 6560.8 6699.9 10278.4 10332.1 10361.6 10365.2 10381.5 5566.8 5587.3 5587.5 5610.6 5665.4 3410.9 3493.8 3497.8 3567.7 3636.3 2327.3 2355.9 2364.0 2364.5 2366.3 373.2 377.6 381.5 382.8 383.3 506.4 557.8 565.8 581.8 594.1 7244.6 7326.1 7566.1 7634.4 7663.0 518.8 572.7 586.2 600.7 620.8 3447.2 3617.6 3652.5 3666.9 3721.2 44584.3 47735.3 47784.0 47803.3 47815.3 42288.4 42945.0 43177.0 43676.0 46195.3 39522.0 40119.6 40288.0 40966.4 41332.0 7522.9 7525.8 7667.7 7676.0 7878.6 30710.0 31063.4 31203.7 31926.0 32149.7 38119.6 38634.6 38663.8 40127.6 40330.6 6816.1 6955.9 6982.4 7035.1 7347.4 11308.2 11319.5 11344.3 11373.9 11453.3 10701.5 10731.2 10840.0 10852.2 10965.2 9571.8 9697.2 9870.8 9905.5 10272.1 10768.9 10774.0 10774.4 10973.4 11176.8 9260.0 9282.6 9531.8 9578.0 9825.6 8976.3 9490.7 9514.0 9515.4 9519.2 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:41:27 INFO - 2015-11-15 20:41:27,127 DEBUG : BROWSER_OUTPUT: 20:41:27 INFO - 2015-11-15 20:41:27,870 INFO : Browser exited with error code: 0 20:41:27 INFO - 2015-11-15 20:41:27,886 INFO : Completed test dromaeo_css (00:18:40) 20:41:27 INFO - 2015-11-15 20:41:27,886 INFO : Starting test kraken 20:41:27 INFO - 2015-11-15 20:41:27,886 DEBUG : operating with platform_type : linux_ 20:41:27 INFO - 2015-11-15 20:41:27,886 INFO : Initialising browser for kraken test... 20:41:27 INFO - 2015-11-15 20:41:27,892 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAt1rzc/profile http://localhost:58371/getInfo.html 20:41:31 INFO - 2015-11-15 20:41:31,737 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:41:31 INFO - 2015-11-15 20:41:31,738 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:41:31 INFO - 2015-11-15 20:41:31,738 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:41:31 INFO - 2015-11-15 20:41:31,738 DEBUG : BROWSER_OUTPUT: __metrics 20:41:31 INFO - 2015-11-15 20:41:31,834 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:41:33 INFO - 2015-11-15 20:41:33,010 INFO : Browser initialized. 20:41:33 INFO - 2015-11-15 20:41:33,011 INFO : Running cycle 1/1 for kraken test... 20:41:33 INFO - 2015-11-15 20:41:33,011 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAt1rzc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:41:44 INFO - 2015-11-15 20:41:44,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 141398016 20:41:44 INFO - 2015-11-15 20:41:44,993 DEBUG : BROWSER_OUTPUT: 20:41:47 INFO - 2015-11-15 20:41:47,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58371/tests/kraken/driver.html?testName=audio-beat-detection) 20:41:48 INFO - 2015-11-15 20:41:48,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 176889856 20:41:48 INFO - 2015-11-15 20:41:48,184 DEBUG : BROWSER_OUTPUT: 20:41:50 INFO - 2015-11-15 20:41:50,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58371/tests/kraken/driver.html?testName=audio-dft) 20:41:51 INFO - 2015-11-15 20:41:51,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 166457344 20:41:51 INFO - 2015-11-15 20:41:51,495 DEBUG : BROWSER_OUTPUT: 20:41:54 INFO - 2015-11-15 20:41:54,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58371/tests/kraken/driver.html?testName=audio-fft) 20:41:55 INFO - 2015-11-15 20:41:55,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 152178688 20:41:55 INFO - 2015-11-15 20:41:55,060 DEBUG : BROWSER_OUTPUT: 20:41:57 INFO - 2015-11-15 20:41:57,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58371/tests/kraken/driver.html?testName=audio-oscillator) 20:41:57 INFO - 2015-11-15 20:41:57,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 154427392 20:41:57 INFO - 2015-11-15 20:41:57,665 DEBUG : BROWSER_OUTPUT: 20:41:59 INFO - 2015-11-15 20:41:59,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:42:00 INFO - 2015-11-15 20:42:00,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 156364800 20:42:00 INFO - 2015-11-15 20:42:00,457 DEBUG : BROWSER_OUTPUT: 20:42:03 INFO - 2015-11-15 20:42:03,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58371/tests/kraken/driver.html?testName=imaging-darkroom) 20:42:04 INFO - 2015-11-15 20:42:04,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 156561408 20:42:04 INFO - 2015-11-15 20:42:04,014 DEBUG : BROWSER_OUTPUT: 20:42:07 INFO - 2015-11-15 20:42:07,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58371/tests/kraken/driver.html?testName=imaging-desaturate) 20:42:08 INFO - 2015-11-15 20:42:08,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 158212096 20:42:08 INFO - 2015-11-15 20:42:08,011 DEBUG : BROWSER_OUTPUT: 20:42:10 INFO - 2015-11-15 20:42:10,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58371/tests/kraken/driver.html?testName=json-parse-financial) 20:42:11 INFO - 2015-11-15 20:42:11,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 155303936 20:42:11 INFO - 2015-11-15 20:42:11,415 DEBUG : BROWSER_OUTPUT: 20:42:13 INFO - 2015-11-15 20:42:13,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:42:13 INFO - 2015-11-15 20:42:13,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 165683200 20:42:13 INFO - 2015-11-15 20:42:13,738 DEBUG : BROWSER_OUTPUT: 20:42:15 INFO - 2015-11-15 20:42:15,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:42:16 INFO - 2015-11-15 20:42:16,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 165867520 20:42:16 INFO - 2015-11-15 20:42:16,226 DEBUG : BROWSER_OUTPUT: 20:42:18 INFO - 2015-11-15 20:42:18,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:42:18 INFO - 2015-11-15 20:42:18,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 173563904 20:42:18 INFO - 2015-11-15 20:42:18,980 DEBUG : BROWSER_OUTPUT: 20:42:21 INFO - 2015-11-15 20:42:21,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:42:22 INFO - 2015-11-15 20:42:22,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 179081216 20:42:22 INFO - 2015-11-15 20:42:22,068 DEBUG : BROWSER_OUTPUT: 20:42:24 INFO - 2015-11-15 20:42:24,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:42:25 INFO - 2015-11-15 20:42:25,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 177438720 20:42:25 INFO - 2015-11-15 20:42:25,279 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58371/tests/kraken/driver.html?testName=ai-astar) 20:42:27 INFO - 2015-11-15 20:42:27,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 236466176 20:42:27 INFO - 2015-11-15 20:42:27,287 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,287 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:42:27 INFO - 2015-11-15 20:42:27,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;107;112;111;113;103;111;103;112 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;131;156;173;139;159;152;134;168;132 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;159;161;160;163;161;161;161 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;85;90;72;72;72;98;91;73 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;93;137;92;92;91;127;91;102;126 20:42:27 INFO - 2015-11-15 20:42:27,288 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;110;110;109 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;147;149;155;148;147;148;147;147 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;95;95;95;94;94 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;69;69;68;68;69;69;78;67;67 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;70;69;70;69;70;69;69;69 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;83;83;84;85;83;83;84;84;97 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;127;119;119;126;121;128;123;120;121 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;149;163;149;151;140;151;149;149;137 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;72;72;70;70;70;69;71;70 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:42:27 INFO - 2015-11-15 20:42:27,289 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:42:27 INFO - 2015-11-15 20:42:27,290 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 20:42:27 INFO - 2015-11-15 20:42:27,290 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:42:27 INFO - 2015-11-15 20:42:27,290 DEBUG : BROWSER_OUTPUT: __startTimestamp1447648947281__endTimestamp 20:42:27 INFO - 2015-11-15 20:42:27,290 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:111.50 stddev:3.78 (3.4%) stddev-sans-first:3.97 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 107.0 112.0 111.0 113.0 103.0 111.0 103.0 112.0 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:156.00 stddev:15.17 (9.7%) stddev-sans-first:15.94 20:42:27 INFO - 2015-11-15 20:42:27,291 DEBUG : BROWSER_OUTPUT: Values: 156.0 131.0 156.0 173.0 139.0 159.0 152.0 134.0 168.0 132.0 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 159.0 161.0 160.0 163.0 161.0 161.0 161.0 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:79.50 stddev:9.98 (12.6%) stddev-sans-first:10.26 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 85.0 90.0 72.0 72.0 72.0 98.0 91.0 73.0 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:91.50 stddev:17.99 (19.7%) stddev-sans-first:18.80 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: Values: 96.0 93.0 137.0 92.0 92.0 91.0 127.0 91.0 102.0 126.0 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:42:27 INFO - 2015-11-15 20:42:27,292 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:2.46 (1.7%) stddev-sans-first:2.60 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 147.0 149.0 155.0 148.0 147.0 148.0 147.0 147.0 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 94.0 94.0 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.40 Median:69.00 stddev:3.17 (4.6%) stddev-sans-first:3.35 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 68.0 68.0 69.0 69.0 78.0 67.0 67.0 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.52 (0.7%) stddev-sans-first:0.50 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 70.0 69.0 70.0 69.0 70.0 69.0 69.0 69.0 20:42:27 INFO - 2015-11-15 20:42:27,293 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:4.30 (5.1%) stddev-sans-first:4.51 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: Values: 87.0 83.0 83.0 84.0 85.0 83.0 83.0 84.0 84.0 97.0 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.50 stddev:3.71 (3.0%) stddev-sans-first:3.50 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: Values: 128.0 127.0 119.0 119.0 126.0 121.0 128.0 123.0 120.0 121.0 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:150.00 stddev:6.94 (4.6%) stddev-sans-first:7.31 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: Values: 151.0 149.0 163.0 149.0 151.0 140.0 151.0 149.0 149.0 137.0 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.14 (1.6%) stddev-sans-first:1.12 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 72.0 72.0 70.0 70.0 70.0 69.0 71.0 70.0 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:42:27 INFO - 2015-11-15 20:42:27,294 DEBUG : BROWSER_OUTPUT: 20:42:28 INFO - 2015-11-15 20:42:28,214 INFO : Browser exited with error code: 0 20:42:28 INFO - 2015-11-15 20:42:28,264 INFO : Completed test kraken (00:01:00) 20:42:28 INFO - 2015-11-15 20:42:28,265 INFO : Starting test v8_7 20:42:28 INFO - 2015-11-15 20:42:28,265 DEBUG : operating with platform_type : linux_ 20:42:28 INFO - 2015-11-15 20:42:28,265 INFO : Initialising browser for v8_7 test... 20:42:28 INFO - 2015-11-15 20:42:28,271 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpulLwhP/profile http://localhost:58371/getInfo.html 20:42:31 INFO - 2015-11-15 20:42:31,996 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:42:31 INFO - 2015-11-15 20:42:31,997 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:42:31 INFO - 2015-11-15 20:42:31,997 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:42:31 INFO - 2015-11-15 20:42:31,997 DEBUG : BROWSER_OUTPUT: __metrics 20:42:32 INFO - 2015-11-15 20:42:32,098 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:42:33 INFO - 2015-11-15 20:42:33,390 INFO : Browser initialized. 20:42:33 INFO - 2015-11-15 20:42:33,391 INFO : Running cycle 1/1 for v8_7 test... 20:42:33 INFO - 2015-11-15 20:42:33,391 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpulLwhP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:42:45 INFO - 2015-11-15 20:42:45,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 142192640 20:42:45 INFO - 2015-11-15 20:42:45,268 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58371/tests/v8_7/run.html (next: http://localhost:58371/tests/v8_7/run.html) 20:43:06 INFO - 2015-11-15 20:43:06,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 439095296 20:43:06 INFO - 2015-11-15 20:43:06,952 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,953 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:43:06 INFO - 2015-11-15 20:43:06,953 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:43:06 INFO - 2015-11-15 20:43:06,953 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:43:06 INFO - 2015-11-15 20:43:06,953 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:43:06 INFO - 2015-11-15 20:43:06,953 DEBUG : BROWSER_OUTPUT: |0;Richards;170.41581458759373 20:43:06 INFO - 2015-11-15 20:43:06,953 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.1598770176787 20:43:06 INFO - 2015-11-15 20:43:06,954 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.4858757062147 20:43:06 INFO - 2015-11-15 20:43:06,954 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 20:43:06 INFO - 2015-11-15 20:43:06,954 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1974.3589743589744 20:43:06 INFO - 2015-11-15 20:43:06,954 DEBUG : BROWSER_OUTPUT: |5;Earley;815.6606851549756 20:43:06 INFO - 2015-11-15 20:43:06,954 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 20:43:06 INFO - 2015-11-15 20:43:06,955 DEBUG : BROWSER_OUTPUT: |7;RegExp;27270.27027027027 20:43:06 INFO - 2015-11-15 20:43:06,955 DEBUG : BROWSER_OUTPUT: |8;Splay;622.6065472513898 20:43:06 INFO - 2015-11-15 20:43:06,955 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 20:43:06 INFO - 2015-11-15 20:43:06,955 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:43:06 INFO - 2015-11-15 20:43:06,955 DEBUG : BROWSER_OUTPUT: __startTimestamp1447648986951__endTimestamp 20:43:06 INFO - 2015-11-15 20:43:06,956 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,956 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:43:06 INFO - 2015-11-15 20:43:06,956 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:43:06 INFO - 2015-11-15 20:43:06,956 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,956 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.42 Median:170.42 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,957 DEBUG : BROWSER_OUTPUT: Values: 170.4 20:43:06 INFO - 2015-11-15 20:43:06,957 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,957 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.16 Median:192.16 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,957 DEBUG : BROWSER_OUTPUT: Values: 192.2 20:43:06 INFO - 2015-11-15 20:43:06,957 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,958 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.49 Median:282.49 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,958 DEBUG : BROWSER_OUTPUT: Values: 282.5 20:43:06 INFO - 2015-11-15 20:43:06,958 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,958 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,958 DEBUG : BROWSER_OUTPUT: Values: 5035.2 20:43:06 INFO - 2015-11-15 20:43:06,959 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,959 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,959 DEBUG : BROWSER_OUTPUT: Values: 1974.4 20:43:06 INFO - 2015-11-15 20:43:06,959 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,959 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:815.66 Median:815.66 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,960 DEBUG : BROWSER_OUTPUT: Values: 815.7 20:43:06 INFO - 2015-11-15 20:43:06,960 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,960 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,960 DEBUG : BROWSER_OUTPUT: Values: 12096.4 20:43:06 INFO - 2015-11-15 20:43:06,960 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,960 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27270.27 Median:27270.27 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,961 DEBUG : BROWSER_OUTPUT: Values: 27270.3 20:43:06 INFO - 2015-11-15 20:43:06,961 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,961 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.61 Median:622.61 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,961 DEBUG : BROWSER_OUTPUT: Values: 622.6 20:43:06 INFO - 2015-11-15 20:43:06,961 DEBUG : BROWSER_OUTPUT: 20:43:06 INFO - 2015-11-15 20:43:06,961 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 20:43:06 INFO - 2015-11-15 20:43:06,962 DEBUG : BROWSER_OUTPUT: Values: 4850.2 20:43:06 INFO - 2015-11-15 20:43:06,962 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:43:06 INFO - 2015-11-15 20:43:06,962 DEBUG : BROWSER_OUTPUT: 20:43:07 INFO - 2015-11-15 20:43:07,886 INFO : Browser exited with error code: 0 20:43:07 INFO - 2015-11-15 20:43:07,900 INFO : Completed test v8_7 (00:00:39) 20:43:07 INFO - 2015-11-15 20:43:07,959 INFO : Completed test suite (00:20:20) 20:43:07 INFO - 2015-11-15 20:43:07,960 DEBUG : Working with test: dromaeo_css 20:43:07 INFO - 2015-11-15 20:43:07,960 DEBUG : Generating results file: dromaeo_css 20:43:07 INFO - 2015-11-15 20:43:07,961 DEBUG : Working with test: kraken 20:43:07 INFO - 2015-11-15 20:43:07,961 DEBUG : Generating results file: kraken 20:43:07 INFO - 2015-11-15 20:43:07,961 INFO : javascript benchmark 20:43:07 INFO - 2015-11-15 20:43:07,961 DEBUG : Working with test: v8_7 20:43:07 INFO - 2015-11-15 20:43:07,962 DEBUG : Generating results file: v8_7 20:43:07 INFO - 2015-11-15 20:43:07,962 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:43:08 INFO - 2015-11-15 20:43:08,011 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 20:43:08 INFO - 2015-11-15 20:43:08,011 DEBUG : process_Request line: dromaeo_css 6042.19 graph.html#tests=[[72,94,35]] 20:43:08 INFO - 2015-11-15 20:43:08,011 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:43:08 INFO - 2015-11-15 20:43:08,044 DEBUG : process_Request line: kraken 1524.20 graph.html#tests=[[232,94,35]] 20:43:08 INFO - 2015-11-15 20:43:08,044 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:43:08 INFO - 2015-11-15 20:43:08,126 DEBUG : process_Request line: v8_7 19591.77 graph.html#tests=[[230,94,35]] 20:43:08 INFO - 2015-11-15 20:43:08,127 INFO : javascript benchmark 20:43:08 INFO - 2015-11-15 20:43:08,131 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [324.66883778545883, 339.7995182842124, 345.12166536165455, 345.21291455481503, 345.7804294273136, 12438.191517551353, 12815.807762883564, 15402.383904643815, 15416.535429134228, 16205.918970405131, 9695.903040969588, 9942.65200717975, 9959.103680668739, 14672.706545869076, 15131.773023404658, 4170.582941705836, 4248.405223268729, 4278.4438023056955, 4278.807453664593, 4284.97857510712, 3168.8574014169417, 3223.435898717715, 4034.7982600869987, 4556.270996640538, 4700.036492519042, 4649.814007439699, 4656.115338085753, 4659.044895796371, 4659.650526210531, 4665.253559430492, 4495.325701144821, 4608.723476591415, 4610.077984403116, 4610.723356598598, 4618.330342100377, 3986.222686576119, 3994.2810294147043, 4000.57993910641, 4001.9399709004388, 4002.2795896738576, 12266.26402415858, 12395.194312369757, 12682.175658582162, 12711.110222284444, 12716.109872308849, 1680.462252079335, 1708.4276767282975, 1758.8944663320242, 1809.3215044358365, 1813.9365122220659, 9188.173064424234, 9328.48693321867, 9406.43561386319, 9580.233581313478, 9601.567929443192, 1655.0731590309465, 1658.5024492652155, 1673.0881669490157, 1699.699759608181, 1722.3971609936548, 52900.47099528994, 55011.44988550103, 55604.44395556074, 55899.0, 55931.44068559303, 6533.705983230766, 6593.6703164841565, 6718.984304708666, 6740.730370785113, 6772.288909664513, 7782.338501227346, 7838.64726087316, 7850.528968261922, 7853.371730261565, 7865.095514015961, 5061.5950723942, 5079.390473143247, 5080.110980578384, 5083.7203953782155, 5136.0, 4981.452040275567, 5003.474635163256, 5202.479752024843, 5228.215767634885, 5244.501772331622, 3071.769617278713, 3074.339017111332, 3077.615298087739, 3094.009916826594, 3123.593932788723, 1038.127972503101, 1076.020821052838, 1079.2499213046858, 1097.4567589043475, 1142.3716955674513, 409.94875640544933, 416.4877201042734, 417.5365344467638, 427.6407817433309, 441.14858323435436, 10890.782184356269, 11176.0, 11299.265547739371, 11374.658760237206, 11375.431228438545, 393.79719444486113, 429.4074177634844, 430.67699225580816, 449.3439578215841, 463.9234526303122, 4109.404136400265, 5662.0, 5970.432808883149, 6381.361863813674, 6440.967795161088, 504247.0, 512736.0, 513809.0, 521914.0, 522700.0, 67666.0, 68593.31406685969, 69052.65473672599, 69323.0, 69683.65158174177, 498.9650724449254, 508.29093414686304, 509.7043714645497, 510.535412774381, 512.8000079968815, 10472.790544189225, 10528.736781580521, 10605.522751476048, 10652.467376631292, 10676.46617669129, 29486.852565737034, 29718.851405742833, 32562.837185813918, 33065.338693226484, 33379.49930750992, 39698.0, 40921.38617920674, 41494.0, 42907.7854610725, 43283.783581081894, 12982.870171298544, 13052.934735326262, 13497.325133743077, 13501.054926155075, 13531.391087400894, 16754.832451675815, 17033.74449383285, 17268.0, 17765.0, 17920.551986199927, 14318.212498312692, 14654.706905861609, 14824.925875370554, 14880.107193568421, 15151.621209469851, 13805.0, 13896.722065558835, 14226.00417970732, 14395.856041439452, 14604.342804574033, 10468.790624187626, 14280.714385712436, 14466.927665362027, 15221.31504082341, 15444.613884652974, 13224.140430871963, 13275.402606882906, 13293.534726284533, 13344.065915386218, 13409.262490562722, 9118.908810912071, 14043.578692639237, 14114.364853581408, 14355.066920650124, 14663.266836657911], "dojo.html": [2645.5767077267633, 2734.1660793457986, 2755.352492164341, 2758.034687859248, 2775.7640600548953, 4623.052274283772, 4756.405449318835, 4803.375561177047, 4825.155597770389, 4846.418429788426, 4690.530946905308, 4774.904501909959, 4835.178019736644, 4854.101991131643, 4870.196417591102, 4398.890027749316, 4411.095725376306, 4416.690831641787, 4529.977350113245, 4567.680262381635, 4484.282514797633, 4501.999999999984, 4556.179887620227, 4575.153596584626, 4600.884977875547, 4257.638100761439, 4301.37630043645, 4378.999999999968, 4379.08039311745, 4381.9561804381865, 4440.533743956903, 4482.125985432842, 4487.798049087799, 4490.101979604092, 4529.4791099023705, 4254.340577210506, 4472.619827314682, 4476.597106260452, 4478.171538265431, 4484.103179364108, 4631.560001799824, 4679.9532004680195, 4705.341252224691, 4733.337332773414, 4759.619230461555, 5176.922346164811, 5189.818356357547, 5218.03466358721, 5225.399079105913, 5256.053910296145, 4941.48114447985, 5059.139946209153, 5232.529072383504, 5236.083685355047, 5242.659227150223, 4689.273162659793, 4741.881452963704, 4756.571908528214, 4781.947971446276, 4814.711117332971, 5228.424873263938, 5238.947610523846, 5242.292290540804, 5244.632875698664, 5250.501202385767, 4810.278458231293, 4944.134776414113, 5039.69761814285, 5046.1926091825135, 5083.796648134107, 5066.138756411346, 5135.4094279157625, 5242.056429842665, 5242.868928276824, 5267.26258323835, 5122.154844450624, 5141.048905952336, 5144.588432925357, 5161.354830646169, 5198.064348417245, 4882.194437917775, 5017.724025178577, 5112.258722485219, 5126.871828204325, 5127.948720512822, 4118.938215926763, 4169.0, 4212.620864122244, 4220.2192594370135, 4234.9364759528635, 3672.926541469156, 3680.9877283747182, 3689.94465083024, 3706.054955986206, 3709.0727318170457, 4412.691111622155, 4414.3157810539415, 4433.7118087324225, 4438.489573699001, 4458.398116254329, 4906.656534042583, 4986.775595098229, 5018.774155163026, 5029.321041659402, 5176.120059589879, 4370.278903980808, 4423.248047831877, 4444.0, 4446.177457170434, 4480.462344518679, 4573.062522182944, 4576.359309696645, 4582.381378513925, 4593.770311484413, 4625.814967401334, 4665.603423708955, 4766.165920963748, 4785.0, 4791.496892826203, 4888.071266459361, 5162.406323272871, 5195.298634684269, 5208.427073021889, 5209.661372010807, 5210.400803907599, 4921.729304888266, 4922.630802689884, 4925.088858561177, 4930.852074437773, 4931.16170251051, 4839.2983017462975, 4918.581920536794, 4953.133201689618, 4960.77676504551, 5038.697678139323, 5171.586273098068, 5199.0, 5202.817901373433, 5204.739763011758, 5207.791688332424, 4999.200127979651, 5004.974975125101, 5007.023630392185, 5009.949900500948, 5032.094223039888, 4792.880177995578, 4914.410270767387, 4919.188333925005, 4923.926141107958, 5034.421041580265, 4892.0, 4897.779599917941, 4902.093112774148, 4906.0433215522635, 4935.457099718957, 5001.57486613642, 5002.774875130701, 5025.547700706954, 5028.823991160292, 5062.316587260672, 4621.584057434847, 4730.101280756645, 4750.168720473972, 4757.524247575215, 4856.0], "mootools.html": [1019.7960407918418, 1549.6125968507872, 1618.2151656446624, 1626.7153248181573, 1660.5599516128227, 6088.756449742011, 6754.1894972603295, 6848.589084654925, 6849.178098628159, 6853.657317134136, 6701.832454188636, 6892.517523773326, 6912.205096413914, 6915.273896240898, 6920.273371296017, 1739.5738044179193, 1785.5803886086824, 2027.7059826325174, 2058.166442590753, 2082.1046949811575, 2053.8048885355865, 2056.3728062940872, 2061.989690051555, 2062.113291284747, 2063.515073957619, 1967.2426115945393, 1989.4230673104782, 2039.9796002039939, 2041.8876961767096, 2044.2231951858273, 2014.385612388221, 2031.908564114611, 2060.062671484471, 2060.1965233558926, 2061.9793802062013, 2051.3743308290964, 2066.966516741629, 2069.6791997240452, 2070.1615845582564, 2073.284716772711, 7008.474364422688, 7043.753468628624, 7051.506394552383, 7067.611281379522, 7075.610841403721, 4172.833086676529, 4243.639290660298, 4250.086231460251, 4257.787110644486, 4281.443412356405, 2331.4987277735368, 2641.643378143945, 2739.561670132789, 2758.655168103987, 2779.8471084090365, 794.8330850521339, 808.6765293882494, 825.1954344514111, 887.5828360670474, 927.8608208768738, 9658.468784216866, 9686.660966866126, 9708.90291097087, 9713.56288966991, 9716.368436051634, 3932.2528719543197, 3982.0, 3994.800259986989, 4007.479027726377, 4072.3077076897, 8284.875726864102, 8293.046299675614, 8321.583920803936, 8330.541820199947, 8340.0, 4318.762468064224, 4326.069894972596, 4327.069680018811, 4331.480222373272, 4334.566543345641, 3917.334053210961, 3933.1543718100174, 3938.03518138058, 3945.723799334019, 3946.2896678597554, 2725.74105459981, 2782.193163982463, 3261.6575259597876, 3350.212700015494, 3416.4362880125, 1041.3491567770143, 1058.2327812335996, 1063.239783554762, 1065.7708592652616, 1066.8453074304182, 883.9513826739462, 884.4118661090431, 912.7809325761903, 922.391221793613, 1181.9645410637695, 6593.40659340652, 6629.303923088103, 6642.701078451481, 6644.335566443317, 6647.501437392215, 1012.5342342522522, 1036.7252678040325, 1039.0856046678873, 1043.4052590023614, 1060.9045185933148, 4989.5758860496535, 5036.84889453317, 5048.596112311006, 5056.898862022813, 5057.898842023139, 7849.8038296833865, 8100.554469504234, 8334.541600211925, 8396.622152003174, 8416.074231834493, 8238.423310368336, 8311.750647480585, 8315.875261870955, 8317.209865062809, 8331.708390206313, 6364.49084073273, 6443.065755465431, 6538.509611779041, 6563.934360656428, 6574.441172500296, 6106.236720409949, 6126.816195514141, 6133.0, 6136.110264011782, 6139.754409823557, 7199.3520583147765, 7243.7464688735645, 7251.311125443074, 7330.083739532559, 7339.9633001834645, 7183.389411899838, 7416.295451932057, 7442.962785186256, 7490.4007679386605, 7491.475596708397, 6559.934400656123, 6640.933590664032, 6658.434033107046, 6664.033715111184, 6669.399754022162, 6636.170478690164, 6695.029220763059, 6714.630695311805, 6719.596824190564, 6725.293844146294, 6336.08126821599, 6435.871282574229, 6481.643509607017, 6542.574732642363, 6586.4401525870835, 6104.4505994460715, 6232.626042437469, 6298.433141017331, 6399.136116624196, 6507.73969041252, 6446.4520515756685, 6539.607623542603, 6540.247871494648, 6540.574862633914, 6542.0, 6008.969955150196, 6025.939740602713, 6043.516518678583, 6044.57687961856, 6046.27444706638, 5906.114082887601, 5919.852003699942, 5921.259842519685, 6052.122442245938, 6085.847853803691], "ext.html": [557.4676184244047, 575.6661136540806, 579.1052823387865, 582.1529674323857, 582.1733138942701, 25957.221283361505, 36770.264594708126, 37136.44295335572, 37146.8142659287, 37163.62836371636, 39786.0, 40298.395524067164, 40314.395284070764, 40315.79842100785, 40334.0, 7014.89477657833, 7130.180029296645, 7875.094364148111, 8053.073896501889, 8053.557054362008, 9970.800583988315, 10108.140808031327, 10127.240456965757, 10153.441560714158, 10191.796164076713, 10160.796784064314, 10266.97330266971, 10271.537780799845, 10277.0, 10283.0, 7095.89356159658, 7262.092238470192, 10127.999999999964, 10153.238507111997, 10469.895301046969, 9982.251331150193, 10118.797624047478, 10129.442880641562, 10132.392056476636, 10134.645287414905, 36630.63369366299, 37294.44058339127, 37351.4397284041, 37365.81317093397, 37389.62610373888, 2814.2401551581165, 2841.1476557032806, 2905.8111222770453, 3288.19439237386, 3314.933701325984, 28338.14985550416, 28397.0, 28638.856805715837, 28662.713372866212, 29037.274068148465, 3111.2532992081965, 3115.376924615063, 3166.1134882233014, 3217.9863343046864, 3273.7217336526423, 221216.0, 221494.0, 222454.0, 222906.0, 224529.0, 49846.252306215436, 51077.74461127745, 54049.72975135099, 54146.45853541493, 54460.72769636206, 55558.0, 55662.721686391305, 55754.72122639361, 55806.72096639491, 55925.0, 13761.724765504634, 13915.860841391457, 13968.720625587432, 13984.51054213118, 14040.0, 10358.326708763907, 10493.317934334244, 10558.102561282378, 10570.365778053341, 10570.471476426148, 18551.44345669632, 18777.0, 18788.71816922747, 18829.435116946515, 18904.432867014013, 6943.722251109899, 7198.712051517985, 7209.747658831916, 7324.37742791858, 7327.530206573985, 779.1896427715226, 846.8052347959881, 876.250805561236, 896.6861598440624, 971.3880255439028, 26151.869240653676, 26252.081177158707, 27315.317117071834, 27835.72164278372, 28575.0, 855.9657613695507, 926.8841394825647, 966.3670295956019, 984.6799790068256, 1063.2982231727024, 13196.538121165713, 13286.20282783036, 13430.395632196574, 13500.122492038183, 13511.932440337736, 269885.55400560884, 274816.0, 275341.0, 275793.0, 276456.0, 44763.0, 45110.77444612821, 45149.548504515195, 45153.0, 45157.322640160426, 1177.7666895566997, 1189.6668932698858, 1191.4042978510745, 1193.2780667696093, 1197.7903866823272, 20388.694169587172, 26002.479950401263, 26304.736952630996, 26581.0, 26824.865875670497, 36954.0, 37258.0, 37299.81350093232, 37341.2531749358, 37369.25261494701, 175135.0, 176768.1161594184, 177352.0, 178046.0, 178887.0, 24325.75674243235, 24692.876535617925, 26217.344566385993, 28224.576631350137, 28897.56653650239, 33538.0, 33630.0, 34104.829475852464, 34129.31741365109, 34510.654893450745, 30685.846570767004, 31383.686163138078, 31769.0, 32037.519437207993, 32198.0, 25070.74929250757, 29617.703822961495, 31866.840665796524, 32063.0, 32270.515942261354, 29645.407091858473, 29775.553366699085, 29892.70107298986, 29987.250318742204, 33209.0, 25254.873725631252, 26087.217383478524, 26718.46563068689, 26812.865935670197, 27134.72865271322, 21647.567048659253, 21796.891015545454, 21975.670364944857, 21995.010224539616, 22018.669719954534], "prototype.html": [307.686160116681, 312.72636443112276, 317.71723166381923, 322.24272958547414, 322.37620204903527, 5228.555572776314, 5420.972895135528, 5460.290162278908, 5467.425920278373, 5472.370677372103, 5293.57651387889, 5363.54409875161, 5367.221752845845, 5369.62412631115, 5384.0847056000475, 3878.709096817736, 3952.1502876881464, 3965.2069586082753, 4113.156802855422, 4121.536854416684, 4006.6794656427414, 4022.034711669193, 4027.617376349242, 4034.5965403459713, 4035.172789578144, 4002.6997975151835, 4003.3794761811964, 4005.459262999487, 4016.7389119707273, 4027.2146931348398, 3862.1310205203745, 3938.566757656641, 3941.211757648453, 4018.457508236409, 4026.4966879140106, 3457.0320310313155, 3460.169559305774, 3464.4110501214855, 3466.5666791651042, 3478.3217272631846, 5101.234814777776, 5108.259302401131, 5123.718195499246, 5129.256257842592, 5139.0749665060275, 4584.770761461914, 4585.358049872987, 4586.3579098926175, 4592.357070010201, 4601.033782905593, 5437.8368648940195, 5546.168074788774, 5549.639273447213, 5559.749811258463, 5565.916511252334, 3681.6134305897763, 3698.31581157484, 3699.3896007158787, 3703.5926048134684, 3704.9259014819822, 5764.221830052973, 5802.390748971339, 5849.151872978437, 5854.151148083504, 5864.325602555718, 3953.150072734376, 3962.980185099114, 3970.146418520032, 3970.3250447424007, 3983.183447393277, 3610.656987586175, 3733.4213196954515, 3790.1093243087853, 4027.0536423940353, 4034.9798251008556, 4394.340848872631, 4489.663275254369, 4547.3406356078185, 4656.720596764205, 4663.813447462064, 5434.83695489136, 5460.945390546044, 5588.469095435927, 5595.692236927008, 5597.048501754712, 1401.1453013661658, 1402.2077526197666, 1408.1339975914943, 1409.6475881029742, 1418.489343836218, 901.9909800901906, 948.6774496671165, 954.8663187153804, 961.9663311784054, 970.1850445625568, 4858.78135483904, 4859.95140048602, 4860.513948605111, 4862.07620552094, 4871.5128487151715, 5760.567957403212, 5765.135229715493, 5772.0, 5780.248567686174, 5782.959067367914, 4829.2997515360075, 4839.782209800567, 4849.0, 4852.805887764521, 4866.416030076342, 2858.4140251248446, 2974.078035808906, 3044.9238769030508, 3069.4628440022907, 3102.503599424081, 5386.811461598825, 5402.432744561765, 5414.8917021659345, 5418.512333889968, 5497.615166938356, 5949.434803693729, 5953.434423729739, 5955.702214889238, 5959.22530071088, 5965.403459654087, 5487.039768040657, 5487.862803429946, 5489.478499542537, 5496.587755918322, 5496.670199787945, 5664.518515926193, 5803.448672376117, 5807.651540907559, 5808.535317174531, 5819.621724587888, 5674.0354139797155, 5691.117876729114, 5696.060150075357, 5699.287589051369, 5699.800506982236, 5498.3127109111365, 5504.834854954358, 5505.174223866452, 5509.862253443696, 5515.22786809855, 3997.5802540732802, 4003.5796241394232, 4004.9199016020098, 4006.8797936061965, 4007.479027726377, 5680.715964201856, 5835.358110607915, 5837.824865254049, 5843.94156058451, 5856.180134781219, 5556.416576259435, 5587.525060369914, 5606.215129881738, 5609.382967873612, 5609.6073274872, 5622.578306626938, 5622.803201887914, 5623.3533143689, 5625.690587017753, 5630.23991761107, 5362.115250983544, 5481.671099734029, 5488.56091512686, 5503.807366742145, 5507.779688812563, 5610.551155907436, 5626.156076588544, 5638.9436105638415, 5642.492175704207, 5648.15277708347, 5302.840914772563, 5493.6978466183145, 5502.477264659851, 5502.5597952164535, 5509.752061157177], "yui.html": [751.2412463411954, 763.1529002806883, 770.4529783853463, 772.5480593852596, 796.9521828690278, 11199.328040317587, 11418.200725949166, 11475.713107172325, 11508.424578771059, 11518.424078796068, 11167.274127181727, 11248.718782030453, 11287.49206285717, 11318.603848865292, 11322.15083868711, 583.6702263221266, 592.5703864698103, 762.1349768013317, 776.7397921696211, 777.0442355902244, 772.6291380137509, 774.1445702498743, 779.5790273252437, 780.5667854340838, 782.0927723840347, 621.5059028072693, 626.2078470734524, 814.7515007922581, 814.9837003259931, 822.8930239068912, 799.1209669363711, 811.407672399149, 814.7229941819751, 814.7963009247688, 815.4821688227988, 599.8560345517088, 602.2441835496423, 602.4036204157896, 603.6709993053796, 604.1481511069371, 11640.476178571984, 11819.822702659467, 11847.585334513336, 11863.644090677293, 11870.169088163746, 8944.373893827435, 8945.604152035414, 9093.499857507835, 10334.328268662588, 10500.684979450629, 8529.95735021321, 8586.31309495239, 8645.956770216171, 8731.650733970633, 9091.227245684058, 2700.4464084862557, 2700.9189724308303, 2702.8918843246247, 2727.440874620698, 2777.8888844446196, 38190.80904595487, 38222.0, 38303.0, 39065.41401878974, 39090.609093908985, 6369.8726025480155, 6400.615963042233, 6483.7730679425995, 6560.803175904731, 6699.866002679919, 10278.434686092336, 10332.070113689804, 10361.63734269297, 10365.170786337076, 10381.532831022621, 5566.777328906798, 5587.3015873015875, 5587.525060369833, 5610.551155907518, 5665.3768085510565, 3410.8635654574036, 3493.825308734553, 3497.772644778132, 3567.7324200685052, 3636.2727454509204, 2327.3483424641126, 2355.9293221203393, 2363.988180059123, 2364.47981444082, 2366.278285123054, 373.24045567270474, 377.56391367970036, 381.47356647825825, 382.7875529081331, 383.3176945037837, 506.42014892947367, 557.8382269141985, 565.7963133272019, 581.8109114537792, 594.0643486508766, 7244.637768111679, 7326.084239470067, 7566.1298950621385, 7634.351080158138, 7663.003809504728, 518.7717404342077, 572.7079189613244, 586.2232541881938, 600.6786369292407, 620.7951376045984, 3447.172678557128, 3617.565892092966, 3652.543432070991, 3666.926661466756, 3721.1999420124803, 44584.3312350315, 47735.283970740464, 47784.0, 47803.28295075577, 47815.282770758466, 42288.365674514906, 42945.0, 43177.0, 43676.01928978521, 46195.307070393974, 39522.0, 40119.598804011584, 40287.99999999941, 40966.38550421746, 41332.0, 7522.924770752223, 7525.8494830102, 7667.69329226847, 7675.961620191863, 7878.645460954156, 30710.0, 31063.378732425677, 31203.68796312008, 31926.0, 32149.67850321467, 38119.61880381161, 38634.6136538631, 38663.806680966416, 40127.59872401239, 40330.59669403268, 6816.147981502312, 6955.930440695528, 6982.441404687715, 7035.110598134452, 7347.412207023318, 11308.151888608223, 11319.547218111513, 11344.319340839576, 11373.943130284295, 11453.255538389978, 10701.464926753786, 10731.248812583044, 10840.0, 10852.240343175901, 10965.177611679315, 9571.760705982406, 9697.224222062077, 9870.802583948138, 9905.504724763588, 10272.126869216201, 10768.946155269174, 10774.0, 10774.407407592658, 10973.3964631946, 11176.832347514632, 9259.953700231456, 9282.58228379711, 9531.761705957406, 9577.952110239683, 9825.55784989663, 8976.31970891931, 9490.667826626312, 9513.952430237805, 9515.381500202464, 9519.238460923249]}, "summary": {"lowerIsBetter": false, "suite": 6042.18631255996, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6997.516654472507, "unit": "ms", "value": 6997.516654472507}, "dojo.html": {"lowerIsBetter": false, "filtered": 4696.541429850013, "unit": "ms", "value": 4696.541429850013}, "mootools.html": {"lowerIsBetter": false, "filtered": 4024.940731226863, "unit": "ms", "value": 4024.940731226863}, "ext.html": {"lowerIsBetter": false, "filtered": 16620.287922012336, "unit": "ms", "value": 16620.287922012336}, "prototype.html": {"lowerIsBetter": false, "filtered": 4157.585208915852, "unit": "ms", "value": 4157.585208915852}, "yui.html": {"lowerIsBetter": false, "filtered": 5323.043918124627, "unit": "ms", "value": 5323.043918124627}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-048"}, "testrun": {"date": 1447647767, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115191231", "branch": "Firefox-Non-PGO", "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 161.0, 159.0, 161.0, 160.0, 163.0, 161.0, 161.0, 161.0], "ai-astar": [111.0, 112.0, 107.0, 112.0, 111.0, 113.0, 103.0, 111.0, 103.0, 112.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "audio-beat-detection": [156.0, 131.0, 156.0, 173.0, 139.0, 159.0, 152.0, 134.0, 168.0, 132.0], "json-stringify-tinderbox": [70.0, 69.0, 70.0, 69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [151.0, 149.0, 163.0, 149.0, 151.0, 140.0, 151.0, 149.0, 149.0, 137.0], "json-parse-financial": [70.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 78.0, 67.0, 67.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 72.0, 72.0, 70.0, 70.0, 70.0, 69.0, 71.0, 70.0], "audio-fft": [73.0, 74.0, 85.0, 90.0, 72.0, 72.0, 72.0, 98.0, 91.0, 73.0], "imaging-darkroom": [149.0, 147.0, 147.0, 149.0, 155.0, 148.0, 147.0, 148.0, 147.0, 147.0], "stanford-crypto-ccm": [128.0, 127.0, 119.0, 119.0, 126.0, 121.0, 128.0, 123.0, 120.0, 121.0], "audio-oscillator": [96.0, 93.0, 137.0, 92.0, 92.0, 91.0, 127.0, 91.0, 102.0, 126.0], "stanford-crypto-aes": [87.0, 83.0, 83.0, 84.0, 85.0, 83.0, 83.0, 84.0, 84.0, 97.0], "imaging-desaturate": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0]}, "summary": {"lowerIsBetter": true, "suite": 1524.2000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.0, "unit": "ms", "value": 80.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.9, "unit": "ms", "value": 148.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.0, "unit": "ms", "value": 150.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.2, "unit": "ms", "value": 123.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.4, "unit": "ms", "value": 148.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 69.4, "unit": "ms", "value": 69.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.7, "unit": "ms", "value": 104.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.9, "unit": "ms", "value": 160.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.2, "unit": "ms", "value": 70.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.4, "unit": "ms", "value": 69.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.3, "unit": "ms", "value": 85.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.0, "unit": "ms", "value": 95.0}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-048"}, "testrun": {"date": 1447647767, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115191231", "branch": "Firefox-Non-PGO", "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.1598770176787], "Encrypt": [282.4858757062147], "NavierStokes": [4850.241545893719], "Decrypt": [5035.175879396985], "Splay": [622.6065472513898], "Richards": [170.41581458759373], "RegExp": [27270.27027027027], "Earley": [815.6606851549756], "Boyer": [12096.385542168675], "RayTrace": [1974.3589743589744]}, "summary": {"lowerIsBetter": false, "suite": 19591.76796234647, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 344.07807199999985, "unit": "score", "value": 344.07807199999985}, "Encrypt": {"lowerIsBetter": false, "filtered": 942.2807399999999, "unit": "score", "value": 942.2807399999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 305.9641434262948, "unit": "score", "value": 305.9641434262948}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 130.88683432539688, "unit": "score", "value": 130.88683432539688}, "RegExp": {"lowerIsBetter": false, "filtered": 33.405792864221986, "unit": "score", "value": 33.405792864221986}, "Richards": {"lowerIsBetter": false, "filtered": 207.15213600000004, "unit": "score", "value": 207.15213600000004}, "Earley": {"lowerIsBetter": false, "filtered": 817.0836380000003, "unit": "score", "value": 817.0836380000003}, "Boyer": {"lowerIsBetter": false, "filtered": 55.096044820717125, "unit": "score", "value": 55.096044820717125}, "RayTrace": {"lowerIsBetter": false, "filtered": 374.7996233766234, "unit": "score", "value": 374.7996233766234}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-048"}, "testrun": {"date": 1447647767, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115191231", "branch": "Firefox-Non-PGO", "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4"}}] 20:43:08 INFO - RETURN: dromaeo_css: 6042.19 20:43:08 INFO - RETURN: kraken: 1524.20 20:43:08 INFO - RETURN: v8_7: 19591.77 20:43:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19591.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1524.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6042.19"}}} 20:43:08 INFO - Return code: 0 20:43:08 INFO - # TBPL SUCCESS # 20:43:08 INFO - Running post-action listener: _resource_record_post_action 20:43:08 INFO - Running post-run listener: _resource_record_post_run 20:43:09 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 24576; Write bytes: 509665280; Read time: 608; Write time: 717508 20:43:09 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 79724544; Read time: 0; Write time: 43196 20:43:09 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 20480; Write bytes: 370995200; Read time: 312; Write time: 571972 20:43:09 INFO - Running post-run listener: _upload_blobber_files 20:43:09 INFO - Blob upload gear active. 20:43:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:43:09 INFO - Copying logs to upload dir... 20:43:09 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.983435 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-15 20:43:08.288979) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 20:43:08.292555) ========= 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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010111 build_url: 'https://queue.taskcluster.net/v1/task/IlNkOXCLSfuZIyJUJXisSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 20:43:08.346875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:43:08.347455) ========= 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-1447642009.609266-1255954101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 20:43:08.402363) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 20:43:08.403209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 20:43:08.403892) ========= ========= Total master_lag: 0.23 =========