builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1449788746.41 results: success (0) buildid: 20151210145238 builduid: e44c610dd5f34f1f9369acd8c6c0e289 revision: fff7c04182f9f5ca24e9656e1458efa100b016cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.414671) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.415189) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.415553) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006216 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.442321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.442658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.814568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.814827) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.867325) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.867634) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.870850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:46.871131) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 15:05:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-10 15:05:47 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169108 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.074653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.074959) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014964 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.140318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.143772) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fff7c04182f9f5ca24e9656e1458efa100b016cc --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 fff7c04182f9f5ca24e9656e1458efa100b016cc --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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 15:05:47,629 truncating revision to first 12 chars 2015-12-10 15:05:47,629 Setting DEBUG logging. 2015-12-10 15:05:47,629 attempt 1/10 2015-12-10 15:05:47,629 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fff7c04182f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 15:05:47,914 unpacking tar archive at: fx-team-fff7c04182f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584891 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.748897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.749195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.756706) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.757050) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 15:05:47.757460) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 15:05:47.757745) ========= /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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:48 INFO - MultiFileLogger online at 20151210 15:05:48 in /builds/slave/test 15:05:48 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 15:05:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:48 INFO - {'append_to_log': False, 15:05:48 INFO - 'base_work_dir': '/builds/slave/test', 15:05:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:05:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:48 INFO - 'branch': 'Fx-Team-Non-PGO', 15:05:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:48 INFO - 'config_files': ('talos/linux_config.py',), 15:05:48 INFO - 'default_actions': ('clobber', 15:05:48 INFO - 'read-buildbot-config', 15:05:48 INFO - 'download-and-extract', 15:05:48 INFO - 'populate-webroot', 15:05:48 INFO - 'create-virtualenv', 15:05:48 INFO - 'install', 15:05:48 INFO - 'run-tests'), 15:05:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:48 INFO - 'download_minidump_stackwalk': True, 15:05:48 INFO - 'download_symbols': 'ondemand', 15:05:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:48 INFO - 'installer_path': 'installer.exe', 15:05:48 INFO - 'log_level': 'info', 15:05:48 INFO - 'log_name': 'talos', 15:05:48 INFO - 'log_to_console': True, 15:05:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:48 INFO - 'opt_config_files': (), 15:05:48 INFO - 'pip_index': False, 15:05:48 INFO - 'sps_profile': False, 15:05:48 INFO - 'sps_profile_interval': 0, 15:05:48 INFO - 'suite': 'dromaeojs', 15:05:48 INFO - 'system_bits': '64', 15:05:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:48 INFO - 'title': 'talos-linux64-ix-015', 15:05:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:48 INFO - 'use_talos_json': True, 15:05:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:48 INFO - 'work_dir': 'build'} 15:05:48 INFO - ##### 15:05:48 INFO - ##### Running clobber step. 15:05:48 INFO - ##### 15:05:48 INFO - Running pre-action listener: _resource_record_pre_action 15:05:48 INFO - Running main action method: clobber 15:05:48 INFO - rmtree: /builds/slave/test/build 15:05:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:49 INFO - Running post-action listener: _resource_record_post_action 15:05:49 INFO - ##### 15:05:49 INFO - ##### Running read-buildbot-config step. 15:05:49 INFO - ##### 15:05:49 INFO - Running pre-action listener: _resource_record_pre_action 15:05:49 INFO - Running main action method: read_buildbot_config 15:05:49 INFO - Using buildbot properties: 15:05:49 INFO - { 15:05:49 INFO - "properties": { 15:05:49 INFO - "buildnumber": 1192, 15:05:49 INFO - "product": "firefox", 15:05:49 INFO - "script_repo_revision": "production", 15:05:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:05:49 INFO - "repository": "", 15:05:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:05:49 INFO - "buildid": "20151210145238", 15:05:49 INFO - "slavename": "talos-linux64-ix-015", 15:05:49 INFO - "pgo_build": "False", 15:05:49 INFO - "basedir": "/builds/slave/test", 15:05:49 INFO - "project": "", 15:05:49 INFO - "platform": "ubuntu64_hw", 15:05:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:05:49 INFO - "slavebuilddir": "test", 15:05:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:05:49 INFO - "branch": "fx-team", 15:05:49 INFO - "repo_path": "integration/fx-team", 15:05:49 INFO - "stage_platform": "linux64", 15:05:49 INFO - "builduid": "e44c610dd5f34f1f9369acd8c6c0e289", 15:05:49 INFO - "revision": "fff7c04182f9f5ca24e9656e1458efa100b016cc" 15:05:49 INFO - }, 15:05:49 INFO - "sourcestamp": { 15:05:49 INFO - "repository": "", 15:05:49 INFO - "hasPatch": false, 15:05:49 INFO - "project": "", 15:05:49 INFO - "branch": "fx-team-linux64-talos", 15:05:49 INFO - "changes": [ 15:05:49 INFO - { 15:05:49 INFO - "category": null, 15:05:49 INFO - "files": [ 15:05:49 INFO - { 15:05:49 INFO - "url": null, 15:05:49 INFO - "name": "https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:05:49 INFO - } 15:05:49 INFO - ], 15:05:49 INFO - "repository": "", 15:05:49 INFO - "rev": "fff7c04182f9f5ca24e9656e1458efa100b016cc", 15:05:49 INFO - "who": "mconley@mozilla.com", 15:05:49 INFO - "when": 1449788722, 15:05:49 INFO - "number": 7278768, 15:05:49 INFO - "comments": "Bug 1195295 - Follow-up: remove other race-y SDK test that I failed to remove in 05b98fe2ac4f. r=Mossop\n\nMossop r+'d this over IRC.", 15:05:49 INFO - "project": "", 15:05:49 INFO - "at": "Thu 10 Dec 2015 15:05:22", 15:05:49 INFO - "branch": "fx-team-linux64-talos", 15:05:49 INFO - "revlink": "", 15:05:49 INFO - "properties": [ 15:05:49 INFO - [ 15:05:49 INFO - "buildid", 15:05:49 INFO - "20151210145238", 15:05:49 INFO - "Change" 15:05:49 INFO - ], 15:05:49 INFO - [ 15:05:49 INFO - "builduid", 15:05:49 INFO - "e44c610dd5f34f1f9369acd8c6c0e289", 15:05:49 INFO - "Change" 15:05:49 INFO - ], 15:05:49 INFO - [ 15:05:49 INFO - "pgo_build", 15:05:49 INFO - "False", 15:05:49 INFO - "Change" 15:05:49 INFO - ] 15:05:49 INFO - ], 15:05:49 INFO - "revision": "fff7c04182f9f5ca24e9656e1458efa100b016cc" 15:05:49 INFO - } 15:05:49 INFO - ], 15:05:49 INFO - "revision": "fff7c04182f9f5ca24e9656e1458efa100b016cc" 15:05:49 INFO - } 15:05:49 INFO - } 15:05:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:05:49 INFO - Running post-action listener: _resource_record_post_action 15:05:49 INFO - ##### 15:05:49 INFO - ##### Running download-and-extract step. 15:05:49 INFO - ##### 15:05:49 INFO - Running pre-action listener: _resource_record_pre_action 15:05:49 INFO - Running main action method: download_and_extract 15:05:49 INFO - mkdir: /builds/slave/test/build/tests 15:05: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')]} 15:05:49 INFO - https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/test_packages.json 15:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/test_packages.json 15:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:05:57 INFO - Downloaded 1302 bytes. 15:05:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:05:57 INFO - Using the following test package requirements: 15:05:57 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:57 INFO - u'jsshell-linux-x86_64.zip'], 15:05:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:57 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05: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')]} 15:05:57 INFO - https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:05:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:05:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:05:58 INFO - Downloaded 21867102 bytes. 15:05:58 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 15:05:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:05:58 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 15:05:59 INFO - Return code: 0 15:05:59 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 15:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:59 INFO - https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:06:04 INFO - Downloaded 21867102 bytes. 15:06:04 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 15:06:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:06:04 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 15:06:05 INFO - Return code: 0 15:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:05 INFO - https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:06:06 INFO - Downloaded 11132038 bytes. 15:06:06 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 15:06:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:06:06 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 15:06:06 INFO - Return code: 0 15:06: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')]} 15:06:06 INFO - https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/obfn1Jh3TVOpRdA0VzrJaA/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 15:06:08 INFO - Downloaded 57730891 bytes. 15:06:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:06:08 INFO - mkdir: /builds/slave/test/properties 15:06:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:06:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:06:08 INFO - Contents: 15:06:08 INFO - build_url:https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:06:08 INFO - Running post-action listener: _resource_record_post_action 15:06:08 INFO - Running post-action listener: set_extra_try_arguments 15:06:08 INFO - ##### 15:06:08 INFO - ##### Running populate-webroot step. 15:06:08 INFO - ##### 15:06:08 INFO - Running pre-action listener: _resource_record_pre_action 15:06:08 INFO - Running main action method: populate_webroot 15:06:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:06:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:06:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:06:08 INFO - '--tppagecycles', 15:06:08 INFO - '7'], 15:06:08 INFO - 'tests': ['tsvgm']}}, 15:06:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:06:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:06:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:06:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:06:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'tests': ['damp', 'tps']}, 15:06:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['damp', 'tps']}, 15:06:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:06:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:06:08 INFO - 'other': {'tests': ['a11yr', 15:06:08 INFO - 'ts_paint', 15:06:08 INFO - 'tpaint', 15:06:08 INFO - 'sessionrestore', 15:06:08 INFO - 'sessionrestore_no_auto_restore']}, 15:06:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['a11yr', 15:06:08 INFO - 'ts_paint', 15:06:08 INFO - 'tpaint', 15:06:08 INFO - 'sessionrestore', 15:06:08 INFO - 'sessionrestore_no_auto_restore']}, 15:06:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['a11yr', 15:06:08 INFO - 'ts_paint', 15:06:08 INFO - 'tpaint', 15:06:08 INFO - 'sessionrestore', 15:06:08 INFO - 'sessionrestore_no_auto_restore']}, 15:06:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['a11yr', 15:06:08 INFO - 'ts_paint', 15:06:08 INFO - 'tpaint', 15:06:08 INFO - 'sessionrestore', 15:06:08 INFO - 'sessionrestore_no_auto_restore']}, 15:06:08 INFO - 'other_l64': {'tests': ['a11yr', 15:06:08 INFO - 'ts_paint', 15:06:08 INFO - 'tpaint', 15:06:08 INFO - 'sessionrestore', 15:06:08 INFO - 'sessionrestore_no_auto_restore']}, 15:06:08 INFO - 'other_nol64': {'tests': ['a11yr', 15:06:08 INFO - 'ts_paint', 15:06:08 INFO - 'tpaint', 15:06:08 INFO - 'sessionrestore', 15:06:08 INFO - 'sessionrestore_no_auto_restore']}, 15:06:08 INFO - 'svgr': {'tests': ['tsvgx', 15:06:08 INFO - 'tsvgr_opacity', 15:06:08 INFO - 'tart', 15:06:08 INFO - 'tscrollx', 15:06:08 INFO - 'cart']}, 15:06:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['tsvgx', 15:06:08 INFO - 'tsvgr_opacity', 15:06:08 INFO - 'tart', 15:06:08 INFO - 'tscrollx', 15:06:08 INFO - 'cart']}, 15:06:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'tests': ['tp5o']}, 15:06:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'talos_options': ['--e10s'], 15:06:08 INFO - 'tests': ['tp5o']}, 15:06:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'talos_options': ['--xperf_path', 15:06:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:08 INFO - 'tests': ['tp5n']}, 15:06:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:08 INFO - 'talos_options': ['--e10s', 15:06:08 INFO - '--xperf_path', 15:06:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:08 INFO - 'tests': ['tp5n']}}, 15:06:08 INFO - 'talos.zip': {'path': '', 15:06:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:06:08 INFO - Running post-action listener: _resource_record_post_action 15:06:08 INFO - ##### 15:06:08 INFO - ##### Running create-virtualenv step. 15:06:08 INFO - ##### 15:06:08 INFO - Running pre-action listener: _resource_record_pre_action 15:06:08 INFO - Running main action method: create_virtualenv 15:06:08 INFO - Creating virtualenv /builds/slave/test/build/venv 15:06:08 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 15:06:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:06:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:06:08 INFO - Using real prefix '/usr' 15:06:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:06:08 INFO - Installing distribute.............................................................................................................................................................................................done. 15:06:10 INFO - Installing pip.................done. 15:06:10 INFO - Return code: 0 15:06:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:10 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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:10 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 15:06:10 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 15:06:10 INFO - Using env: {'DISPLAY': ':0', 15:06:10 INFO - 'HOME': '/home/cltbld', 15:06:10 INFO - 'LANG': 'en_US.UTF-8', 15:06:10 INFO - 'LANGUAGE': 'en_US:en', 15:06:10 INFO - 'LOGNAME': 'cltbld', 15:06:10 INFO - 'MAIL': '/var/mail/cltbld', 15:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:10 INFO - 'MOZ_NO_REMOTE': '1', 15:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:10 INFO - 'NO_EM_RESTART': '1', 15:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:10 INFO - 'PWD': '/builds/slave/test', 15:06:10 INFO - 'SHELL': '/bin/bash', 15:06:10 INFO - 'SHLVL': '1', 15:06:10 INFO - 'TERM': 'linux', 15:06:10 INFO - 'TMOUT': '86400', 15:06:10 INFO - 'USER': 'cltbld', 15:06:10 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:10 INFO - '_': '/tools/buildbot/bin/python'} 15:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:11 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 15:06:11 INFO - Cleaning up... 15:06:11 INFO - Return code: 0 15:06:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:06:11 INFO - Using env: {'DISPLAY': ':0', 15:06:11 INFO - 'HOME': '/home/cltbld', 15:06:11 INFO - 'LANG': 'en_US.UTF-8', 15:06:11 INFO - 'LANGUAGE': 'en_US:en', 15:06:11 INFO - 'LOGNAME': 'cltbld', 15:06:11 INFO - 'MAIL': '/var/mail/cltbld', 15:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:11 INFO - 'MOZ_NO_REMOTE': '1', 15:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:11 INFO - 'NO_EM_RESTART': '1', 15:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:11 INFO - 'PWD': '/builds/slave/test', 15:06:11 INFO - 'SHELL': '/bin/bash', 15:06:11 INFO - 'SHLVL': '1', 15:06:11 INFO - 'TERM': 'linux', 15:06:11 INFO - 'TMOUT': '86400', 15:06:11 INFO - 'USER': 'cltbld', 15:06:11 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:11 INFO - '_': '/tools/buildbot/bin/python'} 15:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:11 INFO - Downloading/unpacking psutil>=0.7.1 15:06:11 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 15:06:11 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 15:06:11 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 15:06:11 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 15:06:11 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 15:06:11 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 15:06:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:06:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:06:13 INFO - Installing collected packages: psutil 15:06:13 INFO - Running setup.py install for psutil 15:06:13 INFO - building 'psutil._psutil_linux' extension 15:06:13 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 15:06:13 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 15:06:13 INFO - building 'psutil._psutil_posix' extension 15:06:13 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 15:06:13 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 15:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:06:13 INFO - Successfully installed psutil 15:06:13 INFO - Cleaning up... 15:06:13 INFO - Return code: 0 15:06:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:06:13 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')]} 15:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:13 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')]} 15:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:13 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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:13 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 15:06:13 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 15:06:13 INFO - Using env: {'DISPLAY': ':0', 15:06:13 INFO - 'HOME': '/home/cltbld', 15:06:13 INFO - 'LANG': 'en_US.UTF-8', 15:06:13 INFO - 'LANGUAGE': 'en_US:en', 15:06:13 INFO - 'LOGNAME': 'cltbld', 15:06:13 INFO - 'MAIL': '/var/mail/cltbld', 15:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:13 INFO - 'MOZ_NO_REMOTE': '1', 15:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:13 INFO - 'NO_EM_RESTART': '1', 15:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:13 INFO - 'PWD': '/builds/slave/test', 15:06:13 INFO - 'SHELL': '/bin/bash', 15:06:13 INFO - 'SHLVL': '1', 15:06:13 INFO - 'TERM': 'linux', 15:06:13 INFO - 'TMOUT': '86400', 15:06:13 INFO - 'USER': 'cltbld', 15:06:13 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:13 INFO - '_': '/tools/buildbot/bin/python'} 15:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:06:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:06:15 INFO - Installing collected packages: mozsystemmonitor 15:06:15 INFO - Running setup.py install for mozsystemmonitor 15:06:15 INFO - Successfully installed mozsystemmonitor 15:06:15 INFO - Cleaning up... 15:06:15 INFO - Return code: 0 15:06:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:06:15 INFO - Using env: {'DISPLAY': ':0', 15:06:15 INFO - 'HOME': '/home/cltbld', 15:06:15 INFO - 'LANG': 'en_US.UTF-8', 15:06:15 INFO - 'LANGUAGE': 'en_US:en', 15:06:15 INFO - 'LOGNAME': 'cltbld', 15:06:15 INFO - 'MAIL': '/var/mail/cltbld', 15:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:15 INFO - 'MOZ_NO_REMOTE': '1', 15:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:15 INFO - 'NO_EM_RESTART': '1', 15:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:15 INFO - 'PWD': '/builds/slave/test', 15:06:15 INFO - 'SHELL': '/bin/bash', 15:06:15 INFO - 'SHLVL': '1', 15:06:15 INFO - 'TERM': 'linux', 15:06:15 INFO - 'TMOUT': '86400', 15:06:15 INFO - 'USER': 'cltbld', 15:06:15 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:15 INFO - '_': '/tools/buildbot/bin/python'} 15:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:17 INFO - Downloading blobuploader-1.2.4.tar.gz 15:06:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:06:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:06:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:18 INFO - Downloading docopt-0.6.1.tar.gz 15:06:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:06:18 INFO - Installing collected packages: blobuploader, requests, docopt 15:06:18 INFO - Running setup.py install for blobuploader 15:06:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:06:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:06:18 INFO - Running setup.py install for requests 15:06:18 INFO - Running setup.py install for docopt 15:06:18 INFO - Successfully installed blobuploader requests docopt 15:06:18 INFO - Cleaning up... 15:06:18 INFO - Return code: 0 15:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:18 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')]} 15:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:18 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')]} 15:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:18 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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:18 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 15:06:18 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 15:06:18 INFO - Using env: {'DISPLAY': ':0', 15:06:18 INFO - 'HOME': '/home/cltbld', 15:06:18 INFO - 'LANG': 'en_US.UTF-8', 15:06:18 INFO - 'LANGUAGE': 'en_US:en', 15:06:18 INFO - 'LOGNAME': 'cltbld', 15:06:18 INFO - 'MAIL': '/var/mail/cltbld', 15:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:18 INFO - 'MOZ_NO_REMOTE': '1', 15:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:18 INFO - 'NO_EM_RESTART': '1', 15:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:18 INFO - 'PWD': '/builds/slave/test', 15:06:18 INFO - 'SHELL': '/bin/bash', 15:06:18 INFO - 'SHLVL': '1', 15:06:18 INFO - 'TERM': 'linux', 15:06:18 INFO - 'TMOUT': '86400', 15:06:18 INFO - 'USER': 'cltbld', 15:06:18 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:18 INFO - '_': '/tools/buildbot/bin/python'} 15:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:19 INFO - Running setup.py (path:/tmp/pip-SJxg__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:19 INFO - Running setup.py (path:/tmp/pip-whRgmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:19 INFO - Running setup.py (path:/tmp/pip-JDyQL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:19 INFO - Running setup.py (path:/tmp/pip-SjmDA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:19 INFO - Running setup.py (path:/tmp/pip-rxqaNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:19 INFO - Running setup.py (path:/tmp/pip-OY8b6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:19 INFO - Running setup.py (path:/tmp/pip-20wB9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:19 INFO - Running setup.py (path:/tmp/pip-wvcgHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:19 INFO - Running setup.py (path:/tmp/pip-BgvkCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:19 INFO - Running setup.py (path:/tmp/pip-kSRD2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:19 INFO - Running setup.py (path:/tmp/pip-0dyKtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:19 INFO - Running setup.py (path:/tmp/pip-Uda5zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:19 INFO - Running setup.py (path:/tmp/pip-wrPyMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:20 INFO - Running setup.py (path:/tmp/pip-sUROq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:20 INFO - Running setup.py (path:/tmp/pip-kHLd6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:20 INFO - Running setup.py (path:/tmp/pip-uSxLxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:20 INFO - Running setup.py (path:/tmp/pip-BdOJt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:06:20 INFO - Running setup.py install for manifestparser 15:06:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:06:20 INFO - Running setup.py install for mozcrash 15:06:20 INFO - Running setup.py install for mozdebug 15:06:20 INFO - Running setup.py install for mozdevice 15:06:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:06:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:06:20 INFO - Running setup.py install for mozfile 15:06:20 INFO - Running setup.py install for mozhttpd 15:06:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:06:20 INFO - Running setup.py install for mozinfo 15:06:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Running setup.py install for mozInstall 15:06:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Running setup.py install for mozleak 15:06:21 INFO - Running setup.py install for mozlog 15:06:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Running setup.py install for moznetwork 15:06:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Running setup.py install for mozprocess 15:06:21 INFO - Running setup.py install for mozprofile 15:06:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Running setup.py install for mozrunner 15:06:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:06:21 INFO - Running setup.py install for mozscreenshot 15:06:21 INFO - Running setup.py install for moztest 15:06:22 INFO - Running setup.py install for mozversion 15:06:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:06:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:06:22 INFO - Cleaning up... 15:06:22 INFO - Return code: 0 15:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:22 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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:22 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 15:06:22 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 15:06:22 INFO - Using env: {'DISPLAY': ':0', 15:06:22 INFO - 'HOME': '/home/cltbld', 15:06:22 INFO - 'LANG': 'en_US.UTF-8', 15:06:22 INFO - 'LANGUAGE': 'en_US:en', 15:06:22 INFO - 'LOGNAME': 'cltbld', 15:06:22 INFO - 'MAIL': '/var/mail/cltbld', 15:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:22 INFO - 'MOZ_NO_REMOTE': '1', 15:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:22 INFO - 'NO_EM_RESTART': '1', 15:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:22 INFO - 'PWD': '/builds/slave/test', 15:06:22 INFO - 'SHELL': '/bin/bash', 15:06:22 INFO - 'SHLVL': '1', 15:06:22 INFO - 'TERM': 'linux', 15:06:22 INFO - 'TMOUT': '86400', 15:06:22 INFO - 'USER': 'cltbld', 15:06:22 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:22 INFO - '_': '/tools/buildbot/bin/python'} 15:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:22 INFO - Running setup.py (path:/tmp/pip-4XOaK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:22 INFO - Running setup.py (path:/tmp/pip-StDA_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:22 INFO - Running setup.py (path:/tmp/pip-zuCwUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:22 INFO - Running setup.py (path:/tmp/pip-KplDNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:22 INFO - Running setup.py (path:/tmp/pip-xefiye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:22 INFO - Running setup.py (path:/tmp/pip-3g9Yj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:22 INFO - Running setup.py (path:/tmp/pip-jmlXWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:22 INFO - Running setup.py (path:/tmp/pip-8qTcFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:22 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)) 15:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:22 INFO - Running setup.py (path:/tmp/pip-eTlgby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:23 INFO - Running setup.py (path:/tmp/pip-Hg1ixC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:23 INFO - Running setup.py (path:/tmp/pip-oHhVky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:23 INFO - Running setup.py (path:/tmp/pip-lbvaqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:23 INFO - Running setup.py (path:/tmp/pip-ORplh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:23 INFO - Running setup.py (path:/tmp/pip-EDm5oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:23 INFO - Running setup.py (path:/tmp/pip-rldxIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:23 INFO - Running setup.py (path:/tmp/pip-PxKneT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:23 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)) 15:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:23 INFO - Running setup.py (path:/tmp/pip-gZFW1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:23 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)) 15:06:23 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)) 15:06:23 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)) 15:06:23 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)) 15:06:23 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)) 15:06:23 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)) 15:06:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:25 INFO - Downloading blessings-1.5.1.tar.gz 15:06:25 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 15:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:06:25 INFO - Installing collected packages: blessings 15:06:25 INFO - Running setup.py install for blessings 15:06:25 INFO - Successfully installed blessings 15:06:25 INFO - Cleaning up... 15:06:25 INFO - Return code: 0 15:06:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:25 INFO - Reading from file tmpfile_stdout 15:06:25 INFO - Current package versions: 15:06:25 INFO - argparse == 1.2.1 15:06:25 INFO - blessings == 1.5.1 15:06:25 INFO - blobuploader == 1.2.4 15:06:25 INFO - docopt == 0.6.1 15:06:25 INFO - manifestparser == 1.1 15:06:25 INFO - mozInstall == 1.12 15:06:25 INFO - mozcrash == 0.16 15:06:25 INFO - mozdebug == 0.1 15:06:25 INFO - mozdevice == 0.47 15:06:25 INFO - mozfile == 1.2 15:06:25 INFO - mozhttpd == 0.7 15:06:25 INFO - mozinfo == 0.9 15:06:25 INFO - mozleak == 0.1 15:06:25 INFO - mozlog == 3.1 15:06:25 INFO - moznetwork == 0.27 15:06:25 INFO - mozprocess == 0.22 15:06:25 INFO - mozprofile == 0.27 15:06:25 INFO - mozrunner == 6.11 15:06:25 INFO - mozscreenshot == 0.1 15:06:25 INFO - mozsystemmonitor == 0.0 15:06:25 INFO - moztest == 0.7 15:06:25 INFO - mozversion == 1.4 15:06:25 INFO - psutil == 3.1.1 15:06:25 INFO - requests == 1.2.3 15:06:25 INFO - wsgiref == 0.1.2 15:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:25 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')]} 15:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:25 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')]} 15:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:25 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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:25 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 15:06:25 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 15:06:25 INFO - Using env: {'DISPLAY': ':0', 15:06:25 INFO - 'HOME': '/home/cltbld', 15:06:25 INFO - 'LANG': 'en_US.UTF-8', 15:06:25 INFO - 'LANGUAGE': 'en_US:en', 15:06:25 INFO - 'LOGNAME': 'cltbld', 15:06:25 INFO - 'MAIL': '/var/mail/cltbld', 15:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:25 INFO - 'MOZ_NO_REMOTE': '1', 15:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:25 INFO - 'NO_EM_RESTART': '1', 15:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:25 INFO - 'PWD': '/builds/slave/test', 15:06:25 INFO - 'SHELL': '/bin/bash', 15:06:25 INFO - 'SHLVL': '1', 15:06:25 INFO - 'TERM': 'linux', 15:06:25 INFO - 'TMOUT': '86400', 15:06:25 INFO - 'USER': 'cltbld', 15:06:25 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:25 INFO - '_': '/tools/buildbot/bin/python'} 15:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 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)) 15:06:25 INFO - Cleaning up... 15:06:25 INFO - Return code: 0 15:06:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:06:25 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')]} 15:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:25 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')]} 15:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:25 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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:25 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 15:06:25 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 15:06:25 INFO - Using env: {'DISPLAY': ':0', 15:06:25 INFO - 'HOME': '/home/cltbld', 15:06:25 INFO - 'LANG': 'en_US.UTF-8', 15:06:25 INFO - 'LANGUAGE': 'en_US:en', 15:06:25 INFO - 'LOGNAME': 'cltbld', 15:06:25 INFO - 'MAIL': '/var/mail/cltbld', 15:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:25 INFO - 'MOZ_NO_REMOTE': '1', 15:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:25 INFO - 'NO_EM_RESTART': '1', 15:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:25 INFO - 'PWD': '/builds/slave/test', 15:06:25 INFO - 'SHELL': '/bin/bash', 15:06:25 INFO - 'SHLVL': '1', 15:06:25 INFO - 'TERM': 'linux', 15:06:25 INFO - 'TMOUT': '86400', 15:06:25 INFO - 'USER': 'cltbld', 15:06:25 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:25 INFO - '_': '/tools/buildbot/bin/python'} 15:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:26 INFO - Downloading/unpacking jsonschema 15:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:06:27 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 15:06:27 INFO - Downloading/unpacking functools32 (from jsonschema) 15:06:27 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 15:06:27 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 15:06:27 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 15:06:27 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 15:06:27 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 15:06:27 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 15:06:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:06:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:06:28 INFO - warning: no files found matching '*.txt' 15:06:28 INFO - no previously-included directories found matching 'build' 15:06:28 INFO - no previously-included directories found matching 'dist' 15:06:28 INFO - no previously-included directories found matching '.git*' 15:06:28 INFO - Installing collected packages: jsonschema, functools32 15:06:28 INFO - Running setup.py install for functools32 15:06:28 INFO - warning: no files found matching '*.txt' 15:06:28 INFO - no previously-included directories found matching 'build' 15:06:28 INFO - no previously-included directories found matching 'dist' 15:06:28 INFO - no previously-included directories found matching '.git*' 15:06:28 INFO - Successfully installed jsonschema functools32 15:06:28 INFO - Cleaning up... 15:06:28 INFO - Return code: 0 15:06:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:06:28 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')]} 15:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:28 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')]} 15:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:28 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 0x7f86c0358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', '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 15:06:28 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 15:06:28 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 15:06:28 INFO - Using env: {'DISPLAY': ':0', 15:06:28 INFO - 'HOME': '/home/cltbld', 15:06:28 INFO - 'LANG': 'en_US.UTF-8', 15:06:28 INFO - 'LANGUAGE': 'en_US:en', 15:06:28 INFO - 'LOGNAME': 'cltbld', 15:06:28 INFO - 'MAIL': '/var/mail/cltbld', 15:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:28 INFO - 'MOZ_NO_REMOTE': '1', 15:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:28 INFO - 'NO_EM_RESTART': '1', 15:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:28 INFO - 'PWD': '/builds/slave/test', 15:06:28 INFO - 'SHELL': '/bin/bash', 15:06:28 INFO - 'SHLVL': '1', 15:06:28 INFO - 'TERM': 'linux', 15:06:28 INFO - 'TMOUT': '86400', 15:06:28 INFO - 'USER': 'cltbld', 15:06:28 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:28 INFO - '_': '/tools/buildbot/bin/python'} 15:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:28 INFO - Downloading/unpacking flake8 15:06:28 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 15:06:28 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 15:06:28 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 15:06:28 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 15:06:28 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 15:06:28 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 15:06:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:06:30 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 15:06:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:06:30 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 15:06:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 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 15:06:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:06:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:06:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:06:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:06:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:06:30 INFO - no previously-included directories found matching 'docs/_build' 15:06:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:06:31 INFO - Running setup.py install for pep8 15:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:06:31 INFO - no previously-included directories found matching 'docs/_build' 15:06:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:06:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:06:31 INFO - Cleaning up... 15:06:31 INFO - Return code: 0 15:06:31 INFO - Running post-action listener: _resource_record_post_action 15:06:31 INFO - Running post-action listener: _start_resource_monitoring 15:06:31 INFO - Starting resource monitoring. 15:06:31 INFO - ##### 15:06:31 INFO - ##### Running install step. 15:06:31 INFO - ##### 15:06:31 INFO - Running pre-action listener: _resource_record_pre_action 15:06:31 INFO - Running main action method: install 15:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:06:31 INFO - Reading from file tmpfile_stdout 15:06:31 INFO - Detecting whether we're running mozinstall >=1.0... 15:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:06:31 INFO - Reading from file tmpfile_stdout 15:06:31 INFO - Output received: 15:06:31 INFO - Usage: mozinstall [options] installer 15:06:31 INFO - Options: 15:06:31 INFO - -h, --help show this help message and exit 15:06:31 INFO - -d DEST, --destination=DEST 15:06:31 INFO - Directory to install application into. [default: 15:06:31 INFO - "/builds/slave/test"] 15:06:31 INFO - --app=APP Application being installed. [default: firefox] 15:06:31 INFO - mkdir: /builds/slave/test/build/application 15:06:31 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'] 15:06:31 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 15:06:46 INFO - Reading from file tmpfile_stdout 15:06:46 INFO - Output received: 15:06:46 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:46 INFO - Running post-action listener: _resource_record_post_action 15:06:46 INFO - ##### 15:06:46 INFO - ##### Running run-tests step. 15:06:46 INFO - ##### 15:06:46 INFO - Running pre-action listener: _resource_record_pre_action 15:06:46 INFO - Running main action method: run_tests 15:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:46 INFO - Python 2.7.3 15:06:46 INFO - Return code: 0 15:06:46 INFO - grabbing minidump binary from tooltool 15:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:46 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 0x14f70b0>, '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 0x14f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:46 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 15:06:46 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 15:06:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:46 INFO - Return code: 0 15:06:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:06:47 INFO - Return code: 0 15:06:47 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/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test/build 15:06:47 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/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 15:06:47 INFO - Using env: {'DISPLAY': ':0', 15:06:47 INFO - 'HOME': '/home/cltbld', 15:06:47 INFO - 'LANG': 'en_US.UTF-8', 15:06:47 INFO - 'LANGUAGE': 'en_US:en', 15:06:47 INFO - 'LOGNAME': 'cltbld', 15:06:47 INFO - 'MAIL': '/var/mail/cltbld', 15:06:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:47 INFO - 'MOZ_NO_REMOTE': '1', 15:06:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:47 INFO - 'NO_EM_RESTART': '1', 15:06:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:47 INFO - 'PWD': '/builds/slave/test', 15:06:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:47 INFO - 'SHELL': '/bin/bash', 15:06:47 INFO - 'SHLVL': '1', 15:06:47 INFO - 'TERM': 'linux', 15:06:47 INFO - 'TMOUT': '86400', 15:06:47 INFO - 'USER': 'cltbld', 15:06:47 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132', 15:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:47 INFO - '_': '/tools/buildbot/bin/python'} 15:06:47 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/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 15:06:47 INFO - mozversion INFO | application_buildid: 20151210145238 15:06:47 INFO - mozversion INFO | application_changeset: fff7c04182f9f5ca24e9656e1458efa100b016cc 15:06:47 INFO - mozversion INFO | application_display_name: Nightly 15:06:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:47 INFO - mozversion INFO | application_name: Firefox 15:06:47 INFO - mozversion INFO | application_remotingname: firefox 15:06:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:06:47 INFO - mozversion INFO | application_vendor: Mozilla 15:06:47 INFO - mozversion INFO | application_version: 45.0a1 15:06:47 INFO - mozversion INFO | platform_buildid: 20151210145238 15:06:47 INFO - mozversion INFO | platform_changeset: fff7c04182f9f5ca24e9656e1458efa100b016cc 15:06:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:47 INFO - mozversion INFO | platform_version: 45.0a1 15:06:47 INFO - 2015-12-10 15:06:47,228 DEBUG : using testdate: 1449788807 15:06:47 INFO - 2015-12-10 15:06:47,228 DEBUG : actual date: 1449788807 15:06:47 INFO - 2015-12-10 15:06:47,237 INFO : starting webserver on 'localhost:42192' 15:06:47 INFO - 2015-12-10 15:06:47,238 INFO : Starting test suite talos-linux64-ix-015 15:06:47 INFO - 2015-12-10 15:06:47,238 INFO : Starting test dromaeo_css 15:06:47 INFO - 2015-12-10 15:06:47,238 DEBUG : operating with platform_type : linux_ 15:06:47 INFO - 2015-12-10 15:06:47,239 INFO : Initialising browser for dromaeo_css test... 15:06:47 INFO - 2015-12-10 15:06:47,256 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ1Msv6/profile http://localhost:42192/getInfo.html 15:06:52 INFO - 2015-12-10 15:06:52,031 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:06:52 INFO - 2015-12-10 15:06:52,031 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:06:52 INFO - 2015-12-10 15:06:52,031 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:06:52 INFO - 2015-12-10 15:06:52,031 DEBUG : BROWSER_OUTPUT: __metrics 15:06:52 INFO - 2015-12-10 15:06:52,107 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:06:52 INFO - 2015-12-10 15:06:52,183 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] 15:06:52 INFO - 2015-12-10 15:06:52,976 INFO : Browser initialized. 15:06:52 INFO - 2015-12-10 15:06:52,977 INFO : Running cycle 1/1 for dromaeo_css test... 15:06:52 INFO - 2015-12-10 15:06:52,977 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ1Msv6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:07:04 INFO - 2015-12-10 15:07:04,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 142987264 15:07:04 INFO - 2015-12-10 15:07:04,931 DEBUG : BROWSER_OUTPUT: 15:07:56 INFO - 2015-12-10 15:07:56,058 DEBUG : BROWSER_OUTPUT: 1449788876054 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] 15:10:08 INFO - 2015-12-10 15:10:08,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42192/tests/dromaeo/cssquery-ext.html) 15:10:09 INFO - 2015-12-10 15:10:09,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 239198208 15:10:09 INFO - 2015-12-10 15:10:09,117 DEBUG : BROWSER_OUTPUT: 15:13:11 INFO - 2015-12-10 15:13:11,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/dromaeo/cssquery-ext.html (next: http://localhost:42192/tests/dromaeo/cssquery-jquery.html) 15:13:12 INFO - 2015-12-10 15:13:12,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 222486528 15:13:12 INFO - 2015-12-10 15:13:12,265 DEBUG : BROWSER_OUTPUT: 15:16:14 INFO - 2015-12-10 15:16:14,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42192/tests/dromaeo/cssquery-mootools.html) 15:16:14 INFO - 2015-12-10 15:16:14,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 225566720 15:16:14 INFO - 2015-12-10 15:16:14,881 DEBUG : BROWSER_OUTPUT: 15:19:16 INFO - 2015-12-10 15:19:16,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42192/tests/dromaeo/cssquery-prototype.html) 15:19:17 INFO - 2015-12-10 15:19:17,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 204439552 15:19:17 INFO - 2015-12-10 15:19:17,410 DEBUG : BROWSER_OUTPUT: 15:22:20 INFO - 2015-12-10 15:22:20,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42192/tests/dromaeo/cssquery-yui.html) 15:22:20 INFO - 2015-12-10 15:22:20,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 206983168 15:22:20 INFO - 2015-12-10 15:22:20,931 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/dromaeo/cssquery-yui.html (next: http://localhost:42192/tests/dromaeo/cssquery-dojo.html) 15:25:23 INFO - 2015-12-10 15:25:23,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 253104128 15:25:23 INFO - 2015-12-10 15:25:23,600 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,601 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:25:23 INFO - 2015-12-10 15:25:23,601 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:25:23 INFO - 2015-12-10 15:25:23,601 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:25:23 INFO - 2015-12-10 15:25:23,601 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:25:23 INFO - 2015-12-10 15:25:23,602 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2601.1546247469573;2655.203438968309;2675.62541244226;2675.7324267573244;2695.6899956505004;4431.578999995003;4583;4629.074185162968;4694.741789201593;4743.027679325739;4647.53524647536;4677.462091859428;4728.219843725789;4728.692634978733;4732.999999999992;4272.498398557962;4324.481062272516;4327.11294184693;4376.452943382077;4394.758288294142;4162.958370416302;4376.846810361638;4381.561843815609;4421.756803375813;4441.089576636782;4210.536840947493;4294.355846623016;4301.118270754488;4308.526062133163;4320.049589090427;4351.608355248043;4353;4364.781760911942;4369.126174765028;4419.64642828573;4325.416068830699;4332.610065094125;4361.040571074359;4379;4394.099209662044;4378.824847006116;4508.977455112737;4520.773961301922;4537.954620453819;4660.766961651904;4941.802327906879;4942.135126352874;4948.678335908155;4952.405711314629;4989.950100498985;4967.975160124212;4969.676970996874;4975.3532040834825;4985.850424487271;5006.799728010875;4478.507364189936;4554.70394424368;4589;4593.28804035375;4653.162430762428;5117.8464646060675;5124.538791508782;5162.380514338229;5169.302144210558;5170.560502357266;4982.153033984231;5000.724960127228;5000.799968001312;5004.049230646166;5046.495350464924;4848.5636292733825;4962.057209130254;5073.695578265316;5083.567896728746;5086.415062267813;4883.511648835088;4884.3161957326;4944.25836124577;4952.5542701157065;4982.4768399317545;4920.8769780755765;4922.630802689812;4922.90154196914;4932.778024988884;4972.5276098770555;4041.7574945503366;4129.710920235615;4142.855000075043;4143.3370660694145;4150.875473735793;3548.414511605556;3624.365735996243;3631.8365673544754;3631.891043268706;3644.1982763791925;4298.183345164409;4361;4364.061726728769;4364.323529852814;4394.978025109854;5046.467472769003;5061.848144555669;5067.873303167376;5068.847934561969;5114.28400023997;4166.812493437803;4244.681648876347;4259.5527469615245;4264.424302719155;4331.393604895317;4430.246858034077;4465.620422264144;4473.776311184428;4474;4515.796789144496;4792.448868380111;4805.447373552086;4810.037992401463;4813.9037219254715;4854.878628034327;4798.760061996956;4858.368412106403;4890.388701412324;4911.115999120193;4949.208126699711;4717.716936983792;4729.385179926588;4735.83424580138;4739.739314337745;4781.187198176388;4938.802447902043;4948.579370753526;4954.777035033504;4957.876053098701;5005.4744251853035;4765.8093676252565;4866.391701037371;4871.658983871095;4925.113479573711;5049.621278404208;4833.685810422311;4884.194107972145;4889.951100488949;4890.388701412324;4937.23472861707;4864.440589332131;4879.682820616648;4880.023995200903;4929.112759703288;4929.975350123226;4417.514073451854;4586.564276393738;4692.061587682545;4704.553067458586;4829.66192366531;4801.255805350176;4802.039592081667;4811.374521312207;4816.397950256218;4823.445303790109;4709.599684026896;4714.033623107323;4718.174319494006;4731.929021064618;4751.453582837879 15:25:23 INFO - 2015-12-10 15:25:23,602 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.5199232644578;574.2104606166521;579.6811753535555;580.3297191743537;580.3471095018105;26628.733712662866;35109;35753.64246357532;35779.642203577954;35794.82102589483;39982.8000859996;40447.79776101123;40496.19007619853;40551.59448405515;40632;6979.930200698004;7101.8224544386285;7797.883031754514;7985.520868747864;7988.161243069481;9950.30347875649;10172.949135254314;10202;10212.336198147133;10217;9697.563609637547;9790.951045244763;9797.167240784542;9797.6080956762;9815.558299876488;7262.963685181593;7453.14288856783;9744.464054477;10074.345167564084;10343.120834729058;9788.168005719523;9926.602935882556;9932.553035113366;9932.95033524835;9936.354136981145;37321;37720;37810.62189378098;37828.81085594582;37829;2821.830690158597;2843.6871944086133;2852.286928267933;2877.5395936650243;2877.7266159714795;28119;28250.152495424965;28400.431991360056;28642.14073577796;28929;3390.5247121700454;3451.620321764604;3456.2396272819938;3521.4013617685055;3566.2154326048226;218838;219789;219904;219918.90040549854;220116;50448.49551504511;51542.742286288325;54890.451095489334;55224.17163742547;55231;63670.68164659147;64887.35112648908;65126.34873651298;65146.674266629314;65148.34851651518;12131.090168237417;12138.817917731241;12155.453004614814;12157.817632735516;12267.325297108744;9762.121409073217;9840.65557705477;9888.653897113567;9903.702888913343;9945.950270248602;18869.33957311515;18883.622327553647;18987.525311867037;18993.62012759737;19024.239030438905;7089.645517724196;7319.963400183072;7467.253274672598;7473.813154671068;7506.587137707369;800.263757343234;886.6719313853915;936.9765755856022;940.9461403228428;1007.5969612155196;26307.473850523264;26351.868240659056;26491.735082649313;27702;27843;904.9864252036225;908.977275568116;916.7158180963922;924.4360939826701;933.6872147830553;12950.222986620833;13154.802677959839;13183.868161318456;13185.73628527424;14158;256798;261568;262301;262556;263889;46707.532924670995;46940.29589556159;47021.5297847024;47201;47206;1141.6689160143465;1172.513406936129;1186.5016692988966;1187.4715751490676;1190.2144584574312;22618.547629047654;25823.741762582886;26579.7342026585;28882.711172888;28903.85548072246;39991.80004099961;40453.595464044985;40514.987125322106;40568;40580;200057;202468;202585;202774;224722;23634.527309454057;27642.447151056465;27791.583126252717;27970.440591188468;28063.57904631473;35262;35784.46323305205;35947.1013224661;36411.45382819207;36631.81684091563;31031.68968310288;31256.531152033192;32229.194270143435;34557;37195.25609487849;32125;32191.35617287594;36525.45211821772;37744;38184.809075955556;37257.62742372542;37819;37990.81004594959;38026.429603555414;38199.80900095482;34784.65215347814;35724.10689732673;35972.46041309435;36066.4590031155;36277.455838162976;27570.86214568914;27693.169204923885;27938.860305699156;28332.575011374433;28453.857730711214 15:25:23 INFO - 2015-12-10 15:25:23,602 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.9898003059909;343.560242889102;344.7121653419395;345.90660521659146;346.75553734617097;12617.306048167347;12941.41763620637;14931.776023359645;14973.775393369107;15921.761173582405;15242.237888105607;15346;16303.184840757975;16322.183890805472;16346.18269086547;4923.138450771118;5051.343325367706;5067.214581739836;5070.847874563769;5071.808125090601;3527.5237842891265;3630.146915474861;5021.623378246646;5210.062188806013;5381.7578208980685;5344.385395679488;5359.062164121283;5359.196120581905;5378.946210537903;5387.649802762828;5187.792488300463;5328.760205790749;5336.38631557372;5341.545968592674;5343.519083282485;5132.153194722866;5134.666246693991;5140.1518749406305;5140.74296285188;5141.820036298749;13015.544455943997;18466.169022394024;18867.339643112424;18904.810951890442;18912.5271868203;1671.9498415047567;1750.8074111847814;1805.5486128467883;1808.104988030933;1815.0471002723543;8829.337799664987;8894.656245649656;8918.866217006751;9023.954880225623;9115.726528204164;1673.9414120505846;1693.1365003848125;1752.9298828046863;1803.6302557975714;1841.6132612151464;54908.725456372464;56029.43970560283;56559.434405655826;56840.71579642075;57870.421295786924;9444.338896277195;9783.804323913482;10009.149222316039;10030.598776048877;10073.093421592092;12689.49242030327;12784.296863672402;12784.61646150617;12791.808122878165;12806.103572750004;6731.427828634523;6768.492363072789;6793.252742198354;6812.284710105368;6841.863162736817;5946.70266486674;6000.729967151488;6303.905441418382;6360.109584658151;6364.809055728336;4185.811638476215;4257;4267.935980960288;4269.573042695705;4290.957090429119;1634.2972521815734;1663;1666.9749953750704;1673.5816045988504;1683.6548507555922;369.3739112204787;374.487072228195;423.4854651598323;809.4738420026912;854.5727136431784;8962.32782541312;9053.728388148365;9192.95403522978;9518.286128540387;9764.316497845224;406.8413318805668;407.6107317511769;407.641275677402;419.6789456066112;427.9614834664895;5421.430749771296;5666.3284331121595;5726.169705392778;5741.684207368635;5745.597808153473;495703;501143;501751;506768;510201;69733.30266697268;69915.65042174756;71200.28799711936;71297.28702712906;71367.6431617849;452.4254197169642;455.76072561905266;456.9268916973268;457.09495199505164;457.816873250709;9617;9642.807143856944;9659.71020869375;9723.222142228464;9742.269329800152;32281.51577726289;33110.50334245036;33224.16939576433;34350.82824585861;34514.654853451146;42882.78558607187;43433;44569;44797.88005299894;44875.326870097626;8382.329413646772;9054.909450905407;9070.501122438329;9071.092890710876;9073.637054517745;15613.453529126426;15686.294116765;15831.366745330059;16046.679066418374;16233.350665973701;12886.613401597968;12951.352432378155;12976.416061277076;13055.477780888657;13218.140820846615;12536.37318134108;12762.106652534234;13070.34648267602;13656.590302290948;13844.10013349129;10296.742581435525;10762.515686793957;11453.542545929195;12396.566120185751;13057.738845223232;8573.485590864568;8701.260392866425;8708.34687398435;8728;8732.257758090633;8932.642694292155;8960.059193784558;12077.637670869888;12393.588769923252;12563.18339307942 15:25:23 INFO - 2015-12-10 15:25:23,603 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1433.3334999225358;1608.3245037084423;1615.07133398296;1650.232641821552;1681.1846254566537;6009.939900600993;6772.221194562627;6906.5165438419335;6915.757948471804;6921.204061532925;6686.7993960181275;6705.396514313711;6792.083068785712;6793.150856142982;6809.5233333666665;1791.9875270472141;1814.700574405228;2058.2384517728424;2128.733908261467;2128.88291143987;2030.7461567304088;2057.9382618521468;2063.7523497180287;2065.2152182170753;2065.7521097468325;2031.4413536277493;2033.054629597237;2040.7040979058027;2085.9165633374646;2089.1538926734697;2038.327351973845;2062.731844860166;2098.045389347843;2098.7691353951054;2099.25476455859;2107.9894600527055;2139.711138996231;2149.752778430485;2150.290404166637;2151.4621344663833;6786.287439818847;6860.485463590251;6869;6869.519133660646;6872.244053154149;4029;4124.835006599732;4154.293770059067;4163.479565054368;4166.395872598487;2631.973680263192;2661.3612732943952;2697.946041079187;2699.0688212566633;2707.8646067696536;862.0818827948215;870.6473878079388;872.4503562755486;881.9338549608805;909.8362294786936;9443.575039123256;9553.1402173804;9587.280953928554;9611.134997850228;9615.807683846353;3856.402257650069;3925.0972276376024;3925.21495700861;3929.862454814125;4019.1157945252;8456.11210822867;8467.703630372907;8468;8468.661253549912;8470.957645211734;4221.831126754957;4239.448871646666;4248.2565551029065;4250.85122020734;4255.936160957588;3901.921961560753;3904.141088960424;3907.433422153772;3907.9609203908167;3908.3160446922243;3000.369922316338;3042.4067306874945;3048.8932887348838;3282.40916635008;3372.8650853966055;990.0643891522442;1047.7642530430744;1118.4128332625273;1121.2823792772633;1127.1321082766224;910.2490445382585;921.8110287391069;922.3082687984012;950.7623094226443;967.240716037921;6388.520860935449;6446.161998940108;6453.612783233021;6454.870902581922;6456.354364563506;560.4115678537601;576.4322142689448;579.9971000145057;580.2369883603048;725.6770737021975;5079.593632509391;5122.410922743858;5238.397584277781;5241.42344342122;5248.763805628756;8110.107888132301;8307.252347288773;8416.326693864476;8454.196851299117;8462;8257.42198046131;8313.376496762767;8321.08468068512;8332.6666933322;8337.666493340319;6442.323556026643;6561.1142495763415;6568.211814582281;6570.868582628321;6577.473802095917;6453.9351007083305;6457.6771161442675;6462.773802916875;6472.514561407819;6496.870062598816;7241.637918104179;7350.08123984502;7488.251174882468;7498.362639175513;7511.136219334847;7482.775516734507;7722.420818438527;7807.570583617956;7821.765347039598;7823.921760782319;5801.6519008859605;5933.9109913352195;6040.577159598962;6095.116208149882;6118.265808103056;5791.8552036199435;6655.2346480153465;6710.966445167743;6720;6742.595444273359;5473.28847249855;5499.257600223918;6000.279966404059;6178.258608966953;6560.3111673273615;5990.1314309424015;6158.846028849314;6251.187345645037;6295.779647712308;6313.242410910537;6220.471259942956;6225.159603453476;6266.655333956676;6277.905831412624;6420.486361091195;5977.163197152315;5978.4021597839865;6002;6009.819705408845;6018.277806663228;6041.788537401346;6076.574639775174;6086.391360864055;6091.238595175603;6096.878062438637 15:25:23 INFO - 2015-12-10 15:25:23,605 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.9268175637847;309.53724182347395;314.3665513989312;318.97288730457893;319.6627557926387;5165.070287348276;5289.735513224343;5290.894182116355;5291.28567643368;5295.655782374148;5215.1655735082395;5232.79068837247;5232.895342093156;5235.162374020158;5237;3931.3709806430975;4035.253478106545;4126.731762435447;4131.669466442678;4137.441445404862;3995.820188091543;4066.1867626474677;4089.0595163112503;4092.529359123709;4105.2815757242515;4036.919261614766;4041.4948131483566;4043.6360727534516;4052.5136983562015;4056.979715101435;3855.768653880776;3947.782871942042;3969.2260009298197;4040.8585699500522;4041.717079804415;3615.5480564929385;3621;3625.854965801365;3627.129488922666;3634.691051260646;5056.443791182967;5062.392512898476;5064.2403639454005;5074.670146440507;5079.212722028092;4640.303954406832;4693.108309421199;4704.905901881977;4706.576408123286;4710.905781884378;5353.598480114007;5490.6431081979545;5501.614886957915;5514.80698175562;5521.199426083195;3817.3319669058083;3846.59610740871;3847.846086156578;3848.422736589534;3851.287511810324;5701.344345400291;5803.390643982363;5803.506701930341;5812.709364531799;5818.156367326714;3959.4456776051375;3963.8216280267457;3968.0873399118364;3969.563348031714;3972.463717398114;3566.4293713005795;3825.502684651033;3876.6317199865966;4018.417329487208;4021.7586944783407;4455.643548516111;4480.305552639346;4503.211937910853;4629.907401851944;4631.073785242965;5394.703291318937;5486.094794358886;5524.558035357162;5529.557635389159;5538.390777014525;1404.8243969503812;1427.7358688642635;1429.621150395146;1429.8284205895359;1430.0633085328918;946.6118891254553;951.3198063384713;965.4545181972304;966.0725703324746;969.2391472693902;4847.781849816767;4856.927146092811;4864.73243971585;4866.197077482247;4868.9756551217015;5695.601307908407;5708.885822283614;5709.571782116275;5712.200291959129;5717.428257174332;4832.710037397767;4846.442659094178;4849.733264670406;4852.4662287148385;4853;2870.899518516842;2952.483315419793;3026.3039500914474;3047.131567503251;3077.1230199393513;5391.595630327741;5396.487333703292;5487.067198576252;5495.725213739297;5500.779968801203;5942.108683697394;5946.13781001761;5947.49446297061;5951.226340575698;5952.226210592596;5438.15708565173;5479.75341109651;5479.972600137134;5485.50630443262;5490.670559766427;5619.157126430904;5770.480656740913;5773.711314434346;5775.33583637887;5777.480026797609;5645.858853528694;5660.433956604306;5666.688332141772;5668.234788303526;5668.773249069991;5462.863428414322;5481.342238931354;5484.2596249505805;5487.094629386106;5488.725563721878;4008.238434697398;4009.438678584942;4013.0769922917307;4014.6386825185873;4016.979915100406;5578.051731205624;5761.5390768739235;5780.739866705924;5785.82642520725;5787.681677507778;5561.916571251515;5564.944350556442;5570.44295570456;5571.164325351229;5574.16387541872;5561.416051314553;5565.443455654402;5569.415211402907;5574.331080270394;5580.832575022756;5280.287161233338;5433.320834895638;5434.483724046209;5437.075697131418;5449.64577302474;5526.0053190424505;5591.329040515002;5592.944070559242;5595.384507704068;5597.972010139923;5242.135047717084;5344.492273234192;5378.247045413567;5474.781008759605;5482.643628164156 15:25:23 INFO - 2015-12-10 15:25:23,606 DEBUG : BROWSER_OUTPUT: |5;yui.html;691.9827004324889;708.8203773396806;714.6569646569646;759.8974138491304;781.0939310399938;11206;11458.656240312783;11462.942685286562;11477.885221147786;11496.655100346981;10202.897971020288;10442.37345759253;11592.304461732301;11714.7657046859;11744.706382340424;808.0787901791962;824.4435006370676;825.1130035212141;826.983460330793;827.3091968206525;794.4756460735915;798.1499702816482;803.2168635580321;803.3573141486817;803.7709252862935;837.4682076881163;849.2059923971076;849.9192576705234;851.535912927456;852.6504133305347;850.9574521273912;851.0510780479782;851.6550796927223;852.0116664668985;852.3479538153317;625.3027873920546;625.3558834400575;625.8341539492038;625.9749610015593;625.974961001564;10275.89724102757;10357;10404.219683523766;10421.218408619308;10422.79154416915;9272.675456359062;9597.760055998586;9660.855087173699;9765.609375624967;9867.640120191725;8754.824903501894;8779.824403511959;8824.117588241188;8832.072632373636;8853.73438796837;3116.439040972624;3133.3263348380206;3153.22745927247;3155.0534839548045;3244.0592228253777;34391.82804085989;34675.479867802;38170.42744358837;38734.80632596819;39107.413388799476;7635.847283054308;9175.77060573491;9210.539473026322;9223.44659320443;9312.34813563044;14109.506167284097;14338.856611433961;16726.91636541834;16777.91611041937;16798.160091995353;6201.472874805602;6305.716242769086;6335.588186767845;6375.617462952145;6412.583182093149;3537.8407971640822;3542.7520073595115;3573.9821300893327;3594.676479116892;3628.1836586768295;2577.4716183182404;2581.6772903387077;2586.9223923281957;2591.4298854252033;2599.8050146239107;458.4155202117327;461.5269348917387;462.35732332058467;465.73220398271127;466.9673122881434;421.54052083229425;426.413681188366;450.84220522817407;496.9801207951714;557.7350758389732;7094.432445404355;7340.229275925951;7363.8159046024275;7388.1503627083575;7415.740449084256;532.5473347654463;546.7724957470425;547.7945770336124;551.1912683357978;576.1588081401118;3307.93384132316;3404.5267448698046;3490.336836001152;3504.421770407905;3506.63180366063;50034.49965500371;50415.49584504181;50490.24264636033;50527.49472505302;50599.24101138486;44139.337909931375;44702.55297447049;45437.54562454399;45494;45523.31715024277;35719.28561428757;36625.45061824075;44387.778061109486;44778.32832507515;45264.54735452603;7380.18817930038;7531.88702169457;7592.202818703957;7627.771166865003;7689.9615501922135;31550.36899261956;31797.364052718352;32154.356912861145;32167.839160804047;32658.673413265562;36249.275014499035;36423.453648194765;37921;38706.6129338703;39122.21755564816;9029.774255643399;10380.636677716244;10461.790764184825;10472.162227021667;10540.894591053991;10430.582776688847;10457.581696732046;10933.234673573092;11102.944485277521;11187.496562654864;10176.949115254376;10178;10551.366917984946;10625.149988001096;11553.768924621292;9792.216622670312;10020.849687254842;10238.180945524191;10355.223358248311;10431.426271555138;11099.389533575732;11135.109191264517;11142.331460112418;11170.888291116984;11199.832002520132;8977.820443590961;9190.126937940884;9193.632254709737;9377.624895004123;9469.289803264921;9005.639774409212;9218.907810922074;9287.442753434816;9389.43663380172;9429.669961551313 15:25:23 INFO - 2015-12-10 15:25:23,606 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:25:23 INFO - 2015-12-10 15:25:23,606 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:25:23 INFO - 2015-12-10 15:25:23,606 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,862 15:25:23 INFO - 2015-12-10 15:25:23,606 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: __startTimestamp1449789923593__endTimestamp 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4603.22 Median:4731.93 stddev:479.65 (10.1%) stddev-sans-first:454.68 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: Values: 2601.2 2655.2 2675.6 2675.7 2695.7 4431.6 4583.0 4629.1 4694.7 4743.0 4647.5 4677.5 4728.2 4728.7 4733.0 4272.5 4324.5 4327.1 4376.5 4394.8 4163.0 4376.8 4381.6 4421.8 4441.1 4210.5 4294.4 4301.1 4308.5 4320.0 4351.6 4353.0 4364.8 4369.1 4419.6 4325.4 4332.6 4361.0 4379.0 4394.1 4378.8 4509.0 4520.8 4538.0 4660.8 4941.8 4942.1 4948.7 4952.4 4990.0 4968.0 4969.7 4975.4 4985.9 5006.8 4478.5 4554.7 4589.0 4593.3 4653.2 5117.8 5124.5 5162.4 5169.3 5170.6 4982.2 5000.7 5000.8 5004.0 5046.5 4848.6 4962.1 5073.7 5083.6 5086.4 4883.5 4884.3 4944.3 4952.6 4982.5 4920.9 4922.6 4922.9 4932.8 4972.5 4041.8 4129.7 4142.9 4143.3 4150.9 3548.4 3624.4 3631.8 3631.9 3644.2 4298.2 4361.0 4364.1 4364.3 4395.0 5046.5 5061.8 5067.9 5068.8 5114.3 4166.8 4244.7 4259.6 4264.4 4331.4 4430.2 4465.6 4473.8 4474.0 4515.8 4792.4 4805.4 4810.0 4813.9 4854.9 4798.8 4858.4 4890.4 4911.1 4949.2 4717.7 4729.4 4735.8 4739.7 4781.2 4938.8 4948.6 4954.8 4957.9 5005.5 4765.8 4866.4 4871.7 4925.1 5049.6 4833.7 4884.2 4890.0 4890.4 4937.2 4864.4 4879.7 4880.0 4929.1 4930.0 4417.5 4586.6 4692.1 4704.6 4829.7 4801.3 4802.0 4811.4 4816.4 4823.4 4709.6 4714.0 4718.2 4731.9 4751.5 15:25:23 INFO - 2015-12-10 15:25:23,607 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,608 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39958.50 Median:35789.64 stddev:59895.97 (167.4%) stddev-sans-first:59990.98 15:25:23 INFO - 2015-12-10 15:25:23,608 DEBUG : BROWSER_OUTPUT: Values: 571.5 574.2 579.7 580.3 580.3 26628.7 35109.0 35753.6 35779.6 35794.8 39982.8 40447.8 40496.2 40551.6 40632.0 6979.9 7101.8 7797.9 7985.5 7988.2 9950.3 10172.9 10202.0 10212.3 10217.0 9697.6 9791.0 9797.2 9797.6 9815.6 7263.0 7453.1 9744.5 10074.3 10343.1 9788.2 9926.6 9932.6 9933.0 9936.4 37321.0 37720.0 37810.6 37828.8 37829.0 2821.8 2843.7 2852.3 2877.5 2877.7 28119.0 28250.2 28400.4 28642.1 28929.0 3390.5 3451.6 3456.2 3521.4 3566.2 218838.0 219789.0 219904.0 219918.9 220116.0 50448.5 51542.7 54890.5 55224.2 55231.0 63670.7 64887.4 65126.3 65146.7 65148.3 12131.1 12138.8 12155.5 12157.8 12267.3 9762.1 9840.7 9888.7 9903.7 9946.0 18869.3 18883.6 18987.5 18993.6 19024.2 7089.6 7320.0 7467.3 7473.8 7506.6 800.3 886.7 937.0 940.9 1007.6 26307.5 26351.9 26491.7 27702.0 27843.0 905.0 909.0 916.7 924.4 933.7 12950.2 13154.8 13183.9 13185.7 14158.0 256798.0 261568.0 262301.0 262556.0 263889.0 46707.5 46940.3 47021.5 47201.0 47206.0 1141.7 1172.5 1186.5 1187.5 1190.2 22618.5 25823.7 26579.7 28882.7 28903.9 39991.8 40453.6 40515.0 40568.0 40580.0 200057.0 202468.0 202585.0 202774.0 224722.0 23634.5 27642.4 27791.6 27970.4 28063.6 35262.0 35784.5 35947.1 36411.5 36631.8 31031.7 31256.5 32229.2 34557.0 37195.3 32125.0 32191.4 36525.5 37744.0 38184.8 37257.6 37819.0 37990.8 38026.4 38199.8 34784.7 35724.1 35972.5 36066.5 36277.5 27570.9 27693.2 27938.9 28332.6 28453.9 15:25:23 INFO - 2015-12-10 15:25:23,608 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,608 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26216.69 Median:22663.88 stddev:82258.66 (363.0%) stddev-sans-first:82466.47 15:25:23 INFO - 2015-12-10 15:25:23,609 DEBUG : BROWSER_OUTPUT: Values: 340.0 343.6 344.7 345.9 346.8 12617.3 12941.4 14931.8 14973.8 15921.8 15242.2 15346.0 16303.2 16322.2 16346.2 4923.1 5051.3 5067.2 5070.8 5071.8 3527.5 3630.1 5021.6 5210.1 5381.8 5344.4 5359.1 5359.2 5378.9 5387.6 5187.8 5328.8 5336.4 5341.5 5343.5 5132.2 5134.7 5140.2 5140.7 5141.8 13015.5 18466.2 18867.3 18904.8 18912.5 1671.9 1750.8 1805.5 1808.1 1815.0 8829.3 8894.7 8918.9 9024.0 9115.7 1673.9 1693.1 1752.9 1803.6 1841.6 54908.7 56029.4 56559.4 56840.7 57870.4 9444.3 9783.8 10009.1 10030.6 10073.1 12689.5 12784.3 12784.6 12791.8 12806.1 6731.4 6768.5 6793.3 6812.3 6841.9 5946.7 6000.7 6303.9 6360.1 6364.8 4185.8 4257.0 4267.9 4269.6 4291.0 1634.3 1663.0 1667.0 1673.6 1683.7 369.4 374.5 423.5 809.5 854.6 8962.3 9053.7 9193.0 9518.3 9764.3 406.8 407.6 407.6 419.7 428.0 5421.4 5666.3 5726.2 5741.7 5745.6 495703.0 501143.0 501751.0 506768.0 510201.0 69733.3 69915.7 71200.3 71297.3 71367.6 452.4 455.8 456.9 457.1 457.8 9617.0 9642.8 9659.7 9723.2 9742.3 32281.5 33110.5 33224.2 34350.8 34514.7 42882.8 43433.0 44569.0 44797.9 44875.3 8382.3 9054.9 9070.5 9071.1 9073.6 15613.5 15686.3 15831.4 16046.7 16233.4 12886.6 12951.4 12976.4 13055.5 13218.1 12536.4 12762.1 13070.3 13656.6 13844.1 10296.7 10762.5 11453.5 12396.6 13057.7 8573.5 8701.3 8708.3 8728.0 8732.3 8932.6 8960.1 12077.6 12393.6 12563.2 15:25:23 INFO - 2015-12-10 15:25:23,609 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,610 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4868.55 Median:6093.18 stddev:2530.31 (41.5%) stddev-sans-first:2524.23 15:25:23 INFO - 2015-12-10 15:25:23,610 DEBUG : BROWSER_OUTPUT: Values: 1433.3 1608.3 1615.1 1650.2 1681.2 6009.9 6772.2 6906.5 6915.8 6921.2 6686.8 6705.4 6792.1 6793.2 6809.5 1792.0 1814.7 2058.2 2128.7 2128.9 2030.7 2057.9 2063.8 2065.2 2065.8 2031.4 2033.1 2040.7 2085.9 2089.2 2038.3 2062.7 2098.0 2098.8 2099.3 2108.0 2139.7 2149.8 2150.3 2151.5 6786.3 6860.5 6869.0 6869.5 6872.2 4029.0 4124.8 4154.3 4163.5 4166.4 2632.0 2661.4 2697.9 2699.1 2707.9 862.1 870.6 872.5 881.9 909.8 9443.6 9553.1 9587.3 9611.1 9615.8 3856.4 3925.1 3925.2 3929.9 4019.1 8456.1 8467.7 8468.0 8468.7 8471.0 4221.8 4239.4 4248.3 4250.9 4255.9 3901.9 3904.1 3907.4 3908.0 3908.3 3000.4 3042.4 3048.9 3282.4 3372.9 990.1 1047.8 1118.4 1121.3 1127.1 910.2 921.8 922.3 950.8 967.2 6388.5 6446.2 6453.6 6454.9 6456.4 560.4 576.4 580.0 580.2 725.7 5079.6 5122.4 5238.4 5241.4 5248.8 8110.1 8307.3 8416.3 8454.2 8462.0 8257.4 8313.4 8321.1 8332.7 8337.7 6442.3 6561.1 6568.2 6570.9 6577.5 6453.9 6457.7 6462.8 6472.5 6496.9 7241.6 7350.1 7488.3 7498.4 7511.1 7482.8 7722.4 7807.6 7821.8 7823.9 5801.7 5933.9 6040.6 6095.1 6118.3 5791.9 6655.2 6711.0 6720.0 6742.6 5473.3 5499.3 6000.3 6178.3 6560.3 5990.1 6158.8 6251.2 6295.8 6313.2 6220.5 6225.2 6266.7 6277.9 6420.5 5977.2 5978.4 6002.0 6009.8 6018.3 6041.8 6076.6 6086.4 6091.2 6096.9 15:25:23 INFO - 2015-12-10 15:25:23,610 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,610 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4587.33 Median:5239.57 stddev:1355.59 (25.9%) stddev-sans-first:1320.73 15:25:23 INFO - 2015-12-10 15:25:23,610 DEBUG : BROWSER_OUTPUT: Values: 304.9 309.5 314.4 319.0 319.7 5165.1 5289.7 5290.9 5291.3 5295.7 5215.2 5232.8 5232.9 5235.2 5237.0 3931.4 4035.3 4126.7 4131.7 4137.4 3995.8 4066.2 4089.1 4092.5 4105.3 4036.9 4041.5 4043.6 4052.5 4057.0 3855.8 3947.8 3969.2 4040.9 4041.7 3615.5 3621.0 3625.9 3627.1 3634.7 5056.4 5062.4 5064.2 5074.7 5079.2 4640.3 4693.1 4704.9 4706.6 4710.9 5353.6 5490.6 5501.6 5514.8 5521.2 3817.3 3846.6 3847.8 3848.4 3851.3 5701.3 5803.4 5803.5 5812.7 5818.2 3959.4 3963.8 3968.1 3969.6 3972.5 3566.4 3825.5 3876.6 4018.4 4021.8 4455.6 4480.3 4503.2 4629.9 4631.1 5394.7 5486.1 5524.6 5529.6 5538.4 1404.8 1427.7 1429.6 1429.8 1430.1 946.6 951.3 965.5 966.1 969.2 4847.8 4856.9 4864.7 4866.2 4869.0 5695.6 5708.9 5709.6 5712.2 5717.4 4832.7 4846.4 4849.7 4852.5 4853.0 2870.9 2952.5 3026.3 3047.1 3077.1 5391.6 5396.5 5487.1 5495.7 5500.8 5942.1 5946.1 5947.5 5951.2 5952.2 5438.2 5479.8 5480.0 5485.5 5490.7 5619.2 5770.5 5773.7 5775.3 5777.5 5645.9 5660.4 5666.7 5668.2 5668.8 5462.9 5481.3 5484.3 5487.1 5488.7 4008.2 4009.4 4013.1 4014.6 4017.0 5578.1 5761.5 5780.7 5785.8 5787.7 5561.9 5564.9 5570.4 5571.2 5574.2 5561.4 5565.4 5569.4 5574.3 5580.8 5280.3 5433.3 5434.5 5437.1 5449.6 5526.0 5591.3 5592.9 5595.4 5598.0 5242.1 5344.5 5378.2 5474.8 5482.6 15:25:23 INFO - 2015-12-10 15:25:23,610 DEBUG : BROWSER_OUTPUT: 15:25:23 INFO - 2015-12-10 15:25:23,610 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11978.24 Median:22990.87 stddev:13733.13 (59.7%) stddev-sans-first:13745.51 15:25:23 INFO - 2015-12-10 15:25:23,612 DEBUG : BROWSER_OUTPUT: Values: 692.0 708.8 714.7 759.9 781.1 11206.0 11458.7 11462.9 11477.9 11496.7 10202.9 10442.4 11592.3 11714.8 11744.7 808.1 824.4 825.1 827.0 827.3 794.5 798.1 803.2 803.4 803.8 837.5 849.2 849.9 851.5 852.7 851.0 851.1 851.7 852.0 852.3 625.3 625.4 625.8 626.0 626.0 10275.9 10357.0 10404.2 10421.2 10422.8 9272.7 9597.8 9660.9 9765.6 9867.6 8754.8 8779.8 8824.1 8832.1 8853.7 3116.4 3133.3 3153.2 3155.1 3244.1 34391.8 34675.5 38170.4 38734.8 39107.4 7635.8 9175.8 9210.5 9223.4 9312.3 14109.5 14338.9 16726.9 16777.9 16798.2 6201.5 6305.7 6335.6 6375.6 6412.6 3537.8 3542.8 3574.0 3594.7 3628.2 2577.5 2581.7 2586.9 2591.4 2599.8 458.4 461.5 462.4 465.7 467.0 421.5 426.4 450.8 497.0 557.7 7094.4 7340.2 7363.8 7388.2 7415.7 532.5 546.8 547.8 551.2 576.2 3307.9 3404.5 3490.3 3504.4 3506.6 50034.5 50415.5 50490.2 50527.5 50599.2 44139.3 44702.6 45437.5 45494.0 45523.3 35719.3 36625.5 44387.8 44778.3 45264.5 7380.2 7531.9 7592.2 7627.8 7690.0 31550.4 31797.4 32154.4 32167.8 32658.7 36249.3 36423.5 37921.0 38706.6 39122.2 9029.8 10380.6 10461.8 10472.2 10540.9 10430.6 10457.6 10933.2 11102.9 11187.5 10176.9 10178.0 10551.4 10625.1 11553.8 9792.2 10020.8 10238.2 10355.2 10431.4 11099.4 11135.1 11142.3 11170.9 11199.8 8977.8 9190.1 9193.6 9377.6 9469.3 9005.6 9218.9 9287.4 9389.4 9429.7 15:25:23 INFO - 2015-12-10 15:25:23,612 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:25:23 INFO - 2015-12-10 15:25:23,612 DEBUG : BROWSER_OUTPUT: 15:25:24 INFO - 2015-12-10 15:25:24,349 INFO : Browser exited with error code: 0 15:25:24 INFO - 2015-12-10 15:25:24,368 INFO : Completed test dromaeo_css (00:18:37) 15:25:24 INFO - 2015-12-10 15:25:24,368 INFO : Starting test kraken 15:25:24 INFO - 2015-12-10 15:25:24,368 DEBUG : operating with platform_type : linux_ 15:25:24 INFO - 2015-12-10 15:25:24,368 INFO : Initialising browser for kraken test... 15:25:24 INFO - 2015-12-10 15:25:24,374 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRdpqbj/profile http://localhost:42192/getInfo.html 15:25:28 INFO - 2015-12-10 15:25:28,652 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:25:28 INFO - 2015-12-10 15:25:28,652 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:25:28 INFO - 2015-12-10 15:25:28,653 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:25:28 INFO - 2015-12-10 15:25:28,653 DEBUG : BROWSER_OUTPUT: __metrics 15:25:28 INFO - 2015-12-10 15:25:28,737 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:25:28 INFO - 2015-12-10 15:25:28,821 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] 15:25:30 INFO - 2015-12-10 15:25:30,045 INFO : Browser initialized. 15:25:30 INFO - 2015-12-10 15:25:30,045 INFO : Running cycle 1/1 for kraken test... 15:25:30 INFO - 2015-12-10 15:25:30,046 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRdpqbj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:25:42 INFO - 2015-12-10 15:25:42,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 143020032 15:25:42 INFO - 2015-12-10 15:25:42,132 DEBUG : BROWSER_OUTPUT: 15:25:44 INFO - 2015-12-10 15:25:44,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42192/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:45 INFO - 2015-12-10 15:25:45,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 180228096 15:25:45 INFO - 2015-12-10 15:25:45,310 DEBUG : BROWSER_OUTPUT: 15:25:48 INFO - 2015-12-10 15:25:48,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42192/tests/kraken/driver.html?testName=audio-dft) 15:25:48 INFO - 2015-12-10 15:25:48,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 167264256 15:25:48 INFO - 2015-12-10 15:25:48,637 DEBUG : BROWSER_OUTPUT: 15:25:51 INFO - 2015-12-10 15:25:51,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42192/tests/kraken/driver.html?testName=audio-fft) 15:25:52 INFO - 2015-12-10 15:25:52,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 153485312 15:25:52 INFO - 2015-12-10 15:25:52,230 DEBUG : BROWSER_OUTPUT: 15:25:54 INFO - 2015-12-10 15:25:54,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42192/tests/kraken/driver.html?testName=audio-oscillator) 15:25:54 INFO - 2015-12-10 15:25:54,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 156557312 15:25:54 INFO - 2015-12-10 15:25:54,880 DEBUG : BROWSER_OUTPUT: 15:25:57 INFO - 2015-12-10 15:25:57,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:57 INFO - 2015-12-10 15:25:57,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 157941760 15:25:57 INFO - 2015-12-10 15:25:57,716 DEBUG : BROWSER_OUTPUT: 15:26:00 INFO - 2015-12-10 15:26:00,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42192/tests/kraken/driver.html?testName=imaging-darkroom) 15:26:01 INFO - 2015-12-10 15:26:01,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 156811264 15:26:01 INFO - 2015-12-10 15:26:01,305 DEBUG : BROWSER_OUTPUT: 15:26:04 INFO - 2015-12-10 15:26:04,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42192/tests/kraken/driver.html?testName=imaging-desaturate) 15:26:05 INFO - 2015-12-10 15:26:05,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 158199808 15:26:05 INFO - 2015-12-10 15:26:05,317 DEBUG : BROWSER_OUTPUT: 15:26:08 INFO - 2015-12-10 15:26:08,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42192/tests/kraken/driver.html?testName=json-parse-financial) 15:26:08 INFO - 2015-12-10 15:26:08,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 158855168 15:26:08 INFO - 2015-12-10 15:26:08,757 DEBUG : BROWSER_OUTPUT: 15:26:10 INFO - 2015-12-10 15:26:10,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:26:11 INFO - 2015-12-10 15:26:11,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 168210432 15:26:11 INFO - 2015-12-10 15:26:11,074 DEBUG : BROWSER_OUTPUT: 15:26:12 INFO - 2015-12-10 15:26:12,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:26:13 INFO - 2015-12-10 15:26:13,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 168120320 15:26:13 INFO - 2015-12-10 15:26:13,575 DEBUG : BROWSER_OUTPUT: 15:26:15 INFO - 2015-12-10 15:26:15,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:26:16 INFO - 2015-12-10 15:26:16,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 179736576 15:26:16 INFO - 2015-12-10 15:26:16,294 DEBUG : BROWSER_OUTPUT: 15:26:18 INFO - 2015-12-10 15:26:18,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:26:19 INFO - 2015-12-10 15:26:19,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 183947264 15:26:19 INFO - 2015-12-10 15:26:19,436 DEBUG : BROWSER_OUTPUT: 15:26:21 INFO - 2015-12-10 15:26:21,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:26:22 INFO - 2015-12-10 15:26:22,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 181583872 15:26:22 INFO - 2015-12-10 15:26:22,572 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42192/tests/kraken/driver.html?testName=ai-astar) 15:26:24 INFO - 2015-12-10 15:26:24,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 240640000 15:26:24 INFO - 2015-12-10 15:26:24,608 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,612 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:26:24 INFO - 2015-12-10 15:26:24,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:26:24 INFO - 2015-12-10 15:26:24,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:26:24 INFO - 2015-12-10 15:26:24,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:26:24 INFO - 2015-12-10 15:26:24,612 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;113;112;111;100;112;111;111 15:26:24 INFO - 2015-12-10 15:26:24,612 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;157;166;133;160;157;133;176;133 15:26:24 INFO - 2015-12-10 15:26:24,613 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;164;162;162;165;164;165;166 15:26:24 INFO - 2015-12-10 15:26:24,613 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;94;74;72;71;99;96;72 15:26:24 INFO - 2015-12-10 15:26:24,613 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;136;94;94;95;139;95;95;141 15:26:24 INFO - 2015-12-10 15:26:24,613 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;110;109;110;109;110 15:26:24 INFO - 2015-12-10 15:26:24,613 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;148;147;147;147;146;146 15:26:24 INFO - 2015-12-10 15:26:24,613 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;96;95;95;95;95 15:26:24 INFO - 2015-12-10 15:26:24,613 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;70;72;71;72;78;69;69 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;68;69;69;69;68 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;83;83;83;83;82;83;82 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;127;118;138;123;123;128;127;139;126 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;133;143;138;144;135;144;154;145;134 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;71;68;69;67;69;68;69 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:26:24 INFO - 2015-12-10 15:26:24,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1024 15:26:24 INFO - 2015-12-10 15:26:24,615 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:26:24 INFO - 2015-12-10 15:26:24,615 DEBUG : BROWSER_OUTPUT: __startTimestamp1449789984610__endTimestamp 15:26:24 INFO - 2015-12-10 15:26:24,615 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,618 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:26:24 INFO - 2015-12-10 15:26:24,620 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:26:24 INFO - 2015-12-10 15:26:24,620 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,620 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:4.06 (3.6%) stddev-sans-first:4.30 15:26:24 INFO - 2015-12-10 15:26:24,620 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 113.0 112.0 111.0 100.0 112.0 111.0 111.0 15:26:24 INFO - 2015-12-10 15:26:24,620 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,620 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.90 Median:157.00 stddev:16.22 (10.3%) stddev-sans-first:17.16 15:26:24 INFO - 2015-12-10 15:26:24,621 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 157.0 166.0 133.0 160.0 157.0 133.0 176.0 133.0 15:26:24 INFO - 2015-12-10 15:26:24,621 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,621 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.42 (0.9%) stddev-sans-first:1.50 15:26:24 INFO - 2015-12-10 15:26:24,621 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 164.0 162.0 162.0 165.0 164.0 165.0 166.0 15:26:24 INFO - 2015-12-10 15:26:24,621 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,622 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:79.50 stddev:11.58 (14.6%) stddev-sans-first:11.84 15:26:24 INFO - 2015-12-10 15:26:24,622 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 94.0 74.0 72.0 71.0 99.0 96.0 72.0 15:26:24 INFO - 2015-12-10 15:26:24,622 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,622 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.90 Median:95.00 stddev:21.27 (22.4%) stddev-sans-first:22.04 15:26:24 INFO - 2015-12-10 15:26:24,622 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 136.0 94.0 94.0 95.0 139.0 95.0 95.0 141.0 15:26:24 INFO - 2015-12-10 15:26:24,622 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,622 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:26:24 INFO - 2015-12-10 15:26:24,623 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 15:26:24 INFO - 2015-12-10 15:26:24,623 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,623 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:26:24 INFO - 2015-12-10 15:26:24,623 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 148.0 147.0 147.0 147.0 146.0 146.0 15:26:24 INFO - 2015-12-10 15:26:24,623 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,623 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:26:24 INFO - 2015-12-10 15:26:24,624 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 15:26:24 INFO - 2015-12-10 15:26:24,624 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,624 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:71.00 stddev:2.58 (3.6%) stddev-sans-first:2.74 15:26:24 INFO - 2015-12-10 15:26:24,624 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 72.0 71.0 72.0 78.0 69.0 69.0 15:26:24 INFO - 2015-12-10 15:26:24,624 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,624 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 15:26:24 INFO - 2015-12-10 15:26:24,625 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 68.0 15:26:24 INFO - 2015-12-10 15:26:24,625 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 83.0 83.0 83.0 83.0 82.0 83.0 82.0 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:7.15 (5.6%) stddev-sans-first:6.86 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: Values: 118.0 127.0 118.0 138.0 123.0 123.0 128.0 127.0 139.0 126.0 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:143.50 stddev:6.40 (4.5%) stddev-sans-first:6.75 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: Values: 139.0 133.0 143.0 138.0 144.0 135.0 144.0 154.0 145.0 134.0 15:26:24 INFO - 2015-12-10 15:26:24,626 DEBUG : BROWSER_OUTPUT: 15:26:24 INFO - 2015-12-10 15:26:24,627 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 15:26:24 INFO - 2015-12-10 15:26:24,627 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 71.0 68.0 69.0 67.0 69.0 68.0 69.0 15:26:24 INFO - 2015-12-10 15:26:24,627 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:26:24 INFO - 2015-12-10 15:26:24,627 DEBUG : BROWSER_OUTPUT: 15:26:25 INFO - 2015-12-10 15:26:25,509 INFO : Browser exited with error code: 0 15:26:25 INFO - 2015-12-10 15:26:25,564 INFO : Completed test kraken (00:01:01) 15:26:25 INFO - 2015-12-10 15:26:25,564 INFO : Starting test v8_7 15:26:25 INFO - 2015-12-10 15:26:25,564 DEBUG : operating with platform_type : linux_ 15:26:25 INFO - 2015-12-10 15:26:25,564 INFO : Initialising browser for v8_7 test... 15:26:25 INFO - 2015-12-10 15:26:25,570 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvpXPS8/profile http://localhost:42192/getInfo.html 15:26:30 INFO - 2015-12-10 15:26:30,012 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:26:30 INFO - 2015-12-10 15:26:30,012 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:26:30 INFO - 2015-12-10 15:26:30,012 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:26:30 INFO - 2015-12-10 15:26:30,012 DEBUG : BROWSER_OUTPUT: __metrics 15:26:30 INFO - 2015-12-10 15:26:30,129 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:26:30 INFO - 2015-12-10 15:26:30,185 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] 15:26:31 INFO - 2015-12-10 15:26:31,491 INFO : Browser initialized. 15:26:31 INFO - 2015-12-10 15:26:31,492 INFO : Running cycle 1/1 for v8_7 test... 15:26:31 INFO - 2015-12-10 15:26:31,492 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvpXPS8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:26:43 INFO - 2015-12-10 15:26:43,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 142393344 15:26:43 INFO - 2015-12-10 15:26:43,464 DEBUG : BROWSER_OUTPUT: 15:27:04 INFO - 2015-12-10 15:27:04,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42192/tests/v8_7/run.html (next: http://localhost:42192/tests/v8_7/run.html) 15:27:05 INFO - 2015-12-10 15:27:05,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 440569856 15:27:05 INFO - 2015-12-10 15:27:05,071 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,073 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:27:05 INFO - 2015-12-10 15:27:05,073 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:27:05 INFO - 2015-12-10 15:27:05,073 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:27:05 INFO - 2015-12-10 15:27:05,073 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:27:05 INFO - 2015-12-10 15:27:05,073 DEBUG : BROWSER_OUTPUT: |0;Richards;165.12549537648613 15:27:05 INFO - 2015-12-10 15:27:05,073 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.11576400521125 15:27:05 INFO - 2015-12-10 15:27:05,073 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 15:27:05 INFO - 2015-12-10 15:27:05,074 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 15:27:05 INFO - 2015-12-10 15:27:05,074 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 15:27:05 INFO - 2015-12-10 15:27:05,074 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 15:27:05 INFO - 2015-12-10 15:27:05,074 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 15:27:05 INFO - 2015-12-10 15:27:05,074 DEBUG : BROWSER_OUTPUT: |7;RegExp;27162.162162162163 15:27:05 INFO - 2015-12-10 15:27:05,074 DEBUG : BROWSER_OUTPUT: |8;Splay;618.8118811881188 15:27:05 INFO - 2015-12-10 15:27:05,074 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:27:05 INFO - 2015-12-10 15:27:05,075 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:27:05 INFO - 2015-12-10 15:27:05,075 DEBUG : BROWSER_OUTPUT: __startTimestamp1449790025072__endTimestamp 15:27:05 INFO - 2015-12-10 15:27:05,075 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,075 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:27:05 INFO - 2015-12-10 15:27:05,075 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:27:05 INFO - 2015-12-10 15:27:05,076 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,076 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.13 Median:165.13 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,076 DEBUG : BROWSER_OUTPUT: Values: 165.1 15:27:05 INFO - 2015-12-10 15:27:05,076 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,076 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.12 Median:186.12 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,076 DEBUG : BROWSER_OUTPUT: Values: 186.1 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: Values: 281.4 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: Values: 5186.5 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,077 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: Values: 1970.5 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: Values: 789.9 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: Values: 12096.4 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: Values: 27162.2 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,078 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.81 Median:618.81 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,079 DEBUG : BROWSER_OUTPUT: Values: 618.8 15:27:05 INFO - 2015-12-10 15:27:05,079 DEBUG : BROWSER_OUTPUT: 15:27:05 INFO - 2015-12-10 15:27:05,079 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:27:05 INFO - 2015-12-10 15:27:05,079 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:27:05 INFO - 2015-12-10 15:27:05,079 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:27:05 INFO - 2015-12-10 15:27:05,079 DEBUG : BROWSER_OUTPUT: 15:27:06 INFO - 2015-12-10 15:27:06,037 INFO : Browser exited with error code: 0 15:27:06 INFO - 2015-12-10 15:27:06,052 INFO : Completed test v8_7 (00:00:40) 15:27:06 INFO - 2015-12-10 15:27:06,142 INFO : Completed test suite (00:20:18) 15:27:06 INFO - 2015-12-10 15:27:06,142 DEBUG : Working with test: dromaeo_css 15:27:06 INFO - 2015-12-10 15:27:06,142 DEBUG : Generating results file: dromaeo_css 15:27:06 INFO - 2015-12-10 15:27:06,144 DEBUG : Working with test: kraken 15:27:06 INFO - 2015-12-10 15:27:06,144 DEBUG : Generating results file: kraken 15:27:06 INFO - 2015-12-10 15:27:06,144 INFO : javascript benchmark 15:27:06 INFO - 2015-12-10 15:27:06,144 DEBUG : Working with test: v8_7 15:27:06 INFO - 2015-12-10 15:27:06,144 DEBUG : Generating results file: v8_7 15:27:06 INFO - 2015-12-10 15:27:06,145 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:27:06 INFO - 2015-12-10 15:27:06,196 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 15:27:06 INFO - 2015-12-10 15:27:06,196 DEBUG : process_Request line: dromaeo_css 6138.67 graph.html#tests=[[72,132,35]] 15:27:06 INFO - 2015-12-10 15:27:06,196 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:27:06 INFO - 2015-12-10 15:27:06,229 DEBUG : process_Request line: kraken 1522.10 graph.html#tests=[[232,132,35]] 15:27:06 INFO - 2015-12-10 15:27:06,229 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:27:06 INFO - 2015-12-10 15:27:06,259 DEBUG : process_Request line: v8_7 19761.99 graph.html#tests=[[230,132,35]] 15:27:06 INFO - 2015-12-10 15:27:06,260 INFO : javascript benchmark 15:27:06 INFO - 2015-12-10 15:27:06,264 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2601.1546247469573, 2655.203438968309, 2675.62541244226, 2675.7324267573244, 2695.6899956505004, 4431.578999995003, 4583.0, 4629.074185162968, 4694.741789201593, 4743.027679325739, 4647.53524647536, 4677.462091859428, 4728.219843725789, 4728.692634978733, 4732.999999999992, 4272.498398557962, 4324.481062272516, 4327.11294184693, 4376.452943382077, 4394.758288294142, 4162.958370416302, 4376.846810361638, 4381.561843815609, 4421.756803375813, 4441.089576636782, 4210.536840947493, 4294.355846623016, 4301.118270754488, 4308.526062133163, 4320.049589090427, 4351.608355248043, 4353.0, 4364.781760911942, 4369.126174765028, 4419.64642828573, 4325.416068830699, 4332.610065094125, 4361.040571074359, 4379.0, 4394.099209662044, 4378.824847006116, 4508.977455112737, 4520.773961301922, 4537.954620453819, 4660.766961651904, 4941.802327906879, 4942.135126352874, 4948.678335908155, 4952.405711314629, 4989.950100498985, 4967.975160124212, 4969.676970996874, 4975.3532040834825, 4985.850424487271, 5006.799728010875, 4478.507364189936, 4554.70394424368, 4589.0, 4593.28804035375, 4653.162430762428, 5117.8464646060675, 5124.538791508782, 5162.380514338229, 5169.302144210558, 5170.560502357266, 4982.153033984231, 5000.724960127228, 5000.799968001312, 5004.049230646166, 5046.495350464924, 4848.5636292733825, 4962.057209130254, 5073.695578265316, 5083.567896728746, 5086.415062267813, 4883.511648835088, 4884.3161957326, 4944.25836124577, 4952.5542701157065, 4982.4768399317545, 4920.8769780755765, 4922.630802689812, 4922.90154196914, 4932.778024988884, 4972.5276098770555, 4041.7574945503366, 4129.710920235615, 4142.855000075043, 4143.3370660694145, 4150.875473735793, 3548.414511605556, 3624.365735996243, 3631.8365673544754, 3631.891043268706, 3644.1982763791925, 4298.183345164409, 4361.0, 4364.061726728769, 4364.323529852814, 4394.978025109854, 5046.467472769003, 5061.848144555669, 5067.873303167376, 5068.847934561969, 5114.28400023997, 4166.812493437803, 4244.681648876347, 4259.5527469615245, 4264.424302719155, 4331.393604895317, 4430.246858034077, 4465.620422264144, 4473.776311184428, 4474.0, 4515.796789144496, 4792.448868380111, 4805.447373552086, 4810.037992401463, 4813.9037219254715, 4854.878628034327, 4798.760061996956, 4858.368412106403, 4890.388701412324, 4911.115999120193, 4949.208126699711, 4717.716936983792, 4729.385179926588, 4735.83424580138, 4739.739314337745, 4781.187198176388, 4938.802447902043, 4948.579370753526, 4954.777035033504, 4957.876053098701, 5005.4744251853035, 4765.8093676252565, 4866.391701037371, 4871.658983871095, 4925.113479573711, 5049.621278404208, 4833.685810422311, 4884.194107972145, 4889.951100488949, 4890.388701412324, 4937.23472861707, 4864.440589332131, 4879.682820616648, 4880.023995200903, 4929.112759703288, 4929.975350123226, 4417.514073451854, 4586.564276393738, 4692.061587682545, 4704.553067458586, 4829.66192366531, 4801.255805350176, 4802.039592081667, 4811.374521312207, 4816.397950256218, 4823.445303790109, 4709.599684026896, 4714.033623107323, 4718.174319494006, 4731.929021064618, 4751.453582837879], "unit": "ms", "name": "dojo.html", "value": 4573.262020453775}, {"lowerIsBetter": false, "replicates": [571.5199232644578, 574.2104606166521, 579.6811753535555, 580.3297191743537, 580.3471095018105, 26628.733712662866, 35109.0, 35753.64246357532, 35779.642203577954, 35794.82102589483, 39982.8000859996, 40447.79776101123, 40496.19007619853, 40551.59448405515, 40632.0, 6979.930200698004, 7101.8224544386285, 7797.883031754514, 7985.520868747864, 7988.161243069481, 9950.30347875649, 10172.949135254314, 10202.0, 10212.336198147133, 10217.0, 9697.563609637547, 9790.951045244763, 9797.167240784542, 9797.6080956762, 9815.558299876488, 7262.963685181593, 7453.14288856783, 9744.464054477, 10074.345167564084, 10343.120834729058, 9788.168005719523, 9926.602935882556, 9932.553035113366, 9932.95033524835, 9936.354136981145, 37321.0, 37720.0, 37810.62189378098, 37828.81085594582, 37829.0, 2821.830690158597, 2843.6871944086133, 2852.286928267933, 2877.5395936650243, 2877.7266159714795, 28119.0, 28250.152495424965, 28400.431991360056, 28642.14073577796, 28929.0, 3390.5247121700454, 3451.620321764604, 3456.2396272819938, 3521.4013617685055, 3566.2154326048226, 218838.0, 219789.0, 219904.0, 219918.90040549854, 220116.0, 50448.49551504511, 51542.742286288325, 54890.451095489334, 55224.17163742547, 55231.0, 63670.68164659147, 64887.35112648908, 65126.34873651298, 65146.674266629314, 65148.34851651518, 12131.090168237417, 12138.817917731241, 12155.453004614814, 12157.817632735516, 12267.325297108744, 9762.121409073217, 9840.65557705477, 9888.653897113567, 9903.702888913343, 9945.950270248602, 18869.33957311515, 18883.622327553647, 18987.525311867037, 18993.62012759737, 19024.239030438905, 7089.645517724196, 7319.963400183072, 7467.253274672598, 7473.813154671068, 7506.587137707369, 800.263757343234, 886.6719313853915, 936.9765755856022, 940.9461403228428, 1007.5969612155196, 26307.473850523264, 26351.868240659056, 26491.735082649313, 27702.0, 27843.0, 904.9864252036225, 908.977275568116, 916.7158180963922, 924.4360939826701, 933.6872147830553, 12950.222986620833, 13154.802677959839, 13183.868161318456, 13185.73628527424, 14158.0, 256798.0, 261568.0, 262301.0, 262556.0, 263889.0, 46707.532924670995, 46940.29589556159, 47021.5297847024, 47201.0, 47206.0, 1141.6689160143465, 1172.513406936129, 1186.5016692988966, 1187.4715751490676, 1190.2144584574312, 22618.547629047654, 25823.741762582886, 26579.7342026585, 28882.711172888, 28903.85548072246, 39991.80004099961, 40453.595464044985, 40514.987125322106, 40568.0, 40580.0, 200057.0, 202468.0, 202585.0, 202774.0, 224722.0, 23634.527309454057, 27642.447151056465, 27791.583126252717, 27970.440591188468, 28063.57904631473, 35262.0, 35784.46323305205, 35947.1013224661, 36411.45382819207, 36631.81684091563, 31031.68968310288, 31256.531152033192, 32229.194270143435, 34557.0, 37195.25609487849, 32125.0, 32191.35617287594, 36525.45211821772, 37744.0, 38184.809075955556, 37257.62742372542, 37819.0, 37990.81004594959, 38026.429603555414, 38199.80900095482, 34784.65215347814, 35724.10689732673, 35972.46041309435, 36066.4590031155, 36277.455838162976, 27570.86214568914, 27693.169204923885, 27938.860305699156, 28332.575011374433, 28453.857730711214], "unit": "ms", "name": "ext.html", "value": 17200.521092490122}, {"lowerIsBetter": false, "replicates": [339.9898003059909, 343.560242889102, 344.7121653419395, 345.90660521659146, 346.75553734617097, 12617.306048167347, 12941.41763620637, 14931.776023359645, 14973.775393369107, 15921.761173582405, 15242.237888105607, 15346.0, 16303.184840757975, 16322.183890805472, 16346.18269086547, 4923.138450771118, 5051.343325367706, 5067.214581739836, 5070.847874563769, 5071.808125090601, 3527.5237842891265, 3630.146915474861, 5021.623378246646, 5210.062188806013, 5381.7578208980685, 5344.385395679488, 5359.062164121283, 5359.196120581905, 5378.946210537903, 5387.649802762828, 5187.792488300463, 5328.760205790749, 5336.38631557372, 5341.545968592674, 5343.519083282485, 5132.153194722866, 5134.666246693991, 5140.1518749406305, 5140.74296285188, 5141.820036298749, 13015.544455943997, 18466.169022394024, 18867.339643112424, 18904.810951890442, 18912.5271868203, 1671.9498415047567, 1750.8074111847814, 1805.5486128467883, 1808.104988030933, 1815.0471002723543, 8829.337799664987, 8894.656245649656, 8918.866217006751, 9023.954880225623, 9115.726528204164, 1673.9414120505846, 1693.1365003848125, 1752.9298828046863, 1803.6302557975714, 1841.6132612151464, 54908.725456372464, 56029.43970560283, 56559.434405655826, 56840.71579642075, 57870.421295786924, 9444.338896277195, 9783.804323913482, 10009.149222316039, 10030.598776048877, 10073.093421592092, 12689.49242030327, 12784.296863672402, 12784.61646150617, 12791.808122878165, 12806.103572750004, 6731.427828634523, 6768.492363072789, 6793.252742198354, 6812.284710105368, 6841.863162736817, 5946.70266486674, 6000.729967151488, 6303.905441418382, 6360.109584658151, 6364.809055728336, 4185.811638476215, 4257.0, 4267.935980960288, 4269.573042695705, 4290.957090429119, 1634.2972521815734, 1663.0, 1666.9749953750704, 1673.5816045988504, 1683.6548507555922, 369.3739112204787, 374.487072228195, 423.4854651598323, 809.4738420026912, 854.5727136431784, 8962.32782541312, 9053.728388148365, 9192.95403522978, 9518.286128540387, 9764.316497845224, 406.8413318805668, 407.6107317511769, 407.641275677402, 419.6789456066112, 427.9614834664895, 5421.430749771296, 5666.3284331121595, 5726.169705392778, 5741.684207368635, 5745.597808153473, 495703.0, 501143.0, 501751.0, 506768.0, 510201.0, 69733.30266697268, 69915.65042174756, 71200.28799711936, 71297.28702712906, 71367.6431617849, 452.4254197169642, 455.76072561905266, 456.9268916973268, 457.09495199505164, 457.816873250709, 9617.0, 9642.807143856944, 9659.71020869375, 9723.222142228464, 9742.269329800152, 32281.51577726289, 33110.50334245036, 33224.16939576433, 34350.82824585861, 34514.654853451146, 42882.78558607187, 43433.0, 44569.0, 44797.88005299894, 44875.326870097626, 8382.329413646772, 9054.909450905407, 9070.501122438329, 9071.092890710876, 9073.637054517745, 15613.453529126426, 15686.294116765, 15831.366745330059, 16046.679066418374, 16233.350665973701, 12886.613401597968, 12951.352432378155, 12976.416061277076, 13055.477780888657, 13218.140820846615, 12536.37318134108, 12762.106652534234, 13070.34648267602, 13656.590302290948, 13844.10013349129, 10296.742581435525, 10762.515686793957, 11453.542545929195, 12396.566120185751, 13057.738845223232, 8573.485590864568, 8701.260392866425, 8708.34687398435, 8728.0, 8732.257758090633, 8932.642694292155, 8960.059193784558, 12077.637670869888, 12393.588769923252, 12563.18339307942], "unit": "ms", "name": "jquery.html", "value": 7415.948331786462}, {"lowerIsBetter": false, "replicates": [1433.3334999225358, 1608.3245037084423, 1615.07133398296, 1650.232641821552, 1681.1846254566537, 6009.939900600993, 6772.221194562627, 6906.5165438419335, 6915.757948471804, 6921.204061532925, 6686.7993960181275, 6705.396514313711, 6792.083068785712, 6793.150856142982, 6809.5233333666665, 1791.9875270472141, 1814.700574405228, 2058.2384517728424, 2128.733908261467, 2128.88291143987, 2030.7461567304088, 2057.9382618521468, 2063.7523497180287, 2065.2152182170753, 2065.7521097468325, 2031.4413536277493, 2033.054629597237, 2040.7040979058027, 2085.9165633374646, 2089.1538926734697, 2038.327351973845, 2062.731844860166, 2098.045389347843, 2098.7691353951054, 2099.25476455859, 2107.9894600527055, 2139.711138996231, 2149.752778430485, 2150.290404166637, 2151.4621344663833, 6786.287439818847, 6860.485463590251, 6869.0, 6869.519133660646, 6872.244053154149, 4029.0, 4124.835006599732, 4154.293770059067, 4163.479565054368, 4166.395872598487, 2631.973680263192, 2661.3612732943952, 2697.946041079187, 2699.0688212566633, 2707.8646067696536, 862.0818827948215, 870.6473878079388, 872.4503562755486, 881.9338549608805, 909.8362294786936, 9443.575039123256, 9553.1402173804, 9587.280953928554, 9611.134997850228, 9615.807683846353, 3856.402257650069, 3925.0972276376024, 3925.21495700861, 3929.862454814125, 4019.1157945252, 8456.11210822867, 8467.703630372907, 8468.0, 8468.661253549912, 8470.957645211734, 4221.831126754957, 4239.448871646666, 4248.2565551029065, 4250.85122020734, 4255.936160957588, 3901.921961560753, 3904.141088960424, 3907.433422153772, 3907.9609203908167, 3908.3160446922243, 3000.369922316338, 3042.4067306874945, 3048.8932887348838, 3282.40916635008, 3372.8650853966055, 990.0643891522442, 1047.7642530430744, 1118.4128332625273, 1121.2823792772633, 1127.1321082766224, 910.2490445382585, 921.8110287391069, 922.3082687984012, 950.7623094226443, 967.240716037921, 6388.520860935449, 6446.161998940108, 6453.612783233021, 6454.870902581922, 6456.354364563506, 560.4115678537601, 576.4322142689448, 579.9971000145057, 580.2369883603048, 725.6770737021975, 5079.593632509391, 5122.410922743858, 5238.397584277781, 5241.42344342122, 5248.763805628756, 8110.107888132301, 8307.252347288773, 8416.326693864476, 8454.196851299117, 8462.0, 8257.42198046131, 8313.376496762767, 8321.08468068512, 8332.6666933322, 8337.666493340319, 6442.323556026643, 6561.1142495763415, 6568.211814582281, 6570.868582628321, 6577.473802095917, 6453.9351007083305, 6457.6771161442675, 6462.773802916875, 6472.514561407819, 6496.870062598816, 7241.637918104179, 7350.08123984502, 7488.251174882468, 7498.362639175513, 7511.136219334847, 7482.775516734507, 7722.420818438527, 7807.570583617956, 7821.765347039598, 7823.921760782319, 5801.6519008859605, 5933.9109913352195, 6040.577159598962, 6095.116208149882, 6118.265808103056, 5791.8552036199435, 6655.2346480153465, 6710.966445167743, 6720.0, 6742.595444273359, 5473.28847249855, 5499.257600223918, 6000.279966404059, 6178.258608966953, 6560.3111673273615, 5990.1314309424015, 6158.846028849314, 6251.187345645037, 6295.779647712308, 6313.242410910537, 6220.471259942956, 6225.159603453476, 6266.655333956676, 6277.905831412624, 6420.486361091195, 5977.163197152315, 5978.4021597839865, 6002.0, 6009.819705408845, 6018.277806663228, 6041.788537401346, 6076.574639775174, 6086.391360864055, 6091.238595175603, 6096.878062438637], "unit": "ms", "name": "mootools.html", "value": 3963.916616544063}, {"lowerIsBetter": false, "replicates": [304.9268175637847, 309.53724182347395, 314.3665513989312, 318.97288730457893, 319.6627557926387, 5165.070287348276, 5289.735513224343, 5290.894182116355, 5291.28567643368, 5295.655782374148, 5215.1655735082395, 5232.79068837247, 5232.895342093156, 5235.162374020158, 5237.0, 3931.3709806430975, 4035.253478106545, 4126.731762435447, 4131.669466442678, 4137.441445404862, 3995.820188091543, 4066.1867626474677, 4089.0595163112503, 4092.529359123709, 4105.2815757242515, 4036.919261614766, 4041.4948131483566, 4043.6360727534516, 4052.5136983562015, 4056.979715101435, 3855.768653880776, 3947.782871942042, 3969.2260009298197, 4040.8585699500522, 4041.717079804415, 3615.5480564929385, 3621.0, 3625.854965801365, 3627.129488922666, 3634.691051260646, 5056.443791182967, 5062.392512898476, 5064.2403639454005, 5074.670146440507, 5079.212722028092, 4640.303954406832, 4693.108309421199, 4704.905901881977, 4706.576408123286, 4710.905781884378, 5353.598480114007, 5490.6431081979545, 5501.614886957915, 5514.80698175562, 5521.199426083195, 3817.3319669058083, 3846.59610740871, 3847.846086156578, 3848.422736589534, 3851.287511810324, 5701.344345400291, 5803.390643982363, 5803.506701930341, 5812.709364531799, 5818.156367326714, 3959.4456776051375, 3963.8216280267457, 3968.0873399118364, 3969.563348031714, 3972.463717398114, 3566.4293713005795, 3825.502684651033, 3876.6317199865966, 4018.417329487208, 4021.7586944783407, 4455.643548516111, 4480.305552639346, 4503.211937910853, 4629.907401851944, 4631.073785242965, 5394.703291318937, 5486.094794358886, 5524.558035357162, 5529.557635389159, 5538.390777014525, 1404.8243969503812, 1427.7358688642635, 1429.621150395146, 1429.8284205895359, 1430.0633085328918, 946.6118891254553, 951.3198063384713, 965.4545181972304, 966.0725703324746, 969.2391472693902, 4847.781849816767, 4856.927146092811, 4864.73243971585, 4866.197077482247, 4868.9756551217015, 5695.601307908407, 5708.885822283614, 5709.571782116275, 5712.200291959129, 5717.428257174332, 4832.710037397767, 4846.442659094178, 4849.733264670406, 4852.4662287148385, 4853.0, 2870.899518516842, 2952.483315419793, 3026.3039500914474, 3047.131567503251, 3077.1230199393513, 5391.595630327741, 5396.487333703292, 5487.067198576252, 5495.725213739297, 5500.779968801203, 5942.108683697394, 5946.13781001761, 5947.49446297061, 5951.226340575698, 5952.226210592596, 5438.15708565173, 5479.75341109651, 5479.972600137134, 5485.50630443262, 5490.670559766427, 5619.157126430904, 5770.480656740913, 5773.711314434346, 5775.33583637887, 5777.480026797609, 5645.858853528694, 5660.433956604306, 5666.688332141772, 5668.234788303526, 5668.773249069991, 5462.863428414322, 5481.342238931354, 5484.2596249505805, 5487.094629386106, 5488.725563721878, 4008.238434697398, 4009.438678584942, 4013.0769922917307, 4014.6386825185873, 4016.979915100406, 5578.051731205624, 5761.5390768739235, 5780.739866705924, 5785.82642520725, 5787.681677507778, 5561.916571251515, 5564.944350556442, 5570.44295570456, 5571.164325351229, 5574.16387541872, 5561.416051314553, 5565.443455654402, 5569.415211402907, 5574.331080270394, 5580.832575022756, 5280.287161233338, 5433.320834895638, 5434.483724046209, 5437.075697131418, 5449.64577302474, 5526.0053190424505, 5591.329040515002, 5592.944070559242, 5595.384507704068, 5597.972010139923, 5242.135047717084, 5344.492273234192, 5378.247045413567, 5474.781008759605, 5482.643628164156], "unit": "ms", "name": "prototype.html", "value": 4155.968053827527}, {"lowerIsBetter": false, "replicates": [691.9827004324889, 708.8203773396806, 714.6569646569646, 759.8974138491304, 781.0939310399938, 11206.0, 11458.656240312783, 11462.942685286562, 11477.885221147786, 11496.655100346981, 10202.897971020288, 10442.37345759253, 11592.304461732301, 11714.7657046859, 11744.706382340424, 808.0787901791962, 824.4435006370676, 825.1130035212141, 826.983460330793, 827.3091968206525, 794.4756460735915, 798.1499702816482, 803.2168635580321, 803.3573141486817, 803.7709252862935, 837.4682076881163, 849.2059923971076, 849.9192576705234, 851.535912927456, 852.6504133305347, 850.9574521273912, 851.0510780479782, 851.6550796927223, 852.0116664668985, 852.3479538153317, 625.3027873920546, 625.3558834400575, 625.8341539492038, 625.9749610015593, 625.974961001564, 10275.89724102757, 10357.0, 10404.219683523766, 10421.218408619308, 10422.79154416915, 9272.675456359062, 9597.760055998586, 9660.855087173699, 9765.609375624967, 9867.640120191725, 8754.824903501894, 8779.824403511959, 8824.117588241188, 8832.072632373636, 8853.73438796837, 3116.439040972624, 3133.3263348380206, 3153.22745927247, 3155.0534839548045, 3244.0592228253777, 34391.82804085989, 34675.479867802, 38170.42744358837, 38734.80632596819, 39107.413388799476, 7635.847283054308, 9175.77060573491, 9210.539473026322, 9223.44659320443, 9312.34813563044, 14109.506167284097, 14338.856611433961, 16726.91636541834, 16777.91611041937, 16798.160091995353, 6201.472874805602, 6305.716242769086, 6335.588186767845, 6375.617462952145, 6412.583182093149, 3537.8407971640822, 3542.7520073595115, 3573.9821300893327, 3594.676479116892, 3628.1836586768295, 2577.4716183182404, 2581.6772903387077, 2586.9223923281957, 2591.4298854252033, 2599.8050146239107, 458.4155202117327, 461.5269348917387, 462.35732332058467, 465.73220398271127, 466.9673122881434, 421.54052083229425, 426.413681188366, 450.84220522817407, 496.9801207951714, 557.7350758389732, 7094.432445404355, 7340.229275925951, 7363.8159046024275, 7388.1503627083575, 7415.740449084256, 532.5473347654463, 546.7724957470425, 547.7945770336124, 551.1912683357978, 576.1588081401118, 3307.93384132316, 3404.5267448698046, 3490.336836001152, 3504.421770407905, 3506.63180366063, 50034.49965500371, 50415.49584504181, 50490.24264636033, 50527.49472505302, 50599.24101138486, 44139.337909931375, 44702.55297447049, 45437.54562454399, 45494.0, 45523.31715024277, 35719.28561428757, 36625.45061824075, 44387.778061109486, 44778.32832507515, 45264.54735452603, 7380.18817930038, 7531.88702169457, 7592.202818703957, 7627.771166865003, 7689.9615501922135, 31550.36899261956, 31797.364052718352, 32154.356912861145, 32167.839160804047, 32658.673413265562, 36249.275014499035, 36423.453648194765, 37921.0, 38706.6129338703, 39122.21755564816, 9029.774255643399, 10380.636677716244, 10461.790764184825, 10472.162227021667, 10540.894591053991, 10430.582776688847, 10457.581696732046, 10933.234673573092, 11102.944485277521, 11187.496562654864, 10176.949115254376, 10178.0, 10551.366917984946, 10625.149988001096, 11553.768924621292, 9792.216622670312, 10020.849687254842, 10238.180945524191, 10355.223358248311, 10431.426271555138, 11099.389533575732, 11135.109191264517, 11142.331460112418, 11170.888291116984, 11199.832002520132, 8977.820443590961, 9190.126937940884, 9193.632254709737, 9377.624895004123, 9469.289803264921, 9005.639774409212, 9218.907810922074, 9287.442753434816, 9389.43663380172, 9429.669961551313], "unit": "ms", "name": "yui.html", "value": 5567.5852316438095}], "name": "dromaeo_css", "value": 6138.666670399141}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 113.0, 112.0, 111.0, 100.0, 112.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 157.0, 166.0, 133.0, 160.0, 157.0, 133.0, 176.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 164.0, 162.0, 162.0, 165.0, 164.0, 165.0, 166.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 85.0, 94.0, 74.0, 72.0, 71.0, 99.0, 96.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 136.0, 94.0, 94.0, 95.0, 139.0, 95.0, 95.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 70.0, 72.0, 71.0, 72.0, 78.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 83.0, 83.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [118.0, 127.0, 118.0, 138.0, 123.0, 123.0, 128.0, 127.0, 139.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [139.0, 133.0, 143.0, 138.0, 144.0, 135.0, 144.0, 154.0, 145.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 71.0, 68.0, 69.0, 67.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1522.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.12549537648613], "unit": "score", "name": "Richards", "value": 213.78891199999993}, {"lowerIsBetter": false, "replicates": [186.11576400521125], "unit": "score", "name": "DeltaBlue", "value": 355.2520139999999}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"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": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [27162.162162162163], "unit": "score", "name": "RegExp", "value": 33.538751243781114}, {"lowerIsBetter": false, "replicates": [618.8118811881188], "unit": "score", "name": "Splay", "value": 131.68945600000004}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19761.994670863332}]} 15:27:06 INFO - RETURN: dromaeo_css: 6138.67 15:27:06 INFO - RETURN: kraken: 1522.10 15:27:06 INFO - RETURN: v8_7: 19761.99 15:27:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19761.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1522.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6138.67"}}} 15:27:06 INFO - Return code: 0 15:27:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:27:06 INFO - # TBPL SUCCESS # 15:27:06 INFO - Running post-action listener: _resource_record_post_action 15:27:06 INFO - Running post-run listener: _resource_record_post_run 15:27:07 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505716736; Read time: 8; Write time: 525920 15:27:07 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232030208; Read time: 0; Write time: 355500 15:27:07 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273682432; Read time: 8; Write time: 170420 15:27:07 INFO - Running post-run listener: _upload_blobber_files 15:27:07 INFO - Blob upload gear active. 15:27:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:27:07 INFO - Copying logs to upload dir... 15:27:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.305060 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 15:27:07.090580) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 15:27:07.093977) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010052 build_url: 'https://queue.taskcluster.net/v1/task/obfn1Jh3TVOpRdA0VzrJaA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 15:27:07.146426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:27:07.146811) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449788519.195239-561364132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 15:27:07.196793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 15:27:07.197303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 15:27:07.197677) ========= ========= Total master_lag: 0.29 =========