builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1448628753.29 results: success (0) buildid: 20151127035613 builduid: 2ef2170d6a8b435682faf05e4839195c revision: 2a711953a62c00ee3ddc753592ccffac7876c966 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.295274) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.295694) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.295983) ========= 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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006506 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.323866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.324144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.348059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.348332) ========= 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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.409816) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.410081) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.410429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.410696) ========= 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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-27 04:52:33-- 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% 40.0M=0s 2015-11-27 04:52:33 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114247 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.551406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.551685) ========= 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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022171 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.617922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:33.618215) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2a711953a62c00ee3ddc753592ccffac7876c966 --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 2a711953a62c00ee3ddc753592ccffac7876c966 --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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-27 04:52:33,918 truncating revision to first 12 chars 2015-11-27 04:52:33,919 Setting DEBUG logging. 2015-11-27 04:52:33,919 attempt 1/10 2015-11-27 04:52:33,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2a711953a62c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-27 04:52:34,181 unpacking tar archive at: fx-team-2a711953a62c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541004 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:34.173079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:34.173435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:34.184561) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:34.184830) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 04:52:34.185234) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-27 04:52:34.185522) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:34 INFO - MultiFileLogger online at 20151127 04:52:34 in /builds/slave/test 04:52:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 04:52:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:34 INFO - {'append_to_log': False, 04:52:34 INFO - 'base_work_dir': '/builds/slave/test', 04:52:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:52:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:34 INFO - 'branch': 'Fx-Team-Non-PGO', 04:52:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:34 INFO - 'config_files': ('talos/linux_config.py',), 04:52:34 INFO - 'default_actions': ('clobber', 04:52:34 INFO - 'read-buildbot-config', 04:52:34 INFO - 'download-and-extract', 04:52:34 INFO - 'populate-webroot', 04:52:34 INFO - 'create-virtualenv', 04:52:34 INFO - 'install', 04:52:34 INFO - 'run-tests'), 04:52:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:34 INFO - 'download_minidump_stackwalk': True, 04:52:34 INFO - 'download_symbols': 'ondemand', 04:52:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:34 INFO - 'installer_path': 'installer.exe', 04:52:34 INFO - 'log_level': 'info', 04:52:34 INFO - 'log_name': 'talos', 04:52:34 INFO - 'log_to_console': True, 04:52:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:34 INFO - 'opt_config_files': (), 04:52:34 INFO - 'pip_index': False, 04:52:34 INFO - 'sps_profile': False, 04:52:34 INFO - 'sps_profile_interval': 0, 04:52:34 INFO - 'suite': 'dromaeojs', 04:52:34 INFO - 'system_bits': '64', 04:52:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:34 INFO - 'title': 'talos-linux64-ix-047', 04:52:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:34 INFO - 'use_talos_json': True, 04:52:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:34 INFO - 'work_dir': 'build'} 04:52:34 INFO - ##### 04:52:34 INFO - ##### Running clobber step. 04:52:34 INFO - ##### 04:52:34 INFO - Running pre-action listener: _resource_record_pre_action 04:52:34 INFO - Running main action method: clobber 04:52:34 INFO - rmtree: /builds/slave/test/build 04:52:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:35 INFO - Running post-action listener: _resource_record_post_action 04:52:35 INFO - ##### 04:52:35 INFO - ##### Running read-buildbot-config step. 04:52:35 INFO - ##### 04:52:35 INFO - Running pre-action listener: _resource_record_pre_action 04:52:35 INFO - Running main action method: read_buildbot_config 04:52:35 INFO - Using buildbot properties: 04:52:35 INFO - { 04:52:35 INFO - "properties": { 04:52:35 INFO - "buildnumber": 936, 04:52:35 INFO - "product": "firefox", 04:52:35 INFO - "script_repo_revision": "production", 04:52:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:52:35 INFO - "repository": "", 04:52:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:52:35 INFO - "buildid": "20151127035613", 04:52:35 INFO - "slavename": "talos-linux64-ix-047", 04:52:35 INFO - "pgo_build": "False", 04:52:35 INFO - "basedir": "/builds/slave/test", 04:52:35 INFO - "project": "", 04:52:35 INFO - "platform": "ubuntu64_hw", 04:52:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:52:35 INFO - "slavebuilddir": "test", 04:52:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:52:35 INFO - "branch": "fx-team", 04:52:35 INFO - "repo_path": "integration/fx-team", 04:52:35 INFO - "stage_platform": "linux64", 04:52:35 INFO - "builduid": "2ef2170d6a8b435682faf05e4839195c", 04:52:35 INFO - "revision": "2a711953a62c00ee3ddc753592ccffac7876c966" 04:52:35 INFO - }, 04:52:35 INFO - "sourcestamp": { 04:52:35 INFO - "repository": "", 04:52:35 INFO - "hasPatch": false, 04:52:35 INFO - "project": "", 04:52:35 INFO - "branch": "fx-team-linux64-talos", 04:52:35 INFO - "changes": [ 04:52:35 INFO - { 04:52:35 INFO - "category": null, 04:52:35 INFO - "files": [ 04:52:35 INFO - { 04:52:35 INFO - "url": null, 04:52:35 INFO - "name": "https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:52:35 INFO - } 04:52:35 INFO - ], 04:52:35 INFO - "repository": "", 04:52:35 INFO - "rev": "2a711953a62c00ee3ddc753592ccffac7876c966", 04:52:35 INFO - "who": "s.kaspari@gmail.com", 04:52:35 INFO - "when": 1448628701, 04:52:35 INFO - "number": 6714686, 04:52:35 INFO - "comments": "Bug 1189336 - (Part 4) Migrate old restrictions if needed. r=ally", 04:52:35 INFO - "project": "", 04:52:35 INFO - "at": "Fri 27 Nov 2015 04:51:41", 04:52:35 INFO - "branch": "fx-team-linux64-talos", 04:52:35 INFO - "revlink": "", 04:52:35 INFO - "properties": [ 04:52:35 INFO - [ 04:52:35 INFO - "buildid", 04:52:35 INFO - "20151127035613", 04:52:35 INFO - "Change" 04:52:35 INFO - ], 04:52:35 INFO - [ 04:52:35 INFO - "builduid", 04:52:35 INFO - "2ef2170d6a8b435682faf05e4839195c", 04:52:35 INFO - "Change" 04:52:35 INFO - ], 04:52:35 INFO - [ 04:52:35 INFO - "pgo_build", 04:52:35 INFO - "False", 04:52:35 INFO - "Change" 04:52:35 INFO - ] 04:52:35 INFO - ], 04:52:35 INFO - "revision": "2a711953a62c00ee3ddc753592ccffac7876c966" 04:52:35 INFO - } 04:52:35 INFO - ], 04:52:35 INFO - "revision": "2a711953a62c00ee3ddc753592ccffac7876c966" 04:52:35 INFO - } 04:52:35 INFO - } 04:52:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:52:35 INFO - Running post-action listener: _resource_record_post_action 04:52:35 INFO - ##### 04:52:35 INFO - ##### Running download-and-extract step. 04:52:35 INFO - ##### 04:52:35 INFO - Running pre-action listener: _resource_record_pre_action 04:52:35 INFO - Running main action method: download_and_extract 04:52:35 INFO - mkdir: /builds/slave/test/build/tests 04:52:35 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')]} 04:52:35 INFO - https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/test_packages.json 04:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/test_packages.json 04:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:52:35 INFO - Downloaded 1302 bytes. 04:52:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:52:35 INFO - Using the following test package requirements: 04:52:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:52:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:35 INFO - u'jsshell-linux-x86_64.zip'], 04:52:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:52:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:52:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:52:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:52:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:52:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:52:35 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')]} 04:52:35 INFO - https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:37 INFO - Downloaded 21517181 bytes. 04:52:37 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 04:52:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:52:37 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 04:52:38 INFO - Return code: 0 04:52:38 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 04:52:38 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')]} 04:52:38 INFO - https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:41 INFO - Downloaded 21517181 bytes. 04:52:41 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 04:52:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:52:41 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 04:52:43 INFO - Return code: 0 04:52: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')]} 04:52:43 INFO - https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:44 INFO - Downloaded 11131728 bytes. 04:52:44 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 04:52:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:44 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 04:52:44 INFO - Return code: 0 04:52:44 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')]} 04:52:44 INFO - https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRYqzmbtRZuDETykfqu9iw/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 04:52:46 INFO - Downloaded 56872241 bytes. 04:52:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:52:46 INFO - mkdir: /builds/slave/test/properties 04:52:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:46 INFO - Contents: 04:52:46 INFO - build_url:https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - Running post-action listener: set_extra_try_arguments 04:52:46 INFO - ##### 04:52:46 INFO - ##### Running populate-webroot step. 04:52:46 INFO - ##### 04:52:46 INFO - Running pre-action listener: _resource_record_pre_action 04:52:46 INFO - Running main action method: populate_webroot 04:52:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:52:46 INFO - '../fennec_ids.txt'], 04:52:46 INFO - 'tests': ['tcheck2']}, 04:52:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:46 INFO - '--tppagecycles', 04:52:46 INFO - '7'], 04:52:46 INFO - 'tests': ['tsvgm']}}, 04:52:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:52:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:52:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:52:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'tests': ['damp', 'tps']}, 04:52:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['damp', 'tps']}, 04:52:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:52:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:46 INFO - 'other': {'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore']}, 04:52:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore']}, 04:52:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore']}, 04:52:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore']}, 04:52:46 INFO - 'other_l64': {'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore']}, 04:52:46 INFO - 'other_nol64': {'tests': ['a11yr', 04:52:46 INFO - 'ts_paint', 04:52:46 INFO - 'tpaint', 04:52:46 INFO - 'sessionrestore', 04:52:46 INFO - 'sessionrestore_no_auto_restore']}, 04:52:46 INFO - 'svgr': {'tests': ['tsvgx', 04:52:46 INFO - 'tsvgr_opacity', 04:52:46 INFO - 'tart', 04:52:46 INFO - 'tscrollx', 04:52:46 INFO - 'cart']}, 04:52:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['tsvgx', 04:52:46 INFO - 'tsvgr_opacity', 04:52:46 INFO - 'tart', 04:52:46 INFO - 'tscrollx', 04:52:46 INFO - 'cart']}, 04:52:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'tests': ['tp5o']}, 04:52:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'talos_options': ['--e10s'], 04:52:46 INFO - 'tests': ['tp5o']}, 04:52:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'talos_options': ['--xperf_path', 04:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:46 INFO - 'tests': ['tp5n']}, 04:52:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:46 INFO - 'talos_options': ['--e10s', 04:52:46 INFO - '--xperf_path', 04:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:46 INFO - 'tests': ['tp5n']}}, 04:52:46 INFO - 'talos.zip': {'path': '', 04:52:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - ##### 04:52:46 INFO - ##### Running create-virtualenv step. 04:52:46 INFO - ##### 04:52:46 INFO - Running pre-action listener: _resource_record_pre_action 04:52:46 INFO - Running main action method: create_virtualenv 04:52:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:46 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 04:52:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:46 INFO - Using real prefix '/usr' 04:52:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:48 INFO - Installing pip.................done. 04:52:48 INFO - Return code: 0 04:52:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:52:48 INFO - Using env: {'DISPLAY': ':0', 04:52:48 INFO - 'HOME': '/home/cltbld', 04:52:48 INFO - 'LANG': 'en_US.UTF-8', 04:52:48 INFO - 'LANGUAGE': 'en_US:en', 04:52:48 INFO - 'LOGNAME': 'cltbld', 04:52:48 INFO - 'MAIL': '/var/mail/cltbld', 04:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:48 INFO - 'MOZ_NO_REMOTE': '1', 04:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:48 INFO - 'NO_EM_RESTART': '1', 04:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:48 INFO - 'PWD': '/builds/slave/test', 04:52:48 INFO - 'SHELL': '/bin/bash', 04:52:48 INFO - 'SHLVL': '1', 04:52:48 INFO - 'TERM': 'linux', 04:52:48 INFO - 'TMOUT': '86400', 04:52:48 INFO - 'USER': 'cltbld', 04:52:48 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:48 INFO - '_': '/tools/buildbot/bin/python'} 04:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:49 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 04:52:49 INFO - Cleaning up... 04:52:49 INFO - Return code: 0 04:52:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 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 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:52:49 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 04:52:49 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 04:52:49 INFO - Using env: {'DISPLAY': ':0', 04:52:49 INFO - 'HOME': '/home/cltbld', 04:52:49 INFO - 'LANG': 'en_US.UTF-8', 04:52:49 INFO - 'LANGUAGE': 'en_US:en', 04:52:49 INFO - 'LOGNAME': 'cltbld', 04:52:49 INFO - 'MAIL': '/var/mail/cltbld', 04:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:49 INFO - 'MOZ_NO_REMOTE': '1', 04:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:49 INFO - 'NO_EM_RESTART': '1', 04:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:49 INFO - 'PWD': '/builds/slave/test', 04:52:49 INFO - 'SHELL': '/bin/bash', 04:52:49 INFO - 'SHLVL': '1', 04:52:49 INFO - 'TERM': 'linux', 04:52:49 INFO - 'TMOUT': '86400', 04:52:49 INFO - 'USER': 'cltbld', 04:52:49 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:49 INFO - '_': '/tools/buildbot/bin/python'} 04:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:49 INFO - Downloading/unpacking psutil>=0.7.1 04:52:49 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 04:52:49 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 04:52:49 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 04:52:49 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 04:52:49 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 04:52:49 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 04:52:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:52:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:51 INFO - Installing collected packages: psutil 04:52:51 INFO - Running setup.py install for psutil 04:52:51 INFO - building 'psutil._psutil_linux' extension 04:52:51 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 04:52:51 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 04:52:51 INFO - building 'psutil._psutil_posix' extension 04:52:51 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 04:52:51 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 04:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:51 INFO - Successfully installed psutil 04:52:51 INFO - Cleaning up... 04:52:51 INFO - Return code: 0 04:52:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:51 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 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:52:51 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 04:52:51 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 04:52:51 INFO - Using env: {'DISPLAY': ':0', 04:52:51 INFO - 'HOME': '/home/cltbld', 04:52:51 INFO - 'LANG': 'en_US.UTF-8', 04:52:51 INFO - 'LANGUAGE': 'en_US:en', 04:52:51 INFO - 'LOGNAME': 'cltbld', 04:52:51 INFO - 'MAIL': '/var/mail/cltbld', 04:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:51 INFO - 'MOZ_NO_REMOTE': '1', 04:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:51 INFO - 'NO_EM_RESTART': '1', 04:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:51 INFO - 'PWD': '/builds/slave/test', 04:52:51 INFO - 'SHELL': '/bin/bash', 04:52:51 INFO - 'SHLVL': '1', 04:52:51 INFO - 'TERM': 'linux', 04:52:51 INFO - 'TMOUT': '86400', 04:52:51 INFO - 'USER': 'cltbld', 04:52:51 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:51 INFO - '_': '/tools/buildbot/bin/python'} 04:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:52:51 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 04:52:51 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 04:52:51 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 04:52:51 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 04:52:51 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 04:52:51 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 04:52:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:52:53 INFO - Installing collected packages: mozsystemmonitor 04:52:53 INFO - Running setup.py install for mozsystemmonitor 04:52:53 INFO - Successfully installed mozsystemmonitor 04:52:53 INFO - Cleaning up... 04:52:53 INFO - Return code: 0 04:52:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:53 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 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:52:53 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 04:52:53 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 04:52:53 INFO - Using env: {'DISPLAY': ':0', 04:52:53 INFO - 'HOME': '/home/cltbld', 04:52:53 INFO - 'LANG': 'en_US.UTF-8', 04:52:53 INFO - 'LANGUAGE': 'en_US:en', 04:52:53 INFO - 'LOGNAME': 'cltbld', 04:52:53 INFO - 'MAIL': '/var/mail/cltbld', 04:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:53 INFO - 'MOZ_NO_REMOTE': '1', 04:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:53 INFO - 'NO_EM_RESTART': '1', 04:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:53 INFO - 'PWD': '/builds/slave/test', 04:52:53 INFO - 'SHELL': '/bin/bash', 04:52:53 INFO - 'SHLVL': '1', 04:52:53 INFO - 'TERM': 'linux', 04:52:53 INFO - 'TMOUT': '86400', 04:52:53 INFO - 'USER': 'cltbld', 04:52:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:53 INFO - '_': '/tools/buildbot/bin/python'} 04:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:53 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 04:52:53 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 04:52:53 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 04:52:53 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 04:52:53 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 04:52:53 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 04:52:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:55 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 04:52:55 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 04:52:55 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 04:52:55 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 04:52:55 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 04:52:55 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 04:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:56 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 04:52:56 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 04:52:56 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 04:52:56 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 04:52:56 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 04:52:56 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 04:52:56 INFO - Downloading docopt-0.6.1.tar.gz 04:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:56 INFO - Running setup.py install for blobuploader 04:52:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:56 INFO - Running setup.py install for requests 04:52:56 INFO - Running setup.py install for docopt 04:52:56 INFO - Successfully installed blobuploader requests docopt 04:52:56 INFO - Cleaning up... 04:52:57 INFO - Return code: 0 04:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:57 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 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:52:57 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 04:52:57 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 04:52:57 INFO - Using env: {'DISPLAY': ':0', 04:52:57 INFO - 'HOME': '/home/cltbld', 04:52:57 INFO - 'LANG': 'en_US.UTF-8', 04:52:57 INFO - 'LANGUAGE': 'en_US:en', 04:52:57 INFO - 'LOGNAME': 'cltbld', 04:52:57 INFO - 'MAIL': '/var/mail/cltbld', 04:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:57 INFO - 'MOZ_NO_REMOTE': '1', 04:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:57 INFO - 'NO_EM_RESTART': '1', 04:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:57 INFO - 'PWD': '/builds/slave/test', 04:52:57 INFO - 'SHELL': '/bin/bash', 04:52:57 INFO - 'SHLVL': '1', 04:52:57 INFO - 'TERM': 'linux', 04:52:57 INFO - 'TMOUT': '86400', 04:52:57 INFO - 'USER': 'cltbld', 04:52:57 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:57 INFO - '_': '/tools/buildbot/bin/python'} 04:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:57 INFO - Running setup.py (path:/tmp/pip-GkM8D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:57 INFO - Running setup.py (path:/tmp/pip-Z5MGg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:57 INFO - Running setup.py (path:/tmp/pip-APbhD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:57 INFO - Running setup.py (path:/tmp/pip-XY6_rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:57 INFO - Running setup.py (path:/tmp/pip-TSfCA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:57 INFO - Running setup.py (path:/tmp/pip-GN0WaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:57 INFO - Running setup.py (path:/tmp/pip-8vLqKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:57 INFO - Running setup.py (path:/tmp/pip-nOMShM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:57 INFO - Running setup.py (path:/tmp/pip-wgwMKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:57 INFO - Running setup.py (path:/tmp/pip-kswsMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:57 INFO - Running setup.py (path:/tmp/pip-eLWTtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:58 INFO - Running setup.py (path:/tmp/pip-j8OOMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:58 INFO - Running setup.py (path:/tmp/pip-LsO2tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:58 INFO - Running setup.py (path:/tmp/pip-JQONDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:58 INFO - Running setup.py (path:/tmp/pip-o0KAif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:58 INFO - Running setup.py (path:/tmp/pip-5hUFye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:58 INFO - Running setup.py (path:/tmp/pip-TiW64F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:58 INFO - Running setup.py install for manifestparser 04:52:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Running setup.py install for mozcrash 04:52:58 INFO - Running setup.py install for mozdebug 04:52:58 INFO - Running setup.py install for mozdevice 04:52:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Running setup.py install for mozfile 04:52:58 INFO - Running setup.py install for mozhttpd 04:52:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Running setup.py install for mozinfo 04:52:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Running setup.py install for mozInstall 04:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Running setup.py install for mozleak 04:52:59 INFO - Running setup.py install for mozlog 04:52:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Running setup.py install for moznetwork 04:52:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Running setup.py install for mozprocess 04:52:59 INFO - Running setup.py install for mozprofile 04:52:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Running setup.py install for mozrunner 04:52:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:59 INFO - Running setup.py install for mozscreenshot 04:53:00 INFO - Running setup.py install for moztest 04:53:00 INFO - Running setup.py install for mozversion 04:53:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:00 INFO - Cleaning up... 04:53:00 INFO - Return code: 0 04:53:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 04:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 04:53:00 INFO - Using env: {'DISPLAY': ':0', 04:53:00 INFO - 'HOME': '/home/cltbld', 04:53:00 INFO - 'LANG': 'en_US.UTF-8', 04:53:00 INFO - 'LANGUAGE': 'en_US:en', 04:53:00 INFO - 'LOGNAME': 'cltbld', 04:53:00 INFO - 'MAIL': '/var/mail/cltbld', 04:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:00 INFO - 'MOZ_NO_REMOTE': '1', 04:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:00 INFO - 'NO_EM_RESTART': '1', 04:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:00 INFO - 'PWD': '/builds/slave/test', 04:53:00 INFO - 'SHELL': '/bin/bash', 04:53:00 INFO - 'SHLVL': '1', 04:53:00 INFO - 'TERM': 'linux', 04:53:00 INFO - 'TMOUT': '86400', 04:53:00 INFO - 'USER': 'cltbld', 04:53:00 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:00 INFO - '_': '/tools/buildbot/bin/python'} 04:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:00 INFO - Running setup.py (path:/tmp/pip-1m4aJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:00 INFO - Running setup.py (path:/tmp/pip-y5fE0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:00 INFO - Running setup.py (path:/tmp/pip-p9VH4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:00 INFO - Running setup.py (path:/tmp/pip-eIh9JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:00 INFO - Running setup.py (path:/tmp/pip-QRoY_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:00 INFO - Running setup.py (path:/tmp/pip-wvUn4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:00 INFO - Running setup.py (path:/tmp/pip-lgz8qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:00 INFO - Running setup.py (path:/tmp/pip-rdE9dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:01 INFO - Running setup.py (path:/tmp/pip-5gqxzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:01 INFO - Running setup.py (path:/tmp/pip-x1fLUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:01 INFO - Running setup.py (path:/tmp/pip-ZqLWHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:01 INFO - Running setup.py (path:/tmp/pip-wpRSmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:01 INFO - Running setup.py (path:/tmp/pip-ETNr1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:01 INFO - Running setup.py (path:/tmp/pip-RiD2cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:01 INFO - Running setup.py (path:/tmp/pip-LFZxNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:01 INFO - Running setup.py (path:/tmp/pip-BeYUs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:01 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)) 04:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:01 INFO - Running setup.py (path:/tmp/pip-tqo7Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:01 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)) 04:53:01 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)) 04:53:01 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)) 04:53:01 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)) 04:53:01 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)) 04:53:01 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)) 04:53:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:03 INFO - Downloading blessings-1.5.1.tar.gz 04:53:03 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 04:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:03 INFO - Installing collected packages: blessings 04:53:03 INFO - Running setup.py install for blessings 04:53:03 INFO - Successfully installed blessings 04:53:03 INFO - Cleaning up... 04:53:03 INFO - Return code: 0 04:53:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:03 INFO - Reading from file tmpfile_stdout 04:53:03 INFO - Current package versions: 04:53:03 INFO - argparse == 1.2.1 04:53:03 INFO - blessings == 1.5.1 04:53:03 INFO - blobuploader == 1.2.4 04:53:03 INFO - docopt == 0.6.1 04:53:03 INFO - manifestparser == 1.1 04:53:03 INFO - mozInstall == 1.12 04:53:03 INFO - mozcrash == 0.16 04:53:03 INFO - mozdebug == 0.1 04:53:03 INFO - mozdevice == 0.47 04:53:03 INFO - mozfile == 1.2 04:53:03 INFO - mozhttpd == 0.7 04:53:03 INFO - mozinfo == 0.9 04:53:03 INFO - mozleak == 0.1 04:53:03 INFO - mozlog == 3.1 04:53:03 INFO - moznetwork == 0.27 04:53:03 INFO - mozprocess == 0.22 04:53:03 INFO - mozprofile == 0.27 04:53:03 INFO - mozrunner == 6.11 04:53:03 INFO - mozscreenshot == 0.1 04:53:03 INFO - mozsystemmonitor == 0.0 04:53:03 INFO - moztest == 0.7 04:53:03 INFO - mozversion == 1.4 04:53:03 INFO - psutil == 3.1.1 04:53:03 INFO - requests == 1.2.3 04:53:03 INFO - wsgiref == 0.1.2 04:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:53:03 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 04:53:03 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 04:53:03 INFO - Using env: {'DISPLAY': ':0', 04:53:03 INFO - 'HOME': '/home/cltbld', 04:53:03 INFO - 'LANG': 'en_US.UTF-8', 04:53:03 INFO - 'LANGUAGE': 'en_US:en', 04:53:03 INFO - 'LOGNAME': 'cltbld', 04:53:03 INFO - 'MAIL': '/var/mail/cltbld', 04:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:03 INFO - 'MOZ_NO_REMOTE': '1', 04:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:03 INFO - 'NO_EM_RESTART': '1', 04:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:03 INFO - 'PWD': '/builds/slave/test', 04:53:03 INFO - 'SHELL': '/bin/bash', 04:53:03 INFO - 'SHLVL': '1', 04:53:03 INFO - 'TERM': 'linux', 04:53:03 INFO - 'TMOUT': '86400', 04:53:03 INFO - 'USER': 'cltbld', 04:53:03 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:03 INFO - '_': '/tools/buildbot/bin/python'} 04:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 INFO - Cleaning up... 04:53:04 INFO - Return code: 0 04:53:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:04 INFO - Using env: {'DISPLAY': ':0', 04:53:04 INFO - 'HOME': '/home/cltbld', 04:53:04 INFO - 'LANG': 'en_US.UTF-8', 04:53:04 INFO - 'LANGUAGE': 'en_US:en', 04:53:04 INFO - 'LOGNAME': 'cltbld', 04:53:04 INFO - 'MAIL': '/var/mail/cltbld', 04:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:04 INFO - 'MOZ_NO_REMOTE': '1', 04:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:04 INFO - 'NO_EM_RESTART': '1', 04:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:04 INFO - 'PWD': '/builds/slave/test', 04:53:04 INFO - 'SHELL': '/bin/bash', 04:53:04 INFO - 'SHLVL': '1', 04:53:04 INFO - 'TERM': 'linux', 04:53:04 INFO - 'TMOUT': '86400', 04:53:04 INFO - 'USER': 'cltbld', 04:53:04 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:04 INFO - '_': '/tools/buildbot/bin/python'} 04:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:04 INFO - Downloading/unpacking jsonschema 04:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:06 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 04:53:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:06 INFO - warning: no files found matching '*.txt' 04:53:06 INFO - no previously-included directories found matching 'build' 04:53:06 INFO - no previously-included directories found matching 'dist' 04:53:06 INFO - no previously-included directories found matching '.git*' 04:53:06 INFO - Installing collected packages: jsonschema, functools32 04:53:06 INFO - Running setup.py install for functools32 04:53:06 INFO - warning: no files found matching '*.txt' 04:53:06 INFO - no previously-included directories found matching 'build' 04:53:06 INFO - no previously-included directories found matching 'dist' 04:53:06 INFO - no previously-included directories found matching '.git*' 04:53:06 INFO - Successfully installed jsonschema functools32 04:53:06 INFO - Cleaning up... 04:53:06 INFO - Return code: 0 04:53:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:53:06 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')]} 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 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')]} 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 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 0x7f06e2416f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2419240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, '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': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', '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 04:53:06 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 04:53:06 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 04:53:06 INFO - Using env: {'DISPLAY': ':0', 04:53:06 INFO - 'HOME': '/home/cltbld', 04:53:06 INFO - 'LANG': 'en_US.UTF-8', 04:53:06 INFO - 'LANGUAGE': 'en_US:en', 04:53:06 INFO - 'LOGNAME': 'cltbld', 04:53:06 INFO - 'MAIL': '/var/mail/cltbld', 04:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:06 INFO - 'MOZ_NO_REMOTE': '1', 04:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:06 INFO - 'NO_EM_RESTART': '1', 04:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:06 INFO - 'PWD': '/builds/slave/test', 04:53:06 INFO - 'SHELL': '/bin/bash', 04:53:06 INFO - 'SHLVL': '1', 04:53:06 INFO - 'TERM': 'linux', 04:53:06 INFO - 'TMOUT': '86400', 04:53:06 INFO - 'USER': 'cltbld', 04:53:06 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:06 INFO - '_': '/tools/buildbot/bin/python'} 04:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:06 INFO - Downloading/unpacking flake8 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:53:08 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 04:53:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:53:08 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 04:53:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 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 04:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:09 INFO - no previously-included directories found matching 'docs/_build' 04:53:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:53:09 INFO - Running setup.py install for pep8 04:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:09 INFO - no previously-included directories found matching 'docs/_build' 04:53:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:53:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:53:09 INFO - Cleaning up... 04:53:09 INFO - Return code: 0 04:53:09 INFO - Running post-action listener: _resource_record_post_action 04:53:09 INFO - Running post-action listener: _start_resource_monitoring 04:53:09 INFO - Starting resource monitoring. 04:53:09 INFO - ##### 04:53:09 INFO - ##### Running install step. 04:53:09 INFO - ##### 04:53:09 INFO - Running pre-action listener: _resource_record_pre_action 04:53:09 INFO - Running main action method: install 04:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:09 INFO - Reading from file tmpfile_stdout 04:53:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:09 INFO - Reading from file tmpfile_stdout 04:53:09 INFO - Output received: 04:53:09 INFO - Usage: mozinstall [options] installer 04:53:09 INFO - Options: 04:53:09 INFO - -h, --help show this help message and exit 04:53:09 INFO - -d DEST, --destination=DEST 04:53:09 INFO - Directory to install application into. [default: 04:53:09 INFO - "/builds/slave/test"] 04:53:09 INFO - --app=APP Application being installed. [default: firefox] 04:53:09 INFO - mkdir: /builds/slave/test/build/application 04:53:09 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'] 04:53:09 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 04:53:23 INFO - Reading from file tmpfile_stdout 04:53:23 INFO - Output received: 04:53:23 INFO - /builds/slave/test/build/application/firefox/firefox 04:53:23 INFO - Running post-action listener: _resource_record_post_action 04:53:23 INFO - ##### 04:53:23 INFO - ##### Running run-tests step. 04:53:23 INFO - ##### 04:53:23 INFO - Running pre-action listener: _resource_record_pre_action 04:53:23 INFO - Running main action method: run_tests 04:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:23 INFO - Python 2.7.3 04:53:23 INFO - Return code: 0 04:53:23 INFO - grabbing minidump binary from tooltool 04:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:23 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 0x24a80b0>, '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 0x24a8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:23 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 04:53:23 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 04:53:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:23 INFO - Return code: 0 04:53:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:53:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:53:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:53:24 INFO - Return code: 0 04:53:24 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 04:53:24 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 04:53:24 INFO - Using env: {'DISPLAY': ':0', 04:53:24 INFO - 'HOME': '/home/cltbld', 04:53:24 INFO - 'LANG': 'en_US.UTF-8', 04:53:24 INFO - 'LANGUAGE': 'en_US:en', 04:53:24 INFO - 'LOGNAME': 'cltbld', 04:53:24 INFO - 'MAIL': '/var/mail/cltbld', 04:53:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:24 INFO - 'MOZ_NO_REMOTE': '1', 04:53:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:24 INFO - 'NO_EM_RESTART': '1', 04:53:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:24 INFO - 'PWD': '/builds/slave/test', 04:53:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:24 INFO - 'SHELL': '/bin/bash', 04:53:24 INFO - 'SHLVL': '1', 04:53:24 INFO - 'TERM': 'linux', 04:53:24 INFO - 'TMOUT': '86400', 04:53:24 INFO - 'USER': 'cltbld', 04:53:24 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995', 04:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:24 INFO - '_': '/tools/buildbot/bin/python'} 04:53:24 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 04:53:25 INFO - mozversion INFO | application_buildid: 20151127035613 04:53:25 INFO - mozversion INFO | application_changeset: 2a711953a62c00ee3ddc753592ccffac7876c966 04:53:25 INFO - mozversion INFO | application_display_name: Nightly 04:53:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:25 INFO - mozversion INFO | application_name: Firefox 04:53:25 INFO - mozversion INFO | application_remotingname: firefox 04:53:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:53:25 INFO - mozversion INFO | application_vendor: Mozilla 04:53:25 INFO - mozversion INFO | application_version: 45.0a1 04:53:25 INFO - mozversion INFO | platform_buildid: 20151127035613 04:53:25 INFO - mozversion INFO | platform_changeset: 2a711953a62c00ee3ddc753592ccffac7876c966 04:53:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:53:25 INFO - mozversion INFO | platform_version: 45.0a1 04:53:25 INFO - 2015-11-27 04:53:25,086 DEBUG : using testdate: 1448628805 04:53:25 INFO - 2015-11-27 04:53:25,086 DEBUG : actual date: 1448628805 04:53:25 INFO - 2015-11-27 04:53:25,136 INFO : starting webserver on 'localhost:60159' 04:53:25 INFO - 2015-11-27 04:53:25,137 INFO : Starting test suite talos-linux64-ix-047 04:53:25 INFO - 2015-11-27 04:53:25,137 INFO : Starting test dromaeo_css 04:53:25 INFO - 2015-11-27 04:53:25,137 DEBUG : operating with platform_type : linux_ 04:53:25 INFO - 2015-11-27 04:53:25,138 INFO : Initialising browser for dromaeo_css test... 04:53:25 INFO - 2015-11-27 04:53:25,149 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5mV1uX/profile http://localhost:60159/getInfo.html 04:53:29 INFO - 2015-11-27 04:53:29,110 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:53:29 INFO - 2015-11-27 04:53:29,110 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:53:29 INFO - 2015-11-27 04:53:29,110 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:53:29 INFO - 2015-11-27 04:53:29,110 DEBUG : BROWSER_OUTPUT: __metrics 04:53:29 INFO - 2015-11-27 04:53:29,247 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:30 INFO - 2015-11-27 04:53:30,468 INFO : Browser initialized. 04:53:30 INFO - 2015-11-27 04:53:30,469 INFO : Running cycle 1/1 for dromaeo_css test... 04:53:30 INFO - 2015-11-27 04:53:30,469 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5mV1uX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:53:42 INFO - 2015-11-27 04:53:42,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 139227136 04:53:42 INFO - 2015-11-27 04:53:42,349 DEBUG : BROWSER_OUTPUT: 04:54:33 INFO - 2015-11-27 04:54:33,379 DEBUG : BROWSER_OUTPUT: 1448628873375 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] 04:56:45 INFO - 2015-11-27 04:56:45,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60159/tests/dromaeo/cssquery-ext.html) 04:56:46 INFO - 2015-11-27 04:56:46,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 235737088 04:56:46 INFO - 2015-11-27 04:56:46,408 DEBUG : BROWSER_OUTPUT: 04:59:49 INFO - 2015-11-27 04:59:49,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/dromaeo/cssquery-ext.html (next: http://localhost:60159/tests/dromaeo/cssquery-jquery.html) 04:59:49 INFO - 2015-11-27 04:59:49,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 218615808 04:59:49 INFO - 2015-11-27 04:59:49,580 DEBUG : BROWSER_OUTPUT: 05:02:51 INFO - 2015-11-27 05:02:51,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60159/tests/dromaeo/cssquery-mootools.html) 05:02:52 INFO - 2015-11-27 05:02:52,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 212705280 05:02:52 INFO - 2015-11-27 05:02:52,121 DEBUG : BROWSER_OUTPUT: 05:05:54 INFO - 2015-11-27 05:05:54,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60159/tests/dromaeo/cssquery-prototype.html) 05:05:54 INFO - 2015-11-27 05:05:54,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 202264576 05:05:54 INFO - 2015-11-27 05:05:54,626 DEBUG : BROWSER_OUTPUT: 05:08:57 INFO - 2015-11-27 05:08:57,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60159/tests/dromaeo/cssquery-yui.html) 05:08:57 INFO - 2015-11-27 05:08:57,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 208310272 05:08:57 INFO - 2015-11-27 05:08:57,925 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/dromaeo/cssquery-yui.html (next: http://localhost:60159/tests/dromaeo/cssquery-dojo.html) 05:12:00 INFO - 2015-11-27 05:12:00,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 251400192 05:12:00 INFO - 2015-11-27 05:12:00,766 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,766 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:12:00 INFO - 2015-11-27 05:12:00,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:12:00 INFO - 2015-11-27 05:12:00,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:12:00 INFO - 2015-11-27 05:12:00,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:12:00 INFO - 2015-11-27 05:12:00,767 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2607.7392260773922;2691.5289824280744;2696.3663539068316;2706.147563517493;2706.4992976299386;4485;4596.356510088586;4640.651951103668;4641.280601506764;4660.9512859606575;4554.772261386934;4568.29191475321;4627.028324051953;4638.67529272951;4655.115528049668;4309.396684464177;4311.784410779464;4326.113146804897;4331.891702707426;4383.189110014641;4160.625543701066;4378.759168245761;4379.934300985487;4426.734395936238;4434.224010798113;4219.367094935784;4270.765107919079;4284.357346398066;4311.439512863339;4317.76252306123;4328.5455027222315;4328.870133895988;4339.869803905888;4340.045190058182;4377.080813029236;4315.287977483743;4320.373545835836;4322.027543802651;4356.564343565618;4373.190959672471;4421.292593185075;4496.752678602676;4522.86431407055;4538.704984176051;4551.749653769041;4993.101241776479;5002.474740152305;5021.698698078127;5028.044671512437;5036.823711170128;5038.647294689373;5039.571636410909;5044.192929131358;5045.369328833895;5075.111855425323;4518.570735780096;4633.536646335407;4647.302904564309;4651.837185698552;4655.976720116411;4988.55103040728;5039.79840806371;5074.695518268915;5076.746162691925;5112.233165025276;4940.505949405031;4950.975245123751;4951.8266860659705;4953.826616068421;4991.575716064102;4801.255805350176;4902.411710594752;5028.798848046037;5039.571636410946;5054.7472626368535;4842.903141937141;4892.951070489321;4905.509449055137;4918.385201849769;4924.8276310328965;4928.063667903087;4934.629902757236;4942.061008408391;4948.455669876311;4992.975035124874;4065.4511640928686;4157.896052598649;4225.154969006211;4236.61904690963;4237.194932962727;3624.7643903146213;3677.1726361568967;3677.2461645362637;3688.428293614494;3710.4990826238113;4267.743935363888;4295.355696645528;4300.569943005675;4304.289792184254;4342.609165175149;4781.13939490895;4890.046440943982;5002.274670172805;5019.121653710586;5063.620228482879;4166.270902592034;4244.384564238168;4250.53244143144;4257.659387249013;4288.506821715543;4472.955270447319;4497.505274419811;4504.504504504502;4511.052678937394;4559.338895860082;4587.885302867455;4698.01341718243;4804.183288840905;4819.204831202812;4820.156472617278;4881.389826271716;4955.950440495549;4969.950300496948;4972.5027497249985;4985.277134815504;4738.786754596121;4739.360186374795;4743.525647435367;4775.808967641256;4785.330053792542;4909.4845041270155;4928.334674818853;4962.975185124052;4968.378952630921;5016.147254966591;4808;4918.336024636628;4921.876953076202;4926.802927882844;5039.067772462106;4856.198727210112;4860.343853579863;4864.975675121602;4869.780859861244;4904.583110435653;4854.199057155671;4854.368932038812;4863.635227358033;4865.80536778539;4867.756612169448;4623.42207224097;4663.090697313991;4727.078219747116;4741.241401375763;4781.976090119527;4893.730844803427;4902.779374928208;4906.362172917497;4906.779194936165;4908.607311415007;4784.545468180518;4791.496892826203;4791.784369703302;4792.7363994980615;4815.398075240595 05:12:00 INFO - 2015-11-27 05:12:00,768 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.3298176225005;559.9216109744635;561.4133230773843;564.1143404854378;576.0984059946181;28504.714952850492;29109.126726198196;29117.272068198254;29127.12618621442;29137.271568210806;29475.115746527637;38407.23185536288;38974;39002;39002.219955600944;7961.800954976128;8102.918970810305;8105.27052565269;8106.554139522324;8108.351331893435;7111;7274.527155734887;7858.724944626939;7965.44241903067;7965.800854978614;10248.436336001518;10497.475126243695;10504.05463508284;10513.579456821757;10528.052475277223;10061.89938100617;10154.543045562967;10159.644412445567;10169.54237059334;10173.135283500911;7210.567365958059;7383.852322953511;9895.65365212214;9974.850377244347;10282.280240383176;37268.44097338542;37310.626893731256;37324.94712790795;37363.25273494515;37382.62617373819;2851.957220641692;2861.3561948561405;2899;2927.0633397312868;2990.5663678766673;28574.8464789857;28959.13122606325;29032.564511532342;29115.708842911725;29282.560761588382;3441.6042155152227;3451.6720911513617;3456.5333679953387;3499.5275637788827;3555.8044307563073;221937;221955;222985;223547;223651;51160;55363;55722;55780.442195577525;55821.441785582436;49246.75376623094;64522.67738661277;66737;66809.66595166993;66866.66566667233;12165.756684866254;12367.567135150226;12380.442880070419;12419.31693756834;12444.128910976146;9213.493257870747;9221.077892210726;9239.76900577491;9357.812843743088;9368.953155234316;19160.23359065622;19422.40685473192;19454.513637159183;19477.902610486857;19541.706874396896;7175.677094530759;7360.300771426706;7365.337119659149;7384.926150738531;7397.852042959111;812.1391325195311;841.5918279634373;922.077922077922;950.3680052764972;958.0228167269346;26826.731732682812;28138.29654258619;28141.296467588472;29080.563791543143;30437.543436848464;932.1563984593953;941.7457286532598;953.6280850468323;958.8226178156924;1038.2835843268122;12817.743645127046;12955.481780728665;13057.542985995444;13377;13602;260195;264430;265865;267690;268484;46999.76500117546;47187.76406117948;47263.76368118206;47276;47308.29037564439;1065.6696424108552;1076.8653918260218;1086.1962148010573;1167.486306025346;1174.7650469906052;23684.41987192203;26425.867870660524;27155.86422067877;27257.45485090327;27390.315242118308;43168.78415607902;43737.78131109324;43852.34221486616;44048;44318.556814431446;235251;240237;244719;249406;250017;26694.59958100669;26715.465690685687;26741.331466713487;26769.732302677505;26797.330066748487;37213.44179837251;39043.609563904;39536.60463395329;40015.39976900291;40134.59865401308;30664.84667576648;30668.386632267677;32734;33919.491207631414;34434.48348274728;30905.536416953313;30906.53640195444;30942;31010.224744381572;32201.677983219866;32905.835470822494;33034;33200.1699957503;33549;33690.494642580874;29142.56286155667;29406.41187176202;29428.58571214335;29762.702372975993;29793.404131917672;23193.903065935272;23330.416739581648;23578.410539736644;23595.29214123579;23650.29049128529 05:12:00 INFO - 2015-11-27 05:12:00,768 DEBUG : BROWSER_OUTPUT: |2;jquery.html;313.894845226849;319.72343922507036;320.3528871679208;324.42090867800965;326.98528566214526;12382.257064576132;12772.42524086416;15399.615009624751;15955.840441595596;16046;11290.774184516305;14008.579742607739;14132.880067989807;14634.195119268436;14639.19484428356;3691.984704206338;4770.0698363819065;4889.633277504184;4922.581580565638;4922.655414120995;4842.757862106881;4852.902941941159;4868.172410690191;4870.610351171916;4874.293227482013;4702.553257440555;4855.126077306083;4929.2606109083745;4957.256411538262;4964.15609346412;4858.271259311096;4871.391076115486;4872.09866174757;4872.561469467747;4874.975625121887;4310.82756689732;4312.547182545819;4312.6765492587865;4314.288142456491;4326.805293761789;18745.250189992385;19156.425307240806;19440.22239110434;19669.50826229356;19698;1596.2417851520552;1698.736695812151;1775.174543837109;1849.2418108575555;1958.0209895052474;8217.79455513611;8244.71785494225;8281.37889658272;8320.875186872141;11067;1648.6125760446284;1718.6133120048014;1744.1976690722283;1752.5706201980597;1760;52351;53449.46550534484;53554.19668704973;54363.184552231745;55534.778608855595;9286.814263714823;9390.389624674373;9461.763455913657;9476.668316608886;9517;9385.38994965325;9710.077542633438;11070.28043177191;11966;12001.039916806809;6288.748450062038;6294.370562943669;6344.1118243445035;6381.202349706286;6449.32282110381;6071.119687645267;6219.689015549205;6254.3745625438005;6259.280182778948;6259.311475737665;3808.352580061396;3848.461215429842;3861.67175790061;3882.592327805596;3890.4164375343926;1527.3814105287377;1599.4162130822167;1631.1925596829644;1654.8841581089448;1678.7733655956533;818.7134502923928;843.5529169540154;859.4542465534431;866.9393142480092;884.3190743127884;15504.534863954099;15596.454124105601;15670.9216453917;15755.44855930037;16114;821.3593397150232;867.1415298854215;872.6640243506296;924.778053267211;942.7548837302213;7210.387117095001;8480.194381533744;8653.524056176844;8670;9047.592858321392;326403;330257;330333;397505;462255;55878.44121558814;70303;70697.2930270701;71178.64410677913;72158;1042.4422933730418;1043.1341986151476;1045.362328979322;1059.5391004912888;1084.8752393474695;13502.662433439242;13591.932040339734;14085.788713169106;14433.20617366055;14453.49412770548;31889.362212756077;32021;32498.350032999682;33463.49804752979;33483.66516334806;40841.38737918874;42586.361204581335;43340;43980;44038;8057.194280571896;8089.624763790288;8246.587670616565;8249.83500330002;8258.215469530385;9650.565724542272;9656.613735450503;9661.46861922601;13511.459541618618;16104.919475402548;13281.335933203109;13432.597022089352;13467.932660336635;13514.72970540564;14041.1575305482;12843.871561284268;13091.279979601213;13138.408771605109;13172.60482185536;13228.735425291248;12750;12858.67853303675;13597.116187447784;13983.650408739863;13996.580102596938;8239.423240373117;8344.499330040217;8358.582070896553;8490.872636910328;8609;8787.384883058125;8877.467351958645;8911.2425443838;13569.79645305341;13800.447982081007 05:12:00 INFO - 2015-11-27 05:12:00,771 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1332.8533861275264;1353.9864601353984;1380.9171449713017;1557.0657605436738;1609.4849648112602;5652.236948012017;6419.069234960928;6595.340465953403;6610.7355705771715;6625.5030872684565;6505.9674701626545;6704.497162712804;6706.329367063304;6756.290589488107;6775.966120169404;1893;1928.1805232776085;1930.671785796418;1931.4591914263958;1931.5847092875028;1963.1558429875147;1979.8119178678003;1984.7320611717378;2029.2390353617393;2035.4504283843353;1949.3761996161234;1953.9413817585423;1979.7723261824858;1981.197614965934;1982.5142840004219;1936.1771247219945;1957.8140076692691;1958.8530860185401;1961.0684924660743;1962.077823422989;1920.5006698258414;1941.9029048547516;1953.638576863285;1985.4837742186992;1989.9701504477443;5639.830805075854;5821.214136091616;6665.533412661116;6736.932630673679;6743.1908171019795;3689.3912504436735;3797;3812.5234345706785;3826.617338266179;3830.0616348994395;2549.1970029440854;2583.2121203033066;2611.112221844563;2629.9211023669322;2641.537730897085;892.8214357128535;899.6626265150569;906.0893801729286;908.0284096017264;925.0425809287423;8675.089115642893;8752.824943501095;8786.077461866476;8788.033316335199;8788.340874434443;3484.7212223022098;3494.2836718472654;3539.3806083935724;3554.129238336572;3554.182538016219;7583.203763604853;7657.042869641295;7667.769966901002;7673.155952845183;7676.270754278335;3810.5236845394325;3812.066043819282;3824.043989002749;3824.8661296854475;3826.1773718650625;3466.376052310558;3471.913202169966;3474.722022238215;3476.1309672581856;3480.686738193575;3072.830994295335;3077.199928018731;3077.368994432954;3092.8608212630484;3103.6275646922513;959.4483172176027;967.4533888353199;971.4220039076738;975.7950830325711;976.0532283684814;1029.45953374479;1145.3929417408788;1168.7837750016274;1170.9063274938155;1172.8358029875824;6318.7472501100365;6349.206349206349;6361.745530178741;6368.10846481493;6372.458341041063;370.1634306467403;374.2795119395153;375.75388120780934;376.495496035314;378.04543527593046;4641.373414589055;5089.8727531812;5115.335006449212;5138.640295179376;5145.922811157836;6951.443884489228;7741;7779.299863012356;7871.921280787234;7909.5649739263745;7744.070711514654;7749.806254843561;7750;7750.844983100306;7755.069391673035;6226.377362263828;6421.197350331208;6430.485561155097;6452;6458.580192287486;6102.572819902564;6126.754929802758;6130.6628135452975;6148.1699970503405;6151.784687535915;6916.550424222611;7121.8575628486105;7127.287271272831;7216.170140433917;7222.349988501061;7214.74748383804;7327.963360183165;7330.853382932205;7343.742968996059;7407.074115735533;5964.343922168645;5971.313298970674;5988.520918326436;6003.609765365237;6014.789482368096;6277.71750271248;6486.967565162144;6490.383413575702;6490.902636460552;6500.5449618526245;5885.970570147122;5974.462298393166;5978.282606087123;6037.396260374103;6117.816465506042;5936.079907614327;6034.275886893601;6044.909326360196;6083.939160608515;6241.875162496815;6107.511399088151;6154.599951003171;6160.4290905818725;6182.659953702409;6245.375462453719;5527.452313352268;5543.362513311021;5546.611737178358;5567.526760225426;5594.972025140011;5844.211031510692;5888.735006924613;5898.587098903035;5903.203067585992;5909.320428150646 05:12:00 INFO - 2015-11-27 05:12:00,773 DEBUG : BROWSER_OUTPUT: |4;prototype.html;276.2692677867042;281.0276443505471;286.0945108730867;291.0961464652254;297.00207303460354;5010.223415370614;5189.247559103927;5342.038433082043;5410.567154627625;5425.538829199513;5264.631475796696;5341.145416733323;5345.1982202669615;5356.678599284036;5358.196270559418;4198.8530401435955;4198.895027624319;4201.201771663389;4202.222588821062;4205.327147656368;3933.6656384207377;4036.475258216428;4042.9191416171657;4192.014876504034;4201.495820501529;4080.6123418275215;4107.014316564033;4107.835686572548;4108.876733697994;4118.588141185887;4085.5710150434224;4093.733907296046;4101.487314085739;4102.241085399196;4106.035081755785;3589.9948014555966;3594.1553734872546;3597.9100522487147;3603.0812142903656;3612.078919875415;4996.90006199874;5092.79628814847;5101.4133374662015;5107.9744601277125;5109.6678715883345;4714.882127946795;4716.693414928019;4724.551167639069;4727.598154156901;4728.1252968201;5587.692676902769;5598.748056337475;5599.804006859781;5600.18797274397;5604.187392828057;3664.633536646341;3735.701143908481;3792.943105853414;3882.514685664292;3890.5914878937588;5870.442307980735;5884.794032208895;5898.085796701475;5900.852478688024;5900.940990590082;4005.879823605238;4012.3981402789814;4017.0961533654695;4019.3569028955226;4022.7787471688753;4075.4701888754867;4075.694322925733;4075.816588253536;4079.612436818557;4079.7144199906315;4579.9542004579525;4663.3937588114;4676.55572720591;4678.064387122589;4680;5594.412586678422;5596.552275817925;5603.719814009283;5604.943950560524;5608.242887210256;1431.978520322196;1466.3254902744857;1467.6477645365035;1467.699121680053;1468.4273133477952;964.8311545479513;970.5341436110706;985.6008316631776;986.7730422002979;990.1089019882164;4935.62982776286;4941.629377796679;4944.208926571731;4950.603951683856;4952.529509696573;5843.5325173985975;5843.707814609337;5844.912326315109;5846.41535846412;5849.385814489502;4935.629827762932;4936.531029552187;4944.184209605447;4944.826931057396;4948.950510494921;3076.14675268134;3124.4063627910623;3128.264857758425;3151.73210277129;3157.1791334253257;5511.200875872976;5513.5037846594;5515;5520.475554822286;5524.281843360337;5972.343042265347;5977.1333156692035;5981.730822113015;5985.431384018511;5985.790497332572;5501.0648189807025;5501.229827824108;5508.834734958038;5514.145307477347;5516.255305533782;5682.176084467646;5831.620944638585;5831.854203644943;5836.241288632451;5838.94161058384;5491.780328786804;5646.265985421869;5650.63270887391;5683.914741278967;5690.374058853606;5393.487618676219;5517.586181036519;5533.418991005887;5537.446255374431;5542;4024.5371782244247;4060.878173654795;4064.878053658395;4067.003584121909;4070.4911886014247;5796.246487956539;5826.533877289722;5829.475347218601;5840.766369345179;5843.912341314969;5489.533389661764;5607.663540187602;5619.8595035124445;5621.353544342453;5622.212890195294;5608.803691870765;5613.494785469327;5614.354349249888;5623.2408624835125;5628.296462942132;5471.835844924659;5500.174973753808;5503.807366742145;5514.145307477347;5517.503424691797;5520.254765606592;5641.8589535261945;5646.3788983212635;5652.236948011966;5658.151277308272;5461.672299662033;5478.561715062865;5513.117901135799;5521.199426083276;5523.613347065667 05:12:00 INFO - 2015-11-27 05:12:00,774 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.6235914349245;674.6660403100465;782.9725959591414;787.8030492376906;797.4338219863896;11076.833847492284;11148.498317575708;11156.107511399088;11166.497507612157;11184.944075279633;10718.142548596114;10792.082672972787;12084.879151208484;12289;12297.200681955666;609.7621927448299;763.4083585221456;777.8055486128468;777.9377649788004;778.0663204155009;613.9324674285825;752.3830459023603;766.4558163703776;766.5209244222361;767.4666107055599;780.0872978615006;798.4171554765026;799.3964556759638;799.936005119589;800.0199755299741;629.9811005669837;635.942765151134;783.4437549339975;790.4901338636575;790.8971833661616;589.2516504039845;589.5165963909595;589.7464090441108;590.35356284868;590.3565114025689;10789.676309710721;10794.190435717353;10794.5682172713;10804.729881753019;10817.18871084664;10429.79140417195;10748.408837513934;11101;11383;11834.112441566831;8716.694915677985;8800.647974081028;8872.467651940904;9001.099890010946;9656.37233579815;3209.245827230599;3216.2281052547455;3231.919202019945;3234.75739319552;3251.9349613007844;39619.40570891439;40106.799466002776;40148.799256003826;40824.1835163295;40827.38758918618;8828.823423531621;8939.016708162097;8946.731598052069;8989.820203595891;9038.367314288069;15140.470083547023;15161.317740701696;15198.088114712931;15207.467738629095;15208.543743687707;6379.393957574023;6444.967775161094;6521.934780652227;6581.638009909501;6722.9663851680425;3358.8320583970703;3364.276680513701;3417.760756747004;3426.931461370759;3438.2951494943477;2582.341502916744;2622.121589267617;2626.921192364232;2629.9605505917425;2631.3290111021565;442.82065763365887;444.06302701300876;445.79493433020525;448.5245639622011;451.3703383779609;545.7053191276666;556.3546286307864;591.588845752198;595.3064679648162;603.7162533609196;7056.470764692669;7308.37878780299;7428.851422971618;7485.4385921055045;7490.700371985168;513.1379282804849;549.9615026948076;567.8324894156234;614.8247749391402;630.6815058395481;3499.2126771476214;3593.7304702147444;3657.743957922973;3742.7754334740002;3933.8033098344968;49103;49183;49329.75335123301;49482.752586237555;51139;43411.48827675811;43666.56333436625;44046.77976610096;44226;44587.77706111449;40709.1858162841;41257.793711031256;41641.58358416438;41709;42322.78838605849;7343.2289609590225;7621.923780762343;7652.120006199359;7668.079830420385;7881.605919704107;30368.39263214679;30873.382532349675;31176.376472470878;31416.52875206828;31539.053828385186;35554.644453555135;39478.802605986784;39820.60179398169;39880.60119398885;40144.59855401408;9616.423014619146;9839.803203936024;9962.352447090916;10067.748306292402;10168.186545076524;10885.619003334845;11122.221444498808;11210.607628732956;11416.94291528537;11605;10948.507317170586;10996.450177490933;11085.778284434427;11145.331280123219;11208.215424920178;10170.389776613427;10247.948760256151;10710.89289107099;10794.784104317712;11093.33439993603;9091.818163636823;9414.764630884283;10663.8933610666;10840.728981775519;11002.394868282001;8107.513549187068;8432.283255923316;8727.956360218159;8915.331350148635;9330;8539.658413663385;9062.864057039282;9144.42544051563;9180.403273787182;9202.447853128833 05:12:00 INFO - 2015-11-27 05:12:00,774 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:12:00 INFO - 2015-11-27 05:12:00,774 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:12:00 INFO - 2015-11-27 05:12:00,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,834 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1448629920760__endTimestamp 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4603.13 Median:4741.24 stddev:470.23 (9.9%) stddev-sans-first:444.86 05:12:00 INFO - 2015-11-27 05:12:00,775 DEBUG : BROWSER_OUTPUT: Values: 2607.7 2691.5 2696.4 2706.1 2706.5 4485.0 4596.4 4640.7 4641.3 4661.0 4554.8 4568.3 4627.0 4638.7 4655.1 4309.4 4311.8 4326.1 4331.9 4383.2 4160.6 4378.8 4379.9 4426.7 4434.2 4219.4 4270.8 4284.4 4311.4 4317.8 4328.5 4328.9 4339.9 4340.0 4377.1 4315.3 4320.4 4322.0 4356.6 4373.2 4421.3 4496.8 4522.9 4538.7 4551.7 4993.1 5002.5 5021.7 5028.0 5036.8 5038.6 5039.6 5044.2 5045.4 5075.1 4518.6 4633.5 4647.3 4651.8 4656.0 4988.6 5039.8 5074.7 5076.7 5112.2 4940.5 4951.0 4951.8 4953.8 4991.6 4801.3 4902.4 5028.8 5039.6 5054.7 4842.9 4893.0 4905.5 4918.4 4924.8 4928.1 4934.6 4942.1 4948.5 4993.0 4065.5 4157.9 4225.2 4236.6 4237.2 3624.8 3677.2 3677.2 3688.4 3710.5 4267.7 4295.4 4300.6 4304.3 4342.6 4781.1 4890.0 5002.3 5019.1 5063.6 4166.3 4244.4 4250.5 4257.7 4288.5 4473.0 4497.5 4504.5 4511.1 4559.3 4587.9 4698.0 4804.2 4819.2 4820.2 4881.4 4956.0 4970.0 4972.5 4985.3 4738.8 4739.4 4743.5 4775.8 4785.3 4909.5 4928.3 4963.0 4968.4 5016.1 4808.0 4918.3 4921.9 4926.8 5039.1 4856.2 4860.3 4865.0 4869.8 4904.6 4854.2 4854.4 4863.6 4865.8 4867.8 4623.4 4663.1 4727.1 4741.2 4782.0 4893.7 4902.8 4906.4 4906.8 4908.6 4784.5 4791.5 4791.8 4792.7 4815.4 05:12:00 INFO - 2015-11-27 05:12:00,776 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,776 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40569.73 Median:30906.04 stddev:63762.26 (206.3%) stddev-sans-first:63870.32 05:12:00 INFO - 2015-11-27 05:12:00,777 DEBUG : BROWSER_OUTPUT: Values: 549.3 559.9 561.4 564.1 576.1 28504.7 29109.1 29117.3 29127.1 29137.3 29475.1 38407.2 38974.0 39002.0 39002.2 7961.8 8102.9 8105.3 8106.6 8108.4 7111.0 7274.5 7858.7 7965.4 7965.8 10248.4 10497.5 10504.1 10513.6 10528.1 10061.9 10154.5 10159.6 10169.5 10173.1 7210.6 7383.9 9895.7 9974.9 10282.3 37268.4 37310.6 37324.9 37363.3 37382.6 2852.0 2861.4 2899.0 2927.1 2990.6 28574.8 28959.1 29032.6 29115.7 29282.6 3441.6 3451.7 3456.5 3499.5 3555.8 221937.0 221955.0 222985.0 223547.0 223651.0 51160.0 55363.0 55722.0 55780.4 55821.4 49246.8 64522.7 66737.0 66809.7 66866.7 12165.8 12367.6 12380.4 12419.3 12444.1 9213.5 9221.1 9239.8 9357.8 9369.0 19160.2 19422.4 19454.5 19477.9 19541.7 7175.7 7360.3 7365.3 7384.9 7397.9 812.1 841.6 922.1 950.4 958.0 26826.7 28138.3 28141.3 29080.6 30437.5 932.2 941.7 953.6 958.8 1038.3 12817.7 12955.5 13057.5 13377.0 13602.0 260195.0 264430.0 265865.0 267690.0 268484.0 46999.8 47187.8 47263.8 47276.0 47308.3 1065.7 1076.9 1086.2 1167.5 1174.8 23684.4 26425.9 27155.9 27257.5 27390.3 43168.8 43737.8 43852.3 44048.0 44318.6 235251.0 240237.0 244719.0 249406.0 250017.0 26694.6 26715.5 26741.3 26769.7 26797.3 37213.4 39043.6 39536.6 40015.4 40134.6 30664.8 30668.4 32734.0 33919.5 34434.5 30905.5 30906.5 30942.0 31010.2 32201.7 32905.8 33034.0 33200.2 33549.0 33690.5 29142.6 29406.4 29428.6 29762.7 29793.4 23193.9 23330.4 23578.4 23595.3 23650.3 05:12:00 INFO - 2015-11-27 05:12:00,777 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,777 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22475.02 Median:4311.69 stddev:61252.78 (1420.6%) stddev-sans-first:61402.00 05:12:00 INFO - 2015-11-27 05:12:00,777 DEBUG : BROWSER_OUTPUT: Values: 313.9 319.7 320.4 324.4 327.0 12382.3 12772.4 15399.6 15955.8 16046.0 11290.8 14008.6 14132.9 14634.2 14639.2 3692.0 4770.1 4889.6 4922.6 4922.7 4842.8 4852.9 4868.2 4870.6 4874.3 4702.6 4855.1 4929.3 4957.3 4964.2 4858.3 4871.4 4872.1 4872.6 4875.0 4310.8 4312.5 4312.7 4314.3 4326.8 18745.3 19156.4 19440.2 19669.5 19698.0 1596.2 1698.7 1775.2 1849.2 1958.0 8217.8 8244.7 8281.4 8320.9 11067.0 1648.6 1718.6 1744.2 1752.6 1760.0 52351.0 53449.5 53554.2 54363.2 55534.8 9286.8 9390.4 9461.8 9476.7 9517.0 9385.4 9710.1 11070.3 11966.0 12001.0 6288.7 6294.4 6344.1 6381.2 6449.3 6071.1 6219.7 6254.4 6259.3 6259.3 3808.4 3848.5 3861.7 3882.6 3890.4 1527.4 1599.4 1631.2 1654.9 1678.8 818.7 843.6 859.5 866.9 884.3 15504.5 15596.5 15670.9 15755.4 16114.0 821.4 867.1 872.7 924.8 942.8 7210.4 8480.2 8653.5 8670.0 9047.6 326403.0 330257.0 330333.0 397505.0 462255.0 55878.4 70303.0 70697.3 71178.6 72158.0 1042.4 1043.1 1045.4 1059.5 1084.9 13502.7 13591.9 14085.8 14433.2 14453.5 31889.4 32021.0 32498.4 33463.5 33483.7 40841.4 42586.4 43340.0 43980.0 44038.0 8057.2 8089.6 8246.6 8249.8 8258.2 9650.6 9656.6 9661.5 13511.5 16104.9 13281.3 13432.6 13467.9 13514.7 14041.2 12843.9 13091.3 13138.4 13172.6 13228.7 12750.0 12858.7 13597.1 13983.7 13996.6 8239.4 8344.5 8358.6 8490.9 8609.0 8787.4 8877.5 8911.2 13569.8 13800.4 05:12:00 INFO - 2015-11-27 05:12:00,777 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,778 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4628.20 Median:5967.83 stddev:2395.55 (40.1%) stddev-sans-first:2389.47 05:12:00 INFO - 2015-11-27 05:12:00,778 DEBUG : BROWSER_OUTPUT: Values: 1332.9 1354.0 1380.9 1557.1 1609.5 5652.2 6419.1 6595.3 6610.7 6625.5 6506.0 6704.5 6706.3 6756.3 6776.0 1893.0 1928.2 1930.7 1931.5 1931.6 1963.2 1979.8 1984.7 2029.2 2035.5 1949.4 1953.9 1979.8 1981.2 1982.5 1936.2 1957.8 1958.9 1961.1 1962.1 1920.5 1941.9 1953.6 1985.5 1990.0 5639.8 5821.2 6665.5 6736.9 6743.2 3689.4 3797.0 3812.5 3826.6 3830.1 2549.2 2583.2 2611.1 2629.9 2641.5 892.8 899.7 906.1 908.0 925.0 8675.1 8752.8 8786.1 8788.0 8788.3 3484.7 3494.3 3539.4 3554.1 3554.2 7583.2 7657.0 7667.8 7673.2 7676.3 3810.5 3812.1 3824.0 3824.9 3826.2 3466.4 3471.9 3474.7 3476.1 3480.7 3072.8 3077.2 3077.4 3092.9 3103.6 959.4 967.5 971.4 975.8 976.1 1029.5 1145.4 1168.8 1170.9 1172.8 6318.7 6349.2 6361.7 6368.1 6372.5 370.2 374.3 375.8 376.5 378.0 4641.4 5089.9 5115.3 5138.6 5145.9 6951.4 7741.0 7779.3 7871.9 7909.6 7744.1 7749.8 7750.0 7750.8 7755.1 6226.4 6421.2 6430.5 6452.0 6458.6 6102.6 6126.8 6130.7 6148.2 6151.8 6916.6 7121.9 7127.3 7216.2 7222.3 7214.7 7328.0 7330.9 7343.7 7407.1 5964.3 5971.3 5988.5 6003.6 6014.8 6277.7 6487.0 6490.4 6490.9 6500.5 5886.0 5974.5 5978.3 6037.4 6117.8 5936.1 6034.3 6044.9 6083.9 6241.9 6107.5 6154.6 6160.4 6182.7 6245.4 5527.5 5543.4 5546.6 5567.5 5595.0 5844.2 5888.7 5898.6 5903.2 5909.3 05:12:00 INFO - 2015-11-27 05:12:00,778 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,778 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4649.52 Median:5350.94 stddev:1368.11 (25.6%) stddev-sans-first:1331.99 05:12:00 INFO - 2015-11-27 05:12:00,779 DEBUG : BROWSER_OUTPUT: Values: 276.3 281.0 286.1 291.1 297.0 5010.2 5189.2 5342.0 5410.6 5425.5 5264.6 5341.1 5345.2 5356.7 5358.2 4198.9 4198.9 4201.2 4202.2 4205.3 3933.7 4036.5 4042.9 4192.0 4201.5 4080.6 4107.0 4107.8 4108.9 4118.6 4085.6 4093.7 4101.5 4102.2 4106.0 3590.0 3594.2 3597.9 3603.1 3612.1 4996.9 5092.8 5101.4 5108.0 5109.7 4714.9 4716.7 4724.6 4727.6 4728.1 5587.7 5598.7 5599.8 5600.2 5604.2 3664.6 3735.7 3792.9 3882.5 3890.6 5870.4 5884.8 5898.1 5900.9 5900.9 4005.9 4012.4 4017.1 4019.4 4022.8 4075.5 4075.7 4075.8 4079.6 4079.7 4580.0 4663.4 4676.6 4678.1 4680.0 5594.4 5596.6 5603.7 5604.9 5608.2 1432.0 1466.3 1467.6 1467.7 1468.4 964.8 970.5 985.6 986.8 990.1 4935.6 4941.6 4944.2 4950.6 4952.5 5843.5 5843.7 5844.9 5846.4 5849.4 4935.6 4936.5 4944.2 4944.8 4949.0 3076.1 3124.4 3128.3 3151.7 3157.2 5511.2 5513.5 5515.0 5520.5 5524.3 5972.3 5977.1 5981.7 5985.4 5985.8 5501.1 5501.2 5508.8 5514.1 5516.3 5682.2 5831.6 5831.9 5836.2 5838.9 5491.8 5646.3 5650.6 5683.9 5690.4 5393.5 5517.6 5533.4 5537.4 5542.0 4024.5 4060.9 4064.9 4067.0 4070.5 5796.2 5826.5 5829.5 5840.8 5843.9 5489.5 5607.7 5619.9 5621.4 5622.2 5608.8 5613.5 5614.4 5623.2 5628.3 5471.8 5500.2 5503.8 5514.1 5517.5 5520.3 5641.9 5646.4 5652.2 5658.2 5461.7 5478.6 5513.1 5521.2 5523.6 05:12:00 INFO - 2015-11-27 05:12:00,779 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-27 05:12:00,780 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12069.75 Median:444.93 stddev:13792.10 (3099.8%) stddev-sans-first:13804.15 05:12:00 INFO - 2015-11-27 05:12:00,780 DEBUG : BROWSER_OUTPUT: Values: 654.6 674.7 783.0 787.8 797.4 11076.8 11148.5 11156.1 11166.5 11184.9 10718.1 10792.1 12084.9 12289.0 12297.2 609.8 763.4 777.8 777.9 778.1 613.9 752.4 766.5 766.5 767.5 780.1 798.4 799.4 799.9 800.0 630.0 635.9 783.4 790.5 790.9 589.3 589.5 589.7 590.4 590.4 10789.7 10794.2 10794.6 10804.7 10817.2 10429.8 10748.4 11101.0 11383.0 11834.1 8716.7 8800.6 8872.5 9001.1 9656.4 3209.2 3216.2 3231.9 3234.8 3251.9 39619.4 40106.8 40148.8 40824.2 40827.4 8828.8 8939.0 8946.7 8989.8 9038.4 15140.5 15161.3 15198.1 15207.5 15208.5 6379.4 6445.0 6521.9 6581.6 6723.0 3358.8 3364.3 3417.8 3426.9 3438.3 2582.3 2622.1 2626.9 2630.0 2631.3 442.8 444.1 445.8 448.5 451.4 545.7 556.4 591.6 595.3 603.7 7056.5 7308.4 7428.9 7485.4 7490.7 513.1 550.0 567.8 614.8 630.7 3499.2 3593.7 3657.7 3742.8 3933.8 49103.0 49183.0 49329.8 49482.8 51139.0 43411.5 43666.6 44046.8 44226.0 44587.8 40709.2 41257.8 41641.6 41709.0 42322.8 7343.2 7621.9 7652.1 7668.1 7881.6 30368.4 30873.4 31176.4 31416.5 31539.1 35554.6 39478.8 39820.6 39880.6 40144.6 9616.4 9839.8 9962.4 10067.7 10168.2 10885.6 11122.2 11210.6 11416.9 11605.0 10948.5 10996.5 11085.8 11145.3 11208.2 10170.4 10247.9 10710.9 10794.8 11093.3 9091.8 9414.8 10663.9 10840.7 11002.4 8107.5 8432.3 8728.0 8915.3 9330.0 8539.7 9062.9 9144.4 9180.4 9202.4 05:12:00 INFO - 2015-11-27 05:12:00,780 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:12:00 INFO - 2015-11-27 05:12:00,780 DEBUG : BROWSER_OUTPUT: 05:12:01 INFO - 2015-11-27 05:12:01,498 INFO : Browser exited with error code: 0 05:12:01 INFO - 2015-11-27 05:12:01,514 INFO : Completed test dromaeo_css (00:18:36) 05:12:01 INFO - 2015-11-27 05:12:01,514 INFO : Starting test kraken 05:12:01 INFO - 2015-11-27 05:12:01,514 DEBUG : operating with platform_type : linux_ 05:12:01 INFO - 2015-11-27 05:12:01,514 INFO : Initialising browser for kraken test... 05:12:01 INFO - 2015-11-27 05:12:01,520 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNI0BKC/profile http://localhost:60159/getInfo.html 05:12:05 INFO - 2015-11-27 05:12:05,297 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:12:05 INFO - 2015-11-27 05:12:05,297 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:12:05 INFO - 2015-11-27 05:12:05,297 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:12:05 INFO - 2015-11-27 05:12:05,297 DEBUG : BROWSER_OUTPUT: __metrics 05:12:05 INFO - 2015-11-27 05:12:05,406 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:06 INFO - 2015-11-27 05:12:06,639 INFO : Browser initialized. 05:12:06 INFO - 2015-11-27 05:12:06,639 INFO : Running cycle 1/1 for kraken test... 05:12:06 INFO - 2015-11-27 05:12:06,640 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNI0BKC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:12:18 INFO - 2015-11-27 05:12:18,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 141594624 05:12:18 INFO - 2015-11-27 05:12:18,536 DEBUG : BROWSER_OUTPUT: 05:12:21 INFO - 2015-11-27 05:12:21,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60159/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:21 INFO - 2015-11-27 05:12:21,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 176889856 05:12:21 INFO - 2015-11-27 05:12:21,703 DEBUG : BROWSER_OUTPUT: 05:12:24 INFO - 2015-11-27 05:12:24,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60159/tests/kraken/driver.html?testName=audio-dft) 05:12:25 INFO - 2015-11-27 05:12:25,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 166989824 05:12:25 INFO - 2015-11-27 05:12:25,005 DEBUG : BROWSER_OUTPUT: 05:12:28 INFO - 2015-11-27 05:12:28,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60159/tests/kraken/driver.html?testName=audio-fft) 05:12:28 INFO - 2015-11-27 05:12:28,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 150077440 05:12:28 INFO - 2015-11-27 05:12:28,571 DEBUG : BROWSER_OUTPUT: 05:12:30 INFO - 2015-11-27 05:12:30,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60159/tests/kraken/driver.html?testName=audio-oscillator) 05:12:31 INFO - 2015-11-27 05:12:31,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 154230784 05:12:31 INFO - 2015-11-27 05:12:31,170 DEBUG : BROWSER_OUTPUT: 05:12:33 INFO - 2015-11-27 05:12:33,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:34 INFO - 2015-11-27 05:12:34,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 155205632 05:12:34 INFO - 2015-11-27 05:12:34,002 DEBUG : BROWSER_OUTPUT: 05:12:37 INFO - 2015-11-27 05:12:37,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60159/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:37 INFO - 2015-11-27 05:12:37,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 156614656 05:12:37 INFO - 2015-11-27 05:12:37,613 DEBUG : BROWSER_OUTPUT: 05:12:40 INFO - 2015-11-27 05:12:40,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60159/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:41 INFO - 2015-11-27 05:12:41,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 156463104 05:12:41 INFO - 2015-11-27 05:12:41,561 DEBUG : BROWSER_OUTPUT: 05:12:44 INFO - 2015-11-27 05:12:44,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60159/tests/kraken/driver.html?testName=json-parse-financial) 05:12:45 INFO - 2015-11-27 05:12:45,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 155336704 05:12:45 INFO - 2015-11-27 05:12:45,008 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-27 05:12:46,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:47 INFO - 2015-11-27 05:12:47,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 165236736 05:12:47 INFO - 2015-11-27 05:12:47,367 DEBUG : BROWSER_OUTPUT: 05:12:49 INFO - 2015-11-27 05:12:49,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:49 INFO - 2015-11-27 05:12:49,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 165339136 05:12:49 INFO - 2015-11-27 05:12:49,867 DEBUG : BROWSER_OUTPUT: 05:12:51 INFO - 2015-11-27 05:12:51,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:52 INFO - 2015-11-27 05:12:52,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 171503616 05:12:52 INFO - 2015-11-27 05:12:52,565 DEBUG : BROWSER_OUTPUT: 05:12:55 INFO - 2015-11-27 05:12:55,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:55 INFO - 2015-11-27 05:12:55,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 178688000 05:12:55 INFO - 2015-11-27 05:12:55,686 DEBUG : BROWSER_OUTPUT: 05:12:58 INFO - 2015-11-27 05:12:58,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:58 INFO - 2015-11-27 05:12:58,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 179372032 05:12:58 INFO - 2015-11-27 05:12:58,855 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60159/tests/kraken/driver.html?testName=ai-astar) 05:13:00 INFO - 2015-11-27 05:13:00,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 236052480 05:13:00 INFO - 2015-11-27 05:13:00,830 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,830 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:13:00 INFO - 2015-11-27 05:13:00,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:13:00 INFO - 2015-11-27 05:13:00,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:13:00 INFO - 2015-11-27 05:13:00,830 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;112;112;112;102;111;111;108 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;137;157;173;133;162;166;132;165;130 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;159;160;161;158;161;162;161 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;80;91;71;73;71;100;86;72 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;133;94;94;94;134;94;94;126 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;109;111;109;109;110 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;146;146;147;146;147 05:13:00 INFO - 2015-11-27 05:13:00,831 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:13:00 INFO - 2015-11-27 05:13:00,832 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;72;74;71;73;73;73;73;70 05:13:00 INFO - 2015-11-27 05:13:00,832 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;79;69;69;71;69;69;70;70 05:13:00 INFO - 2015-11-27 05:13:00,832 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;86;81;82;82;83;82;82;91;82 05:13:00 INFO - 2015-11-27 05:13:00,832 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;124;119;125;120;119;120;137;121;129 05:13:00 INFO - 2015-11-27 05:13:00,832 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;149;149;147;150;133;150;146;145;134 05:13:00 INFO - 2015-11-27 05:13:00,832 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;70;71;68;68;69;67;69;67 05:13:00 INFO - 2015-11-27 05:13:00,832 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:13:00 INFO - 2015-11-27 05:13:00,833 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:13:00 INFO - 2015-11-27 05:13:00,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 05:13:00 INFO - 2015-11-27 05:13:00,833 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:13:00 INFO - 2015-11-27 05:13:00,833 DEBUG : BROWSER_OUTPUT: __startTimestamp1448629980824__endTimestamp 05:13:00 INFO - 2015-11-27 05:13:00,833 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,834 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:13:00 INFO - 2015-11-27 05:13:00,834 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:13:00 INFO - 2015-11-27 05:13:00,834 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,834 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:3.33 (3.0%) stddev-sans-first:3.53 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 112.0 112.0 112.0 102.0 111.0 111.0 108.0 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.90 Median:159.50 stddev:16.31 (10.2%) stddev-sans-first:17.26 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: Values: 154.0 137.0 157.0 173.0 133.0 162.0 166.0 132.0 165.0 130.0 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.22 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 159.0 160.0 161.0 158.0 161.0 162.0 161.0 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.00 Median:73.00 stddev:10.11 (13.9%) stddev-sans-first:10.49 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 80.0 91.0 71.0 73.0 71.0 100.0 86.0 72.0 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:94.00 stddev:17.92 (19.1%) stddev-sans-first:18.55 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 133.0 94.0 94.0 94.0 134.0 94.0 94.0 126.0 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 05:13:00 INFO - 2015-11-27 05:13:00,835 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 109.0 111.0 109.0 109.0 110.0 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:73.00 stddev:1.16 (1.6%) stddev-sans-first:1.22 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 74.0 71.0 73.0 73.0 73.0 73.0 70.0 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:69.50 stddev:3.16 (4.6%) stddev-sans-first:3.24 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 79.0 69.0 69.0 71.0 69.0 69.0 70.0 70.0 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.50 stddev:3.46 (4.2%) stddev-sans-first:3.17 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: Values: 89.0 86.0 81.0 82.0 82.0 83.0 82.0 82.0 91.0 82.0 05:13:00 INFO - 2015-11-27 05:13:00,836 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:124.50 stddev:5.68 (4.6%) stddev-sans-first:5.97 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: Values: 126.0 124.0 119.0 125.0 120.0 119.0 120.0 137.0 121.0 129.0 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:149.00 stddev:6.39 (4.3%) stddev-sans-first:6.63 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 149.0 147.0 150.0 133.0 150.0 146.0 145.0 134.0 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 70.0 71.0 68.0 68.0 69.0 67.0 69.0 67.0 05:13:00 INFO - 2015-11-27 05:13:00,837 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:13:00 INFO - 2015-11-27 05:13:00,838 DEBUG : BROWSER_OUTPUT: 05:13:01 INFO - 2015-11-27 05:13:01,729 INFO : Browser exited with error code: 0 05:13:01 INFO - 2015-11-27 05:13:01,785 INFO : Completed test kraken (00:01:00) 05:13:01 INFO - 2015-11-27 05:13:01,785 INFO : Starting test v8_7 05:13:01 INFO - 2015-11-27 05:13:01,786 DEBUG : operating with platform_type : linux_ 05:13:01 INFO - 2015-11-27 05:13:01,786 INFO : Initialising browser for v8_7 test... 05:13:01 INFO - 2015-11-27 05:13:01,792 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIKTpwa/profile http://localhost:60159/getInfo.html 05:13:05 INFO - 2015-11-27 05:13:05,707 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:13:05 INFO - 2015-11-27 05:13:05,708 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:13:05 INFO - 2015-11-27 05:13:05,708 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:13:05 INFO - 2015-11-27 05:13:05,708 DEBUG : BROWSER_OUTPUT: __metrics 05:13:05 INFO - 2015-11-27 05:13:05,825 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:07 INFO - 2015-11-27 05:13:07,061 INFO : Browser initialized. 05:13:07 INFO - 2015-11-27 05:13:07,062 INFO : Running cycle 1/1 for v8_7 test... 05:13:07 INFO - 2015-11-27 05:13:07,062 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIKTpwa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:13:18 INFO - 2015-11-27 05:13:18,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 139390976 05:13:18 INFO - 2015-11-27 05:13:18,965 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60159/tests/v8_7/run.html (next: http://localhost:60159/tests/v8_7/run.html) 05:13:40 INFO - 2015-11-27 05:13:40,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 448159744 05:13:40 INFO - 2015-11-27 05:13:40,670 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,671 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:13:40 INFO - 2015-11-27 05:13:40,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:13:40 INFO - 2015-11-27 05:13:40,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:13:40 INFO - 2015-11-27 05:13:40,671 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:13:40 INFO - 2015-11-27 05:13:40,671 DEBUG : BROWSER_OUTPUT: |0;Richards;164.69038208168644 05:13:40 INFO - 2015-11-27 05:13:40,672 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.0860545524395 05:13:40 INFO - 2015-11-27 05:13:40,672 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 05:13:40 INFO - 2015-11-27 05:13:40,672 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 05:13:40 INFO - 2015-11-27 05:13:40,672 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 05:13:40 INFO - 2015-11-27 05:13:40,672 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 05:13:40 INFO - 2015-11-27 05:13:40,672 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 05:13:40 INFO - 2015-11-27 05:13:40,673 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 05:13:40 INFO - 2015-11-27 05:13:40,673 DEBUG : BROWSER_OUTPUT: |8;Splay;622.66500622665 05:13:40 INFO - 2015-11-27 05:13:40,673 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 05:13:40 INFO - 2015-11-27 05:13:40,673 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:13:40 INFO - 2015-11-27 05:13:40,673 DEBUG : BROWSER_OUTPUT: __startTimestamp1448630020670__endTimestamp 05:13:40 INFO - 2015-11-27 05:13:40,673 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.69 Median:164.69 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: Values: 164.7 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.09 Median:192.09 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: Values: 192.1 05:13:40 INFO - 2015-11-27 05:13:40,674 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: Values: 278.3 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: Values: 5186.5 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: Values: 1970.5 05:13:40 INFO - 2015-11-27 05:13:40,675 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,676 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,676 DEBUG : BROWSER_OUTPUT: Values: 795.5 05:13:40 INFO - 2015-11-27 05:13:40,676 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,676 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,676 DEBUG : BROWSER_OUTPUT: Values: 12132.5 05:13:40 INFO - 2015-11-27 05:13:40,676 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,677 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,677 DEBUG : BROWSER_OUTPUT: Values: 26000.0 05:13:40 INFO - 2015-11-27 05:13:40,677 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,677 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,678 DEBUG : BROWSER_OUTPUT: Values: 622.7 05:13:40 INFO - 2015-11-27 05:13:40,678 DEBUG : BROWSER_OUTPUT: 05:13:40 INFO - 2015-11-27 05:13:40,679 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:13:40 INFO - 2015-11-27 05:13:40,679 DEBUG : BROWSER_OUTPUT: Values: 4826.9 05:13:40 INFO - 2015-11-27 05:13:40,679 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:13:40 INFO - 2015-11-27 05:13:40,679 DEBUG : BROWSER_OUTPUT: 05:13:41 INFO - 2015-11-27 05:13:41,553 INFO : Browser exited with error code: 0 05:13:41 INFO - 2015-11-27 05:13:41,572 INFO : Completed test v8_7 (00:00:39) 05:13:41 INFO - 2015-11-27 05:13:41,644 INFO : Completed test suite (00:20:16) 05:13:41 INFO - 2015-11-27 05:13:41,644 DEBUG : Working with test: dromaeo_css 05:13:41 INFO - 2015-11-27 05:13:41,644 DEBUG : Generating results file: dromaeo_css 05:13:41 INFO - 2015-11-27 05:13:41,645 DEBUG : Working with test: kraken 05:13:41 INFO - 2015-11-27 05:13:41,646 DEBUG : Generating results file: kraken 05:13:41 INFO - 2015-11-27 05:13:41,646 INFO : javascript benchmark 05:13:41 INFO - 2015-11-27 05:13:41,646 DEBUG : Working with test: v8_7 05:13:41 INFO - 2015-11-27 05:13:41,646 DEBUG : Generating results file: v8_7 05:13:41 INFO - 2015-11-27 05:13:41,647 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:13:41 INFO - 2015-11-27 05:13:41,783 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:13:41 INFO - 2015-11-27 05:13:41,783 DEBUG : process_Request line: dromaeo_css 6121.94 graph.html#tests=[[72,132,35]] 05:13:41 INFO - 2015-11-27 05:13:41,783 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:13:41 INFO - 2015-11-27 05:13:41,818 DEBUG : process_Request line: kraken 1520.80 graph.html#tests=[[232,132,35]] 05:13:41 INFO - 2015-11-27 05:13:41,818 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:13:41 INFO - 2015-11-27 05:13:41,925 DEBUG : process_Request line: v8_7 19780.16 graph.html#tests=[[230,132,35]] 05:13:41 INFO - 2015-11-27 05:13:41,927 INFO : javascript benchmark 05:13:41 INFO - 2015-11-27 05:13:41,930 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2607.7392260773922, 2691.5289824280744, 2696.3663539068316, 2706.147563517493, 2706.4992976299386, 4485.0, 4596.356510088586, 4640.651951103668, 4641.280601506764, 4660.9512859606575, 4554.772261386934, 4568.29191475321, 4627.028324051953, 4638.67529272951, 4655.115528049668, 4309.396684464177, 4311.784410779464, 4326.113146804897, 4331.891702707426, 4383.189110014641, 4160.625543701066, 4378.759168245761, 4379.934300985487, 4426.734395936238, 4434.224010798113, 4219.367094935784, 4270.765107919079, 4284.357346398066, 4311.439512863339, 4317.76252306123, 4328.5455027222315, 4328.870133895988, 4339.869803905888, 4340.045190058182, 4377.080813029236, 4315.287977483743, 4320.373545835836, 4322.027543802651, 4356.564343565618, 4373.190959672471, 4421.292593185075, 4496.752678602676, 4522.86431407055, 4538.704984176051, 4551.749653769041, 4993.101241776479, 5002.474740152305, 5021.698698078127, 5028.044671512437, 5036.823711170128, 5038.647294689373, 5039.571636410909, 5044.192929131358, 5045.369328833895, 5075.111855425323, 4518.570735780096, 4633.536646335407, 4647.302904564309, 4651.837185698552, 4655.976720116411, 4988.55103040728, 5039.79840806371, 5074.695518268915, 5076.746162691925, 5112.233165025276, 4940.505949405031, 4950.975245123751, 4951.8266860659705, 4953.826616068421, 4991.575716064102, 4801.255805350176, 4902.411710594752, 5028.798848046037, 5039.571636410946, 5054.7472626368535, 4842.903141937141, 4892.951070489321, 4905.509449055137, 4918.385201849769, 4924.8276310328965, 4928.063667903087, 4934.629902757236, 4942.061008408391, 4948.455669876311, 4992.975035124874, 4065.4511640928686, 4157.896052598649, 4225.154969006211, 4236.61904690963, 4237.194932962727, 3624.7643903146213, 3677.1726361568967, 3677.2461645362637, 3688.428293614494, 3710.4990826238113, 4267.743935363888, 4295.355696645528, 4300.569943005675, 4304.289792184254, 4342.609165175149, 4781.13939490895, 4890.046440943982, 5002.274670172805, 5019.121653710586, 5063.620228482879, 4166.270902592034, 4244.384564238168, 4250.53244143144, 4257.659387249013, 4288.506821715543, 4472.955270447319, 4497.505274419811, 4504.504504504502, 4511.052678937394, 4559.338895860082, 4587.885302867455, 4698.01341718243, 4804.183288840905, 4819.204831202812, 4820.156472617278, 4881.389826271716, 4955.950440495549, 4969.950300496948, 4972.5027497249985, 4985.277134815504, 4738.786754596121, 4739.360186374795, 4743.525647435367, 4775.808967641256, 4785.330053792542, 4909.4845041270155, 4928.334674818853, 4962.975185124052, 4968.378952630921, 5016.147254966591, 4808.0, 4918.336024636628, 4921.876953076202, 4926.802927882844, 5039.067772462106, 4856.198727210112, 4860.343853579863, 4864.975675121602, 4869.780859861244, 4904.583110435653, 4854.199057155671, 4854.368932038812, 4863.635227358033, 4865.80536778539, 4867.756612169448, 4623.42207224097, 4663.090697313991, 4727.078219747116, 4741.241401375763, 4781.976090119527, 4893.730844803427, 4902.779374928208, 4906.362172917497, 4906.779194936165, 4908.607311415007, 4784.545468180518, 4791.496892826203, 4791.784369703302, 4792.7363994980615, 4815.398075240595], "unit": "ms", "name": "dojo.html", "value": 4574.3360739938635}, {"lowerIsBetter": false, "replicates": [549.3298176225005, 559.9216109744635, 561.4133230773843, 564.1143404854378, 576.0984059946181, 28504.714952850492, 29109.126726198196, 29117.272068198254, 29127.12618621442, 29137.271568210806, 29475.115746527637, 38407.23185536288, 38974.0, 39002.0, 39002.219955600944, 7961.800954976128, 8102.918970810305, 8105.27052565269, 8106.554139522324, 8108.351331893435, 7111.0, 7274.527155734887, 7858.724944626939, 7965.44241903067, 7965.800854978614, 10248.436336001518, 10497.475126243695, 10504.05463508284, 10513.579456821757, 10528.052475277223, 10061.89938100617, 10154.543045562967, 10159.644412445567, 10169.54237059334, 10173.135283500911, 7210.567365958059, 7383.852322953511, 9895.65365212214, 9974.850377244347, 10282.280240383176, 37268.44097338542, 37310.626893731256, 37324.94712790795, 37363.25273494515, 37382.62617373819, 2851.957220641692, 2861.3561948561405, 2899.0, 2927.0633397312868, 2990.5663678766673, 28574.8464789857, 28959.13122606325, 29032.564511532342, 29115.708842911725, 29282.560761588382, 3441.6042155152227, 3451.6720911513617, 3456.5333679953387, 3499.5275637788827, 3555.8044307563073, 221937.0, 221955.0, 222985.0, 223547.0, 223651.0, 51160.0, 55363.0, 55722.0, 55780.442195577525, 55821.441785582436, 49246.75376623094, 64522.67738661277, 66737.0, 66809.66595166993, 66866.66566667233, 12165.756684866254, 12367.567135150226, 12380.442880070419, 12419.31693756834, 12444.128910976146, 9213.493257870747, 9221.077892210726, 9239.76900577491, 9357.812843743088, 9368.953155234316, 19160.23359065622, 19422.40685473192, 19454.513637159183, 19477.902610486857, 19541.706874396896, 7175.677094530759, 7360.300771426706, 7365.337119659149, 7384.926150738531, 7397.852042959111, 812.1391325195311, 841.5918279634373, 922.077922077922, 950.3680052764972, 958.0228167269346, 26826.731732682812, 28138.29654258619, 28141.296467588472, 29080.563791543143, 30437.543436848464, 932.1563984593953, 941.7457286532598, 953.6280850468323, 958.8226178156924, 1038.2835843268122, 12817.743645127046, 12955.481780728665, 13057.542985995444, 13377.0, 13602.0, 260195.0, 264430.0, 265865.0, 267690.0, 268484.0, 46999.76500117546, 47187.76406117948, 47263.76368118206, 47276.0, 47308.29037564439, 1065.6696424108552, 1076.8653918260218, 1086.1962148010573, 1167.486306025346, 1174.7650469906052, 23684.41987192203, 26425.867870660524, 27155.86422067877, 27257.45485090327, 27390.315242118308, 43168.78415607902, 43737.78131109324, 43852.34221486616, 44048.0, 44318.556814431446, 235251.0, 240237.0, 244719.0, 249406.0, 250017.0, 26694.59958100669, 26715.465690685687, 26741.331466713487, 26769.732302677505, 26797.330066748487, 37213.44179837251, 39043.609563904, 39536.60463395329, 40015.39976900291, 40134.59865401308, 30664.84667576648, 30668.386632267677, 32734.0, 33919.491207631414, 34434.48348274728, 30905.536416953313, 30906.53640195444, 30942.0, 31010.224744381572, 32201.677983219866, 32905.835470822494, 33034.0, 33200.1699957503, 33549.0, 33690.494642580874, 29142.56286155667, 29406.41187176202, 29428.58571214335, 29762.702372975993, 29793.404131917672, 23193.903065935272, 23330.416739581648, 23578.410539736644, 23595.29214123579, 23650.29049128529], "unit": "ms", "name": "ext.html", "value": 16876.617072811536}, {"lowerIsBetter": false, "replicates": [313.894845226849, 319.72343922507036, 320.3528871679208, 324.42090867800965, 326.98528566214526, 12382.257064576132, 12772.42524086416, 15399.615009624751, 15955.840441595596, 16046.0, 11290.774184516305, 14008.579742607739, 14132.880067989807, 14634.195119268436, 14639.19484428356, 3691.984704206338, 4770.0698363819065, 4889.633277504184, 4922.581580565638, 4922.655414120995, 4842.757862106881, 4852.902941941159, 4868.172410690191, 4870.610351171916, 4874.293227482013, 4702.553257440555, 4855.126077306083, 4929.2606109083745, 4957.256411538262, 4964.15609346412, 4858.271259311096, 4871.391076115486, 4872.09866174757, 4872.561469467747, 4874.975625121887, 4310.82756689732, 4312.547182545819, 4312.6765492587865, 4314.288142456491, 4326.805293761789, 18745.250189992385, 19156.425307240806, 19440.22239110434, 19669.50826229356, 19698.0, 1596.2417851520552, 1698.736695812151, 1775.174543837109, 1849.2418108575555, 1958.0209895052474, 8217.79455513611, 8244.71785494225, 8281.37889658272, 8320.875186872141, 11067.0, 1648.6125760446284, 1718.6133120048014, 1744.1976690722283, 1752.5706201980597, 1760.0, 52351.0, 53449.46550534484, 53554.19668704973, 54363.184552231745, 55534.778608855595, 9286.814263714823, 9390.389624674373, 9461.763455913657, 9476.668316608886, 9517.0, 9385.38994965325, 9710.077542633438, 11070.28043177191, 11966.0, 12001.039916806809, 6288.748450062038, 6294.370562943669, 6344.1118243445035, 6381.202349706286, 6449.32282110381, 6071.119687645267, 6219.689015549205, 6254.3745625438005, 6259.280182778948, 6259.311475737665, 3808.352580061396, 3848.461215429842, 3861.67175790061, 3882.592327805596, 3890.4164375343926, 1527.3814105287377, 1599.4162130822167, 1631.1925596829644, 1654.8841581089448, 1678.7733655956533, 818.7134502923928, 843.5529169540154, 859.4542465534431, 866.9393142480092, 884.3190743127884, 15504.534863954099, 15596.454124105601, 15670.9216453917, 15755.44855930037, 16114.0, 821.3593397150232, 867.1415298854215, 872.6640243506296, 924.778053267211, 942.7548837302213, 7210.387117095001, 8480.194381533744, 8653.524056176844, 8670.0, 9047.592858321392, 326403.0, 330257.0, 330333.0, 397505.0, 462255.0, 55878.44121558814, 70303.0, 70697.2930270701, 71178.64410677913, 72158.0, 1042.4422933730418, 1043.1341986151476, 1045.362328979322, 1059.5391004912888, 1084.8752393474695, 13502.662433439242, 13591.932040339734, 14085.788713169106, 14433.20617366055, 14453.49412770548, 31889.362212756077, 32021.0, 32498.350032999682, 33463.49804752979, 33483.66516334806, 40841.38737918874, 42586.361204581335, 43340.0, 43980.0, 44038.0, 8057.194280571896, 8089.624763790288, 8246.587670616565, 8249.83500330002, 8258.215469530385, 9650.565724542272, 9656.613735450503, 9661.46861922601, 13511.459541618618, 16104.919475402548, 13281.335933203109, 13432.597022089352, 13467.932660336635, 13514.72970540564, 14041.1575305482, 12843.871561284268, 13091.279979601213, 13138.408771605109, 13172.60482185536, 13228.735425291248, 12750.0, 12858.67853303675, 13597.116187447784, 13983.650408739863, 13996.580102596938, 8239.423240373117, 8344.499330040217, 8358.582070896553, 8490.872636910328, 8609.0, 8787.384883058125, 8877.467351958645, 8911.2425443838, 13569.79645305341, 13800.447982081007], "unit": "ms", "name": "jquery.html", "value": 7771.4355370628155}, {"lowerIsBetter": false, "replicates": [1332.8533861275264, 1353.9864601353984, 1380.9171449713017, 1557.0657605436738, 1609.4849648112602, 5652.236948012017, 6419.069234960928, 6595.340465953403, 6610.7355705771715, 6625.5030872684565, 6505.9674701626545, 6704.497162712804, 6706.329367063304, 6756.290589488107, 6775.966120169404, 1893.0, 1928.1805232776085, 1930.671785796418, 1931.4591914263958, 1931.5847092875028, 1963.1558429875147, 1979.8119178678003, 1984.7320611717378, 2029.2390353617393, 2035.4504283843353, 1949.3761996161234, 1953.9413817585423, 1979.7723261824858, 1981.197614965934, 1982.5142840004219, 1936.1771247219945, 1957.8140076692691, 1958.8530860185401, 1961.0684924660743, 1962.077823422989, 1920.5006698258414, 1941.9029048547516, 1953.638576863285, 1985.4837742186992, 1989.9701504477443, 5639.830805075854, 5821.214136091616, 6665.533412661116, 6736.932630673679, 6743.1908171019795, 3689.3912504436735, 3797.0, 3812.5234345706785, 3826.617338266179, 3830.0616348994395, 2549.1970029440854, 2583.2121203033066, 2611.112221844563, 2629.9211023669322, 2641.537730897085, 892.8214357128535, 899.6626265150569, 906.0893801729286, 908.0284096017264, 925.0425809287423, 8675.089115642893, 8752.824943501095, 8786.077461866476, 8788.033316335199, 8788.340874434443, 3484.7212223022098, 3494.2836718472654, 3539.3806083935724, 3554.129238336572, 3554.182538016219, 7583.203763604853, 7657.042869641295, 7667.769966901002, 7673.155952845183, 7676.270754278335, 3810.5236845394325, 3812.066043819282, 3824.043989002749, 3824.8661296854475, 3826.1773718650625, 3466.376052310558, 3471.913202169966, 3474.722022238215, 3476.1309672581856, 3480.686738193575, 3072.830994295335, 3077.199928018731, 3077.368994432954, 3092.8608212630484, 3103.6275646922513, 959.4483172176027, 967.4533888353199, 971.4220039076738, 975.7950830325711, 976.0532283684814, 1029.45953374479, 1145.3929417408788, 1168.7837750016274, 1170.9063274938155, 1172.8358029875824, 6318.7472501100365, 6349.206349206349, 6361.745530178741, 6368.10846481493, 6372.458341041063, 370.1634306467403, 374.2795119395153, 375.75388120780934, 376.495496035314, 378.04543527593046, 4641.373414589055, 5089.8727531812, 5115.335006449212, 5138.640295179376, 5145.922811157836, 6951.443884489228, 7741.0, 7779.299863012356, 7871.921280787234, 7909.5649739263745, 7744.070711514654, 7749.806254843561, 7750.0, 7750.844983100306, 7755.069391673035, 6226.377362263828, 6421.197350331208, 6430.485561155097, 6452.0, 6458.580192287486, 6102.572819902564, 6126.754929802758, 6130.6628135452975, 6148.1699970503405, 6151.784687535915, 6916.550424222611, 7121.8575628486105, 7127.287271272831, 7216.170140433917, 7222.349988501061, 7214.74748383804, 7327.963360183165, 7330.853382932205, 7343.742968996059, 7407.074115735533, 5964.343922168645, 5971.313298970674, 5988.520918326436, 6003.609765365237, 6014.789482368096, 6277.71750271248, 6486.967565162144, 6490.383413575702, 6490.902636460552, 6500.5449618526245, 5885.970570147122, 5974.462298393166, 5978.282606087123, 6037.396260374103, 6117.816465506042, 5936.079907614327, 6034.275886893601, 6044.909326360196, 6083.939160608515, 6241.875162496815, 6107.511399088151, 6154.599951003171, 6160.4290905818725, 6182.659953702409, 6245.375462453719, 5527.452313352268, 5543.362513311021, 5546.611737178358, 5567.526760225426, 5594.972025140011, 5844.211031510692, 5888.735006924613, 5898.587098903035, 5903.203067585992, 5909.320428150646], "unit": "ms", "name": "mootools.html", "value": 3746.453524017803}, {"lowerIsBetter": false, "replicates": [276.2692677867042, 281.0276443505471, 286.0945108730867, 291.0961464652254, 297.00207303460354, 5010.223415370614, 5189.247559103927, 5342.038433082043, 5410.567154627625, 5425.538829199513, 5264.631475796696, 5341.145416733323, 5345.1982202669615, 5356.678599284036, 5358.196270559418, 4198.8530401435955, 4198.895027624319, 4201.201771663389, 4202.222588821062, 4205.327147656368, 3933.6656384207377, 4036.475258216428, 4042.9191416171657, 4192.014876504034, 4201.495820501529, 4080.6123418275215, 4107.014316564033, 4107.835686572548, 4108.876733697994, 4118.588141185887, 4085.5710150434224, 4093.733907296046, 4101.487314085739, 4102.241085399196, 4106.035081755785, 3589.9948014555966, 3594.1553734872546, 3597.9100522487147, 3603.0812142903656, 3612.078919875415, 4996.90006199874, 5092.79628814847, 5101.4133374662015, 5107.9744601277125, 5109.6678715883345, 4714.882127946795, 4716.693414928019, 4724.551167639069, 4727.598154156901, 4728.1252968201, 5587.692676902769, 5598.748056337475, 5599.804006859781, 5600.18797274397, 5604.187392828057, 3664.633536646341, 3735.701143908481, 3792.943105853414, 3882.514685664292, 3890.5914878937588, 5870.442307980735, 5884.794032208895, 5898.085796701475, 5900.852478688024, 5900.940990590082, 4005.879823605238, 4012.3981402789814, 4017.0961533654695, 4019.3569028955226, 4022.7787471688753, 4075.4701888754867, 4075.694322925733, 4075.816588253536, 4079.612436818557, 4079.7144199906315, 4579.9542004579525, 4663.3937588114, 4676.55572720591, 4678.064387122589, 4680.0, 5594.412586678422, 5596.552275817925, 5603.719814009283, 5604.943950560524, 5608.242887210256, 1431.978520322196, 1466.3254902744857, 1467.6477645365035, 1467.699121680053, 1468.4273133477952, 964.8311545479513, 970.5341436110706, 985.6008316631776, 986.7730422002979, 990.1089019882164, 4935.62982776286, 4941.629377796679, 4944.208926571731, 4950.603951683856, 4952.529509696573, 5843.5325173985975, 5843.707814609337, 5844.912326315109, 5846.41535846412, 5849.385814489502, 4935.629827762932, 4936.531029552187, 4944.184209605447, 4944.826931057396, 4948.950510494921, 3076.14675268134, 3124.4063627910623, 3128.264857758425, 3151.73210277129, 3157.1791334253257, 5511.200875872976, 5513.5037846594, 5515.0, 5520.475554822286, 5524.281843360337, 5972.343042265347, 5977.1333156692035, 5981.730822113015, 5985.431384018511, 5985.790497332572, 5501.0648189807025, 5501.229827824108, 5508.834734958038, 5514.145307477347, 5516.255305533782, 5682.176084467646, 5831.620944638585, 5831.854203644943, 5836.241288632451, 5838.94161058384, 5491.780328786804, 5646.265985421869, 5650.63270887391, 5683.914741278967, 5690.374058853606, 5393.487618676219, 5517.586181036519, 5533.418991005887, 5537.446255374431, 5542.0, 4024.5371782244247, 4060.878173654795, 4064.878053658395, 4067.003584121909, 4070.4911886014247, 5796.246487956539, 5826.533877289722, 5829.475347218601, 5840.766369345179, 5843.912341314969, 5489.533389661764, 5607.663540187602, 5619.8595035124445, 5621.353544342453, 5622.212890195294, 5608.803691870765, 5613.494785469327, 5614.354349249888, 5623.2408624835125, 5628.296462942132, 5471.835844924659, 5500.174973753808, 5503.807366742145, 5514.145307477347, 5517.503424691797, 5520.254765606592, 5641.8589535261945, 5646.3788983212635, 5652.236948011966, 5658.151277308272, 5461.672299662033, 5478.561715062865, 5513.117901135799, 5521.199426083276, 5523.613347065667], "unit": "ms", "name": "prototype.html", "value": 4204.4617001467295}, {"lowerIsBetter": false, "replicates": [654.6235914349245, 674.6660403100465, 782.9725959591414, 787.8030492376906, 797.4338219863896, 11076.833847492284, 11148.498317575708, 11156.107511399088, 11166.497507612157, 11184.944075279633, 10718.142548596114, 10792.082672972787, 12084.879151208484, 12289.0, 12297.200681955666, 609.7621927448299, 763.4083585221456, 777.8055486128468, 777.9377649788004, 778.0663204155009, 613.9324674285825, 752.3830459023603, 766.4558163703776, 766.5209244222361, 767.4666107055599, 780.0872978615006, 798.4171554765026, 799.3964556759638, 799.936005119589, 800.0199755299741, 629.9811005669837, 635.942765151134, 783.4437549339975, 790.4901338636575, 790.8971833661616, 589.2516504039845, 589.5165963909595, 589.7464090441108, 590.35356284868, 590.3565114025689, 10789.676309710721, 10794.190435717353, 10794.5682172713, 10804.729881753019, 10817.18871084664, 10429.79140417195, 10748.408837513934, 11101.0, 11383.0, 11834.112441566831, 8716.694915677985, 8800.647974081028, 8872.467651940904, 9001.099890010946, 9656.37233579815, 3209.245827230599, 3216.2281052547455, 3231.919202019945, 3234.75739319552, 3251.9349613007844, 39619.40570891439, 40106.799466002776, 40148.799256003826, 40824.1835163295, 40827.38758918618, 8828.823423531621, 8939.016708162097, 8946.731598052069, 8989.820203595891, 9038.367314288069, 15140.470083547023, 15161.317740701696, 15198.088114712931, 15207.467738629095, 15208.543743687707, 6379.393957574023, 6444.967775161094, 6521.934780652227, 6581.638009909501, 6722.9663851680425, 3358.8320583970703, 3364.276680513701, 3417.760756747004, 3426.931461370759, 3438.2951494943477, 2582.341502916744, 2622.121589267617, 2626.921192364232, 2629.9605505917425, 2631.3290111021565, 442.82065763365887, 444.06302701300876, 445.79493433020525, 448.5245639622011, 451.3703383779609, 545.7053191276666, 556.3546286307864, 591.588845752198, 595.3064679648162, 603.7162533609196, 7056.470764692669, 7308.37878780299, 7428.851422971618, 7485.4385921055045, 7490.700371985168, 513.1379282804849, 549.9615026948076, 567.8324894156234, 614.8247749391402, 630.6815058395481, 3499.2126771476214, 3593.7304702147444, 3657.743957922973, 3742.7754334740002, 3933.8033098344968, 49103.0, 49183.0, 49329.75335123301, 49482.752586237555, 51139.0, 43411.48827675811, 43666.56333436625, 44046.77976610096, 44226.0, 44587.77706111449, 40709.1858162841, 41257.793711031256, 41641.58358416438, 41709.0, 42322.78838605849, 7343.2289609590225, 7621.923780762343, 7652.120006199359, 7668.079830420385, 7881.605919704107, 30368.39263214679, 30873.382532349675, 31176.376472470878, 31416.52875206828, 31539.053828385186, 35554.644453555135, 39478.802605986784, 39820.60179398169, 39880.60119398885, 40144.59855401408, 9616.423014619146, 9839.803203936024, 9962.352447090916, 10067.748306292402, 10168.186545076524, 10885.619003334845, 11122.221444498808, 11210.607628732956, 11416.94291528537, 11605.0, 10948.507317170586, 10996.450177490933, 11085.778284434427, 11145.331280123219, 11208.215424920178, 10170.389776613427, 10247.948760256151, 10710.89289107099, 10794.784104317712, 11093.33439993603, 9091.818163636823, 9414.764630884283, 10663.8933610666, 10840.728981775519, 11002.394868282001, 8107.513549187068, 8432.283255923316, 8727.956360218159, 8915.331350148635, 9330.0, 8539.658413663385, 9062.864057039282, 9144.42544051563, 9180.403273787182, 9202.447853128833], "unit": "ms", "name": "yui.html", "value": 5569.823719879689}], "name": "dromaeo_css", "value": 6121.941384808755}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 112.0, 112.0, 112.0, 102.0, 111.0, 111.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [154.0, 137.0, 157.0, 173.0, 133.0, 162.0, 166.0, 132.0, 165.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 159.0, 160.0, 161.0, 158.0, 161.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 80.0, 91.0, 71.0, 73.0, 71.0, 100.0, 86.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 133.0, 94.0, 94.0, 94.0, 134.0, 94.0, 94.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 111.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 74.0, 71.0, 73.0, 73.0, 73.0, 73.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 79.0, 69.0, 69.0, 71.0, 69.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 81.0, 82.0, 82.0, 83.0, 82.0, 82.0, 91.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [126.0, 124.0, 119.0, 125.0, 120.0, 119.0, 120.0, 137.0, 121.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 149.0, 147.0, 150.0, 133.0, 150.0, 146.0, 145.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 71.0, 68.0, 68.0, 69.0, 67.0, 69.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1520.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.69038208168644], "unit": "score", "name": "Richards", "value": 214.35374400000003}, {"lowerIsBetter": false, "replicates": [192.0860545524395], "unit": "score", "name": "DeltaBlue", "value": 344.2103079999998}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [795.5449482895783], "unit": "score", "name": "Earley", "value": 837.743991}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [622.66500622665], "unit": "score", "name": "Splay", "value": 130.874546}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19780.15830749043}]} 05:13:41 INFO - RETURN: dromaeo_css: 6121.94 05:13:41 INFO - RETURN: kraken: 1520.80 05:13:41 INFO - RETURN: v8_7: 19780.16 05:13:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19780.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6121.94"}}} 05:13:41 INFO - Return code: 0 05:13:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:13:42 INFO - # TBPL SUCCESS # 05:13:42 INFO - Running post-action listener: _resource_record_post_action 05:13:42 INFO - Running post-run listener: _resource_record_post_run 05:13:43 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511479808; Read time: 16; Write time: 488996 05:13:43 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237641728; Read time: 0; Write time: 327436 05:13:43 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273530880; Read time: 16; Write time: 161532 05:13:43 INFO - Running post-run listener: _upload_blobber_files 05:13:43 INFO - Blob upload gear active. 05:13:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:13:43 INFO - Copying logs to upload dir... 05:13:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.712217 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-27 05:13:43.410251) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 05:13:43.417699) ========= 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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009924 build_url: 'https://queue.taskcluster.net/v1/task/zRYqzmbtRZuDETykfqu9iw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 05:13:43.443334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 05:13:43.443693) ========= 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=f5f5a079460e1a9be8676904000001c1-1448626673.44797-1895419995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 05:13:43.492946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 05:13:43.493255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 05:13:43.496574) ========= ========= Total master_lag: 0.74 =========