builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1448623556.02 results: success (0) buildid: 20151127020611 builduid: c44d237dab494c4db5f648803ec0847b revision: ad985ade8a2e5e58123f0a774605d273834c3ba1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.021988) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.022450) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.022785) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007840 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.063866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.064153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.097928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.098576) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003621 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.151680) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.152273) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.152912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.153406) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-27 03:25:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-27 03:25:56 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.257352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.424417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.424733) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.475162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:56.475573) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad985ade8a2e5e58123f0a774605d273834c3ba1 --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 ad985ade8a2e5e58123f0a774605d273834c3ba1 --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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-27 03:25:56,621 truncating revision to first 12 chars 2015-11-27 03:25:56,621 Setting DEBUG logging. 2015-11-27 03:25:56,621 attempt 1/10 2015-11-27 03:25:56,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad985ade8a2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-27 03:25:56,873 unpacking tar archive at: mozilla-central-ad985ade8a2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587605 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:57.075617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:57.075944) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:57.086486) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:57.086820) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 03:25:57.087267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-27 03:25:57.087560) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:57 INFO - MultiFileLogger online at 20151127 03:25:57 in /builds/slave/test 03:25:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 03:25:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:57 INFO - {'append_to_log': False, 03:25:57 INFO - 'base_work_dir': '/builds/slave/test', 03:25:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:25:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:57 INFO - 'branch': 'Firefox-Non-PGO', 03:25:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:57 INFO - 'config_files': ('talos/linux_config.py',), 03:25:57 INFO - 'default_actions': ('clobber', 03:25:57 INFO - 'read-buildbot-config', 03:25:57 INFO - 'download-and-extract', 03:25:57 INFO - 'populate-webroot', 03:25:57 INFO - 'create-virtualenv', 03:25:57 INFO - 'install', 03:25:57 INFO - 'run-tests'), 03:25:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:57 INFO - 'download_minidump_stackwalk': True, 03:25:57 INFO - 'download_symbols': 'ondemand', 03:25:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:57 INFO - 'installer_path': 'installer.exe', 03:25:57 INFO - 'log_level': 'info', 03:25:57 INFO - 'log_name': 'talos', 03:25:57 INFO - 'log_to_console': True, 03:25:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:57 INFO - 'opt_config_files': (), 03:25:57 INFO - 'pip_index': False, 03:25:57 INFO - 'sps_profile': False, 03:25:57 INFO - 'sps_profile_interval': 0, 03:25:57 INFO - 'suite': 'dromaeojs-e10s', 03:25:57 INFO - 'system_bits': '64', 03:25:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:57 INFO - 'title': 'talos-linux64-ix-041', 03:25:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:57 INFO - 'use_talos_json': True, 03:25:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:57 INFO - 'work_dir': 'build'} 03:25:57 INFO - ##### 03:25:57 INFO - ##### Running clobber step. 03:25:57 INFO - ##### 03:25:57 INFO - Running pre-action listener: _resource_record_pre_action 03:25:57 INFO - Running main action method: clobber 03:25:57 INFO - rmtree: /builds/slave/test/build 03:25:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:57 INFO - Running post-action listener: _resource_record_post_action 03:25:57 INFO - ##### 03:25:57 INFO - ##### Running read-buildbot-config step. 03:25:57 INFO - ##### 03:25:57 INFO - Running pre-action listener: _resource_record_pre_action 03:25:57 INFO - Running main action method: read_buildbot_config 03:25:57 INFO - Using buildbot properties: 03:25:57 INFO - { 03:25:57 INFO - "properties": { 03:25:57 INFO - "buildnumber": 126, 03:25:57 INFO - "product": "firefox", 03:25:57 INFO - "script_repo_revision": "production", 03:25:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:25:57 INFO - "repository": "", 03:25:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:25:57 INFO - "buildid": "20151127020611", 03:25:57 INFO - "slavename": "talos-linux64-ix-041", 03:25:57 INFO - "pgo_build": "False", 03:25:57 INFO - "basedir": "/builds/slave/test", 03:25:57 INFO - "project": "", 03:25:57 INFO - "platform": "ubuntu64_hw", 03:25:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:25:57 INFO - "slavebuilddir": "test", 03:25:57 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:25:57 INFO - "branch": "mozilla-central", 03:25:57 INFO - "repo_path": "mozilla-central", 03:25:57 INFO - "stage_platform": "linux64", 03:25:57 INFO - "builduid": "c44d237dab494c4db5f648803ec0847b", 03:25:57 INFO - "revision": "ad985ade8a2e5e58123f0a774605d273834c3ba1" 03:25:57 INFO - }, 03:25:57 INFO - "sourcestamp": { 03:25:57 INFO - "repository": "", 03:25:57 INFO - "hasPatch": false, 03:25:57 INFO - "project": "", 03:25:57 INFO - "branch": "mozilla-central-linux64-talos", 03:25:57 INFO - "changes": [ 03:25:57 INFO - { 03:25:57 INFO - "category": null, 03:25:57 INFO - "files": [ 03:25:57 INFO - { 03:25:57 INFO - "url": null, 03:25:57 INFO - "name": "https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:25:57 INFO - } 03:25:57 INFO - ], 03:25:57 INFO - "repository": "", 03:25:57 INFO - "rev": "ad985ade8a2e5e58123f0a774605d273834c3ba1", 03:25:57 INFO - "who": "cbook@mozilla.com", 03:25:57 INFO - "when": 1448623524, 03:25:57 INFO - "number": 6714453, 03:25:57 INFO - "comments": "merge fx-team to mozilla-central a=merge", 03:25:57 INFO - "project": "", 03:25:57 INFO - "at": "Fri 27 Nov 2015 03:25:24", 03:25:57 INFO - "branch": "mozilla-central-linux64-talos", 03:25:57 INFO - "revlink": "", 03:25:57 INFO - "properties": [ 03:25:57 INFO - [ 03:25:57 INFO - "buildid", 03:25:57 INFO - "20151127020611", 03:25:57 INFO - "Change" 03:25:57 INFO - ], 03:25:57 INFO - [ 03:25:57 INFO - "builduid", 03:25:57 INFO - "c44d237dab494c4db5f648803ec0847b", 03:25:57 INFO - "Change" 03:25:57 INFO - ], 03:25:57 INFO - [ 03:25:57 INFO - "pgo_build", 03:25:57 INFO - "False", 03:25:57 INFO - "Change" 03:25:57 INFO - ] 03:25:57 INFO - ], 03:25:57 INFO - "revision": "ad985ade8a2e5e58123f0a774605d273834c3ba1" 03:25:57 INFO - } 03:25:57 INFO - ], 03:25:57 INFO - "revision": "ad985ade8a2e5e58123f0a774605d273834c3ba1" 03:25:57 INFO - } 03:25:57 INFO - } 03:25:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:25:57 INFO - Running post-action listener: _resource_record_post_action 03:25:57 INFO - ##### 03:25:57 INFO - ##### Running download-and-extract step. 03:25:57 INFO - ##### 03:25:57 INFO - Running pre-action listener: _resource_record_pre_action 03:25:57 INFO - Running main action method: download_and_extract 03:25:57 INFO - mkdir: /builds/slave/test/build/tests 03:25:57 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')]} 03:25:57 INFO - https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:25:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/test_packages.json 03:25:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/test_packages.json 03:25:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:25:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:25:58 INFO - Downloaded 1302 bytes. 03:25:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:25:58 INFO - Using the following test package requirements: 03:25:58 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:58 INFO - u'jsshell-linux-x86_64.zip'], 03:25:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:25:58 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:25:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:25:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:25:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:58 INFO - https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:25:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:25:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:25:59 INFO - Downloaded 21515003 bytes. 03:25:59 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 03:25:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:25:59 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 03:26:00 INFO - Return code: 0 03:26:00 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 03:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:26:00 INFO - https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:26:08 INFO - Downloaded 21515003 bytes. 03:26:08 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 03:26:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:26:08 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 03:26:09 INFO - Return code: 0 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:09 INFO - https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:26:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:26:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:26:10 INFO - Downloaded 11131728 bytes. 03:26:10 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 03:26:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:26:10 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 03:26:10 INFO - Return code: 0 03:26: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')]} 03:26:10 INFO - https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:26:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:26:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:26:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:26:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gjxbKD0lQMePbckhsWjs0w/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 03:26:12 INFO - Downloaded 56870456 bytes. 03:26:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:26:12 INFO - mkdir: /builds/slave/test/properties 03:26:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:12 INFO - Contents: 03:26:12 INFO - build_url:https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:26:12 INFO - Running post-action listener: _resource_record_post_action 03:26:12 INFO - Running post-action listener: set_extra_try_arguments 03:26:12 INFO - ##### 03:26:12 INFO - ##### Running populate-webroot step. 03:26:12 INFO - ##### 03:26:12 INFO - Running pre-action listener: _resource_record_pre_action 03:26:12 INFO - Running main action method: populate_webroot 03:26:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:26:12 INFO - '../fennec_ids.txt'], 03:26:12 INFO - 'tests': ['tcheck2']}, 03:26:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:12 INFO - '--tppagecycles', 03:26:12 INFO - '7'], 03:26:12 INFO - 'tests': ['tsvgm']}}, 03:26:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:26:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:26:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:26:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'tests': ['damp', 'tps']}, 03:26:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['damp', 'tps']}, 03:26:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:26:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:12 INFO - 'other': {'tests': ['a11yr', 03:26:12 INFO - 'ts_paint', 03:26:12 INFO - 'tpaint', 03:26:12 INFO - 'sessionrestore', 03:26:12 INFO - 'sessionrestore_no_auto_restore']}, 03:26:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['a11yr', 03:26:12 INFO - 'ts_paint', 03:26:12 INFO - 'tpaint', 03:26:12 INFO - 'sessionrestore', 03:26:12 INFO - 'sessionrestore_no_auto_restore']}, 03:26:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['a11yr', 03:26:12 INFO - 'ts_paint', 03:26:12 INFO - 'tpaint', 03:26:12 INFO - 'sessionrestore', 03:26:12 INFO - 'sessionrestore_no_auto_restore']}, 03:26:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['a11yr', 03:26:12 INFO - 'ts_paint', 03:26:12 INFO - 'tpaint', 03:26:12 INFO - 'sessionrestore', 03:26:12 INFO - 'sessionrestore_no_auto_restore']}, 03:26:12 INFO - 'other_l64': {'tests': ['a11yr', 03:26:12 INFO - 'ts_paint', 03:26:12 INFO - 'tpaint', 03:26:12 INFO - 'sessionrestore', 03:26:12 INFO - 'sessionrestore_no_auto_restore']}, 03:26:12 INFO - 'other_nol64': {'tests': ['a11yr', 03:26:12 INFO - 'ts_paint', 03:26:12 INFO - 'tpaint', 03:26:12 INFO - 'sessionrestore', 03:26:12 INFO - 'sessionrestore_no_auto_restore']}, 03:26:12 INFO - 'svgr': {'tests': ['tsvgx', 03:26:12 INFO - 'tsvgr_opacity', 03:26:12 INFO - 'tart', 03:26:12 INFO - 'tscrollx', 03:26:12 INFO - 'cart']}, 03:26:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['tsvgx', 03:26:12 INFO - 'tsvgr_opacity', 03:26:12 INFO - 'tart', 03:26:12 INFO - 'tscrollx', 03:26:12 INFO - 'cart']}, 03:26:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'tests': ['tp5o']}, 03:26:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'talos_options': ['--e10s'], 03:26:12 INFO - 'tests': ['tp5o']}, 03:26:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'talos_options': ['--xperf_path', 03:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:12 INFO - 'tests': ['tp5n']}, 03:26:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:12 INFO - 'talos_options': ['--e10s', 03:26:12 INFO - '--xperf_path', 03:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:12 INFO - 'tests': ['tp5n']}}, 03:26:12 INFO - 'talos.zip': {'path': '', 03:26:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:12 INFO - Running post-action listener: _resource_record_post_action 03:26:12 INFO - ##### 03:26:12 INFO - ##### Running create-virtualenv step. 03:26:12 INFO - ##### 03:26:12 INFO - Running pre-action listener: _resource_record_pre_action 03:26:12 INFO - Running main action method: create_virtualenv 03:26:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:12 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 03:26:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:12 INFO - Using real prefix '/usr' 03:26:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:15 INFO - Installing pip.................done. 03:26:15 INFO - Return code: 0 03:26:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:15 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 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:15 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 03:26:15 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 03:26:15 INFO - Using env: {'DISPLAY': ':0', 03:26:15 INFO - 'HOME': '/home/cltbld', 03:26:15 INFO - 'LANG': 'en_US.UTF-8', 03:26:15 INFO - 'LANGUAGE': 'en_US:en', 03:26:15 INFO - 'LOGNAME': 'cltbld', 03:26:15 INFO - 'MAIL': '/var/mail/cltbld', 03:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:15 INFO - 'MOZ_NO_REMOTE': '1', 03:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:15 INFO - 'NO_EM_RESTART': '1', 03:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:15 INFO - 'PWD': '/builds/slave/test', 03:26:15 INFO - 'SHELL': '/bin/bash', 03:26:15 INFO - 'SHLVL': '1', 03:26:15 INFO - 'TERM': 'linux', 03:26:15 INFO - 'TMOUT': '86400', 03:26:15 INFO - 'USER': 'cltbld', 03:26:15 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:15 INFO - '_': '/tools/buildbot/bin/python'} 03:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:16 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 03:26:16 INFO - Cleaning up... 03:26:16 INFO - Return code: 0 03:26:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:26:16 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')]} 03:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:16 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')]} 03:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:16 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 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:16 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 03:26:16 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 03:26:16 INFO - Using env: {'DISPLAY': ':0', 03:26:16 INFO - 'HOME': '/home/cltbld', 03:26:16 INFO - 'LANG': 'en_US.UTF-8', 03:26:16 INFO - 'LANGUAGE': 'en_US:en', 03:26:16 INFO - 'LOGNAME': 'cltbld', 03:26:16 INFO - 'MAIL': '/var/mail/cltbld', 03:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:16 INFO - 'MOZ_NO_REMOTE': '1', 03:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:16 INFO - 'NO_EM_RESTART': '1', 03:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:16 INFO - 'PWD': '/builds/slave/test', 03:26:16 INFO - 'SHELL': '/bin/bash', 03:26:16 INFO - 'SHLVL': '1', 03:26:16 INFO - 'TERM': 'linux', 03:26:16 INFO - 'TMOUT': '86400', 03:26:16 INFO - 'USER': 'cltbld', 03:26:16 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:16 INFO - '_': '/tools/buildbot/bin/python'} 03:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:16 INFO - Downloading/unpacking psutil>=0.7.1 03:26:16 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 03:26:16 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 03:26:16 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 03:26:16 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 03:26:16 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 03:26:16 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 03:26:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:26:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:19 INFO - Installing collected packages: psutil 03:26:19 INFO - Running setup.py install for psutil 03:26:19 INFO - building 'psutil._psutil_linux' extension 03:26:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:26:21 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 03:26:21 INFO - building 'psutil._psutil_posix' extension 03:26:21 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 03:26:21 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 03:26:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:21 INFO - Successfully installed psutil 03:26:21 INFO - Cleaning up... 03:26:21 INFO - Return code: 0 03:26:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:21 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 03:26:21 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 03:26:21 INFO - Using env: {'DISPLAY': ':0', 03:26:21 INFO - 'HOME': '/home/cltbld', 03:26:21 INFO - 'LANG': 'en_US.UTF-8', 03:26:21 INFO - 'LANGUAGE': 'en_US:en', 03:26:21 INFO - 'LOGNAME': 'cltbld', 03:26:21 INFO - 'MAIL': '/var/mail/cltbld', 03:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:21 INFO - 'MOZ_NO_REMOTE': '1', 03:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:21 INFO - 'NO_EM_RESTART': '1', 03:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:21 INFO - 'PWD': '/builds/slave/test', 03:26:21 INFO - 'SHELL': '/bin/bash', 03:26:21 INFO - 'SHLVL': '1', 03:26:21 INFO - 'TERM': 'linux', 03:26:21 INFO - 'TMOUT': '86400', 03:26:21 INFO - 'USER': 'cltbld', 03:26:21 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:21 INFO - '_': '/tools/buildbot/bin/python'} 03:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:26:21 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 03:26:21 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 03:26:21 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 03:26:21 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 03:26:21 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 03:26:21 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 03:26:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:23 INFO - Installing collected packages: mozsystemmonitor 03:26:23 INFO - Running setup.py install for mozsystemmonitor 03:26:23 INFO - Successfully installed mozsystemmonitor 03:26:23 INFO - Cleaning up... 03:26:23 INFO - Return code: 0 03:26:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:23 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')]} 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 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')]} 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 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 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:23 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 03:26:23 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 03:26:23 INFO - Using env: {'DISPLAY': ':0', 03:26:23 INFO - 'HOME': '/home/cltbld', 03:26:23 INFO - 'LANG': 'en_US.UTF-8', 03:26:23 INFO - 'LANGUAGE': 'en_US:en', 03:26:23 INFO - 'LOGNAME': 'cltbld', 03:26:23 INFO - 'MAIL': '/var/mail/cltbld', 03:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:23 INFO - 'MOZ_NO_REMOTE': '1', 03:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:23 INFO - 'NO_EM_RESTART': '1', 03:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:23 INFO - 'PWD': '/builds/slave/test', 03:26:23 INFO - 'SHELL': '/bin/bash', 03:26:23 INFO - 'SHLVL': '1', 03:26:23 INFO - 'TERM': 'linux', 03:26:23 INFO - 'TMOUT': '86400', 03:26:23 INFO - 'USER': 'cltbld', 03:26:23 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:23 INFO - '_': '/tools/buildbot/bin/python'} 03:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:26 INFO - Downloading docopt-0.6.1.tar.gz 03:26:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:26 INFO - Running setup.py install for blobuploader 03:26:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:26 INFO - Running setup.py install for requests 03:26:26 INFO - Running setup.py install for docopt 03:26:26 INFO - Successfully installed blobuploader requests docopt 03:26:26 INFO - Cleaning up... 03:26:26 INFO - Return code: 0 03:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:26 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')]} 03:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:26 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')]} 03:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:26 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 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:26 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 03:26:26 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 03:26:26 INFO - Using env: {'DISPLAY': ':0', 03:26:26 INFO - 'HOME': '/home/cltbld', 03:26:26 INFO - 'LANG': 'en_US.UTF-8', 03:26:26 INFO - 'LANGUAGE': 'en_US:en', 03:26:26 INFO - 'LOGNAME': 'cltbld', 03:26:26 INFO - 'MAIL': '/var/mail/cltbld', 03:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:26 INFO - 'MOZ_NO_REMOTE': '1', 03:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:26 INFO - 'NO_EM_RESTART': '1', 03:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:26 INFO - 'PWD': '/builds/slave/test', 03:26:26 INFO - 'SHELL': '/bin/bash', 03:26:26 INFO - 'SHLVL': '1', 03:26:26 INFO - 'TERM': 'linux', 03:26:26 INFO - 'TMOUT': '86400', 03:26:26 INFO - 'USER': 'cltbld', 03:26:26 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:26 INFO - '_': '/tools/buildbot/bin/python'} 03:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:27 INFO - Running setup.py (path:/tmp/pip-9uGIiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:27 INFO - Running setup.py (path:/tmp/pip-FnAI6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:27 INFO - Running setup.py (path:/tmp/pip-4O_QBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:27 INFO - Running setup.py (path:/tmp/pip-LJSK5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:27 INFO - Running setup.py (path:/tmp/pip-BwYcwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:27 INFO - Running setup.py (path:/tmp/pip-LKyUE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:27 INFO - Running setup.py (path:/tmp/pip-wugk_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:27 INFO - Running setup.py (path:/tmp/pip-t0tRuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:27 INFO - Running setup.py (path:/tmp/pip-UiczpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:27 INFO - Running setup.py (path:/tmp/pip-ltekMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:27 INFO - Running setup.py (path:/tmp/pip-pJnCzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:27 INFO - Running setup.py (path:/tmp/pip-5HQV46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:28 INFO - Running setup.py (path:/tmp/pip-WgiPsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:28 INFO - Running setup.py (path:/tmp/pip-IpV2YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:28 INFO - Running setup.py (path:/tmp/pip-cBoAPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:28 INFO - Running setup.py (path:/tmp/pip-d9r0PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:28 INFO - Running setup.py (path:/tmp/pip-MkzogU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:28 INFO - Running setup.py install for manifestparser 03:26:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:28 INFO - Running setup.py install for mozcrash 03:26:28 INFO - Running setup.py install for mozdebug 03:26:28 INFO - Running setup.py install for mozdevice 03:26:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:28 INFO - Running setup.py install for mozfile 03:26:28 INFO - Running setup.py install for mozhttpd 03:26:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:28 INFO - Running setup.py install for mozinfo 03:26:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Running setup.py install for mozInstall 03:26:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Running setup.py install for mozleak 03:26:29 INFO - Running setup.py install for mozlog 03:26:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Running setup.py install for moznetwork 03:26:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Running setup.py install for mozprocess 03:26:29 INFO - Running setup.py install for mozprofile 03:26:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Running setup.py install for mozrunner 03:26:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:29 INFO - Running setup.py install for mozscreenshot 03:26:29 INFO - Running setup.py install for moztest 03:26:29 INFO - Running setup.py install for mozversion 03:26:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:30 INFO - Cleaning up... 03:26:30 INFO - Return code: 0 03:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:30 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 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:30 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 03:26:30 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 03:26:30 INFO - Using env: {'DISPLAY': ':0', 03:26:30 INFO - 'HOME': '/home/cltbld', 03:26:30 INFO - 'LANG': 'en_US.UTF-8', 03:26:30 INFO - 'LANGUAGE': 'en_US:en', 03:26:30 INFO - 'LOGNAME': 'cltbld', 03:26:30 INFO - 'MAIL': '/var/mail/cltbld', 03:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:30 INFO - 'MOZ_NO_REMOTE': '1', 03:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:30 INFO - 'NO_EM_RESTART': '1', 03:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:30 INFO - 'PWD': '/builds/slave/test', 03:26:30 INFO - 'SHELL': '/bin/bash', 03:26:30 INFO - 'SHLVL': '1', 03:26:30 INFO - 'TERM': 'linux', 03:26:30 INFO - 'TMOUT': '86400', 03:26:30 INFO - 'USER': 'cltbld', 03:26:30 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:30 INFO - '_': '/tools/buildbot/bin/python'} 03:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:30 INFO - Running setup.py (path:/tmp/pip-oTyqpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:30 INFO - Running setup.py (path:/tmp/pip-SP7w2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:30 INFO - Running setup.py (path:/tmp/pip-3xvFPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:30 INFO - Running setup.py (path:/tmp/pip-cDVpL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:30 INFO - Running setup.py (path:/tmp/pip-kjwXbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:30 INFO - Running setup.py (path:/tmp/pip-nv2FZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:30 INFO - Running setup.py (path:/tmp/pip-vS50i3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:30 INFO - Running setup.py (path:/tmp/pip-Xg3JJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:30 INFO - Running setup.py (path:/tmp/pip-2c61Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:30 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)) 03:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:30 INFO - Running setup.py (path:/tmp/pip-Rc3fkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:31 INFO - Running setup.py (path:/tmp/pip-tPp30p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:31 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)) 03:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:31 INFO - Running setup.py (path:/tmp/pip-Ots2dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:31 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)) 03:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:31 INFO - Running setup.py (path:/tmp/pip-XSp09D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:31 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)) 03:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:31 INFO - Running setup.py (path:/tmp/pip-S8rJ5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:31 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)) 03:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:31 INFO - Running setup.py (path:/tmp/pip-WEIm9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:31 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)) 03:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:31 INFO - Running setup.py (path:/tmp/pip-eyTf7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:31 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)) 03:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:31 INFO - Running setup.py (path:/tmp/pip-8HpPA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:31 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)) 03:26:31 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)) 03:26:31 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)) 03:26:31 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)) 03:26:31 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)) 03:26:31 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)) 03:26:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:31 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 03:26:31 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 03:26:31 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 03:26:31 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 03:26:31 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 03:26:31 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 03:26:33 INFO - Downloading blessings-1.5.1.tar.gz 03:26:33 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 03:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:33 INFO - Installing collected packages: blessings 03:26:33 INFO - Running setup.py install for blessings 03:26:33 INFO - Successfully installed blessings 03:26:33 INFO - Cleaning up... 03:26:33 INFO - Return code: 0 03:26:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:33 INFO - Reading from file tmpfile_stdout 03:26:33 INFO - Current package versions: 03:26:33 INFO - argparse == 1.2.1 03:26:33 INFO - blessings == 1.5.1 03:26:33 INFO - blobuploader == 1.2.4 03:26:33 INFO - docopt == 0.6.1 03:26:33 INFO - manifestparser == 1.1 03:26:33 INFO - mozInstall == 1.12 03:26:33 INFO - mozcrash == 0.16 03:26:33 INFO - mozdebug == 0.1 03:26:33 INFO - mozdevice == 0.47 03:26:33 INFO - mozfile == 1.2 03:26:33 INFO - mozhttpd == 0.7 03:26:33 INFO - mozinfo == 0.9 03:26:33 INFO - mozleak == 0.1 03:26:33 INFO - mozlog == 3.1 03:26:33 INFO - moznetwork == 0.27 03:26:33 INFO - mozprocess == 0.22 03:26:33 INFO - mozprofile == 0.27 03:26:33 INFO - mozrunner == 6.11 03:26:33 INFO - mozscreenshot == 0.1 03:26:33 INFO - mozsystemmonitor == 0.0 03:26:33 INFO - moztest == 0.7 03:26:33 INFO - mozversion == 1.4 03:26:33 INFO - psutil == 3.1.1 03:26:33 INFO - requests == 1.2.3 03:26:33 INFO - wsgiref == 0.1.2 03:26:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:33 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')]} 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:33 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')]} 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:33 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 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:33 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 03:26:33 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 03:26:33 INFO - Using env: {'DISPLAY': ':0', 03:26:33 INFO - 'HOME': '/home/cltbld', 03:26:33 INFO - 'LANG': 'en_US.UTF-8', 03:26:33 INFO - 'LANGUAGE': 'en_US:en', 03:26:33 INFO - 'LOGNAME': 'cltbld', 03:26:33 INFO - 'MAIL': '/var/mail/cltbld', 03:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:33 INFO - 'MOZ_NO_REMOTE': '1', 03:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:33 INFO - 'NO_EM_RESTART': '1', 03:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:33 INFO - 'PWD': '/builds/slave/test', 03:26:33 INFO - 'SHELL': '/bin/bash', 03:26:33 INFO - 'SHLVL': '1', 03:26:33 INFO - 'TERM': 'linux', 03:26:33 INFO - 'TMOUT': '86400', 03:26:33 INFO - 'USER': 'cltbld', 03:26:33 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:33 INFO - '_': '/tools/buildbot/bin/python'} 03:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:33 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)) 03:26:33 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)) 03:26:33 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)) 03:26:33 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)) 03:26:33 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)) 03:26:33 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)) 03:26:33 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)) 03:26:33 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)) 03:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:33 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)) 03:26:33 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)) 03:26:33 INFO - Cleaning up... 03:26:33 INFO - Return code: 0 03:26:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:33 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')]} 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:33 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')]} 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:33 INFO - Using env: {'DISPLAY': ':0', 03:26:33 INFO - 'HOME': '/home/cltbld', 03:26:33 INFO - 'LANG': 'en_US.UTF-8', 03:26:33 INFO - 'LANGUAGE': 'en_US:en', 03:26:33 INFO - 'LOGNAME': 'cltbld', 03:26:33 INFO - 'MAIL': '/var/mail/cltbld', 03:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:33 INFO - 'MOZ_NO_REMOTE': '1', 03:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:33 INFO - 'NO_EM_RESTART': '1', 03:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:33 INFO - 'PWD': '/builds/slave/test', 03:26:33 INFO - 'SHELL': '/bin/bash', 03:26:33 INFO - 'SHLVL': '1', 03:26:33 INFO - 'TERM': 'linux', 03:26:33 INFO - 'TMOUT': '86400', 03:26:33 INFO - 'USER': 'cltbld', 03:26:33 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:33 INFO - '_': '/tools/buildbot/bin/python'} 03:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:34 INFO - Downloading/unpacking jsonschema 03:26:34 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 03:26:34 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 03:26:34 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 03:26:34 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 03:26:34 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 03:26:34 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 03:26:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:26:35 INFO - Downloading/unpacking functools32 (from jsonschema) 03:26:35 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 03:26:35 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 03:26:35 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 03:26:35 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 03:26:35 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 03:26:35 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 03:26:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:36 INFO - warning: no files found matching '*.txt' 03:26:36 INFO - no previously-included directories found matching 'build' 03:26:36 INFO - no previously-included directories found matching 'dist' 03:26:36 INFO - no previously-included directories found matching '.git*' 03:26:36 INFO - Installing collected packages: jsonschema, functools32 03:26:36 INFO - Running setup.py install for functools32 03:26:36 INFO - warning: no files found matching '*.txt' 03:26:36 INFO - no previously-included directories found matching 'build' 03:26:36 INFO - no previously-included directories found matching 'dist' 03:26:36 INFO - no previously-included directories found matching '.git*' 03:26:36 INFO - Successfully installed jsonschema functools32 03:26:36 INFO - Cleaning up... 03:26:36 INFO - Return code: 0 03:26:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74c3dd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xede8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, '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': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', '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 03:26:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:26:36 INFO - Using env: {'DISPLAY': ':0', 03:26:36 INFO - 'HOME': '/home/cltbld', 03:26:36 INFO - 'LANG': 'en_US.UTF-8', 03:26:36 INFO - 'LANGUAGE': 'en_US:en', 03:26:36 INFO - 'LOGNAME': 'cltbld', 03:26:36 INFO - 'MAIL': '/var/mail/cltbld', 03:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:36 INFO - 'MOZ_NO_REMOTE': '1', 03:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:36 INFO - 'NO_EM_RESTART': '1', 03:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:36 INFO - 'PWD': '/builds/slave/test', 03:26:36 INFO - 'SHELL': '/bin/bash', 03:26:36 INFO - 'SHLVL': '1', 03:26:36 INFO - 'TERM': 'linux', 03:26:36 INFO - 'TMOUT': '86400', 03:26:36 INFO - 'USER': 'cltbld', 03:26:36 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:36 INFO - '_': '/tools/buildbot/bin/python'} 03:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:36 INFO - Downloading/unpacking flake8 03:26:36 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 03:26:36 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 03:26:36 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 03:26:36 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 03:26:36 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 03:26:36 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 03:26:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:26:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:26:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:26:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:38 INFO - no previously-included directories found matching 'docs/_build' 03:26:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:38 INFO - Running setup.py install for pep8 03:26:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:38 INFO - no previously-included directories found matching 'docs/_build' 03:26:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:39 INFO - Cleaning up... 03:26:39 INFO - Return code: 0 03:26:39 INFO - Running post-action listener: _resource_record_post_action 03:26:39 INFO - Running post-action listener: _start_resource_monitoring 03:26:39 INFO - Starting resource monitoring. 03:26:39 INFO - ##### 03:26:39 INFO - ##### Running install step. 03:26:39 INFO - ##### 03:26:39 INFO - Running pre-action listener: _resource_record_pre_action 03:26:39 INFO - Running main action method: install 03:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:39 INFO - Reading from file tmpfile_stdout 03:26:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:39 INFO - Reading from file tmpfile_stdout 03:26:39 INFO - Output received: 03:26:39 INFO - Usage: mozinstall [options] installer 03:26:39 INFO - Options: 03:26:39 INFO - -h, --help show this help message and exit 03:26:39 INFO - -d DEST, --destination=DEST 03:26:39 INFO - Directory to install application into. [default: 03:26:39 INFO - "/builds/slave/test"] 03:26:39 INFO - --app=APP Application being installed. [default: firefox] 03:26:39 INFO - mkdir: /builds/slave/test/build/application 03:26:39 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'] 03:26:39 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 03:26:53 INFO - Reading from file tmpfile_stdout 03:26:53 INFO - Output received: 03:26:53 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:53 INFO - Running post-action listener: _resource_record_post_action 03:26:53 INFO - ##### 03:26:53 INFO - ##### Running run-tests step. 03:26:53 INFO - ##### 03:26:53 INFO - Running pre-action listener: _resource_record_pre_action 03:26:53 INFO - Running main action method: run_tests 03:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:53 INFO - Python 2.7.3 03:26:53 INFO - Return code: 0 03:26:53 INFO - grabbing minidump binary from tooltool 03:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b0b0>, '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 0x103bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:26:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:26:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:53 INFO - Return code: 0 03:26:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:26:54 INFO - Return code: 0 03:26:54 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test/build 03:26:54 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 03:26:54 INFO - Using env: {'DISPLAY': ':0', 03:26:54 INFO - 'HOME': '/home/cltbld', 03:26:54 INFO - 'LANG': 'en_US.UTF-8', 03:26:54 INFO - 'LANGUAGE': 'en_US:en', 03:26:54 INFO - 'LOGNAME': 'cltbld', 03:26:54 INFO - 'MAIL': '/var/mail/cltbld', 03:26:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:54 INFO - 'MOZ_NO_REMOTE': '1', 03:26:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:54 INFO - 'NO_EM_RESTART': '1', 03:26:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:54 INFO - 'PWD': '/builds/slave/test', 03:26:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:54 INFO - 'SHELL': '/bin/bash', 03:26:54 INFO - 'SHLVL': '1', 03:26:54 INFO - 'TERM': 'linux', 03:26:54 INFO - 'TMOUT': '86400', 03:26:54 INFO - 'USER': 'cltbld', 03:26:54 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719', 03:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:54 INFO - '_': '/tools/buildbot/bin/python'} 03:26:54 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 03:26:55 INFO - mozversion INFO | application_buildid: 20151127020611 03:26:55 INFO - mozversion INFO | application_changeset: ad985ade8a2e5e58123f0a774605d273834c3ba1 03:26:55 INFO - mozversion INFO | application_display_name: Nightly 03:26:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:55 INFO - mozversion INFO | application_name: Firefox 03:26:55 INFO - mozversion INFO | application_remotingname: firefox 03:26:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:26:55 INFO - mozversion INFO | application_vendor: Mozilla 03:26:55 INFO - mozversion INFO | application_version: 45.0a1 03:26:55 INFO - mozversion INFO | platform_buildid: 20151127020611 03:26:55 INFO - mozversion INFO | platform_changeset: ad985ade8a2e5e58123f0a774605d273834c3ba1 03:26:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:26:55 INFO - mozversion INFO | platform_version: 45.0a1 03:26:55 INFO - 2015-11-27 03:26:55,622 DEBUG : using testdate: 1448623615 03:26:55 INFO - 2015-11-27 03:26:55,622 DEBUG : actual date: 1448623615 03:26:55 INFO - 2015-11-27 03:26:55,670 INFO : starting webserver on 'localhost:46153' 03:26:55 INFO - 2015-11-27 03:26:55,671 INFO : Starting test suite talos-linux64-ix-041.e 03:26:55 INFO - 2015-11-27 03:26:55,671 INFO : Starting test dromaeo_css 03:26:55 INFO - 2015-11-27 03:26:55,671 DEBUG : operating with platform_type : linux_ 03:26:55 INFO - 2015-11-27 03:26:55,672 INFO : Initialising browser for dromaeo_css test... 03:26:55 INFO - 2015-11-27 03:26:55,701 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFTpy8/profile http://localhost:46153/getInfo.html 03:27:01 INFO - 2015-11-27 03:27:01,533 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:27:01 INFO - 2015-11-27 03:27:01,534 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:27:01 INFO - 2015-11-27 03:27:01,534 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:27:01 INFO - 2015-11-27 03:27:01,534 DEBUG : BROWSER_OUTPUT: __metrics 03:27:02 INFO - 2015-11-27 03:27:02,641 INFO : Browser initialized. 03:27:02 INFO - 2015-11-27 03:27:02,642 INFO : Running cycle 1/1 for dromaeo_css test... 03:27:02 INFO - 2015-11-27 03:27:02,642 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFTpy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:27:14 INFO - 2015-11-27 03:27:14,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 138121216 03:27:14 INFO - 2015-11-27 03:27:14,519 DEBUG : BROWSER_OUTPUT: 03:28:04 INFO - 2015-11-27 03:28:04,170 DEBUG : BROWSER_OUTPUT: 1448623684169 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] 03:30:16 INFO - 2015-11-27 03:30:16,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46153/tests/dromaeo/cssquery-ext.html) 03:30:17 INFO - 2015-11-27 03:30:17,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 144666624 03:30:17 INFO - 2015-11-27 03:30:17,350 DEBUG : BROWSER_OUTPUT: 03:33:19 INFO - 2015-11-27 03:33:19,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/dromaeo/cssquery-ext.html (next: http://localhost:46153/tests/dromaeo/cssquery-jquery.html) 03:33:19 INFO - 2015-11-27 03:33:19,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 144441344 03:33:19 INFO - 2015-11-27 03:33:19,918 DEBUG : BROWSER_OUTPUT: 03:36:21 INFO - 2015-11-27 03:36:21,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46153/tests/dromaeo/cssquery-mootools.html) 03:36:22 INFO - 2015-11-27 03:36:22,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 143413248 03:36:22 INFO - 2015-11-27 03:36:22,366 DEBUG : BROWSER_OUTPUT: 03:39:24 INFO - 2015-11-27 03:39:24,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46153/tests/dromaeo/cssquery-prototype.html) 03:39:24 INFO - 2015-11-27 03:39:24,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 141410304 03:39:24 INFO - 2015-11-27 03:39:24,689 DEBUG : BROWSER_OUTPUT: 03:42:27 INFO - 2015-11-27 03:42:27,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46153/tests/dromaeo/cssquery-yui.html) 03:42:27 INFO - 2015-11-27 03:42:27,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 143429632 03:42:27 INFO - 2015-11-27 03:42:27,865 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/dromaeo/cssquery-yui.html (next: http://localhost:46153/tests/dromaeo/cssquery-dojo.html) 03:45:30 INFO - 2015-11-27 03:45:30,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 145842176 03:45:30 INFO - 2015-11-27 03:45:30,360 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,360 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:45:30 INFO - 2015-11-27 03:45:30,360 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:45:30 INFO - 2015-11-27 03:45:30,360 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:45:30 INFO - 2015-11-27 03:45:30,360 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:45:30 INFO - 2015-11-27 03:45:30,362 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2727.127319257838;2768.432471343375;2800.7059258777826;2806.579013148029;2821.955876325759;4671.5562021607975;4825.252085926678;4829.154897892872;4863.148948933936;4889.9266511002315;4784.5933095686905;4786.904261914759;4787.904241915168;4803.375561177042;4815.0610630926985;4355.1507456046165;4394.934075988863;4420.270655341881;4514.909701805978;4520.457545094577;4346.065595896882;4475.820967161309;4494.011317510142;4546.454425468932;4553.043860789222;4419.403380543634;4435.800388982471;4510.481294651125;4510.751908645023;4532.614727748145;4488.169688607618;4513.097380523908;4513.7517436540975;4518.593326600621;4569.817207311704;4258.127083947783;4375.846845360397;4472.664550158751;4485.798139083749;4500.369948207253;4664.463586687507;4691.906161876777;4768.880777980578;4777.116233496814;4781.737004464753;5208.973955130238;5215.478452154792;5225.712585807779;5227.712475813829;5263.236830659571;5032.672876263031;5163.870903227412;5170;5239.869003274911;5260.079486089957;4810.230363141881;4854.927176092361;4892.657513974059;4925.950740492621;4929.359183306147;5375.435579264199;5383.488568585978;5386.461353864583;5390.434004429557;5392.676439413648;4877.731724755173;4975.029869175549;5007.273945277914;5018.447970723218;5172.301739265226;5079.720615366116;5103.18349064148;5113.386393632788;5156;5257.5005374489365;5172.379314482211;5211.478852114758;5223.817166399158;5224.2947202127225;5229.895402092013;5137.12668846297;5188.0661480933795;5191.558717508979;5198.2202669599865;5215.191645294985;4141.6065473779945;4206.305959516707;4237.173751118502;4289.978550107229;4321.157374311979;3757.492738480325;3762.0406796266775;3769.8680546180753;3800.7339486235696;3807;4293.055527783882;4447.6219521341045;4450.821967121279;4455.710378825366;4459.331100334975;5117.104506711311;5162.354705661793;5197.142471492237;5200.24596433515;5241.318628578337;4389.561043895585;4485.6860019798305;4487.057717879282;4491.797869095899;4506.301523263899;4440.933385999213;4540.091981603692;4609.285560738091;4617.630589552828;4639.489656137822;4847.491013443609;4901.534354236342;4909.754512274443;4916.06594746997;4954.281629163751;5225.555827754683;5247.737613119405;5250.2912106866615;5260.0531904257605;5273.156294992937;4771.308160316666;4803.279508073817;4863.173260545645;4962.900741985212;4966.6771659842;5092.3889133302755;5114.514121158484;5123.308353372396;5138.049460849755;5204.505571970657;5195;5205.6356055075785;5207;5224.190250511177;5257.237700533325;4802.991371811959;4957;4973.378327709036;5031.069252188357;5103.540681338697;5044.974775126101;5048.545630893237;5052.216906379517;5065.493450654905;5135.409427915837;4911.9754401227765;4984.028114517634;4985.700857948535;4987.750612469435;4990.750462476934;4910.705357678551;4943.134951383566;5001.524855138756;5017.799288028438;5063.544281014726;4918.729469879191;4945.085159245407;5017.347744793154;5050.3434553507805;5070.366204224472 03:45:30 INFO - 2015-11-27 03:45:30,363 DEBUG : BROWSER_OUTPUT: |1;ext.html;547.4744245524297;571.3343954293249;575.1832397994847;589.1633879890555;590.4656286061113;36896;37502.62497375025;37544;37591.436128458095;37787.622123778754;40401.39397909034;40555.797221013854;40709;41001.58998410015;41091.38362924558;8010.239027292412;8089.191080891923;8166.510009399425;8202.712905048325;8209.548474833882;7938.2855543001115;8054.556999365032;8079.394045446586;8085.151059138794;8101.311388531982;8063.556504392256;8108.7161949331785;8146.633401496917;8151;8196.426250162462;7954.880676789853;8058.919410805935;8093.838123237561;8099.352051835839;8116.553589552631;7880.211978802131;8064.032316122044;8071.636776345079;8099.149589293098;8103.230193131702;37180.25639487222;37701;37840.62159378426;37858;37867.24265514702;3078.1381213260324;3094.938101237985;3366.3267346530793;3370.1574606348413;3459.3600183966046;25054;25196.118135865156;25343.873280633663;25541.489170216493;26013.73986260151;3382.475716263983;3402.931941361159;3514.420120680085;3552.289542091592;3572.481990111445;203809;206411;207404;207538;207791.96104019534;38581.614183857804;38907.805460972515;39031;54905.72547137239;55143.172852407246;37620.43569346462;37839.62160378361;38048.23903521914;38221.42667859984;38275.23449530994;12260.44827982743;12525.93737031309;12532.749345013232;12540;12671.809922851164;9315.161635452841;9379.71860844162;9383.530823458936;9396.154346108882;9402.48286344244;13175.275359855108;13406.463741450429;13415.798763018562;13441.798373024412;13470.595882123553;5509.256250406224;5510.779568817203;5538.695371754511;5554.1391084381985;5594.804181853616;873.9737807865774;968.9224862011022;1005.9094681478556;1009.9798004039878;1037.8858325584179;26040.0931285305;26438.33904152373;26525.734742652712;26579.734202658114;26586;957.262907561174;961.8557216417594;972.557486343712;1042.468341146021;1110.6001839337832;13396.866031339758;14140.43438262458;14329.211893345757;14527.78208326876;14786.03890747098;291380;296115;296411;296579;296676;48085.5191448088;49252;49333.50666493361;49506;49554.50445495571;1215.635309407192;1227.0367761307332;1237.8143278508296;1247.8814512621286;1255.5668294438403;27927.581086284128;28138.2965425866;28216.128210634382;28520;28624.713752862204;39951.60048399595;40412.393814092226;40413.393799092446;40646.59353406428;40672.79663601663;257685;261406;261757;262568;263378;29761.851190743906;39030.80484597559;42811.357829633205;43036.569634304506;43805;39036;39591.208175836895;39649.80175099106;39749.40375894306;40324.79837600793;33430.83284583561;33645.66354336425;33661.49507757337;34035.14912127118;34044.31291073102;33902.66097338995;34037.149071273416;34237;34403.655963441044;34445;34280.657193427745;34381.65618343885;34397.312053759284;34678.82660586681;34750.82624586861;29938.401231975673;30484.390312194075;31079.378412432077;31266.21834454157;31276.218094547818;24051.759482404952;24153.879230603736;24169.75830241675;24207.515849682557;24579.754202457745 03:45:30 INFO - 2015-11-27 03:45:30,366 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.1322170641588;316.3009748455912;323.32909213382237;325.39579871234815;326.43363763869684;14827.629309267273;15084.924575377121;15243;15801.367945282174;16284.4300449484;9439.480828554444;9560.856587151198;10772.5690972361;11833.940830295858;11843;4513.932291015629;4642.210824159901;4665.603423708972;4692.296155576657;4749.643776716743;4941.407031156248;4953.1579631462555;4953.430355509108;4954.677945933521;4959.677620954626;4932.975335123319;4986.301917731521;5998.940010599882;6516.67416629169;6523.05415714721;6445.129907462527;6526.955687090067;6534.281229064799;6568.7700930467445;6575.342465753411;6401.967990160066;6402.167718196652;6406.8718625627225;6415.8396040098905;6438.839029024265;20454;21121.47196320089;21260.25589104374;21324.573508529742;21814.89092554543;1820.872538922276;1860.5348662834292;1890.5273681579606;1956.344624550777;2070.4306315763133;12668.936655316757;12806.743865122738;12963.092583519157;13105.541306054338;13118.409671564707;1879.1825555883236;1909.30310436691;1958.9510262243416;2022.0698478699817;2043.6832290994919;57026.85946281051;62182.68908655473;63781.36218637847;64929.350706492805;65465;14588.708225835424;15276;15289.464868729541;15344.386224551115;15759.921200393925;22783.544329113323;22869;22943.88528057349;23025.309240722807;23113.88443057774;8170.387220958333;8174.059983101901;8175.468594541336;8188.303994160444;8192.713255036046;6613.206415230203;6648.803215421271;6707.3628005339415;6747.696353664097;6851.246362900077;7476.364509016686;7563.924360756322;7579.393648508106;7579.772606821804;7597.278258565428;3010.488217003071;3121.734652554558;3127.37452509499;3180.109569320594;3255.121117298316;367.74441762974476;373.4491624853374;391.14729888842595;400.1297178636454;406.8982754311422;9747.951260243653;9774.511274436392;9807.215422766161;9907.157891579152;10023.448710320856;393.5926316262654;397.6023976023976;400.95990400960255;404.52468349688996;412.78122595024684;5244.187150991603;5343.5457986071615;5355.357357117171;5383.892322153535;5460.372057213392;469150;470762;471267;484559;495474;72715.6364218186;74301.62849185828;76460;76726;76935;402.073221225079;404.34496116291206;404.5893418180549;405.3392969459821;405.44251653975783;9451.432914025181;9451.716448506555;9494.620215191315;9590.760230994281;9735.610575576897;29608.407831843673;29734.553981690726;30910.845445772626;30933.69066309398;32002.839985800852;37797.811010944766;38205.80897095497;39147.2170556593;39289.80355098206;40644.59355406408;7996.1204267529365;8344.87482687748;8810.64757409722;8871.112888711077;8905.064968178507;9483.478408687588;11184.94407527957;15317.46388876384;15491.5352539424;15607.21963901823;12973.351332433529;13137.802932956205;13174.868251317748;13277.800832987707;13917.652058698208;12916.741665166455;13017.21896686202;13197.472101115847;13253.337333133111;13366;12898.613041608767;12973.156744811557;13668.111572747739;14079.929600351932;14298.356573953988;8625.266852317623;8628.52543110135;8725.94970998;8748.91251087481;8825.117488251124;9248.815023699623;10671.679849604525;13320.86679133235;14109.2945352734;14119.43522259098 03:45:30 INFO - 2015-11-27 03:45:30,367 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1400.9352891802228;1601.5275493729348;1638.3528506240036;1645.4450544235694;1663.9251233694486;5612.270404847374;5837.270341207349;6313;6690.096836927013;6704.597724136555;6543.312952140028;6650.833729156761;6656.068150458939;6710.496712746539;6728.259891411941;1944.6888497840384;1964.7347608072942;1968.6554852900686;1974.1215159254139;1979.0401655197218;1976.7825539190678;1985.8510611704107;1989.1744925855753;2027.391782465262;2037.5008123009884;1967.803219678035;1980.4553747719349;1988.065609163698;2006.8896210708406;2010.8491863110253;1971.3297478857185;1986.1261045140163;1997.9600407991904;1997.980020199794;1998.7701414337319;1972.447714639903;1992.471994921347;1996;2001.629698505781;2009.3067891577382;6623.768168114141;6752.324767523258;6757.256701762803;6760.256371799098;6767.763128290536;3912.6674232690257;3956.5845586213322;3965.7025723070883;3967.702422318309;3975.920481590352;2343.847649902751;2389.0682633772844;2395.3293077938206;2508.636247744067;2621.9475610487875;805.5730462854638;830.2403300979596;834.1533343656193;841.7306461932184;843.7342237195326;8623.13768623139;8735.213830755263;8828.646854125891;8838.204561589488;8863.911360886374;3665.7433979621705;3691.7784932903573;3694.2057457646733;3696.77819330841;3714.0343510687417;7796.415268854745;7849.293563579191;7862.01724784402;7872.921270787333;7885.48744331628;3901.551321597996;3907.257621051991;3919.5884432134785;3925.7055720821054;3942.073612701013;3447.620761716209;3522.18989632386;3543.7696549724187;3545.3795585772386;3579.874704385386;3140.9371812563622;3161.6206055273515;3175.4601717707583;3209.293955329824;3215.6623554526436;957.6504575829772;971.7522031881825;975.3513913247752;978.882534095913;980.8479685648736;1119.6585041562403;1119.8040342939953;1129.6272230164027;1141.5662048421548;1158.5423757615863;6189.938100619026;6280.937190628127;6283.874322513524;6296.842578935563;6298.244210694746;410.3258704485691;414.834066373447;415.89810496428566;415.9979200104041;416.8082681966329;4774.355462012584;4811.206150985118;4851.296561998491;4865.416150062015;4875.049365373789;7716.6527506262355;7786.065672119382;7847.6468558914985;7866.921330786733;7969.681212751541;7676.884846727304;7763.9223607764325;7851.411144164211;7949.523028618301;7958.323542498837;6208.937910620926;6312.779052733133;6326.304106548276;6365.2361716594305;6372.36276372359;5913.763449462145;5961.731722072604;6001.519878409629;6009.789657361971;6048.334683184934;6998.2651821558;7068.964655176691;7069.787906362817;7084;7106.253843346374;7211.567305961449;7322.780316590511;7348.228436014356;7356.301151390609;7395.297446742551;5361.303030605996;5645.322561292507;5767.567432442667;5846.795362162474;5959.76160953557;6297.118403423433;6318.304986451579;6322.083297921868;6333.36666333363;6357.586756860975;5937.940620593911;5968.522518198621;6132.41742034506;6191.288001879661;6256.718447669775;5380.43505431924;6061.333253342217;6173.41352571505;6195;6206.627602343874;5978.910316345346;6118.265808103056;6119.938800611937;6188.783392581238;6189.319174890668;5693.8861222774485;5729;5737.799177028784;5740.052891272893;5745.597808153389;5671.858203544779;5693.4021927696995;5737.426257374229;5766.625169363978;5773.24947756789 03:45:30 INFO - 2015-11-27 03:45:30,367 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.193059433586;295.97928145029846;296.18696677619937;302.5356078419625;304.18781852453947;5441.211024401459;5574.581906357029;5593.776248950042;5624.690642014688;5738.393249890027;5547.25112109865;5564.387917329091;5566.248556444879;5582.078956972105;5606.21512988182;4117.97941010296;4244.660427165819;4246.150769846027;4247.554006829285;4248.511421186557;4192.350185721203;4206.978965105171;4207.873763787076;4207.957920420802;4211.936820947688;4150.771707556083;4155.189738001091;4159;4162.604552567501;4204.957950420488;4198.097409057053;4201.852935147255;4207.095474473003;4210.810513526899;4212.178625168093;3636.163682353047;3647.4528820676846;3651.068977410743;3651.4157734762575;3653.2510835278704;5226.268322434862;5232.1628539433505;5346.5455436287575;5349.812756553541;5357.169638705968;4841.419029716457;4843.370361852936;4846.345743324641;4851.320815085891;4855.955969466546;5770.682612456313;5836.941630583682;5840.3575606683235;5841.7371218295275;5850.210221620069;3868.9226215475815;3989.7207195496326;3990.08228107534;3993.5806740292433;3995.4805875236325;6048.485878700316;6123.785667501661;6150.784722534735;6166.290876549209;6205.7517699291975;4094.9795251023556;4103.651189648914;4106.589341065869;4109;4121.1345617420075;4162.438070860456;4165.187788381237;4167.499900012018;4175.62419382257;4179.477565304337;4724.95275047252;4822.42130944289;4824.782884770194;4825.083234185494;4829.396325459317;5809.448102430262;5833.329167145747;5847.473727364558;5848.385919478478;5858.179854820329;1453.2661006192018;1463.4000059975358;1465;1465.2893346726828;1466.208247546313;960.3901522533102;961.8653388525612;968.7771812483169;986.2504496582649;988.3032462114193;5041.067402530543;5057.519535644108;5060.7722652480725;5071.163258062378;5077.746112694351;6029.005214139618;6033.728482218311;6071.362506936796;6073.75704971805;6093.482054025458;5013.799448022111;5053.191489361684;5063.1898896176435;5064.620153488503;5068.695878247243;3182.713555779991;3265.5754751882105;3266.7549933755063;3283.7044665980175;3291.9835400822844;5655.660660360391;5683.2895888014;5711.371749107595;5718;5719.399463056319;6290.370962903673;6315.305316415191;6329.841753956188;6333;6342.460890824239;5749.626274292157;5763.423657634287;5765.85585360361;5770.5095066919785;5776;6126.5711400203345;6135.509159267159;6136.079588061648;6137.723802428991;6142.692865356804;5821.185034095145;5968.343482217039;6025.728842202024;6034.517238620988;6042.425969532887;5720.799772008127;5760.337561180518;5766.481016708516;5788.82633520995;5789.536837052941;4001.8399264029113;4053.5135783706146;4064.288749468772;4070.9415551956113;4074.9592504075767;5992.490638295793;6113.84715382119;6120.632762034292;6124.265088189446;6127.417895299939;5846.123081537803;5862.94137058624;5874.911876321773;5883.735231914488;5894.793682221273;5853.707314634166;5860.179574859438;5878.500327472213;5893.292804863444;5901.734421950937;5605.24329215567;5733.5126514245085;5738.512226460631;5749.396313387201;5754.597178197486;5856.443637854397;5873.148393483007;5919.733611987384;5924;5924.585279030599;5744.109663002241;5756.56825738063;5777.768889244383;5783.392743762012;5793.768249270151 03:45:30 INFO - 2015-11-27 03:45:30,368 DEBUG : BROWSER_OUTPUT: |5;yui.html;753.4800987318749;764.7208768799386;766.4328396986228;774.0788461730543;783.4085265624451;11162;11322.037626801732;11364.488598013078;11418.942905285483;11513.136514761394;11664.41677916105;11844.644660660173;11901.1669183157;11920;11990.820137697941;760.1828034862517;772.1197834468682;772.4862966127519;777.7161336112307;779.7154038775834;761.3186198352471;773.5088218980932;776.4254451705725;777.4829738224074;778.1362687416963;784.5449639209245;793.896793416855;795.2564352330561;795.3676826922582;796.1361922314296;795.5385876191824;798.0941631248546;798.696495331776;800.4516905919435;800.727752564131;578.9855253618651;581.7847396463336;582.7639805878626;585.1719816459747;585.5257241634247;10314.12329951955;10415.323004004715;10428.478576071166;10439.478026098664;10492.580296788119;8892.15524525169;8912.24245939096;9395;9928.751781205456;10052.246081543914;8702.086280940537;8752.824943501158;8814.118588141198;8933.553322333857;8942.061083586195;3130.874765009397;3183.1564635371647;3198.2484116232667;3217.8230197339135;3305.8512366943546;37420.06449838749;37652.11739413046;37958.24083518314;38096.80951595252;40474.59525404737;8902.599383027778;8950.641974321084;8970.641174353083;9037.819243615222;9087.591058402388;15576.532704018897;15605.921970390076;15611.843881561039;15651.452199172974;15660.295286711897;6114.510839132859;6131.601445906002;6137.938620613737;6301.52738544611;6517.837054073591;3488.1977145256733;3640.162762564625;3673.651003154696;3679.5032670589662;3702.4816525686424;2683.825551339157;2690;2715.212588349396;2720.537508623499;2729.044834308016;479.6666316909714;497.45031739927583;498.2177980570542;501.82937801147784;502.47240397583124;458.4246770303248;488.82402335159315;527.3855957809186;539.3069905171914;622.1818308923841;7842;8138.918610813935;8308.875366869503;8330.125336839545;8513.702020429255;560.5767645427758;561.7921369093461;576.6367188671111;580.2717589425245;588.8969430349672;3764.7552909060823;3864.439656249828;3978.9403158952637;4012.1975604878558;4122.793860306972;54124.45875541194;54743;54819.17771233435;54858.45141548533;54862.72568637211;44717.776411118386;45930.54069459329;46324.305135423;46881.5311846884;47223.52776472191;39233;39614.40578391269;40486.797566012574;42561.14877702429;42561.46700928859;8098.392620553364;8220.219079187467;8407.663693452194;8505.404621676424;9033.141851524095;32126.83936580302;32201.35597288088;33508.32983340368;34067.14832129217;34176.48735268923;41352.58647413487;41952.3707144387;42054.15891682088;42364.36453453139;43398.78300608603;10032.147267482345;10036.89963100389;10396.480175991019;10790.460476976277;10792.514336855018;11106.833397498882;11148.777024459627;11249.887501124884;11300.321980681185;11349;9804.65683701067;9906.75233119149;10414.25641891403;10594;10949.50727217293;10217.233707472118;10235.283530152818;10275.332103413255;10366.429846358222;10537.315074520131;10517.421541815274;10527.736806579896;10687.198460115678;10718.678439646823;10743.462826858782;8550.82898342042;8659.760844688872;8697.478151310941;9019.549022548978;9246.306527010636;8742.650293988168;8766.21104100634;9086.818263634823;9316.720498385059;9372.203362714246 03:45:30 INFO - 2015-11-27 03:45:30,368 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:45:30 INFO - 2015-11-27 03:45:30,368 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:45:30 INFO - 2015-11-27 03:45:30,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,318 03:45:30 INFO - 2015-11-27 03:45:30,368 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:45:30 INFO - 2015-11-27 03:45:30,368 DEBUG : BROWSER_OUTPUT: __startTimestamp1448624730358__endTimestamp 03:45:30 INFO - 2015-11-27 03:45:30,368 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4780.29 Median:4911.98 stddev:505.43 (10.3%) stddev-sans-first:480.63 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: Values: 2727.1 2768.4 2800.7 2806.6 2822.0 4671.6 4825.3 4829.2 4863.1 4889.9 4784.6 4786.9 4787.9 4803.4 4815.1 4355.2 4394.9 4420.3 4514.9 4520.5 4346.1 4475.8 4494.0 4546.5 4553.0 4419.4 4435.8 4510.5 4510.8 4532.6 4488.2 4513.1 4513.8 4518.6 4569.8 4258.1 4375.8 4472.7 4485.8 4500.4 4664.5 4691.9 4768.9 4777.1 4781.7 5209.0 5215.5 5225.7 5227.7 5263.2 5032.7 5163.9 5170.0 5239.9 5260.1 4810.2 4854.9 4892.7 4926.0 4929.4 5375.4 5383.5 5386.5 5390.4 5392.7 4877.7 4975.0 5007.3 5018.4 5172.3 5079.7 5103.2 5113.4 5156.0 5257.5 5172.4 5211.5 5223.8 5224.3 5229.9 5137.1 5188.1 5191.6 5198.2 5215.2 4141.6 4206.3 4237.2 4290.0 4321.2 3757.5 3762.0 3769.9 3800.7 3807.0 4293.1 4447.6 4450.8 4455.7 4459.3 5117.1 5162.4 5197.1 5200.2 5241.3 4389.6 4485.7 4487.1 4491.8 4506.3 4440.9 4540.1 4609.3 4617.6 4639.5 4847.5 4901.5 4909.8 4916.1 4954.3 5225.6 5247.7 5250.3 5260.1 5273.2 4771.3 4803.3 4863.2 4962.9 4966.7 5092.4 5114.5 5123.3 5138.0 5204.5 5195.0 5205.6 5207.0 5224.2 5257.2 4803.0 4957.0 4973.4 5031.1 5103.5 5045.0 5048.5 5052.2 5065.5 5135.4 4912.0 4984.0 4985.7 4987.8 4990.8 4910.7 4943.1 5001.5 5017.8 5063.5 4918.7 4945.1 5017.3 5050.3 5070.4 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40978.14 Median:20234.24 stddev:67121.93 (331.7%) stddev-sans-first:67241.57 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: Values: 547.5 571.3 575.2 589.2 590.5 36896.0 37502.6 37544.0 37591.4 37787.6 40401.4 40555.8 40709.0 41001.6 41091.4 8010.2 8089.2 8166.5 8202.7 8209.5 7938.3 8054.6 8079.4 8085.2 8101.3 8063.6 8108.7 8146.6 8151.0 8196.4 7954.9 8058.9 8093.8 8099.4 8116.6 7880.2 8064.0 8071.6 8099.1 8103.2 37180.3 37701.0 37840.6 37858.0 37867.2 3078.1 3094.9 3366.3 3370.2 3459.4 25054.0 25196.1 25343.9 25541.5 26013.7 3382.5 3402.9 3514.4 3552.3 3572.5 203809.0 206411.0 207404.0 207538.0 207792.0 38581.6 38907.8 39031.0 54905.7 55143.2 37620.4 37839.6 38048.2 38221.4 38275.2 12260.4 12525.9 12532.7 12540.0 12671.8 9315.2 9379.7 9383.5 9396.2 9402.5 13175.3 13406.5 13415.8 13441.8 13470.6 5509.3 5510.8 5538.7 5554.1 5594.8 874.0 968.9 1005.9 1010.0 1037.9 26040.1 26438.3 26525.7 26579.7 26586.0 957.3 961.9 972.6 1042.5 1110.6 13396.9 14140.4 14329.2 14527.8 14786.0 291380.0 296115.0 296411.0 296579.0 296676.0 48085.5 49252.0 49333.5 49506.0 49554.5 1215.6 1227.0 1237.8 1247.9 1255.6 27927.6 28138.3 28216.1 28520.0 28624.7 39951.6 40412.4 40413.4 40646.6 40672.8 257685.0 261406.0 261757.0 262568.0 263378.0 29761.9 39030.8 42811.4 43036.6 43805.0 39036.0 39591.2 39649.8 39749.4 40324.8 33430.8 33645.7 33661.5 34035.1 34044.3 33902.7 34037.1 34237.0 34403.7 34445.0 34280.7 34381.7 34397.3 34678.8 34750.8 29938.4 30484.4 31079.4 31266.2 31276.2 24051.8 24153.9 24169.8 24207.5 24579.8 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,372 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26433.02 Median:404.56 stddev:78228.33 (19336.8%) stddev-sans-first:78423.20 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: Values: 316.1 316.3 323.3 325.4 326.4 14827.6 15084.9 15243.0 15801.4 16284.4 9439.5 9560.9 10772.6 11833.9 11843.0 4513.9 4642.2 4665.6 4692.3 4749.6 4941.4 4953.2 4953.4 4954.7 4959.7 4933.0 4986.3 5998.9 6516.7 6523.1 6445.1 6527.0 6534.3 6568.8 6575.3 6402.0 6402.2 6406.9 6415.8 6438.8 20454.0 21121.5 21260.3 21324.6 21814.9 1820.9 1860.5 1890.5 1956.3 2070.4 12668.9 12806.7 12963.1 13105.5 13118.4 1879.2 1909.3 1959.0 2022.1 2043.7 57026.9 62182.7 63781.4 64929.4 65465.0 14588.7 15276.0 15289.5 15344.4 15759.9 22783.5 22869.0 22943.9 23025.3 23113.9 8170.4 8174.1 8175.5 8188.3 8192.7 6613.2 6648.8 6707.4 6747.7 6851.2 7476.4 7563.9 7579.4 7579.8 7597.3 3010.5 3121.7 3127.4 3180.1 3255.1 367.7 373.4 391.1 400.1 406.9 9748.0 9774.5 9807.2 9907.2 10023.4 393.6 397.6 401.0 404.5 412.8 5244.2 5343.5 5355.4 5383.9 5460.4 469150.0 470762.0 471267.0 484559.0 495474.0 72715.6 74301.6 76460.0 76726.0 76935.0 402.1 404.3 404.6 405.3 405.4 9451.4 9451.7 9494.6 9590.8 9735.6 29608.4 29734.6 30910.8 30933.7 32002.8 37797.8 38205.8 39147.2 39289.8 40644.6 7996.1 8344.9 8810.6 8871.1 8905.1 9483.5 11184.9 15317.5 15491.5 15607.2 12973.4 13137.8 13174.9 13277.8 13917.7 12916.7 13017.2 13197.5 13253.3 13366.0 12898.6 12973.2 13668.1 14079.9 14298.4 8625.3 8628.5 8725.9 8748.9 8825.1 9248.8 10671.7 13320.9 14109.3 14119.4 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4640.74 Median:5842.03 stddev:2392.23 (40.9%) stddev-sans-first:2386.55 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: Values: 1400.9 1601.5 1638.4 1645.4 1663.9 5612.3 5837.3 6313.0 6690.1 6704.6 6543.3 6650.8 6656.1 6710.5 6728.3 1944.7 1964.7 1968.7 1974.1 1979.0 1976.8 1985.9 1989.2 2027.4 2037.5 1967.8 1980.5 1988.1 2006.9 2010.8 1971.3 1986.1 1998.0 1998.0 1998.8 1972.4 1992.5 1996.0 2001.6 2009.3 6623.8 6752.3 6757.3 6760.3 6767.8 3912.7 3956.6 3965.7 3967.7 3975.9 2343.8 2389.1 2395.3 2508.6 2621.9 805.6 830.2 834.2 841.7 843.7 8623.1 8735.2 8828.6 8838.2 8863.9 3665.7 3691.8 3694.2 3696.8 3714.0 7796.4 7849.3 7862.0 7872.9 7885.5 3901.6 3907.3 3919.6 3925.7 3942.1 3447.6 3522.2 3543.8 3545.4 3579.9 3140.9 3161.6 3175.5 3209.3 3215.7 957.7 971.8 975.4 978.9 980.8 1119.7 1119.8 1129.6 1141.6 1158.5 6189.9 6280.9 6283.9 6296.8 6298.2 410.3 414.8 415.9 416.0 416.8 4774.4 4811.2 4851.3 4865.4 4875.0 7716.7 7786.1 7847.6 7866.9 7969.7 7676.9 7763.9 7851.4 7949.5 7958.3 6208.9 6312.8 6326.3 6365.2 6372.4 5913.8 5961.7 6001.5 6009.8 6048.3 6998.3 7069.0 7069.8 7084.0 7106.3 7211.6 7322.8 7348.2 7356.3 7395.3 5361.3 5645.3 5767.6 5846.8 5959.8 6297.1 6318.3 6322.1 6333.4 6357.6 5937.9 5968.5 6132.4 6191.3 6256.7 5380.4 6061.3 6173.4 6195.0 6206.6 5978.9 6118.3 6119.9 6188.8 6189.3 5693.9 5729.0 5737.8 5740.1 5745.6 5671.9 5693.4 5737.4 5766.6 5773.2 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4826.02 Median:5587.93 stddev:1453.43 (26.0%) stddev-sans-first:1417.04 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: Values: 288.2 296.0 296.2 302.5 304.2 5441.2 5574.6 5593.8 5624.7 5738.4 5547.3 5564.4 5566.2 5582.1 5606.2 4118.0 4244.7 4246.2 4247.6 4248.5 4192.4 4207.0 4207.9 4208.0 4211.9 4150.8 4155.2 4159.0 4162.6 4205.0 4198.1 4201.9 4207.1 4210.8 4212.2 3636.2 3647.5 3651.1 3651.4 3653.3 5226.3 5232.2 5346.5 5349.8 5357.2 4841.4 4843.4 4846.3 4851.3 4856.0 5770.7 5836.9 5840.4 5841.7 5850.2 3868.9 3989.7 3990.1 3993.6 3995.5 6048.5 6123.8 6150.8 6166.3 6205.8 4095.0 4103.7 4106.6 4109.0 4121.1 4162.4 4165.2 4167.5 4175.6 4179.5 4725.0 4822.4 4824.8 4825.1 4829.4 5809.4 5833.3 5847.5 5848.4 5858.2 1453.3 1463.4 1465.0 1465.3 1466.2 960.4 961.9 968.8 986.3 988.3 5041.1 5057.5 5060.8 5071.2 5077.7 6029.0 6033.7 6071.4 6073.8 6093.5 5013.8 5053.2 5063.2 5064.6 5068.7 3182.7 3265.6 3266.8 3283.7 3292.0 5655.7 5683.3 5711.4 5718.0 5719.4 6290.4 6315.3 6329.8 6333.0 6342.5 5749.6 5763.4 5765.9 5770.5 5776.0 6126.6 6135.5 6136.1 6137.7 6142.7 5821.2 5968.3 6025.7 6034.5 6042.4 5720.8 5760.3 5766.5 5788.8 5789.5 4001.8 4053.5 4064.3 4070.9 4075.0 5992.5 6113.8 6120.6 6124.3 6127.4 5846.1 5862.9 5874.9 5883.7 5894.8 5853.7 5860.2 5878.5 5893.3 5901.7 5605.2 5733.5 5738.5 5749.4 5754.6 5856.4 5873.1 5919.7 5924.0 5924.6 5744.1 5756.6 5777.8 5783.4 5793.8 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12372.26 Median:484.25 stddev:14443.49 (2982.7%) stddev-sans-first:14457.65 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: Values: 753.5 764.7 766.4 774.1 783.4 11162.0 11322.0 11364.5 11418.9 11513.1 11664.4 11844.6 11901.2 11920.0 11990.8 760.2 772.1 772.5 777.7 779.7 761.3 773.5 776.4 777.5 778.1 784.5 793.9 795.3 795.4 796.1 795.5 798.1 798.7 800.5 800.7 579.0 581.8 582.8 585.2 585.5 10314.1 10415.3 10428.5 10439.5 10492.6 8892.2 8912.2 9395.0 9928.8 10052.2 8702.1 8752.8 8814.1 8933.6 8942.1 3130.9 3183.2 3198.2 3217.8 3305.9 37420.1 37652.1 37958.2 38096.8 40474.6 8902.6 8950.6 8970.6 9037.8 9087.6 15576.5 15605.9 15611.8 15651.5 15660.3 6114.5 6131.6 6137.9 6301.5 6517.8 3488.2 3640.2 3673.7 3679.5 3702.5 2683.8 2690.0 2715.2 2720.5 2729.0 479.7 497.5 498.2 501.8 502.5 458.4 488.8 527.4 539.3 622.2 7842.0 8138.9 8308.9 8330.1 8513.7 560.6 561.8 576.6 580.3 588.9 3764.8 3864.4 3978.9 4012.2 4122.8 54124.5 54743.0 54819.2 54858.5 54862.7 44717.8 45930.5 46324.3 46881.5 47223.5 39233.0 39614.4 40486.8 42561.1 42561.5 8098.4 8220.2 8407.7 8505.4 9033.1 32126.8 32201.4 33508.3 34067.1 34176.5 41352.6 41952.4 42054.2 42364.4 43398.8 10032.1 10036.9 10396.5 10790.5 10792.5 11106.8 11148.8 11249.9 11300.3 11349.0 9804.7 9906.8 10414.3 10594.0 10949.5 10217.2 10235.3 10275.3 10366.4 10537.3 10517.4 10527.7 10687.2 10718.7 10743.5 8550.8 8659.8 8697.5 9019.5 9246.3 8742.7 8766.2 9086.8 9316.7 9372.2 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:45:30 INFO - 2015-11-27 03:45:30,373 DEBUG : BROWSER_OUTPUT: 03:45:31 INFO - 2015-11-27 03:45:31,093 INFO : Browser exited with error code: 0 03:45:31 INFO - 2015-11-27 03:45:31,115 INFO : Completed test dromaeo_css (00:18:35) 03:45:31 INFO - 2015-11-27 03:45:31,115 INFO : Starting test kraken 03:45:31 INFO - 2015-11-27 03:45:31,115 DEBUG : operating with platform_type : linux_ 03:45:31 INFO - 2015-11-27 03:45:31,115 INFO : Initialising browser for kraken test... 03:45:31 INFO - 2015-11-27 03:45:31,121 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Spdij/profile http://localhost:46153/getInfo.html 03:45:35 INFO - 2015-11-27 03:45:35,839 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:45:35 INFO - 2015-11-27 03:45:35,839 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:45:35 INFO - 2015-11-27 03:45:35,839 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:45:35 INFO - 2015-11-27 03:45:35,839 DEBUG : BROWSER_OUTPUT: __metrics 03:45:36 INFO - 2015-11-27 03:45:36,913 INFO : Browser initialized. 03:45:36 INFO - 2015-11-27 03:45:36,914 INFO : Running cycle 1/1 for kraken test... 03:45:36 INFO - 2015-11-27 03:45:36,914 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Spdij/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:45:48 INFO - 2015-11-27 03:45:48,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 138702848 03:45:48 INFO - 2015-11-27 03:45:48,833 DEBUG : BROWSER_OUTPUT: 03:45:51 INFO - 2015-11-27 03:45:51,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46153/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:52 INFO - 2015-11-27 03:45:52,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 140627968 03:45:52 INFO - 2015-11-27 03:45:52,076 DEBUG : BROWSER_OUTPUT: 03:45:54 INFO - 2015-11-27 03:45:54,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46153/tests/kraken/driver.html?testName=audio-dft) 03:45:55 INFO - 2015-11-27 03:45:55,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 140824576 03:45:55 INFO - 2015-11-27 03:45:55,410 DEBUG : BROWSER_OUTPUT: 03:45:58 INFO - 2015-11-27 03:45:58,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46153/tests/kraken/driver.html?testName=audio-fft) 03:45:58 INFO - 2015-11-27 03:45:58,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 135348224 03:45:58 INFO - 2015-11-27 03:45:58,894 DEBUG : BROWSER_OUTPUT: 03:46:00 INFO - 2015-11-27 03:46:00,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46153/tests/kraken/driver.html?testName=audio-oscillator) 03:46:01 INFO - 2015-11-27 03:46:01,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 136024064 03:46:01 INFO - 2015-11-27 03:46:01,565 DEBUG : BROWSER_OUTPUT: 03:46:03 INFO - 2015-11-27 03:46:03,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:04 INFO - 2015-11-27 03:46:04,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 137728000 03:46:04 INFO - 2015-11-27 03:46:04,398 DEBUG : BROWSER_OUTPUT: 03:46:07 INFO - 2015-11-27 03:46:07,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46153/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:08 INFO - 2015-11-27 03:46:08,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 137924608 03:46:08 INFO - 2015-11-27 03:46:08,098 DEBUG : BROWSER_OUTPUT: 03:46:11 INFO - 2015-11-27 03:46:11,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46153/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:12 INFO - 2015-11-27 03:46:12,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 135704576 03:46:12 INFO - 2015-11-27 03:46:12,202 DEBUG : BROWSER_OUTPUT: 03:46:15 INFO - 2015-11-27 03:46:15,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46153/tests/kraken/driver.html?testName=json-parse-financial) 03:46:15 INFO - 2015-11-27 03:46:15,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 136294400 03:46:15 INFO - 2015-11-27 03:46:15,804 DEBUG : BROWSER_OUTPUT: 03:46:17 INFO - 2015-11-27 03:46:17,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:18 INFO - 2015-11-27 03:46:18,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 137457664 03:46:18 INFO - 2015-11-27 03:46:18,160 DEBUG : BROWSER_OUTPUT: 03:46:20 INFO - 2015-11-27 03:46:20,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:20 INFO - 2015-11-27 03:46:20,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 137633792 03:46:20 INFO - 2015-11-27 03:46:20,657 DEBUG : BROWSER_OUTPUT: 03:46:22 INFO - 2015-11-27 03:46:22,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:23 INFO - 2015-11-27 03:46:23,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 139485184 03:46:23 INFO - 2015-11-27 03:46:23,478 DEBUG : BROWSER_OUTPUT: 03:46:26 INFO - 2015-11-27 03:46:26,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:26 INFO - 2015-11-27 03:46:26,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 138113024 03:46:26 INFO - 2015-11-27 03:46:26,680 DEBUG : BROWSER_OUTPUT: 03:46:29 INFO - 2015-11-27 03:46:29,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:29 INFO - 2015-11-27 03:46:29,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 137596928 03:46:29 INFO - 2015-11-27 03:46:29,869 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46153/tests/kraken/driver.html?testName=ai-astar) 03:46:31 INFO - 2015-11-27 03:46:31,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 137805824 03:46:31 INFO - 2015-11-27 03:46:31,901 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:46:31 INFO - 2015-11-27 03:46:31,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:46:31 INFO - 2015-11-27 03:46:31,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:46:31 INFO - 2015-11-27 03:46:31,901 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:46:31 INFO - 2015-11-27 03:46:31,901 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;115;115;113;124;113;113;113;113 03:46:31 INFO - 2015-11-27 03:46:31,901 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;154;176;130;168;163;137;180;131 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;164;164;161;165;171;162;167;162 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;74;73;72;148;73;73;72;72;156 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;130;94;94;94;140;95;95;126 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;110;110;110;110;111 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;149;146;148;147;148;149;147;149;147 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;95;96;96;96;95 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;75;73;74;75;75;81;75;71 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;68;68;70;69;68;68;70 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;84;84;87;83;84;84;84;86 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;128;132;130;132;127;129;132;131;129 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;148;149;147;147;137;146;146;148;147 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;71;70;70;70;76;70;71;69 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:46:31 INFO - 2015-11-27 03:46:31,903 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:46:31 INFO - 2015-11-27 03:46:31,904 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,801 03:46:31 INFO - 2015-11-27 03:46:31,904 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:46:31 INFO - 2015-11-27 03:46:31,904 DEBUG : BROWSER_OUTPUT: __startTimestamp1448624791900__endTimestamp 03:46:31 INFO - 2015-11-27 03:46:31,904 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,905 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:46:31 INFO - 2015-11-27 03:46:31,905 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:46:31 INFO - 2015-11-27 03:46:31,905 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,905 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.10 Median:113.50 stddev:3.98 (3.5%) stddev-sans-first:4.23 03:46:31 INFO - 2015-11-27 03:46:31,905 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 115.0 115.0 113.0 124.0 113.0 113.0 113.0 113.0 03:46:31 INFO - 2015-11-27 03:46:31,905 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.20 Median:158.50 stddev:19.37 (12.2%) stddev-sans-first:20.54 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 154.0 176.0 130.0 168.0 163.0 137.0 180.0 131.0 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.00 (1.8%) stddev-sans-first:3.08 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 164.0 164.0 161.0 165.0 171.0 162.0 167.0 162.0 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:73.00 stddev:33.33 (45.7%) stddev-sans-first:35.02 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: Values: 76.0 74.0 73.0 72.0 148.0 73.0 73.0 72.0 72.0 156.0 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.00 stddev:18.54 (19.7%) stddev-sans-first:19.18 03:46:31 INFO - 2015-11-27 03:46:31,906 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 130.0 94.0 94.0 94.0 140.0 95.0 95.0 126.0 03:46:31 INFO - 2015-11-27 03:46:31,907 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,907 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:46:31 INFO - 2015-11-27 03:46:31,907 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 03:46:31 INFO - 2015-11-27 03:46:31,907 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,907 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 03:46:31 INFO - 2015-11-27 03:46:31,907 DEBUG : BROWSER_OUTPUT: Values: 147.0 149.0 146.0 148.0 147.0 148.0 149.0 147.0 149.0 147.0 03:46:31 INFO - 2015-11-27 03:46:31,907 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,908 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:46:31 INFO - 2015-11-27 03:46:31,908 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 03:46:31 INFO - 2015-11-27 03:46:31,908 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,909 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.70 Median:75.00 stddev:2.54 (3.4%) stddev-sans-first:2.68 03:46:31 INFO - 2015-11-27 03:46:31,909 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 75.0 73.0 74.0 75.0 75.0 81.0 75.0 71.0 03:46:31 INFO - 2015-11-27 03:46:31,909 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 68.0 68.0 70.0 69.0 68.0 68.0 70.0 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:1.35 (1.6%) stddev-sans-first:1.32 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 84.0 84.0 87.0 83.0 84.0 84.0 84.0 86.0 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:131.50 stddev:2.00 (1.5%) stddev-sans-first:1.87 03:46:31 INFO - 2015-11-27 03:46:31,910 DEBUG : BROWSER_OUTPUT: Values: 133.0 128.0 132.0 130.0 132.0 127.0 129.0 132.0 131.0 129.0 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.00 stddev:4.85 (3.3%) stddev-sans-first:3.55 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: Values: 135.0 148.0 149.0 147.0 147.0 137.0 146.0 146.0 148.0 147.0 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.50 stddev:1.97 (2.8%) stddev-sans-first:2.05 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 71.0 70.0 70.0 70.0 76.0 70.0 71.0 69.0 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:46:31 INFO - 2015-11-27 03:46:31,911 DEBUG : BROWSER_OUTPUT: 03:46:32 INFO - 2015-11-27 03:46:32,797 INFO : Browser exited with error code: 0 03:46:32 INFO - 2015-11-27 03:46:32,848 INFO : Completed test kraken (00:01:01) 03:46:32 INFO - 2015-11-27 03:46:32,849 INFO : Starting test v8_7 03:46:32 INFO - 2015-11-27 03:46:32,849 DEBUG : operating with platform_type : linux_ 03:46:32 INFO - 2015-11-27 03:46:32,849 INFO : Initialising browser for v8_7 test... 03:46:32 INFO - 2015-11-27 03:46:32,855 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp10KFf9/profile http://localhost:46153/getInfo.html 03:46:37 INFO - 2015-11-27 03:46:37,374 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:46:37 INFO - 2015-11-27 03:46:37,374 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:46:37 INFO - 2015-11-27 03:46:37,374 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:46:37 INFO - 2015-11-27 03:46:37,374 DEBUG : BROWSER_OUTPUT: __metrics 03:46:38 INFO - 2015-11-27 03:46:38,473 INFO : Browser initialized. 03:46:38 INFO - 2015-11-27 03:46:38,474 INFO : Running cycle 1/1 for v8_7 test... 03:46:38 INFO - 2015-11-27 03:46:38,474 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp10KFf9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:46:50 INFO - 2015-11-27 03:46:50,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 140226560 03:46:50 INFO - 2015-11-27 03:46:50,473 DEBUG : BROWSER_OUTPUT: 03:47:11 INFO - 2015-11-27 03:47:11,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46153/tests/v8_7/run.html (next: http://localhost:46153/tests/v8_7/run.html) 03:47:12 INFO - 2015-11-27 03:47:12,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 137228288 03:47:12 INFO - 2015-11-27 03:47:12,102 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,102 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:47:12 INFO - 2015-11-27 03:47:12,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:47:12 INFO - 2015-11-27 03:47:12,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:47:12 INFO - 2015-11-27 03:47:12,102 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:47:12 INFO - 2015-11-27 03:47:12,103 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 03:47:12 INFO - 2015-11-27 03:47:12,103 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.0949742021785 03:47:12 INFO - 2015-11-27 03:47:12,103 DEBUG : BROWSER_OUTPUT: |2;Encrypt;276.93159789531984 03:47:12 INFO - 2015-11-27 03:47:12,103 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 03:47:12 INFO - 2015-11-27 03:47:12,103 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1051.5247108307046 03:47:12 INFO - 2015-11-27 03:47:12,103 DEBUG : BROWSER_OUTPUT: |5;Earley;749.6251874062968 03:47:12 INFO - 2015-11-27 03:47:12,103 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 03:47:12 INFO - 2015-11-27 03:47:12,104 DEBUG : BROWSER_OUTPUT: |7;RegExp;25575 03:47:12 INFO - 2015-11-27 03:47:12,104 DEBUG : BROWSER_OUTPUT: |8;Splay;622.66500622665 03:47:12 INFO - 2015-11-27 03:47:12,104 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 03:47:12 INFO - 2015-11-27 03:47:12,104 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:47:12 INFO - 2015-11-27 03:47:12,105 DEBUG : BROWSER_OUTPUT: __startTimestamp1448624832101__endTimestamp 03:47:12 INFO - 2015-11-27 03:47:12,105 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,105 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:47:12 INFO - 2015-11-27 03:47:12,105 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:47:12 INFO - 2015-11-27 03:47:12,105 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,106 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,106 DEBUG : BROWSER_OUTPUT: Values: 165.9 03:47:12 INFO - 2015-11-27 03:47:12,106 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,106 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,106 DEBUG : BROWSER_OUTPUT: Values: 191.1 03:47:12 INFO - 2015-11-27 03:47:12,106 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,107 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:276.93 Median:276.93 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,107 DEBUG : BROWSER_OUTPUT: Values: 276.9 03:47:12 INFO - 2015-11-27 03:47:12,107 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,108 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,109 DEBUG : BROWSER_OUTPUT: Values: 5208.3 03:47:12 INFO - 2015-11-27 03:47:12,109 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,109 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,109 DEBUG : BROWSER_OUTPUT: Values: 1051.5 03:47:12 INFO - 2015-11-27 03:47:12,109 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,109 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:749.63 Median:749.63 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,109 DEBUG : BROWSER_OUTPUT: Values: 749.6 03:47:12 INFO - 2015-11-27 03:47:12,110 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,110 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,110 DEBUG : BROWSER_OUTPUT: Values: 12280.5 03:47:12 INFO - 2015-11-27 03:47:12,110 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,110 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,110 DEBUG : BROWSER_OUTPUT: Values: 25575.0 03:47:12 INFO - 2015-11-27 03:47:12,110 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,111 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,111 DEBUG : BROWSER_OUTPUT: Values: 622.7 03:47:12 INFO - 2015-11-27 03:47:12,111 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,111 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:47:12 INFO - 2015-11-27 03:47:12,111 DEBUG : BROWSER_OUTPUT: Values: 4840.6 03:47:12 INFO - 2015-11-27 03:47:12,111 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:47:12 INFO - 2015-11-27 03:47:12,111 DEBUG : BROWSER_OUTPUT: 03:47:12 INFO - 2015-11-27 03:47:12,981 INFO : Browser exited with error code: 0 03:47:12 INFO - 2015-11-27 03:47:12,993 INFO : Completed test v8_7 (00:00:40) 03:47:13 INFO - 2015-11-27 03:47:13,162 INFO : Completed test suite (00:20:17) 03:47:13 INFO - 2015-11-27 03:47:13,162 DEBUG : Working with test: dromaeo_css 03:47:13 INFO - 2015-11-27 03:47:13,162 DEBUG : Generating results file: dromaeo_css 03:47:13 INFO - 2015-11-27 03:47:13,163 DEBUG : Working with test: kraken 03:47:13 INFO - 2015-11-27 03:47:13,163 DEBUG : Generating results file: kraken 03:47:13 INFO - 2015-11-27 03:47:13,163 INFO : javascript benchmark 03:47:13 INFO - 2015-11-27 03:47:13,164 DEBUG : Working with test: v8_7 03:47:13 INFO - 2015-11-27 03:47:13,164 DEBUG : Generating results file: v8_7 03:47:13 INFO - 2015-11-27 03:47:13,164 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:47:13 INFO - 2015-11-27 03:47:13,218 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 03:47:13 INFO - 2015-11-27 03:47:13,219 DEBUG : process_Request line: dromaeo_css 6239.53 graph.html#tests=[[72,94,43]] 03:47:13 INFO - 2015-11-27 03:47:13,219 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:47:13 INFO - 2015-11-27 03:47:13,258 DEBUG : process_Request line: kraken 1552.70 graph.html#tests=[[232,94,43]] 03:47:13 INFO - 2015-11-27 03:47:13,258 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:47:13 INFO - 2015-11-27 03:47:13,308 DEBUG : process_Request line: v8_7 21192.05 graph.html#tests=[[230,94,43]] 03:47:13 INFO - 2015-11-27 03:47:13,310 INFO : javascript benchmark 03:47:13 INFO - 2015-11-27 03:47:13,313 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2727.127319257838, 2768.432471343375, 2800.7059258777826, 2806.579013148029, 2821.955876325759, 4671.5562021607975, 4825.252085926678, 4829.154897892872, 4863.148948933936, 4889.9266511002315, 4784.5933095686905, 4786.904261914759, 4787.904241915168, 4803.375561177042, 4815.0610630926985, 4355.1507456046165, 4394.934075988863, 4420.270655341881, 4514.909701805978, 4520.457545094577, 4346.065595896882, 4475.820967161309, 4494.011317510142, 4546.454425468932, 4553.043860789222, 4419.403380543634, 4435.800388982471, 4510.481294651125, 4510.751908645023, 4532.614727748145, 4488.169688607618, 4513.097380523908, 4513.7517436540975, 4518.593326600621, 4569.817207311704, 4258.127083947783, 4375.846845360397, 4472.664550158751, 4485.798139083749, 4500.369948207253, 4664.463586687507, 4691.906161876777, 4768.880777980578, 4777.116233496814, 4781.737004464753, 5208.973955130238, 5215.478452154792, 5225.712585807779, 5227.712475813829, 5263.236830659571, 5032.672876263031, 5163.870903227412, 5170.0, 5239.869003274911, 5260.079486089957, 4810.230363141881, 4854.927176092361, 4892.657513974059, 4925.950740492621, 4929.359183306147, 5375.435579264199, 5383.488568585978, 5386.461353864583, 5390.434004429557, 5392.676439413648, 4877.731724755173, 4975.029869175549, 5007.273945277914, 5018.447970723218, 5172.301739265226, 5079.720615366116, 5103.18349064148, 5113.386393632788, 5156.0, 5257.5005374489365, 5172.379314482211, 5211.478852114758, 5223.817166399158, 5224.2947202127225, 5229.895402092013, 5137.12668846297, 5188.0661480933795, 5191.558717508979, 5198.2202669599865, 5215.191645294985, 4141.6065473779945, 4206.305959516707, 4237.173751118502, 4289.978550107229, 4321.157374311979, 3757.492738480325, 3762.0406796266775, 3769.8680546180753, 3800.7339486235696, 3807.0, 4293.055527783882, 4447.6219521341045, 4450.821967121279, 4455.710378825366, 4459.331100334975, 5117.104506711311, 5162.354705661793, 5197.142471492237, 5200.24596433515, 5241.318628578337, 4389.561043895585, 4485.6860019798305, 4487.057717879282, 4491.797869095899, 4506.301523263899, 4440.933385999213, 4540.091981603692, 4609.285560738091, 4617.630589552828, 4639.489656137822, 4847.491013443609, 4901.534354236342, 4909.754512274443, 4916.06594746997, 4954.281629163751, 5225.555827754683, 5247.737613119405, 5250.2912106866615, 5260.0531904257605, 5273.156294992937, 4771.308160316666, 4803.279508073817, 4863.173260545645, 4962.900741985212, 4966.6771659842, 5092.3889133302755, 5114.514121158484, 5123.308353372396, 5138.049460849755, 5204.505571970657, 5195.0, 5205.6356055075785, 5207.0, 5224.190250511177, 5257.237700533325, 4802.991371811959, 4957.0, 4973.378327709036, 5031.069252188357, 5103.540681338697, 5044.974775126101, 5048.545630893237, 5052.216906379517, 5065.493450654905, 5135.409427915837, 4911.9754401227765, 4984.028114517634, 4985.700857948535, 4987.750612469435, 4990.750462476934, 4910.705357678551, 4943.134951383566, 5001.524855138756, 5017.799288028438, 5063.544281014726, 4918.729469879191, 4945.085159245407, 5017.347744793154, 5050.3434553507805, 5070.366204224472], "unit": "ms", "name": "dojo.html", "value": 4748.656392083683}, {"lowerIsBetter": false, "replicates": [547.4744245524297, 571.3343954293249, 575.1832397994847, 589.1633879890555, 590.4656286061113, 36896.0, 37502.62497375025, 37544.0, 37591.436128458095, 37787.622123778754, 40401.39397909034, 40555.797221013854, 40709.0, 41001.58998410015, 41091.38362924558, 8010.239027292412, 8089.191080891923, 8166.510009399425, 8202.712905048325, 8209.548474833882, 7938.2855543001115, 8054.556999365032, 8079.394045446586, 8085.151059138794, 8101.311388531982, 8063.556504392256, 8108.7161949331785, 8146.633401496917, 8151.0, 8196.426250162462, 7954.880676789853, 8058.919410805935, 8093.838123237561, 8099.352051835839, 8116.553589552631, 7880.211978802131, 8064.032316122044, 8071.636776345079, 8099.149589293098, 8103.230193131702, 37180.25639487222, 37701.0, 37840.62159378426, 37858.0, 37867.24265514702, 3078.1381213260324, 3094.938101237985, 3366.3267346530793, 3370.1574606348413, 3459.3600183966046, 25054.0, 25196.118135865156, 25343.873280633663, 25541.489170216493, 26013.73986260151, 3382.475716263983, 3402.931941361159, 3514.420120680085, 3552.289542091592, 3572.481990111445, 203809.0, 206411.0, 207404.0, 207538.0, 207791.96104019534, 38581.614183857804, 38907.805460972515, 39031.0, 54905.72547137239, 55143.172852407246, 37620.43569346462, 37839.62160378361, 38048.23903521914, 38221.42667859984, 38275.23449530994, 12260.44827982743, 12525.93737031309, 12532.749345013232, 12540.0, 12671.809922851164, 9315.161635452841, 9379.71860844162, 9383.530823458936, 9396.154346108882, 9402.48286344244, 13175.275359855108, 13406.463741450429, 13415.798763018562, 13441.798373024412, 13470.595882123553, 5509.256250406224, 5510.779568817203, 5538.695371754511, 5554.1391084381985, 5594.804181853616, 873.9737807865774, 968.9224862011022, 1005.9094681478556, 1009.9798004039878, 1037.8858325584179, 26040.0931285305, 26438.33904152373, 26525.734742652712, 26579.734202658114, 26586.0, 957.262907561174, 961.8557216417594, 972.557486343712, 1042.468341146021, 1110.6001839337832, 13396.866031339758, 14140.43438262458, 14329.211893345757, 14527.78208326876, 14786.03890747098, 291380.0, 296115.0, 296411.0, 296579.0, 296676.0, 48085.5191448088, 49252.0, 49333.50666493361, 49506.0, 49554.50445495571, 1215.635309407192, 1227.0367761307332, 1237.8143278508296, 1247.8814512621286, 1255.5668294438403, 27927.581086284128, 28138.2965425866, 28216.128210634382, 28520.0, 28624.713752862204, 39951.60048399595, 40412.393814092226, 40413.393799092446, 40646.59353406428, 40672.79663601663, 257685.0, 261406.0, 261757.0, 262568.0, 263378.0, 29761.851190743906, 39030.80484597559, 42811.357829633205, 43036.569634304506, 43805.0, 39036.0, 39591.208175836895, 39649.80175099106, 39749.40375894306, 40324.79837600793, 33430.83284583561, 33645.66354336425, 33661.49507757337, 34035.14912127118, 34044.31291073102, 33902.66097338995, 34037.149071273416, 34237.0, 34403.655963441044, 34445.0, 34280.657193427745, 34381.65618343885, 34397.312053759284, 34678.82660586681, 34750.82624586861, 29938.401231975673, 30484.390312194075, 31079.378412432077, 31266.21834454157, 31276.218094547818, 24051.759482404952, 24153.879230603736, 24169.75830241675, 24207.515849682557, 24579.754202457745], "unit": "ms", "name": "ext.html", "value": 16663.472212307857}, {"lowerIsBetter": false, "replicates": [316.1322170641588, 316.3009748455912, 323.32909213382237, 325.39579871234815, 326.43363763869684, 14827.629309267273, 15084.924575377121, 15243.0, 15801.367945282174, 16284.4300449484, 9439.480828554444, 9560.856587151198, 10772.5690972361, 11833.940830295858, 11843.0, 4513.932291015629, 4642.210824159901, 4665.603423708972, 4692.296155576657, 4749.643776716743, 4941.407031156248, 4953.1579631462555, 4953.430355509108, 4954.677945933521, 4959.677620954626, 4932.975335123319, 4986.301917731521, 5998.940010599882, 6516.67416629169, 6523.05415714721, 6445.129907462527, 6526.955687090067, 6534.281229064799, 6568.7700930467445, 6575.342465753411, 6401.967990160066, 6402.167718196652, 6406.8718625627225, 6415.8396040098905, 6438.839029024265, 20454.0, 21121.47196320089, 21260.25589104374, 21324.573508529742, 21814.89092554543, 1820.872538922276, 1860.5348662834292, 1890.5273681579606, 1956.344624550777, 2070.4306315763133, 12668.936655316757, 12806.743865122738, 12963.092583519157, 13105.541306054338, 13118.409671564707, 1879.1825555883236, 1909.30310436691, 1958.9510262243416, 2022.0698478699817, 2043.6832290994919, 57026.85946281051, 62182.68908655473, 63781.36218637847, 64929.350706492805, 65465.0, 14588.708225835424, 15276.0, 15289.464868729541, 15344.386224551115, 15759.921200393925, 22783.544329113323, 22869.0, 22943.88528057349, 23025.309240722807, 23113.88443057774, 8170.387220958333, 8174.059983101901, 8175.468594541336, 8188.303994160444, 8192.713255036046, 6613.206415230203, 6648.803215421271, 6707.3628005339415, 6747.696353664097, 6851.246362900077, 7476.364509016686, 7563.924360756322, 7579.393648508106, 7579.772606821804, 7597.278258565428, 3010.488217003071, 3121.734652554558, 3127.37452509499, 3180.109569320594, 3255.121117298316, 367.74441762974476, 373.4491624853374, 391.14729888842595, 400.1297178636454, 406.8982754311422, 9747.951260243653, 9774.511274436392, 9807.215422766161, 9907.157891579152, 10023.448710320856, 393.5926316262654, 397.6023976023976, 400.95990400960255, 404.52468349688996, 412.78122595024684, 5244.187150991603, 5343.5457986071615, 5355.357357117171, 5383.892322153535, 5460.372057213392, 469150.0, 470762.0, 471267.0, 484559.0, 495474.0, 72715.6364218186, 74301.62849185828, 76460.0, 76726.0, 76935.0, 402.073221225079, 404.34496116291206, 404.5893418180549, 405.3392969459821, 405.44251653975783, 9451.432914025181, 9451.716448506555, 9494.620215191315, 9590.760230994281, 9735.610575576897, 29608.407831843673, 29734.553981690726, 30910.845445772626, 30933.69066309398, 32002.839985800852, 37797.811010944766, 38205.80897095497, 39147.2170556593, 39289.80355098206, 40644.59355406408, 7996.1204267529365, 8344.87482687748, 8810.64757409722, 8871.112888711077, 8905.064968178507, 9483.478408687588, 11184.94407527957, 15317.46388876384, 15491.5352539424, 15607.21963901823, 12973.351332433529, 13137.802932956205, 13174.868251317748, 13277.800832987707, 13917.652058698208, 12916.741665166455, 13017.21896686202, 13197.472101115847, 13253.337333133111, 13366.0, 12898.613041608767, 12973.156744811557, 13668.111572747739, 14079.929600351932, 14298.356573953988, 8625.266852317623, 8628.52543110135, 8725.94970998, 8748.91251087481, 8825.117488251124, 9248.815023699623, 10671.679849604525, 13320.86679133235, 14109.2945352734, 14119.43522259098], "unit": "ms", "name": "jquery.html", "value": 8020.042713983362}, {"lowerIsBetter": false, "replicates": [1400.9352891802228, 1601.5275493729348, 1638.3528506240036, 1645.4450544235694, 1663.9251233694486, 5612.270404847374, 5837.270341207349, 6313.0, 6690.096836927013, 6704.597724136555, 6543.312952140028, 6650.833729156761, 6656.068150458939, 6710.496712746539, 6728.259891411941, 1944.6888497840384, 1964.7347608072942, 1968.6554852900686, 1974.1215159254139, 1979.0401655197218, 1976.7825539190678, 1985.8510611704107, 1989.1744925855753, 2027.391782465262, 2037.5008123009884, 1967.803219678035, 1980.4553747719349, 1988.065609163698, 2006.8896210708406, 2010.8491863110253, 1971.3297478857185, 1986.1261045140163, 1997.9600407991904, 1997.980020199794, 1998.7701414337319, 1972.447714639903, 1992.471994921347, 1996.0, 2001.629698505781, 2009.3067891577382, 6623.768168114141, 6752.324767523258, 6757.256701762803, 6760.256371799098, 6767.763128290536, 3912.6674232690257, 3956.5845586213322, 3965.7025723070883, 3967.702422318309, 3975.920481590352, 2343.847649902751, 2389.0682633772844, 2395.3293077938206, 2508.636247744067, 2621.9475610487875, 805.5730462854638, 830.2403300979596, 834.1533343656193, 841.7306461932184, 843.7342237195326, 8623.13768623139, 8735.213830755263, 8828.646854125891, 8838.204561589488, 8863.911360886374, 3665.7433979621705, 3691.7784932903573, 3694.2057457646733, 3696.77819330841, 3714.0343510687417, 7796.415268854745, 7849.293563579191, 7862.01724784402, 7872.921270787333, 7885.48744331628, 3901.551321597996, 3907.257621051991, 3919.5884432134785, 3925.7055720821054, 3942.073612701013, 3447.620761716209, 3522.18989632386, 3543.7696549724187, 3545.3795585772386, 3579.874704385386, 3140.9371812563622, 3161.6206055273515, 3175.4601717707583, 3209.293955329824, 3215.6623554526436, 957.6504575829772, 971.7522031881825, 975.3513913247752, 978.882534095913, 980.8479685648736, 1119.6585041562403, 1119.8040342939953, 1129.6272230164027, 1141.5662048421548, 1158.5423757615863, 6189.938100619026, 6280.937190628127, 6283.874322513524, 6296.842578935563, 6298.244210694746, 410.3258704485691, 414.834066373447, 415.89810496428566, 415.9979200104041, 416.8082681966329, 4774.355462012584, 4811.206150985118, 4851.296561998491, 4865.416150062015, 4875.049365373789, 7716.6527506262355, 7786.065672119382, 7847.6468558914985, 7866.921330786733, 7969.681212751541, 7676.884846727304, 7763.9223607764325, 7851.411144164211, 7949.523028618301, 7958.323542498837, 6208.937910620926, 6312.779052733133, 6326.304106548276, 6365.2361716594305, 6372.36276372359, 5913.763449462145, 5961.731722072604, 6001.519878409629, 6009.789657361971, 6048.334683184934, 6998.2651821558, 7068.964655176691, 7069.787906362817, 7084.0, 7106.253843346374, 7211.567305961449, 7322.780316590511, 7348.228436014356, 7356.301151390609, 7395.297446742551, 5361.303030605996, 5645.322561292507, 5767.567432442667, 5846.795362162474, 5959.76160953557, 6297.118403423433, 6318.304986451579, 6322.083297921868, 6333.36666333363, 6357.586756860975, 5937.940620593911, 5968.522518198621, 6132.41742034506, 6191.288001879661, 6256.718447669775, 5380.43505431924, 6061.333253342217, 6173.41352571505, 6195.0, 6206.627602343874, 5978.910316345346, 6118.265808103056, 6119.938800611937, 6188.783392581238, 6189.319174890668, 5693.8861222774485, 5729.0, 5737.799177028784, 5740.052891272893, 5745.597808153389, 5671.858203544779, 5693.4021927696995, 5737.426257374229, 5766.625169363978, 5773.24947756789], "unit": "ms", "name": "mootools.html", "value": 3769.1345125810913}, {"lowerIsBetter": false, "replicates": [288.193059433586, 295.97928145029846, 296.18696677619937, 302.5356078419625, 304.18781852453947, 5441.211024401459, 5574.581906357029, 5593.776248950042, 5624.690642014688, 5738.393249890027, 5547.25112109865, 5564.387917329091, 5566.248556444879, 5582.078956972105, 5606.21512988182, 4117.97941010296, 4244.660427165819, 4246.150769846027, 4247.554006829285, 4248.511421186557, 4192.350185721203, 4206.978965105171, 4207.873763787076, 4207.957920420802, 4211.936820947688, 4150.771707556083, 4155.189738001091, 4159.0, 4162.604552567501, 4204.957950420488, 4198.097409057053, 4201.852935147255, 4207.095474473003, 4210.810513526899, 4212.178625168093, 3636.163682353047, 3647.4528820676846, 3651.068977410743, 3651.4157734762575, 3653.2510835278704, 5226.268322434862, 5232.1628539433505, 5346.5455436287575, 5349.812756553541, 5357.169638705968, 4841.419029716457, 4843.370361852936, 4846.345743324641, 4851.320815085891, 4855.955969466546, 5770.682612456313, 5836.941630583682, 5840.3575606683235, 5841.7371218295275, 5850.210221620069, 3868.9226215475815, 3989.7207195496326, 3990.08228107534, 3993.5806740292433, 3995.4805875236325, 6048.485878700316, 6123.785667501661, 6150.784722534735, 6166.290876549209, 6205.7517699291975, 4094.9795251023556, 4103.651189648914, 4106.589341065869, 4109.0, 4121.1345617420075, 4162.438070860456, 4165.187788381237, 4167.499900012018, 4175.62419382257, 4179.477565304337, 4724.95275047252, 4822.42130944289, 4824.782884770194, 4825.083234185494, 4829.396325459317, 5809.448102430262, 5833.329167145747, 5847.473727364558, 5848.385919478478, 5858.179854820329, 1453.2661006192018, 1463.4000059975358, 1465.0, 1465.2893346726828, 1466.208247546313, 960.3901522533102, 961.8653388525612, 968.7771812483169, 986.2504496582649, 988.3032462114193, 5041.067402530543, 5057.519535644108, 5060.7722652480725, 5071.163258062378, 5077.746112694351, 6029.005214139618, 6033.728482218311, 6071.362506936796, 6073.75704971805, 6093.482054025458, 5013.799448022111, 5053.191489361684, 5063.1898896176435, 5064.620153488503, 5068.695878247243, 3182.713555779991, 3265.5754751882105, 3266.7549933755063, 3283.7044665980175, 3291.9835400822844, 5655.660660360391, 5683.2895888014, 5711.371749107595, 5718.0, 5719.399463056319, 6290.370962903673, 6315.305316415191, 6329.841753956188, 6333.0, 6342.460890824239, 5749.626274292157, 5763.423657634287, 5765.85585360361, 5770.5095066919785, 5776.0, 6126.5711400203345, 6135.509159267159, 6136.079588061648, 6137.723802428991, 6142.692865356804, 5821.185034095145, 5968.343482217039, 6025.728842202024, 6034.517238620988, 6042.425969532887, 5720.799772008127, 5760.337561180518, 5766.481016708516, 5788.82633520995, 5789.536837052941, 4001.8399264029113, 4053.5135783706146, 4064.288749468772, 4070.9415551956113, 4074.9592504075767, 5992.490638295793, 6113.84715382119, 6120.632762034292, 6124.265088189446, 6127.417895299939, 5846.123081537803, 5862.94137058624, 5874.911876321773, 5883.735231914488, 5894.793682221273, 5853.707314634166, 5860.179574859438, 5878.500327472213, 5893.292804863444, 5901.734421950937, 5605.24329215567, 5733.5126514245085, 5738.512226460631, 5749.396313387201, 5754.597178197486, 5856.443637854397, 5873.148393483007, 5919.733611987384, 5924.0, 5924.585279030599, 5744.109663002241, 5756.56825738063, 5777.768889244383, 5783.392743762012, 5793.768249270151], "unit": "ms", "name": "prototype.html", "value": 4350.3131447464775}, {"lowerIsBetter": false, "replicates": [753.4800987318749, 764.7208768799386, 766.4328396986228, 774.0788461730543, 783.4085265624451, 11162.0, 11322.037626801732, 11364.488598013078, 11418.942905285483, 11513.136514761394, 11664.41677916105, 11844.644660660173, 11901.1669183157, 11920.0, 11990.820137697941, 760.1828034862517, 772.1197834468682, 772.4862966127519, 777.7161336112307, 779.7154038775834, 761.3186198352471, 773.5088218980932, 776.4254451705725, 777.4829738224074, 778.1362687416963, 784.5449639209245, 793.896793416855, 795.2564352330561, 795.3676826922582, 796.1361922314296, 795.5385876191824, 798.0941631248546, 798.696495331776, 800.4516905919435, 800.727752564131, 578.9855253618651, 581.7847396463336, 582.7639805878626, 585.1719816459747, 585.5257241634247, 10314.12329951955, 10415.323004004715, 10428.478576071166, 10439.478026098664, 10492.580296788119, 8892.15524525169, 8912.24245939096, 9395.0, 9928.751781205456, 10052.246081543914, 8702.086280940537, 8752.824943501158, 8814.118588141198, 8933.553322333857, 8942.061083586195, 3130.874765009397, 3183.1564635371647, 3198.2484116232667, 3217.8230197339135, 3305.8512366943546, 37420.06449838749, 37652.11739413046, 37958.24083518314, 38096.80951595252, 40474.59525404737, 8902.599383027778, 8950.641974321084, 8970.641174353083, 9037.819243615222, 9087.591058402388, 15576.532704018897, 15605.921970390076, 15611.843881561039, 15651.452199172974, 15660.295286711897, 6114.510839132859, 6131.601445906002, 6137.938620613737, 6301.52738544611, 6517.837054073591, 3488.1977145256733, 3640.162762564625, 3673.651003154696, 3679.5032670589662, 3702.4816525686424, 2683.825551339157, 2690.0, 2715.212588349396, 2720.537508623499, 2729.044834308016, 479.6666316909714, 497.45031739927583, 498.2177980570542, 501.82937801147784, 502.47240397583124, 458.4246770303248, 488.82402335159315, 527.3855957809186, 539.3069905171914, 622.1818308923841, 7842.0, 8138.918610813935, 8308.875366869503, 8330.125336839545, 8513.702020429255, 560.5767645427758, 561.7921369093461, 576.6367188671111, 580.2717589425245, 588.8969430349672, 3764.7552909060823, 3864.439656249828, 3978.9403158952637, 4012.1975604878558, 4122.793860306972, 54124.45875541194, 54743.0, 54819.17771233435, 54858.45141548533, 54862.72568637211, 44717.776411118386, 45930.54069459329, 46324.305135423, 46881.5311846884, 47223.52776472191, 39233.0, 39614.40578391269, 40486.797566012574, 42561.14877702429, 42561.46700928859, 8098.392620553364, 8220.219079187467, 8407.663693452194, 8505.404621676424, 9033.141851524095, 32126.83936580302, 32201.35597288088, 33508.32983340368, 34067.14832129217, 34176.48735268923, 41352.58647413487, 41952.3707144387, 42054.15891682088, 42364.36453453139, 43398.78300608603, 10032.147267482345, 10036.89963100389, 10396.480175991019, 10790.460476976277, 10792.514336855018, 11106.833397498882, 11148.777024459627, 11249.887501124884, 11300.321980681185, 11349.0, 9804.65683701067, 9906.75233119149, 10414.25641891403, 10594.0, 10949.50727217293, 10217.233707472118, 10235.283530152818, 10275.332103413255, 10366.429846358222, 10537.315074520131, 10517.421541815274, 10527.736806579896, 10687.198460115678, 10718.678439646823, 10743.462826858782, 8550.82898342042, 8659.760844688872, 8697.478151310941, 9019.549022548978, 9246.306527010636, 8742.650293988168, 8766.21104100634, 9086.818263634823, 9316.720498385059, 9372.203362714246], "unit": "ms", "name": "yui.html", "value": 5670.088200781827}], "name": "dromaeo_css", "value": 6239.528368804081}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 115.0, 115.0, 113.0, 124.0, 113.0, 113.0, 113.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 154.0, 176.0, 130.0, 168.0, 163.0, 137.0, 180.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 164.0, 161.0, 165.0, 171.0, 162.0, 167.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 73.0, 72.0, 148.0, 73.0, 73.0, 72.0, 72.0, 156.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 130.0, 94.0, 94.0, 94.0, 140.0, 95.0, 95.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 146.0, 148.0, 147.0, 148.0, 149.0, 147.0, 149.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 73.0, 74.0, 75.0, 75.0, 81.0, 75.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 74.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 68.0, 68.0, 70.0, 69.0, 68.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 84.0, 84.0, 87.0, 83.0, 84.0, 84.0, 84.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [133.0, 128.0, 132.0, 130.0, 132.0, 127.0, 129.0, 132.0, 131.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [135.0, 148.0, 149.0, 147.0, 147.0, 137.0, 146.0, 146.0, 148.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 70.0, 70.0, 70.0, 76.0, 70.0, 71.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1552.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [276.93159789531984], "unit": "score", "name": "Encrypt", "value": 961.1795910000001}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1051.5247108307046], "unit": "score", "name": "RayTrace", "value": 703.7295389999999}, {"lowerIsBetter": false, "replicates": [749.6251874062968], "unit": "score", "name": "Earley", "value": 889.0616419999996}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [622.66500622665], "unit": "score", "name": "Splay", "value": 130.874546}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21192.05243816562}]} 03:47:13 INFO - RETURN: dromaeo_css: 6239.53 03:47:13 INFO - RETURN: kraken: 1552.70 03:47:13 INFO - RETURN: v8_7: 21192.05 03:47:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21192.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1552.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6239.53"}}} 03:47:13 INFO - Return code: 0 03:47:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:47:13 INFO - # TBPL SUCCESS # 03:47:13 INFO - Running post-action listener: _resource_record_post_action 03:47:13 INFO - Running post-run listener: _resource_record_post_run 03:47:14 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10276864; Write bytes: 411783168; Read time: 4028; Write time: 443432 03:47:14 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13623296; Read time: 0; Write time: 9928 03:47:14 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8515584; Write bytes: 365379584; Read time: 3736; Write time: 399740 03:47:14 INFO - Running post-run listener: _upload_blobber_files 03:47:14 INFO - Blob upload gear active. 03:47:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:47:14 INFO - Copying logs to upload dir... 03:47:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.393731 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-27 03:47:14.503617) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 03:47:14.507309) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009981 build_url: 'https://queue.taskcluster.net/v1/task/gjxbKD0lQMePbckhsWjs0w/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-27 03:47:14.559261) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:47:14.559583) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448608474.419121-122018719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 03:47:14.610346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 03:47:14.610664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 03:47:14.610983) ========= ========= Total master_lag: 0.25 =========