builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1448731540.9 results: success (0) buildid: 20151128084531 builduid: 707cba0418554f1bb29daf5ba2e7baf9 revision: 959df62d450d8d8d51252ba9c292b668835ac3e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.899063) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.899547) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.899832) ========= 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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007512 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.921551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.921934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.934610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.934884) ========= 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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.983864) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.984174) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.984525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:40.984845) ========= 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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-28 09:25:41-- 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% 222M=0s 2015-11-28 09:25:41 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123523 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:41.120922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:41.121236) ========= 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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022543 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:41.170767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-28 09:25:41.171130) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 959df62d450d8d8d51252ba9c292b668835ac3e7 --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 959df62d450d8d8d51252ba9c292b668835ac3e7 --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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-28 09:25:41,688 truncating revision to first 12 chars 2015-11-28 09:25:41,688 Setting DEBUG logging. 2015-11-28 09:25:41,688 attempt 1/10 2015-11-28 09:25:41,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/959df62d450d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-28 09:25:42,430 unpacking tar archive at: fx-team-959df62d450d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.032402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-28 09:25:42.216046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:42.216364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:42.225401) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:42.225653) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 09:25:42.226072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-28 09:25:42.226370) ========= /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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:25:42 INFO - MultiFileLogger online at 20151128 09:25:42 in /builds/slave/test 09:25:42 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:25:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:25:42 INFO - {'append_to_log': False, 09:25:42 INFO - 'base_work_dir': '/builds/slave/test', 09:25:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:25:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:25:42 INFO - 'branch': 'Fx-Team-Non-PGO', 09:25:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:42 INFO - 'config_files': ('talos/linux_config.py',), 09:25:42 INFO - 'default_actions': ('clobber', 09:25:42 INFO - 'read-buildbot-config', 09:25:42 INFO - 'download-and-extract', 09:25:42 INFO - 'populate-webroot', 09:25:42 INFO - 'create-virtualenv', 09:25:42 INFO - 'install', 09:25:42 INFO - 'run-tests'), 09:25:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:42 INFO - 'download_minidump_stackwalk': True, 09:25:42 INFO - 'download_symbols': 'ondemand', 09:25:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:42 INFO - 'installer_path': 'installer.exe', 09:25:42 INFO - 'log_level': 'info', 09:25:42 INFO - 'log_name': 'talos', 09:25:42 INFO - 'log_to_console': True, 09:25:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:25:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:25:42 INFO - 'opt_config_files': (), 09:25:42 INFO - 'pip_index': False, 09:25:42 INFO - 'sps_profile': False, 09:25:42 INFO - 'sps_profile_interval': 0, 09:25:42 INFO - 'suite': 'dromaeojs-e10s', 09:25:42 INFO - 'system_bits': '64', 09:25:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:42 INFO - 'title': 'talos-linux64-ix-033', 09:25:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:42 INFO - 'use_talos_json': True, 09:25:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:25:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:42 INFO - 'work_dir': 'build'} 09:25:42 INFO - ##### 09:25:42 INFO - ##### Running clobber step. 09:25:42 INFO - ##### 09:25:42 INFO - Running pre-action listener: _resource_record_pre_action 09:25:42 INFO - Running main action method: clobber 09:25:42 INFO - rmtree: /builds/slave/test/build 09:25:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:25:43 INFO - Running post-action listener: _resource_record_post_action 09:25:43 INFO - ##### 09:25:43 INFO - ##### Running read-buildbot-config step. 09:25:43 INFO - ##### 09:25:43 INFO - Running pre-action listener: _resource_record_pre_action 09:25:43 INFO - Running main action method: read_buildbot_config 09:25:43 INFO - Using buildbot properties: 09:25:43 INFO - { 09:25:43 INFO - "properties": { 09:25:43 INFO - "buildnumber": 743, 09:25:43 INFO - "product": "firefox", 09:25:43 INFO - "script_repo_revision": "production", 09:25:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:25:43 INFO - "repository": "", 09:25:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:25:43 INFO - "buildid": "20151128084531", 09:25:43 INFO - "slavename": "talos-linux64-ix-033", 09:25:43 INFO - "pgo_build": "False", 09:25:43 INFO - "basedir": "/builds/slave/test", 09:25:43 INFO - "project": "", 09:25:43 INFO - "platform": "ubuntu64_hw", 09:25:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:25:43 INFO - "slavebuilddir": "test", 09:25:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:25:43 INFO - "branch": "fx-team", 09:25:43 INFO - "repo_path": "integration/fx-team", 09:25:43 INFO - "stage_platform": "linux64", 09:25:43 INFO - "builduid": "707cba0418554f1bb29daf5ba2e7baf9", 09:25:43 INFO - "revision": "959df62d450d8d8d51252ba9c292b668835ac3e7" 09:25:43 INFO - }, 09:25:43 INFO - "sourcestamp": { 09:25:43 INFO - "repository": "", 09:25:43 INFO - "hasPatch": false, 09:25:43 INFO - "project": "", 09:25:43 INFO - "branch": "fx-team-linux64-talos", 09:25:43 INFO - "changes": [ 09:25:43 INFO - { 09:25:43 INFO - "category": null, 09:25:43 INFO - "files": [ 09:25:43 INFO - { 09:25:43 INFO - "url": null, 09:25:43 INFO - "name": "https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:25:43 INFO - } 09:25:43 INFO - ], 09:25:43 INFO - "repository": "", 09:25:43 INFO - "rev": "959df62d450d8d8d51252ba9c292b668835ac3e7", 09:25:43 INFO - "who": "markcapella@twcny.rr.com", 09:25:43 INFO - "when": 1448731506, 09:25:43 INFO - "number": 6717497, 09:25:43 INFO - "comments": "Bug 1218072 - crash in nsTextEditorState::FinishedRestoringSelection, r=smaug", 09:25:43 INFO - "project": "", 09:25:43 INFO - "at": "Sat 28 Nov 2015 09:25:06", 09:25:43 INFO - "branch": "fx-team-linux64-talos", 09:25:43 INFO - "revlink": "", 09:25:43 INFO - "properties": [ 09:25:43 INFO - [ 09:25:43 INFO - "buildid", 09:25:43 INFO - "20151128084531", 09:25:43 INFO - "Change" 09:25:43 INFO - ], 09:25:43 INFO - [ 09:25:43 INFO - "builduid", 09:25:43 INFO - "707cba0418554f1bb29daf5ba2e7baf9", 09:25:43 INFO - "Change" 09:25:43 INFO - ], 09:25:43 INFO - [ 09:25:43 INFO - "pgo_build", 09:25:43 INFO - "False", 09:25:43 INFO - "Change" 09:25:43 INFO - ] 09:25:43 INFO - ], 09:25:43 INFO - "revision": "959df62d450d8d8d51252ba9c292b668835ac3e7" 09:25:43 INFO - } 09:25:43 INFO - ], 09:25:43 INFO - "revision": "959df62d450d8d8d51252ba9c292b668835ac3e7" 09:25:43 INFO - } 09:25:43 INFO - } 09:25:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:25:43 INFO - Running post-action listener: _resource_record_post_action 09:25:43 INFO - ##### 09:25:43 INFO - ##### Running download-and-extract step. 09:25:43 INFO - ##### 09:25:43 INFO - Running pre-action listener: _resource_record_pre_action 09:25:43 INFO - Running main action method: download_and_extract 09:25:43 INFO - mkdir: /builds/slave/test/build/tests 09:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:43 INFO - https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/test_packages.json 09:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/test_packages.json 09:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:25:43 INFO - Downloaded 1302 bytes. 09:25:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:25:43 INFO - Using the following test package requirements: 09:25:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:25:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:43 INFO - u'jsshell-linux-x86_64.zip'], 09:25:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:25:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:25:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:25:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:25:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:25:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:43 INFO - https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:45 INFO - Downloaded 21517181 bytes. 09:25:45 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:25:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:25:45 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:25:46 INFO - Return code: 0 09:25:46 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:25:46 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:25:46 INFO - https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:49 INFO - Downloaded 21517181 bytes. 09:25:49 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:25:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:25:49 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:25:50 INFO - Return code: 0 09:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:50 INFO - https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:25:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:51 INFO - Downloaded 11131728 bytes. 09:25:51 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:25:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:51 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:25:51 INFO - Return code: 0 09:25:51 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:25:51 INFO - https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:25:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:25:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:25:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HxB4MXjKQQuA-K1OAu9-yw/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:25:54 INFO - Downloaded 56880988 bytes. 09:25:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:25:54 INFO - mkdir: /builds/slave/test/properties 09:25:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:25:54 INFO - Writing to file /builds/slave/test/properties/build_url 09:25:54 INFO - Contents: 09:25:54 INFO - build_url:https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - Running post-action listener: set_extra_try_arguments 09:25:54 INFO - ##### 09:25:54 INFO - ##### Running populate-webroot step. 09:25:54 INFO - ##### 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: populate_webroot 09:25:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:25:54 INFO - '../fennec_ids.txt'], 09:25:54 INFO - 'tests': ['tcheck2']}, 09:25:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:54 INFO - '--tppagecycles', 09:25:54 INFO - '7'], 09:25:54 INFO - 'tests': ['tsvgm']}}, 09:25:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:25:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:25:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:25:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'tests': ['damp', 'tps']}, 09:25:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['damp', 'tps']}, 09:25:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:25:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:54 INFO - 'other': {'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other_l64': {'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'other_nol64': {'tests': ['a11yr', 09:25:54 INFO - 'ts_paint', 09:25:54 INFO - 'tpaint', 09:25:54 INFO - 'sessionrestore', 09:25:54 INFO - 'sessionrestore_no_auto_restore']}, 09:25:54 INFO - 'svgr': {'tests': ['tsvgx', 09:25:54 INFO - 'tsvgr_opacity', 09:25:54 INFO - 'tart', 09:25:54 INFO - 'tscrollx', 09:25:54 INFO - 'cart']}, 09:25:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tsvgx', 09:25:54 INFO - 'tsvgr_opacity', 09:25:54 INFO - 'tart', 09:25:54 INFO - 'tscrollx', 09:25:54 INFO - 'cart']}, 09:25:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'tests': ['tp5o']}, 09:25:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s'], 09:25:54 INFO - 'tests': ['tp5o']}, 09:25:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--xperf_path', 09:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:54 INFO - 'tests': ['tp5n']}, 09:25:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:54 INFO - 'talos_options': ['--e10s', 09:25:54 INFO - '--xperf_path', 09:25:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:54 INFO - 'tests': ['tp5n']}}, 09:25:54 INFO - 'talos.zip': {'path': '', 09:25:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:54 INFO - Running post-action listener: _resource_record_post_action 09:25:54 INFO - ##### 09:25:54 INFO - ##### Running create-virtualenv step. 09:25:54 INFO - ##### 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: create_virtualenv 09:25:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:25: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:25:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:25:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:54 INFO - Using real prefix '/usr' 09:25:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:25:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:56 INFO - Installing pip.................done. 09:25:56 INFO - Return code: 0 09:25:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:25:56 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:25:56 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:25:56 INFO - Using env: {'DISPLAY': ':0', 09:25:56 INFO - 'HOME': '/home/cltbld', 09:25:56 INFO - 'LANG': 'en_US.UTF-8', 09:25:56 INFO - 'LANGUAGE': 'en_US:en', 09:25:56 INFO - 'LOGNAME': 'cltbld', 09:25:56 INFO - 'MAIL': '/var/mail/cltbld', 09:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:56 INFO - 'MOZ_NO_REMOTE': '1', 09:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:56 INFO - 'NO_EM_RESTART': '1', 09:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:56 INFO - 'PWD': '/builds/slave/test', 09:25:56 INFO - 'SHELL': '/bin/bash', 09:25:56 INFO - 'SHLVL': '1', 09:25:56 INFO - 'TERM': 'linux', 09:25:56 INFO - 'TMOUT': '86400', 09:25:56 INFO - 'USER': 'cltbld', 09:25:56 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:56 INFO - '_': '/tools/buildbot/bin/python'} 09:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:56 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:25:56 INFO - Cleaning up... 09:25:57 INFO - Return code: 0 09:25:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:57 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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:25:57 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:25:57 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:25:57 INFO - Using env: {'DISPLAY': ':0', 09:25:57 INFO - 'HOME': '/home/cltbld', 09:25:57 INFO - 'LANG': 'en_US.UTF-8', 09:25:57 INFO - 'LANGUAGE': 'en_US:en', 09:25:57 INFO - 'LOGNAME': 'cltbld', 09:25:57 INFO - 'MAIL': '/var/mail/cltbld', 09:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:57 INFO - 'MOZ_NO_REMOTE': '1', 09:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:57 INFO - 'NO_EM_RESTART': '1', 09:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:57 INFO - 'PWD': '/builds/slave/test', 09:25:57 INFO - 'SHELL': '/bin/bash', 09:25:57 INFO - 'SHLVL': '1', 09:25:57 INFO - 'TERM': 'linux', 09:25:57 INFO - 'TMOUT': '86400', 09:25:57 INFO - 'USER': 'cltbld', 09:25:57 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:57 INFO - '_': '/tools/buildbot/bin/python'} 09:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:57 INFO - Downloading/unpacking psutil>=0.7.1 09:25:57 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:25:57 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:25:57 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:25:57 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:25:57 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:25:57 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:25:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:25:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:58 INFO - Installing collected packages: psutil 09:25:58 INFO - Running setup.py install for psutil 09:25:59 INFO - building 'psutil._psutil_linux' extension 09:25:59 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:25:59 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:25:59 INFO - building 'psutil._psutil_posix' extension 09:25:59 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:25:59 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:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:59 INFO - Successfully installed psutil 09:25:59 INFO - Cleaning up... 09:25:59 INFO - Return code: 0 09:25:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:25:59 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:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:59 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:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:59 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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:25:59 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:25:59 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:25:59 INFO - Using env: {'DISPLAY': ':0', 09:25:59 INFO - 'HOME': '/home/cltbld', 09:25:59 INFO - 'LANG': 'en_US.UTF-8', 09:25:59 INFO - 'LANGUAGE': 'en_US:en', 09:25:59 INFO - 'LOGNAME': 'cltbld', 09:25:59 INFO - 'MAIL': '/var/mail/cltbld', 09:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:59 INFO - 'MOZ_NO_REMOTE': '1', 09:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:59 INFO - 'NO_EM_RESTART': '1', 09:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:59 INFO - 'PWD': '/builds/slave/test', 09:25:59 INFO - 'SHELL': '/bin/bash', 09:25:59 INFO - 'SHLVL': '1', 09:25:59 INFO - 'TERM': 'linux', 09:25:59 INFO - 'TMOUT': '86400', 09:25:59 INFO - 'USER': 'cltbld', 09:25:59 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:59 INFO - '_': '/tools/buildbot/bin/python'} 09:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:25:59 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:25:59 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:25:59 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:25:59 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:25:59 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:25:59 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:26:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:26:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:01 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:26:01 INFO - Installing collected packages: mozsystemmonitor 09:26:01 INFO - Running setup.py install for mozsystemmonitor 09:26:01 INFO - Successfully installed mozsystemmonitor 09:26:01 INFO - Cleaning up... 09:26:01 INFO - Return code: 0 09:26:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:26:01 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:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:01 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:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:01 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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:26:01 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:26:01 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:26:01 INFO - Using env: {'DISPLAY': ':0', 09:26:01 INFO - 'HOME': '/home/cltbld', 09:26:01 INFO - 'LANG': 'en_US.UTF-8', 09:26:01 INFO - 'LANGUAGE': 'en_US:en', 09:26:01 INFO - 'LOGNAME': 'cltbld', 09:26:01 INFO - 'MAIL': '/var/mail/cltbld', 09:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:01 INFO - 'MOZ_NO_REMOTE': '1', 09:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:01 INFO - 'NO_EM_RESTART': '1', 09:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:01 INFO - 'PWD': '/builds/slave/test', 09:26:01 INFO - 'SHELL': '/bin/bash', 09:26:01 INFO - 'SHLVL': '1', 09:26:01 INFO - 'TERM': 'linux', 09:26:01 INFO - 'TMOUT': '86400', 09:26:01 INFO - 'USER': 'cltbld', 09:26:01 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:01 INFO - '_': '/tools/buildbot/bin/python'} 09:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:03 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26: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:26: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:26: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:26: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:26: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:26: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:26:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:26:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26: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:26: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:26: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:26: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:26: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:26: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:26:04 INFO - Downloading docopt-0.6.1.tar.gz 09:26:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:04 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:04 INFO - Running setup.py install for blobuploader 09:26:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:26:04 INFO - Running setup.py install for requests 09:26:04 INFO - Running setup.py install for docopt 09:26:04 INFO - Successfully installed blobuploader requests docopt 09:26:04 INFO - Cleaning up... 09:26:04 INFO - Return code: 0 09:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:04 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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:26:04 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:26:04 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:26:04 INFO - Using env: {'DISPLAY': ':0', 09:26:04 INFO - 'HOME': '/home/cltbld', 09:26:04 INFO - 'LANG': 'en_US.UTF-8', 09:26:04 INFO - 'LANGUAGE': 'en_US:en', 09:26:04 INFO - 'LOGNAME': 'cltbld', 09:26:04 INFO - 'MAIL': '/var/mail/cltbld', 09:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:04 INFO - 'MOZ_NO_REMOTE': '1', 09:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:04 INFO - 'NO_EM_RESTART': '1', 09:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:04 INFO - 'PWD': '/builds/slave/test', 09:26:04 INFO - 'SHELL': '/bin/bash', 09:26:04 INFO - 'SHLVL': '1', 09:26:04 INFO - 'TERM': 'linux', 09:26:04 INFO - 'TMOUT': '86400', 09:26:04 INFO - 'USER': 'cltbld', 09:26:04 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:04 INFO - '_': '/tools/buildbot/bin/python'} 09:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:05 INFO - Running setup.py (path:/tmp/pip-pWDWXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:05 INFO - Running setup.py (path:/tmp/pip-PGMF6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:05 INFO - Running setup.py (path:/tmp/pip-FHk2rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:05 INFO - Running setup.py (path:/tmp/pip-Tf5xAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:05 INFO - Running setup.py (path:/tmp/pip-UhaHWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:05 INFO - Running setup.py (path:/tmp/pip-VI_w_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:05 INFO - Running setup.py (path:/tmp/pip-n5KZH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:05 INFO - Running setup.py (path:/tmp/pip-6mPOoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:05 INFO - Running setup.py (path:/tmp/pip-tUAS9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:05 INFO - Running setup.py (path:/tmp/pip-rAKcww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:05 INFO - Running setup.py (path:/tmp/pip-w0qGAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:05 INFO - Running setup.py (path:/tmp/pip-gi7aXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:05 INFO - Running setup.py (path:/tmp/pip-UzYaFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:06 INFO - Running setup.py (path:/tmp/pip-NGYTxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:06 INFO - Running setup.py (path:/tmp/pip-DLzrJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:06 INFO - Running setup.py (path:/tmp/pip-tpZViz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:06 INFO - Running setup.py (path:/tmp/pip-CYuoI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:06 INFO - Running setup.py install for manifestparser 09:26:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:26:06 INFO - Running setup.py install for mozcrash 09:26:06 INFO - Running setup.py install for mozdebug 09:26:06 INFO - Running setup.py install for mozdevice 09:26:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:26:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:26:06 INFO - Running setup.py install for mozfile 09:26:06 INFO - Running setup.py install for mozhttpd 09:26:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:26:06 INFO - Running setup.py install for mozinfo 09:26:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Running setup.py install for mozInstall 09:26:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Running setup.py install for mozleak 09:26:07 INFO - Running setup.py install for mozlog 09:26:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Running setup.py install for moznetwork 09:26:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Running setup.py install for mozprocess 09:26:07 INFO - Running setup.py install for mozprofile 09:26:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Running setup.py install for mozrunner 09:26:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:26:07 INFO - Running setup.py install for mozscreenshot 09:26:07 INFO - Running setup.py install for moztest 09:26:07 INFO - Running setup.py install for mozversion 09:26:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:26:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:08 INFO - Cleaning up... 09:26:08 INFO - Return code: 0 09:26:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26: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:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:08 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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:26:08 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:26:08 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:26:08 INFO - Using env: {'DISPLAY': ':0', 09:26:08 INFO - 'HOME': '/home/cltbld', 09:26:08 INFO - 'LANG': 'en_US.UTF-8', 09:26:08 INFO - 'LANGUAGE': 'en_US:en', 09:26:08 INFO - 'LOGNAME': 'cltbld', 09:26:08 INFO - 'MAIL': '/var/mail/cltbld', 09:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:08 INFO - 'MOZ_NO_REMOTE': '1', 09:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:08 INFO - 'NO_EM_RESTART': '1', 09:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:08 INFO - 'PWD': '/builds/slave/test', 09:26:08 INFO - 'SHELL': '/bin/bash', 09:26:08 INFO - 'SHLVL': '1', 09:26:08 INFO - 'TERM': 'linux', 09:26:08 INFO - 'TMOUT': '86400', 09:26:08 INFO - 'USER': 'cltbld', 09:26:08 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:08 INFO - '_': '/tools/buildbot/bin/python'} 09:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:08 INFO - Running setup.py (path:/tmp/pip-fc0MEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:08 INFO - Running setup.py (path:/tmp/pip-QNsFoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:08 INFO - Running setup.py (path:/tmp/pip-QyUlS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:08 INFO - Running setup.py (path:/tmp/pip-tH8eqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:08 INFO - Running setup.py (path:/tmp/pip-cXktHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:08 INFO - Running setup.py (path:/tmp/pip-EkEmlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:08 INFO - Running setup.py (path:/tmp/pip-LDFBii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:08 INFO - Running setup.py (path:/tmp/pip-gbVH7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:08 INFO - Running setup.py (path:/tmp/pip-Z5e9fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:08 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:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:08 INFO - Running setup.py (path:/tmp/pip-iM8zcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:09 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:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:09 INFO - Running setup.py (path:/tmp/pip-fbPnxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:09 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:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:09 INFO - Running setup.py (path:/tmp/pip-7G77H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:09 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:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:09 INFO - Running setup.py (path:/tmp/pip-BfRe3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:09 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:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:09 INFO - Running setup.py (path:/tmp/pip-e6IMcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:09 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:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:09 INFO - Running setup.py (path:/tmp/pip-7yNZfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:09 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:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:09 INFO - Running setup.py (path:/tmp/pip-XOAMst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:09 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:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:09 INFO - Running setup.py (path:/tmp/pip-865lCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:09 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:26:09 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:26:09 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:26:09 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:26:09 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:26:09 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:26:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:11 INFO - Downloading blessings-1.5.1.tar.gz 09:26:11 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:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:26:11 INFO - Installing collected packages: blessings 09:26:11 INFO - Running setup.py install for blessings 09:26:11 INFO - Successfully installed blessings 09:26:11 INFO - Cleaning up... 09:26:11 INFO - Return code: 0 09:26:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:11 INFO - Reading from file tmpfile_stdout 09:26:11 INFO - Current package versions: 09:26:11 INFO - argparse == 1.2.1 09:26:11 INFO - blessings == 1.5.1 09:26:11 INFO - blobuploader == 1.2.4 09:26:11 INFO - docopt == 0.6.1 09:26:11 INFO - manifestparser == 1.1 09:26:11 INFO - mozInstall == 1.12 09:26:11 INFO - mozcrash == 0.16 09:26:11 INFO - mozdebug == 0.1 09:26:11 INFO - mozdevice == 0.47 09:26:11 INFO - mozfile == 1.2 09:26:11 INFO - mozhttpd == 0.7 09:26:11 INFO - mozinfo == 0.9 09:26:11 INFO - mozleak == 0.1 09:26:11 INFO - mozlog == 3.1 09:26:11 INFO - moznetwork == 0.27 09:26:11 INFO - mozprocess == 0.22 09:26:11 INFO - mozprofile == 0.27 09:26:11 INFO - mozrunner == 6.11 09:26:11 INFO - mozscreenshot == 0.1 09:26:11 INFO - mozsystemmonitor == 0.0 09:26:11 INFO - moztest == 0.7 09:26:11 INFO - mozversion == 1.4 09:26:11 INFO - psutil == 3.1.1 09:26:11 INFO - requests == 1.2.3 09:26:11 INFO - wsgiref == 0.1.2 09:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26: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:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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/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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:26: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/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:26: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/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:26:11 INFO - Using env: {'DISPLAY': ':0', 09:26:11 INFO - 'HOME': '/home/cltbld', 09:26:11 INFO - 'LANG': 'en_US.UTF-8', 09:26:11 INFO - 'LANGUAGE': 'en_US:en', 09:26:11 INFO - 'LOGNAME': 'cltbld', 09:26:11 INFO - 'MAIL': '/var/mail/cltbld', 09:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:11 INFO - 'MOZ_NO_REMOTE': '1', 09:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:11 INFO - 'NO_EM_RESTART': '1', 09:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:11 INFO - 'PWD': '/builds/slave/test', 09:26:11 INFO - 'SHELL': '/bin/bash', 09:26:11 INFO - 'SHLVL': '1', 09:26:11 INFO - 'TERM': 'linux', 09:26:11 INFO - 'TMOUT': '86400', 09:26:11 INFO - 'USER': 'cltbld', 09:26:11 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:11 INFO - '_': '/tools/buildbot/bin/python'} 09:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 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:26:11 INFO - Cleaning up... 09:26:11 INFO - Return code: 0 09:26:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:26: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:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:26:11 INFO - Using env: {'DISPLAY': ':0', 09:26:11 INFO - 'HOME': '/home/cltbld', 09:26:11 INFO - 'LANG': 'en_US.UTF-8', 09:26:11 INFO - 'LANGUAGE': 'en_US:en', 09:26:11 INFO - 'LOGNAME': 'cltbld', 09:26:11 INFO - 'MAIL': '/var/mail/cltbld', 09:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:11 INFO - 'MOZ_NO_REMOTE': '1', 09:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:11 INFO - 'NO_EM_RESTART': '1', 09:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:11 INFO - 'PWD': '/builds/slave/test', 09:26:11 INFO - 'SHELL': '/bin/bash', 09:26:11 INFO - 'SHLVL': '1', 09:26:11 INFO - 'TERM': 'linux', 09:26:11 INFO - 'TMOUT': '86400', 09:26:11 INFO - 'USER': 'cltbld', 09:26:11 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:11 INFO - '_': '/tools/buildbot/bin/python'} 09:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:12 INFO - Downloading/unpacking jsonschema 09:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:26:13 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:26:13 INFO - Downloading/unpacking functools32 (from jsonschema) 09:26: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:26: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:26: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:26: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:26: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:26: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:26:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:26:13 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:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:26:14 INFO - warning: no files found matching '*.txt' 09:26:14 INFO - no previously-included directories found matching 'build' 09:26:14 INFO - no previously-included directories found matching 'dist' 09:26:14 INFO - no previously-included directories found matching '.git*' 09:26:14 INFO - Installing collected packages: jsonschema, functools32 09:26:14 INFO - Running setup.py install for functools32 09:26:14 INFO - warning: no files found matching '*.txt' 09:26:14 INFO - no previously-included directories found matching 'build' 09:26:14 INFO - no previously-included directories found matching 'dist' 09:26:14 INFO - no previously-included directories found matching '.git*' 09:26:14 INFO - Successfully installed jsonschema functools32 09:26:14 INFO - Cleaning up... 09:26:14 INFO - Return code: 0 09:26:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:26:14 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:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:14 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:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:14 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 0x7f5b79795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, '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': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', '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:26:14 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:26:14 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:26:14 INFO - Using env: {'DISPLAY': ':0', 09:26:14 INFO - 'HOME': '/home/cltbld', 09:26:14 INFO - 'LANG': 'en_US.UTF-8', 09:26:14 INFO - 'LANGUAGE': 'en_US:en', 09:26:14 INFO - 'LOGNAME': 'cltbld', 09:26:14 INFO - 'MAIL': '/var/mail/cltbld', 09:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:14 INFO - 'MOZ_NO_REMOTE': '1', 09:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:14 INFO - 'NO_EM_RESTART': '1', 09:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:14 INFO - 'PWD': '/builds/slave/test', 09:26:14 INFO - 'SHELL': '/bin/bash', 09:26:14 INFO - 'SHLVL': '1', 09:26:14 INFO - 'TERM': 'linux', 09:26:14 INFO - 'TMOUT': '86400', 09:26:14 INFO - 'USER': 'cltbld', 09:26:14 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:14 INFO - '_': '/tools/buildbot/bin/python'} 09:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:14 INFO - Downloading/unpacking flake8 09:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:26:16 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:26:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:26:16 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:26:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 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:26:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:17 INFO - no previously-included directories found matching 'docs/_build' 09:26:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:26:17 INFO - Running setup.py install for pep8 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:17 INFO - no previously-included directories found matching 'docs/_build' 09:26:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:26:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:26:17 INFO - Cleaning up... 09:26:17 INFO - Return code: 0 09:26:17 INFO - Running post-action listener: _resource_record_post_action 09:26:17 INFO - Running post-action listener: _start_resource_monitoring 09:26:17 INFO - Starting resource monitoring. 09:26:17 INFO - ##### 09:26:17 INFO - ##### Running install step. 09:26:17 INFO - ##### 09:26:17 INFO - Running pre-action listener: _resource_record_pre_action 09:26:17 INFO - Running main action method: install 09:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:17 INFO - Reading from file tmpfile_stdout 09:26:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:26:17 INFO - Reading from file tmpfile_stdout 09:26:17 INFO - Output received: 09:26:17 INFO - Usage: mozinstall [options] installer 09:26:17 INFO - Options: 09:26:17 INFO - -h, --help show this help message and exit 09:26:17 INFO - -d DEST, --destination=DEST 09:26:17 INFO - Directory to install application into. [default: 09:26:17 INFO - "/builds/slave/test"] 09:26:17 INFO - --app=APP Application being installed. [default: firefox] 09:26:17 INFO - mkdir: /builds/slave/test/build/application 09:26:17 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:26:17 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:26:32 INFO - Reading from file tmpfile_stdout 09:26:32 INFO - Output received: 09:26:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:26:32 INFO - Running post-action listener: _resource_record_post_action 09:26:32 INFO - ##### 09:26:32 INFO - ##### Running run-tests step. 09:26:32 INFO - ##### 09:26:32 INFO - Running pre-action listener: _resource_record_pre_action 09:26:32 INFO - Running main action method: run_tests 09:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:26:32 INFO - Python 2.7.3 09:26:32 INFO - Return code: 0 09:26:32 INFO - grabbing minidump binary from tooltool 09:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:32 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 0x2c530b0>, '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 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:26:32 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:26:32 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:26:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:26:32 INFO - Return code: 0 09:26:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:26:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:26:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:26:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:26:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:26:33 INFO - Return code: 0 09:26:33 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/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test/build 09:26:33 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/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 09:26:33 INFO - Using env: {'DISPLAY': ':0', 09:26:33 INFO - 'HOME': '/home/cltbld', 09:26:33 INFO - 'LANG': 'en_US.UTF-8', 09:26:33 INFO - 'LANGUAGE': 'en_US:en', 09:26:33 INFO - 'LOGNAME': 'cltbld', 09:26:33 INFO - 'MAIL': '/var/mail/cltbld', 09:26:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:26:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:33 INFO - 'MOZ_NO_REMOTE': '1', 09:26:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:33 INFO - 'NO_EM_RESTART': '1', 09:26:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:33 INFO - 'PWD': '/builds/slave/test', 09:26:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:26:33 INFO - 'SHELL': '/bin/bash', 09:26:33 INFO - 'SHLVL': '1', 09:26:33 INFO - 'TERM': 'linux', 09:26:33 INFO - 'TMOUT': '86400', 09:26:33 INFO - 'USER': 'cltbld', 09:26:33 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094', 09:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:33 INFO - '_': '/tools/buildbot/bin/python'} 09:26:33 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/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 09:26:33 INFO - mozversion INFO | application_buildid: 20151128084531 09:26:33 INFO - mozversion INFO | application_changeset: 959df62d450d8d8d51252ba9c292b668835ac3e7 09:26:33 INFO - mozversion INFO | application_display_name: Nightly 09:26:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:26:33 INFO - mozversion INFO | application_name: Firefox 09:26:33 INFO - mozversion INFO | application_remotingname: firefox 09:26:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:26:33 INFO - mozversion INFO | application_vendor: Mozilla 09:26:33 INFO - mozversion INFO | application_version: 45.0a1 09:26:33 INFO - mozversion INFO | platform_buildid: 20151128084531 09:26:33 INFO - mozversion INFO | platform_changeset: 959df62d450d8d8d51252ba9c292b668835ac3e7 09:26:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:26:33 INFO - mozversion INFO | platform_version: 45.0a1 09:26:33 INFO - 2015-11-28 09:26:33,381 DEBUG : using testdate: 1448731593 09:26:33 INFO - 2015-11-28 09:26:33,381 DEBUG : actual date: 1448731593 09:26:33 INFO - 2015-11-28 09:26:33,467 INFO : starting webserver on 'localhost:60446' 09:26:33 INFO - 2015-11-28 09:26:33,468 INFO : Starting test suite talos-linux64-ix-033.e 09:26:33 INFO - 2015-11-28 09:26:33,469 INFO : Starting test dromaeo_css 09:26:33 INFO - 2015-11-28 09:26:33,469 DEBUG : operating with platform_type : linux_ 09:26:33 INFO - 2015-11-28 09:26:33,469 INFO : Initialising browser for dromaeo_css test... 09:26:33 INFO - 2015-11-28 09:26:33,478 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR1NhOd/profile http://localhost:60446/getInfo.html 09:26:39 INFO - 2015-11-28 09:26:39,113 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:26:39 INFO - 2015-11-28 09:26:39,113 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:26:39 INFO - 2015-11-28 09:26:39,113 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:26:39 INFO - 2015-11-28 09:26:39,113 DEBUG : BROWSER_OUTPUT: __metrics 09:26:40 INFO - 2015-11-28 09:26:40,649 INFO : Browser initialized. 09:26:40 INFO - 2015-11-28 09:26:40,650 INFO : Running cycle 1/1 for dromaeo_css test... 09:26:40 INFO - 2015-11-28 09:26:40,650 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR1NhOd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:26:52 INFO - 2015-11-28 09:26:52,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 138592256 09:26:52 INFO - 2015-11-28 09:26:52,603 DEBUG : BROWSER_OUTPUT: 09:27:42 INFO - 2015-11-28 09:27:42,236 DEBUG : BROWSER_OUTPUT: 1448731662231 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:29:54 INFO - 2015-11-28 09:29:54,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60446/tests/dromaeo/cssquery-ext.html) 09:29:55 INFO - 2015-11-28 09:29:55,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 144658432 09:29:55 INFO - 2015-11-28 09:29:55,117 DEBUG : BROWSER_OUTPUT: 09:32:57 INFO - 2015-11-28 09:32:57,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/dromaeo/cssquery-ext.html (next: http://localhost:60446/tests/dromaeo/cssquery-jquery.html) 09:32:57 INFO - 2015-11-28 09:32:57,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 144936960 09:32:57 INFO - 2015-11-28 09:32:57,720 DEBUG : BROWSER_OUTPUT: 09:35:59 INFO - 2015-11-28 09:35:59,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60446/tests/dromaeo/cssquery-mootools.html) 09:36:00 INFO - 2015-11-28 09:36:00,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 142819328 09:36:00 INFO - 2015-11-28 09:36:00,163 DEBUG : BROWSER_OUTPUT: 09:39:01 INFO - 2015-11-28 09:39:01,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60446/tests/dromaeo/cssquery-prototype.html) 09:39:02 INFO - 2015-11-28 09:39:02,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 141881344 09:39:02 INFO - 2015-11-28 09:39:02,516 DEBUG : BROWSER_OUTPUT: 09:42:05 INFO - 2015-11-28 09:42:05,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60446/tests/dromaeo/cssquery-yui.html) 09:42:05 INFO - 2015-11-28 09:42:05,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 142630912 09:42:05 INFO - 2015-11-28 09:42:05,724 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/dromaeo/cssquery-yui.html (next: http://localhost:60446/tests/dromaeo/cssquery-dojo.html) 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 145235968 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2614.960775588366;2647.404334024846;2688.166668332816;2701.1896431070672;2714.443539074489;4543.136804007245;4669.136209801185;4701.177293973554;4704.717716936982;4739;4626.375439315691;4665.136949664306;4679.9298010529865;4750.691205071676;4781.282807578865;4300.2689542777725;4340.609345158935;4346.239408103585;4349.086691794727;4429.645628349725;4325.74045557266;4403.889902752425;4410.933835992462;4445.266531022394;4491.528389519102;4141.233871733739;4238.533761286256;4297.419848320468;4364.388985542043;4393.648508119375;4305.870823875289;4340.936470564732;4358.411614432042;4360.738355698668;4393.340998850166;4347.5652434756585;4349.608535231812;4349.717268377545;4376.496702879178;4410.25025745624;4389.670774691911;4434.401355816988;4486.282194848808;4601.4248218972625;4612.331211974279;4988.800447982077;5056.595472362239;5057.291979122926;5064.898702025939;5083.949160508385;4764.785584648665;5064.417591976933;5064.594832413435;5065.797368105272;5120.667156634807;4579.519150489184;4605.953940460619;4663.393758811333;4672.042231342567;4698.976505117453;5172.922406163911;5218.191180367049;5220.112580861187;5251.894962100813;5273.499017593323;4713.929291060636;4805.879853003633;5012.699238045729;5038.974805125951;5048.5203905628905;4853.684510506876;4976.377952755905;4991.750412479361;5005.874853128701;5039.823606173766;4993.925091123636;4996.4254110777;5001.049800537886;5006.499350064964;5013.623978201649;4769.928451073237;4890.413150421901;5014.924776128361;5015.849524514198;5065.037642847921;4135.60711732385;4182.707210495236;4203.0543127796;4237.025484138665;4243.490781106287;3664.523611930432;3688.8155592220282;3697.0757310672334;3724.217914237986;3736.065983504124;4226.640735537514;4267.701260911706;4349.499807522176;4400.515943246241;4405.185040767468;5047.242913562922;5064.772085256172;5101.566366858859;5101.7194054327365;5116.360454943132;4350.891227719332;4406.845760398371;4418.204723149864;4439.64482841372;4469.284914413678;4285.400043993844;4338.609525142752;4373.803178856959;4436.511983681792;4444.977775111104;4736.550027747358;4747.264174053027;4786.712797232108;4802.375691160127;4802.73584952831;5016.698998060128;5027.673201241908;5036.320096787033;5044.873878153076;5072.467390924047;4611.515790841913;4630.884227894195;4692.53074692528;4698.318743782201;4778.426588809365;4920.581750551243;4930.285108659153;4943.530364615356;4984.975075124601;5022.221555658879;4761.047790441856;5059.418166910705;5063.822766203165;5064.392272927273;5103.515166059218;4760.119377915097;4816.686915350491;4818.373611430492;4834.250691142878;4889;4846.006568653488;4878;4878.902421951612;4901.607871370211;4927.778249978831;4517.186906356887;4679.836205732783;4774.95225047759;4798.424189097331;4811.9518804811505;4797.9040419192115;4928.063667903087;4947.505249475168;4980.128477516348;5022.045811295842;4755.667103302874;4757.690750101232;4772.188727916193;4776.188048031912;4808.711477311373 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.7722595123022;554.2130175151285;577.1746402644219;582.1384351160284;584.815783028346;27663.861680691592;36344.273114537726;36668.816655916686;36776.712815051476;37037.259254814955;39454;40088.79955600218;40154.39768403476;40168.598314016854;40199.397009044886;7955.801104972378;8104.716334928249;8143.348532117446;8148.633311500997;8169.95915020424;7945.841083178333;8096.919030809676;8108.513489190638;8115.715949941753;8141.877871831927;8102.270795628392;8188.590570471482;8223.876641850347;8227.053888802775;8244.752657420288;8021.598920053974;8059.355251579889;8087.353011759045;8101.068377136587;8125.9842519685035;7910.7231246906085;7962.761117166494;7994.080680721733;8031;8080.676772929076;36993;37503.624963750284;37563.62436375629;37572;37802.62197378019;2934.60382848317;3014.773891958112;3255.4465740824116;3318.634950155481;3399.895034113898;28308.575371369447;28324.575131373047;28403.573946390614;28614.14157575276;28939;3388.3053973935284;3442.8794992175403;3497.3355062538035;3507.7018453431488;3550.5206797082324;216800;217116;217139;217593;217825;51462.74268628633;52553;56029.719851400485;56279.155812662844;62098.379016210165;56855.14717279244;57043.71478142583;57356.426435735106;57532.71233643805;57597.712011439675;12640.862322390845;12651.810222846665;12722.045846561545;12808.423620937081;12884.291363975071;9905.851412228678;9917;9920.305578609572;10006.849897251546;10058.34620749649;19567.706484402745;19857.503562411057;19863.503412414517;19869.900650496656;19873.60252794936;7659.961700191463;7732.884006739903;7863.72476963315;7923;8020;808.9838203235902;851.089334412173;932.4079209701888;1009.4195837393528;1043.6242952537082;25972.35069123287;26263.343416414362;26274.6058809118;26330.21009369722;26474.867625661747;921.953902304882;931.4550987672152;942.2979879989451;1024.5645600619707;1053.657561292583;13095.672608184681;13375.130616509896;13584.45662173502;13615.931920340534;13627.25050122233;308530;313749;314858;317344;317390;46413;46429.767851160526;46434.535654643696;46524.06951860944;46888.765556172686;1175.26545908807;1180.2859270141612;1199.892009719112;1201.0271679939276;1201.5494189678695;23952.802359882284;24415.633765493887;24500.6324905123;24624.384390390383;24697.542344071484;38195.42706859344;38544.6145538541;38859;38860.41709374418;38896.6110338893;241001.51487123792;244947;245410;246358;246881;29088.236617521303;42177;42774;42875;43175.784121079196;45777;46698.06603867836;46718.299225510964;47411.28883066826;47567.76216118897;33453.33093338071;33664.49503257502;34335.65664343325;34785;35025.64974350224;38036.619633803304;38852.41721374125;40018.599814001485;40411.59588404196;40590.39114413227;38460.80769596134;38525.80737096297;39033.21933561256;39033.609663904135;39464.60535394724;30173.849130754206;30892.22769430782;31055.84472077625;31219;31223.687763122987;23984.321097523007;24527.01891924303;24591.631125532775;24666.383340416633;24828.751712483365 09:45:08 INFO - 2015-11-28 09:45:08,284 DEBUG : BROWSER_OUTPUT: |2;jquery.html;319.2848020434228;320.1372301647062;321.63012535584073;327.1396227920567;328.57613678354926;15011;15075.472358467456;15365;15912;16516.66966660666;13813.51652692156;13843.792343114861;13907.443702251923;14297.285135743197;14934.103953762782;4470.0389416275575;4478.552144785528;4542;4561.429821272341;4570.611498022672;4527.207738645724;4565.61192298655;4570.474395444517;4572.245579479399;4583.633309335245;3352.2792599591085;4444.20004399208;4602.194615942213;4610.631149508048;5262.2632831403635;5155.845324640248;5178.249153872705;5184.948150518484;5212.1660534314515;5230.163173892159;4559.954400456019;4591.977040114812;4655.092257009885;4993.575546078588;5000.649954503187;18083.819161808344;18183.54541136469;18266.36067737636;19222.135003924857;19325.806741932684;1708.6582683463357;1724.5774785177712;1768.3457120865362;1838.1820090059928;1856.712209607513;8779.253763430115;8829.293656507463;8957.462552246887;9048.411853229585;11251.437428128642;1728.9567760805955;1758.648270345923;1894.7536820213422;1914.2247389807012;1932.2367664772478;56644;57612;58058;58617;59625;9683.757906052406;9878.802423951482;10037;10071.5467803949;10103.09072183507;12499.93750031244;12513.687157821127;12544.874551254554;12583;12588.559400420942;6943.930560694328;6981.755638552626;7015.8596828063155;7023.367896889305;7087.893681594677;6564.540482166298;6599.8020059398295;6600.174978127734;6616.305287944792;6659;4224.788760562021;4229.302165142779;4244.893877653083;4272.423222864935;4296.2911119664905;1628.6091338079013;1759.7536344911723;1764.1708397053364;1766.4170823628172;1777.9022153781666;344.6691176470616;348.0828018172084;349.50544978854634;810.5015415519531;828.6395417993192;9328.533573321307;9424.151826335663;9515.714528564155;9581.952090239503;9612.134907858326;809.2069771623724;820.6104033181166;821.3059964330131;823.9382046346548;880.704963837109;8387.329013678891;8525.275351595059;8568.828623427496;8609.827803443895;8651.394402391898;525238;532379.3810309469;538628;552642;553164;69727.65136174287;71855.92216116762;72773.636131819;74639;75227.62386188144;1087.6465148826662;1093.6172339681048;1110.2339385823757;1112.554978008803;1114.966551003455;13893.235872027135;14045.578632641038;14066.929665351608;14071.155730656194;14142.646433838825;30792.230194245323;31297.374052518368;31825.5226171603;31841.363172735953;31949.6805031956;43442.34836477392;43583;43776.56223437852;44169.33745993877;46334.30498542457;8619.267362274277;8752.124787521198;8759.16787905148;8841.336899732674;8857.64569417216;12022.338771367658;15932.8406715936;16347.754783678492;16410.835891641407;16481.752773708165;12886.613401597591;13946.30268486592;13961.309508959186;14197.858021420067;14353.928230359199;12821.423035963218;13270.469181232642;13388.129771564818;13539.932300338436;13625.795613065613;13768.93115534456;13867.653308667364;14067.366968486238;14112.50606228777;14248.715025699636;8449.788755281168;8603.096674849301;8743.693970710994;8750.82498350042;8751.212390884597;12882.420291086735;13763.105398149088;13807.033507654367;14151.221682807545;14165 09:45:08 INFO - 2015-11-28 09:45:08,285 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1462.663587374903;1607.7106120898238;1623.691498615263;1666.042025835145;1681.6972944869926;5436.103042997901;5717.256756621644;6318.810435686931;6711.966440167798;6724.63014534201;6219.346968568303;6501.544891857572;6516.70674819633;6539.803805885819;6574.408303252706;1921.2411097616398;1951.0537389366145;1953.7753158386754;1957.1584218785915;1962.3328068456722;1946.7858535561147;1949.8342640875542;1961.2155137944865;2019.1923230707687;2025.463252238158;1935.5644979879555;1944.965853268898;1947.1724517080256;1954.2378472395776;1955.5697746495819;1926.807319268069;1930.942071737857;1950.5123719070232;1953.7850836407983;1957.628050670368;1947.1821834829407;1964.5186929202437;1967.842572594189;1968.7440632717655;1977.5253939054667;6477.902831457532;6539.50953678476;6578.638174900427;6594.901076483857;6613.074169616258;3820.6752426043818;3882.650561449455;3916.725829191958;3917.275304068756;3926.587708290617;2492.626106084102;2515.05685367987;2530.6204069389555;2566.4353842154696;2577.9945821129772;826.2604968553171;826.9421140520166;840.9075001749864;849.413904405958;857.7941294089436;8573.228409443118;8574.228319451217;8576.271016963503;8665.783355416102;8700.738977830675;3413.6415676354122;3426.0407086015957;3446.551948246712;3471.8264086795557;3478.1478537757907;7384.2246564111065;7438.628068596657;7491.138519070268;7498.512596681198;7502.512336698097;3868.613138686109;3875.6822680288838;3888.0279930017496;3912.667423268997;3915.980420097881;3329.067860998924;3467.0638927489435;3494.4932984717584;3504.737144714157;3520.9295814083575;2996.131121974603;3016.8039077459894;3017.125033740235;3024.5765592817024;3025.9546106808416;857.0443954990266;872.5986046418718;888.9644414223488;892.0767006148606;892.8928528576482;1157.1908672002198;1174.442139983501;1182.485618755844;1187.2579637726421;1198.8141838015122;6247.312795592481;6258.405451482102;6278.811635650938;6291.056341548804;6291.842703932347;986.5461887531816;1000.4547521600599;1015.5633077776627;1023.4473384372504;1031.2059714020313;5036.420811606712;5039.244113383022;5050.974745126251;5069.417017043013;5071.721055341918;7559.886601700979;7639.274268944441;7768.378529717609;7856.410769192334;7866.72466463671;7670.463067585216;7706.190849960785;7718.343940764986;7794.10367807698;7816.570088645065;6213.99999999991;6280.246370435486;6290;6334.588251763713;6345.365463453618;5984.042553191469;6009.098635204754;6014.398560143951;6031.276246850406;6037.486813620892;6830.965845170742;6939.167299924042;6990.580565165903;7018.473614478832;7040.964795175992;7080.787576372717;7159.964200178966;7191.928080719335;7198.964005179941;7217.314355136254;4891.413030436371;4968.304437378698;5698.116791897262;5733.541316694571;5772.5381969441505;6081.087836824512;6233.376662333731;6278.215223097113;6298.590591611531;6313.179286692701;5844.47399734026;5904.468597826216;5941.643501389931;5951.940480595312;6053.485453736305;5837.299524056971;5837.474627283565;5862.736176871966;5866.560007999332;5904.734286957183;5920.407959204045;5922.555808314308;5949.405059494189;6000.429959153874;6066.757329706938;5511.862203444946;5512.952539017734;5520.199571062254;5578.051731205786;5609.046462101534;5631.8592035199445;5631.88736225265;5662.377138514677;5703.8859222816145;5707.1724599933605 09:45:08 INFO - 2015-11-28 09:45:08,285 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.2232383725859;294.6670262603258;295.8210282778919;298.19784778944637;298.4776640878463;5502.697351645658;5595.104783234683;5639.2105105285245;5674.432556744324;5685.1756495308255;5576.776928922848;5577.637453565526;5586.190002449653;5607.635503692257;5618.4662457066515;4270.402143699885;4278.893027674302;4283.293256612656;4283.614474697284;4290.6138447539715;4157.417961485395;4239.130978149472;4240.109576988836;4279.1227798301425;4285.764282964436;4161.438205842218;4182.142660754538;4182.560831112735;4195.790210489478;4221.0291632924445;4206.053637931472;4209.34755112958;4210.115875666113;4213.178430206111;4236.576342365739;3650;3651.5618125824803;3652.4886515887797;3656.360136976045;3666.2667466506805;5289.603279754034;5319.308489896327;5415.323084614423;5442.891142177174;5449.291592093042;4802.327674125625;4808.158572249842;4811.687240329367;4812.302216178635;4813.374261346037;5842.065269556851;5851.941480585225;5864.618799778001;5868.882622347572;5879.500242479395;3928.64642182205;3938.0548668319684;3943.0930885896405;3943.2310699413624;3963.742356746802;5929.258842644669;6158.8768224635705;6169.81490555284;6169.951108311598;6197.442230199259;3983.083890705096;3999.7400168988925;4009.538903026131;4010.959890401117;4012.799360031987;4051.7974101294817;4054.0675644601906;4067.186562687415;4070.430139780433;4073.450084238649;4741.525847415231;4751.881202969884;4758.476567577563;4760.619150467955;4765.618750499952;5741.7990370337675;5837.708114594253;5891.351951285355;5895.528357731371;5907.1434641976675;1450.6445920749272;1466.948656797007;1467.0610809082195;1470.073853472327;1471.6835880285576;966.7969726357403;968;968.1867231525553;987.4026214140486;987.9604815807431;5148.76830542619;5168.2764412982215;5182.170852663556;5189.117849965515;5191.377034755854;6136.8772624548155;6140.263168419729;6144.109104179869;6146.139540464339;6152.661603611755;5167.483251674803;5169.741512924414;5173.094708426086;5178.97410512945;5189.221616757441;3262.6411094779555;3303.1907182740383;3334.8165850878436;3356.9664303357144;3366.6633336666628;5811.360750317462;5823.097419899922;5844.707764611752;5846.590738648339;5855.121731740273;6034.336223015464;6150.969245153835;6160.014397696347;6339.619622822645;6360.427561519393;5774.884502310014;5813.59304848665;5814.622049566765;5814.796482123105;5820.068788993741;6161.691915404302;6164.167837341902;6169.043798211284;6175.413335733098;6179.752809887555;5785.334686511105;5971.970140149271;6009;6020.157177994996;6025.8192254232445;5748.568857335633;5806.82579522615;5812.244408226903;5824.5631577631;5840.532757379485;4032.0726232965994;4045.110075783323;4060.309747343018;4060.715749897479;4067.9389809152294;6046;6141.631502109888;6173.41352571505;6173.969130154321;6178.66017369049;5902.1146827976145;5903.0555111182;5905.261842269716;5913.852153696192;5922.555808314308;5905.527557795452;5923.407659234214;5930;5932.911006334994;5939.2575928009;5614.775408983758;5773;5774.82675519735;5782.3639399666845;5786.884262314646;5961.344252132349;5962.344142144448;5968.4031596841705;5978.8206353809455;5991;5793.188953546422;5806.042003069446;5810.1575271586225;5820.1560773688425;5829.125631155191 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: |5;yui.html;698.5703792167818;730.9963450182752;756.1984296645555;774.759824454419;774.8992630957974;11306.717332066692;11667.41662916855;11702.941485292562;11752.353620550866;11754.706132346684;10537.52581133849;10669.093127084207;10689.893101068987;10692.251542392036;10694.839577406345;576.20771439271;602.0908428273317;608.2731136292133;756.8297133145026;771.783900507856;764.4114032195206;770.6493545436841;772.382094324541;776.4370831147401;777.0209535984671;737.4505993035169;798.8362385710915;803.8030682482771;806.2340776262545;813.5403497024163;790.1150711203431;802.5505716798612;804.5574933786423;805.8589746794316;807.9192080791933;593.4332712259825;598.1058317814894;601.515779797263;601.651042395414;601.7021574320695;10708.357498550035;10757.78484430307;10766.515506802134;10770.838437423445;10774.5690172393;10302.896971030268;10392.896071039344;10859.185561082872;11122.777544449147;11278.323300601991;9474.336796424253;9496.525173741285;9533.47565883876;9744.610215591369;9749.853752193723;3167.651558328582;3218.308063766278;3243.2702641905616;3255.365203785263;3258.3809076275434;41212.58787412118;41357.79321103375;41395;41436.792816035726;41642.79178604148;8676.305895528343;8971.975624061894;9016.819663606691;9033.954830225939;9248.815023699488;15528.844711552965;15810.288537015862;16495.092769897772;16549.338026479047;16575.91712041432;6452.870942581122;6472.579282346633;6565.606063636197;6572.112764776694;6677.465802735769;3556.324298383299;3557.1285035166034;3672.944905826415;3697.8520859165333;3721.2557488502407;2702.2163572563736;2721.9727802722114;2726.9727302727115;2735.86320683965;2737.2335745991154;485.05898556799696;505.4389627513457;505.9494050594985;506.1597747738736;513.7585334892594;423.77116357166784;514.0182251898855;592.9762809487572;608.8143116349468;634.2167423232304;7735.22647735222;7991.640376183086;8062.516249025077;8152.592370381457;8507.532085735344;452.38927447945014;453.5713750505806;494.35239835815196;596.6664504831698;606.1756011823916;3682.3739964206147;3733.1600389912596;3855.76865388072;3871.7289789715014;3963.8018099095507;47816.043679126225;48666.75666621644;48928.510714893106;49298.753506232955;49325.50674493281;43168;43201.135977280275;43606.127877442275;43828.780856095516;44431.111377772264;43550.34674479885;44130.11739765251;44781;45153.77423112929;45205.095898081854;8456.196661317164;8554.144585541397;8609.354298427768;8876.20114189726;8951.910480895107;33060.66939330672;33699.66300336965;34014.829925851205;34395.31209375848;34555.13612159716;40012;40147.19705605813;42002.36996444994;43351.566484334755;43404.348934765374;10725.570977160825;10857.294275872044;10937.343759374464;10988.066014388867;11017.504212310305;11345.432728363383;11353.48909299067;11453.312801231952;11584.247023943417;11684.766304674029;10618.203634727271;10645.414502202453;10861.239713219999;10995.560177592806;11078.058365039062;10642.148628109888;10726.892731072589;10915.39965301916;10915.508802103766;10931.56273749041;10322.793544129225;10369;10397.896021039995;10787.67636970892;10902.345859248471;9538.332316737762;9737.9026209737;9923.503824808586;10268.897311026794;10282.177425805769;9429.317418873554;9577.659127721985;9654.131128198496;9701.272404569545;9727.805443891224 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,345 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: __startTimestamp1448732708278__endTimestamp 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:45:08 INFO - 2015-11-28 09:45:08,286 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,287 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4631.16 Median:4750.69 stddev:482.40 (10.2%) stddev-sans-first:457.22 09:45:08 INFO - 2015-11-28 09:45:08,288 DEBUG : BROWSER_OUTPUT: Values: 2615.0 2647.4 2688.2 2701.2 2714.4 4543.1 4669.1 4701.2 4704.7 4739.0 4626.4 4665.1 4679.9 4750.7 4781.3 4300.3 4340.6 4346.2 4349.1 4429.6 4325.7 4403.9 4410.9 4445.3 4491.5 4141.2 4238.5 4297.4 4364.4 4393.6 4305.9 4340.9 4358.4 4360.7 4393.3 4347.6 4349.6 4349.7 4376.5 4410.3 4389.7 4434.4 4486.3 4601.4 4612.3 4988.8 5056.6 5057.3 5064.9 5083.9 4764.8 5064.4 5064.6 5065.8 5120.7 4579.5 4606.0 4663.4 4672.0 4699.0 5172.9 5218.2 5220.1 5251.9 5273.5 4713.9 4805.9 5012.7 5039.0 5048.5 4853.7 4976.4 4991.8 5005.9 5039.8 4993.9 4996.4 5001.0 5006.5 5013.6 4769.9 4890.4 5014.9 5015.8 5065.0 4135.6 4182.7 4203.1 4237.0 4243.5 3664.5 3688.8 3697.1 3724.2 3736.1 4226.6 4267.7 4349.5 4400.5 4405.2 5047.2 5064.8 5101.6 5101.7 5116.4 4350.9 4406.8 4418.2 4439.6 4469.3 4285.4 4338.6 4373.8 4436.5 4445.0 4736.6 4747.3 4786.7 4802.4 4802.7 5016.7 5027.7 5036.3 5044.9 5072.5 4611.5 4630.9 4692.5 4698.3 4778.4 4920.6 4930.3 4943.5 4985.0 5022.2 4761.0 5059.4 5063.8 5064.4 5103.5 4760.1 4816.7 4818.4 4834.3 4889.0 4846.0 4878.0 4878.9 4901.6 4927.8 4517.2 4679.8 4775.0 4798.4 4812.0 4797.9 4928.1 4947.5 4980.1 5022.0 4755.7 4757.7 4772.2 4776.2 4808.7 09:45:08 INFO - 2015-11-28 09:45:08,288 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,288 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42666.52 Median:37687.31 stddev:68461.71 (181.7%) stddev-sans-first:68580.73 09:45:08 INFO - 2015-11-28 09:45:08,288 DEBUG : BROWSER_OUTPUT: Values: 548.8 554.2 577.2 582.1 584.8 27663.9 36344.3 36668.8 36776.7 37037.3 39454.0 40088.8 40154.4 40168.6 40199.4 7955.8 8104.7 8143.3 8148.6 8170.0 7945.8 8096.9 8108.5 8115.7 8141.9 8102.3 8188.6 8223.9 8227.1 8244.8 8021.6 8059.4 8087.4 8101.1 8126.0 7910.7 7962.8 7994.1 8031.0 8080.7 36993.0 37503.6 37563.6 37572.0 37802.6 2934.6 3014.8 3255.4 3318.6 3399.9 28308.6 28324.6 28403.6 28614.1 28939.0 3388.3 3442.9 3497.3 3507.7 3550.5 216800.0 217116.0 217139.0 217593.0 217825.0 51462.7 52553.0 56029.7 56279.2 62098.4 56855.1 57043.7 57356.4 57532.7 57597.7 12640.9 12651.8 12722.0 12808.4 12884.3 9905.9 9917.0 9920.3 10006.8 10058.3 19567.7 19857.5 19863.5 19869.9 19873.6 7660.0 7732.9 7863.7 7923.0 8020.0 809.0 851.1 932.4 1009.4 1043.6 25972.4 26263.3 26274.6 26330.2 26474.9 922.0 931.5 942.3 1024.6 1053.7 13095.7 13375.1 13584.5 13615.9 13627.3 308530.0 313749.0 314858.0 317344.0 317390.0 46413.0 46429.8 46434.5 46524.1 46888.8 1175.3 1180.3 1199.9 1201.0 1201.5 23952.8 24415.6 24500.6 24624.4 24697.5 38195.4 38544.6 38859.0 38860.4 38896.6 241001.5 244947.0 245410.0 246358.0 246881.0 29088.2 42177.0 42774.0 42875.0 43175.8 45777.0 46698.1 46718.3 47411.3 47567.8 33453.3 33664.5 34335.7 34785.0 35025.6 38036.6 38852.4 40018.6 40411.6 40590.4 38460.8 38525.8 39033.2 39033.6 39464.6 30173.8 30892.2 31055.8 31219.0 31223.7 23984.3 24527.0 24591.6 24666.4 24828.8 09:45:08 INFO - 2015-11-28 09:45:08,288 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,288 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27689.87 Median:4258.66 stddev:88293.25 (2073.3%) stddev-sans-first:88517.02 09:45:08 INFO - 2015-11-28 09:45:08,290 DEBUG : BROWSER_OUTPUT: Values: 319.3 320.1 321.6 327.1 328.6 15011.0 15075.5 15365.0 15912.0 16516.7 13813.5 13843.8 13907.4 14297.3 14934.1 4470.0 4478.6 4542.0 4561.4 4570.6 4527.2 4565.6 4570.5 4572.2 4583.6 3352.3 4444.2 4602.2 4610.6 5262.3 5155.8 5178.2 5184.9 5212.2 5230.2 4560.0 4592.0 4655.1 4993.6 5000.6 18083.8 18183.5 18266.4 19222.1 19325.8 1708.7 1724.6 1768.3 1838.2 1856.7 8779.3 8829.3 8957.5 9048.4 11251.4 1729.0 1758.6 1894.8 1914.2 1932.2 56644.0 57612.0 58058.0 58617.0 59625.0 9683.8 9878.8 10037.0 10071.5 10103.1 12499.9 12513.7 12544.9 12583.0 12588.6 6943.9 6981.8 7015.9 7023.4 7087.9 6564.5 6599.8 6600.2 6616.3 6659.0 4224.8 4229.3 4244.9 4272.4 4296.3 1628.6 1759.8 1764.2 1766.4 1777.9 344.7 348.1 349.5 810.5 828.6 9328.5 9424.2 9515.7 9582.0 9612.1 809.2 820.6 821.3 823.9 880.7 8387.3 8525.3 8568.8 8609.8 8651.4 525238.0 532379.4 538628.0 552642.0 553164.0 69727.7 71855.9 72773.6 74639.0 75227.6 1087.6 1093.6 1110.2 1112.6 1115.0 13893.2 14045.6 14066.9 14071.2 14142.6 30792.2 31297.4 31825.5 31841.4 31949.7 43442.3 43583.0 43776.6 44169.3 46334.3 8619.3 8752.1 8759.2 8841.3 8857.6 12022.3 15932.8 16347.8 16410.8 16481.8 12886.6 13946.3 13961.3 14197.9 14353.9 12821.4 13270.5 13388.1 13539.9 13625.8 13768.9 13867.7 14067.4 14112.5 14248.7 8449.8 8603.1 8743.7 8750.8 8751.2 12882.4 13763.1 13807.0 14151.2 14165.0 09:45:08 INFO - 2015-11-28 09:45:08,290 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,290 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4576.05 Median:5804.92 stddev:2315.39 (39.9%) stddev-sans-first:2310.06 09:45:08 INFO - 2015-11-28 09:45:08,290 DEBUG : BROWSER_OUTPUT: Values: 1462.7 1607.7 1623.7 1666.0 1681.7 5436.1 5717.3 6318.8 6712.0 6724.6 6219.3 6501.5 6516.7 6539.8 6574.4 1921.2 1951.1 1953.8 1957.2 1962.3 1946.8 1949.8 1961.2 2019.2 2025.5 1935.6 1945.0 1947.2 1954.2 1955.6 1926.8 1930.9 1950.5 1953.8 1957.6 1947.2 1964.5 1967.8 1968.7 1977.5 6477.9 6539.5 6578.6 6594.9 6613.1 3820.7 3882.7 3916.7 3917.3 3926.6 2492.6 2515.1 2530.6 2566.4 2578.0 826.3 826.9 840.9 849.4 857.8 8573.2 8574.2 8576.3 8665.8 8700.7 3413.6 3426.0 3446.6 3471.8 3478.1 7384.2 7438.6 7491.1 7498.5 7502.5 3868.6 3875.7 3888.0 3912.7 3916.0 3329.1 3467.1 3494.5 3504.7 3520.9 2996.1 3016.8 3017.1 3024.6 3026.0 857.0 872.6 889.0 892.1 892.9 1157.2 1174.4 1182.5 1187.3 1198.8 6247.3 6258.4 6278.8 6291.1 6291.8 986.5 1000.5 1015.6 1023.4 1031.2 5036.4 5039.2 5051.0 5069.4 5071.7 7559.9 7639.3 7768.4 7856.4 7866.7 7670.5 7706.2 7718.3 7794.1 7816.6 6214.0 6280.2 6290.0 6334.6 6345.4 5984.0 6009.1 6014.4 6031.3 6037.5 6831.0 6939.2 6990.6 7018.5 7041.0 7080.8 7160.0 7191.9 7199.0 7217.3 4891.4 4968.3 5698.1 5733.5 5772.5 6081.1 6233.4 6278.2 6298.6 6313.2 5844.5 5904.5 5941.6 5951.9 6053.5 5837.3 5837.5 5862.7 5866.6 5904.7 5920.4 5922.6 5949.4 6000.4 6066.8 5511.9 5513.0 5520.2 5578.1 5609.0 5631.9 5631.9 5662.4 5703.9 5707.2 09:45:08 INFO - 2015-11-28 09:45:08,290 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,291 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4847.32 Median:5611.21 stddev:1465.73 (26.1%) stddev-sans-first:1429.34 09:45:08 INFO - 2015-11-28 09:45:08,292 DEBUG : BROWSER_OUTPUT: Values: 288.2 294.7 295.8 298.2 298.5 5502.7 5595.1 5639.2 5674.4 5685.2 5576.8 5577.6 5586.2 5607.6 5618.5 4270.4 4278.9 4283.3 4283.6 4290.6 4157.4 4239.1 4240.1 4279.1 4285.8 4161.4 4182.1 4182.6 4195.8 4221.0 4206.1 4209.3 4210.1 4213.2 4236.6 3650.0 3651.6 3652.5 3656.4 3666.3 5289.6 5319.3 5415.3 5442.9 5449.3 4802.3 4808.2 4811.7 4812.3 4813.4 5842.1 5851.9 5864.6 5868.9 5879.5 3928.6 3938.1 3943.1 3943.2 3963.7 5929.3 6158.9 6169.8 6170.0 6197.4 3983.1 3999.7 4009.5 4011.0 4012.8 4051.8 4054.1 4067.2 4070.4 4073.5 4741.5 4751.9 4758.5 4760.6 4765.6 5741.8 5837.7 5891.4 5895.5 5907.1 1450.6 1466.9 1467.1 1470.1 1471.7 966.8 968.0 968.2 987.4 988.0 5148.8 5168.3 5182.2 5189.1 5191.4 6136.9 6140.3 6144.1 6146.1 6152.7 5167.5 5169.7 5173.1 5179.0 5189.2 3262.6 3303.2 3334.8 3357.0 3366.7 5811.4 5823.1 5844.7 5846.6 5855.1 6034.3 6151.0 6160.0 6339.6 6360.4 5774.9 5813.6 5814.6 5814.8 5820.1 6161.7 6164.2 6169.0 6175.4 6179.8 5785.3 5972.0 6009.0 6020.2 6025.8 5748.6 5806.8 5812.2 5824.6 5840.5 4032.1 4045.1 4060.3 4060.7 4067.9 6046.0 6141.6 6173.4 6174.0 6178.7 5902.1 5903.1 5905.3 5913.9 5922.6 5905.5 5923.4 5930.0 5932.9 5939.3 5614.8 5773.0 5774.8 5782.4 5786.9 5961.3 5962.3 5968.4 5978.8 5991.0 5793.2 5806.0 5810.2 5820.2 5829.1 09:45:08 INFO - 2015-11-28 09:45:08,292 DEBUG : BROWSER_OUTPUT: 09:45:08 INFO - 2015-11-28 09:45:08,292 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12490.41 Median:43578.24 stddev:14193.54 (32.6%) stddev-sans-first:14205.73 09:45:08 INFO - 2015-11-28 09:45:08,293 DEBUG : BROWSER_OUTPUT: Values: 698.6 731.0 756.2 774.8 774.9 11306.7 11667.4 11702.9 11752.4 11754.7 10537.5 10669.1 10689.9 10692.3 10694.8 576.2 602.1 608.3 756.8 771.8 764.4 770.6 772.4 776.4 777.0 737.5 798.8 803.8 806.2 813.5 790.1 802.6 804.6 805.9 807.9 593.4 598.1 601.5 601.7 601.7 10708.4 10757.8 10766.5 10770.8 10774.6 10302.9 10392.9 10859.2 11122.8 11278.3 9474.3 9496.5 9533.5 9744.6 9749.9 3167.7 3218.3 3243.3 3255.4 3258.4 41212.6 41357.8 41395.0 41436.8 41642.8 8676.3 8972.0 9016.8 9034.0 9248.8 15528.8 15810.3 16495.1 16549.3 16575.9 6452.9 6472.6 6565.6 6572.1 6677.5 3556.3 3557.1 3672.9 3697.9 3721.3 2702.2 2722.0 2727.0 2735.9 2737.2 485.1 505.4 505.9 506.2 513.8 423.8 514.0 593.0 608.8 634.2 7735.2 7991.6 8062.5 8152.6 8507.5 452.4 453.6 494.4 596.7 606.2 3682.4 3733.2 3855.8 3871.7 3963.8 47816.0 48666.8 48928.5 49298.8 49325.5 43168.0 43201.1 43606.1 43828.8 44431.1 43550.3 44130.1 44781.0 45153.8 45205.1 8456.2 8554.1 8609.4 8876.2 8951.9 33060.7 33699.7 34014.8 34395.3 34555.1 40012.0 40147.2 42002.4 43351.6 43404.3 10725.6 10857.3 10937.3 10988.1 11017.5 11345.4 11353.5 11453.3 11584.2 11684.8 10618.2 10645.4 10861.2 10995.6 11078.1 10642.1 10726.9 10915.4 10915.5 10931.6 10322.8 10369.0 10397.9 10787.7 10902.3 9538.3 9737.9 9923.5 10268.9 10282.2 9429.3 9577.7 9654.1 9701.3 9727.8 09:45:08 INFO - 2015-11-28 09:45:08,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:45:08 INFO - 2015-11-28 09:45:08,293 DEBUG : BROWSER_OUTPUT: 09:45:09 INFO - 2015-11-28 09:45:09,029 INFO : Browser exited with error code: 0 09:45:09 INFO - 2015-11-28 09:45:09,046 INFO : Completed test dromaeo_css (00:18:35) 09:45:09 INFO - 2015-11-28 09:45:09,046 INFO : Starting test kraken 09:45:09 INFO - 2015-11-28 09:45:09,046 DEBUG : operating with platform_type : linux_ 09:45:09 INFO - 2015-11-28 09:45:09,046 INFO : Initialising browser for kraken test... 09:45:09 INFO - 2015-11-28 09:45:09,052 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMhV0s/profile http://localhost:60446/getInfo.html 09:45:14 INFO - 2015-11-28 09:45:14,791 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:14 INFO - 2015-11-28 09:45:14,791 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:14 INFO - 2015-11-28 09:45:14,791 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:45:14 INFO - 2015-11-28 09:45:14,791 DEBUG : BROWSER_OUTPUT: __metrics 09:45:15 INFO - 2015-11-28 09:45:15,893 INFO : Browser initialized. 09:45:15 INFO - 2015-11-28 09:45:15,894 INFO : Running cycle 1/1 for kraken test... 09:45:15 INFO - 2015-11-28 09:45:15,894 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMhV0s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:27 INFO - 2015-11-28 09:45:27,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 09:45:27 INFO - 2015-11-28 09:45:27,866 DEBUG : BROWSER_OUTPUT: 09:45:30 INFO - 2015-11-28 09:45:30,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60446/tests/kraken/driver.html?testName=audio-beat-detection) 09:45:31 INFO - 2015-11-28 09:45:31,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 140599296 09:45:31 INFO - 2015-11-28 09:45:31,055 DEBUG : BROWSER_OUTPUT: 09:45:33 INFO - 2015-11-28 09:45:33,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60446/tests/kraken/driver.html?testName=audio-dft) 09:45:34 INFO - 2015-11-28 09:45:34,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 140890112 09:45:34 INFO - 2015-11-28 09:45:34,435 DEBUG : BROWSER_OUTPUT: 09:45:37 INFO - 2015-11-28 09:45:37,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60446/tests/kraken/driver.html?testName=audio-fft) 09:45:37 INFO - 2015-11-28 09:45:37,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 134742016 09:45:37 INFO - 2015-11-28 09:45:37,941 DEBUG : BROWSER_OUTPUT: 09:45:39 INFO - 2015-11-28 09:45:39,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60446/tests/kraken/driver.html?testName=audio-oscillator) 09:45:40 INFO - 2015-11-28 09:45:40,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 134975488 09:45:40 INFO - 2015-11-28 09:45:40,566 DEBUG : BROWSER_OUTPUT: 09:45:42 INFO - 2015-11-28 09:45:42,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:45:43 INFO - 2015-11-28 09:45:43,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 136740864 09:45:43 INFO - 2015-11-28 09:45:43,450 DEBUG : BROWSER_OUTPUT: 09:45:46 INFO - 2015-11-28 09:45:46,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60446/tests/kraken/driver.html?testName=imaging-darkroom) 09:45:47 INFO - 2015-11-28 09:45:47,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 137138176 09:45:47 INFO - 2015-11-28 09:45:47,121 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-28 09:45:50,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60446/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:51 INFO - 2015-11-28 09:45:51,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 135290880 09:45:51 INFO - 2015-11-28 09:45:51,237 DEBUG : BROWSER_OUTPUT: 09:45:54 INFO - 2015-11-28 09:45:54,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60446/tests/kraken/driver.html?testName=json-parse-financial) 09:45:54 INFO - 2015-11-28 09:45:54,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 135962624 09:45:54 INFO - 2015-11-28 09:45:54,730 DEBUG : BROWSER_OUTPUT: 09:45:56 INFO - 2015-11-28 09:45:56,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:57 INFO - 2015-11-28 09:45:57,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 138100736 09:45:57 INFO - 2015-11-28 09:45:57,126 DEBUG : BROWSER_OUTPUT: 09:45:59 INFO - 2015-11-28 09:45:59,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:59 INFO - 2015-11-28 09:45:59,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 136962048 09:45:59 INFO - 2015-11-28 09:45:59,654 DEBUG : BROWSER_OUTPUT: 09:46:01 INFO - 2015-11-28 09:46:01,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:46:02 INFO - 2015-11-28 09:46:02,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 138432512 09:46:02 INFO - 2015-11-28 09:46:02,402 DEBUG : BROWSER_OUTPUT: 09:46:04 INFO - 2015-11-28 09:46:04,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:05 INFO - 2015-11-28 09:46:05,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 137719808 09:46:05 INFO - 2015-11-28 09:46:05,609 DEBUG : BROWSER_OUTPUT: 09:46:08 INFO - 2015-11-28 09:46:08,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:08 INFO - 2015-11-28 09:46:08,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 137338880 09:46:08 INFO - 2015-11-28 09:46:08,811 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60446/tests/kraken/driver.html?testName=ai-astar) 09:46:10 INFO - 2015-11-28 09:46:10,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 137760768 09:46:10 INFO - 2015-11-28 09:46:10,871 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,871 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:46:10 INFO - 2015-11-28 09:46:10,871 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:46:10 INFO - 2015-11-28 09:46:10,871 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:46:10 INFO - 2015-11-28 09:46:10,871 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:46:10 INFO - 2015-11-28 09:46:10,871 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;113;113;113;124;114;114;115;114 09:46:10 INFO - 2015-11-28 09:46:10,871 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;130;158;172;142;158;154;137;171;142 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |2;audio-dft;166;164;163;164;163;165;168;164;165;162 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;73;138;72;73;73;73;87 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;139;95;94;96;128;96;94;128 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;111 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;149;148;150;148;148;148;148 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;96;96;96;97;96;96 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;77;77;74;77;74;77;82;72;73 09:46:10 INFO - 2015-11-28 09:46:10,872 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;69;69;69;69;71 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;84;86;84;87;85;83;87;84 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;120;130;127;122;121;128;128;133;131 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;150;148;149;150;155;150;140;144;149 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;71;77;71;71;71;72;70;75 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,824 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: __startTimestamp1448732770866__endTimestamp 09:46:10 INFO - 2015-11-28 09:46:10,873 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:4.13 (3.6%) stddev-sans-first:4.37 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 113.0 113.0 113.0 124.0 114.0 114.0 115.0 114.0 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.30 Median:158.00 stddev:14.12 (8.9%) stddev-sans-first:14.77 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: Values: 159.0 130.0 158.0 172.0 142.0 158.0 154.0 137.0 171.0 142.0 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:1.71 (1.0%) stddev-sans-first:1.72 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: Values: 166.0 164.0 163.0 164.0 163.0 165.0 168.0 164.0 165.0 162.0 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,875 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:20.67 (28.3%) stddev-sans-first:21.69 09:46:10 INFO - 2015-11-28 09:46:10,876 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 73.0 138.0 72.0 73.0 73.0 73.0 87.0 09:46:10 INFO - 2015-11-28 09:46:10,876 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,876 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.50 stddev:17.98 (19.0%) stddev-sans-first:18.54 09:46:10 INFO - 2015-11-28 09:46:10,876 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 139.0 95.0 94.0 96.0 128.0 96.0 94.0 128.0 09:46:10 INFO - 2015-11-28 09:46:10,876 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,876 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 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 149.0 148.0 150.0 148.0 148.0 148.0 148.0 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.70 Median:77.00 stddev:2.91 (3.8%) stddev-sans-first:3.02 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: Values: 74.0 77.0 77.0 74.0 77.0 74.0 77.0 82.0 72.0 73.0 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 09:46:10 INFO - 2015-11-28 09:46:10,877 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 71.0 09:46:10 INFO - 2015-11-28 09:46:10,878 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,878 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.84 (2.2%) stddev-sans-first:1.73 09:46:10 INFO - 2015-11-28 09:46:10,878 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 84.0 86.0 84.0 87.0 85.0 83.0 87.0 84.0 09:46:10 INFO - 2015-11-28 09:46:10,878 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,878 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:128.00 stddev:4.61 (3.6%) stddev-sans-first:4.64 09:46:10 INFO - 2015-11-28 09:46:10,878 DEBUG : BROWSER_OUTPUT: Values: 122.0 120.0 130.0 127.0 122.0 121.0 128.0 128.0 133.0 131.0 09:46:10 INFO - 2015-11-28 09:46:10,878 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,879 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:149.50 stddev:5.35 (3.6%) stddev-sans-first:4.21 09:46:10 INFO - 2015-11-28 09:46:10,879 DEBUG : BROWSER_OUTPUT: Values: 137.0 150.0 148.0 149.0 150.0 155.0 150.0 140.0 144.0 149.0 09:46:10 INFO - 2015-11-28 09:46:10,879 DEBUG : BROWSER_OUTPUT: 09:46:10 INFO - 2015-11-28 09:46:10,879 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.00 stddev:2.21 (3.1%) stddev-sans-first:2.32 09:46:10 INFO - 2015-11-28 09:46:10,879 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 77.0 71.0 71.0 71.0 72.0 70.0 75.0 09:46:10 INFO - 2015-11-28 09:46:10,879 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:46:10 INFO - 2015-11-28 09:46:10,879 DEBUG : BROWSER_OUTPUT: 09:46:11 INFO - 2015-11-28 09:46:11,789 INFO : Browser exited with error code: 0 09:46:11 INFO - 2015-11-28 09:46:11,838 INFO : Completed test kraken (00:01:02) 09:46:11 INFO - 2015-11-28 09:46:11,839 INFO : Starting test v8_7 09:46:11 INFO - 2015-11-28 09:46:11,839 DEBUG : operating with platform_type : linux_ 09:46:11 INFO - 2015-11-28 09:46:11,839 INFO : Initialising browser for v8_7 test... 09:46:11 INFO - 2015-11-28 09:46:11,845 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFr15HX/profile http://localhost:60446/getInfo.html 09:46:17 INFO - 2015-11-28 09:46:17,511 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:46:17 INFO - 2015-11-28 09:46:17,512 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:46:17 INFO - 2015-11-28 09:46:17,512 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:46:17 INFO - 2015-11-28 09:46:17,512 DEBUG : BROWSER_OUTPUT: __metrics 09:46:19 INFO - 2015-11-28 09:46:19,009 INFO : Browser initialized. 09:46:19 INFO - 2015-11-28 09:46:19,010 INFO : Running cycle 1/1 for v8_7 test... 09:46:19 INFO - 2015-11-28 09:46:19,010 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFr15HX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:46:30 INFO - 2015-11-28 09:46:30,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 138768384 09:46:30 INFO - 2015-11-28 09:46:30,991 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60446/tests/v8_7/run.html (next: http://localhost:60446/tests/v8_7/run.html) 09:46:52 INFO - 2015-11-28 09:46:52,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 137809920 09:46:52 INFO - 2015-11-28 09:46:52,738 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,738 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:46:52 INFO - 2015-11-28 09:46:52,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:46:52 INFO - 2015-11-28 09:46:52,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:46:52 INFO - 2015-11-28 09:46:52,738 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.84288354898337 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.31558513588465 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1068.3760683760684 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |5;Earley;719.4244604316547 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 09:46:52 INFO - 2015-11-28 09:46:52,739 DEBUG : BROWSER_OUTPUT: |7;RegExp;25666.666666666668 09:46:52 INFO - 2015-11-28 09:46:52,740 DEBUG : BROWSER_OUTPUT: |8;Splay;606.060606060606 09:46:52 INFO - 2015-11-28 09:46:52,740 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 09:46:52 INFO - 2015-11-28 09:46:52,740 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:46:52 INFO - 2015-11-28 09:46:52,740 DEBUG : BROWSER_OUTPUT: __startTimestamp1448732812735__endTimestamp 09:46:52 INFO - 2015-11-28 09:46:52,740 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,741 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:46:52 INFO - 2015-11-28 09:46:52,741 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:46:52 INFO - 2015-11-28 09:46:52,741 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,741 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,741 DEBUG : BROWSER_OUTPUT: Values: 165.9 09:46:52 INFO - 2015-11-28 09:46:52,742 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,742 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.84 Median:184.84 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,742 DEBUG : BROWSER_OUTPUT: Values: 184.8 09:46:52 INFO - 2015-11-28 09:46:52,742 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,742 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.32 Median:277.32 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,742 DEBUG : BROWSER_OUTPUT: Values: 277.3 09:46:52 INFO - 2015-11-28 09:46:52,742 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,743 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,743 DEBUG : BROWSER_OUTPUT: Values: 5208.3 09:46:52 INFO - 2015-11-28 09:46:52,743 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,743 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,743 DEBUG : BROWSER_OUTPUT: Values: 1068.4 09:46:52 INFO - 2015-11-28 09:46:52,743 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,744 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:719.42 Median:719.42 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,744 DEBUG : BROWSER_OUTPUT: Values: 719.4 09:46:52 INFO - 2015-11-28 09:46:52,744 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,744 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,744 DEBUG : BROWSER_OUTPUT: Values: 12180.7 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: Values: 25666.7 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.06 Median:606.06 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: Values: 606.1 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: Values: 4845.4 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:46:52 INFO - 2015-11-28 09:46:52,745 DEBUG : BROWSER_OUTPUT: 09:46:53 INFO - 2015-11-28 09:46:53,957 INFO : Browser exited with error code: 0 09:46:53 INFO - 2015-11-28 09:46:53,972 INFO : Completed test v8_7 (00:00:42) 09:46:54 INFO - 2015-11-28 09:46:54,221 INFO : Completed test suite (00:20:20) 09:46:54 INFO - 2015-11-28 09:46:54,221 DEBUG : Working with test: dromaeo_css 09:46:54 INFO - 2015-11-28 09:46:54,221 DEBUG : Generating results file: dromaeo_css 09:46:54 INFO - 2015-11-28 09:46:54,222 DEBUG : Working with test: kraken 09:46:54 INFO - 2015-11-28 09:46:54,222 DEBUG : Generating results file: kraken 09:46:54 INFO - 2015-11-28 09:46:54,223 INFO : javascript benchmark 09:46:54 INFO - 2015-11-28 09:46:54,223 DEBUG : Working with test: v8_7 09:46:54 INFO - 2015-11-28 09:46:54,223 DEBUG : Generating results file: v8_7 09:46:54 INFO - 2015-11-28 09:46:54,223 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:54 INFO - 2015-11-28 09:46:54,283 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 09:46:54 INFO - 2015-11-28 09:46:54,284 DEBUG : process_Request line: dromaeo_css 6269.69 graph.html#tests=[[72,132,43]] 09:46:54 INFO - 2015-11-28 09:46:54,284 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:54 INFO - 2015-11-28 09:46:54,314 DEBUG : process_Request line: kraken 1546.40 graph.html#tests=[[232,132,43]] 09:46:54 INFO - 2015-11-28 09:46:54,314 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:46:54 INFO - 2015-11-28 09:46:54,344 DEBUG : process_Request line: v8_7 21378.85 graph.html#tests=[[230,132,43]] 09:46:54 INFO - 2015-11-28 09:46:54,345 INFO : javascript benchmark 09:46:54 INFO - 2015-11-28 09:46:54,349 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.960775588366, 2647.404334024846, 2688.166668332816, 2701.1896431070672, 2714.443539074489, 4543.136804007245, 4669.136209801185, 4701.177293973554, 4704.717716936982, 4739.0, 4626.375439315691, 4665.136949664306, 4679.9298010529865, 4750.691205071676, 4781.282807578865, 4300.2689542777725, 4340.609345158935, 4346.239408103585, 4349.086691794727, 4429.645628349725, 4325.74045557266, 4403.889902752425, 4410.933835992462, 4445.266531022394, 4491.528389519102, 4141.233871733739, 4238.533761286256, 4297.419848320468, 4364.388985542043, 4393.648508119375, 4305.870823875289, 4340.936470564732, 4358.411614432042, 4360.738355698668, 4393.340998850166, 4347.5652434756585, 4349.608535231812, 4349.717268377545, 4376.496702879178, 4410.25025745624, 4389.670774691911, 4434.401355816988, 4486.282194848808, 4601.4248218972625, 4612.331211974279, 4988.800447982077, 5056.595472362239, 5057.291979122926, 5064.898702025939, 5083.949160508385, 4764.785584648665, 5064.417591976933, 5064.594832413435, 5065.797368105272, 5120.667156634807, 4579.519150489184, 4605.953940460619, 4663.393758811333, 4672.042231342567, 4698.976505117453, 5172.922406163911, 5218.191180367049, 5220.112580861187, 5251.894962100813, 5273.499017593323, 4713.929291060636, 4805.879853003633, 5012.699238045729, 5038.974805125951, 5048.5203905628905, 4853.684510506876, 4976.377952755905, 4991.750412479361, 5005.874853128701, 5039.823606173766, 4993.925091123636, 4996.4254110777, 5001.049800537886, 5006.499350064964, 5013.623978201649, 4769.928451073237, 4890.413150421901, 5014.924776128361, 5015.849524514198, 5065.037642847921, 4135.60711732385, 4182.707210495236, 4203.0543127796, 4237.025484138665, 4243.490781106287, 3664.523611930432, 3688.8155592220282, 3697.0757310672334, 3724.217914237986, 3736.065983504124, 4226.640735537514, 4267.701260911706, 4349.499807522176, 4400.515943246241, 4405.185040767468, 5047.242913562922, 5064.772085256172, 5101.566366858859, 5101.7194054327365, 5116.360454943132, 4350.891227719332, 4406.845760398371, 4418.204723149864, 4439.64482841372, 4469.284914413678, 4285.400043993844, 4338.609525142752, 4373.803178856959, 4436.511983681792, 4444.977775111104, 4736.550027747358, 4747.264174053027, 4786.712797232108, 4802.375691160127, 4802.73584952831, 5016.698998060128, 5027.673201241908, 5036.320096787033, 5044.873878153076, 5072.467390924047, 4611.515790841913, 4630.884227894195, 4692.53074692528, 4698.318743782201, 4778.426588809365, 4920.581750551243, 4930.285108659153, 4943.530364615356, 4984.975075124601, 5022.221555658879, 4761.047790441856, 5059.418166910705, 5063.822766203165, 5064.392272927273, 5103.515166059218, 4760.119377915097, 4816.686915350491, 4818.373611430492, 4834.250691142878, 4889.0, 4846.006568653488, 4878.0, 4878.902421951612, 4901.607871370211, 4927.778249978831, 4517.186906356887, 4679.836205732783, 4774.95225047759, 4798.424189097331, 4811.9518804811505, 4797.9040419192115, 4928.063667903087, 4947.505249475168, 4980.128477516348, 5022.045811295842, 4755.667103302874, 4757.690750101232, 4772.188727916193, 4776.188048031912, 4808.711477311373], "unit": "ms", "name": "dojo.html", "value": 4601.299891263756}, {"lowerIsBetter": false, "replicates": [548.7722595123022, 554.2130175151285, 577.1746402644219, 582.1384351160284, 584.815783028346, 27663.861680691592, 36344.273114537726, 36668.816655916686, 36776.712815051476, 37037.259254814955, 39454.0, 40088.79955600218, 40154.39768403476, 40168.598314016854, 40199.397009044886, 7955.801104972378, 8104.716334928249, 8143.348532117446, 8148.633311500997, 8169.95915020424, 7945.841083178333, 8096.919030809676, 8108.513489190638, 8115.715949941753, 8141.877871831927, 8102.270795628392, 8188.590570471482, 8223.876641850347, 8227.053888802775, 8244.752657420288, 8021.598920053974, 8059.355251579889, 8087.353011759045, 8101.068377136587, 8125.9842519685035, 7910.7231246906085, 7962.761117166494, 7994.080680721733, 8031.0, 8080.676772929076, 36993.0, 37503.624963750284, 37563.62436375629, 37572.0, 37802.62197378019, 2934.60382848317, 3014.773891958112, 3255.4465740824116, 3318.634950155481, 3399.895034113898, 28308.575371369447, 28324.575131373047, 28403.573946390614, 28614.14157575276, 28939.0, 3388.3053973935284, 3442.8794992175403, 3497.3355062538035, 3507.7018453431488, 3550.5206797082324, 216800.0, 217116.0, 217139.0, 217593.0, 217825.0, 51462.74268628633, 52553.0, 56029.719851400485, 56279.155812662844, 62098.379016210165, 56855.14717279244, 57043.71478142583, 57356.426435735106, 57532.71233643805, 57597.712011439675, 12640.862322390845, 12651.810222846665, 12722.045846561545, 12808.423620937081, 12884.291363975071, 9905.851412228678, 9917.0, 9920.305578609572, 10006.849897251546, 10058.34620749649, 19567.706484402745, 19857.503562411057, 19863.503412414517, 19869.900650496656, 19873.60252794936, 7659.961700191463, 7732.884006739903, 7863.72476963315, 7923.0, 8020.0, 808.9838203235902, 851.089334412173, 932.4079209701888, 1009.4195837393528, 1043.6242952537082, 25972.35069123287, 26263.343416414362, 26274.6058809118, 26330.21009369722, 26474.867625661747, 921.953902304882, 931.4550987672152, 942.2979879989451, 1024.5645600619707, 1053.657561292583, 13095.672608184681, 13375.130616509896, 13584.45662173502, 13615.931920340534, 13627.25050122233, 308530.0, 313749.0, 314858.0, 317344.0, 317390.0, 46413.0, 46429.767851160526, 46434.535654643696, 46524.06951860944, 46888.765556172686, 1175.26545908807, 1180.2859270141612, 1199.892009719112, 1201.0271679939276, 1201.5494189678695, 23952.802359882284, 24415.633765493887, 24500.6324905123, 24624.384390390383, 24697.542344071484, 38195.42706859344, 38544.6145538541, 38859.0, 38860.41709374418, 38896.6110338893, 241001.51487123792, 244947.0, 245410.0, 246358.0, 246881.0, 29088.236617521303, 42177.0, 42774.0, 42875.0, 43175.784121079196, 45777.0, 46698.06603867836, 46718.299225510964, 47411.28883066826, 47567.76216118897, 33453.33093338071, 33664.49503257502, 34335.65664343325, 34785.0, 35025.64974350224, 38036.619633803304, 38852.41721374125, 40018.599814001485, 40411.59588404196, 40590.39114413227, 38460.80769596134, 38525.80737096297, 39033.21933561256, 39033.609663904135, 39464.60535394724, 30173.849130754206, 30892.22769430782, 31055.84472077625, 31219.0, 31223.687763122987, 23984.321097523007, 24527.01891924303, 24591.631125532775, 24666.383340416633, 24828.751712483365], "unit": "ms", "name": "ext.html", "value": 17374.96785415458}, {"lowerIsBetter": false, "replicates": [319.2848020434228, 320.1372301647062, 321.63012535584073, 327.1396227920567, 328.57613678354926, 15011.0, 15075.472358467456, 15365.0, 15912.0, 16516.66966660666, 13813.51652692156, 13843.792343114861, 13907.443702251923, 14297.285135743197, 14934.103953762782, 4470.0389416275575, 4478.552144785528, 4542.0, 4561.429821272341, 4570.611498022672, 4527.207738645724, 4565.61192298655, 4570.474395444517, 4572.245579479399, 4583.633309335245, 3352.2792599591085, 4444.20004399208, 4602.194615942213, 4610.631149508048, 5262.2632831403635, 5155.845324640248, 5178.249153872705, 5184.948150518484, 5212.1660534314515, 5230.163173892159, 4559.954400456019, 4591.977040114812, 4655.092257009885, 4993.575546078588, 5000.649954503187, 18083.819161808344, 18183.54541136469, 18266.36067737636, 19222.135003924857, 19325.806741932684, 1708.6582683463357, 1724.5774785177712, 1768.3457120865362, 1838.1820090059928, 1856.712209607513, 8779.253763430115, 8829.293656507463, 8957.462552246887, 9048.411853229585, 11251.437428128642, 1728.9567760805955, 1758.648270345923, 1894.7536820213422, 1914.2247389807012, 1932.2367664772478, 56644.0, 57612.0, 58058.0, 58617.0, 59625.0, 9683.757906052406, 9878.802423951482, 10037.0, 10071.5467803949, 10103.09072183507, 12499.93750031244, 12513.687157821127, 12544.874551254554, 12583.0, 12588.559400420942, 6943.930560694328, 6981.755638552626, 7015.8596828063155, 7023.367896889305, 7087.893681594677, 6564.540482166298, 6599.8020059398295, 6600.174978127734, 6616.305287944792, 6659.0, 4224.788760562021, 4229.302165142779, 4244.893877653083, 4272.423222864935, 4296.2911119664905, 1628.6091338079013, 1759.7536344911723, 1764.1708397053364, 1766.4170823628172, 1777.9022153781666, 344.6691176470616, 348.0828018172084, 349.50544978854634, 810.5015415519531, 828.6395417993192, 9328.533573321307, 9424.151826335663, 9515.714528564155, 9581.952090239503, 9612.134907858326, 809.2069771623724, 820.6104033181166, 821.3059964330131, 823.9382046346548, 880.704963837109, 8387.329013678891, 8525.275351595059, 8568.828623427496, 8609.827803443895, 8651.394402391898, 525238.0, 532379.3810309469, 538628.0, 552642.0, 553164.0, 69727.65136174287, 71855.92216116762, 72773.636131819, 74639.0, 75227.62386188144, 1087.6465148826662, 1093.6172339681048, 1110.2339385823757, 1112.554978008803, 1114.966551003455, 13893.235872027135, 14045.578632641038, 14066.929665351608, 14071.155730656194, 14142.646433838825, 30792.230194245323, 31297.374052518368, 31825.5226171603, 31841.363172735953, 31949.6805031956, 43442.34836477392, 43583.0, 43776.56223437852, 44169.33745993877, 46334.30498542457, 8619.267362274277, 8752.124787521198, 8759.16787905148, 8841.336899732674, 8857.64569417216, 12022.338771367658, 15932.8406715936, 16347.754783678492, 16410.835891641407, 16481.752773708165, 12886.613401597591, 13946.30268486592, 13961.309508959186, 14197.858021420067, 14353.928230359199, 12821.423035963218, 13270.469181232642, 13388.129771564818, 13539.932300338436, 13625.795613065613, 13768.93115534456, 13867.653308667364, 14067.366968486238, 14112.50606228777, 14248.715025699636, 8449.788755281168, 8603.096674849301, 8743.693970710994, 8750.82498350042, 8751.212390884597, 12882.420291086735, 13763.105398149088, 13807.033507654367, 14151.221682807545, 14165.0], "unit": "ms", "name": "jquery.html", "value": 7982.216444798121}, {"lowerIsBetter": false, "replicates": [1462.663587374903, 1607.7106120898238, 1623.691498615263, 1666.042025835145, 1681.6972944869926, 5436.103042997901, 5717.256756621644, 6318.810435686931, 6711.966440167798, 6724.63014534201, 6219.346968568303, 6501.544891857572, 6516.70674819633, 6539.803805885819, 6574.408303252706, 1921.2411097616398, 1951.0537389366145, 1953.7753158386754, 1957.1584218785915, 1962.3328068456722, 1946.7858535561147, 1949.8342640875542, 1961.2155137944865, 2019.1923230707687, 2025.463252238158, 1935.5644979879555, 1944.965853268898, 1947.1724517080256, 1954.2378472395776, 1955.5697746495819, 1926.807319268069, 1930.942071737857, 1950.5123719070232, 1953.7850836407983, 1957.628050670368, 1947.1821834829407, 1964.5186929202437, 1967.842572594189, 1968.7440632717655, 1977.5253939054667, 6477.902831457532, 6539.50953678476, 6578.638174900427, 6594.901076483857, 6613.074169616258, 3820.6752426043818, 3882.650561449455, 3916.725829191958, 3917.275304068756, 3926.587708290617, 2492.626106084102, 2515.05685367987, 2530.6204069389555, 2566.4353842154696, 2577.9945821129772, 826.2604968553171, 826.9421140520166, 840.9075001749864, 849.413904405958, 857.7941294089436, 8573.228409443118, 8574.228319451217, 8576.271016963503, 8665.783355416102, 8700.738977830675, 3413.6415676354122, 3426.0407086015957, 3446.551948246712, 3471.8264086795557, 3478.1478537757907, 7384.2246564111065, 7438.628068596657, 7491.138519070268, 7498.512596681198, 7502.512336698097, 3868.613138686109, 3875.6822680288838, 3888.0279930017496, 3912.667423268997, 3915.980420097881, 3329.067860998924, 3467.0638927489435, 3494.4932984717584, 3504.737144714157, 3520.9295814083575, 2996.131121974603, 3016.8039077459894, 3017.125033740235, 3024.5765592817024, 3025.9546106808416, 857.0443954990266, 872.5986046418718, 888.9644414223488, 892.0767006148606, 892.8928528576482, 1157.1908672002198, 1174.442139983501, 1182.485618755844, 1187.2579637726421, 1198.8141838015122, 6247.312795592481, 6258.405451482102, 6278.811635650938, 6291.056341548804, 6291.842703932347, 986.5461887531816, 1000.4547521600599, 1015.5633077776627, 1023.4473384372504, 1031.2059714020313, 5036.420811606712, 5039.244113383022, 5050.974745126251, 5069.417017043013, 5071.721055341918, 7559.886601700979, 7639.274268944441, 7768.378529717609, 7856.410769192334, 7866.72466463671, 7670.463067585216, 7706.190849960785, 7718.343940764986, 7794.10367807698, 7816.570088645065, 6213.99999999991, 6280.246370435486, 6290.0, 6334.588251763713, 6345.365463453618, 5984.042553191469, 6009.098635204754, 6014.398560143951, 6031.276246850406, 6037.486813620892, 6830.965845170742, 6939.167299924042, 6990.580565165903, 7018.473614478832, 7040.964795175992, 7080.787576372717, 7159.964200178966, 7191.928080719335, 7198.964005179941, 7217.314355136254, 4891.413030436371, 4968.304437378698, 5698.116791897262, 5733.541316694571, 5772.5381969441505, 6081.087836824512, 6233.376662333731, 6278.215223097113, 6298.590591611531, 6313.179286692701, 5844.47399734026, 5904.468597826216, 5941.643501389931, 5951.940480595312, 6053.485453736305, 5837.299524056971, 5837.474627283565, 5862.736176871966, 5866.560007999332, 5904.734286957183, 5920.407959204045, 5922.555808314308, 5949.405059494189, 6000.429959153874, 6066.757329706938, 5511.862203444946, 5512.952539017734, 5520.199571062254, 5578.051731205786, 5609.046462101534, 5631.8592035199445, 5631.88736225265, 5662.377138514677, 5703.8859222816145, 5707.1724599933605], "unit": "ms", "name": "mootools.html", "value": 3801.7109628051753}, {"lowerIsBetter": false, "replicates": [288.2232383725859, 294.6670262603258, 295.8210282778919, 298.19784778944637, 298.4776640878463, 5502.697351645658, 5595.104783234683, 5639.2105105285245, 5674.432556744324, 5685.1756495308255, 5576.776928922848, 5577.637453565526, 5586.190002449653, 5607.635503692257, 5618.4662457066515, 4270.402143699885, 4278.893027674302, 4283.293256612656, 4283.614474697284, 4290.6138447539715, 4157.417961485395, 4239.130978149472, 4240.109576988836, 4279.1227798301425, 4285.764282964436, 4161.438205842218, 4182.142660754538, 4182.560831112735, 4195.790210489478, 4221.0291632924445, 4206.053637931472, 4209.34755112958, 4210.115875666113, 4213.178430206111, 4236.576342365739, 3650.0, 3651.5618125824803, 3652.4886515887797, 3656.360136976045, 3666.2667466506805, 5289.603279754034, 5319.308489896327, 5415.323084614423, 5442.891142177174, 5449.291592093042, 4802.327674125625, 4808.158572249842, 4811.687240329367, 4812.302216178635, 4813.374261346037, 5842.065269556851, 5851.941480585225, 5864.618799778001, 5868.882622347572, 5879.500242479395, 3928.64642182205, 3938.0548668319684, 3943.0930885896405, 3943.2310699413624, 3963.742356746802, 5929.258842644669, 6158.8768224635705, 6169.81490555284, 6169.951108311598, 6197.442230199259, 3983.083890705096, 3999.7400168988925, 4009.538903026131, 4010.959890401117, 4012.799360031987, 4051.7974101294817, 4054.0675644601906, 4067.186562687415, 4070.430139780433, 4073.450084238649, 4741.525847415231, 4751.881202969884, 4758.476567577563, 4760.619150467955, 4765.618750499952, 5741.7990370337675, 5837.708114594253, 5891.351951285355, 5895.528357731371, 5907.1434641976675, 1450.6445920749272, 1466.948656797007, 1467.0610809082195, 1470.073853472327, 1471.6835880285576, 966.7969726357403, 968.0, 968.1867231525553, 987.4026214140486, 987.9604815807431, 5148.76830542619, 5168.2764412982215, 5182.170852663556, 5189.117849965515, 5191.377034755854, 6136.8772624548155, 6140.263168419729, 6144.109104179869, 6146.139540464339, 6152.661603611755, 5167.483251674803, 5169.741512924414, 5173.094708426086, 5178.97410512945, 5189.221616757441, 3262.6411094779555, 3303.1907182740383, 3334.8165850878436, 3356.9664303357144, 3366.6633336666628, 5811.360750317462, 5823.097419899922, 5844.707764611752, 5846.590738648339, 5855.121731740273, 6034.336223015464, 6150.969245153835, 6160.014397696347, 6339.619622822645, 6360.427561519393, 5774.884502310014, 5813.59304848665, 5814.622049566765, 5814.796482123105, 5820.068788993741, 6161.691915404302, 6164.167837341902, 6169.043798211284, 6175.413335733098, 6179.752809887555, 5785.334686511105, 5971.970140149271, 6009.0, 6020.157177994996, 6025.8192254232445, 5748.568857335633, 5806.82579522615, 5812.244408226903, 5824.5631577631, 5840.532757379485, 4032.0726232965994, 4045.110075783323, 4060.309747343018, 4060.715749897479, 4067.9389809152294, 6046.0, 6141.631502109888, 6173.41352571505, 6173.969130154321, 6178.66017369049, 5902.1146827976145, 5903.0555111182, 5905.261842269716, 5913.852153696192, 5922.555808314308, 5905.527557795452, 5923.407659234214, 5930.0, 5932.911006334994, 5939.2575928009, 5614.775408983758, 5773.0, 5774.82675519735, 5782.3639399666845, 5786.884262314646, 5961.344252132349, 5962.344142144448, 5968.4031596841705, 5978.8206353809455, 5991.0, 5793.188953546422, 5806.042003069446, 5810.1575271586225, 5820.1560773688425, 5829.125631155191], "unit": "ms", "name": "prototype.html", "value": 4366.332152678854}, {"lowerIsBetter": false, "replicates": [698.5703792167818, 730.9963450182752, 756.1984296645555, 774.759824454419, 774.8992630957974, 11306.717332066692, 11667.41662916855, 11702.941485292562, 11752.353620550866, 11754.706132346684, 10537.52581133849, 10669.093127084207, 10689.893101068987, 10692.251542392036, 10694.839577406345, 576.20771439271, 602.0908428273317, 608.2731136292133, 756.8297133145026, 771.783900507856, 764.4114032195206, 770.6493545436841, 772.382094324541, 776.4370831147401, 777.0209535984671, 737.4505993035169, 798.8362385710915, 803.8030682482771, 806.2340776262545, 813.5403497024163, 790.1150711203431, 802.5505716798612, 804.5574933786423, 805.8589746794316, 807.9192080791933, 593.4332712259825, 598.1058317814894, 601.515779797263, 601.651042395414, 601.7021574320695, 10708.357498550035, 10757.78484430307, 10766.515506802134, 10770.838437423445, 10774.5690172393, 10302.896971030268, 10392.896071039344, 10859.185561082872, 11122.777544449147, 11278.323300601991, 9474.336796424253, 9496.525173741285, 9533.47565883876, 9744.610215591369, 9749.853752193723, 3167.651558328582, 3218.308063766278, 3243.2702641905616, 3255.365203785263, 3258.3809076275434, 41212.58787412118, 41357.79321103375, 41395.0, 41436.792816035726, 41642.79178604148, 8676.305895528343, 8971.975624061894, 9016.819663606691, 9033.954830225939, 9248.815023699488, 15528.844711552965, 15810.288537015862, 16495.092769897772, 16549.338026479047, 16575.91712041432, 6452.870942581122, 6472.579282346633, 6565.606063636197, 6572.112764776694, 6677.465802735769, 3556.324298383299, 3557.1285035166034, 3672.944905826415, 3697.8520859165333, 3721.2557488502407, 2702.2163572563736, 2721.9727802722114, 2726.9727302727115, 2735.86320683965, 2737.2335745991154, 485.05898556799696, 505.4389627513457, 505.9494050594985, 506.1597747738736, 513.7585334892594, 423.77116357166784, 514.0182251898855, 592.9762809487572, 608.8143116349468, 634.2167423232304, 7735.22647735222, 7991.640376183086, 8062.516249025077, 8152.592370381457, 8507.532085735344, 452.38927447945014, 453.5713750505806, 494.35239835815196, 596.6664504831698, 606.1756011823916, 3682.3739964206147, 3733.1600389912596, 3855.76865388072, 3871.7289789715014, 3963.8018099095507, 47816.043679126225, 48666.75666621644, 48928.510714893106, 49298.753506232955, 49325.50674493281, 43168.0, 43201.135977280275, 43606.127877442275, 43828.780856095516, 44431.111377772264, 43550.34674479885, 44130.11739765251, 44781.0, 45153.77423112929, 45205.095898081854, 8456.196661317164, 8554.144585541397, 8609.354298427768, 8876.20114189726, 8951.910480895107, 33060.66939330672, 33699.66300336965, 34014.829925851205, 34395.31209375848, 34555.13612159716, 40012.0, 40147.19705605813, 42002.36996444994, 43351.566484334755, 43404.348934765374, 10725.570977160825, 10857.294275872044, 10937.343759374464, 10988.066014388867, 11017.504212310305, 11345.432728363383, 11353.48909299067, 11453.312801231952, 11584.247023943417, 11684.766304674029, 10618.203634727271, 10645.414502202453, 10861.239713219999, 10995.560177592806, 11078.058365039062, 10642.148628109888, 10726.892731072589, 10915.39965301916, 10915.508802103766, 10931.56273749041, 10322.793544129225, 10369.0, 10397.896021039995, 10787.67636970892, 10902.345859248471, 9538.332316737762, 9737.9026209737, 9923.503824808586, 10268.897311026794, 10282.177425805769, 9429.317418873554, 9577.659127721985, 9654.131128198496, 9701.272404569545, 9727.805443891224], "unit": "ms", "name": "yui.html", "value": 5733.329356254706}], "name": "dromaeo_css", "value": 6269.694832060661}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 113.0, 113.0, 113.0, 124.0, 114.0, 114.0, 115.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [159.0, 130.0, 158.0, 172.0, 142.0, 158.0, 154.0, 137.0, 171.0, 142.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [166.0, 164.0, 163.0, 164.0, 163.0, 165.0, 168.0, 164.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 73.0, 138.0, 72.0, 73.0, 73.0, 73.0, 87.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 139.0, 95.0, 94.0, 96.0, 128.0, 96.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 149.0, 148.0, 150.0, 148.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 77.0, 74.0, 77.0, 74.0, 77.0, 82.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 75.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 86.0, 84.0, 87.0, 85.0, 83.0, 87.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 130.0, 127.0, 122.0, 121.0, 128.0, 128.0, 133.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [137.0, 150.0, 148.0, 149.0, 150.0, 155.0, 150.0, 140.0, 144.0, 149.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 77.0, 71.0, 71.0, 71.0, 72.0, 70.0, 75.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1546.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [184.84288354898337], "unit": "score", "name": "DeltaBlue", "value": 357.6983799999999}, {"lowerIsBetter": false, "replicates": [277.31558513588465], "unit": "score", "name": "Encrypt", "value": 959.8486860000002}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [719.4244604316547], "unit": "score", "name": "Earley", "value": 926.3835699999998}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [606.060606060606], "unit": "score", "name": "Splay", "value": 134.46015000000003}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21378.850715794546}]} 09:46:54 INFO - RETURN: dromaeo_css: 6269.69 09:46:54 INFO - RETURN: kraken: 1546.40 09:46:54 INFO - RETURN: v8_7: 21378.85 09:46:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21378.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1546.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6269.69"}}} 09:46:54 INFO - Return code: 0 09:46:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:46:54 INFO - # TBPL SUCCESS # 09:46:54 INFO - Running post-action listener: _resource_record_post_action 09:46:54 INFO - Running post-run listener: _resource_record_post_run 09:46:55 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499863552; Read time: 12; Write time: 864184 09:46:55 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 229564416; Read time: 0; Write time: 536264 09:46:55 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269991936; Read time: 12; Write time: 327868 09:46:55 INFO - Running post-run listener: _upload_blobber_files 09:46:55 INFO - Blob upload gear active. 09:46:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:46:55 INFO - Copying logs to upload dir... 09:46:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.907576 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-28 09:46:55.163653) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-28 09:46:55.167431) ========= 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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010039 build_url: 'https://queue.taskcluster.net/v1/task/HxB4MXjKQQuA-K1OAu9-yw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-28 09:46:55.221088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:46:55.221595) ========= 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=a194aa7faa1be204aaca7d660000020b-1448718975.576768-807766094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 09:46:55.272546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-28 09:46:55.272886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-28 09:46:55.273225) ========= ========= Total master_lag: 0.23 =========