builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1448559577.68 results: success (0) buildid: 20151126075612 builduid: 3d51a1fbb8204edc80382d0578ecd39b revision: b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.684951) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.685405) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.685690) ========= 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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003118 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.761977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.762289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.772878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.773235) ========= 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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003303 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.820000) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.820304) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.820699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.821035) ========= 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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 09:39:38-- 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% 245M=0s 2015-11-26 09:39:38 (245 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.971670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:37.971978) ========= 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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012590 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:38.019149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:38.019495) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce --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 b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce --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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 09:39:38,267 truncating revision to first 12 chars 2015-11-26 09:39:38,267 Setting DEBUG logging. 2015-11-26 09:39:38,267 attempt 1/10 2015-11-26 09:39:38,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7d8d9b1e833?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 09:39:38,694 unpacking tar archive at: fx-team-b7d8d9b1e833/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:38.744943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:38.745271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:38.755170) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:38.755436) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 09:39:38.755798) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-11-26 09:39:38.756087) ========= /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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:39:39 INFO - MultiFileLogger online at 20151126 09:39:39 in /builds/slave/test 09:39:39 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 09:39:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:39 INFO - {'append_to_log': False, 09:39:39 INFO - 'base_work_dir': '/builds/slave/test', 09:39:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:39:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:39 INFO - 'branch': 'Fx-Team-Non-PGO', 09:39:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:39 INFO - 'config_files': ('talos/linux_config.py',), 09:39:39 INFO - 'default_actions': ('clobber', 09:39:39 INFO - 'read-buildbot-config', 09:39:39 INFO - 'download-and-extract', 09:39:39 INFO - 'populate-webroot', 09:39:39 INFO - 'create-virtualenv', 09:39:39 INFO - 'install', 09:39:39 INFO - 'run-tests'), 09:39:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:39 INFO - 'download_minidump_stackwalk': True, 09:39:39 INFO - 'download_symbols': 'ondemand', 09:39:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:39 INFO - 'installer_path': 'installer.exe', 09:39:39 INFO - 'log_level': 'info', 09:39:39 INFO - 'log_name': 'talos', 09:39:39 INFO - 'log_to_console': True, 09:39:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:39:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:39:39 INFO - 'opt_config_files': (), 09:39:39 INFO - 'pip_index': False, 09:39:39 INFO - 'sps_profile': False, 09:39:39 INFO - 'sps_profile_interval': 0, 09:39:39 INFO - 'suite': 'dromaeojs-e10s', 09:39:39 INFO - 'system_bits': '64', 09:39:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:39 INFO - 'title': 'talos-linux64-ix-013', 09:39:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:39 INFO - 'use_talos_json': True, 09:39:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:39 INFO - 'work_dir': 'build'} 09:39:39 INFO - ##### 09:39:39 INFO - ##### Running clobber step. 09:39:39 INFO - ##### 09:39:39 INFO - Running pre-action listener: _resource_record_pre_action 09:39:39 INFO - Running main action method: clobber 09:39:39 INFO - rmtree: /builds/slave/test/build 09:39:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:40 INFO - Running post-action listener: _resource_record_post_action 09:39:40 INFO - ##### 09:39:40 INFO - ##### Running read-buildbot-config step. 09:39:40 INFO - ##### 09:39:40 INFO - Running pre-action listener: _resource_record_pre_action 09:39:40 INFO - Running main action method: read_buildbot_config 09:39:40 INFO - Using buildbot properties: 09:39:40 INFO - { 09:39:40 INFO - "properties": { 09:39:40 INFO - "buildnumber": 737, 09:39:40 INFO - "product": "firefox", 09:39:40 INFO - "script_repo_revision": "production", 09:39:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:39:40 INFO - "repository": "", 09:39:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:39:40 INFO - "buildid": "20151126075612", 09:39:40 INFO - "slavename": "talos-linux64-ix-013", 09:39:40 INFO - "pgo_build": "False", 09:39:40 INFO - "basedir": "/builds/slave/test", 09:39:40 INFO - "project": "", 09:39:40 INFO - "platform": "ubuntu64_hw", 09:39:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:39:40 INFO - "slavebuilddir": "test", 09:39:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:39:40 INFO - "branch": "fx-team", 09:39:40 INFO - "repo_path": "integration/fx-team", 09:39:40 INFO - "stage_platform": "linux64", 09:39:40 INFO - "builduid": "3d51a1fbb8204edc80382d0578ecd39b", 09:39:40 INFO - "revision": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce" 09:39:40 INFO - }, 09:39:40 INFO - "sourcestamp": { 09:39:40 INFO - "repository": "", 09:39:40 INFO - "hasPatch": false, 09:39:40 INFO - "project": "", 09:39:40 INFO - "branch": "fx-team-linux64-talos", 09:39:40 INFO - "changes": [ 09:39:40 INFO - { 09:39:40 INFO - "category": null, 09:39:40 INFO - "files": [ 09:39:40 INFO - { 09:39:40 INFO - "url": null, 09:39:40 INFO - "name": "https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:39:40 INFO - } 09:39:40 INFO - ], 09:39:40 INFO - "repository": "", 09:39:40 INFO - "rev": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce", 09:39:40 INFO - "who": "cbook@mozilla.com", 09:39:40 INFO - "when": 1448558934, 09:39:40 INFO - "number": 6711821, 09:39:40 INFO - "comments": "Merge mozilla-central to fx-team", 09:39:40 INFO - "project": "", 09:39:40 INFO - "at": "Thu 26 Nov 2015 09:28:54", 09:39:40 INFO - "branch": "fx-team-linux64-talos", 09:39:40 INFO - "revlink": "", 09:39:40 INFO - "properties": [ 09:39:40 INFO - [ 09:39:40 INFO - "buildid", 09:39:40 INFO - "20151126075612", 09:39:40 INFO - "Change" 09:39:40 INFO - ], 09:39:40 INFO - [ 09:39:40 INFO - "builduid", 09:39:40 INFO - "3d51a1fbb8204edc80382d0578ecd39b", 09:39:40 INFO - "Change" 09:39:40 INFO - ], 09:39:40 INFO - [ 09:39:40 INFO - "pgo_build", 09:39:40 INFO - "False", 09:39:40 INFO - "Change" 09:39:40 INFO - ] 09:39:40 INFO - ], 09:39:40 INFO - "revision": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce" 09:39:40 INFO - } 09:39:40 INFO - ], 09:39:40 INFO - "revision": "b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce" 09:39:40 INFO - } 09:39:40 INFO - } 09:39:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:39:40 INFO - Running post-action listener: _resource_record_post_action 09:39:40 INFO - ##### 09:39:40 INFO - ##### Running download-and-extract step. 09:39:40 INFO - ##### 09:39:40 INFO - Running pre-action listener: _resource_record_pre_action 09:39:40 INFO - Running main action method: download_and_extract 09:39:40 INFO - mkdir: /builds/slave/test/build/tests 09:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:40 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json 09:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json 09:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:39:41 INFO - Downloaded 1302 bytes. 09:39:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:39:41 INFO - Using the following test package requirements: 09:39:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:39:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:39:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'jsshell-linux-x86_64.zip'], 09:39:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:39:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:39:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:39:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:39:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:39:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:39:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:39:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:39: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')]} 09:39:41 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:46 INFO - Downloaded 21515226 bytes. 09:39:46 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 09:39:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:39:46 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 09:39:47 INFO - Return code: 0 09:39:47 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 09:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:47 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:48 INFO - Downloaded 21515226 bytes. 09:39:48 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 09:39:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:39:48 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 09:39:49 INFO - Return code: 0 09:39:49 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')]} 09:39:49 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:39:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:39:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:39:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:51 INFO - Downloaded 11131728 bytes. 09:39:53 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 09:39:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:39:53 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 09:39:53 INFO - Return code: 0 09:39: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')]} 09:39:53 INFO - https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:39:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:39:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:39:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/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 09:39:54 INFO - Downloaded 56868570 bytes. 09:39:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:39:54 INFO - mkdir: /builds/slave/test/properties 09:39:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:54 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:54 INFO - Contents: 09:39:54 INFO - build_url:https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:39:54 INFO - Running post-action listener: _resource_record_post_action 09:39:54 INFO - Running post-action listener: set_extra_try_arguments 09:39:54 INFO - ##### 09:39:54 INFO - ##### Running populate-webroot step. 09:39:54 INFO - ##### 09:39:54 INFO - Running pre-action listener: _resource_record_pre_action 09:39:54 INFO - Running main action method: populate_webroot 09:39:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:39:54 INFO - '../fennec_ids.txt'], 09:39:54 INFO - 'tests': ['tcheck2']}, 09:39:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:54 INFO - '--tppagecycles', 09:39:54 INFO - '7'], 09:39:54 INFO - 'tests': ['tsvgm']}}, 09:39:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:39:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:39:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:39:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'tests': ['damp', 'tps']}, 09:39:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['damp', 'tps']}, 09:39:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:39:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:54 INFO - 'other': {'tests': ['a11yr', 09:39:54 INFO - 'ts_paint', 09:39:54 INFO - 'tpaint', 09:39:54 INFO - 'sessionrestore', 09:39:54 INFO - 'sessionrestore_no_auto_restore']}, 09:39:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['a11yr', 09:39:54 INFO - 'ts_paint', 09:39:54 INFO - 'tpaint', 09:39:54 INFO - 'sessionrestore', 09:39:54 INFO - 'sessionrestore_no_auto_restore']}, 09:39:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['a11yr', 09:39:54 INFO - 'ts_paint', 09:39:54 INFO - 'tpaint', 09:39:54 INFO - 'sessionrestore', 09:39:54 INFO - 'sessionrestore_no_auto_restore']}, 09:39:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['a11yr', 09:39:54 INFO - 'ts_paint', 09:39:54 INFO - 'tpaint', 09:39:54 INFO - 'sessionrestore', 09:39:54 INFO - 'sessionrestore_no_auto_restore']}, 09:39:54 INFO - 'other_l64': {'tests': ['a11yr', 09:39:54 INFO - 'ts_paint', 09:39:54 INFO - 'tpaint', 09:39:54 INFO - 'sessionrestore', 09:39:54 INFO - 'sessionrestore_no_auto_restore']}, 09:39:54 INFO - 'other_nol64': {'tests': ['a11yr', 09:39:54 INFO - 'ts_paint', 09:39:54 INFO - 'tpaint', 09:39:54 INFO - 'sessionrestore', 09:39:54 INFO - 'sessionrestore_no_auto_restore']}, 09:39:54 INFO - 'svgr': {'tests': ['tsvgx', 09:39:54 INFO - 'tsvgr_opacity', 09:39:54 INFO - 'tart', 09:39:54 INFO - 'tscrollx', 09:39:54 INFO - 'cart']}, 09:39:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['tsvgx', 09:39:54 INFO - 'tsvgr_opacity', 09:39:54 INFO - 'tart', 09:39:54 INFO - 'tscrollx', 09:39:54 INFO - 'cart']}, 09:39:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'tests': ['tp5o']}, 09:39:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'talos_options': ['--e10s'], 09:39:54 INFO - 'tests': ['tp5o']}, 09:39:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'talos_options': ['--xperf_path', 09:39:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:54 INFO - 'tests': ['tp5n']}, 09:39:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:54 INFO - 'talos_options': ['--e10s', 09:39:54 INFO - '--xperf_path', 09:39:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:54 INFO - 'tests': ['tp5n']}}, 09:39:54 INFO - 'talos.zip': {'path': '', 09:39:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:54 INFO - Running post-action listener: _resource_record_post_action 09:39:54 INFO - ##### 09:39:54 INFO - ##### Running create-virtualenv step. 09:39:54 INFO - ##### 09:39:54 INFO - Running pre-action listener: _resource_record_pre_action 09:39:54 INFO - Running main action method: create_virtualenv 09:39:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:54 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 09:39:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:54 INFO - Using real prefix '/usr' 09:39:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:00 INFO - Installing pip.................done. 09:40:00 INFO - Return code: 0 09:40:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40: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', 'pip>=1.5'] in /builds/slave/test/build 09:40: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 pip>=1.5 09:40:00 INFO - Using env: {'DISPLAY': ':0', 09:40:00 INFO - 'HOME': '/home/cltbld', 09:40:00 INFO - 'LANG': 'en_US.UTF-8', 09:40:00 INFO - 'LANGUAGE': 'en_US:en', 09:40:00 INFO - 'LOGNAME': 'cltbld', 09:40:00 INFO - 'MAIL': '/var/mail/cltbld', 09:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:00 INFO - 'MOZ_NO_REMOTE': '1', 09:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:00 INFO - 'NO_EM_RESTART': '1', 09:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:00 INFO - 'PWD': '/builds/slave/test', 09:40:00 INFO - 'SHELL': '/bin/bash', 09:40:00 INFO - 'SHLVL': '1', 09:40:00 INFO - 'TERM': 'linux', 09:40:00 INFO - 'TMOUT': '86400', 09:40:00 INFO - 'USER': 'cltbld', 09:40:00 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:00 INFO - '_': '/tools/buildbot/bin/python'} 09:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:00 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 09:40:00 INFO - Cleaning up... 09:40:00 INFO - Return code: 0 09:40:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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', '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 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40: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', 'psutil>=0.7.1'] in /builds/slave/test/build 09:40: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 psutil>=0.7.1 09:40:00 INFO - Using env: {'DISPLAY': ':0', 09:40:00 INFO - 'HOME': '/home/cltbld', 09:40:00 INFO - 'LANG': 'en_US.UTF-8', 09:40:00 INFO - 'LANGUAGE': 'en_US:en', 09:40:00 INFO - 'LOGNAME': 'cltbld', 09:40:00 INFO - 'MAIL': '/var/mail/cltbld', 09:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:00 INFO - 'MOZ_NO_REMOTE': '1', 09:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:00 INFO - 'NO_EM_RESTART': '1', 09:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:00 INFO - 'PWD': '/builds/slave/test', 09:40:00 INFO - 'SHELL': '/bin/bash', 09:40:00 INFO - 'SHLVL': '1', 09:40:00 INFO - 'TERM': 'linux', 09:40:00 INFO - 'TMOUT': '86400', 09:40:00 INFO - 'USER': 'cltbld', 09:40:00 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:00 INFO - '_': '/tools/buildbot/bin/python'} 09:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:00 INFO - Downloading/unpacking psutil>=0.7.1 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:40:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:02 INFO - Installing collected packages: psutil 09:40:02 INFO - Running setup.py install for psutil 09:40:02 INFO - building 'psutil._psutil_linux' extension 09:40:02 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 09:40:02 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 09:40:02 INFO - building 'psutil._psutil_posix' extension 09:40:02 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 09:40:02 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 09:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:02 INFO - Successfully installed psutil 09:40:02 INFO - Cleaning up... 09:40:03 INFO - Return code: 0 09:40:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:03 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 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40:03 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 09:40:03 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 09:40:03 INFO - Using env: {'DISPLAY': ':0', 09:40:03 INFO - 'HOME': '/home/cltbld', 09:40:03 INFO - 'LANG': 'en_US.UTF-8', 09:40:03 INFO - 'LANGUAGE': 'en_US:en', 09:40:03 INFO - 'LOGNAME': 'cltbld', 09:40:03 INFO - 'MAIL': '/var/mail/cltbld', 09:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:03 INFO - 'MOZ_NO_REMOTE': '1', 09:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:03 INFO - 'NO_EM_RESTART': '1', 09:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:03 INFO - 'PWD': '/builds/slave/test', 09:40:03 INFO - 'SHELL': '/bin/bash', 09:40:03 INFO - 'SHLVL': '1', 09:40:03 INFO - 'TERM': 'linux', 09:40:03 INFO - 'TMOUT': '86400', 09:40:03 INFO - 'USER': 'cltbld', 09:40:03 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:03 INFO - '_': '/tools/buildbot/bin/python'} 09:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:40:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:40:04 INFO - Installing collected packages: mozsystemmonitor 09:40:04 INFO - Running setup.py install for mozsystemmonitor 09:40:05 INFO - Successfully installed mozsystemmonitor 09:40:05 INFO - Cleaning up... 09:40:05 INFO - Return code: 0 09:40:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40:05 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 09:40:05 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 09:40:05 INFO - Using env: {'DISPLAY': ':0', 09:40:05 INFO - 'HOME': '/home/cltbld', 09:40:05 INFO - 'LANG': 'en_US.UTF-8', 09:40:05 INFO - 'LANGUAGE': 'en_US:en', 09:40:05 INFO - 'LOGNAME': 'cltbld', 09:40:05 INFO - 'MAIL': '/var/mail/cltbld', 09:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:05 INFO - 'MOZ_NO_REMOTE': '1', 09:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:05 INFO - 'NO_EM_RESTART': '1', 09:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:05 INFO - 'PWD': '/builds/slave/test', 09:40:05 INFO - 'SHELL': '/bin/bash', 09:40:05 INFO - 'SHLVL': '1', 09:40:05 INFO - 'TERM': 'linux', 09:40:05 INFO - 'TMOUT': '86400', 09:40:05 INFO - 'USER': 'cltbld', 09:40:05 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:05 INFO - '_': '/tools/buildbot/bin/python'} 09:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40: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 09:40:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:07 INFO - Downloading docopt-0.6.1.tar.gz 09:40:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:07 INFO - Running setup.py install for blobuploader 09:40:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:07 INFO - Running setup.py install for requests 09:40:08 INFO - Running setup.py install for docopt 09:40:08 INFO - Successfully installed blobuploader requests docopt 09:40:08 INFO - Cleaning up... 09:40:08 INFO - Return code: 0 09:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:08 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 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40:08 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 09:40:08 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 09:40:08 INFO - Using env: {'DISPLAY': ':0', 09:40:08 INFO - 'HOME': '/home/cltbld', 09:40:08 INFO - 'LANG': 'en_US.UTF-8', 09:40:08 INFO - 'LANGUAGE': 'en_US:en', 09:40:08 INFO - 'LOGNAME': 'cltbld', 09:40:08 INFO - 'MAIL': '/var/mail/cltbld', 09:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:08 INFO - 'MOZ_NO_REMOTE': '1', 09:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:08 INFO - 'NO_EM_RESTART': '1', 09:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:08 INFO - 'PWD': '/builds/slave/test', 09:40:08 INFO - 'SHELL': '/bin/bash', 09:40:08 INFO - 'SHLVL': '1', 09:40:08 INFO - 'TERM': 'linux', 09:40:08 INFO - 'TMOUT': '86400', 09:40:08 INFO - 'USER': 'cltbld', 09:40:08 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:08 INFO - '_': '/tools/buildbot/bin/python'} 09:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:08 INFO - Running setup.py (path:/tmp/pip-BnPT6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:08 INFO - Running setup.py (path:/tmp/pip-iLqjJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:08 INFO - Running setup.py (path:/tmp/pip-JrhlXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:08 INFO - Running setup.py (path:/tmp/pip-Z9GPO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:08 INFO - Running setup.py (path:/tmp/pip-vzMEwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:08 INFO - Running setup.py (path:/tmp/pip-Yegyei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:09 INFO - Running setup.py (path:/tmp/pip-dfI7tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:09 INFO - Running setup.py (path:/tmp/pip-EB33CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:09 INFO - Running setup.py (path:/tmp/pip-Llpe1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:09 INFO - Running setup.py (path:/tmp/pip-a3NT1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:09 INFO - Running setup.py (path:/tmp/pip-_vI67J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:09 INFO - Running setup.py (path:/tmp/pip-liflKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:09 INFO - Running setup.py (path:/tmp/pip-qgtLJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:09 INFO - Running setup.py (path:/tmp/pip-pjLEdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:09 INFO - Running setup.py (path:/tmp/pip-pXvCGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:09 INFO - Running setup.py (path:/tmp/pip-NaZE2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:09 INFO - Running setup.py (path:/tmp/pip-1kQiUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:09 INFO - Running setup.py install for manifestparser 09:40:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:09 INFO - Running setup.py install for mozcrash 09:40:10 INFO - Running setup.py install for mozdebug 09:40:10 INFO - Running setup.py install for mozdevice 09:40:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for mozfile 09:40:10 INFO - Running setup.py install for mozhttpd 09:40:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for mozinfo 09:40:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for mozInstall 09:40:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for mozleak 09:40:10 INFO - Running setup.py install for mozlog 09:40:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for moznetwork 09:40:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:10 INFO - Running setup.py install for mozprocess 09:40:11 INFO - Running setup.py install for mozprofile 09:40:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:11 INFO - Running setup.py install for mozrunner 09:40:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:11 INFO - Running setup.py install for mozscreenshot 09:40:11 INFO - Running setup.py install for moztest 09:40:11 INFO - Running setup.py install for mozversion 09:40:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:11 INFO - Cleaning up... 09:40:11 INFO - Return code: 0 09:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40:11 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 09:40:11 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 09:40:11 INFO - Using env: {'DISPLAY': ':0', 09:40:11 INFO - 'HOME': '/home/cltbld', 09:40:11 INFO - 'LANG': 'en_US.UTF-8', 09:40:11 INFO - 'LANGUAGE': 'en_US:en', 09:40:11 INFO - 'LOGNAME': 'cltbld', 09:40:11 INFO - 'MAIL': '/var/mail/cltbld', 09:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:11 INFO - 'MOZ_NO_REMOTE': '1', 09:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:11 INFO - 'NO_EM_RESTART': '1', 09:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:11 INFO - 'PWD': '/builds/slave/test', 09:40:11 INFO - 'SHELL': '/bin/bash', 09:40:11 INFO - 'SHLVL': '1', 09:40:11 INFO - 'TERM': 'linux', 09:40:11 INFO - 'TMOUT': '86400', 09:40:11 INFO - 'USER': 'cltbld', 09:40:11 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:11 INFO - '_': '/tools/buildbot/bin/python'} 09:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:11 INFO - Running setup.py (path:/tmp/pip-flTjWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:11 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)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:11 INFO - Running setup.py (path:/tmp/pip-1IhsFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:11 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)) 09:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:11 INFO - Running setup.py (path:/tmp/pip-L5xyyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:12 INFO - Running setup.py (path:/tmp/pip-0boKZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:12 INFO - Running setup.py (path:/tmp/pip-g9KAeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:12 INFO - Running setup.py (path:/tmp/pip-HyIOn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:12 INFO - Running setup.py (path:/tmp/pip-5f2KCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:12 INFO - Running setup.py (path:/tmp/pip-tYO5AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:12 INFO - Running setup.py (path:/tmp/pip-8cW6QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:12 INFO - Running setup.py (path:/tmp/pip-5ycTJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:12 INFO - Running setup.py (path:/tmp/pip-IGdZAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:12 INFO - Running setup.py (path:/tmp/pip-_MDYQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:12 INFO - Running setup.py (path:/tmp/pip-FTNZZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:12 INFO - Running setup.py (path:/tmp/pip-llHhAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:12 INFO - Running setup.py (path:/tmp/pip-qViDfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:12 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)) 09:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:12 INFO - Running setup.py (path:/tmp/pip-eIBsFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:13 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)) 09:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:13 INFO - Running setup.py (path:/tmp/pip-FJx2Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:13 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)) 09:40:13 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)) 09:40:13 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)) 09:40:13 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)) 09:40:13 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)) 09:40:13 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)) 09:40:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:14 INFO - Downloading blessings-1.5.1.tar.gz 09:40:14 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 09:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:14 INFO - Installing collected packages: blessings 09:40:14 INFO - Running setup.py install for blessings 09:40:14 INFO - Successfully installed blessings 09:40:14 INFO - Cleaning up... 09:40:15 INFO - Return code: 0 09:40:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:15 INFO - Reading from file tmpfile_stdout 09:40:15 INFO - Current package versions: 09:40:15 INFO - argparse == 1.2.1 09:40:15 INFO - blessings == 1.5.1 09:40:15 INFO - blobuploader == 1.2.4 09:40:15 INFO - docopt == 0.6.1 09:40:15 INFO - manifestparser == 1.1 09:40:15 INFO - mozInstall == 1.12 09:40:15 INFO - mozcrash == 0.16 09:40:15 INFO - mozdebug == 0.1 09:40:15 INFO - mozdevice == 0.47 09:40:15 INFO - mozfile == 1.2 09:40:15 INFO - mozhttpd == 0.7 09:40:15 INFO - mozinfo == 0.9 09:40:15 INFO - mozleak == 0.1 09:40:15 INFO - mozlog == 3.1 09:40:15 INFO - moznetwork == 0.27 09:40:15 INFO - mozprocess == 0.22 09:40:15 INFO - mozprofile == 0.27 09:40:15 INFO - mozrunner == 6.11 09:40:15 INFO - mozscreenshot == 0.1 09:40:15 INFO - mozsystemmonitor == 0.0 09:40:15 INFO - moztest == 0.7 09:40:15 INFO - mozversion == 1.4 09:40:15 INFO - psutil == 3.1.1 09:40:15 INFO - requests == 1.2.3 09:40:15 INFO - wsgiref == 0.1.2 09:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40:15 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 09:40:15 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 09:40:15 INFO - Using env: {'DISPLAY': ':0', 09:40:15 INFO - 'HOME': '/home/cltbld', 09:40:15 INFO - 'LANG': 'en_US.UTF-8', 09:40:15 INFO - 'LANGUAGE': 'en_US:en', 09:40:15 INFO - 'LOGNAME': 'cltbld', 09:40:15 INFO - 'MAIL': '/var/mail/cltbld', 09:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:15 INFO - 'MOZ_NO_REMOTE': '1', 09:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:15 INFO - 'NO_EM_RESTART': '1', 09:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:15 INFO - 'PWD': '/builds/slave/test', 09:40:15 INFO - 'SHELL': '/bin/bash', 09:40:15 INFO - 'SHLVL': '1', 09:40:15 INFO - 'TERM': 'linux', 09:40:15 INFO - 'TMOUT': '86400', 09:40:15 INFO - 'USER': 'cltbld', 09:40:15 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:15 INFO - '_': '/tools/buildbot/bin/python'} 09:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 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)) 09:40:15 INFO - Cleaning up... 09:40:15 INFO - Return code: 0 09:40:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:40:15 INFO - Using env: {'DISPLAY': ':0', 09:40:15 INFO - 'HOME': '/home/cltbld', 09:40:15 INFO - 'LANG': 'en_US.UTF-8', 09:40:15 INFO - 'LANGUAGE': 'en_US:en', 09:40:15 INFO - 'LOGNAME': 'cltbld', 09:40:15 INFO - 'MAIL': '/var/mail/cltbld', 09:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:15 INFO - 'MOZ_NO_REMOTE': '1', 09:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:15 INFO - 'NO_EM_RESTART': '1', 09:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:15 INFO - 'PWD': '/builds/slave/test', 09:40:15 INFO - 'SHELL': '/bin/bash', 09:40:15 INFO - 'SHLVL': '1', 09:40:15 INFO - 'TERM': 'linux', 09:40:15 INFO - 'TMOUT': '86400', 09:40:15 INFO - 'USER': 'cltbld', 09:40:15 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:15 INFO - '_': '/tools/buildbot/bin/python'} 09:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:15 INFO - Downloading/unpacking jsonschema 09:40:15 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 09:40:15 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 09:40:15 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 09:40:15 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 09:40:15 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 09:40:15 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 09:40:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:17 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 09:40:17 INFO - Downloading/unpacking functools32 (from jsonschema) 09:40:17 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 09:40:17 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 09:40:17 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 09:40:17 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 09:40:17 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 09:40:17 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 09:40:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:17 INFO - warning: no files found matching '*.txt' 09:40:17 INFO - no previously-included directories found matching 'build' 09:40:17 INFO - no previously-included directories found matching 'dist' 09:40:17 INFO - no previously-included directories found matching '.git*' 09:40:17 INFO - Installing collected packages: jsonschema, functools32 09:40:17 INFO - Running setup.py install for functools32 09:40:17 INFO - warning: no files found matching '*.txt' 09:40:17 INFO - no previously-included directories found matching 'build' 09:40:17 INFO - no previously-included directories found matching 'dist' 09:40:17 INFO - no previously-included directories found matching '.git*' 09:40:17 INFO - Successfully installed jsonschema functools32 09:40:17 INFO - Cleaning up... 09:40:17 INFO - Return code: 0 09:40:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72811c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b8240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, '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': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', '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 09:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:40:17 INFO - Using env: {'DISPLAY': ':0', 09:40:17 INFO - 'HOME': '/home/cltbld', 09:40:17 INFO - 'LANG': 'en_US.UTF-8', 09:40:17 INFO - 'LANGUAGE': 'en_US:en', 09:40:17 INFO - 'LOGNAME': 'cltbld', 09:40:17 INFO - 'MAIL': '/var/mail/cltbld', 09:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:17 INFO - 'MOZ_NO_REMOTE': '1', 09:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:17 INFO - 'NO_EM_RESTART': '1', 09:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:17 INFO - 'PWD': '/builds/slave/test', 09:40:17 INFO - 'SHELL': '/bin/bash', 09:40:17 INFO - 'SHLVL': '1', 09:40:17 INFO - 'TERM': 'linux', 09:40:17 INFO - 'TMOUT': '86400', 09:40:17 INFO - 'USER': 'cltbld', 09:40:17 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:17 INFO - '_': '/tools/buildbot/bin/python'} 09:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:18 INFO - Downloading/unpacking flake8 09:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:40:19 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 09:40:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:40:19 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 09:40:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:20 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 09:40:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:40:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:40:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:40:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:40:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:40:20 INFO - no previously-included directories found matching 'docs/_build' 09:40:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:40:20 INFO - Running setup.py install for pep8 09:40:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:40:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:40:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:40:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:40:20 INFO - no previously-included directories found matching 'docs/_build' 09:40:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:40:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:40:20 INFO - Cleaning up... 09:40:20 INFO - Return code: 0 09:40:20 INFO - Running post-action listener: _resource_record_post_action 09:40:20 INFO - Running post-action listener: _start_resource_monitoring 09:40:20 INFO - Starting resource monitoring. 09:40:20 INFO - ##### 09:40:20 INFO - ##### Running install step. 09:40:20 INFO - ##### 09:40:20 INFO - Running pre-action listener: _resource_record_pre_action 09:40:20 INFO - Running main action method: install 09:40:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:20 INFO - Reading from file tmpfile_stdout 09:40:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:20 INFO - Reading from file tmpfile_stdout 09:40:20 INFO - Output received: 09:40:20 INFO - Usage: mozinstall [options] installer 09:40:20 INFO - Options: 09:40:20 INFO - -h, --help show this help message and exit 09:40:20 INFO - -d DEST, --destination=DEST 09:40:20 INFO - Directory to install application into. [default: 09:40:20 INFO - "/builds/slave/test"] 09:40:20 INFO - --app=APP Application being installed. [default: firefox] 09:40:20 INFO - mkdir: /builds/slave/test/build/application 09:40:20 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'] 09:40:20 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 09:40:40 INFO - Reading from file tmpfile_stdout 09:40:40 INFO - Output received: 09:40:40 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:40 INFO - Running post-action listener: _resource_record_post_action 09:40:40 INFO - ##### 09:40:40 INFO - ##### Running run-tests step. 09:40:40 INFO - ##### 09:40:40 INFO - Running pre-action listener: _resource_record_pre_action 09:40:40 INFO - Running main action method: run_tests 09:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:40 INFO - Python 2.7.3 09:40:40 INFO - Return code: 0 09:40:40 INFO - grabbing minidump binary from tooltool 09:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:40 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 0x15470b0>, '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 0x1547fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1548440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:40 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 09:40:40 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 09:40:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:40 INFO - Return code: 0 09:40:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:40:41 INFO - Return code: 0 09:40:41 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/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] in /builds/slave/test/build 09:40:41 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/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost 09:40:41 INFO - Using env: {'DISPLAY': ':0', 09:40:41 INFO - 'HOME': '/home/cltbld', 09:40:41 INFO - 'LANG': 'en_US.UTF-8', 09:40:41 INFO - 'LANGUAGE': 'en_US:en', 09:40:41 INFO - 'LOGNAME': 'cltbld', 09:40:41 INFO - 'MAIL': '/var/mail/cltbld', 09:40:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:41 INFO - 'MOZ_NO_REMOTE': '1', 09:40:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:41 INFO - 'NO_EM_RESTART': '1', 09:40:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:41 INFO - 'PWD': '/builds/slave/test', 09:40:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:41 INFO - 'SHELL': '/bin/bash', 09:40:41 INFO - 'SHLVL': '1', 09:40:41 INFO - 'TERM': 'linux', 09:40:41 INFO - 'TMOUT': '86400', 09:40:41 INFO - 'USER': 'cltbld', 09:40:41 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416', 09:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:41 INFO - '_': '/tools/buildbot/bin/python'} 09:40:41 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/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] with output_timeout 3600 09:40:41 INFO - mozversion INFO | application_buildid: 20151126075612 09:40:41 INFO - mozversion INFO | application_changeset: b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce 09:40:41 INFO - mozversion INFO | application_display_name: Nightly 09:40:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:41 INFO - mozversion INFO | application_name: Firefox 09:40:41 INFO - mozversion INFO | application_remotingname: firefox 09:40:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:40:41 INFO - mozversion INFO | application_vendor: Mozilla 09:40:41 INFO - mozversion INFO | application_version: 45.0a1 09:40:41 INFO - mozversion INFO | platform_buildid: 20151126075612 09:40:41 INFO - mozversion INFO | platform_changeset: b7d8d9b1e8334cbfe01793f8dcc6cd36a3015fce 09:40:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:40:41 INFO - mozversion INFO | platform_version: 45.0a1 09:40:41 INFO - 2015-11-26 09:40:41,210 DEBUG : using testdate: 1448559641 09:40:41 INFO - 2015-11-26 09:40:41,210 DEBUG : actual date: 1448559641 09:40:41 INFO - 2015-11-26 09:40:41,261 INFO : starting webserver on 'localhost:42860' 09:40:41 INFO - 2015-11-26 09:40:41,262 INFO : Starting test suite talos-linux64-ix-013.e 09:40:41 INFO - 2015-11-26 09:40:41,262 INFO : Starting test dromaeo_css 09:40:41 INFO - 2015-11-26 09:40:41,262 DEBUG : operating with platform_type : linux_ 09:40:41 INFO - 2015-11-26 09:40:41,262 INFO : Initialising browser for dromaeo_css test... 09:40:41 INFO - 2015-11-26 09:40:41,269 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzR6pg/profile http://localhost:42860/getInfo.html 09:41:44 INFO - 2015-11-26 09:41:44,187 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:41:44 INFO - 2015-11-26 09:41:44,187 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:41:44 INFO - 2015-11-26 09:41:44,187 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:41:44 INFO - 2015-11-26 09:41:44,187 DEBUG : BROWSER_OUTPUT: __metrics 09:41:50 INFO - 2015-11-26 09:41:50,145 INFO : Browser initialized. 09:41:50 INFO - 2015-11-26 09:41:50,145 INFO : Running cycle 1/1 for dromaeo_css test... 09:41:50 INFO - 2015-11-26 09:41:50,146 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzR6pg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:42:02 INFO - 2015-11-26 09:42:02,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 09:42:02 INFO - 2015-11-26 09:42:02,058 DEBUG : BROWSER_OUTPUT: 09:42:51 INFO - 2015-11-26 09:42:51,686 DEBUG : BROWSER_OUTPUT: 1448559771682 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] 09:45:03 INFO - 2015-11-26 09:45:03,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42860/tests/dromaeo/cssquery-ext.html) 09:45:04 INFO - 2015-11-26 09:45:04,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 149852160 09:45:04 INFO - 2015-11-26 09:45:04,910 DEBUG : BROWSER_OUTPUT: 09:48:06 INFO - 2015-11-26 09:48:06,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/dromaeo/cssquery-ext.html (next: http://localhost:42860/tests/dromaeo/cssquery-jquery.html) 09:48:07 INFO - 2015-11-26 09:48:07,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 141783040 09:48:07 INFO - 2015-11-26 09:48:07,500 DEBUG : BROWSER_OUTPUT: 09:51:09 INFO - 2015-11-26 09:51:09,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42860/tests/dromaeo/cssquery-mootools.html) 09:51:09 INFO - 2015-11-26 09:51:09,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 142536704 09:51:09 INFO - 2015-11-26 09:51:09,856 DEBUG : BROWSER_OUTPUT: 09:54:11 INFO - 2015-11-26 09:54:11,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42860/tests/dromaeo/cssquery-prototype.html) 09:54:12 INFO - 2015-11-26 09:54:12,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 141737984 09:54:12 INFO - 2015-11-26 09:54:12,172 DEBUG : BROWSER_OUTPUT: 09:57:14 INFO - 2015-11-26 09:57:14,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42860/tests/dromaeo/cssquery-yui.html) 09:57:15 INFO - 2015-11-26 09:57:15,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 142901248 09:57:15 INFO - 2015-11-26 09:57:15,405 DEBUG : BROWSER_OUTPUT: 10:00:17 INFO - 2015-11-26 10:00:17,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/dromaeo/cssquery-yui.html (next: http://localhost:42860/tests/dromaeo/cssquery-dojo.html) 10:00:18 INFO - 2015-11-26 10:00:18,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 145268736 10:00:18 INFO - 2015-11-26 10:00:18,182 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,182 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:00:18 INFO - 2015-11-26 10:00:18,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:00:18 INFO - 2015-11-26 10:00:18,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:00:18 INFO - 2015-11-26 10:00:18,182 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:00:18 INFO - 2015-11-26 10:00:18,182 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2700.378912850045;2745.1352823860493;2779.3190668286275;2789.637347144872;2796.80422370434;4661.394018777562;4723.267893476516;4799.208130658446;4805.879853003672;4839.588634966028;4803.759812009403;4842.080004799086;4862.124817532843;4957.033378491195;4963.55328020479;4381.5837495438045;4486.2597671384265;4515.774211289438;4518.638508919278;4550.135474259897;4346.717463364871;4448.866534003985;4479.10417916418;4514.932276015862;4568.314752787075;4382.846600369004;4447.844325448594;4470.888227794315;4483.820647174141;4506.909861802778;4458.665600080007;4498.415206023229;4504.279315309567;4522.525134860825;4551.180787458256;4296.978515107405;4387.407699960497;4453.042595841909;4472.664550158718;4479.619232365253;4703.482616912137;4705.952940470585;4749.833755818564;4753.928691069636;4800.159972004885;5173.405058418255;5174.197999310113;5182.144946083891;5190.455002224788;5254.605904557174;5012.27322038306;5205.115130427836;5206.323177986837;5214.113600687892;5228.398734145584;4750.07373562159;4808.374911261549;4832.275158726149;4835.734034628094;4876.975835074603;5376.946230537723;5423.322084739408;5430.0768869292315;5432.29380180574;5438.320209973754;5150.510701483353;5175.990681817009;5205.635605507654;5205.895882082337;5255.211718242294;5011.448740638527;5162.5611822994715;5220.582353411718;5290.65610735301;5357.035733567917;5222;5223;5234.869128271824;5243.764030618631;5263.34208223972;4939.2838038484215;5141.845744627667;5170;5178.352705911761;5215.400228973641;4195.244855925902;4288.163808057461;4309.07354918694;4309.504406993173;4349.847755328548;3779.3952967525065;3820.3505404081375;3830.8276127574327;3858.7105967052585;3865.2269546090893;4395.055063161436;4534.13851368239;4547.8635640930825;4554.908901821945;4604.332371806069;5159.432462429129;5170.353705786777;5229.816956406507;5236.73816309183;5240.030594340059;4483.08096840147;4491.595756381941;4493.775311234491;4511.616512596466;4552.544745525421;4433.955660443419;4494.191045611756;4642.187617166982;4649.139909116824;4673.439187297546;4870.245112007645;4897.559219670246;4937.456879743298;4944.975275123746;4970.9254361183885;5268.6575372600655;5302.973485132549;5307.920381194208;5312.920306195333;5367.651102678314;4783.162946484282;4887.560119589254;4887.804487820589;4990.051890141007;5007.749612519432;5010.724410157331;5101.92347114801;5102.79588816458;5111.514406131411;5180.7409629519125;5282.920756188737;5283.656562323436;5290.65610735301;5292;5293.788248470172;5052.59579233653;5082.974585127051;5094.414142373675;5103.77033033507;5133.409657889241;4855.393075865517;4940.851774446773;4972.726500042532;5010.3737032870895;5059.822906198413;4939.43196532389;4972.3038774572315;4976.477469865612;4997.5002499749735;5030.698158110525;4859.635527335393;5124.256982737556;5127.077126117335;5134.12719837636;5141.665791723675;4917.6311776616185;4933.186024305949;4948.6535942485125;4957.132501812096;4960.950390496048 10:00:18 INFO - 2015-11-26 10:00:18,183 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.8367540633527;563.0512586292101;585.037613126407;589.6845187824512;592.1532208941213;33739.49390759137;33957.98126056219;34033.659663403356;34092;34351.31297374054;35671.82164089182;36008.27983440329;36125.27749445009;36140;36162;7962.044554653449;8039.437239393244;8071.798205044892;8083.474574152661;8087.797805054862;7897.328727058179;7957.244061814118;8005.5997200140055;8014.919850801505;8018.599070046504;7977.082635496905;7985.760427187193;8005.039395272546;8064.959675201616;8074.232947869943;7983.281504664579;8006.15935326794;8015.158408367125;8036.156203598625;8085.110637829834;7756.961215193945;7863.252990965849;7869.252421019994;7893.289603935616;7913.881291780628;36829.815850920844;37178;37211;37284.62715372839;37291;2991.491446454108;3194.297254603983;3210.6307774605984;3363.899083027513;3377.105067157205;27582.862085689645;27646;28063.57904631432;28106.859465702746;28121.156365309074;3394.7114495267933;3413.35146322198;3477.374072666919;3479.407182519076;3488.1977145256733;215133;215929;216383;216602;216691;49131.612890324745;52192.478075218765;52405.7379713099;52470.21294680583;52492;45605;63067;63940.36059639344;64036;64234;13774.93112534451;14053.22707251111;14058.43766249359;14135.575932722035;14203.502877399242;9975.501224938724;10142.18862490999;10142.391456512632;10183;10195.490225488844;18473.7228941566;18490.167942442622;18495.352662657013;18615.534611634546;18722.344717934808;7341.74303899361;7647.808804779814;7677.117131529945;7719.150893401721;7747.147813740484;867.8134201146657;901.5402144906145;915.922146617545;928.8885333759993;1010.3634710132569;25901.8704906478;25912;25996.35009124787;26003.21990340293;26201;937.9588656591178;943.3773709351794;977.1596427072711;1083.2904447586843;1096.4736926275432;12212.084093693009;13835.654108647364;14020.158790472604;14343;14464.13215207091;274140;274738;274968;275557;276711;45443.54556454459;45523.31715024211;45604.8598785033;45666.31500527495;45708.3143752844;1220.7985682362312;1227.7298994221258;1242.2546472116658;1248.2385744695728;1252.8183413405188;26363.20910372692;26401.207963761117;26599.33501662474;26770.732292676825;26970.595441068006;38736.61263387443;38967.2206555873;39161;39221.2155756889;39243.80378098091;258589;259325;259350;259379;259921;27514.44971100607;28372.43255134927;28858.567121493616;28906.85546572338;29058.128256152348;34334.65665343314;34433.48349774806;34513.827430862686;35331.82334088313;35336.46995295021;32486;32826.83586582052;32952.34095318128;33187.83406082954;33619.49570756392;32352.676473234966;32959.67040329662;32994.67005329916;33038.66961330356;33161.50257746184;31726;32315.19212019718;32453.51319730159;32726.181845454055;32741.18147046343;27762.722372776014;29619.703802961696;29862.85068574643;29879.850600746857;30489.237769055064;22083.889580551993;22573.661395079416;22748.09007639742;22859.428514287276;22928.338989123076 10:00:18 INFO - 2015-11-26 10:00:18,183 DEBUG : BROWSER_OUTPUT: |2;jquery.html;305.8317925141172;311.9984400077999;314.0719174838353;316.55523988795744;319.5797526252979;14182.57452276432;14829.925850370746;15219;15752.212389380515;16448.342066317335;10068.49657517123;10303.845442318372;12496.625101246955;15154.090754554734;15217.315220815062;4540.18276710192;4570.0859828034445;4627.768611569425;4653.790014596196;4670.439547254335;4625.676202665814;4656.837010704626;4660.16117098922;4669;4684.320773487842;4691.671582989192;4699.248120300753;4717.127331443694;4740.810367585293;4768.117898188829;5336.706481143536;5492.148716948879;5496.917546236789;5498.202760599731;5510;4802.59177969873;4820.517948205186;5088.160453525164;5093.159628661267;5106.4382917879;10970.122390208764;11119.388433636146;11217.439128043647;13577.389017494237;17680;1821.1258595874056;1854.573448106943;1871.1860340751816;1879.746234258385;1972.0534143611146;9074.546272686406;9335;9422.293328000427;9784.217262619044;10524.78950420995;1733.8352856478614;1768.2661695396396;1798.3436045843173;1802.4322338463342;1857.9814201857944;50410.24384634233;53882;53989;56219.43780562224;59771.70114149401;9634.373765705206;9882.851757223647;9936.950315248521;10005.549750261256;10071.5467803949;11286.266392684449;11722.94138529302;11730.70673233176;12464.376781161087;12479.875201248053;6699.564528305645;6790.93209067903;6817.795466136024;6848.14398200225;6916.619585922823;6670.5664131832245;6673.599584024877;6698.665066746643;6704.597724136567;6708.228553716288;4003.559608443069;4005.5794141615293;4026.939595906064;4079.592040795956;4110.403991421227;1689.729643257073;1725.1115675427166;1750.8511776498885;1774.8846324989092;1814.383109742694;841.1126261793744;865.7143142762873;892.0900681305033;905.0587389115246;915.7390143808982;15281.38874445032;15311.92344038295;15609.531714048597;15724.528264152093;16167.272472738756;890.7906641939139;897.3225214962791;915.8076803871129;933.1834644685899;954.022127319503;6757.729690812411;8819.823603527893;8867.778305542413;9000.36997410175;9209.171174594185;493632;497510;512870;520686;520792;65345.673271633335;73666;74808.62595686987;74984.25015749772;75295.24704752992;873.9650413983496;889.0620395482828;897.0177655467253;899.2311573604604;900.8423525882944;13676.316184190551;13999.300034998412;14158.716825663636;14205.786913196516;14387.784183237469;24817.883195256618;26244.475110498064;29785.702142978294;30398.848005759828;30721;38053.809730951165;39217;39585.2082958345;40020;40969.180616388105;8430.662773489237;8524.70163544273;8678.132186781271;8682.696105636272;8683.478991260545;14064.929675351557;15325.233738312816;16363.672726545641;16579.336826527287;16690.83164178496;13271.203727775977;13482.19106853592;13637.386317615532;13811.51659691906;14547.927260363631;13685.863141368856;13832;13943.721125577229;14257.287135643384;14291.285435727965;14079.155250684991;14134.717305654034;14354.712905742035;14613.488527901472;14810.925945370203;8755.51844648525;8997.505137217255;9169.220616247694;9247.537623118682;9270.490123043297;9544.42733435996;9733.951330243304;13638.863611363759;14309.141451512942;14383.28083595795 10:00:18 INFO - 2015-11-26 10:00:18,183 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1342.3355439057668;1351;1392.937317820698;1605.4300723243248;1686.2159096020348;5705.51503122234;6034;6431.3890180432845;6964.164300283966;6974.930250697492;6536.150300460945;6745.291744366845;6794.694238759255;6799.966000169992;6832.692528836202;1982.2071171531431;2004.1983206717284;2007.0968064371018;2015.7782643909159;2025.625259327022;2002.6895831146196;2013.2349707111277;2031.908564114611;2033.4306394209646;2046.1713006232499;1968.507873031742;1974.7136665183539;2007.056683358819;2014.1037238428905;2017.515796208914;2008.9899550502228;2011.3463124484529;2021.2925476083253;2021.3733742539787;2025.574629327843;1994.4216177308708;2002.1590931808676;2011.5675129847007;2022.2719820864477;2028.198861449719;6724.562903411263;6764.188297404294;6796.286389929036;6799.830004249884;6802.2857599951785;3887.455756194135;4001.8199181036925;4018.3369743992207;4018.5378681451716;4020.1356708307853;2531.190019193859;2564.5896656534865;2601.89592416305;2656.2695258803983;2663.3474798674256;833.0669649991987;835.5028757889107;836.2891542189151;873.3231745397304;881.4755220643707;9052.818943621156;9095.181433670936;9125.224355929753;9135.36052476327;9157.725268241897;3708.8887333380044;3714.517112775322;3770.7549009314857;3807.048237940515;3810.714196435223;7942.722004729807;7946.324562412144;7948.205179482121;7968.163342848918;7973.322267607203;4129.256733787947;4150.045489537363;4154.896127596834;4159.313713237282;4174.123434078817;3656.762310449812;3741.9064523387133;3759.774413535142;3766;3780.640839120334;3038.6657467678538;3040.0423866481988;3064.728137822823;3072.923176920595;3113.8910138145056;948.1229862377273;951.0727041134838;953.7424895278236;958.8849338079475;965.6089283839916;941.8351788436996;942.8774259346378;1129.170060005895;1149.7298134938283;1153.878842721519;6359.2368915729485;6377.362263773585;6382.074599183093;6408.51936104794;6441.774537891151;442.0738552732021;1085.1535802074395;1099.4008265495324;1108.1854836695022;1130.6268931252666;4868.464468908417;4884;4971.950280497149;5032.723200224023;5051.318072060299;8014.2386473286115;8113.7565873023905;8131.14622964592;8149.551774652333;8189.099199088096;7926.9603651982525;7961.562114083781;7978;8027.719029834045;8047.315978141924;6357.205349331333;6454;6513.478921686254;6538.640374779433;6547.639879806657;6142.14010038586;6186.10301506288;6210.627362358273;6212.875742485216;6215;7160.391366733886;7319.74380896666;7404.444666649915;7419.332260096618;7461.962690186514;7520.360769334668;7522.533106044269;7545.962270188614;7565.205653406313;7573.35626471756;5199.844004679866;5341.317484992215;5755.050416681201;5804.970975145097;5878.441548052928;6305.8108256752375;6508.381703738138;6525.0538671893255;6534.411902928759;6548.017797330439;5929.140274660236;6082.330943596289;6084.756609735561;6105.572609917263;6186.81439556814;5985.910211346746;6087.634741915499;6147.723352449061;6189.473894718999;6233.937660623335;6101.145839582373;6255.937440625536;6259.749610015549;6263.56155069159;6271.43557079865;5633.380328163817;5701;5719.685417302088;5726.5418766499415;5727.7422515986045;5742.310922689304;5768.048272035067;5807.76768929255;5808.564357673107;5822.475977162076 10:00:18 INFO - 2015-11-26 10:00:18,184 DEBUG : BROWSER_OUTPUT: |4;prototype.html;286.4757493786371;296.7729686789606;297.43932686885216;303.9832809195495;304.82320254252534;5537.698640819409;5583.3579138399045;5633;5647.181158731982;5805;5568.5266752326;5612.382637909826;5632.577556683244;5636.464535869086;5637.379888212304;4147.9585204148025;4265.509466411356;4270.338097594878;4281.100968796556;4282.957170428294;4255.319148936171;4258.829646814123;4266.488021437432;4271.060366719316;4272.33778764292;4199.45407097077;4214.473190851144;4214.578542145791;4218.873433796991;4247.575242475743;4230.91538169238;4231.196072746168;4236.470441194866;4245.511766146871;4246.745195288293;3678;3678.1724112074835;3689.335919534483;3690.1697118148472;3700.204456041937;5251.212318152269;5289.603279754034;5406.54044406222;5413.648112872651;5421;4848.248521479177;4853.975730121362;4858.222684370484;4859.927101093486;4864.683795553277;5863.472287494146;5872.412758724136;5876.08920617305;5907.970460147715;5919.200907877467;3846.615338466131;3984.641382275609;3985.880423587297;3994.6804255659476;3998.460207871929;6059;6191.2570491540855;6203.348648391899;6222.751089956397;6233.87532249357;4097.364908439196;4107.034846810997;4107.116969851496;4108.4453598764385;4109.383592461155;4173.332266837291;4173.353130264813;4173.91652166961;4174.91650166995;4180.728252663567;4734.337192792943;4824.107540105022;4824.662273640882;4826.903461930741;4834.903301934012;5901.498372638373;5904.675242861684;5908.379620139824;5908.852278693067;5910.970445147746;1468.2585294426246;1491.2320155120121;1492.0674578388507;1492.0674578388507;1493.9626509337354;980.519545422752;993.4704940248861;1001.4341896828414;1006.6778630838207;1010.2170817616407;5118.846434606968;5149.9742501287255;5152.201408781645;5162.045021671003;5164.122099243138;6079.331273559905;6112.419320164578;6131.816045518642;6142.57002009855;6143.047827586731;5108.386993560796;5131.589472842164;5148.871278218075;5162.896742065138;5167.018266529422;3265.804051756902;3300.5379246905454;3325.9667403325657;3338.0987133473827;3351.977646817695;5674.2339784129435;5761.53907687384;5767.04843700793;5769.624974376652;5789.739461724233;6307.905381419282;6318.304986451487;6325.209348831396;6346.809595712136;6365.267994180728;5748.885022299531;5759.452851979056;5764.654120752768;5780.797672081457;5794.536437085023;6111.205543279345;6113.419225173601;6150.938490615036;6153.630782153085;6155.538334625011;5882.5293976482635;6028.125921741235;6040.395960403925;6064.818055458343;6071.332153463027;5821.825345239649;5828.970855145697;5837.5038121758425;5843.30544142194;5848;4071.7353372031907;4096.2831504486;4111.938320925129;4114.855980040684;4121.9381709274985;5984.251968503937;6134.754609815736;6159.199304090619;6160.229971253593;6163.013917773134;5914.674692891932;5927.051671732502;5932.406759324033;5943.078822782476;5953.642781433128;5941.7623295067715;5950.553708471795;5954;5965.224520812267;5977.820665380045;5642.125470552071;5803.47768700819;5812.21535092757;5830.9416905832095;5868.94131058701;5988.431099045583;6027;6030.698465076816;6034.426729460694;6038.456538911519;5777.768889244551;5838.32859221195;5839.211706419579;5846.970765146317;5861 10:00:18 INFO - 2015-11-26 10:00:18,185 DEBUG : BROWSER_OUTPUT: |5;yui.html;695.1484431571324;733.9633018349081;749.760076775432;753.6796861333931;768.1511929318103;11432.542698292069;11626.709332266697;11766.588169414083;11836.704082397944;11841.585544505944;11787;11931;11940.22388544744;11949.283043017404;11971.940140299308;771.5216565729241;779.6959185917497;784.8940393046922;787.7400457848896;788.2039140468111;773.1765669561927;785.9921400786005;791.1653205867807;792.0890975378333;793.2503783924194;812.553095797312;820.1019883227856;822.9094799572042;823.8970128733908;825.3067423364373;812.7561731480532;813.446856137826;815.3517953227139;815.9836803263931;816.4896939412837;602.0187095035064;604.7671646416161;605.2585582661249;605.6003037994902;606.9453749162552;12572.874271257262;12724.236545807282;12748.681282967907;12761.106722529426;12808.871911280861;10909.127269818395;11237.381943993078;11262.436878156059;11302.208845380826;11355.432228388547;8542.871856922151;9124.88259157858;9421.293402994734;9429.622815087389;9473.952630236805;3123.1879711275005;3123.3440977394775;3164.256399746058;3175.333180032196;3179.998300535324;44128.558714412764;44614.77692611516;44635.55364446379;44646.33030504545;44724.552754472366;9436.716898493056;9598.616055357708;9664.516774161264;9691.806163876683;10060.597576096874;15997.60005999836;16229.431969881234;16263;16689.415870444718;16945.49163525096;6213.424958659661;6321.273053598895;6324.71538780756;6406.5515413920575;6507.967460162668;3619.348517266917;3698.334299826003;3743.47591337213;3784.2242340320167;3825.827837747308;2563.910263140781;2593.494268617639;2616.3459135216194;2624.593188055854;2634.1702363755358;485.3302442629149;489.870184401134;495.28678702668043;499.8175665881927;505.3152977715143;455.317024463305;458.6812165544914;478.7558345243881;504.53834741212114;598.0938877600439;7872.685092596232;8183.427160098736;8682.522461264565;8845.867311990325;8935.419197752126;547.7671989404566;549.8570371703386;563.1749487001563;570.1533223163682;591.6804925340355;3796.7532110412735;3874.5737968823405;3926.2540117377607;3946.644801967837;4129.69027322952;49058.75470622695;49242;49467.50532494701;54084.729576352656;55007.44992550103;45017.324740128926;45034.54965450303;45344;45431.772841135586;45695.31457028147;42960.57039429628;43684.34473482901;43997.78001110038;44148.77925610352;44634.10731785411;8217.506949582805;8243.25810677042;8639.611217495101;8640.827183456422;8832.116788321116;31282.68717312889;31583.526247105852;31645.841770790998;32431;32575.67424325821;36731;36831.89504314875;39081.609183908935;40342.79828600956;40768.388474172316;10229.948850255701;10303.639372621923;10318.845217321596;10360.53377598025;10441.895581044093;10678.57285708563;10845.295055821347;10857.40284284372;11628.360440175871;11974.880251197377;10299.588016479256;10513.106385957279;10549.736256593647;10652.414117223318;10994.505247263733;10716.732081697708;10758.784824303626;10949.726256843642;11019.393933333744;11259.887401125883;9935.850962235716;10851.891481085087;11133.05369043608;11157.497912594115;11171.385573793194;9087.227585655293;9372.672472864126;9452.574634141618;9543.952280238555;9869.950650246703;8896.421732587361;8985.955070224607;9406.811863762823;9474.526273686426;9570.425774453555 10:00:18 INFO - 2015-11-26 10:00:18,185 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:00:18 INFO - 2015-11-26 10:00:18,185 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,341 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: __startTimestamp1448560818176__endTimestamp 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,186 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4800.86 Median:4937.46 stddev:511.24 (10.4%) stddev-sans-first:485.53 10:00:18 INFO - 2015-11-26 10:00:18,187 DEBUG : BROWSER_OUTPUT: Values: 2700.4 2745.1 2779.3 2789.6 2796.8 4661.4 4723.3 4799.2 4805.9 4839.6 4803.8 4842.1 4862.1 4957.0 4963.6 4381.6 4486.3 4515.8 4518.6 4550.1 4346.7 4448.9 4479.1 4514.9 4568.3 4382.8 4447.8 4470.9 4483.8 4506.9 4458.7 4498.4 4504.3 4522.5 4551.2 4297.0 4387.4 4453.0 4472.7 4479.6 4703.5 4706.0 4749.8 4753.9 4800.2 5173.4 5174.2 5182.1 5190.5 5254.6 5012.3 5205.1 5206.3 5214.1 5228.4 4750.1 4808.4 4832.3 4835.7 4877.0 5376.9 5423.3 5430.1 5432.3 5438.3 5150.5 5176.0 5205.6 5205.9 5255.2 5011.4 5162.6 5220.6 5290.7 5357.0 5222.0 5223.0 5234.9 5243.8 5263.3 4939.3 5141.8 5170.0 5178.4 5215.4 4195.2 4288.2 4309.1 4309.5 4349.8 3779.4 3820.4 3830.8 3858.7 3865.2 4395.1 4534.1 4547.9 4554.9 4604.3 5159.4 5170.4 5229.8 5236.7 5240.0 4483.1 4491.6 4493.8 4511.6 4552.5 4434.0 4494.2 4642.2 4649.1 4673.4 4870.2 4897.6 4937.5 4945.0 4970.9 5268.7 5303.0 5307.9 5312.9 5367.7 4783.2 4887.6 4887.8 4990.1 5007.7 5010.7 5101.9 5102.8 5111.5 5180.7 5282.9 5283.7 5290.7 5292.0 5293.8 5052.6 5083.0 5094.4 5103.8 5133.4 4855.4 4940.9 4972.7 5010.4 5059.8 4939.4 4972.3 4976.5 4997.5 5030.7 4859.6 5124.3 5127.1 5134.1 5141.7 4917.6 4933.2 4948.7 4957.1 4961.0 10:00:18 INFO - 2015-11-26 10:00:18,187 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,187 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40646.94 Median:18551.70 stddev:65600.40 (353.6%) stddev-sans-first:65715.32 10:00:18 INFO - 2015-11-26 10:00:18,188 DEBUG : BROWSER_OUTPUT: Values: 543.8 563.1 585.0 589.7 592.2 33739.5 33958.0 34033.7 34092.0 34351.3 35671.8 36008.3 36125.3 36140.0 36162.0 7962.0 8039.4 8071.8 8083.5 8087.8 7897.3 7957.2 8005.6 8014.9 8018.6 7977.1 7985.8 8005.0 8065.0 8074.2 7983.3 8006.2 8015.2 8036.2 8085.1 7757.0 7863.3 7869.3 7893.3 7913.9 36829.8 37178.0 37211.0 37284.6 37291.0 2991.5 3194.3 3210.6 3363.9 3377.1 27582.9 27646.0 28063.6 28106.9 28121.2 3394.7 3413.4 3477.4 3479.4 3488.2 215133.0 215929.0 216383.0 216602.0 216691.0 49131.6 52192.5 52405.7 52470.2 52492.0 45605.0 63067.0 63940.4 64036.0 64234.0 13774.9 14053.2 14058.4 14135.6 14203.5 9975.5 10142.2 10142.4 10183.0 10195.5 18473.7 18490.2 18495.4 18615.5 18722.3 7341.7 7647.8 7677.1 7719.2 7747.1 867.8 901.5 915.9 928.9 1010.4 25901.9 25912.0 25996.4 26003.2 26201.0 938.0 943.4 977.2 1083.3 1096.5 12212.1 13835.7 14020.2 14343.0 14464.1 274140.0 274738.0 274968.0 275557.0 276711.0 45443.5 45523.3 45604.9 45666.3 45708.3 1220.8 1227.7 1242.3 1248.2 1252.8 26363.2 26401.2 26599.3 26770.7 26970.6 38736.6 38967.2 39161.0 39221.2 39243.8 258589.0 259325.0 259350.0 259379.0 259921.0 27514.4 28372.4 28858.6 28906.9 29058.1 34334.7 34433.5 34513.8 35331.8 35336.5 32486.0 32826.8 32952.3 33187.8 33619.5 32352.7 32959.7 32994.7 33038.7 33161.5 31726.0 32315.2 32453.5 32726.2 32741.2 27762.7 29619.7 29862.9 29879.9 30489.2 22083.9 22573.7 22748.1 22859.4 22928.3 10:00:18 INFO - 2015-11-26 10:00:18,188 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,188 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26491.12 Median:4325.29 stddev:83160.66 (1922.7%) stddev-sans-first:83370.70 10:00:18 INFO - 2015-11-26 10:00:18,188 DEBUG : BROWSER_OUTPUT: Values: 305.8 312.0 314.1 316.6 319.6 14182.6 14829.9 15219.0 15752.2 16448.3 10068.5 10303.8 12496.6 15154.1 15217.3 4540.2 4570.1 4627.8 4653.8 4670.4 4625.7 4656.8 4660.2 4669.0 4684.3 4691.7 4699.2 4717.1 4740.8 4768.1 5336.7 5492.1 5496.9 5498.2 5510.0 4802.6 4820.5 5088.2 5093.2 5106.4 10970.1 11119.4 11217.4 13577.4 17680.0 1821.1 1854.6 1871.2 1879.7 1972.1 9074.5 9335.0 9422.3 9784.2 10524.8 1733.8 1768.3 1798.3 1802.4 1858.0 50410.2 53882.0 53989.0 56219.4 59771.7 9634.4 9882.9 9937.0 10005.5 10071.5 11286.3 11722.9 11730.7 12464.4 12479.9 6699.6 6790.9 6817.8 6848.1 6916.6 6670.6 6673.6 6698.7 6704.6 6708.2 4003.6 4005.6 4026.9 4079.6 4110.4 1689.7 1725.1 1750.9 1774.9 1814.4 841.1 865.7 892.1 905.1 915.7 15281.4 15311.9 15609.5 15724.5 16167.3 890.8 897.3 915.8 933.2 954.0 6757.7 8819.8 8867.8 9000.4 9209.2 493632.0 497510.0 512870.0 520686.0 520792.0 65345.7 73666.0 74808.6 74984.3 75295.2 874.0 889.1 897.0 899.2 900.8 13676.3 13999.3 14158.7 14205.8 14387.8 24817.9 26244.5 29785.7 30398.8 30721.0 38053.8 39217.0 39585.2 40020.0 40969.2 8430.7 8524.7 8678.1 8682.7 8683.5 14064.9 15325.2 16363.7 16579.3 16690.8 13271.2 13482.2 13637.4 13811.5 14547.9 13685.9 13832.0 13943.7 14257.3 14291.3 14079.2 14134.7 14354.7 14613.5 14810.9 8755.5 8997.5 9169.2 9247.5 9270.5 9544.4 9734.0 13638.9 14309.1 14383.3 10:00:18 INFO - 2015-11-26 10:00:18,188 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,188 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4743.06 Median:6009.96 stddev:2436.69 (40.5%) stddev-sans-first:2430.12 10:00:18 INFO - 2015-11-26 10:00:18,189 DEBUG : BROWSER_OUTPUT: Values: 1342.3 1351.0 1392.9 1605.4 1686.2 5705.5 6034.0 6431.4 6964.2 6974.9 6536.2 6745.3 6794.7 6800.0 6832.7 1982.2 2004.2 2007.1 2015.8 2025.6 2002.7 2013.2 2031.9 2033.4 2046.2 1968.5 1974.7 2007.1 2014.1 2017.5 2009.0 2011.3 2021.3 2021.4 2025.6 1994.4 2002.2 2011.6 2022.3 2028.2 6724.6 6764.2 6796.3 6799.8 6802.3 3887.5 4001.8 4018.3 4018.5 4020.1 2531.2 2564.6 2601.9 2656.3 2663.3 833.1 835.5 836.3 873.3 881.5 9052.8 9095.2 9125.2 9135.4 9157.7 3708.9 3714.5 3770.8 3807.0 3810.7 7942.7 7946.3 7948.2 7968.2 7973.3 4129.3 4150.0 4154.9 4159.3 4174.1 3656.8 3741.9 3759.8 3766.0 3780.6 3038.7 3040.0 3064.7 3072.9 3113.9 948.1 951.1 953.7 958.9 965.6 941.8 942.9 1129.2 1149.7 1153.9 6359.2 6377.4 6382.1 6408.5 6441.8 442.1 1085.2 1099.4 1108.2 1130.6 4868.5 4884.0 4972.0 5032.7 5051.3 8014.2 8113.8 8131.1 8149.6 8189.1 7927.0 7961.6 7978.0 8027.7 8047.3 6357.2 6454.0 6513.5 6538.6 6547.6 6142.1 6186.1 6210.6 6212.9 6215.0 7160.4 7319.7 7404.4 7419.3 7462.0 7520.4 7522.5 7546.0 7565.2 7573.4 5199.8 5341.3 5755.1 5805.0 5878.4 6305.8 6508.4 6525.1 6534.4 6548.0 5929.1 6082.3 6084.8 6105.6 6186.8 5985.9 6087.6 6147.7 6189.5 6233.9 6101.1 6255.9 6259.7 6263.6 6271.4 5633.4 5701.0 5719.7 5726.5 5727.7 5742.3 5768.0 5807.8 5808.6 5822.5 10:00:18 INFO - 2015-11-26 10:00:18,189 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,189 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4869.00 Median:5597.87 stddev:1464.32 (26.2%) stddev-sans-first:1427.46 10:00:18 INFO - 2015-11-26 10:00:18,190 DEBUG : BROWSER_OUTPUT: Values: 286.5 296.8 297.4 304.0 304.8 5537.7 5583.4 5633.0 5647.2 5805.0 5568.5 5612.4 5632.6 5636.5 5637.4 4148.0 4265.5 4270.3 4281.1 4283.0 4255.3 4258.8 4266.5 4271.1 4272.3 4199.5 4214.5 4214.6 4218.9 4247.6 4230.9 4231.2 4236.5 4245.5 4246.7 3678.0 3678.2 3689.3 3690.2 3700.2 5251.2 5289.6 5406.5 5413.6 5421.0 4848.2 4854.0 4858.2 4859.9 4864.7 5863.5 5872.4 5876.1 5908.0 5919.2 3846.6 3984.6 3985.9 3994.7 3998.5 6059.0 6191.3 6203.3 6222.8 6233.9 4097.4 4107.0 4107.1 4108.4 4109.4 4173.3 4173.4 4173.9 4174.9 4180.7 4734.3 4824.1 4824.7 4826.9 4834.9 5901.5 5904.7 5908.4 5908.9 5911.0 1468.3 1491.2 1492.1 1492.1 1494.0 980.5 993.5 1001.4 1006.7 1010.2 5118.8 5150.0 5152.2 5162.0 5164.1 6079.3 6112.4 6131.8 6142.6 6143.0 5108.4 5131.6 5148.9 5162.9 5167.0 3265.8 3300.5 3326.0 3338.1 3352.0 5674.2 5761.5 5767.0 5769.6 5789.7 6307.9 6318.3 6325.2 6346.8 6365.3 5748.9 5759.5 5764.7 5780.8 5794.5 6111.2 6113.4 6150.9 6153.6 6155.5 5882.5 6028.1 6040.4 6064.8 6071.3 5821.8 5829.0 5837.5 5843.3 5848.0 4071.7 4096.3 4111.9 4114.9 4121.9 5984.3 6134.8 6159.2 6160.2 6163.0 5914.7 5927.1 5932.4 5943.1 5953.6 5941.8 5950.6 5954.0 5965.2 5977.8 5642.1 5803.5 5812.2 5830.9 5868.9 5988.4 6027.0 6030.7 6034.4 6038.5 5777.8 5838.3 5839.2 5847.0 5861.0 10:00:18 INFO - 2015-11-26 10:00:18,190 DEBUG : BROWSER_OUTPUT: 10:00:18 INFO - 2015-11-26 10:00:18,190 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12616.60 Median:45025.94 stddev:14387.72 (32.0%) stddev-sans-first:14400.23 10:00:18 INFO - 2015-11-26 10:00:18,190 DEBUG : BROWSER_OUTPUT: Values: 695.1 734.0 749.8 753.7 768.2 11432.5 11626.7 11766.6 11836.7 11841.6 11787.0 11931.0 11940.2 11949.3 11971.9 771.5 779.7 784.9 787.7 788.2 773.2 786.0 791.2 792.1 793.3 812.6 820.1 822.9 823.9 825.3 812.8 813.4 815.4 816.0 816.5 602.0 604.8 605.3 605.6 606.9 12572.9 12724.2 12748.7 12761.1 12808.9 10909.1 11237.4 11262.4 11302.2 11355.4 8542.9 9124.9 9421.3 9429.6 9474.0 3123.2 3123.3 3164.3 3175.3 3180.0 44128.6 44614.8 44635.6 44646.3 44724.6 9436.7 9598.6 9664.5 9691.8 10060.6 15997.6 16229.4 16263.0 16689.4 16945.5 6213.4 6321.3 6324.7 6406.6 6508.0 3619.3 3698.3 3743.5 3784.2 3825.8 2563.9 2593.5 2616.3 2624.6 2634.2 485.3 489.9 495.3 499.8 505.3 455.3 458.7 478.8 504.5 598.1 7872.7 8183.4 8682.5 8845.9 8935.4 547.8 549.9 563.2 570.2 591.7 3796.8 3874.6 3926.3 3946.6 4129.7 49058.8 49242.0 49467.5 54084.7 55007.4 45017.3 45034.5 45344.0 45431.8 45695.3 42960.6 43684.3 43997.8 44148.8 44634.1 8217.5 8243.3 8639.6 8640.8 8832.1 31282.7 31583.5 31645.8 32431.0 32575.7 36731.0 36831.9 39081.6 40342.8 40768.4 10229.9 10303.6 10318.8 10360.5 10441.9 10678.6 10845.3 10857.4 11628.4 11974.9 10299.6 10513.1 10549.7 10652.4 10994.5 10716.7 10758.8 10949.7 11019.4 11259.9 9935.9 10851.9 11133.1 11157.5 11171.4 9087.2 9372.7 9452.6 9544.0 9870.0 8896.4 8986.0 9406.8 9474.5 9570.4 10:00:18 INFO - 2015-11-26 10:00:18,190 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:00:18 INFO - 2015-11-26 10:00:18,190 DEBUG : BROWSER_OUTPUT: 10:00:19 INFO - 2015-11-26 10:00:19,893 INFO : Browser exited with error code: 0 10:00:19 INFO - 2015-11-26 10:00:19,914 INFO : Completed test dromaeo_css (00:19:38) 10:00:19 INFO - 2015-11-26 10:00:19,914 INFO : Starting test kraken 10:00:19 INFO - 2015-11-26 10:00:19,914 DEBUG : operating with platform_type : linux_ 10:00:19 INFO - 2015-11-26 10:00:19,914 INFO : Initialising browser for kraken test... 10:00:19 INFO - 2015-11-26 10:00:19,920 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps4VzEh/profile http://localhost:42860/getInfo.html 10:00:36 INFO - 2015-11-26 10:00:36,182 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:00:36 INFO - 2015-11-26 10:00:36,183 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:00:36 INFO - 2015-11-26 10:00:36,183 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:00:36 INFO - 2015-11-26 10:00:36,183 DEBUG : BROWSER_OUTPUT: __metrics 10:00:41 INFO - 2015-11-26 10:00:41,037 INFO : Browser initialized. 10:00:41 INFO - 2015-11-26 10:00:41,037 INFO : Running cycle 1/1 for kraken test... 10:00:41 INFO - 2015-11-26 10:00:41,038 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps4VzEh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:00:52 INFO - 2015-11-26 10:00:52,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 139038720 10:00:52 INFO - 2015-11-26 10:00:52,896 DEBUG : BROWSER_OUTPUT: 10:00:55 INFO - 2015-11-26 10:00:55,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42860/tests/kraken/driver.html?testName=audio-beat-detection) 10:00:56 INFO - 2015-11-26 10:00:56,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 141668352 10:00:56 INFO - 2015-11-26 10:00:56,107 DEBUG : BROWSER_OUTPUT: 10:00:58 INFO - 2015-11-26 10:00:58,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42860/tests/kraken/driver.html?testName=audio-dft) 10:00:59 INFO - 2015-11-26 10:00:59,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 141111296 10:00:59 INFO - 2015-11-26 10:00:59,463 DEBUG : BROWSER_OUTPUT: 10:01:02 INFO - 2015-11-26 10:01:02,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42860/tests/kraken/driver.html?testName=audio-fft) 10:01:03 INFO - 2015-11-26 10:01:03,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 137297920 10:01:03 INFO - 2015-11-26 10:01:03,003 DEBUG : BROWSER_OUTPUT: 10:01:05 INFO - 2015-11-26 10:01:05,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42860/tests/kraken/driver.html?testName=audio-oscillator) 10:01:05 INFO - 2015-11-26 10:01:05,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 135446528 10:01:05 INFO - 2015-11-26 10:01:05,665 DEBUG : BROWSER_OUTPUT: 10:01:07 INFO - 2015-11-26 10:01:07,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:01:08 INFO - 2015-11-26 10:01:08,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 10:01:08 INFO - 2015-11-26 10:01:08,501 DEBUG : BROWSER_OUTPUT: 10:01:11 INFO - 2015-11-26 10:01:11,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42860/tests/kraken/driver.html?testName=imaging-darkroom) 10:01:12 INFO - 2015-11-26 10:01:12,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 137801728 10:01:12 INFO - 2015-11-26 10:01:12,136 DEBUG : BROWSER_OUTPUT: 10:01:15 INFO - 2015-11-26 10:01:15,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42860/tests/kraken/driver.html?testName=imaging-desaturate) 10:01:16 INFO - 2015-11-26 10:01:16,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 135348224 10:01:16 INFO - 2015-11-26 10:01:16,203 DEBUG : BROWSER_OUTPUT: 10:01:19 INFO - 2015-11-26 10:01:19,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42860/tests/kraken/driver.html?testName=json-parse-financial) 10:01:19 INFO - 2015-11-26 10:01:19,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 136224768 10:01:19 INFO - 2015-11-26 10:01:19,708 DEBUG : BROWSER_OUTPUT: 10:01:21 INFO - 2015-11-26 10:01:21,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:01:22 INFO - 2015-11-26 10:01:22,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 138153984 10:01:22 INFO - 2015-11-26 10:01:22,076 DEBUG : BROWSER_OUTPUT: 10:01:23 INFO - 2015-11-26 10:01:23,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:01:24 INFO - 2015-11-26 10:01:24,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 137465856 10:01:24 INFO - 2015-11-26 10:01:24,578 DEBUG : BROWSER_OUTPUT: 10:01:26 INFO - 2015-11-26 10:01:26,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:01:27 INFO - 2015-11-26 10:01:27,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 139202560 10:01:27 INFO - 2015-11-26 10:01:27,387 DEBUG : BROWSER_OUTPUT: 10:01:29 INFO - 2015-11-26 10:01:29,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:01:31 INFO - 2015-11-26 10:01:30,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 156049408 10:01:31 INFO - 2015-11-26 10:01:30,596 DEBUG : BROWSER_OUTPUT: 10:01:34 INFO - 2015-11-26 10:01:34,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:01:34 INFO - 2015-11-26 10:01:34,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 137883648 10:01:34 INFO - 2015-11-26 10:01:34,624 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42860/tests/kraken/driver.html?testName=ai-astar) 10:01:36 INFO - 2015-11-26 10:01:36,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 138432512 10:01:36 INFO - 2015-11-26 10:01:36,649 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,653 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:01:36 INFO - 2015-11-26 10:01:36,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:01:36 INFO - 2015-11-26 10:01:36,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:01:36 INFO - 2015-11-26 10:01:36,653 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:01:36 INFO - 2015-11-26 10:01:36,653 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;110;115;115;115;125;113;113;113;112 10:01:36 INFO - 2015-11-26 10:01:36,653 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;133;160;161;132;158;155;145;161;135 10:01:36 INFO - 2015-11-26 10:01:36,654 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;164;161;163;164;174;163;165;163 10:01:36 INFO - 2015-11-26 10:01:36,654 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;73;72;126;71;72;71;74;107 10:01:36 INFO - 2015-11-26 10:01:36,654 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;93;129;93;94;95;129;94;94;131 10:01:36 INFO - 2015-11-26 10:01:36,654 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;111;111;110;110;110;110 10:01:36 INFO - 2015-11-26 10:01:36,654 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;151;147;149;148;148;148;148;147 10:01:36 INFO - 2015-11-26 10:01:36,654 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;96 10:01:36 INFO - 2015-11-26 10:01:36,654 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;73;89;74;73;73;74;73;74 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;75;68;69;69;69;70;69;69;69 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;83;92;84;83;83;94;95 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;131;139;136;122;130;127;123;129;127 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;146;152;151;155;146;151;145;150;134 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;69;69;75;70;73;69;69;68 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:01:36 INFO - 2015-11-26 10:01:36,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,812 10:01:36 INFO - 2015-11-26 10:01:36,656 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:01:36 INFO - 2015-11-26 10:01:36,656 DEBUG : BROWSER_OUTPUT: __startTimestamp1448560896651__endTimestamp 10:01:36 INFO - 2015-11-26 10:01:36,656 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,663 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:4.01 (3.5%) stddev-sans-first:4.25 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: Values: 115.0 110.0 115.0 115.0 115.0 125.0 113.0 113.0 113.0 112.0 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:159.00 stddev:12.54 (7.9%) stddev-sans-first:12.66 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: Values: 161.0 133.0 160.0 161.0 132.0 158.0 155.0 145.0 161.0 135.0 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.53 (2.2%) stddev-sans-first:3.71 10:01:36 INFO - 2015-11-26 10:01:36,664 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 164.0 161.0 163.0 164.0 174.0 163.0 165.0 163.0 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:72.00 stddev:19.21 (26.7%) stddev-sans-first:20.09 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 72.0 126.0 71.0 72.0 71.0 74.0 107.0 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:94.00 stddev:17.14 (18.2%) stddev-sans-first:17.94 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: Values: 97.0 93.0 129.0 93.0 94.0 95.0 129.0 94.0 94.0 131.0 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,665 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 151.0 147.0 149.0 148.0 148.0 148.0 148.0 147.0 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,666 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.20 Median:74.00 stddev:4.89 (6.6%) stddev-sans-first:5.17 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 73.0 89.0 74.0 73.0 73.0 74.0 73.0 74.0 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.00 stddev:1.99 (2.9%) stddev-sans-first:2.06 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 68.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:83.50 stddev:5.30 (6.3%) stddev-sans-first:5.41 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 83.0 92.0 84.0 83.0 83.0 94.0 95.0 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:130.50 stddev:5.76 (4.4%) stddev-sans-first:5.55 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: Values: 137.0 131.0 139.0 136.0 122.0 130.0 127.0 123.0 129.0 127.0 10:01:36 INFO - 2015-11-26 10:01:36,667 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,668 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:150.50 stddev:7.04 (4.7%) stddev-sans-first:6.12 10:01:36 INFO - 2015-11-26 10:01:36,668 DEBUG : BROWSER_OUTPUT: Values: 135.0 146.0 152.0 151.0 155.0 146.0 151.0 145.0 150.0 134.0 10:01:36 INFO - 2015-11-26 10:01:36,668 DEBUG : BROWSER_OUTPUT: 10:01:36 INFO - 2015-11-26 10:01:36,668 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.17 (3.1%) stddev-sans-first:2.29 10:01:36 INFO - 2015-11-26 10:01:36,668 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 69.0 69.0 75.0 70.0 73.0 69.0 69.0 68.0 10:01:36 INFO - 2015-11-26 10:01:36,668 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:01:36 INFO - 2015-11-26 10:01:36,668 DEBUG : BROWSER_OUTPUT: 10:01:38 INFO - 2015-11-26 10:01:38,081 INFO : Browser exited with error code: 0 10:01:39 INFO - 2015-11-26 10:01:39,040 INFO : Completed test kraken (00:01:19) 10:01:39 INFO - 2015-11-26 10:01:39,040 INFO : Starting test v8_7 10:01:39 INFO - 2015-11-26 10:01:39,040 DEBUG : operating with platform_type : linux_ 10:01:39 INFO - 2015-11-26 10:01:39,040 INFO : Initialising browser for v8_7 test... 10:01:39 INFO - 2015-11-26 10:01:39,046 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAlVvdD/profile http://localhost:42860/getInfo.html 10:01:54 INFO - 2015-11-26 10:01:54,800 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:01:54 INFO - 2015-11-26 10:01:54,800 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:01:54 INFO - 2015-11-26 10:01:54,801 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:01:54 INFO - 2015-11-26 10:01:54,801 DEBUG : BROWSER_OUTPUT: __metrics 10:01:55 INFO - 2015-11-26 10:01:55,927 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:01:58 INFO - 2015-11-26 10:01:58,361 INFO : Browser initialized. 10:01:58 INFO - 2015-11-26 10:01:58,361 INFO : Running cycle 1/1 for v8_7 test... 10:01:58 INFO - 2015-11-26 10:01:58,362 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAlVvdD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:02:10 INFO - 2015-11-26 10:02:10,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 10:02:10 INFO - 2015-11-26 10:02:10,154 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42860/tests/v8_7/run.html (next: http://localhost:42860/tests/v8_7/run.html) 10:02:31 INFO - 2015-11-26 10:02:31,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 137191424 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |0;Richards;165.56291390728478 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.4036557501904 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1084.5986984815618 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |5;Earley;713.2667617689016 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |7;RegExp;27944.444444444445 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |8;Splay;613.8735420503376 10:02:31 INFO - 2015-11-26 10:02:31,848 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 10:02:31 INFO - 2015-11-26 10:02:31,849 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:02:31 INFO - 2015-11-26 10:02:31,849 DEBUG : BROWSER_OUTPUT: __startTimestamp1448560951846__endTimestamp 10:02:31 INFO - 2015-11-26 10:02:31,849 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,849 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.56 Median:165.56 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: Values: 165.6 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.40 Median:190.40 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: Values: 190.4 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,850 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: Values: 278.1 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: Values: 5117.3 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1084.60 Median:1084.60 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: Values: 1084.6 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.27 Median:713.27 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: Values: 713.3 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: Values: 12444.4 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27944.44 Median:27944.44 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,851 DEBUG : BROWSER_OUTPUT: Values: 27944.4 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.87 Median:613.87 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: Values: 613.9 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: Values: 4835.7 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:02:31 INFO - 2015-11-26 10:02:31,852 DEBUG : BROWSER_OUTPUT: 10:02:33 INFO - 2015-11-26 10:02:33,673 INFO : Browser exited with error code: 0 10:02:33 INFO - 2015-11-26 10:02:33,687 INFO : Completed test v8_7 (00:00:54) 10:02:34 INFO - 2015-11-26 10:02:34,136 INFO : Completed test suite (00:21:52) 10:02:34 INFO - 2015-11-26 10:02:34,136 DEBUG : Working with test: dromaeo_css 10:02:34 INFO - 2015-11-26 10:02:34,136 DEBUG : Generating results file: dromaeo_css 10:02:34 INFO - 2015-11-26 10:02:34,137 DEBUG : Working with test: kraken 10:02:34 INFO - 2015-11-26 10:02:34,137 DEBUG : Generating results file: kraken 10:02:34 INFO - 2015-11-26 10:02:34,138 INFO : javascript benchmark 10:02:34 INFO - 2015-11-26 10:02:34,138 DEBUG : Working with test: v8_7 10:02:34 INFO - 2015-11-26 10:02:34,138 DEBUG : Generating results file: v8_7 10:02:34 INFO - 2015-11-26 10:02:34,138 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:02:34 INFO - 2015-11-26 10:02:34,211 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:02:34 INFO - 2015-11-26 10:02:34,211 DEBUG : process_Request line: dromaeo_css 6321.01 graph.html#tests=[[72,132,43]] 10:02:34 INFO - 2015-11-26 10:02:34,211 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:02:34 INFO - 2015-11-26 10:02:34,246 DEBUG : process_Request line: kraken 1547.60 graph.html#tests=[[232,132,43]] 10:02:34 INFO - 2015-11-26 10:02:34,246 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:02:34 INFO - 2015-11-26 10:02:34,278 DEBUG : process_Request line: v8_7 21093.57 graph.html#tests=[[230,132,43]] 10:02:34 INFO - 2015-11-26 10:02:34,279 INFO : javascript benchmark 10:02:34 INFO - 2015-11-26 10:02:34,283 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2700.378912850045, 2745.1352823860493, 2779.3190668286275, 2789.637347144872, 2796.80422370434, 4661.394018777562, 4723.267893476516, 4799.208130658446, 4805.879853003672, 4839.588634966028, 4803.759812009403, 4842.080004799086, 4862.124817532843, 4957.033378491195, 4963.55328020479, 4381.5837495438045, 4486.2597671384265, 4515.774211289438, 4518.638508919278, 4550.135474259897, 4346.717463364871, 4448.866534003985, 4479.10417916418, 4514.932276015862, 4568.314752787075, 4382.846600369004, 4447.844325448594, 4470.888227794315, 4483.820647174141, 4506.909861802778, 4458.665600080007, 4498.415206023229, 4504.279315309567, 4522.525134860825, 4551.180787458256, 4296.978515107405, 4387.407699960497, 4453.042595841909, 4472.664550158718, 4479.619232365253, 4703.482616912137, 4705.952940470585, 4749.833755818564, 4753.928691069636, 4800.159972004885, 5173.405058418255, 5174.197999310113, 5182.144946083891, 5190.455002224788, 5254.605904557174, 5012.27322038306, 5205.115130427836, 5206.323177986837, 5214.113600687892, 5228.398734145584, 4750.07373562159, 4808.374911261549, 4832.275158726149, 4835.734034628094, 4876.975835074603, 5376.946230537723, 5423.322084739408, 5430.0768869292315, 5432.29380180574, 5438.320209973754, 5150.510701483353, 5175.990681817009, 5205.635605507654, 5205.895882082337, 5255.211718242294, 5011.448740638527, 5162.5611822994715, 5220.582353411718, 5290.65610735301, 5357.035733567917, 5222.0, 5223.0, 5234.869128271824, 5243.764030618631, 5263.34208223972, 4939.2838038484215, 5141.845744627667, 5170.0, 5178.352705911761, 5215.400228973641, 4195.244855925902, 4288.163808057461, 4309.07354918694, 4309.504406993173, 4349.847755328548, 3779.3952967525065, 3820.3505404081375, 3830.8276127574327, 3858.7105967052585, 3865.2269546090893, 4395.055063161436, 4534.13851368239, 4547.8635640930825, 4554.908901821945, 4604.332371806069, 5159.432462429129, 5170.353705786777, 5229.816956406507, 5236.73816309183, 5240.030594340059, 4483.08096840147, 4491.595756381941, 4493.775311234491, 4511.616512596466, 4552.544745525421, 4433.955660443419, 4494.191045611756, 4642.187617166982, 4649.139909116824, 4673.439187297546, 4870.245112007645, 4897.559219670246, 4937.456879743298, 4944.975275123746, 4970.9254361183885, 5268.6575372600655, 5302.973485132549, 5307.920381194208, 5312.920306195333, 5367.651102678314, 4783.162946484282, 4887.560119589254, 4887.804487820589, 4990.051890141007, 5007.749612519432, 5010.724410157331, 5101.92347114801, 5102.79588816458, 5111.514406131411, 5180.7409629519125, 5282.920756188737, 5283.656562323436, 5290.65610735301, 5292.0, 5293.788248470172, 5052.59579233653, 5082.974585127051, 5094.414142373675, 5103.77033033507, 5133.409657889241, 4855.393075865517, 4940.851774446773, 4972.726500042532, 5010.3737032870895, 5059.822906198413, 4939.43196532389, 4972.3038774572315, 4976.477469865612, 4997.5002499749735, 5030.698158110525, 4859.635527335393, 5124.256982737556, 5127.077126117335, 5134.12719837636, 5141.665791723675, 4917.6311776616185, 4933.186024305949, 4948.6535942485125, 4957.132501812096, 4960.950390496048], "unit": "ms", "name": "dojo.html", "value": 4768.52001876651}, {"lowerIsBetter": false, "replicates": [543.8367540633527, 563.0512586292101, 585.037613126407, 589.6845187824512, 592.1532208941213, 33739.49390759137, 33957.98126056219, 34033.659663403356, 34092.0, 34351.31297374054, 35671.82164089182, 36008.27983440329, 36125.27749445009, 36140.0, 36162.0, 7962.044554653449, 8039.437239393244, 8071.798205044892, 8083.474574152661, 8087.797805054862, 7897.328727058179, 7957.244061814118, 8005.5997200140055, 8014.919850801505, 8018.599070046504, 7977.082635496905, 7985.760427187193, 8005.039395272546, 8064.959675201616, 8074.232947869943, 7983.281504664579, 8006.15935326794, 8015.158408367125, 8036.156203598625, 8085.110637829834, 7756.961215193945, 7863.252990965849, 7869.252421019994, 7893.289603935616, 7913.881291780628, 36829.815850920844, 37178.0, 37211.0, 37284.62715372839, 37291.0, 2991.491446454108, 3194.297254603983, 3210.6307774605984, 3363.899083027513, 3377.105067157205, 27582.862085689645, 27646.0, 28063.57904631432, 28106.859465702746, 28121.156365309074, 3394.7114495267933, 3413.35146322198, 3477.374072666919, 3479.407182519076, 3488.1977145256733, 215133.0, 215929.0, 216383.0, 216602.0, 216691.0, 49131.612890324745, 52192.478075218765, 52405.7379713099, 52470.21294680583, 52492.0, 45605.0, 63067.0, 63940.36059639344, 64036.0, 64234.0, 13774.93112534451, 14053.22707251111, 14058.43766249359, 14135.575932722035, 14203.502877399242, 9975.501224938724, 10142.18862490999, 10142.391456512632, 10183.0, 10195.490225488844, 18473.7228941566, 18490.167942442622, 18495.352662657013, 18615.534611634546, 18722.344717934808, 7341.74303899361, 7647.808804779814, 7677.117131529945, 7719.150893401721, 7747.147813740484, 867.8134201146657, 901.5402144906145, 915.922146617545, 928.8885333759993, 1010.3634710132569, 25901.8704906478, 25912.0, 25996.35009124787, 26003.21990340293, 26201.0, 937.9588656591178, 943.3773709351794, 977.1596427072711, 1083.2904447586843, 1096.4736926275432, 12212.084093693009, 13835.654108647364, 14020.158790472604, 14343.0, 14464.13215207091, 274140.0, 274738.0, 274968.0, 275557.0, 276711.0, 45443.54556454459, 45523.31715024211, 45604.8598785033, 45666.31500527495, 45708.3143752844, 1220.7985682362312, 1227.7298994221258, 1242.2546472116658, 1248.2385744695728, 1252.8183413405188, 26363.20910372692, 26401.207963761117, 26599.33501662474, 26770.732292676825, 26970.595441068006, 38736.61263387443, 38967.2206555873, 39161.0, 39221.2155756889, 39243.80378098091, 258589.0, 259325.0, 259350.0, 259379.0, 259921.0, 27514.44971100607, 28372.43255134927, 28858.567121493616, 28906.85546572338, 29058.128256152348, 34334.65665343314, 34433.48349774806, 34513.827430862686, 35331.82334088313, 35336.46995295021, 32486.0, 32826.83586582052, 32952.34095318128, 33187.83406082954, 33619.49570756392, 32352.676473234966, 32959.67040329662, 32994.67005329916, 33038.66961330356, 33161.50257746184, 31726.0, 32315.19212019718, 32453.51319730159, 32726.181845454055, 32741.18147046343, 27762.722372776014, 29619.703802961696, 29862.85068574643, 29879.850600746857, 30489.237769055064, 22083.889580551993, 22573.661395079416, 22748.09007639742, 22859.428514287276, 22928.338989123076], "unit": "ms", "name": "ext.html", "value": 16756.114333695197}, {"lowerIsBetter": false, "replicates": [305.8317925141172, 311.9984400077999, 314.0719174838353, 316.55523988795744, 319.5797526252979, 14182.57452276432, 14829.925850370746, 15219.0, 15752.212389380515, 16448.342066317335, 10068.49657517123, 10303.845442318372, 12496.625101246955, 15154.090754554734, 15217.315220815062, 4540.18276710192, 4570.0859828034445, 4627.768611569425, 4653.790014596196, 4670.439547254335, 4625.676202665814, 4656.837010704626, 4660.16117098922, 4669.0, 4684.320773487842, 4691.671582989192, 4699.248120300753, 4717.127331443694, 4740.810367585293, 4768.117898188829, 5336.706481143536, 5492.148716948879, 5496.917546236789, 5498.202760599731, 5510.0, 4802.59177969873, 4820.517948205186, 5088.160453525164, 5093.159628661267, 5106.4382917879, 10970.122390208764, 11119.388433636146, 11217.439128043647, 13577.389017494237, 17680.0, 1821.1258595874056, 1854.573448106943, 1871.1860340751816, 1879.746234258385, 1972.0534143611146, 9074.546272686406, 9335.0, 9422.293328000427, 9784.217262619044, 10524.78950420995, 1733.8352856478614, 1768.2661695396396, 1798.3436045843173, 1802.4322338463342, 1857.9814201857944, 50410.24384634233, 53882.0, 53989.0, 56219.43780562224, 59771.70114149401, 9634.373765705206, 9882.851757223647, 9936.950315248521, 10005.549750261256, 10071.5467803949, 11286.266392684449, 11722.94138529302, 11730.70673233176, 12464.376781161087, 12479.875201248053, 6699.564528305645, 6790.93209067903, 6817.795466136024, 6848.14398200225, 6916.619585922823, 6670.5664131832245, 6673.599584024877, 6698.665066746643, 6704.597724136567, 6708.228553716288, 4003.559608443069, 4005.5794141615293, 4026.939595906064, 4079.592040795956, 4110.403991421227, 1689.729643257073, 1725.1115675427166, 1750.8511776498885, 1774.8846324989092, 1814.383109742694, 841.1126261793744, 865.7143142762873, 892.0900681305033, 905.0587389115246, 915.7390143808982, 15281.38874445032, 15311.92344038295, 15609.531714048597, 15724.528264152093, 16167.272472738756, 890.7906641939139, 897.3225214962791, 915.8076803871129, 933.1834644685899, 954.022127319503, 6757.729690812411, 8819.823603527893, 8867.778305542413, 9000.36997410175, 9209.171174594185, 493632.0, 497510.0, 512870.0, 520686.0, 520792.0, 65345.673271633335, 73666.0, 74808.62595686987, 74984.25015749772, 75295.24704752992, 873.9650413983496, 889.0620395482828, 897.0177655467253, 899.2311573604604, 900.8423525882944, 13676.316184190551, 13999.300034998412, 14158.716825663636, 14205.786913196516, 14387.784183237469, 24817.883195256618, 26244.475110498064, 29785.702142978294, 30398.848005759828, 30721.0, 38053.809730951165, 39217.0, 39585.2082958345, 40020.0, 40969.180616388105, 8430.662773489237, 8524.70163544273, 8678.132186781271, 8682.696105636272, 8683.478991260545, 14064.929675351557, 15325.233738312816, 16363.672726545641, 16579.336826527287, 16690.83164178496, 13271.203727775977, 13482.19106853592, 13637.386317615532, 13811.51659691906, 14547.927260363631, 13685.863141368856, 13832.0, 13943.721125577229, 14257.287135643384, 14291.285435727965, 14079.155250684991, 14134.717305654034, 14354.712905742035, 14613.488527901472, 14810.925945370203, 8755.51844648525, 8997.505137217255, 9169.220616247694, 9247.537623118682, 9270.490123043297, 9544.42733435996, 9733.951330243304, 13638.863611363759, 14309.141451512942, 14383.28083595795], "unit": "ms", "name": "jquery.html", "value": 8019.113812214316}, {"lowerIsBetter": false, "replicates": [1342.3355439057668, 1351.0, 1392.937317820698, 1605.4300723243248, 1686.2159096020348, 5705.51503122234, 6034.0, 6431.3890180432845, 6964.164300283966, 6974.930250697492, 6536.150300460945, 6745.291744366845, 6794.694238759255, 6799.966000169992, 6832.692528836202, 1982.2071171531431, 2004.1983206717284, 2007.0968064371018, 2015.7782643909159, 2025.625259327022, 2002.6895831146196, 2013.2349707111277, 2031.908564114611, 2033.4306394209646, 2046.1713006232499, 1968.507873031742, 1974.7136665183539, 2007.056683358819, 2014.1037238428905, 2017.515796208914, 2008.9899550502228, 2011.3463124484529, 2021.2925476083253, 2021.3733742539787, 2025.574629327843, 1994.4216177308708, 2002.1590931808676, 2011.5675129847007, 2022.2719820864477, 2028.198861449719, 6724.562903411263, 6764.188297404294, 6796.286389929036, 6799.830004249884, 6802.2857599951785, 3887.455756194135, 4001.8199181036925, 4018.3369743992207, 4018.5378681451716, 4020.1356708307853, 2531.190019193859, 2564.5896656534865, 2601.89592416305, 2656.2695258803983, 2663.3474798674256, 833.0669649991987, 835.5028757889107, 836.2891542189151, 873.3231745397304, 881.4755220643707, 9052.818943621156, 9095.181433670936, 9125.224355929753, 9135.36052476327, 9157.725268241897, 3708.8887333380044, 3714.517112775322, 3770.7549009314857, 3807.048237940515, 3810.714196435223, 7942.722004729807, 7946.324562412144, 7948.205179482121, 7968.163342848918, 7973.322267607203, 4129.256733787947, 4150.045489537363, 4154.896127596834, 4159.313713237282, 4174.123434078817, 3656.762310449812, 3741.9064523387133, 3759.774413535142, 3766.0, 3780.640839120334, 3038.6657467678538, 3040.0423866481988, 3064.728137822823, 3072.923176920595, 3113.8910138145056, 948.1229862377273, 951.0727041134838, 953.7424895278236, 958.8849338079475, 965.6089283839916, 941.8351788436996, 942.8774259346378, 1129.170060005895, 1149.7298134938283, 1153.878842721519, 6359.2368915729485, 6377.362263773585, 6382.074599183093, 6408.51936104794, 6441.774537891151, 442.0738552732021, 1085.1535802074395, 1099.4008265495324, 1108.1854836695022, 1130.6268931252666, 4868.464468908417, 4884.0, 4971.950280497149, 5032.723200224023, 5051.318072060299, 8014.2386473286115, 8113.7565873023905, 8131.14622964592, 8149.551774652333, 8189.099199088096, 7926.9603651982525, 7961.562114083781, 7978.0, 8027.719029834045, 8047.315978141924, 6357.205349331333, 6454.0, 6513.478921686254, 6538.640374779433, 6547.639879806657, 6142.14010038586, 6186.10301506288, 6210.627362358273, 6212.875742485216, 6215.0, 7160.391366733886, 7319.74380896666, 7404.444666649915, 7419.332260096618, 7461.962690186514, 7520.360769334668, 7522.533106044269, 7545.962270188614, 7565.205653406313, 7573.35626471756, 5199.844004679866, 5341.317484992215, 5755.050416681201, 5804.970975145097, 5878.441548052928, 6305.8108256752375, 6508.381703738138, 6525.0538671893255, 6534.411902928759, 6548.017797330439, 5929.140274660236, 6082.330943596289, 6084.756609735561, 6105.572609917263, 6186.81439556814, 5985.910211346746, 6087.634741915499, 6147.723352449061, 6189.473894718999, 6233.937660623335, 6101.145839582373, 6255.937440625536, 6259.749610015549, 6263.56155069159, 6271.43557079865, 5633.380328163817, 5701.0, 5719.685417302088, 5726.5418766499415, 5727.7422515986045, 5742.310922689304, 5768.048272035067, 5807.76768929255, 5808.564357673107, 5822.475977162076], "unit": "ms", "name": "mootools.html", "value": 3909.529291912381}, {"lowerIsBetter": false, "replicates": [286.4757493786371, 296.7729686789606, 297.43932686885216, 303.9832809195495, 304.82320254252534, 5537.698640819409, 5583.3579138399045, 5633.0, 5647.181158731982, 5805.0, 5568.5266752326, 5612.382637909826, 5632.577556683244, 5636.464535869086, 5637.379888212304, 4147.9585204148025, 4265.509466411356, 4270.338097594878, 4281.100968796556, 4282.957170428294, 4255.319148936171, 4258.829646814123, 4266.488021437432, 4271.060366719316, 4272.33778764292, 4199.45407097077, 4214.473190851144, 4214.578542145791, 4218.873433796991, 4247.575242475743, 4230.91538169238, 4231.196072746168, 4236.470441194866, 4245.511766146871, 4246.745195288293, 3678.0, 3678.1724112074835, 3689.335919534483, 3690.1697118148472, 3700.204456041937, 5251.212318152269, 5289.603279754034, 5406.54044406222, 5413.648112872651, 5421.0, 4848.248521479177, 4853.975730121362, 4858.222684370484, 4859.927101093486, 4864.683795553277, 5863.472287494146, 5872.412758724136, 5876.08920617305, 5907.970460147715, 5919.200907877467, 3846.615338466131, 3984.641382275609, 3985.880423587297, 3994.6804255659476, 3998.460207871929, 6059.0, 6191.2570491540855, 6203.348648391899, 6222.751089956397, 6233.87532249357, 4097.364908439196, 4107.034846810997, 4107.116969851496, 4108.4453598764385, 4109.383592461155, 4173.332266837291, 4173.353130264813, 4173.91652166961, 4174.91650166995, 4180.728252663567, 4734.337192792943, 4824.107540105022, 4824.662273640882, 4826.903461930741, 4834.903301934012, 5901.498372638373, 5904.675242861684, 5908.379620139824, 5908.852278693067, 5910.970445147746, 1468.2585294426246, 1491.2320155120121, 1492.0674578388507, 1492.0674578388507, 1493.9626509337354, 980.519545422752, 993.4704940248861, 1001.4341896828414, 1006.6778630838207, 1010.2170817616407, 5118.846434606968, 5149.9742501287255, 5152.201408781645, 5162.045021671003, 5164.122099243138, 6079.331273559905, 6112.419320164578, 6131.816045518642, 6142.57002009855, 6143.047827586731, 5108.386993560796, 5131.589472842164, 5148.871278218075, 5162.896742065138, 5167.018266529422, 3265.804051756902, 3300.5379246905454, 3325.9667403325657, 3338.0987133473827, 3351.977646817695, 5674.2339784129435, 5761.53907687384, 5767.04843700793, 5769.624974376652, 5789.739461724233, 6307.905381419282, 6318.304986451487, 6325.209348831396, 6346.809595712136, 6365.267994180728, 5748.885022299531, 5759.452851979056, 5764.654120752768, 5780.797672081457, 5794.536437085023, 6111.205543279345, 6113.419225173601, 6150.938490615036, 6153.630782153085, 6155.538334625011, 5882.5293976482635, 6028.125921741235, 6040.395960403925, 6064.818055458343, 6071.332153463027, 5821.825345239649, 5828.970855145697, 5837.5038121758425, 5843.30544142194, 5848.0, 4071.7353372031907, 4096.2831504486, 4111.938320925129, 4114.855980040684, 4121.9381709274985, 5984.251968503937, 6134.754609815736, 6159.199304090619, 6160.229971253593, 6163.013917773134, 5914.674692891932, 5927.051671732502, 5932.406759324033, 5943.078822782476, 5953.642781433128, 5941.7623295067715, 5950.553708471795, 5954.0, 5965.224520812267, 5977.820665380045, 5642.125470552071, 5803.47768700819, 5812.21535092757, 5830.9416905832095, 5868.94131058701, 5988.431099045583, 6027.0, 6030.698465076816, 6034.426729460694, 6038.456538911519, 5777.768889244551, 5838.32859221195, 5839.211706419579, 5846.970765146317, 5861.0], "unit": "ms", "name": "prototype.html", "value": 4390.600690165032}, {"lowerIsBetter": false, "replicates": [695.1484431571324, 733.9633018349081, 749.760076775432, 753.6796861333931, 768.1511929318103, 11432.542698292069, 11626.709332266697, 11766.588169414083, 11836.704082397944, 11841.585544505944, 11787.0, 11931.0, 11940.22388544744, 11949.283043017404, 11971.940140299308, 771.5216565729241, 779.6959185917497, 784.8940393046922, 787.7400457848896, 788.2039140468111, 773.1765669561927, 785.9921400786005, 791.1653205867807, 792.0890975378333, 793.2503783924194, 812.553095797312, 820.1019883227856, 822.9094799572042, 823.8970128733908, 825.3067423364373, 812.7561731480532, 813.446856137826, 815.3517953227139, 815.9836803263931, 816.4896939412837, 602.0187095035064, 604.7671646416161, 605.2585582661249, 605.6003037994902, 606.9453749162552, 12572.874271257262, 12724.236545807282, 12748.681282967907, 12761.106722529426, 12808.871911280861, 10909.127269818395, 11237.381943993078, 11262.436878156059, 11302.208845380826, 11355.432228388547, 8542.871856922151, 9124.88259157858, 9421.293402994734, 9429.622815087389, 9473.952630236805, 3123.1879711275005, 3123.3440977394775, 3164.256399746058, 3175.333180032196, 3179.998300535324, 44128.558714412764, 44614.77692611516, 44635.55364446379, 44646.33030504545, 44724.552754472366, 9436.716898493056, 9598.616055357708, 9664.516774161264, 9691.806163876683, 10060.597576096874, 15997.60005999836, 16229.431969881234, 16263.0, 16689.415870444718, 16945.49163525096, 6213.424958659661, 6321.273053598895, 6324.71538780756, 6406.5515413920575, 6507.967460162668, 3619.348517266917, 3698.334299826003, 3743.47591337213, 3784.2242340320167, 3825.827837747308, 2563.910263140781, 2593.494268617639, 2616.3459135216194, 2624.593188055854, 2634.1702363755358, 485.3302442629149, 489.870184401134, 495.28678702668043, 499.8175665881927, 505.3152977715143, 455.317024463305, 458.6812165544914, 478.7558345243881, 504.53834741212114, 598.0938877600439, 7872.685092596232, 8183.427160098736, 8682.522461264565, 8845.867311990325, 8935.419197752126, 547.7671989404566, 549.8570371703386, 563.1749487001563, 570.1533223163682, 591.6804925340355, 3796.7532110412735, 3874.5737968823405, 3926.2540117377607, 3946.644801967837, 4129.69027322952, 49058.75470622695, 49242.0, 49467.50532494701, 54084.729576352656, 55007.44992550103, 45017.324740128926, 45034.54965450303, 45344.0, 45431.772841135586, 45695.31457028147, 42960.57039429628, 43684.34473482901, 43997.78001110038, 44148.77925610352, 44634.10731785411, 8217.506949582805, 8243.25810677042, 8639.611217495101, 8640.827183456422, 8832.116788321116, 31282.68717312889, 31583.526247105852, 31645.841770790998, 32431.0, 32575.67424325821, 36731.0, 36831.89504314875, 39081.609183908935, 40342.79828600956, 40768.388474172316, 10229.948850255701, 10303.639372621923, 10318.845217321596, 10360.53377598025, 10441.895581044093, 10678.57285708563, 10845.295055821347, 10857.40284284372, 11628.360440175871, 11974.880251197377, 10299.588016479256, 10513.106385957279, 10549.736256593647, 10652.414117223318, 10994.505247263733, 10716.732081697708, 10758.784824303626, 10949.726256843642, 11019.393933333744, 11259.887401125883, 9935.850962235716, 10851.891481085087, 11133.05369043608, 11157.497912594115, 11171.385573793194, 9087.227585655293, 9372.672472864126, 9452.574634141618, 9543.952280238555, 9869.950650246703, 8896.421732587361, 8985.955070224607, 9406.811863762823, 9474.526273686426, 9570.425774453555], "unit": "ms", "name": "yui.html", "value": 5798.898746392996}], "name": "dromaeo_css", "value": 6321.015262770098}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 115.0, 115.0, 125.0, 113.0, 113.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [161.0, 133.0, 160.0, 161.0, 132.0, 158.0, 155.0, 145.0, 161.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 164.0, 161.0, 163.0, 164.0, 174.0, 163.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 72.0, 126.0, 71.0, 72.0, 71.0, 74.0, 107.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [97.0, 93.0, 129.0, 93.0, 94.0, 95.0, 129.0, 94.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 151.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 89.0, 74.0, 73.0, 73.0, 74.0, 73.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 75.2}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 92.0, 84.0, 83.0, 83.0, 94.0, 95.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [137.0, 131.0, 139.0, 136.0, 122.0, 130.0, 127.0, 123.0, 129.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [135.0, 146.0, 152.0, 151.0, 155.0, 146.0, 151.0, 145.0, 150.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 69.0, 69.0, 75.0, 70.0, 73.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1547.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.56291390728478], "unit": "score", "name": "Richards", "value": 213.2240799999999}, {"lowerIsBetter": false, "replicates": [190.4036557501904], "unit": "score", "name": "DeltaBlue", "value": 347.251736}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [1084.5986984815618], "unit": "score", "name": "RayTrace", "value": 682.2698579999999}, {"lowerIsBetter": false, "replicates": [713.2667617689016], "unit": "score", "name": "Earley", "value": 934.3811260000003}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [27944.444444444445], "unit": "score", "name": "RegExp", "value": 32.59986083499008}, {"lowerIsBetter": false, "replicates": [613.8735420503376], "unit": "score", "name": "Splay", "value": 132.748839}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21093.566938610355}]} 10:02:34 INFO - RETURN: dromaeo_css: 6321.01 10:02:34 INFO - RETURN: kraken: 1547.60 10:02:34 INFO - RETURN: v8_7: 21093.57 10:02:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21093.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1547.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6321.01"}}} 10:02:34 INFO - Return code: 0 10:02:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:02:34 INFO - # TBPL SUCCESS # 10:02:34 INFO - Running post-action listener: _resource_record_post_action 10:02:34 INFO - Running post-run listener: _resource_record_post_run 10:02:35 INFO - Total resource usage - Wall time: 1333s; CPU: 14.0%; Read bytes: 53248; Write bytes: 517857280; Read time: 5680; Write time: 7636552 10:02:35 INFO - install - Wall time: 19s; CPU: 28.0%; Read bytes: 0; Write bytes: 115179520; Read time: 0; Write time: 982200 10:02:35 INFO - run-tests - Wall time: 1314s; CPU: 14.0%; Read bytes: 53248; Write bytes: 390291456; Read time: 5680; Write time: 6645180 10:02:35 INFO - Running post-run listener: _upload_blobber_files 10:02:35 INFO - Blob upload gear active. 10:02:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:02:35 INFO - Copying logs to upload dir... 10:02:35 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1376.600236 ========= master_lag: 8.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-11-26 10:02:43.390008) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 10:02:43.393463) ========= 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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009996 build_url: 'https://queue.taskcluster.net/v1/task/6Yx9Li06QBGmsLpZ0NfV4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 10:02:43.416534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:02:43.416838) ========= 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=256b35f542ca8bede9e27f1f00000291-1448559563.459400-852553416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 10:02:43.467044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 10:02:43.467366) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 10:02:43.467656) ========= ========= Total master_lag: 8.27 =========