builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1449756858.81 results: success (0) buildid: 20151210050608 builduid: 6251f748b7c944dd84eb608401da839f revision: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:18.806757) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:18.807152) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:18.810464) ========= 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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006382 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:18.872841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:18.873180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:18.996346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:18.996617) ========= 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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.095566) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.095845) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.096191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.096487) ========= 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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 06:14:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-12-10 06:14:21 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098377 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.270309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.270607) ========= 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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019657 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.330696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.331069) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f --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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 06:14:21,548 truncating revision to first 12 chars 2015-12-10 06:14:21,548 Setting DEBUG logging. 2015-12-10 06:14:21,548 attempt 1/10 2015-12-10 06:14:21,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/412e4d7ce98c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 06:14:21,775 unpacking tar archive at: fx-team-412e4d7ce98c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.883766) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.884058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.967120) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.967454) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 06:14:19.967870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 06:14:19.968177) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:22 INFO - MultiFileLogger online at 20151210 06:14:22 in /builds/slave/test 06:14:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:14:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:22 INFO - {'append_to_log': False, 06:14:22 INFO - 'base_work_dir': '/builds/slave/test', 06:14:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:14:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:22 INFO - 'branch': 'Fx-Team-Non-PGO', 06:14:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:22 INFO - 'config_files': ('talos/linux_config.py',), 06:14:22 INFO - 'default_actions': ('clobber', 06:14:22 INFO - 'read-buildbot-config', 06:14:22 INFO - 'download-and-extract', 06:14:22 INFO - 'populate-webroot', 06:14:22 INFO - 'create-virtualenv', 06:14:22 INFO - 'install', 06:14:22 INFO - 'run-tests'), 06:14:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:22 INFO - 'download_minidump_stackwalk': True, 06:14:22 INFO - 'download_symbols': 'ondemand', 06:14:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:22 INFO - 'installer_path': 'installer.exe', 06:14:22 INFO - 'log_level': 'info', 06:14:22 INFO - 'log_name': 'talos', 06:14:22 INFO - 'log_to_console': True, 06:14:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:22 INFO - 'opt_config_files': (), 06:14:22 INFO - 'pip_index': False, 06:14:22 INFO - 'sps_profile': False, 06:14:22 INFO - 'sps_profile_interval': 0, 06:14:22 INFO - 'suite': 'dromaeojs-e10s', 06:14:22 INFO - 'system_bits': '64', 06:14:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:22 INFO - 'title': 'talos-linux64-ix-061', 06:14:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:22 INFO - 'use_talos_json': True, 06:14:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:22 INFO - 'work_dir': 'build'} 06:14:22 INFO - ##### 06:14:22 INFO - ##### Running clobber step. 06:14:22 INFO - ##### 06:14:22 INFO - Running pre-action listener: _resource_record_pre_action 06:14:22 INFO - Running main action method: clobber 06:14:22 INFO - rmtree: /builds/slave/test/build 06:14:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:22 INFO - Running post-action listener: _resource_record_post_action 06:14:22 INFO - ##### 06:14:22 INFO - ##### Running read-buildbot-config step. 06:14:22 INFO - ##### 06:14:22 INFO - Running pre-action listener: _resource_record_pre_action 06:14:22 INFO - Running main action method: read_buildbot_config 06:14:22 INFO - Using buildbot properties: 06:14:22 INFO - { 06:14:22 INFO - "properties": { 06:14:22 INFO - "buildnumber": 559, 06:14:22 INFO - "product": "firefox", 06:14:22 INFO - "script_repo_revision": "production", 06:14:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:14:22 INFO - "repository": "", 06:14:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:14:22 INFO - "buildid": "20151210050608", 06:14:22 INFO - "slavename": "talos-linux64-ix-061", 06:14:22 INFO - "pgo_build": "False", 06:14:22 INFO - "basedir": "/builds/slave/test", 06:14:22 INFO - "project": "", 06:14:22 INFO - "platform": "ubuntu64_hw", 06:14:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:14:22 INFO - "slavebuilddir": "test", 06:14:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:14:22 INFO - "branch": "fx-team", 06:14:22 INFO - "repo_path": "integration/fx-team", 06:14:22 INFO - "stage_platform": "linux64", 06:14:22 INFO - "builduid": "6251f748b7c944dd84eb608401da839f", 06:14:22 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 06:14:22 INFO - }, 06:14:22 INFO - "sourcestamp": { 06:14:22 INFO - "repository": "", 06:14:22 INFO - "hasPatch": false, 06:14:22 INFO - "project": "", 06:14:22 INFO - "branch": "fx-team-linux64-talos", 06:14:22 INFO - "changes": [ 06:14:22 INFO - { 06:14:22 INFO - "category": null, 06:14:22 INFO - "files": [ 06:14:22 INFO - { 06:14:22 INFO - "url": null, 06:14:22 INFO - "name": "https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:14:22 INFO - } 06:14:22 INFO - ], 06:14:22 INFO - "repository": "", 06:14:22 INFO - "rev": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f", 06:14:22 INFO - "who": "cbook@mozilla.com", 06:14:22 INFO - "when": 1449756797, 06:14:22 INFO - "number": 7244130, 06:14:22 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 06:14:22 INFO - "project": "", 06:14:22 INFO - "at": "Thu 10 Dec 2015 06:13:17", 06:14:22 INFO - "branch": "fx-team-linux64-talos", 06:14:22 INFO - "revlink": "", 06:14:22 INFO - "properties": [ 06:14:22 INFO - [ 06:14:22 INFO - "buildid", 06:14:22 INFO - "20151210050608", 06:14:22 INFO - "Change" 06:14:22 INFO - ], 06:14:22 INFO - [ 06:14:22 INFO - "builduid", 06:14:22 INFO - "6251f748b7c944dd84eb608401da839f", 06:14:22 INFO - "Change" 06:14:22 INFO - ], 06:14:22 INFO - [ 06:14:22 INFO - "pgo_build", 06:14:22 INFO - "False", 06:14:22 INFO - "Change" 06:14:22 INFO - ] 06:14:22 INFO - ], 06:14:22 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 06:14:22 INFO - } 06:14:22 INFO - ], 06:14:22 INFO - "revision": "412e4d7ce98ca4dbc37de133d0f26d7e1a59946f" 06:14:22 INFO - } 06:14:22 INFO - } 06:14:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:14:22 INFO - Running post-action listener: _resource_record_post_action 06:14:22 INFO - ##### 06:14:22 INFO - ##### Running download-and-extract step. 06:14:22 INFO - ##### 06:14:22 INFO - Running pre-action listener: _resource_record_pre_action 06:14:22 INFO - Running main action method: download_and_extract 06:14:22 INFO - mkdir: /builds/slave/test/build/tests 06:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:22 INFO - https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:14:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/test_packages.json 06:14:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/test_packages.json 06:14:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:14:26 INFO - Downloaded 1302 bytes. 06:14:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:14:26 INFO - Using the following test package requirements: 06:14:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:26 INFO - u'jsshell-linux-x86_64.zip'], 06:14:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:14:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:14:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14: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')]} 06:14:26 INFO - https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:28 INFO - Downloaded 21866925 bytes. 06:14:28 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 06:14:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:14:28 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 06:14:29 INFO - Return code: 0 06:14:29 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 06:14:29 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')]} 06:14:29 INFO - https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:38 INFO - Downloaded 21866925 bytes. 06:14:38 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 06:14:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:14:38 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 06:14:39 INFO - Return code: 0 06:14:39 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')]} 06:14:39 INFO - https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:41 INFO - Downloaded 11132038 bytes. 06:14:41 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 06:14:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:41 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 06:14:41 INFO - Return code: 0 06:14:41 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')]} 06:14:41 INFO - https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzADg9JQR8a-M-wAUDyrrw/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 06:14:43 INFO - Downloaded 57728829 bytes. 06:14:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:14:43 INFO - mkdir: /builds/slave/test/properties 06:14:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:43 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:43 INFO - Contents: 06:14:43 INFO - build_url:https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:14:43 INFO - Running post-action listener: _resource_record_post_action 06:14:43 INFO - Running post-action listener: set_extra_try_arguments 06:14:43 INFO - ##### 06:14:43 INFO - ##### Running populate-webroot step. 06:14:43 INFO - ##### 06:14:43 INFO - Running pre-action listener: _resource_record_pre_action 06:14:43 INFO - Running main action method: populate_webroot 06:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:43 INFO - '--tppagecycles', 06:14:43 INFO - '7'], 06:14:43 INFO - 'tests': ['tsvgm']}}, 06:14:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:14:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:14:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:14:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'tests': ['damp', 'tps']}, 06:14:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['damp', 'tps']}, 06:14:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:43 INFO - 'other': {'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore']}, 06:14:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore']}, 06:14:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore']}, 06:14:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore']}, 06:14:43 INFO - 'other_l64': {'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore']}, 06:14:43 INFO - 'other_nol64': {'tests': ['a11yr', 06:14:43 INFO - 'ts_paint', 06:14:43 INFO - 'tpaint', 06:14:43 INFO - 'sessionrestore', 06:14:43 INFO - 'sessionrestore_no_auto_restore']}, 06:14:43 INFO - 'svgr': {'tests': ['tsvgx', 06:14:43 INFO - 'tsvgr_opacity', 06:14:43 INFO - 'tart', 06:14:43 INFO - 'tscrollx', 06:14:43 INFO - 'cart']}, 06:14:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['tsvgx', 06:14:43 INFO - 'tsvgr_opacity', 06:14:43 INFO - 'tart', 06:14:43 INFO - 'tscrollx', 06:14:43 INFO - 'cart']}, 06:14:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'tests': ['tp5o']}, 06:14:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--e10s'], 06:14:43 INFO - 'tests': ['tp5o']}, 06:14:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--xperf_path', 06:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:43 INFO - 'tests': ['tp5n']}, 06:14:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:43 INFO - 'talos_options': ['--e10s', 06:14:43 INFO - '--xperf_path', 06:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:43 INFO - 'tests': ['tp5n']}}, 06:14:43 INFO - 'talos.zip': {'path': '', 06:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:43 INFO - Running post-action listener: _resource_record_post_action 06:14:43 INFO - ##### 06:14:43 INFO - ##### Running create-virtualenv step. 06:14:43 INFO - ##### 06:14:43 INFO - Running pre-action listener: _resource_record_pre_action 06:14:43 INFO - Running main action method: create_virtualenv 06:14:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:43 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 06:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:43 INFO - Using real prefix '/usr' 06:14:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:45 INFO - Installing pip.................done. 06:14:45 INFO - Return code: 0 06:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:45 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')]} 06:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 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')]} 06:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:14:45 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 06:14:45 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 06:14:45 INFO - Using env: {'DISPLAY': ':0', 06:14:45 INFO - 'HOME': '/home/cltbld', 06:14:45 INFO - 'LANG': 'en_US.UTF-8', 06:14:45 INFO - 'LANGUAGE': 'en_US:en', 06:14:45 INFO - 'LOGNAME': 'cltbld', 06:14:45 INFO - 'MAIL': '/var/mail/cltbld', 06:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:45 INFO - 'MOZ_NO_REMOTE': '1', 06:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:45 INFO - 'NO_EM_RESTART': '1', 06:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:45 INFO - 'PWD': '/builds/slave/test', 06:14:45 INFO - 'SHELL': '/bin/bash', 06:14:45 INFO - 'SHLVL': '1', 06:14:45 INFO - 'TERM': 'linux', 06:14:45 INFO - 'TMOUT': '86400', 06:14:45 INFO - 'USER': 'cltbld', 06:14:45 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:45 INFO - '_': '/tools/buildbot/bin/python'} 06:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:45 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 06:14:45 INFO - Cleaning up... 06:14:45 INFO - Return code: 0 06:14:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:14:45 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')]} 06:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 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')]} 06:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:14:45 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 06:14:45 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 06:14:45 INFO - Using env: {'DISPLAY': ':0', 06:14:45 INFO - 'HOME': '/home/cltbld', 06:14:45 INFO - 'LANG': 'en_US.UTF-8', 06:14:45 INFO - 'LANGUAGE': 'en_US:en', 06:14:45 INFO - 'LOGNAME': 'cltbld', 06:14:45 INFO - 'MAIL': '/var/mail/cltbld', 06:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:45 INFO - 'MOZ_NO_REMOTE': '1', 06:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:45 INFO - 'NO_EM_RESTART': '1', 06:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:45 INFO - 'PWD': '/builds/slave/test', 06:14:45 INFO - 'SHELL': '/bin/bash', 06:14:45 INFO - 'SHLVL': '1', 06:14:45 INFO - 'TERM': 'linux', 06:14:45 INFO - 'TMOUT': '86400', 06:14:45 INFO - 'USER': 'cltbld', 06:14:45 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:45 INFO - '_': '/tools/buildbot/bin/python'} 06:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:46 INFO - Downloading/unpacking psutil>=0.7.1 06:14:46 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 06:14:46 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 06:14:46 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 06:14:46 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 06:14:46 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 06:14:46 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 06:14:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:14:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:47 INFO - Installing collected packages: psutil 06:14:47 INFO - Running setup.py install for psutil 06:14:47 INFO - building 'psutil._psutil_linux' extension 06:14:47 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 06:14:48 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 06:14:48 INFO - building 'psutil._psutil_posix' extension 06:14:48 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 06:14:48 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 06:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:48 INFO - Successfully installed psutil 06:14:48 INFO - Cleaning up... 06:14:48 INFO - Return code: 0 06:14:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:48 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:14:48 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 06:14:48 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 06:14:48 INFO - Using env: {'DISPLAY': ':0', 06:14:48 INFO - 'HOME': '/home/cltbld', 06:14:48 INFO - 'LANG': 'en_US.UTF-8', 06:14:48 INFO - 'LANGUAGE': 'en_US:en', 06:14:48 INFO - 'LOGNAME': 'cltbld', 06:14:48 INFO - 'MAIL': '/var/mail/cltbld', 06:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:48 INFO - 'MOZ_NO_REMOTE': '1', 06:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:48 INFO - 'NO_EM_RESTART': '1', 06:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:48 INFO - 'PWD': '/builds/slave/test', 06:14:48 INFO - 'SHELL': '/bin/bash', 06:14:48 INFO - 'SHLVL': '1', 06:14:48 INFO - 'TERM': 'linux', 06:14:48 INFO - 'TMOUT': '86400', 06:14:48 INFO - 'USER': 'cltbld', 06:14:48 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:48 INFO - '_': '/tools/buildbot/bin/python'} 06:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:14:48 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 06:14:48 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 06:14:48 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 06:14:48 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 06:14:48 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 06:14:48 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 06:14:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:14:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:14:50 INFO - Installing collected packages: mozsystemmonitor 06:14:50 INFO - Running setup.py install for mozsystemmonitor 06:14:50 INFO - Successfully installed mozsystemmonitor 06:14:50 INFO - Cleaning up... 06:14:50 INFO - Return code: 0 06:14:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14:50 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')]} 06:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:50 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')]} 06:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:50 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:14:50 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 06:14:50 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 06:14:50 INFO - Using env: {'DISPLAY': ':0', 06:14:50 INFO - 'HOME': '/home/cltbld', 06:14:50 INFO - 'LANG': 'en_US.UTF-8', 06:14:50 INFO - 'LANGUAGE': 'en_US:en', 06:14:50 INFO - 'LOGNAME': 'cltbld', 06:14:50 INFO - 'MAIL': '/var/mail/cltbld', 06:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:50 INFO - 'MOZ_NO_REMOTE': '1', 06:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:50 INFO - 'NO_EM_RESTART': '1', 06:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:50 INFO - 'PWD': '/builds/slave/test', 06:14:50 INFO - 'SHELL': '/bin/bash', 06:14:50 INFO - 'SHLVL': '1', 06:14:50 INFO - 'TERM': 'linux', 06:14:50 INFO - 'TMOUT': '86400', 06:14:50 INFO - 'USER': 'cltbld', 06:14:50 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:50 INFO - '_': '/tools/buildbot/bin/python'} 06:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:50 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 06:14:50 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 06:14:50 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 06:14:50 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 06:14:50 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 06:14:50 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 06:14:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:53 INFO - Downloading docopt-0.6.1.tar.gz 06:14:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:53 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:53 INFO - Running setup.py install for blobuploader 06:14:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:53 INFO - Running setup.py install for requests 06:14:53 INFO - Running setup.py install for docopt 06:14:53 INFO - Successfully installed blobuploader requests docopt 06:14:53 INFO - Cleaning up... 06:14:53 INFO - Return code: 0 06:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:53 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:14:53 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 06:14:53 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 06:14:53 INFO - Using env: {'DISPLAY': ':0', 06:14:53 INFO - 'HOME': '/home/cltbld', 06:14:53 INFO - 'LANG': 'en_US.UTF-8', 06:14:53 INFO - 'LANGUAGE': 'en_US:en', 06:14:53 INFO - 'LOGNAME': 'cltbld', 06:14:53 INFO - 'MAIL': '/var/mail/cltbld', 06:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:53 INFO - 'MOZ_NO_REMOTE': '1', 06:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:53 INFO - 'NO_EM_RESTART': '1', 06:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:53 INFO - 'PWD': '/builds/slave/test', 06:14:53 INFO - 'SHELL': '/bin/bash', 06:14:53 INFO - 'SHLVL': '1', 06:14:53 INFO - 'TERM': 'linux', 06:14:53 INFO - 'TMOUT': '86400', 06:14:53 INFO - 'USER': 'cltbld', 06:14:53 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:53 INFO - '_': '/tools/buildbot/bin/python'} 06:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:53 INFO - Running setup.py (path:/tmp/pip-BD2KDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:54 INFO - Running setup.py (path:/tmp/pip-kocqML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:54 INFO - Running setup.py (path:/tmp/pip-j3T_dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:54 INFO - Running setup.py (path:/tmp/pip-NcpwoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:54 INFO - Running setup.py (path:/tmp/pip-1MWwQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:54 INFO - Running setup.py (path:/tmp/pip-MABQrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:54 INFO - Running setup.py (path:/tmp/pip-WZ0ze0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:54 INFO - Running setup.py (path:/tmp/pip-miqOVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:54 INFO - Running setup.py (path:/tmp/pip-dnW7WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:54 INFO - Running setup.py (path:/tmp/pip-j0o3hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:54 INFO - Running setup.py (path:/tmp/pip-dlu7Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:54 INFO - Running setup.py (path:/tmp/pip-7T1e6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:54 INFO - Running setup.py (path:/tmp/pip-ie0jNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:54 INFO - Running setup.py (path:/tmp/pip-rpzRE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:54 INFO - Running setup.py (path:/tmp/pip-6mjqNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:55 INFO - Running setup.py (path:/tmp/pip-1LbMAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:55 INFO - Running setup.py (path:/tmp/pip-_fXPKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:55 INFO - Running setup.py install for manifestparser 06:14:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozcrash 06:14:55 INFO - Running setup.py install for mozdebug 06:14:55 INFO - Running setup.py install for mozdevice 06:14:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozfile 06:14:55 INFO - Running setup.py install for mozhttpd 06:14:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozinfo 06:14:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozInstall 06:14:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozleak 06:14:56 INFO - Running setup.py install for mozlog 06:14:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Running setup.py install for moznetwork 06:14:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Running setup.py install for mozprocess 06:14:56 INFO - Running setup.py install for mozprofile 06:14:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Running setup.py install for mozrunner 06:14:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Running setup.py install for mozscreenshot 06:14:56 INFO - Running setup.py install for moztest 06:14:56 INFO - Running setup.py install for mozversion 06:14:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:56 INFO - Cleaning up... 06:14:56 INFO - Return code: 0 06:14:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:56 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:14:56 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 06:14:56 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 06:14:56 INFO - Using env: {'DISPLAY': ':0', 06:14:56 INFO - 'HOME': '/home/cltbld', 06:14:56 INFO - 'LANG': 'en_US.UTF-8', 06:14:56 INFO - 'LANGUAGE': 'en_US:en', 06:14:56 INFO - 'LOGNAME': 'cltbld', 06:14:56 INFO - 'MAIL': '/var/mail/cltbld', 06:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:56 INFO - 'MOZ_NO_REMOTE': '1', 06:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:56 INFO - 'NO_EM_RESTART': '1', 06:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:56 INFO - 'PWD': '/builds/slave/test', 06:14:56 INFO - 'SHELL': '/bin/bash', 06:14:56 INFO - 'SHLVL': '1', 06:14:56 INFO - 'TERM': 'linux', 06:14:56 INFO - 'TMOUT': '86400', 06:14:56 INFO - 'USER': 'cltbld', 06:14:56 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:56 INFO - '_': '/tools/buildbot/bin/python'} 06:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:57 INFO - Running setup.py (path:/tmp/pip-djLHLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:57 INFO - Running setup.py (path:/tmp/pip-46kh64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:57 INFO - Running setup.py (path:/tmp/pip-oOEWnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:57 INFO - Running setup.py (path:/tmp/pip-ah0Bc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:57 INFO - Running setup.py (path:/tmp/pip-UNNPwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:57 INFO - Running setup.py (path:/tmp/pip-7rPN7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:57 INFO - Running setup.py (path:/tmp/pip-G0BLY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:57 INFO - Running setup.py (path:/tmp/pip-lD6NfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:57 INFO - Running setup.py (path:/tmp/pip-LP8Zl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:57 INFO - Running setup.py (path:/tmp/pip-jWfP_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:57 INFO - Running setup.py (path:/tmp/pip-EeCAcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:57 INFO - Running setup.py (path:/tmp/pip-UEG2Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:58 INFO - Running setup.py (path:/tmp/pip-m7XPd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:58 INFO - Running setup.py (path:/tmp/pip-Y3BfKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:58 INFO - Running setup.py (path:/tmp/pip-nbQ22Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:58 INFO - Running setup.py (path:/tmp/pip-QOyMrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:58 INFO - Running setup.py (path:/tmp/pip-WJLNyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:00 INFO - Downloading blessings-1.5.1.tar.gz 06:15:00 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 06:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:00 INFO - Installing collected packages: blessings 06:15:00 INFO - Running setup.py install for blessings 06:15:00 INFO - Successfully installed blessings 06:15:00 INFO - Cleaning up... 06:15:00 INFO - Return code: 0 06:15:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:00 INFO - Reading from file tmpfile_stdout 06:15:00 INFO - Current package versions: 06:15:00 INFO - argparse == 1.2.1 06:15:00 INFO - blessings == 1.5.1 06:15:00 INFO - blobuploader == 1.2.4 06:15:00 INFO - docopt == 0.6.1 06:15:00 INFO - manifestparser == 1.1 06:15:00 INFO - mozInstall == 1.12 06:15:00 INFO - mozcrash == 0.16 06:15:00 INFO - mozdebug == 0.1 06:15:00 INFO - mozdevice == 0.47 06:15:00 INFO - mozfile == 1.2 06:15:00 INFO - mozhttpd == 0.7 06:15:00 INFO - mozinfo == 0.9 06:15:00 INFO - mozleak == 0.1 06:15:00 INFO - mozlog == 3.1 06:15:00 INFO - moznetwork == 0.27 06:15:00 INFO - mozprocess == 0.22 06:15:00 INFO - mozprofile == 0.27 06:15:00 INFO - mozrunner == 6.11 06:15:00 INFO - mozscreenshot == 0.1 06:15:00 INFO - mozsystemmonitor == 0.0 06:15:00 INFO - moztest == 0.7 06:15:00 INFO - mozversion == 1.4 06:15:00 INFO - psutil == 3.1.1 06:15:00 INFO - requests == 1.2.3 06:15:00 INFO - wsgiref == 0.1.2 06:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:15:00 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 06:15:00 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 06:15:00 INFO - Using env: {'DISPLAY': ':0', 06:15:00 INFO - 'HOME': '/home/cltbld', 06:15:00 INFO - 'LANG': 'en_US.UTF-8', 06:15:00 INFO - 'LANGUAGE': 'en_US:en', 06:15:00 INFO - 'LOGNAME': 'cltbld', 06:15:00 INFO - 'MAIL': '/var/mail/cltbld', 06:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:00 INFO - 'MOZ_NO_REMOTE': '1', 06:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:00 INFO - 'NO_EM_RESTART': '1', 06:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:00 INFO - 'PWD': '/builds/slave/test', 06:15:00 INFO - 'SHELL': '/bin/bash', 06:15:00 INFO - 'SHLVL': '1', 06:15:00 INFO - 'TERM': 'linux', 06:15:00 INFO - 'TMOUT': '86400', 06:15:00 INFO - 'USER': 'cltbld', 06:15:00 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:00 INFO - '_': '/tools/buildbot/bin/python'} 06:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 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)) 06:15:00 INFO - Cleaning up... 06:15:00 INFO - Return code: 0 06:15:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:15:00 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 06:15:00 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 06:15:00 INFO - Using env: {'DISPLAY': ':0', 06:15:00 INFO - 'HOME': '/home/cltbld', 06:15:00 INFO - 'LANG': 'en_US.UTF-8', 06:15:00 INFO - 'LANGUAGE': 'en_US:en', 06:15:00 INFO - 'LOGNAME': 'cltbld', 06:15:00 INFO - 'MAIL': '/var/mail/cltbld', 06:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:00 INFO - 'MOZ_NO_REMOTE': '1', 06:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:00 INFO - 'NO_EM_RESTART': '1', 06:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:00 INFO - 'PWD': '/builds/slave/test', 06:15:00 INFO - 'SHELL': '/bin/bash', 06:15:00 INFO - 'SHLVL': '1', 06:15:00 INFO - 'TERM': 'linux', 06:15:00 INFO - 'TMOUT': '86400', 06:15:00 INFO - 'USER': 'cltbld', 06:15:00 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:00 INFO - '_': '/tools/buildbot/bin/python'} 06:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:00 INFO - Downloading/unpacking jsonschema 06:15:00 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 06:15:00 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 06:15:00 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 06:15:00 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 06:15:00 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 06:15:00 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 06:15:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:03 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 06:15:03 INFO - Downloading/unpacking functools32 (from jsonschema) 06:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:03 INFO - warning: no files found matching '*.txt' 06:15:03 INFO - no previously-included directories found matching 'build' 06:15:03 INFO - no previously-included directories found matching 'dist' 06:15:03 INFO - no previously-included directories found matching '.git*' 06:15:03 INFO - Installing collected packages: jsonschema, functools32 06:15:03 INFO - Running setup.py install for functools32 06:15:04 INFO - warning: no files found matching '*.txt' 06:15:04 INFO - no previously-included directories found matching 'build' 06:15:04 INFO - no previously-included directories found matching 'dist' 06:15:04 INFO - no previously-included directories found matching '.git*' 06:15:04 INFO - Successfully installed jsonschema functools32 06:15:04 INFO - Cleaning up... 06:15:04 INFO - Return code: 0 06:15:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:15:04 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')]} 06:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 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')]} 06:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 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 0x7fb75cd03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, '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': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', '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 06:15:04 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 06:15:04 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 06:15:04 INFO - Using env: {'DISPLAY': ':0', 06:15:04 INFO - 'HOME': '/home/cltbld', 06:15:04 INFO - 'LANG': 'en_US.UTF-8', 06:15:04 INFO - 'LANGUAGE': 'en_US:en', 06:15:04 INFO - 'LOGNAME': 'cltbld', 06:15:04 INFO - 'MAIL': '/var/mail/cltbld', 06:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:04 INFO - 'MOZ_NO_REMOTE': '1', 06:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:04 INFO - 'NO_EM_RESTART': '1', 06:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:04 INFO - 'PWD': '/builds/slave/test', 06:15:04 INFO - 'SHELL': '/bin/bash', 06:15:04 INFO - 'SHLVL': '1', 06:15:04 INFO - 'TERM': 'linux', 06:15:04 INFO - 'TMOUT': '86400', 06:15:04 INFO - 'USER': 'cltbld', 06:15:04 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:04 INFO - '_': '/tools/buildbot/bin/python'} 06:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:04 INFO - Downloading/unpacking flake8 06:15:04 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 06:15:04 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 06:15:04 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 06:15:04 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 06:15:04 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 06:15:04 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 06:15:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:15:05 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 06:15:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:15:06 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 06:15:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:06 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 06:15:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:06 INFO - no previously-included directories found matching 'docs/_build' 06:15:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:15:06 INFO - Running setup.py install for pep8 06:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:06 INFO - no previously-included directories found matching 'docs/_build' 06:15:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:15:06 INFO - Cleaning up... 06:15:06 INFO - Return code: 0 06:15:06 INFO - Running post-action listener: _resource_record_post_action 06:15:06 INFO - Running post-action listener: _start_resource_monitoring 06:15:06 INFO - Starting resource monitoring. 06:15:06 INFO - ##### 06:15:06 INFO - ##### Running install step. 06:15:06 INFO - ##### 06:15:06 INFO - Running pre-action listener: _resource_record_pre_action 06:15:06 INFO - Running main action method: install 06:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:07 INFO - Reading from file tmpfile_stdout 06:15:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:07 INFO - Reading from file tmpfile_stdout 06:15:07 INFO - Output received: 06:15:07 INFO - Usage: mozinstall [options] installer 06:15:07 INFO - Options: 06:15:07 INFO - -h, --help show this help message and exit 06:15:07 INFO - -d DEST, --destination=DEST 06:15:07 INFO - Directory to install application into. [default: 06:15:07 INFO - "/builds/slave/test"] 06:15:07 INFO - --app=APP Application being installed. [default: firefox] 06:15:07 INFO - mkdir: /builds/slave/test/build/application 06:15:07 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'] 06:15:07 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 06:15:21 INFO - Reading from file tmpfile_stdout 06:15:21 INFO - Output received: 06:15:21 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:21 INFO - Running post-action listener: _resource_record_post_action 06:15:21 INFO - ##### 06:15:21 INFO - ##### Running run-tests step. 06:15:21 INFO - ##### 06:15:21 INFO - Running pre-action listener: _resource_record_pre_action 06:15:21 INFO - Running main action method: run_tests 06:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:21 INFO - Python 2.7.3 06:15:21 INFO - Return code: 0 06:15:21 INFO - grabbing minidump binary from tooltool 06:15: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')]} 06:15:21 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 0x1d240b0>, '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 0x1d24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d25440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:21 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 06:15:21 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 06:15:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:21 INFO - Return code: 0 06:15:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:15:22 INFO - Return code: 0 06:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test/build 06:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 06:15:22 INFO - Using env: {'DISPLAY': ':0', 06:15:22 INFO - 'HOME': '/home/cltbld', 06:15:22 INFO - 'LANG': 'en_US.UTF-8', 06:15:22 INFO - 'LANGUAGE': 'en_US:en', 06:15:22 INFO - 'LOGNAME': 'cltbld', 06:15:22 INFO - 'MAIL': '/var/mail/cltbld', 06:15:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:22 INFO - 'MOZ_NO_REMOTE': '1', 06:15:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:22 INFO - 'NO_EM_RESTART': '1', 06:15:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:22 INFO - 'PWD': '/builds/slave/test', 06:15:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:22 INFO - 'SHELL': '/bin/bash', 06:15:22 INFO - 'SHLVL': '1', 06:15:22 INFO - 'TERM': 'linux', 06:15:22 INFO - 'TMOUT': '86400', 06:15:22 INFO - 'USER': 'cltbld', 06:15:22 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690', 06:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:22 INFO - '_': '/tools/buildbot/bin/python'} 06:15:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 06:15:22 INFO - mozversion INFO | application_buildid: 20151210050608 06:15:22 INFO - mozversion INFO | application_changeset: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f 06:15:22 INFO - mozversion INFO | application_display_name: Nightly 06:15:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:22 INFO - mozversion INFO | application_name: Firefox 06:15:22 INFO - mozversion INFO | application_remotingname: firefox 06:15:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:15:22 INFO - mozversion INFO | application_vendor: Mozilla 06:15:22 INFO - mozversion INFO | application_version: 45.0a1 06:15:22 INFO - mozversion INFO | platform_buildid: 20151210050608 06:15:22 INFO - mozversion INFO | platform_changeset: 412e4d7ce98ca4dbc37de133d0f26d7e1a59946f 06:15:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:15:22 INFO - mozversion INFO | platform_version: 45.0a1 06:15:22 INFO - 2015-12-10 06:15:22,935 DEBUG : using testdate: 1449756922 06:15:22 INFO - 2015-12-10 06:15:22,935 DEBUG : actual date: 1449756922 06:15:22 INFO - 2015-12-10 06:15:22,983 INFO : starting webserver on 'localhost:35127' 06:15:22 INFO - 2015-12-10 06:15:22,984 INFO : Starting test suite talos-linux64-ix-061.e 06:15:22 INFO - 2015-12-10 06:15:22,984 INFO : Starting test dromaeo_css 06:15:22 INFO - 2015-12-10 06:15:22,984 DEBUG : operating with platform_type : linux_ 06:15:22 INFO - 2015-12-10 06:15:22,985 INFO : Initialising browser for dromaeo_css test... 06:15:23 INFO - 2015-12-10 06:15:23,001 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe8U6V4/profile http://localhost:35127/getInfo.html 06:15:27 INFO - 2015-12-10 06:15:27,826 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:15:27 INFO - 2015-12-10 06:15:27,826 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:15:27 INFO - 2015-12-10 06:15:27,826 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:15:27 INFO - 2015-12-10 06:15:27,826 DEBUG : BROWSER_OUTPUT: __metrics 06:15:27 INFO - 2015-12-10 06:15:27,942 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:15:28 INFO - 2015-12-10 06:15:28,880 INFO : Browser initialized. 06:15:28 INFO - 2015-12-10 06:15:28,880 INFO : Running cycle 1/1 for dromaeo_css test... 06:15:28 INFO - 2015-12-10 06:15:28,881 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe8U6V4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:15:40 INFO - 2015-12-10 06:15:40,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 143007744 06:15:40 INFO - 2015-12-10 06:15:40,906 DEBUG : BROWSER_OUTPUT: 06:16:30 INFO - 2015-12-10 06:16:30,545 DEBUG : BROWSER_OUTPUT: 1449756990537 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] 06:18:42 INFO - 2015-12-10 06:18:42,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35127/tests/dromaeo/cssquery-ext.html) 06:18:43 INFO - 2015-12-10 06:18:43,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 145436672 06:18:43 INFO - 2015-12-10 06:18:43,249 DEBUG : BROWSER_OUTPUT: 06:21:45 INFO - 2015-12-10 06:21:45,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-ext.html (next: http://localhost:35127/tests/dromaeo/cssquery-jquery.html) 06:21:45 INFO - 2015-12-10 06:21:45,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 144527360 06:21:45 INFO - 2015-12-10 06:21:45,979 DEBUG : BROWSER_OUTPUT: 06:24:47 INFO - 2015-12-10 06:24:47,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35127/tests/dromaeo/cssquery-mootools.html) 06:24:48 INFO - 2015-12-10 06:24:48,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 145170432 06:24:48 INFO - 2015-12-10 06:24:48,466 DEBUG : BROWSER_OUTPUT: 06:27:50 INFO - 2015-12-10 06:27:50,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35127/tests/dromaeo/cssquery-prototype.html) 06:27:50 INFO - 2015-12-10 06:27:50,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 143708160 06:27:50 INFO - 2015-12-10 06:27:50,793 DEBUG : BROWSER_OUTPUT: 06:30:53 INFO - 2015-12-10 06:30:53,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35127/tests/dromaeo/cssquery-yui.html) 06:30:54 INFO - 2015-12-10 06:30:54,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 144822272 06:30:54 INFO - 2015-12-10 06:30:54,101 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/dromaeo/cssquery-yui.html (next: http://localhost:35127/tests/dromaeo/cssquery-dojo.html) 06:33:56 INFO - 2015-12-10 06:33:56,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 146976768 06:33:56 INFO - 2015-12-10 06:33:56,928 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,928 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:33:56 INFO - 2015-12-10 06:33:56,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:33:56 INFO - 2015-12-10 06:33:56,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:33:56 INFO - 2015-12-10 06:33:56,928 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:33:56 INFO - 2015-12-10 06:33:56,930 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2637.551616225242;2647.285232987095;2683.3828219509514;2695.541757901158;2713.9050133245332;4454.844080457185;4583.152116858383;4595.586397224253;4655.231886738684;4707.24684050552;4508.54914508549;4568.109218702354;4613.9077218455695;4712.387389639351;4719.056188762244;4264.701470897038;4276.636485898694;4363.105563359503;4408.030233348658;4451.132029254297;4331;4349.565043495641;4353.477582690081;4410.448693913261;4420.845270415536;4107.938380924288;4180.728252663597;4241.851535196253;4275.102228532012;4298.333758267474;4252.617264446184;4294.5490723473895;4295.52749197588;4333.414988976511;4334.046509767846;4108.815103320358;4254.829806807755;4283.336082907154;4291.54938731435;4300.333448315516;4295.52749197588;4309.095090031066;4382.320740285261;4386.846460373871;4405.5814697604;4956.3804524434445;4991.30121782947;5022.573081288095;5027.09512287788;5030.8239211627415;4774.474807771142;4894.681845680055;5058.721770302632;5064.772085256135;5106.693598384109;4543.045960348364;4552.339910712928;4557.703749256288;4568.223402021697;4580.954190458119;4940.086084074458;4981.32752078472;4991.600671946236;5050.545450909436;5067.391912970467;4824.421069471686;4834.589059929875;4858.80564777412;4889.315495830587;4903.313536104948;4773.069251495925;4893.290472881412;4899.093667671421;4968.189042283382;5015.498450155028;4761.166795810788;4763.428388593322;4895.412550493892;4930.383702037246;4946.3817022872145;4923.01539692063;4967.428745694219;4978.701277923264;4982.327385802871;5010.849674509771;3975.4633124528395;4072.165206132736;4143.875683729493;4155.750654960712;4210.347396153601;3505.298940211968;3569.928601427957;3576.803275819855;3597.6762091411897;3602.6757591816863;4301.698881078294;4341.001569639001;4341.717788343811;4357.673174511924;4377.124575084996;4794.065157294294;4867.294242334912;4910.361652985089;4985.975070124626;4987.775550100254;4295.205387003414;4303.268444364466;4321.114171594815;4334.176506463762;4340.045190058182;4344.522102568715;4357.934630980474;4381.978090109529;4386.605205531518;4416.6908316418185;4609.6542759292515;4663.370444989883;4733.124371991193;4765.69023013503;4778.187708089633;4935.662955616919;4950.232713929347;4951.158303088556;4956.702597844141;5012.373453318335;4743.003969166376;4750.809967601395;4762.261849413347;4771.785269662943;4801.063792560417;4756.928646070242;4825.059113472839;4893.461719210813;4900.558949694545;4938.259261110862;4909.140900342497;4922.606191504743;4923.483034281492;4934.605231581537;4960.801567937242;4613.515580864095;4732.645051621211;4753.239481682914;4768.713877167381;4800.543948324904;4752.334673145831;4788.664793464424;4821.373221481185;4837.830675926326;4869.683470574401;4640.419947506562;4647.535246475325;4719.126961512131;4734.502877197982;4788.353572267699;4670.229412147093;4814.566688998007;4867.026594681007;4867.221244600847;4879.365682461257;4674.579287864109;4721.102990431807;4736.976315118402;4743.573078422958;4776.5701086902345 06:33:56 INFO - 2015-12-10 06:33:56,933 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.3050908400835;578.3291381996885;581.4272941152966;582.4408567774939;586.9236999190105;35373.82313088434;36148.81925590368;36151;36215.275694486096;36376.636233637655;40831.79584102083;41475.792621036926;41551.16897662045;41596;41607;7879;8029.437939344249;8054.718084867001;8072.071711753165;8075.555844428583;7948.5628290444;7984.281414672679;7996.560189189592;8006.279434850862;8029.237222463857;8027.438079334449;8070.354371650254;8090.110087890327;8095.919040809605;8102.906107675447;8021.679132834709;8089.514629122242;8114.431989760719;8121.999999999971;8139.633716482773;7877.842443151105;7929.286364227247;7956.124826269106;7961.721339753139;7986.161453047404;37317.44023839645;37752.81123594364;37780.43329350062;37790.05524861873;37816.24367512662;2659.2421159969317;2789.497890379731;2799.9860000699864;3341.448660970937;3364.6971772540346;28217.153485395473;28280.858595707097;28622.713772862215;28750.568741468895;28997.275068123254;3379.4423920053164;3433.2790114076074;3444.913877153066;3535.505029295901;3576.2847430513743;212275;212664;212728;212914;213431.99999999846;52957;54168.45831541713;56940;57198.714006430535;58065.70967145222;55807.720961395746;55871.72064139653;55934.160987585215;56069.43930560724;56528;12093.45579448927;12162.817557736642;12193.32936688473;12196.085293603015;12276.202046866925;9730.75673108178;9739.853902191473;9752.122308992224;9759.414435133773;9778.511074446391;19048.092753507663;19345.709814352795;19424;19431.90284048599;19476.4157075288;7108.147022357351;7255.782326530212;7285.817854553678;7327.59266940875;7395.26047395267;777.4596655324608;806.2260230179094;856.246503077288;868.9304855611535;1005.9044390782864;26060.73939260621;26121.346966325993;26604;26798.732012680015;26956.32609184747;903.3270213690843;949.6391371279008;950.3632566180676;956.0917128727737;1048.0672201740306;13635.38640761168;14017.948653851003;14219;14281.928590357189;14284.214368209641;263685;269231;269324;269718;269938;45323.320150197775;45704;45884;45908.54091459043;45951.540484595396;1137.3403426012892;1152.9538818447336;1156.7223866272034;1159.3044173496003;1166.9649910502699;25093.247202583952;25117.24648260555;25473.363165921;25516.362090947874;25728.356791080372;40717.59282407138;40794.592054079076;41091.383629244985;41175;41458.170836583704;251773;253868;255971;256319;256557;28213.717862821108;28922.566161507173;28945.421091577628;28979.710202897702;29586;33138.66861331452;33875.83062084674;34109.488357674156;34174.65825341715;35949.82025089858;31471.52792708157;32290.83854580712;32397.838010809795;32509.837450812596;32701.672983269862;32149.35701286008;32337;32365.19087022843;32407;32656.34687306288;32170.19574510656;32556.046637201845;33749.493757594144;34098.48852267169;34202.14494637654;25448.618270726325;28054.85972570124;28836.423271534033;29265.85367073151;29399.70600294055;22685.43286417853;22953.081876724744;23657.171998979953;23895.761042390048;24337.391565210302 06:33:56 INFO - 2015-12-10 06:33:56,933 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.95201195826604;343.4110500491657;344.47467611891864;346.40072674273523;346.4543344232833;14894.180820054893;15230.847691523082;15920.681586368266;16595.087270200132;17458.738118928228;16063.03621782691;16159.757603635926;16184.838151618509;16521.33914643413;16566.17169141541;4663.953360466386;4751.026039661861;4789.928151077719;4796.08874313881;4798.688085274463;4742.715437073769;4755.595774359166;4757.286407038954;4764.952350476486;4774.880627984311;4702.788374523155;4902.607791376681;4979.576735977446;5016.849494515171;5079.923801142986;4743.193657078305;4911.091448082117;4932;4933.7286449245275;4948.035133149037;5077.213031980049;5166.922496162523;5168.8449346519665;5174.327337446146;5175.663581867167;11623.883761162364;11795.882041179564;16266.43067492644;18734.1569629367;18836.34072807445;1728.3777839977597;1764.5500397398582;1818.6180902010594;1841.162271166616;1857.3870622694478;8950.462972221687;9052.140046695553;9079.591418386188;9103.863442048374;9186.770330741718;1726.6719323328653;1728.1791149204153;1752.623186015;1794.6500432415685;1799.7300404939233;53671.46328536743;56382;56667.71666141643;56740.43259567393;58267.70866145642;9399.389039712396;9723.416595004323;9887;9897.80204395908;9955.402675839472;12502.687432814253;12522.561710340095;12599;12629.052821038458;12724.745505089846;6707.094542236833;6788.49086318528;6838.897416538756;6921.273266307066;6945.340192681788;6344.524160687967;6364.6181229126405;6396.584222025554;6416.743330266737;6437.871242575216;4168.7707176105;4170.623694180913;4174.039970806671;4195.706300558932;4203.453551038346;1674.8576371008357;1730.8442240198442;1762.118940529735;1783.1975610975112;1795.5870149865605;784.3137254901961;818.5907046476761;822.0464261456682;828.511178404732;924.8289066522581;10700.571977120828;15277.465288714842;15319.61700957485;15465.613359666098;16025.759613605805;389.3089765665966;401.6064257028129;401.9376996565537;405.450614417466;415.43293404502634;3951.723379363417;5311.415744268127;5351.1973204019705;5376;5382;501101;506990;512919;514551;516126;69931.30068699247;74184.62907685427;74881.5023699523;76120.61939690266;76326;444.0563801920918;446.8547721990301;452.81887245101564;455.26247479083435;455.7516153696177;9255.490947997925;9324;9396.718098457057;9421.576029078846;9529.285303602397;31363.529547056354;32218.516722249653;33081.83459082786;33599.16002099967;33701.66298336985;45031.32453013142;45737.77131114323;46222;48167;48296;8644.265237454636;8862.601182946653;9036.548172591212;9054.637814487347;9121.224695900923;10583.788324233627;14190.148591084568;14775.261236937895;14946.252687365806;14996;12787.74424511486;13526.458941642224;13670.726585468434;13843.584692459242;13915.234662093682;13299.468021279428;13368.331583420984;13463.528776492776;13765.105268157538;13963.232022238875;13177.868221318047;13246.139000964906;13565.728685426038;13769.655758606115;14005.299735013412;8930.240929521064;9059.320550958837;9216.815663686555;9238.399504032217;9241.768955775891;9740.951295243478;9855.901440985499;11077.72305692332;13073.542426015043;13163.868361316647 06:33:56 INFO - 2015-12-10 06:33:56,937 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1499.4152280610556;1633.5344426838349;1713.1691129802043;1726.162811036647;1754.0703427183582;5745.971270143644;6101.511879049676;6474.741010359586;6695.363940425664;6716.4291035262;6299.244090709121;6514.250861150969;6559.967200164005;6592.1430214072225;6595.472362211023;2006.1173083843062;2043.070402966654;2046.4781480722395;2047.2834507922257;2047.4471892588992;2038.8165065144135;2051.6307064728344;2068.9379318620468;2073.792620737922;2079.241077006889;2027.7059826325249;2035.0435295411207;2050.9692354614695;2052.4560991337307;2056.681214411761;2027.4931267183204;2049.7437820272467;2050.518128239855;2052.5176583502866;2053.3429302623017;2034.3998520436508;2063.7626672932656;2066.2354928676486;2076.5431605046865;2082.6771850363216;6868.62222577758;6932.757353492654;6943.375096241312;6974.232834388214;7010;3988.102676897704;4064.4309796628495;4076.347784354519;4089.734167279117;4090.325096359097;2618.4763047390406;2631.223788982255;2633.789296856247;2717.714639962815;2721.07483455626;826.9793255168609;832.4505826154709;841.3605659698612;853.3514528957975;867.3884911137633;9134;9149.63401463934;9236.491992940453;9257.490838003907;9258.027907069796;3738.682212011955;3748.6813620842536;3784.6404591563755;3814.3515602347666;3816.656500914931;7921.445498815027;7940.801479962932;7951.84096318082;7961.800954976172;8002.079760827463;4114.218298523271;4126.793660317032;4134.834606615702;4149.8962525937095;4151.875443736692;3198.4082944655315;3286.4905939579403;3707.3697471429923;3732.869349572806;3768.1144930941205;3344.5652065231366;3364.1421437533763;3369.2924485858243;3392.236746732015;3432.9485057724155;1054.99472502637;1070.1224995503767;1074.5755426606447;1074.7742973975396;1081.648464249122;911.9863202051974;917.4586993673764;1136.6646839182295;1142.971425714347;1152.2740673375888;6396.944504156855;6403.199600049994;6407.871842563216;6444.677766111676;6469.223693156851;418.56260208082625;419.9937000944988;420.325377768683;423.6166269526084;426.5691651432076;5174;5201.973990130025;5237.73811309433;5261.447548007481;5286.47135286476;8034.357251419872;8411.369147313975;8452.366072544584;8469;8476.957615211884;8320.583970801557;8348.499090054616;8409.705660301861;8443.155684431631;8460.830783384297;6238.376162383816;6340.1440805490665;6347.68261586928;6382.074599183093;6410.166678331881;6714.261431242462;6763.391294783493;6769.120014398097;6777.559458635173;6801.1158549388265;7519.285667861544;7641.044869391326;7673.232676732282;7705.075390953121;7836.216378362118;7662.846743064996;7828.13890472059;7878.054633444023;7884.093329266978;7971.362291016589;5124.743762811919;5812.883742325214;6224.62652240867;6271.122042913905;6274.874502510015;6392.137061496638;6405.775797847053;6425.5502114851515;6450.741970321323;6460.547761656639;6146.354632763674;6168.722407491584;6269.122322874892;6365.586236894587;6443.548951573345;6077.331493535796;6108.51131909455;6246.5002799775;6334.524910631629;6339.904901426575;6255.874882502416;6354.745810167541;6364.522660800551;6369.426751592379;6406.711697973509;5860.882782344244;5886.087656413263;5929.762809487572;5937.079752638348;5938.970305148447;5868.2077919480325;5908.409159084229;5981.641101533922;6007.189029481139;6050.394960503914 06:33:56 INFO - 2015-12-10 06:33:56,937 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.2533628596652;305.85166194395714;313.7850572357935;317.92687681833183;320.4968199926117;5357.08929481988;5406.8918621627545;5451.6456430332;5527.806526771564;5603.299587551556;5406.621536492447;5452.291202143726;5473.507384335409;5484;5487.396386397493;4086.1419101988618;4155.916881662365;4191.434156388887;4197.118605092935;4198.496180458334;4154.273002224613;4165.479315085614;4179.1432756284885;4188.895277618053;4191.392248124021;4146.709730318879;4147.875563733093;4149.854755083573;4150.58494150584;4153.7300075494995;4147;4151.377293406013;4152.854650087247;4165.687573431975;4165.75005499671;3504.9649503504893;3632.763870348419;3642.7814331140216;3643.198496330803;3648.872289469882;4994.450610432849;5079.161938280179;5127.846164615067;5135.64050516464;5168.8449346519665;4752.097101550728;4757.8105473631595;4764.618830493587;4768.141734487791;4781.665283430127;5646.378898321182;5681.147827825818;5696.458836410535;5717.571182161313;5728.914066289009;3925.725199236055;3933.0560665440375;3935.1736135411597;3941.743786653887;3944.3886197639413;5850.590458667895;5853.678047707374;5909.4090590941;5921.259842519685;5988.401159884021;4179.059711564934;4185.895352616209;4188.581141885848;4189;4193.035601811601;4242.830286788494;4250.638695710837;4254.702170848011;4262.25410553152;4263.786810659454;4685.0629874025335;4822.156122678587;4826.6621336506105;4826.927596086061;4838.637102217348;5579.553635709133;5684;5702.6293290935955;5719.571032172604;5721;1488.6576087499936;1513.583764464781;1513.7199618070692;1516.9987808046635;1517.8254500732337;986.40815510693;1034.9081718786751;1042.8997407734762;1045.3518818332682;1047.9423631700329;5004.399472063303;5017.1721665924715;5020.071286811952;5024.447310795809;5025.47232540578;5812.38969908162;5874.559408044328;5890.528757699374;5890.8821823563285;5900.76396944126;4990.850274491771;5002.199648056294;5002.324221385804;5008.273800299009;5010.073136469692;3102.953455698166;3134.326119884236;3170.651228364878;3171.5242713593148;3173.793703409271;5595.244641973363;5597.160425936142;5597.328320601472;5604.635698679573;5619.381867994517;6034;6042.879142417127;6045.395460454008;6059.303180134253;6082.057281121345;5583.8883222336135;5589.189567512688;5599.132134519156;5604.103343465026;5612.35457922336;5745.396733342939;5929.584929054925;5941.079132734433;5942.732577033958;5961;5842.649441033552;5843.561732869966;5849.298084229919;5849.853753656193;5875.177475153397;5664.886702265849;5672.03575392176;5691.8292451226525;5695.544356451391;5696.54427645779;3979.8209080590864;4022.316206244887;4066.369712694537;4077.612626800449;4084.754914705008;5780.306363236438;5889.440503152194;5922;5939.732712027882;5939.990201665813;5654.6324488908085;5702.201691763239;5708.34354049273;5714.171445140514;5739.799107031234;5680.829575112753;5695.629784064023;5700.401457846866;5707.571932105192;5726.828195154152;5416.160495123262;5557.360903495988;5605.5515558756015;5609.943900561106;5614.719264036864;5766.077427611562;5767.480926716616;5768.596198266081;5775.9133612995;5789.56578256624;5624.29696287964;5629.521490673339;5632.718364081861;5632.85917852057;5633.8591535211945 06:33:56 INFO - 2015-12-10 06:33:56,938 DEBUG : BROWSER_OUTPUT: |5;yui.html;648.7891435283534;720.484853329869;762.4015148108736;791.8099656082541;806.12535399092;11532.308061516314;11710.765784684301;11739.765204695901;11779.23434976727;11816.877396647305;10480.056794888458;10812.567497300119;11887.286762794238;11956.82064769027;11960.940195299012;774.7443343696567;779.8479296537178;782.2451334462243;789.0649580247397;800.9959950200256;775.3564541430599;775.3564541430627;778.7507997440821;786.4062632712323;804.6741069866713;807.11620775251;809.821839195379;811.6185392865374;822.1490757066438;826.5371392020458;803.5741057239673;805.4040010392297;807.0315621254489;813.1421350475247;842.8482873082843;599.241958921964;600.771706751436;603.0381541441394;615.1725928625991;626.261012005833;10907.83638245427;10938.453077346101;11005;11011.779764404748;11021.504032318484;9502.952485237598;9716.75708107296;9815.852762208573;9872.950635246849;10062.04410581001;9990.200783937267;10065.094141527225;10174.796504069951;10286.022827831344;10374.118199953013;3285.195127193853;3316.043534314742;3320.468725004012;3326.501024846268;3328.4341661917533;36527.08682282938;37187.628123718685;37253.62746372502;37285.81357093197;39818.20363592712;8918.777030574158;9252.907470925205;9342.439453632804;9440.197583205505;9454;15628.531144065697;15695.921520392325;15701.293441795147;15707;15719.68560628781;6166.136740856284;6166.4758495527485;6589.53873228879;6620.3710647488415;6622.337766223339;3610.7291953103095;3670.8164591770305;3670.8164591770305;3685.4471829225295;3702.648248416396;2758.2828464599347;2774.9722502775116;2779.749822515943;2793.678726946427;2796.7063458336584;480.30595789085135;484.4211167654619;486.3701506549028;487.23747335419955;499.85254349966846;433.3369943985707;433.3975773674532;451.905099929012;452.37346275408794;459.7861994172659;7113.75101871432;7134.054156542036;7264.128304603481;7347.70609175627;7376;509.96175286853634;539.398570593785;557.2226743692527;559.2366419836975;572.4933433911019;3318.2699806042633;3392.2537041850755;3407.3185362927516;3418.521407002972;3501.28223714138;45538;48677;49602.503974959785;49967.50032499701;50146;38062.42906356407;38264.61735382611;38327.42508862369;38403.03992400212;39038.60961390407;38231.808840956175;41214;42657.14685706331;44353;44859.77570112129;7276.272372762682;7488.737894173678;7503.137139229058;7742.651580678996;7849.01887264092;31583.684163158076;34158.65841341555;35001.64998349984;35444.46833297554;35948.14700015569;44016.11967760563;44018.119637607706;44257.778711106235;44494.332585010605;45422.77288613668;10145.492725363554;10437.634682786065;10596.046355828012;10650.8402373966;10951.34291942486;10960.890391095987;11114.22200445961;11322.490487927898;11347.20569560123;11526.88473115258;9686;10343.37939723619;10707;10830.079443247412;10894.727631809268;10984.231103822656;11016.449177541252;11272.210945233755;11485.942570287096;11488.54045838157;10655.786884262427;10745.355278683304;10768.946155269487;11067.83398249043;11126.888731112585;8908.55457227149;9450.905490945002;9497.527769245327;9585.021657118805;9629.374090684083;9119.726408207764;9204.585793639168;9264.629414823601;9327.720168394959;9350.111739384747 06:33:56 INFO - 2015-12-10 06:33:56,938 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:33:56 INFO - 2015-12-10 06:33:56,938 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:33:56 INFO - 2015-12-10 06:33:56,938 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,332 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: __startTimestamp1449758036927__endTimestamp 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4562.80 Median:4719.13 stddev:469.12 (9.9%) stddev-sans-first:445.59 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: Values: 2637.6 2647.3 2683.4 2695.5 2713.9 4454.8 4583.2 4595.6 4655.2 4707.2 4508.5 4568.1 4613.9 4712.4 4719.1 4264.7 4276.6 4363.1 4408.0 4451.1 4331.0 4349.6 4353.5 4410.4 4420.8 4107.9 4180.7 4241.9 4275.1 4298.3 4252.6 4294.5 4295.5 4333.4 4334.0 4108.8 4254.8 4283.3 4291.5 4300.3 4295.5 4309.1 4382.3 4386.8 4405.6 4956.4 4991.3 5022.6 5027.1 5030.8 4774.5 4894.7 5058.7 5064.8 5106.7 4543.0 4552.3 4557.7 4568.2 4581.0 4940.1 4981.3 4991.6 5050.5 5067.4 4824.4 4834.6 4858.8 4889.3 4903.3 4773.1 4893.3 4899.1 4968.2 5015.5 4761.2 4763.4 4895.4 4930.4 4946.4 4923.0 4967.4 4978.7 4982.3 5010.8 3975.5 4072.2 4143.9 4155.8 4210.3 3505.3 3569.9 3576.8 3597.7 3602.7 4301.7 4341.0 4341.7 4357.7 4377.1 4794.1 4867.3 4910.4 4986.0 4987.8 4295.2 4303.3 4321.1 4334.2 4340.0 4344.5 4357.9 4382.0 4386.6 4416.7 4609.7 4663.4 4733.1 4765.7 4778.2 4935.7 4950.2 4951.2 4956.7 5012.4 4743.0 4750.8 4762.3 4771.8 4801.1 4756.9 4825.1 4893.5 4900.6 4938.3 4909.1 4922.6 4923.5 4934.6 4960.8 4613.5 4732.6 4753.2 4768.7 4800.5 4752.3 4788.7 4821.4 4837.8 4869.7 4640.4 4647.5 4719.1 4734.5 4788.4 4670.2 4814.6 4867.0 4867.2 4879.4 4674.6 4721.1 4737.0 4743.6 4776.6 06:33:56 INFO - 2015-12-10 06:33:56,939 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,940 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40447.59 Median:34188.40 stddev:64258.24 (188.0%) stddev-sans-first:64368.75 06:33:56 INFO - 2015-12-10 06:33:56,940 DEBUG : BROWSER_OUTPUT: Values: 574.3 578.3 581.4 582.4 586.9 35373.8 36148.8 36151.0 36215.3 36376.6 40831.8 41475.8 41551.2 41596.0 41607.0 7879.0 8029.4 8054.7 8072.1 8075.6 7948.6 7984.3 7996.6 8006.3 8029.2 8027.4 8070.4 8090.1 8095.9 8102.9 8021.7 8089.5 8114.4 8122.0 8139.6 7877.8 7929.3 7956.1 7961.7 7986.2 37317.4 37752.8 37780.4 37790.1 37816.2 2659.2 2789.5 2800.0 3341.4 3364.7 28217.2 28280.9 28622.7 28750.6 28997.3 3379.4 3433.3 3444.9 3535.5 3576.3 212275.0 212664.0 212728.0 212914.0 213432.0 52957.0 54168.5 56940.0 57198.7 58065.7 55807.7 55871.7 55934.2 56069.4 56528.0 12093.5 12162.8 12193.3 12196.1 12276.2 9730.8 9739.9 9752.1 9759.4 9778.5 19048.1 19345.7 19424.0 19431.9 19476.4 7108.1 7255.8 7285.8 7327.6 7395.3 777.5 806.2 856.2 868.9 1005.9 26060.7 26121.3 26604.0 26798.7 26956.3 903.3 949.6 950.4 956.1 1048.1 13635.4 14017.9 14219.0 14281.9 14284.2 263685.0 269231.0 269324.0 269718.0 269938.0 45323.3 45704.0 45884.0 45908.5 45951.5 1137.3 1153.0 1156.7 1159.3 1167.0 25093.2 25117.2 25473.4 25516.4 25728.4 40717.6 40794.6 41091.4 41175.0 41458.2 251773.0 253868.0 255971.0 256319.0 256557.0 28213.7 28922.6 28945.4 28979.7 29586.0 33138.7 33875.8 34109.5 34174.7 35949.8 31471.5 32290.8 32397.8 32509.8 32701.7 32149.4 32337.0 32365.2 32407.0 32656.3 32170.2 32556.0 33749.5 34098.5 34202.1 25448.6 28054.9 28836.4 29265.9 29399.7 22685.4 22953.1 23657.2 23895.8 24337.4 06:33:56 INFO - 2015-12-10 06:33:56,940 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,940 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26721.72 Median:45979.89 stddev:83473.16 (181.5%) stddev-sans-first:83683.80 06:33:56 INFO - 2015-12-10 06:33:56,940 DEBUG : BROWSER_OUTPUT: Values: 331.0 343.4 344.5 346.4 346.5 14894.2 15230.8 15920.7 16595.1 17458.7 16063.0 16159.8 16184.8 16521.3 16566.2 4664.0 4751.0 4789.9 4796.1 4798.7 4742.7 4755.6 4757.3 4765.0 4774.9 4702.8 4902.6 4979.6 5016.8 5079.9 4743.2 4911.1 4932.0 4933.7 4948.0 5077.2 5166.9 5168.8 5174.3 5175.7 11623.9 11795.9 16266.4 18734.2 18836.3 1728.4 1764.6 1818.6 1841.2 1857.4 8950.5 9052.1 9079.6 9103.9 9186.8 1726.7 1728.2 1752.6 1794.7 1799.7 53671.5 56382.0 56667.7 56740.4 58267.7 9399.4 9723.4 9887.0 9897.8 9955.4 12502.7 12522.6 12599.0 12629.1 12724.7 6707.1 6788.5 6838.9 6921.3 6945.3 6344.5 6364.6 6396.6 6416.7 6437.9 4168.8 4170.6 4174.0 4195.7 4203.5 1674.9 1730.8 1762.1 1783.2 1795.6 784.3 818.6 822.0 828.5 924.8 10700.6 15277.5 15319.6 15465.6 16025.8 389.3 401.6 401.9 405.5 415.4 3951.7 5311.4 5351.2 5376.0 5382.0 501101.0 506990.0 512919.0 514551.0 516126.0 69931.3 74184.6 74881.5 76120.6 76326.0 444.1 446.9 452.8 455.3 455.8 9255.5 9324.0 9396.7 9421.6 9529.3 31363.5 32218.5 33081.8 33599.2 33701.7 45031.3 45737.8 46222.0 48167.0 48296.0 8644.3 8862.6 9036.5 9054.6 9121.2 10583.8 14190.1 14775.3 14946.3 14996.0 12787.7 13526.5 13670.7 13843.6 13915.2 13299.5 13368.3 13463.5 13765.1 13963.2 13177.9 13246.1 13565.7 13769.7 14005.3 8930.2 9059.3 9216.8 9238.4 9241.8 9741.0 9855.9 11077.7 13073.5 13163.9 06:33:56 INFO - 2015-12-10 06:33:56,940 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,940 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4832.89 Median:6063.86 stddev:2511.37 (41.4%) stddev-sans-first:2505.92 06:33:56 INFO - 2015-12-10 06:33:56,941 DEBUG : BROWSER_OUTPUT: Values: 1499.4 1633.5 1713.2 1726.2 1754.1 5746.0 6101.5 6474.7 6695.4 6716.4 6299.2 6514.3 6560.0 6592.1 6595.5 2006.1 2043.1 2046.5 2047.3 2047.4 2038.8 2051.6 2068.9 2073.8 2079.2 2027.7 2035.0 2051.0 2052.5 2056.7 2027.5 2049.7 2050.5 2052.5 2053.3 2034.4 2063.8 2066.2 2076.5 2082.7 6868.6 6932.8 6943.4 6974.2 7010.0 3988.1 4064.4 4076.3 4089.7 4090.3 2618.5 2631.2 2633.8 2717.7 2721.1 827.0 832.5 841.4 853.4 867.4 9134.0 9149.6 9236.5 9257.5 9258.0 3738.7 3748.7 3784.6 3814.4 3816.7 7921.4 7940.8 7951.8 7961.8 8002.1 4114.2 4126.8 4134.8 4149.9 4151.9 3198.4 3286.5 3707.4 3732.9 3768.1 3344.6 3364.1 3369.3 3392.2 3432.9 1055.0 1070.1 1074.6 1074.8 1081.6 912.0 917.5 1136.7 1143.0 1152.3 6396.9 6403.2 6407.9 6444.7 6469.2 418.6 420.0 420.3 423.6 426.6 5174.0 5202.0 5237.7 5261.4 5286.5 8034.4 8411.4 8452.4 8469.0 8477.0 8320.6 8348.5 8409.7 8443.2 8460.8 6238.4 6340.1 6347.7 6382.1 6410.2 6714.3 6763.4 6769.1 6777.6 6801.1 7519.3 7641.0 7673.2 7705.1 7836.2 7662.8 7828.1 7878.1 7884.1 7971.4 5124.7 5812.9 6224.6 6271.1 6274.9 6392.1 6405.8 6425.6 6450.7 6460.5 6146.4 6168.7 6269.1 6365.6 6443.5 6077.3 6108.5 6246.5 6334.5 6339.9 6255.9 6354.7 6364.5 6369.4 6406.7 5860.9 5886.1 5929.8 5937.1 5939.0 5868.2 5908.4 5981.6 6007.2 6050.4 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4733.89 Median:5406.76 stddev:1386.51 (25.6%) stddev-sans-first:1349.86 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: Values: 299.3 305.9 313.8 317.9 320.5 5357.1 5406.9 5451.6 5527.8 5603.3 5406.6 5452.3 5473.5 5484.0 5487.4 4086.1 4155.9 4191.4 4197.1 4198.5 4154.3 4165.5 4179.1 4188.9 4191.4 4146.7 4147.9 4149.9 4150.6 4153.7 4147.0 4151.4 4152.9 4165.7 4165.8 3505.0 3632.8 3642.8 3643.2 3648.9 4994.5 5079.2 5127.8 5135.6 5168.8 4752.1 4757.8 4764.6 4768.1 4781.7 5646.4 5681.1 5696.5 5717.6 5728.9 3925.7 3933.1 3935.2 3941.7 3944.4 5850.6 5853.7 5909.4 5921.3 5988.4 4179.1 4185.9 4188.6 4189.0 4193.0 4242.8 4250.6 4254.7 4262.3 4263.8 4685.1 4822.2 4826.7 4826.9 4838.6 5579.6 5684.0 5702.6 5719.6 5721.0 1488.7 1513.6 1513.7 1517.0 1517.8 986.4 1034.9 1042.9 1045.4 1047.9 5004.4 5017.2 5020.1 5024.4 5025.5 5812.4 5874.6 5890.5 5890.9 5900.8 4990.9 5002.2 5002.3 5008.3 5010.1 3103.0 3134.3 3170.7 3171.5 3173.8 5595.2 5597.2 5597.3 5604.6 5619.4 6034.0 6042.9 6045.4 6059.3 6082.1 5583.9 5589.2 5599.1 5604.1 5612.4 5745.4 5929.6 5941.1 5942.7 5961.0 5842.6 5843.6 5849.3 5849.9 5875.2 5664.9 5672.0 5691.8 5695.5 5696.5 3979.8 4022.3 4066.4 4077.6 4084.8 5780.3 5889.4 5922.0 5939.7 5940.0 5654.6 5702.2 5708.3 5714.2 5739.8 5680.8 5695.6 5700.4 5707.6 5726.8 5416.2 5557.4 5605.6 5609.9 5614.7 5766.1 5767.5 5768.6 5775.9 5789.6 5624.3 5629.5 5632.7 5632.9 5633.9 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12182.25 Median:44137.95 stddev:13756.70 (31.2%) stddev-sans-first:13768.02 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: Values: 648.8 720.5 762.4 791.8 806.1 11532.3 11710.8 11739.8 11779.2 11816.9 10480.1 10812.6 11887.3 11956.8 11960.9 774.7 779.8 782.2 789.1 801.0 775.4 775.4 778.8 786.4 804.7 807.1 809.8 811.6 822.1 826.5 803.6 805.4 807.0 813.1 842.8 599.2 600.8 603.0 615.2 626.3 10907.8 10938.5 11005.0 11011.8 11021.5 9503.0 9716.8 9815.9 9873.0 10062.0 9990.2 10065.1 10174.8 10286.0 10374.1 3285.2 3316.0 3320.5 3326.5 3328.4 36527.1 37187.6 37253.6 37285.8 39818.2 8918.8 9252.9 9342.4 9440.2 9454.0 15628.5 15695.9 15701.3 15707.0 15719.7 6166.1 6166.5 6589.5 6620.4 6622.3 3610.7 3670.8 3670.8 3685.4 3702.6 2758.3 2775.0 2779.7 2793.7 2796.7 480.3 484.4 486.4 487.2 499.9 433.3 433.4 451.9 452.4 459.8 7113.8 7134.1 7264.1 7347.7 7376.0 510.0 539.4 557.2 559.2 572.5 3318.3 3392.3 3407.3 3418.5 3501.3 45538.0 48677.0 49602.5 49967.5 50146.0 38062.4 38264.6 38327.4 38403.0 39038.6 38231.8 41214.0 42657.1 44353.0 44859.8 7276.3 7488.7 7503.1 7742.7 7849.0 31583.7 34158.7 35001.6 35444.5 35948.1 44016.1 44018.1 44257.8 44494.3 45422.8 10145.5 10437.6 10596.0 10650.8 10951.3 10960.9 11114.2 11322.5 11347.2 11526.9 9686.0 10343.4 10707.0 10830.1 10894.7 10984.2 11016.4 11272.2 11485.9 11488.5 10655.8 10745.4 10768.9 11067.8 11126.9 8908.6 9450.9 9497.5 9585.0 9629.4 9119.7 9204.6 9264.6 9327.7 9350.1 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:33:56 INFO - 2015-12-10 06:33:56,942 DEBUG : BROWSER_OUTPUT: 06:33:57 INFO - 2015-12-10 06:33:57,631 INFO : Browser exited with error code: 0 06:33:57 INFO - 2015-12-10 06:33:57,650 INFO : Completed test dromaeo_css (00:18:34) 06:33:57 INFO - 2015-12-10 06:33:57,651 INFO : Starting test kraken 06:33:57 INFO - 2015-12-10 06:33:57,651 DEBUG : operating with platform_type : linux_ 06:33:57 INFO - 2015-12-10 06:33:57,651 INFO : Initialising browser for kraken test... 06:33:57 INFO - 2015-12-10 06:33:57,657 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzv3HA_/profile http://localhost:35127/getInfo.html 06:34:02 INFO - 2015-12-10 06:34:02,325 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:34:02 INFO - 2015-12-10 06:34:02,326 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:34:02 INFO - 2015-12-10 06:34:02,326 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:34:02 INFO - 2015-12-10 06:34:02,326 DEBUG : BROWSER_OUTPUT: __metrics 06:34:02 INFO - 2015-12-10 06:34:02,442 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:34:03 INFO - 2015-12-10 06:34:03,344 INFO : Browser initialized. 06:34:03 INFO - 2015-12-10 06:34:03,345 INFO : Running cycle 1/1 for kraken test... 06:34:03 INFO - 2015-12-10 06:34:03,345 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzv3HA_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:34:15 INFO - 2015-12-10 06:34:15,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 143249408 06:34:15 INFO - 2015-12-10 06:34:15,405 DEBUG : BROWSER_OUTPUT: 06:34:18 INFO - 2015-12-10 06:34:18,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:18 INFO - 2015-12-10 06:34:18,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 144031744 06:34:18 INFO - 2015-12-10 06:34:18,623 DEBUG : BROWSER_OUTPUT: 06:34:21 INFO - 2015-12-10 06:34:21,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-dft) 06:34:21 INFO - 2015-12-10 06:34:21,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 144216064 06:34:21 INFO - 2015-12-10 06:34:21,947 DEBUG : BROWSER_OUTPUT: 06:34:24 INFO - 2015-12-10 06:34:24,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-fft) 06:34:25 INFO - 2015-12-10 06:34:25,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 139235328 06:34:25 INFO - 2015-12-10 06:34:25,432 DEBUG : BROWSER_OUTPUT: 06:34:27 INFO - 2015-12-10 06:34:27,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35127/tests/kraken/driver.html?testName=audio-oscillator) 06:34:28 INFO - 2015-12-10 06:34:28,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 139202560 06:34:28 INFO - 2015-12-10 06:34:28,124 DEBUG : BROWSER_OUTPUT: 06:34:30 INFO - 2015-12-10 06:34:30,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:30 INFO - 2015-12-10 06:34:30,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 140689408 06:34:30 INFO - 2015-12-10 06:34:30,987 DEBUG : BROWSER_OUTPUT: 06:34:34 INFO - 2015-12-10 06:34:34,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35127/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:34 INFO - 2015-12-10 06:34:34,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 139534336 06:34:34 INFO - 2015-12-10 06:34:34,654 DEBUG : BROWSER_OUTPUT: 06:34:38 INFO - 2015-12-10 06:34:38,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35127/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:38 INFO - 2015-12-10 06:34:38,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 137191424 06:34:38 INFO - 2015-12-10 06:34:38,719 DEBUG : BROWSER_OUTPUT: 06:34:41 INFO - 2015-12-10 06:34:41,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35127/tests/kraken/driver.html?testName=json-parse-financial) 06:34:42 INFO - 2015-12-10 06:34:42,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 138047488 06:34:42 INFO - 2015-12-10 06:34:42,206 DEBUG : BROWSER_OUTPUT: 06:34:44 INFO - 2015-12-10 06:34:44,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:44 INFO - 2015-12-10 06:34:44,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 140435456 06:34:44 INFO - 2015-12-10 06:34:44,593 DEBUG : BROWSER_OUTPUT: 06:34:46 INFO - 2015-12-10 06:34:46,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:47 INFO - 2015-12-10 06:34:47,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 06:34:47 INFO - 2015-12-10 06:34:47,106 DEBUG : BROWSER_OUTPUT: 06:34:49 INFO - 2015-12-10 06:34:49,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:49 INFO - 2015-12-10 06:34:49,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 140972032 06:34:49 INFO - 2015-12-10 06:34:49,906 DEBUG : BROWSER_OUTPUT: 06:34:52 INFO - 2015-12-10 06:34:52,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:53 INFO - 2015-12-10 06:34:53,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 141275136 06:34:53 INFO - 2015-12-10 06:34:53,117 DEBUG : BROWSER_OUTPUT: 06:34:55 INFO - 2015-12-10 06:34:55,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:56 INFO - 2015-12-10 06:34:56,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 141168640 06:34:56 INFO - 2015-12-10 06:34:56,331 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35127/tests/kraken/driver.html?testName=ai-astar) 06:34:58 INFO - 2015-12-10 06:34:58,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 06:34:58 INFO - 2015-12-10 06:34:58,377 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,378 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:34:58 INFO - 2015-12-10 06:34:58,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:34:58 INFO - 2015-12-10 06:34:58,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:34:58 INFO - 2015-12-10 06:34:58,379 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:34:58 INFO - 2015-12-10 06:34:58,379 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;110;116;112;114;123;113;114;112;113 06:34:58 INFO - 2015-12-10 06:34:58,379 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;132;158;164;135;157;153;138;170;131 06:34:58 INFO - 2015-12-10 06:34:58,380 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;163;162;163;166;170;164;165;164 06:34:58 INFO - 2015-12-10 06:34:58,380 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;80;141;73;81;72;74;91 06:34:58 INFO - 2015-12-10 06:34:58,380 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;95;95;96;137;100;97;133 06:34:58 INFO - 2015-12-10 06:34:58,380 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;113;110;110;110;111;110;110;111;110 06:34:58 INFO - 2015-12-10 06:34:58,380 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;150;149;148;147;148;147;147;148;147 06:34:58 INFO - 2015-12-10 06:34:58,380 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;97;96;95;96;96;96;96 06:34:58 INFO - 2015-12-10 06:34:58,381 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;82;73;76;74;74;78;75;79 06:34:58 INFO - 2015-12-10 06:34:58,381 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;70;69;69;68;68 06:34:58 INFO - 2015-12-10 06:34:58,381 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;85;83;85;87;85;94;102;93 06:34:58 INFO - 2015-12-10 06:34:58,381 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;131;127;123;125;131;130;132;133;131 06:34:58 INFO - 2015-12-10 06:34:58,381 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;138;149;144;162;138;142;151;136;146 06:34:58 INFO - 2015-12-10 06:34:58,381 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;70;70;75;70;72;73;72;71 06:34:58 INFO - 2015-12-10 06:34:58,381 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:34:58 INFO - 2015-12-10 06:34:58,382 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:34:58 INFO - 2015-12-10 06:34:58,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,821 06:34:58 INFO - 2015-12-10 06:34:58,382 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:34:58 INFO - 2015-12-10 06:34:58,382 DEBUG : BROWSER_OUTPUT: __startTimestamp1449758098377__endTimestamp 06:34:58 INFO - 2015-12-10 06:34:58,382 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.00 Median:113.50 stddev:3.53 (3.1%) stddev-sans-first:3.72 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 116.0 112.0 114.0 123.0 113.0 114.0 112.0 113.0 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.30 Median:156.00 stddev:14.11 (9.0%) stddev-sans-first:14.82 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: Values: 155.0 132.0 158.0 164.0 135.0 157.0 153.0 138.0 170.0 131.0 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,390 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.22 (1.4%) stddev-sans-first:2.35 06:34:58 INFO - 2015-12-10 06:34:58,391 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 163.0 162.0 163.0 166.0 170.0 164.0 165.0 164.0 06:34:58 INFO - 2015-12-10 06:34:58,391 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,391 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.10 Median:73.50 stddev:21.19 (28.8%) stddev-sans-first:22.16 06:34:58 INFO - 2015-12-10 06:34:58,391 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 80.0 141.0 73.0 81.0 72.0 74.0 91.0 06:34:58 INFO - 2015-12-10 06:34:58,391 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,391 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:95.00 stddev:18.25 (19.2%) stddev-sans-first:18.79 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 95.0 95.0 96.0 137.0 100.0 97.0 133.0 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 110.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: Values: 149.0 150.0 149.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 06:34:58 INFO - 2015-12-10 06:34:58,392 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.00 Median:75.50 stddev:2.83 (3.7%) stddev-sans-first:2.98 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 82.0 73.0 76.0 74.0 74.0 78.0 75.0 79.0 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 70.0 69.0 69.0 68.0 68.0 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,393 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:85.00 stddev:6.09 (7.2%) stddev-sans-first:6.34 06:34:58 INFO - 2015-12-10 06:34:58,394 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 85.0 83.0 85.0 87.0 85.0 94.0 102.0 93.0 06:34:58 INFO - 2015-12-10 06:34:58,394 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,394 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:131.00 stddev:3.25 (2.5%) stddev-sans-first:3.42 06:34:58 INFO - 2015-12-10 06:34:58,394 DEBUG : BROWSER_OUTPUT: Values: 128.0 131.0 127.0 123.0 125.0 131.0 130.0 132.0 133.0 131.0 06:34:58 INFO - 2015-12-10 06:34:58,394 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,394 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:145.00 stddev:8.32 (5.7%) stddev-sans-first:8.15 06:34:58 INFO - 2015-12-10 06:34:58,395 DEBUG : BROWSER_OUTPUT: Values: 135.0 138.0 149.0 144.0 162.0 138.0 142.0 151.0 136.0 146.0 06:34:58 INFO - 2015-12-10 06:34:58,395 DEBUG : BROWSER_OUTPUT: 06:34:58 INFO - 2015-12-10 06:34:58,395 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.65 (2.3%) stddev-sans-first:1.74 06:34:58 INFO - 2015-12-10 06:34:58,395 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 70.0 75.0 70.0 72.0 73.0 72.0 71.0 06:34:58 INFO - 2015-12-10 06:34:58,395 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:34:58 INFO - 2015-12-10 06:34:58,396 DEBUG : BROWSER_OUTPUT: 06:34:59 INFO - 2015-12-10 06:34:59,340 INFO : Browser exited with error code: 0 06:34:59 INFO - 2015-12-10 06:34:59,396 INFO : Completed test kraken (00:01:01) 06:34:59 INFO - 2015-12-10 06:34:59,396 INFO : Starting test v8_7 06:34:59 INFO - 2015-12-10 06:34:59,396 DEBUG : operating with platform_type : linux_ 06:34:59 INFO - 2015-12-10 06:34:59,396 INFO : Initialising browser for v8_7 test... 06:34:59 INFO - 2015-12-10 06:34:59,403 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNzn7F3/profile http://localhost:35127/getInfo.html 06:35:04 INFO - 2015-12-10 06:35:04,023 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:35:04 INFO - 2015-12-10 06:35:04,024 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:35:04 INFO - 2015-12-10 06:35:04,024 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:35:04 INFO - 2015-12-10 06:35:04,024 DEBUG : BROWSER_OUTPUT: __metrics 06:35:04 INFO - 2015-12-10 06:35:04,152 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:35:05 INFO - 2015-12-10 06:35:05,080 INFO : Browser initialized. 06:35:05 INFO - 2015-12-10 06:35:05,081 INFO : Running cycle 1/1 for v8_7 test... 06:35:05 INFO - 2015-12-10 06:35:05,081 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNzn7F3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:35:17 INFO - 2015-12-10 06:35:17,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 143101952 06:35:17 INFO - 2015-12-10 06:35:17,169 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35127/tests/v8_7/run.html (next: http://localhost:35127/tests/v8_7/run.html) 06:35:38 INFO - 2015-12-10 06:35:38,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 137650176 06:35:38 INFO - 2015-12-10 06:35:38,876 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,876 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:35:38 INFO - 2015-12-10 06:35:38,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:35:38 INFO - 2015-12-10 06:35:38,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:35:38 INFO - 2015-12-10 06:35:38,876 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:35:38 INFO - 2015-12-10 06:35:38,877 DEBUG : BROWSER_OUTPUT: |0;Richards;167.1402306535183 06:35:38 INFO - 2015-12-10 06:35:38,877 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.73551263001485 06:35:38 INFO - 2015-12-10 06:35:38,877 DEBUG : BROWSER_OUTPUT: |2;Encrypt;276.93159789531984 06:35:38 INFO - 2015-12-10 06:35:38,877 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 06:35:38 INFO - 2015-12-10 06:35:38,877 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1061.5711252653928 06:35:38 INFO - 2015-12-10 06:35:38,877 DEBUG : BROWSER_OUTPUT: |5;Earley;725.6894049346879 06:35:38 INFO - 2015-12-10 06:35:38,877 DEBUG : BROWSER_OUTPUT: |6;Boyer;12395.061728395061 06:35:38 INFO - 2015-12-10 06:35:38,878 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 06:35:38 INFO - 2015-12-10 06:35:38,878 DEBUG : BROWSER_OUTPUT: |8;Splay;593.4718100890208 06:35:38 INFO - 2015-12-10 06:35:38,878 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 06:35:38 INFO - 2015-12-10 06:35:38,878 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:35:38 INFO - 2015-12-10 06:35:38,878 DEBUG : BROWSER_OUTPUT: __startTimestamp1449758138875__endTimestamp 06:35:38 INFO - 2015-12-10 06:35:38,878 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,879 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:35:38 INFO - 2015-12-10 06:35:38,880 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:35:38 INFO - 2015-12-10 06:35:38,880 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,880 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,881 DEBUG : BROWSER_OUTPUT: Values: 167.1 06:35:38 INFO - 2015-12-10 06:35:38,881 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,881 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.74 Median:185.74 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,881 DEBUG : BROWSER_OUTPUT: Values: 185.7 06:35:38 INFO - 2015-12-10 06:35:38,881 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,881 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:276.93 Median:276.93 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: Values: 276.9 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: Values: 5175.3 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: Values: 1061.6 06:35:38 INFO - 2015-12-10 06:35:38,882 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,883 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:725.69 Median:725.69 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,883 DEBUG : BROWSER_OUTPUT: Values: 725.7 06:35:38 INFO - 2015-12-10 06:35:38,883 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,883 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,883 DEBUG : BROWSER_OUTPUT: Values: 12395.1 06:35:38 INFO - 2015-12-10 06:35:38,883 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,883 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,884 DEBUG : BROWSER_OUTPUT: Values: 27027.0 06:35:38 INFO - 2015-12-10 06:35:38,884 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,884 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.47 Median:593.47 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,884 DEBUG : BROWSER_OUTPUT: Values: 593.5 06:35:38 INFO - 2015-12-10 06:35:38,884 DEBUG : BROWSER_OUTPUT: 06:35:38 INFO - 2015-12-10 06:35:38,884 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 06:35:38 INFO - 2015-12-10 06:35:38,884 DEBUG : BROWSER_OUTPUT: Values: 4854.4 06:35:38 INFO - 2015-12-10 06:35:38,885 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:35:38 INFO - 2015-12-10 06:35:38,885 DEBUG : BROWSER_OUTPUT: 06:35:39 INFO - 2015-12-10 06:35:39,784 INFO : Browser exited with error code: 0 06:35:39 INFO - 2015-12-10 06:35:39,801 INFO : Completed test v8_7 (00:00:40) 06:35:39 INFO - 2015-12-10 06:35:39,910 INFO : Completed test suite (00:20:16) 06:35:39 INFO - 2015-12-10 06:35:39,910 DEBUG : Working with test: dromaeo_css 06:35:39 INFO - 2015-12-10 06:35:39,910 DEBUG : Generating results file: dromaeo_css 06:35:39 INFO - 2015-12-10 06:35:39,911 DEBUG : Working with test: kraken 06:35:39 INFO - 2015-12-10 06:35:39,911 DEBUG : Generating results file: kraken 06:35:39 INFO - 2015-12-10 06:35:39,911 INFO : javascript benchmark 06:35:39 INFO - 2015-12-10 06:35:39,912 DEBUG : Working with test: v8_7 06:35:39 INFO - 2015-12-10 06:35:39,912 DEBUG : Generating results file: v8_7 06:35:39 INFO - 2015-12-10 06:35:39,912 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:35:40 INFO - 2015-12-10 06:35:40,040 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 06:35:40 INFO - 2015-12-10 06:35:40,041 DEBUG : process_Request line: dromaeo_css 6155.86 graph.html#tests=[[72,132,43]] 06:35:40 INFO - 2015-12-10 06:35:40,041 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:35:40 INFO - 2015-12-10 06:35:40,149 DEBUG : process_Request line: kraken 1550.40 graph.html#tests=[[232,132,43]] 06:35:40 INFO - 2015-12-10 06:35:40,149 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:35:40 INFO - 2015-12-10 06:35:40,255 DEBUG : process_Request line: v8_7 21260.89 graph.html#tests=[[230,132,43]] 06:35:40 INFO - 2015-12-10 06:35:40,257 INFO : javascript benchmark 06:35:40 INFO - 2015-12-10 06:35:40,261 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2637.551616225242, 2647.285232987095, 2683.3828219509514, 2695.541757901158, 2713.9050133245332, 4454.844080457185, 4583.152116858383, 4595.586397224253, 4655.231886738684, 4707.24684050552, 4508.54914508549, 4568.109218702354, 4613.9077218455695, 4712.387389639351, 4719.056188762244, 4264.701470897038, 4276.636485898694, 4363.105563359503, 4408.030233348658, 4451.132029254297, 4331.0, 4349.565043495641, 4353.477582690081, 4410.448693913261, 4420.845270415536, 4107.938380924288, 4180.728252663597, 4241.851535196253, 4275.102228532012, 4298.333758267474, 4252.617264446184, 4294.5490723473895, 4295.52749197588, 4333.414988976511, 4334.046509767846, 4108.815103320358, 4254.829806807755, 4283.336082907154, 4291.54938731435, 4300.333448315516, 4295.52749197588, 4309.095090031066, 4382.320740285261, 4386.846460373871, 4405.5814697604, 4956.3804524434445, 4991.30121782947, 5022.573081288095, 5027.09512287788, 5030.8239211627415, 4774.474807771142, 4894.681845680055, 5058.721770302632, 5064.772085256135, 5106.693598384109, 4543.045960348364, 4552.339910712928, 4557.703749256288, 4568.223402021697, 4580.954190458119, 4940.086084074458, 4981.32752078472, 4991.600671946236, 5050.545450909436, 5067.391912970467, 4824.421069471686, 4834.589059929875, 4858.80564777412, 4889.315495830587, 4903.313536104948, 4773.069251495925, 4893.290472881412, 4899.093667671421, 4968.189042283382, 5015.498450155028, 4761.166795810788, 4763.428388593322, 4895.412550493892, 4930.383702037246, 4946.3817022872145, 4923.01539692063, 4967.428745694219, 4978.701277923264, 4982.327385802871, 5010.849674509771, 3975.4633124528395, 4072.165206132736, 4143.875683729493, 4155.750654960712, 4210.347396153601, 3505.298940211968, 3569.928601427957, 3576.803275819855, 3597.6762091411897, 3602.6757591816863, 4301.698881078294, 4341.001569639001, 4341.717788343811, 4357.673174511924, 4377.124575084996, 4794.065157294294, 4867.294242334912, 4910.361652985089, 4985.975070124626, 4987.775550100254, 4295.205387003414, 4303.268444364466, 4321.114171594815, 4334.176506463762, 4340.045190058182, 4344.522102568715, 4357.934630980474, 4381.978090109529, 4386.605205531518, 4416.6908316418185, 4609.6542759292515, 4663.370444989883, 4733.124371991193, 4765.69023013503, 4778.187708089633, 4935.662955616919, 4950.232713929347, 4951.158303088556, 4956.702597844141, 5012.373453318335, 4743.003969166376, 4750.809967601395, 4762.261849413347, 4771.785269662943, 4801.063792560417, 4756.928646070242, 4825.059113472839, 4893.461719210813, 4900.558949694545, 4938.259261110862, 4909.140900342497, 4922.606191504743, 4923.483034281492, 4934.605231581537, 4960.801567937242, 4613.515580864095, 4732.645051621211, 4753.239481682914, 4768.713877167381, 4800.543948324904, 4752.334673145831, 4788.664793464424, 4821.373221481185, 4837.830675926326, 4869.683470574401, 4640.419947506562, 4647.535246475325, 4719.126961512131, 4734.502877197982, 4788.353572267699, 4670.229412147093, 4814.566688998007, 4867.026594681007, 4867.221244600847, 4879.365682461257, 4674.579287864109, 4721.102990431807, 4736.976315118402, 4743.573078422958, 4776.5701086902345], "unit": "ms", "name": "dojo.html", "value": 4534.109168040035}, {"lowerIsBetter": false, "replicates": [574.3050908400835, 578.3291381996885, 581.4272941152966, 582.4408567774939, 586.9236999190105, 35373.82313088434, 36148.81925590368, 36151.0, 36215.275694486096, 36376.636233637655, 40831.79584102083, 41475.792621036926, 41551.16897662045, 41596.0, 41607.0, 7879.0, 8029.437939344249, 8054.718084867001, 8072.071711753165, 8075.555844428583, 7948.5628290444, 7984.281414672679, 7996.560189189592, 8006.279434850862, 8029.237222463857, 8027.438079334449, 8070.354371650254, 8090.110087890327, 8095.919040809605, 8102.906107675447, 8021.679132834709, 8089.514629122242, 8114.431989760719, 8121.999999999971, 8139.633716482773, 7877.842443151105, 7929.286364227247, 7956.124826269106, 7961.721339753139, 7986.161453047404, 37317.44023839645, 37752.81123594364, 37780.43329350062, 37790.05524861873, 37816.24367512662, 2659.2421159969317, 2789.497890379731, 2799.9860000699864, 3341.448660970937, 3364.6971772540346, 28217.153485395473, 28280.858595707097, 28622.713772862215, 28750.568741468895, 28997.275068123254, 3379.4423920053164, 3433.2790114076074, 3444.913877153066, 3535.505029295901, 3576.2847430513743, 212275.0, 212664.0, 212728.0, 212914.0, 213431.99999999846, 52957.0, 54168.45831541713, 56940.0, 57198.714006430535, 58065.70967145222, 55807.720961395746, 55871.72064139653, 55934.160987585215, 56069.43930560724, 56528.0, 12093.45579448927, 12162.817557736642, 12193.32936688473, 12196.085293603015, 12276.202046866925, 9730.75673108178, 9739.853902191473, 9752.122308992224, 9759.414435133773, 9778.511074446391, 19048.092753507663, 19345.709814352795, 19424.0, 19431.90284048599, 19476.4157075288, 7108.147022357351, 7255.782326530212, 7285.817854553678, 7327.59266940875, 7395.26047395267, 777.4596655324608, 806.2260230179094, 856.246503077288, 868.9304855611535, 1005.9044390782864, 26060.73939260621, 26121.346966325993, 26604.0, 26798.732012680015, 26956.32609184747, 903.3270213690843, 949.6391371279008, 950.3632566180676, 956.0917128727737, 1048.0672201740306, 13635.38640761168, 14017.948653851003, 14219.0, 14281.928590357189, 14284.214368209641, 263685.0, 269231.0, 269324.0, 269718.0, 269938.0, 45323.320150197775, 45704.0, 45884.0, 45908.54091459043, 45951.540484595396, 1137.3403426012892, 1152.9538818447336, 1156.7223866272034, 1159.3044173496003, 1166.9649910502699, 25093.247202583952, 25117.24648260555, 25473.363165921, 25516.362090947874, 25728.356791080372, 40717.59282407138, 40794.592054079076, 41091.383629244985, 41175.0, 41458.170836583704, 251773.0, 253868.0, 255971.0, 256319.0, 256557.0, 28213.717862821108, 28922.566161507173, 28945.421091577628, 28979.710202897702, 29586.0, 33138.66861331452, 33875.83062084674, 34109.488357674156, 34174.65825341715, 35949.82025089858, 31471.52792708157, 32290.83854580712, 32397.838010809795, 32509.837450812596, 32701.672983269862, 32149.35701286008, 32337.0, 32365.19087022843, 32407.0, 32656.34687306288, 32170.19574510656, 32556.046637201845, 33749.493757594144, 34098.48852267169, 34202.14494637654, 25448.618270726325, 28054.85972570124, 28836.423271534033, 29265.85367073151, 29399.70600294055, 22685.43286417853, 22953.081876724744, 23657.171998979953, 23895.761042390048, 24337.391565210302], "unit": "ms", "name": "ext.html", "value": 16665.260300181162}, {"lowerIsBetter": false, "replicates": [330.95201195826604, 343.4110500491657, 344.47467611891864, 346.40072674273523, 346.4543344232833, 14894.180820054893, 15230.847691523082, 15920.681586368266, 16595.087270200132, 17458.738118928228, 16063.03621782691, 16159.757603635926, 16184.838151618509, 16521.33914643413, 16566.17169141541, 4663.953360466386, 4751.026039661861, 4789.928151077719, 4796.08874313881, 4798.688085274463, 4742.715437073769, 4755.595774359166, 4757.286407038954, 4764.952350476486, 4774.880627984311, 4702.788374523155, 4902.607791376681, 4979.576735977446, 5016.849494515171, 5079.923801142986, 4743.193657078305, 4911.091448082117, 4932.0, 4933.7286449245275, 4948.035133149037, 5077.213031980049, 5166.922496162523, 5168.8449346519665, 5174.327337446146, 5175.663581867167, 11623.883761162364, 11795.882041179564, 16266.43067492644, 18734.1569629367, 18836.34072807445, 1728.3777839977597, 1764.5500397398582, 1818.6180902010594, 1841.162271166616, 1857.3870622694478, 8950.462972221687, 9052.140046695553, 9079.591418386188, 9103.863442048374, 9186.770330741718, 1726.6719323328653, 1728.1791149204153, 1752.623186015, 1794.6500432415685, 1799.7300404939233, 53671.46328536743, 56382.0, 56667.71666141643, 56740.43259567393, 58267.70866145642, 9399.389039712396, 9723.416595004323, 9887.0, 9897.80204395908, 9955.402675839472, 12502.687432814253, 12522.561710340095, 12599.0, 12629.052821038458, 12724.745505089846, 6707.094542236833, 6788.49086318528, 6838.897416538756, 6921.273266307066, 6945.340192681788, 6344.524160687967, 6364.6181229126405, 6396.584222025554, 6416.743330266737, 6437.871242575216, 4168.7707176105, 4170.623694180913, 4174.039970806671, 4195.706300558932, 4203.453551038346, 1674.8576371008357, 1730.8442240198442, 1762.118940529735, 1783.1975610975112, 1795.5870149865605, 784.3137254901961, 818.5907046476761, 822.0464261456682, 828.511178404732, 924.8289066522581, 10700.571977120828, 15277.465288714842, 15319.61700957485, 15465.613359666098, 16025.759613605805, 389.3089765665966, 401.6064257028129, 401.9376996565537, 405.450614417466, 415.43293404502634, 3951.723379363417, 5311.415744268127, 5351.1973204019705, 5376.0, 5382.0, 501101.0, 506990.0, 512919.0, 514551.0, 516126.0, 69931.30068699247, 74184.62907685427, 74881.5023699523, 76120.61939690266, 76326.0, 444.0563801920918, 446.8547721990301, 452.81887245101564, 455.26247479083435, 455.7516153696177, 9255.490947997925, 9324.0, 9396.718098457057, 9421.576029078846, 9529.285303602397, 31363.529547056354, 32218.516722249653, 33081.83459082786, 33599.16002099967, 33701.66298336985, 45031.32453013142, 45737.77131114323, 46222.0, 48167.0, 48296.0, 8644.265237454636, 8862.601182946653, 9036.548172591212, 9054.637814487347, 9121.224695900923, 10583.788324233627, 14190.148591084568, 14775.261236937895, 14946.252687365806, 14996.0, 12787.74424511486, 13526.458941642224, 13670.726585468434, 13843.584692459242, 13915.234662093682, 13299.468021279428, 13368.331583420984, 13463.528776492776, 13765.105268157538, 13963.232022238875, 13177.868221318047, 13246.139000964906, 13565.728685426038, 13769.655758606115, 14005.299735013412, 8930.240929521064, 9059.320550958837, 9216.815663686555, 9238.399504032217, 9241.768955775891, 9740.951295243478, 9855.901440985499, 11077.72305692332, 13073.542426015043, 13163.868361316647], "unit": "ms", "name": "jquery.html", "value": 7592.383190940725}, {"lowerIsBetter": false, "replicates": [1499.4152280610556, 1633.5344426838349, 1713.1691129802043, 1726.162811036647, 1754.0703427183582, 5745.971270143644, 6101.511879049676, 6474.741010359586, 6695.363940425664, 6716.4291035262, 6299.244090709121, 6514.250861150969, 6559.967200164005, 6592.1430214072225, 6595.472362211023, 2006.1173083843062, 2043.070402966654, 2046.4781480722395, 2047.2834507922257, 2047.4471892588992, 2038.8165065144135, 2051.6307064728344, 2068.9379318620468, 2073.792620737922, 2079.241077006889, 2027.7059826325249, 2035.0435295411207, 2050.9692354614695, 2052.4560991337307, 2056.681214411761, 2027.4931267183204, 2049.7437820272467, 2050.518128239855, 2052.5176583502866, 2053.3429302623017, 2034.3998520436508, 2063.7626672932656, 2066.2354928676486, 2076.5431605046865, 2082.6771850363216, 6868.62222577758, 6932.757353492654, 6943.375096241312, 6974.232834388214, 7010.0, 3988.102676897704, 4064.4309796628495, 4076.347784354519, 4089.734167279117, 4090.325096359097, 2618.4763047390406, 2631.223788982255, 2633.789296856247, 2717.714639962815, 2721.07483455626, 826.9793255168609, 832.4505826154709, 841.3605659698612, 853.3514528957975, 867.3884911137633, 9134.0, 9149.63401463934, 9236.491992940453, 9257.490838003907, 9258.027907069796, 3738.682212011955, 3748.6813620842536, 3784.6404591563755, 3814.3515602347666, 3816.656500914931, 7921.445498815027, 7940.801479962932, 7951.84096318082, 7961.800954976172, 8002.079760827463, 4114.218298523271, 4126.793660317032, 4134.834606615702, 4149.8962525937095, 4151.875443736692, 3198.4082944655315, 3286.4905939579403, 3707.3697471429923, 3732.869349572806, 3768.1144930941205, 3344.5652065231366, 3364.1421437533763, 3369.2924485858243, 3392.236746732015, 3432.9485057724155, 1054.99472502637, 1070.1224995503767, 1074.5755426606447, 1074.7742973975396, 1081.648464249122, 911.9863202051974, 917.4586993673764, 1136.6646839182295, 1142.971425714347, 1152.2740673375888, 6396.944504156855, 6403.199600049994, 6407.871842563216, 6444.677766111676, 6469.223693156851, 418.56260208082625, 419.9937000944988, 420.325377768683, 423.6166269526084, 426.5691651432076, 5174.0, 5201.973990130025, 5237.73811309433, 5261.447548007481, 5286.47135286476, 8034.357251419872, 8411.369147313975, 8452.366072544584, 8469.0, 8476.957615211884, 8320.583970801557, 8348.499090054616, 8409.705660301861, 8443.155684431631, 8460.830783384297, 6238.376162383816, 6340.1440805490665, 6347.68261586928, 6382.074599183093, 6410.166678331881, 6714.261431242462, 6763.391294783493, 6769.120014398097, 6777.559458635173, 6801.1158549388265, 7519.285667861544, 7641.044869391326, 7673.232676732282, 7705.075390953121, 7836.216378362118, 7662.846743064996, 7828.13890472059, 7878.054633444023, 7884.093329266978, 7971.362291016589, 5124.743762811919, 5812.883742325214, 6224.62652240867, 6271.122042913905, 6274.874502510015, 6392.137061496638, 6405.775797847053, 6425.5502114851515, 6450.741970321323, 6460.547761656639, 6146.354632763674, 6168.722407491584, 6269.122322874892, 6365.586236894587, 6443.548951573345, 6077.331493535796, 6108.51131909455, 6246.5002799775, 6334.524910631629, 6339.904901426575, 6255.874882502416, 6354.745810167541, 6364.522660800551, 6369.426751592379, 6406.711697973509, 5860.882782344244, 5886.087656413263, 5929.762809487572, 5937.079752638348, 5938.970305148447, 5868.2077919480325, 5908.409159084229, 5981.641101533922, 6007.189029481139, 6050.394960503914], "unit": "ms", "name": "mootools.html", "value": 3911.6981150873144}, {"lowerIsBetter": false, "replicates": [299.2533628596652, 305.85166194395714, 313.7850572357935, 317.92687681833183, 320.4968199926117, 5357.08929481988, 5406.8918621627545, 5451.6456430332, 5527.806526771564, 5603.299587551556, 5406.621536492447, 5452.291202143726, 5473.507384335409, 5484.0, 5487.396386397493, 4086.1419101988618, 4155.916881662365, 4191.434156388887, 4197.118605092935, 4198.496180458334, 4154.273002224613, 4165.479315085614, 4179.1432756284885, 4188.895277618053, 4191.392248124021, 4146.709730318879, 4147.875563733093, 4149.854755083573, 4150.58494150584, 4153.7300075494995, 4147.0, 4151.377293406013, 4152.854650087247, 4165.687573431975, 4165.75005499671, 3504.9649503504893, 3632.763870348419, 3642.7814331140216, 3643.198496330803, 3648.872289469882, 4994.450610432849, 5079.161938280179, 5127.846164615067, 5135.64050516464, 5168.8449346519665, 4752.097101550728, 4757.8105473631595, 4764.618830493587, 4768.141734487791, 4781.665283430127, 5646.378898321182, 5681.147827825818, 5696.458836410535, 5717.571182161313, 5728.914066289009, 3925.725199236055, 3933.0560665440375, 3935.1736135411597, 3941.743786653887, 3944.3886197639413, 5850.590458667895, 5853.678047707374, 5909.4090590941, 5921.259842519685, 5988.401159884021, 4179.059711564934, 4185.895352616209, 4188.581141885848, 4189.0, 4193.035601811601, 4242.830286788494, 4250.638695710837, 4254.702170848011, 4262.25410553152, 4263.786810659454, 4685.0629874025335, 4822.156122678587, 4826.6621336506105, 4826.927596086061, 4838.637102217348, 5579.553635709133, 5684.0, 5702.6293290935955, 5719.571032172604, 5721.0, 1488.6576087499936, 1513.583764464781, 1513.7199618070692, 1516.9987808046635, 1517.8254500732337, 986.40815510693, 1034.9081718786751, 1042.8997407734762, 1045.3518818332682, 1047.9423631700329, 5004.399472063303, 5017.1721665924715, 5020.071286811952, 5024.447310795809, 5025.47232540578, 5812.38969908162, 5874.559408044328, 5890.528757699374, 5890.8821823563285, 5900.76396944126, 4990.850274491771, 5002.199648056294, 5002.324221385804, 5008.273800299009, 5010.073136469692, 3102.953455698166, 3134.326119884236, 3170.651228364878, 3171.5242713593148, 3173.793703409271, 5595.244641973363, 5597.160425936142, 5597.328320601472, 5604.635698679573, 5619.381867994517, 6034.0, 6042.879142417127, 6045.395460454008, 6059.303180134253, 6082.057281121345, 5583.8883222336135, 5589.189567512688, 5599.132134519156, 5604.103343465026, 5612.35457922336, 5745.396733342939, 5929.584929054925, 5941.079132734433, 5942.732577033958, 5961.0, 5842.649441033552, 5843.561732869966, 5849.298084229919, 5849.853753656193, 5875.177475153397, 5664.886702265849, 5672.03575392176, 5691.8292451226525, 5695.544356451391, 5696.54427645779, 3979.8209080590864, 4022.316206244887, 4066.369712694537, 4077.612626800449, 4084.754914705008, 5780.306363236438, 5889.440503152194, 5922.0, 5939.732712027882, 5939.990201665813, 5654.6324488908085, 5702.201691763239, 5708.34354049273, 5714.171445140514, 5739.799107031234, 5680.829575112753, 5695.629784064023, 5700.401457846866, 5707.571932105192, 5726.828195154152, 5416.160495123262, 5557.360903495988, 5605.5515558756015, 5609.943900561106, 5614.719264036864, 5766.077427611562, 5767.480926716616, 5768.596198266081, 5775.9133612995, 5789.56578256624, 5624.29696287964, 5629.521490673339, 5632.718364081861, 5632.85917852057, 5633.8591535211945], "unit": "ms", "name": "prototype.html", "value": 4292.336538599431}, {"lowerIsBetter": false, "replicates": [648.7891435283534, 720.484853329869, 762.4015148108736, 791.8099656082541, 806.12535399092, 11532.308061516314, 11710.765784684301, 11739.765204695901, 11779.23434976727, 11816.877396647305, 10480.056794888458, 10812.567497300119, 11887.286762794238, 11956.82064769027, 11960.940195299012, 774.7443343696567, 779.8479296537178, 782.2451334462243, 789.0649580247397, 800.9959950200256, 775.3564541430599, 775.3564541430627, 778.7507997440821, 786.4062632712323, 804.6741069866713, 807.11620775251, 809.821839195379, 811.6185392865374, 822.1490757066438, 826.5371392020458, 803.5741057239673, 805.4040010392297, 807.0315621254489, 813.1421350475247, 842.8482873082843, 599.241958921964, 600.771706751436, 603.0381541441394, 615.1725928625991, 626.261012005833, 10907.83638245427, 10938.453077346101, 11005.0, 11011.779764404748, 11021.504032318484, 9502.952485237598, 9716.75708107296, 9815.852762208573, 9872.950635246849, 10062.04410581001, 9990.200783937267, 10065.094141527225, 10174.796504069951, 10286.022827831344, 10374.118199953013, 3285.195127193853, 3316.043534314742, 3320.468725004012, 3326.501024846268, 3328.4341661917533, 36527.08682282938, 37187.628123718685, 37253.62746372502, 37285.81357093197, 39818.20363592712, 8918.777030574158, 9252.907470925205, 9342.439453632804, 9440.197583205505, 9454.0, 15628.531144065697, 15695.921520392325, 15701.293441795147, 15707.0, 15719.68560628781, 6166.136740856284, 6166.4758495527485, 6589.53873228879, 6620.3710647488415, 6622.337766223339, 3610.7291953103095, 3670.8164591770305, 3670.8164591770305, 3685.4471829225295, 3702.648248416396, 2758.2828464599347, 2774.9722502775116, 2779.749822515943, 2793.678726946427, 2796.7063458336584, 480.30595789085135, 484.4211167654619, 486.3701506549028, 487.23747335419955, 499.85254349966846, 433.3369943985707, 433.3975773674532, 451.905099929012, 452.37346275408794, 459.7861994172659, 7113.75101871432, 7134.054156542036, 7264.128304603481, 7347.70609175627, 7376.0, 509.96175286853634, 539.398570593785, 557.2226743692527, 559.2366419836975, 572.4933433911019, 3318.2699806042633, 3392.2537041850755, 3407.3185362927516, 3418.521407002972, 3501.28223714138, 45538.0, 48677.0, 49602.503974959785, 49967.50032499701, 50146.0, 38062.42906356407, 38264.61735382611, 38327.42508862369, 38403.03992400212, 39038.60961390407, 38231.808840956175, 41214.0, 42657.14685706331, 44353.0, 44859.77570112129, 7276.272372762682, 7488.737894173678, 7503.137139229058, 7742.651580678996, 7849.01887264092, 31583.684163158076, 34158.65841341555, 35001.64998349984, 35444.46833297554, 35948.14700015569, 44016.11967760563, 44018.119637607706, 44257.778711106235, 44494.332585010605, 45422.77288613668, 10145.492725363554, 10437.634682786065, 10596.046355828012, 10650.8402373966, 10951.34291942486, 10960.890391095987, 11114.22200445961, 11322.490487927898, 11347.20569560123, 11526.88473115258, 9686.0, 10343.37939723619, 10707.0, 10830.079443247412, 10894.727631809268, 10984.231103822656, 11016.449177541252, 11272.210945233755, 11485.942570287096, 11488.54045838157, 10655.786884262427, 10745.355278683304, 10768.946155269487, 11067.83398249043, 11126.888731112585, 8908.55457227149, 9450.905490945002, 9497.527769245327, 9585.021657118805, 9629.374090684083, 9119.726408207764, 9204.585793639168, 9264.629414823601, 9327.720168394959, 9350.111739384747], "unit": "ms", "name": "yui.html", "value": 5648.6433041552955}], "name": "dromaeo_css", "value": 6155.854933116506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 116.0, 112.0, 114.0, 123.0, 113.0, 114.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 158.0, 164.0, 135.0, 157.0, 153.0, 138.0, 170.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 162.0, 163.0, 166.0, 170.0, 164.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 80.0, 141.0, 73.0, 81.0, 72.0, 74.0, 91.0], "unit": "ms", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 95.0, 95.0, 96.0, 137.0, 100.0, 97.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [111.0, 113.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 149.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 82.0, 73.0, 76.0, 74.0, 74.0, 78.0, 75.0, 79.0], "unit": "ms", "name": "json-parse-financial", "value": 76.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 70.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 83.0, 85.0, 87.0, 85.0, 94.0, 102.0, 93.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [128.0, 131.0, 127.0, 123.0, 125.0, 131.0, 130.0, 132.0, 133.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.1}, {"lowerIsBetter": true, "replicates": [135.0, 138.0, 149.0, 144.0, 162.0, 138.0, 142.0, 151.0, 136.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 70.0, 75.0, 70.0, 72.0, 73.0, 72.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1550.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [185.73551263001485], "unit": "score", "name": "DeltaBlue", "value": 355.9793120000001}, {"lowerIsBetter": false, "replicates": [276.93159789531984], "unit": "score", "name": "Encrypt", "value": 961.1795910000001}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [725.6894049346879], "unit": "score", "name": "Earley", "value": 918.3860139999999}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [593.4718100890208], "unit": "score", "name": "Splay", "value": 137.31233500000002}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21260.893382266688}]} 06:35:40 INFO - RETURN: dromaeo_css: 6155.86 06:35:40 INFO - RETURN: kraken: 1550.40 06:35:40 INFO - RETURN: v8_7: 21260.89 06:35:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21260.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1550.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6155.86"}}} 06:35:40 INFO - Return code: 0 06:35:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:35:40 INFO - # TBPL SUCCESS # 06:35:40 INFO - Running post-action listener: _resource_record_post_action 06:35:40 INFO - Running post-run listener: _resource_record_post_run 06:35:41 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 12288; Write bytes: 507133952; Read time: 256; Write time: 269228 06:35:41 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 231010304; Read time: 124; Write time: 148564 06:35:41 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 274771968; Read time: 132; Write time: 120592 06:35:41 INFO - Running post-run listener: _upload_blobber_files 06:35:41 INFO - Blob upload gear active. 06:35:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:35:41 INFO - Copying logs to upload dir... 06:35:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.373623 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 06:35:39.351996) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 06:35:39.355942) ========= 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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009990 build_url: 'https://queue.taskcluster.net/v1/task/TzADg9JQR8a-M-wAUDyrrw/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-12-10 06:35:39.408324) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:35:39.408719) ========= 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=5804b9f07a53938c557deee7000001c5-1449732815.12519-737415690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 06:35:39.458848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 06:35:39.459207) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 06:35:39.459592) ========= ========= Total master_lag: 0.38 =========