builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1449750203.99 results: success (0) buildid: 20151210030342 builduid: 55fc1ad5cc8f450eaa4d374dd2173cb6 revision: 986e6476df2cbe5f06ebdf2b18a207ab69200577 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:23.986820) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:23.987655) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:23.988024) ========= 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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006243 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.039696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.040119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.080912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.081370) ========= 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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004338 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.136170) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.136822) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.137645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.137963) ========= 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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 04:23:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.8M=0s 2015-12-10 04:23:24 (33.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.365323) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.365703) ========= 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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.418341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:24.419136) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 986e6476df2cbe5f06ebdf2b18a207ab69200577 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 986e6476df2cbe5f06ebdf2b18a207ab69200577 --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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 04:23:24,587 truncating revision to first 12 chars 2015-12-10 04:23:24,587 Setting DEBUG logging. 2015-12-10 04:23:24,587 attempt 1/10 2015-12-10 04:23:24,587 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/986e6476df2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 04:23:25,033 unpacking tar archive at: mozilla-central-986e6476df2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732461 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:25.166240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:25.166618) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:25.177964) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:25.178524) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 04:23:25.179071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-10 04:23:25.179536) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:25 INFO - MultiFileLogger online at 20151210 04:23:25 in /builds/slave/test 04:23:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:23:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:25 INFO - {'append_to_log': False, 04:23:25 INFO - 'base_work_dir': '/builds/slave/test', 04:23:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:23:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:25 INFO - 'branch': 'Firefox-Non-PGO', 04:23:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:25 INFO - 'config_files': ('talos/linux_config.py',), 04:23:25 INFO - 'default_actions': ('clobber', 04:23:25 INFO - 'read-buildbot-config', 04:23:25 INFO - 'download-and-extract', 04:23:25 INFO - 'populate-webroot', 04:23:25 INFO - 'create-virtualenv', 04:23:25 INFO - 'install', 04:23:25 INFO - 'run-tests'), 04:23:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:25 INFO - 'download_minidump_stackwalk': True, 04:23:25 INFO - 'download_symbols': 'ondemand', 04:23:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:25 INFO - 'installer_path': 'installer.exe', 04:23:25 INFO - 'log_level': 'info', 04:23:25 INFO - 'log_name': 'talos', 04:23:25 INFO - 'log_to_console': True, 04:23:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:25 INFO - 'opt_config_files': (), 04:23:25 INFO - 'pip_index': False, 04:23:25 INFO - 'sps_profile': False, 04:23:25 INFO - 'sps_profile_interval': 0, 04:23:25 INFO - 'suite': 'dromaeojs-e10s', 04:23:25 INFO - 'system_bits': '64', 04:23:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:25 INFO - 'title': 'talos-linux64-ix-005', 04:23:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:25 INFO - 'use_talos_json': True, 04:23:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:25 INFO - 'work_dir': 'build'} 04:23:25 INFO - ##### 04:23:25 INFO - ##### Running clobber step. 04:23:25 INFO - ##### 04:23:25 INFO - Running pre-action listener: _resource_record_pre_action 04:23:25 INFO - Running main action method: clobber 04:23:25 INFO - rmtree: /builds/slave/test/build 04:23:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:25 INFO - Running post-action listener: _resource_record_post_action 04:23:25 INFO - ##### 04:23:25 INFO - ##### Running read-buildbot-config step. 04:23:25 INFO - ##### 04:23:25 INFO - Running pre-action listener: _resource_record_pre_action 04:23:25 INFO - Running main action method: read_buildbot_config 04:23:25 INFO - Using buildbot properties: 04:23:25 INFO - { 04:23:25 INFO - "properties": { 04:23:25 INFO - "buildnumber": 143, 04:23:25 INFO - "product": "firefox", 04:23:25 INFO - "script_repo_revision": "production", 04:23:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:23:25 INFO - "repository": "", 04:23:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:23:25 INFO - "buildid": "20151210030342", 04:23:25 INFO - "slavename": "talos-linux64-ix-005", 04:23:25 INFO - "pgo_build": "False", 04:23:25 INFO - "basedir": "/builds/slave/test", 04:23:25 INFO - "project": "", 04:23:25 INFO - "platform": "ubuntu64_hw", 04:23:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:23:25 INFO - "slavebuilddir": "test", 04:23:25 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:23:25 INFO - "branch": "mozilla-central", 04:23:25 INFO - "repo_path": "mozilla-central", 04:23:25 INFO - "stage_platform": "linux64", 04:23:25 INFO - "builduid": "55fc1ad5cc8f450eaa4d374dd2173cb6", 04:23:25 INFO - "revision": "986e6476df2cbe5f06ebdf2b18a207ab69200577" 04:23:25 INFO - }, 04:23:25 INFO - "sourcestamp": { 04:23:25 INFO - "repository": "", 04:23:25 INFO - "hasPatch": false, 04:23:25 INFO - "project": "", 04:23:25 INFO - "branch": "mozilla-central-linux64-talos", 04:23:25 INFO - "changes": [ 04:23:25 INFO - { 04:23:25 INFO - "category": null, 04:23:25 INFO - "files": [ 04:23:25 INFO - { 04:23:25 INFO - "url": null, 04:23:25 INFO - "name": "https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:23:25 INFO - } 04:23:25 INFO - ], 04:23:25 INFO - "repository": "", 04:23:25 INFO - "rev": "986e6476df2cbe5f06ebdf2b18a207ab69200577", 04:23:25 INFO - "who": "cbook@mozilla.com", 04:23:25 INFO - "when": 1449750145, 04:23:25 INFO - "number": 7236557, 04:23:25 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:23:25 INFO - "project": "", 04:23:25 INFO - "at": "Thu 10 Dec 2015 04:22:25", 04:23:25 INFO - "branch": "mozilla-central-linux64-talos", 04:23:25 INFO - "revlink": "", 04:23:25 INFO - "properties": [ 04:23:25 INFO - [ 04:23:25 INFO - "buildid", 04:23:25 INFO - "20151210030342", 04:23:25 INFO - "Change" 04:23:25 INFO - ], 04:23:25 INFO - [ 04:23:25 INFO - "builduid", 04:23:25 INFO - "55fc1ad5cc8f450eaa4d374dd2173cb6", 04:23:25 INFO - "Change" 04:23:25 INFO - ], 04:23:25 INFO - [ 04:23:25 INFO - "pgo_build", 04:23:25 INFO - "False", 04:23:25 INFO - "Change" 04:23:25 INFO - ] 04:23:25 INFO - ], 04:23:25 INFO - "revision": "986e6476df2cbe5f06ebdf2b18a207ab69200577" 04:23:25 INFO - } 04:23:25 INFO - ], 04:23:25 INFO - "revision": "986e6476df2cbe5f06ebdf2b18a207ab69200577" 04:23:25 INFO - } 04:23:25 INFO - } 04:23:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:23:25 INFO - Running post-action listener: _resource_record_post_action 04:23:25 INFO - ##### 04:23:25 INFO - ##### Running download-and-extract step. 04:23:25 INFO - ##### 04:23:25 INFO - Running pre-action listener: _resource_record_pre_action 04:23:25 INFO - Running main action method: download_and_extract 04:23:25 INFO - mkdir: /builds/slave/test/build/tests 04:23: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')]} 04:23:25 INFO - https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:23:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/test_packages.json 04:23:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/test_packages.json 04:23:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:23:26 INFO - Downloaded 1302 bytes. 04:23:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:23:26 INFO - Using the following test package requirements: 04:23:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:26 INFO - u'jsshell-linux-x86_64.zip'], 04:23:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:26 INFO - https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:29 INFO - Downloaded 21859993 bytes. 04:23:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:23:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:23:30 INFO - Return code: 0 04:23:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:30 INFO - https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:31 INFO - Downloaded 21859993 bytes. 04:23:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:23:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:23:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:23:32 INFO - Return code: 0 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 INFO - https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:23:34 INFO - Downloaded 11132038 bytes. 04:23:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:23:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:23:34 INFO - Return code: 0 04:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:34 INFO - https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:23:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:23:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:23:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:23:39 INFO - Downloaded 57731135 bytes. 04:23:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:23:39 INFO - mkdir: /builds/slave/test/properties 04:23:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:39 INFO - Contents: 04:23:39 INFO - build_url:https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:23:39 INFO - Running post-action listener: _resource_record_post_action 04:23:39 INFO - Running post-action listener: set_extra_try_arguments 04:23:39 INFO - ##### 04:23:39 INFO - ##### Running populate-webroot step. 04:23:39 INFO - ##### 04:23:39 INFO - Running pre-action listener: _resource_record_pre_action 04:23:39 INFO - Running main action method: populate_webroot 04:23:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:39 INFO - '--tppagecycles', 04:23:39 INFO - '7'], 04:23:39 INFO - 'tests': ['tsvgm']}}, 04:23:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:23:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:23:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:23:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'tests': ['damp', 'tps']}, 04:23:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['damp', 'tps']}, 04:23:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:23:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:39 INFO - 'other': {'tests': ['a11yr', 04:23:39 INFO - 'ts_paint', 04:23:39 INFO - 'tpaint', 04:23:39 INFO - 'sessionrestore', 04:23:39 INFO - 'sessionrestore_no_auto_restore']}, 04:23:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['a11yr', 04:23:39 INFO - 'ts_paint', 04:23:39 INFO - 'tpaint', 04:23:39 INFO - 'sessionrestore', 04:23:39 INFO - 'sessionrestore_no_auto_restore']}, 04:23:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['a11yr', 04:23:39 INFO - 'ts_paint', 04:23:39 INFO - 'tpaint', 04:23:39 INFO - 'sessionrestore', 04:23:39 INFO - 'sessionrestore_no_auto_restore']}, 04:23:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['a11yr', 04:23:39 INFO - 'ts_paint', 04:23:39 INFO - 'tpaint', 04:23:39 INFO - 'sessionrestore', 04:23:39 INFO - 'sessionrestore_no_auto_restore']}, 04:23:39 INFO - 'other_l64': {'tests': ['a11yr', 04:23:39 INFO - 'ts_paint', 04:23:39 INFO - 'tpaint', 04:23:39 INFO - 'sessionrestore', 04:23:39 INFO - 'sessionrestore_no_auto_restore']}, 04:23:39 INFO - 'other_nol64': {'tests': ['a11yr', 04:23:39 INFO - 'ts_paint', 04:23:39 INFO - 'tpaint', 04:23:39 INFO - 'sessionrestore', 04:23:39 INFO - 'sessionrestore_no_auto_restore']}, 04:23:39 INFO - 'svgr': {'tests': ['tsvgx', 04:23:39 INFO - 'tsvgr_opacity', 04:23:39 INFO - 'tart', 04:23:39 INFO - 'tscrollx', 04:23:39 INFO - 'cart']}, 04:23:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['tsvgx', 04:23:39 INFO - 'tsvgr_opacity', 04:23:39 INFO - 'tart', 04:23:39 INFO - 'tscrollx', 04:23:39 INFO - 'cart']}, 04:23:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'tests': ['tp5o']}, 04:23:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'talos_options': ['--e10s'], 04:23:39 INFO - 'tests': ['tp5o']}, 04:23:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'talos_options': ['--xperf_path', 04:23:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:39 INFO - 'tests': ['tp5n']}, 04:23:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:39 INFO - 'talos_options': ['--e10s', 04:23:39 INFO - '--xperf_path', 04:23:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:39 INFO - 'tests': ['tp5n']}}, 04:23:39 INFO - 'talos.zip': {'path': '', 04:23:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:39 INFO - Running post-action listener: _resource_record_post_action 04:23:39 INFO - ##### 04:23:39 INFO - ##### Running create-virtualenv step. 04:23:39 INFO - ##### 04:23:39 INFO - Running pre-action listener: _resource_record_pre_action 04:23:39 INFO - Running main action method: create_virtualenv 04:23:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:23:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:39 INFO - Using real prefix '/usr' 04:23:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:41 INFO - Installing pip.................done. 04:23:41 INFO - Return code: 0 04:23:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:41 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 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:23:41 INFO - Using env: {'DISPLAY': ':0', 04:23:41 INFO - 'HOME': '/home/cltbld', 04:23:41 INFO - 'LANG': 'en_US.UTF-8', 04:23:41 INFO - 'LANGUAGE': 'en_US:en', 04:23:41 INFO - 'LOGNAME': 'cltbld', 04:23:41 INFO - 'MAIL': '/var/mail/cltbld', 04:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:41 INFO - 'MOZ_NO_REMOTE': '1', 04:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:41 INFO - 'NO_EM_RESTART': '1', 04:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:41 INFO - 'PWD': '/builds/slave/test', 04:23:41 INFO - 'SHELL': '/bin/bash', 04:23:41 INFO - 'SHLVL': '1', 04:23:41 INFO - 'TERM': 'linux', 04:23:41 INFO - 'TMOUT': '86400', 04:23:41 INFO - 'USER': 'cltbld', 04:23:41 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:41 INFO - '_': '/tools/buildbot/bin/python'} 04:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:23:42 INFO - Cleaning up... 04:23:42 INFO - Return code: 0 04:23:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 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 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:23:42 INFO - Using env: {'DISPLAY': ':0', 04:23:42 INFO - 'HOME': '/home/cltbld', 04:23:42 INFO - 'LANG': 'en_US.UTF-8', 04:23:42 INFO - 'LANGUAGE': 'en_US:en', 04:23:42 INFO - 'LOGNAME': 'cltbld', 04:23:42 INFO - 'MAIL': '/var/mail/cltbld', 04:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:42 INFO - 'MOZ_NO_REMOTE': '1', 04:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:42 INFO - 'NO_EM_RESTART': '1', 04:23:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:42 INFO - 'PWD': '/builds/slave/test', 04:23:42 INFO - 'SHELL': '/bin/bash', 04:23:42 INFO - 'SHLVL': '1', 04:23:42 INFO - 'TERM': 'linux', 04:23:42 INFO - 'TMOUT': '86400', 04:23:42 INFO - 'USER': 'cltbld', 04:23:42 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:42 INFO - '_': '/tools/buildbot/bin/python'} 04:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:42 INFO - Downloading/unpacking psutil>=0.7.1 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:23:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:44 INFO - Installing collected packages: psutil 04:23:44 INFO - Running setup.py install for psutil 04:23:44 INFO - building 'psutil._psutil_linux' extension 04:23:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:23:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:23:45 INFO - building 'psutil._psutil_posix' extension 04:23:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:23:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:23:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:45 INFO - Successfully installed psutil 04:23:45 INFO - Cleaning up... 04:23:45 INFO - Return code: 0 04:23:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:23:45 INFO - Using env: {'DISPLAY': ':0', 04:23:45 INFO - 'HOME': '/home/cltbld', 04:23:45 INFO - 'LANG': 'en_US.UTF-8', 04:23:45 INFO - 'LANGUAGE': 'en_US:en', 04:23:45 INFO - 'LOGNAME': 'cltbld', 04:23:45 INFO - 'MAIL': '/var/mail/cltbld', 04:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:45 INFO - 'MOZ_NO_REMOTE': '1', 04:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:45 INFO - 'NO_EM_RESTART': '1', 04:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:45 INFO - 'PWD': '/builds/slave/test', 04:23:45 INFO - 'SHELL': '/bin/bash', 04:23:45 INFO - 'SHLVL': '1', 04:23:45 INFO - 'TERM': 'linux', 04:23:45 INFO - 'TMOUT': '86400', 04:23:45 INFO - 'USER': 'cltbld', 04:23:45 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:45 INFO - '_': '/tools/buildbot/bin/python'} 04:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:23:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:23:47 INFO - Installing collected packages: mozsystemmonitor 04:23:47 INFO - Running setup.py install for mozsystemmonitor 04:23:47 INFO - Successfully installed mozsystemmonitor 04:23:47 INFO - Cleaning up... 04:23:47 INFO - Return code: 0 04:23:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:47 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 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:23:47 INFO - Using env: {'DISPLAY': ':0', 04:23:47 INFO - 'HOME': '/home/cltbld', 04:23:47 INFO - 'LANG': 'en_US.UTF-8', 04:23:47 INFO - 'LANGUAGE': 'en_US:en', 04:23:47 INFO - 'LOGNAME': 'cltbld', 04:23:47 INFO - 'MAIL': '/var/mail/cltbld', 04:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:47 INFO - 'MOZ_NO_REMOTE': '1', 04:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:47 INFO - 'NO_EM_RESTART': '1', 04:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:47 INFO - 'PWD': '/builds/slave/test', 04:23:47 INFO - 'SHELL': '/bin/bash', 04:23:47 INFO - 'SHLVL': '1', 04:23:47 INFO - 'TERM': 'linux', 04:23:47 INFO - 'TMOUT': '86400', 04:23:47 INFO - 'USER': 'cltbld', 04:23:47 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:47 INFO - '_': '/tools/buildbot/bin/python'} 04:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:49 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:50 INFO - Downloading docopt-0.6.1.tar.gz 04:23:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:50 INFO - Running setup.py install for blobuploader 04:23:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:50 INFO - Running setup.py install for requests 04:23:50 INFO - Running setup.py install for docopt 04:23:50 INFO - Successfully installed blobuploader requests docopt 04:23:50 INFO - Cleaning up... 04:23:50 INFO - Return code: 0 04:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:50 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 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:50 INFO - Using env: {'DISPLAY': ':0', 04:23:50 INFO - 'HOME': '/home/cltbld', 04:23:50 INFO - 'LANG': 'en_US.UTF-8', 04:23:50 INFO - 'LANGUAGE': 'en_US:en', 04:23:50 INFO - 'LOGNAME': 'cltbld', 04:23:50 INFO - 'MAIL': '/var/mail/cltbld', 04:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:50 INFO - 'MOZ_NO_REMOTE': '1', 04:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:50 INFO - 'NO_EM_RESTART': '1', 04:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:50 INFO - 'PWD': '/builds/slave/test', 04:23:50 INFO - 'SHELL': '/bin/bash', 04:23:50 INFO - 'SHLVL': '1', 04:23:50 INFO - 'TERM': 'linux', 04:23:50 INFO - 'TMOUT': '86400', 04:23:50 INFO - 'USER': 'cltbld', 04:23:50 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:50 INFO - '_': '/tools/buildbot/bin/python'} 04:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:50 INFO - Running setup.py (path:/tmp/pip-uVWrBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:51 INFO - Running setup.py (path:/tmp/pip-md_dF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:51 INFO - Running setup.py (path:/tmp/pip-QuUgwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:51 INFO - Running setup.py (path:/tmp/pip-3heX8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:51 INFO - Running setup.py (path:/tmp/pip-oBNj2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:51 INFO - Running setup.py (path:/tmp/pip-mHjd1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:51 INFO - Running setup.py (path:/tmp/pip-Yp5Hq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:51 INFO - Running setup.py (path:/tmp/pip-HGQvFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:51 INFO - Running setup.py (path:/tmp/pip-YPTVXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:51 INFO - Running setup.py (path:/tmp/pip-GkGsY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:51 INFO - Running setup.py (path:/tmp/pip-4yBTFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:51 INFO - Running setup.py (path:/tmp/pip-QYlKgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:51 INFO - Running setup.py (path:/tmp/pip-nuzxSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:51 INFO - Running setup.py (path:/tmp/pip-5QS43s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:51 INFO - Running setup.py (path:/tmp/pip-6yYzJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:52 INFO - Running setup.py (path:/tmp/pip-Z0eevT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:52 INFO - Running setup.py (path:/tmp/pip-s3r0vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:52 INFO - Running setup.py install for manifestparser 04:23:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Running setup.py install for mozcrash 04:23:52 INFO - Running setup.py install for mozdebug 04:23:52 INFO - Running setup.py install for mozdevice 04:23:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Running setup.py install for mozfile 04:23:52 INFO - Running setup.py install for mozhttpd 04:23:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Running setup.py install for mozinfo 04:23:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Running setup.py install for mozInstall 04:23:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:52 INFO - Running setup.py install for mozleak 04:23:53 INFO - Running setup.py install for mozlog 04:23:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Running setup.py install for moznetwork 04:23:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Running setup.py install for mozprocess 04:23:53 INFO - Running setup.py install for mozprofile 04:23:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Running setup.py install for mozrunner 04:23:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Running setup.py install for mozscreenshot 04:23:53 INFO - Running setup.py install for moztest 04:23:53 INFO - Running setup.py install for mozversion 04:23:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:53 INFO - Cleaning up... 04:23:53 INFO - Return code: 0 04:23:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:53 INFO - Using env: {'DISPLAY': ':0', 04:23:53 INFO - 'HOME': '/home/cltbld', 04:23:53 INFO - 'LANG': 'en_US.UTF-8', 04:23:53 INFO - 'LANGUAGE': 'en_US:en', 04:23:53 INFO - 'LOGNAME': 'cltbld', 04:23:53 INFO - 'MAIL': '/var/mail/cltbld', 04:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:53 INFO - 'MOZ_NO_REMOTE': '1', 04:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:53 INFO - 'NO_EM_RESTART': '1', 04:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:53 INFO - 'PWD': '/builds/slave/test', 04:23:53 INFO - 'SHELL': '/bin/bash', 04:23:53 INFO - 'SHLVL': '1', 04:23:53 INFO - 'TERM': 'linux', 04:23:53 INFO - 'TMOUT': '86400', 04:23:53 INFO - 'USER': 'cltbld', 04:23:53 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:53 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:54 INFO - Running setup.py (path:/tmp/pip-AH74RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:54 INFO - Running setup.py (path:/tmp/pip-R8IBvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:54 INFO - Running setup.py (path:/tmp/pip-jwjCcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:54 INFO - Running setup.py (path:/tmp/pip-22tC7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:54 INFO - Running setup.py (path:/tmp/pip-4Kzi03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:54 INFO - Running setup.py (path:/tmp/pip-0S7hc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:54 INFO - Running setup.py (path:/tmp/pip-bThhof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:54 INFO - Running setup.py (path:/tmp/pip-6hty7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:54 INFO - Running setup.py (path:/tmp/pip-_Bwe3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:54 INFO - Running setup.py (path:/tmp/pip-vZvcqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:54 INFO - Running setup.py (path:/tmp/pip-luEFmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:54 INFO - Running setup.py (path:/tmp/pip-1E0MRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:55 INFO - Running setup.py (path:/tmp/pip-IMEW4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:55 INFO - Running setup.py (path:/tmp/pip-RyUlB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:55 INFO - Running setup.py (path:/tmp/pip-MjST_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:55 INFO - Running setup.py (path:/tmp/pip-9_jC_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:55 INFO - Running setup.py (path:/tmp/pip-a2zpop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:57 INFO - Downloading blessings-1.5.1.tar.gz 04:23:57 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:57 INFO - Installing collected packages: blessings 04:23:57 INFO - Running setup.py install for blessings 04:23:57 INFO - Successfully installed blessings 04:23:57 INFO - Cleaning up... 04:23:57 INFO - Return code: 0 04:23:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:57 INFO - Reading from file tmpfile_stdout 04:23:57 INFO - Current package versions: 04:23:57 INFO - argparse == 1.2.1 04:23:57 INFO - blessings == 1.5.1 04:23:57 INFO - blobuploader == 1.2.4 04:23:57 INFO - docopt == 0.6.1 04:23:57 INFO - manifestparser == 1.1 04:23:57 INFO - mozInstall == 1.12 04:23:57 INFO - mozcrash == 0.16 04:23:57 INFO - mozdebug == 0.1 04:23:57 INFO - mozdevice == 0.47 04:23:57 INFO - mozfile == 1.2 04:23:57 INFO - mozhttpd == 0.7 04:23:57 INFO - mozinfo == 0.9 04:23:57 INFO - mozleak == 0.1 04:23:57 INFO - mozlog == 3.1 04:23:57 INFO - moznetwork == 0.27 04:23:57 INFO - mozprocess == 0.22 04:23:57 INFO - mozprofile == 0.27 04:23:57 INFO - mozrunner == 6.11 04:23:57 INFO - mozscreenshot == 0.1 04:23:57 INFO - mozsystemmonitor == 0.0 04:23:57 INFO - moztest == 0.7 04:23:57 INFO - mozversion == 1.4 04:23:57 INFO - psutil == 3.1.1 04:23:57 INFO - requests == 1.2.3 04:23:57 INFO - wsgiref == 0.1.2 04:23:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:57 INFO - Using env: {'DISPLAY': ':0', 04:23:57 INFO - 'HOME': '/home/cltbld', 04:23:57 INFO - 'LANG': 'en_US.UTF-8', 04:23:57 INFO - 'LANGUAGE': 'en_US:en', 04:23:57 INFO - 'LOGNAME': 'cltbld', 04:23:57 INFO - 'MAIL': '/var/mail/cltbld', 04:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:57 INFO - 'MOZ_NO_REMOTE': '1', 04:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:57 INFO - 'NO_EM_RESTART': '1', 04:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:57 INFO - 'PWD': '/builds/slave/test', 04:23:57 INFO - 'SHELL': '/bin/bash', 04:23:57 INFO - 'SHLVL': '1', 04:23:57 INFO - 'TERM': 'linux', 04:23:57 INFO - 'TMOUT': '86400', 04:23:57 INFO - 'USER': 'cltbld', 04:23:57 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:57 INFO - '_': '/tools/buildbot/bin/python'} 04:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:57 INFO - Cleaning up... 04:23:57 INFO - Return code: 0 04:23:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:23:57 INFO - Using env: {'DISPLAY': ':0', 04:23:57 INFO - 'HOME': '/home/cltbld', 04:23:57 INFO - 'LANG': 'en_US.UTF-8', 04:23:57 INFO - 'LANGUAGE': 'en_US:en', 04:23:57 INFO - 'LOGNAME': 'cltbld', 04:23:57 INFO - 'MAIL': '/var/mail/cltbld', 04:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:57 INFO - 'MOZ_NO_REMOTE': '1', 04:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:57 INFO - 'NO_EM_RESTART': '1', 04:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:57 INFO - 'PWD': '/builds/slave/test', 04:23:57 INFO - 'SHELL': '/bin/bash', 04:23:57 INFO - 'SHLVL': '1', 04:23:57 INFO - 'TERM': 'linux', 04:23:57 INFO - 'TMOUT': '86400', 04:23:57 INFO - 'USER': 'cltbld', 04:23:57 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:57 INFO - '_': '/tools/buildbot/bin/python'} 04:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:58 INFO - Downloading/unpacking jsonschema 04:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:23:59 INFO - Downloading/unpacking functools32 (from jsonschema) 04:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:59 INFO - warning: no files found matching '*.txt' 04:23:59 INFO - no previously-included directories found matching 'build' 04:23:59 INFO - no previously-included directories found matching 'dist' 04:23:59 INFO - no previously-included directories found matching '.git*' 04:23:59 INFO - Installing collected packages: jsonschema, functools32 04:24:00 INFO - Running setup.py install for functools32 04:24:00 INFO - warning: no files found matching '*.txt' 04:24:00 INFO - no previously-included directories found matching 'build' 04:24:00 INFO - no previously-included directories found matching 'dist' 04:24:00 INFO - no previously-included directories found matching '.git*' 04:24:00 INFO - Successfully installed jsonschema functools32 04:24:00 INFO - Cleaning up... 04:24:00 INFO - Return code: 0 04:24:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f566bb50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, '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': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:24:00 INFO - Using env: {'DISPLAY': ':0', 04:24:00 INFO - 'HOME': '/home/cltbld', 04:24:00 INFO - 'LANG': 'en_US.UTF-8', 04:24:00 INFO - 'LANGUAGE': 'en_US:en', 04:24:00 INFO - 'LOGNAME': 'cltbld', 04:24:00 INFO - 'MAIL': '/var/mail/cltbld', 04:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:00 INFO - 'MOZ_NO_REMOTE': '1', 04:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:00 INFO - 'NO_EM_RESTART': '1', 04:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:00 INFO - 'PWD': '/builds/slave/test', 04:24:00 INFO - 'SHELL': '/bin/bash', 04:24:00 INFO - 'SHLVL': '1', 04:24:00 INFO - 'TERM': 'linux', 04:24:00 INFO - 'TMOUT': '86400', 04:24:00 INFO - 'USER': 'cltbld', 04:24:00 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:00 INFO - '_': '/tools/buildbot/bin/python'} 04:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:00 INFO - Downloading/unpacking flake8 04:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:24:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:24:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:24:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:24:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:24:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:02 INFO - no previously-included directories found matching 'docs/_build' 04:24:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:24:02 INFO - Running setup.py install for pep8 04:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:02 INFO - no previously-included directories found matching 'docs/_build' 04:24:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:24:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:24:02 INFO - Cleaning up... 04:24:02 INFO - Return code: 0 04:24:02 INFO - Running post-action listener: _resource_record_post_action 04:24:02 INFO - Running post-action listener: _start_resource_monitoring 04:24:02 INFO - Starting resource monitoring. 04:24:02 INFO - ##### 04:24:02 INFO - ##### Running install step. 04:24:02 INFO - ##### 04:24:02 INFO - Running pre-action listener: _resource_record_pre_action 04:24:02 INFO - Running main action method: install 04:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:03 INFO - Reading from file tmpfile_stdout 04:24:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:03 INFO - Reading from file tmpfile_stdout 04:24:03 INFO - Output received: 04:24:03 INFO - Usage: mozinstall [options] installer 04:24:03 INFO - Options: 04:24:03 INFO - -h, --help show this help message and exit 04:24:03 INFO - -d DEST, --destination=DEST 04:24:03 INFO - Directory to install application into. [default: 04:24:03 INFO - "/builds/slave/test"] 04:24:03 INFO - --app=APP Application being installed. [default: firefox] 04:24:03 INFO - mkdir: /builds/slave/test/build/application 04:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:24:17 INFO - Reading from file tmpfile_stdout 04:24:17 INFO - Output received: 04:24:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:17 INFO - Running post-action listener: _resource_record_post_action 04:24:17 INFO - ##### 04:24:17 INFO - ##### Running run-tests step. 04:24:17 INFO - ##### 04:24:17 INFO - Running pre-action listener: _resource_record_pre_action 04:24:17 INFO - Running main action method: run_tests 04:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:17 INFO - Python 2.7.3 04:24:17 INFO - Return code: 0 04:24:17 INFO - grabbing minidump binary from tooltool 04:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:17 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 0x2c020b0>, '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 0x2c02fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c03440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:24:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:24:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:17 INFO - Return code: 0 04:24:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:18 INFO - Return code: 0 04:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] in /builds/slave/test/build 04:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost 04:24:18 INFO - Using env: {'DISPLAY': ':0', 04:24:18 INFO - 'HOME': '/home/cltbld', 04:24:18 INFO - 'LANG': 'en_US.UTF-8', 04:24:18 INFO - 'LANGUAGE': 'en_US:en', 04:24:18 INFO - 'LOGNAME': 'cltbld', 04:24:18 INFO - 'MAIL': '/var/mail/cltbld', 04:24:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:18 INFO - 'MOZ_NO_REMOTE': '1', 04:24:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:18 INFO - 'NO_EM_RESTART': '1', 04:24:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:18 INFO - 'PWD': '/builds/slave/test', 04:24:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:18 INFO - 'SHELL': '/bin/bash', 04:24:18 INFO - 'SHLVL': '1', 04:24:18 INFO - 'TERM': 'linux', 04:24:18 INFO - 'TMOUT': '86400', 04:24:18 INFO - 'USER': 'cltbld', 04:24:18 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599', 04:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:18 INFO - '_': '/tools/buildbot/bin/python'} 04:24:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] with output_timeout 3600 04:24:19 INFO - mozversion INFO | application_buildid: 20151210030342 04:24:19 INFO - mozversion INFO | application_changeset: 986e6476df2cbe5f06ebdf2b18a207ab69200577 04:24:19 INFO - mozversion INFO | application_display_name: Nightly 04:24:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:19 INFO - mozversion INFO | application_name: Firefox 04:24:19 INFO - mozversion INFO | application_remotingname: firefox 04:24:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:24:19 INFO - mozversion INFO | application_vendor: Mozilla 04:24:19 INFO - mozversion INFO | application_version: 45.0a1 04:24:19 INFO - mozversion INFO | platform_buildid: 20151210030342 04:24:19 INFO - mozversion INFO | platform_changeset: 986e6476df2cbe5f06ebdf2b18a207ab69200577 04:24:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:24:19 INFO - mozversion INFO | platform_version: 45.0a1 04:24:19 INFO - 2015-12-10 04:24:19,056 DEBUG : using testdate: 1449750259 04:24:19 INFO - 2015-12-10 04:24:19,056 DEBUG : actual date: 1449750259 04:24:19 INFO - 2015-12-10 04:24:19,067 INFO : starting webserver on 'localhost:53124' 04:24:19 INFO - 2015-12-10 04:24:19,068 INFO : Starting test suite talos-linux64-ix-005.e 04:24:19 INFO - 2015-12-10 04:24:19,068 INFO : Starting test dromaeo_css 04:24:19 INFO - 2015-12-10 04:24:19,068 DEBUG : operating with platform_type : linux_ 04:24:19 INFO - 2015-12-10 04:24:19,069 INFO : Initialising browser for dromaeo_css test... 04:24:19 INFO - 2015-12-10 04:24:19,088 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjhHoa4/profile http://localhost:53124/getInfo.html 04:24:26 INFO - 2015-12-10 04:24:26,083 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:24:26 INFO - 2015-12-10 04:24:26,083 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:24:26 INFO - 2015-12-10 04:24:26,083 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:24:26 INFO - 2015-12-10 04:24:26,083 DEBUG : BROWSER_OUTPUT: __metrics 04:24:26 INFO - 2015-12-10 04:24:26,240 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] 04:24:27 INFO - 2015-12-10 04:24:27,572 INFO : Browser initialized. 04:24:27 INFO - 2015-12-10 04:24:27,572 INFO : Running cycle 1/1 for dromaeo_css test... 04:24:27 INFO - 2015-12-10 04:24:27,572 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjhHoa4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:24:39 INFO - 2015-12-10 04:24:39,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 143118336 04:24:39 INFO - 2015-12-10 04:24:39,576 DEBUG : BROWSER_OUTPUT: 04:25:29 INFO - 2015-12-10 04:25:29,189 DEBUG : BROWSER_OUTPUT: 1449750329185 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:27:40 INFO - 2015-12-10 04:27:40,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53124/tests/dromaeo/cssquery-ext.html) 04:27:42 INFO - 2015-12-10 04:27:42,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 146440192 04:27:42 INFO - 2015-12-10 04:27:42,147 DEBUG : BROWSER_OUTPUT: 04:30:44 INFO - 2015-12-10 04:30:44,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-ext.html (next: http://localhost:53124/tests/dromaeo/cssquery-jquery.html) 04:30:44 INFO - 2015-12-10 04:30:44,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 147410944 04:30:44 INFO - 2015-12-10 04:30:44,931 DEBUG : BROWSER_OUTPUT: 04:33:46 INFO - 2015-12-10 04:33:46,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53124/tests/dromaeo/cssquery-mootools.html) 04:33:47 INFO - 2015-12-10 04:33:47,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 145383424 04:33:47 INFO - 2015-12-10 04:33:47,385 DEBUG : BROWSER_OUTPUT: 04:36:49 INFO - 2015-12-10 04:36:49,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53124/tests/dromaeo/cssquery-prototype.html) 04:36:49 INFO - 2015-12-10 04:36:49,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 144797696 04:36:49 INFO - 2015-12-10 04:36:49,730 DEBUG : BROWSER_OUTPUT: 04:39:52 INFO - 2015-12-10 04:39:52,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53124/tests/dromaeo/cssquery-yui.html) 04:39:52 INFO - 2015-12-10 04:39:52,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 146001920 04:39:52 INFO - 2015-12-10 04:39:52,922 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/dromaeo/cssquery-yui.html (next: http://localhost:53124/tests/dromaeo/cssquery-dojo.html) 04:42:55 INFO - 2015-12-10 04:42:55,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 148037632 04:42:55 INFO - 2015-12-10 04:42:55,362 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,362 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:42:55 INFO - 2015-12-10 04:42:55,362 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:42:55 INFO - 2015-12-10 04:42:55,363 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:42:55 INFO - 2015-12-10 04:42:55,363 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:42:55 INFO - 2015-12-10 04:42:55,363 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2666.6666666666665;2705;2732.4535092981396;2735.20679003089;2759.1722483255016;4596.632269418446;4731.810727570893;4767.189577771778;4773.546513081256;4786.641001924857;4685.625149988001;4694.389729335182;4713.764311784405;4816.6869153504995;4819.493953134915;4356.86929392118;4384.057427653054;4430.26900561407;4444.799984000728;4468.4414448193975;4285.721428107178;4331.826726930919;4346.239408103585;4379.364992076147;4404.867853964386;4241.024564350186;4246;4343.087951530182;4350.3909452676335;4364.25807612705;4380.233459144637;4383.693141480097;4398;4404.383386325917;4424.646028317727;4375.408014272373;4380.956190438087;4389.056352884113;4425.181341451842;4450;4411.514733379326;4471.731696098244;4486.618637415823;4597.862064138081;4629.65277604181;5003.374578177728;5031.597472202252;5047.596192304607;5060.063888180698;5068.467810879878;4865.44047434546;5075.974620126913;5078.847634570969;5084.542391184774;5124.948750512522;4648.442186937556;4708.387909571734;4778.1399348116975;4780.784864681098;4829.66192366538;5191.97404012985;5229.6339256251695;5232.816851410183;5249.107651699221;5295.841124766263;4741.170295198326;4851.927221091686;5035.018171456531;5052.8484145475695;5059.266406371129;4988.12707776145;4995.575376093073;5018.723970181675;5077.847664570068;5094.694318340911;5049.495050494921;5072.695638261716;5073.949260507421;5084.49155084496;5142.5628821549835;4857.927131093036;5021.397432308147;5047.192449208109;5052.621053421009;5081.2632168335385;4079.1637714268504;4108.075682971307;4130.648894843912;4155.397467367215;4164.646005089541;3674.7427680062137;3681.263747250507;3701.8149092545264;3709.146896213886;3732.8320225589914;4287.57124287575;4341.891452713708;4363.890902727458;4427.22523558376;4452.710573812757;5068.594512438996;5078.7460626968505;5112.846614601568;5129.615278854101;5193;4420.403245561873;4421.248387774086;4438.334249862546;4447.177272204653;4463.620592249695;4298.183345164472;4406.669499787528;4429.357743127229;4498.347739577808;4540;4777.283407488904;4778.976105119452;4787.712737235777;4807.278908163873;4814.398200224972;5056.165732654071;5078.035173317058;5079.466656001215;5079.873003174803;5095.15929871567;4629.282461218517;4751.144793937125;4765.785539650793;4776.689515181502;4880.585150262125;4918.6065114791445;4958.677685950402;4958.925616115834;4964.950350496449;5005.624578156726;4864.270359446112;5042.773075211698;5043.773030213722;5053.494650534917;5091.032703786269;4763.595094417014;4781.665283430266;4783.6651434399255;4800.975995120002;4803.759812009455;4824.614030877451;4859.514048595112;4897.3878265216845;4899.265110233351;4903.362562866804;4805.975970120127;4831.396075490564;4843.975780121218;4856.955754512796;4893.951060489349;4910.754462276944;4942.901141977212;4960.330355401975;4960.925586116139;5026.271190677258;4686.531346865286;4772.308015337826;4809.639277054165;4872.415310162662;4872.707637541759 04:42:55 INFO - 2015-12-10 04:42:55,363 DEBUG : BROWSER_OUTPUT: |1;ext.html;507.21128644957076;510.96423250372465;523.7302789063632;526.2632314759334;529.6636635736309;33034.83482582587;33675.326493470115;33707.66292337076;33760.324793504114;33769.66230337696;37216.81391593038;37607.62392376075;37833.24333513328;37868.62131378692;37890.62109378912;7707.34487568556;7843.529388236696;7862.803429914241;7863.174366691501;7895.526268423884;7885;7943.72196973106;7967.760967170994;7970.202979702041;8002.719904803333;7949;7957.244061814147;7983.12185659577;8009.439339246255;8047.959760201191;7978.880316795253;8050.758477245692;8053.395995300347;8064.8387032259025;8081.4747041442115;7870.606469676493;8002.8799568006525;8014.67941282348;8026.719064832703;8039.839203215962;37614.43578346327;38115;38141;38203;38308.61691383078;3171.9682803171904;3201.8559164837407;3465.0297916583395;3696.168362118529;3727.1800203955086;28327.858360708065;28634.284142896387;28956.710432895612;29397.265068373246;29481.705182948324;3219.388316219911;3391.423458012119;3431.1079119428878;3465.462853257724;3501.1422201560526;217412;217574;218793;218964;219043;52839.73580132075;54077.24034495688;57730.13404798931;58120.709396452745;62610.68694656497;55598;56242.437575624535;56399.71800140973;56601.43398566044;56840.43159568351;12609.11736178477;12724.55464058772;12746.171498852545;12785.680357991125;12791.488340466463;8893.4663920165;8948.105189481;8951.149640784246;8960.372773905894;8964.68623598171;19236.8076319235;19522.609547808963;19598.70601940972;19607.607847842963;19838.60322793536;7682.313788588956;7868.370530357558;7884.4086693497065;7943.880841787378;8051.315638170704;848.5290663681593;859.4628357276702;876.088867577712;882.9161229683169;979.8334283171878;25989.610155847677;26244.60633090505;26331;26535.601965970527;26661.600075998875;930.134974473746;971.6647756523988;975.4342481360794;1000.1598657127902;1085.7231405991422;12759.61721148367;13024.283664398548;13222.537211197754;13250.602481925558;13281.40233689467;328531;333471;334762;335833;337114;48334.516654833;48514.514854851;49027.75486122547;49072;49170.50829491731;1204.0233453371413;1219.1283232488813;1222.1200735470447;1227.110344999868;1239.3679223596032;24641.260762177164;24920.252392428258;24957.87521062383;24989.750102498743;25107.24678259655;35569.82215088908;35673.28653426865;35889.82055089813;35921.46117808183;35983;251721;251745;252108;252636;253533;29752.256193595334;42468;42590.361144583476;42864;42926.78536607297;46345.536544634124;46354.76822615865;46855;46976.7651161742;47472.52527474681;32796.1800954978;32909.341813163126;33675.326493470486;34016.319673606886;34162.82918585391;33033;38021;40097;41601.79199103985;42811;34736.65263347334;34785.65214347824;35078.64921350754;35168.64831351654;35207.295854082266;35251.64748352586;35815.283694325444;36011;36375.81812090923;36484.45273320955;28415;28497.28756781097;28888.133355999355;28941.855290724256;29831.701682982894 04:42:55 INFO - 2015-12-10 04:42:55,363 DEBUG : BROWSER_OUTPUT: |2;jquery.html;269.5242896288052;272.5081228382771;273.464010539343;273.5609346998068;279.5415518549579;13351.198928064323;13657.180569165857;15061.246937653115;15498.302576384061;15611.609709757247;9931.553080111395;10161.745956351095;10193.592256309757;13196.670083247924;15788.44740434082;4510.548945105488;4608.193566125915;4644.744539050351;4651.813927442915;4652.511486293941;3227.7417806575536;3366.747493937952;4629.560191781776;5068.163752980754;5244.659097158691;5214.582833373321;5228.607854410915;5235.319408476893;5248.370195576536;5252.264682944391;5207.739613019353;5280.339957505312;5718.971405142989;5741.540676745892;5793.710314484301;5059.241113832918;5073.923891141636;5083.822066227664;5087.109755792721;5112.565431938289;10924.344539327665;11603.361815100166;11631.360275184861;11685.065194784482;11725.061995040376;1761.5243884151334;1771.9114044297733;1822.6172503774092;1852.981470185308;1855.870089093764;8563.871541926876;8807.427517211361;12688.36558172097;12721.491140354467;12723;1702.727563589832;1734.913254337278;1762.0837164674426;1787.8480329172037;1799.0195343537803;55182;57057.71471142659;57963.71018144924;58467;58490.70754646242;9438.858417123749;9528.904710952802;9694.079062489052;9726.513674316257;9830.21358291335;12188.024958003338;12223.572174973833;12233.632991010283;12236.449359778831;12289.385530723428;6593.967030164915;6600.405963463215;6665.366790154928;6670.166229221348;6691.063251144844;6135.570510064253;6139.324674285825;6171.352008039181;6171.382861713792;6182.721777520022;4038.9798051009557;4090.734102283342;4111.794410279534;4123.2165888481095;4132.442120313719;1602.8156761972523;1616.5473667373155;1642.1214650162105;1644.9506514804575;1695.4320302698734;849.5115308697524;876.1326286975848;918.93108016899;967.2842096848423;989.5547003848297;13426.462941482427;14796.408143674347;14812.963092583415;16035.19824008795;16254.106024168548;839.5802098950525;852.8933883264592;867.4058270085012;883.5891310540629;965.8602848638674;9101.863472047793;9309.301802364715;9367.531623418801;9402.388844725208;9581.993890641383;482559;482757;483933;495156;496061;69260.6536967312;69355.65322173356;69458.30541694518;70913.64543177251;71944.64027679933;1015.8882522922472;1020.2144348851491;1029.25893356783;1036.2849633752687;1038.08129805123;13628.523001694894;14488.985770995929;14635.268236587915;14659.04716193444;14735.115893046452;32358.35283294274;32386.190345240615;32514.83742581272;33045.67817287282;33388.499172512915;40775;40795;41371.379429307985;41486.58513414827;43596.34605480857;8388.70639527638;8768.605412756313;8800.427972181787;8805.1194880514;8813.030566637537;10125.443100629536;10202.38785672862;11661;15944.441944531885;15998.360065597246;10408.531616077144;10956.178286628694;12673.80989285143;12835.229886206858;12947.352632368533;13098.345082746015;13574.660633483847;13631.113977591425;13660.726785464434;13704.040717150103;13975.161490310615;13997.860021399656;14082.718345633235;14211.431542738175;14259.429622815385;8519.701810436853;8637.179467950535;8681.913180868363;8733.781655458664;8735.039145694096;13273.734525309634;13336.333183340601;13444;13574.321283935962;13693.246871422167 04:42:55 INFO - 2015-12-10 04:42:55,363 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1457.6064462595093;1649.3979697410446;1676.7317229243324;1708.5130737739746;1733.7746093007906;5594.636348637336;5916.733746981386;6732.990051492278;6971.058907047547;6978.267281935394;6696.933030669692;6864.176298844133;6924.23833378328;6939.4101501372315;7020.613866237355;2013.4362378533997;2028.8072633099832;2040.8979551022464;2052.8563000589966;2056.444759914822;2041.3365656161807;2095.21429463951;2097.685347197925;2098.192196004534;2100.054975261131;1980.1485361294638;2002.059032254845;2020;2027.979720202794;2028.0164120401594;2002.0690378973775;2003.4490515108316;2016.5865997470482;2026.996636664853;2030.1067530286628;1948.2109745553073;1951.1805041882444;2046.0383619698866;2050.7846676099093;2062.36066819285;6816.693248803816;6821.829454263683;6836;6914.723411063552;6917.27368626292;4103.117829666636;4147.854825081138;4161.854335098287;4174;4177.624013838769;2707.350235943379;2722.0881004863395;2743.341598016482;2769.4461107778525;2776.7500924916653;795.6220795122329;804.5936801915054;805.9556724380157;822.8230930349944;833.4874052457756;9214.447133171963;9248.16766491019;9256.611508273745;9260.536973151315;9281.953590232073;3724.72064595151;3764.6235376462682;3765.962340376616;3814.256220037066;3848.5766565677754;7989.680412783424;8013.398995075393;8013.719519816778;8022.037355517258;8096.797580060545;4125.133721918431;4126.442930204444;4126.91746165075;4136.937945930814;4138.6482149017065;3247.0908145719236;3342.8328583570724;3653.5250417446096;3752.6810221130963;3773.3208022555655;3269;3373.7469689773366;3382;3384.966150338514;3420.6921377075687;1064.9414282214552;1083.111848284415;1083.5557421457165;1092.819684752007;1098.9120870330355;938.3244064273712;958.0563145301873;960.7646126698863;1006.4213077480478;1222.9571964981183;6539.47684185264;6540.9345906541275;6550.344965503412;6599.538032337787;6602.438792702674;426.73755640281;432.0214713673532;1110.8778034416207;1116.932984020945;1134.3194083549804;5219.347581552306;5255.789768409298;5265.131253343156;5266.210068489757;5303.36359636846;8001.679932802739;8129;8200.753977380688;8318.292945099613;8401.117882622359;8253.215944485264;8290.378221633402;8304.211099945616;8306.293965012921;8308.792280192923;6251.156093927261;6608.140941677551;6660.433863121592;6678.666066696645;6695.029220762962;6497;6530.053142294436;6551.050097735706;6588.604683718992;6592.241892182268;7298.744543940937;7404.074490688664;7416.3325300721035;7472.514286571355;7477.626118694152;7601.88597171054;7642.1593624702355;7703.114141873756;7764.495307804975;7782.416318776228;5228.37259528859;5459.454054594509;6000.489958353589;6053.152558641882;6136.325004249618;6089.573729839046;6344.238691356882;6397.552171348148;6412.23053233615;6434.903476447951;5854.326752423355;5905.409459054232;5917.822465326047;6065.150878877049;6071.058985857199;5842.444967728059;6068.6358818471035;6158.353372895961;6165.537584681257;6174.104754810617;6061.848453788514;6099.054646529795;6298.08677741734;6319.58922670025;6321.367863213642;5861.736221869941;5873.177755114202;5877.911831322619;5887.764489420375;5892.292924849045;5801.680907550125;5807.7967271147;5861.208736820475;5879.559033072451;5893.263342082239 04:42:55 INFO - 2015-12-10 04:42:55,363 DEBUG : BROWSER_OUTPUT: |4;prototype.html;254.6282427655623;256.3872345095223;256.64198443171773;259.74934188508087;265.6506693697788;5534.612577119603;5619.7471113799875;5619.831405057845;5632.690202038886;5746.798862039829;5530.617345663584;5547.944520554804;5557.055300598898;5584.106542953128;5589.469000444961;4138.2758017347;4146.771927543984;4147.419361289422;4148.066684995867;4152.647025002879;4144.896377590554;4151.252774500589;4152.397902304179;4155.168966206771;4163.500379954395;3988.8205030773684;4069.7558146511155;4093.5292441369324;4096.815643296044;4109.712320137592;4091.3862920561855;4098.856540021085;4106.527749308838;4106.630403263705;4107.28122578549;3486.564179477565;3487.459443786217;3488.6162522122545;3492.580890293156;3492.7205823534055;5304.549113325334;5324.866878328073;5328.547073498718;5335.866603334909;5347.54545863602;4537.523560026183;4672.57946784791;4680.578747912704;4686.859394218179;4715.740634265114;5622.606417550773;5780.942190578083;5783.161441590988;5792.971035144839;5824.184614153979;3764.9834544672785;3765.3034188675183;3770.057485628593;3775.1505911170043;3778.112143646241;6073.301570319426;6137.662428566382;6147.569670123094;6150.04674275488;6155.538334624876;3812.8093595320124;3883.76697398157;3914.921701565953;3921.745086569364;3923.588023257574;3969.4442778011103;3969.8090572828037;3973.3443981743267;3975.045988962628;3982.900427489278;4675.064987002545;4676.883077923079;4681.438227412732;4690.882727931829;4692.859214223578;5816.360200377955;5828.271466066742;5833.912491312633;5848.502877255396;5849.883002340014;1384.3009280313377;1394.6792237785367;1410.330093205719;1410.6825964158188;1411.1744629391715;884.7080463447047;889.6041261638509;898.1512470715112;901.8466860633708;908.2280061947424;5100.4899510049445;5106.846794596094;5121.8463446096675;5122.974385128051;5124.538791508708;5995.760169593167;6004.969975150097;6043;6044.546659000593;6061.484773794277;5043.470435604282;5082.949170508322;5083.923741143886;5085.796568137233;5101.642884998088;3206.5190221466964;3240.6759324067875;3280.5899262592175;3283.146381940665;3314.121757734202;5796.362400135981;5804.651720896675;5807.651540907559;5808.244928159313;5813.128030795415;6335.778247761398;6361.395667411589;6365.077063825812;6365.840853978595;6368.872622547616;5598.440155984369;5767.452092051249;5771.94228057714;5775.797847075332;5802.187693722883;6098.75604975796;6128.448439640454;6129.570930034854;6133.080037994337;6153.446189842935;5992.910106348496;5999.610025348338;5999.790007349722;6000.519958403404;6019.6990150493175;5600.607957443103;5743.971280143573;5747.1379293106365;5763.279590051244;5776.740046697824;3806.3719486284454;3841.7887016214377;3841.8847434577006;3851.441540976599;3853.0367408147963;6128.601640893327;6132.754689812357;6135.11040899076;6135.815925522242;6137.171481849893;5871.031279838779;5886.58793884424;5887.116932460165;5901.173835663097;5915.319738230159;5736.885262294814;5867.647941123546;5873.177755114373;5875.441833025856;5880.411958804086;5751.539876809761;5754.4533269339345;5758.337791153904;5760.020796464527;5761;5896.764129434775;5911.970440147772;5913.172155898092;5914.881702366015;5924.437178468039;5660.490555849993;5742.483176514133;5759.280089988752;5769.423057694197;5776.7400466979925 04:42:55 INFO - 2015-12-10 04:42:55,364 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.279762053413;701.3372363116855;714.942804575634;765.6669348833258;797.4816369359919;11800.46897889595;11803.291802491856;11815.350155741431;11885.168038237327;11903.047756179496;11701.3564253966;11707.239029463079;11743.119266055037;11777.110390421614;11783.057355411567;619.1610367951429;625.9968700156493;788.3889985261411;789.7157023471574;804.6982381606897;798.3573223555036;806.8749343851683;807.2936180841764;808.458332916947;809.0938149272823;824.2458150792019;834.1741675741033;837.8031162676766;838.375410319313;842.3471809347774;827.4497459189631;829.2868133405267;829.5686243153586;830.9916900830975;833.9207775261341;610.8930937085992;612.773273888664;613.895637741585;614.5851550203595;616.2512547255062;11749.353785541793;11749.4712737927;11859.40702964857;11875.940620296844;11897.940510297392;11240;11986.160968732192;12108;12152.635420937386;12190;9194.172524472762;9207.861882071775;9309.953450232773;9318.440893546409;9326;3103.3948380065895;3181.1569933967517;3185.0922487091298;3185.5699480570056;3273.427150248721;37543;37925.43111853324;37958;38074.23851522954;38314.80842595797;8702.086280940537;9128.634854605874;9219.539023048821;9449.055094490495;9535.332526723201;15026.849731502545;15087.773683394758;15134.470293539673;15141.091534507965;15143.394264229308;6113.786017489367;6199.814005579839;6288.339724328879;6291.465225455796;6329.145565348711;3270.394976929228;3374.4600863861665;3397.3205358928312;3457.94813077804;3470.340635279289;2656.189862092042;2667.333166708323;2671.666041744782;2686.6104414859738;2704.851233182194;468.7937307584652;478.51430797740323;487.2788273355454;487.3226215560374;493.67910857941905;537.725759862473;551.3246273315157;555.9027170245191;574.7241324164424;582.913774441162;6974.58152510851;7289.416846652255;7309.817254568678;7419.962900185573;7441.776746697607;580.7241560258843;583.1077261773722;593.6586462783916;597.3220394851875;604.2899592978321;2940.7206315400003;3323.3685599735973;3605.3149901518627;3847.8076096195077;3892.922141557153;48167.75916120397;49132;49451;49539;49622.25566616504;43678.344824827655;43782.124357513305;44251.77874110673;44692.77653611711;44753.77623111864;39531.80234098869;40164.79917600393;40440.79779601142;40445.59554404477;41363.586364135976;7496.812579685551;7497.662605182671;7650.540967541965;7658.157602663591;7828.316911863976;31239.68760312368;31270.218244544067;31605.683943161195;31789;31917.6808231924;36688.449673255454;39494.60505394909;39707.40438893361;39757.60242397539;39821.40267895926;10022.699319020441;10076.748081298027;10112.59549618007;10196.4391958443;10221.59113635476;10291.433971131659;10417.322874013165;10639.734006649896;11134.832977505182;11242.269252498561;10358.948205258925;10906.34561926287;11010.483561117375;11091.44542772842;11106.666799996014;10238.12975897057;10645.414502202453;10792.838107428237;10880.782384352427;10979.945100274766;9984.251181161297;9998.750031249278;10381.792364152523;10408.947955260175;10506.106980906708;8783.736487905373;8866.42368246062;8869.866951995855;8903.554822258991;9050.049744776703;9048.50233237152;9191.402558833654;9199.310051746012;9285.86071208946;9387.765305867408 04:42:55 INFO - 2015-12-10 04:42:55,364 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:42:55 INFO - 2015-12-10 04:42:55,364 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,336 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: __startTimestamp1449751375356__endTimestamp 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,365 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4661.44 Median:4783.67 stddev:484.57 (10.1%) stddev-sans-first:460.10 04:42:55 INFO - 2015-12-10 04:42:55,366 DEBUG : BROWSER_OUTPUT: Values: 2666.7 2705.0 2732.5 2735.2 2759.2 4596.6 4731.8 4767.2 4773.5 4786.6 4685.6 4694.4 4713.8 4816.7 4819.5 4356.9 4384.1 4430.3 4444.8 4468.4 4285.7 4331.8 4346.2 4379.4 4404.9 4241.0 4246.0 4343.1 4350.4 4364.3 4380.2 4383.7 4398.0 4404.4 4424.6 4375.4 4381.0 4389.1 4425.2 4450.0 4411.5 4471.7 4486.6 4597.9 4629.7 5003.4 5031.6 5047.6 5060.1 5068.5 4865.4 5076.0 5078.8 5084.5 5124.9 4648.4 4708.4 4778.1 4780.8 4829.7 5192.0 5229.6 5232.8 5249.1 5295.8 4741.2 4851.9 5035.0 5052.8 5059.3 4988.1 4995.6 5018.7 5077.8 5094.7 5049.5 5072.7 5073.9 5084.5 5142.6 4857.9 5021.4 5047.2 5052.6 5081.3 4079.2 4108.1 4130.6 4155.4 4164.6 3674.7 3681.3 3701.8 3709.1 3732.8 4287.6 4341.9 4363.9 4427.2 4452.7 5068.6 5078.7 5112.8 5129.6 5193.0 4420.4 4421.2 4438.3 4447.2 4463.6 4298.2 4406.7 4429.4 4498.3 4540.0 4777.3 4779.0 4787.7 4807.3 4814.4 5056.2 5078.0 5079.5 5079.9 5095.2 4629.3 4751.1 4765.8 4776.7 4880.6 4918.6 4958.7 4958.9 4965.0 5005.6 4864.3 5042.8 5043.8 5053.5 5091.0 4763.6 4781.7 4783.7 4801.0 4803.8 4824.6 4859.5 4897.4 4899.3 4903.4 4806.0 4831.4 4844.0 4857.0 4894.0 4910.8 4942.9 4960.3 4960.9 5026.3 4686.5 4772.3 4809.6 4872.4 4872.7 04:42:55 INFO - 2015-12-10 04:42:55,366 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,366 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43451.17 Median:36430.14 stddev:71346.26 (195.8%) stddev-sans-first:71473.55 04:42:55 INFO - 2015-12-10 04:42:55,366 DEBUG : BROWSER_OUTPUT: Values: 507.2 511.0 523.7 526.3 529.7 33034.8 33675.3 33707.7 33760.3 33769.7 37216.8 37607.6 37833.2 37868.6 37890.6 7707.3 7843.5 7862.8 7863.2 7895.5 7885.0 7943.7 7967.8 7970.2 8002.7 7949.0 7957.2 7983.1 8009.4 8048.0 7978.9 8050.8 8053.4 8064.8 8081.5 7870.6 8002.9 8014.7 8026.7 8039.8 37614.4 38115.0 38141.0 38203.0 38308.6 3172.0 3201.9 3465.0 3696.2 3727.2 28327.9 28634.3 28956.7 29397.3 29481.7 3219.4 3391.4 3431.1 3465.5 3501.1 217412.0 217574.0 218793.0 218964.0 219043.0 52839.7 54077.2 57730.1 58120.7 62610.7 55598.0 56242.4 56399.7 56601.4 56840.4 12609.1 12724.6 12746.2 12785.7 12791.5 8893.5 8948.1 8951.1 8960.4 8964.7 19236.8 19522.6 19598.7 19607.6 19838.6 7682.3 7868.4 7884.4 7943.9 8051.3 848.5 859.5 876.1 882.9 979.8 25989.6 26244.6 26331.0 26535.6 26661.6 930.1 971.7 975.4 1000.2 1085.7 12759.6 13024.3 13222.5 13250.6 13281.4 328531.0 333471.0 334762.0 335833.0 337114.0 48334.5 48514.5 49027.8 49072.0 49170.5 1204.0 1219.1 1222.1 1227.1 1239.4 24641.3 24920.3 24957.9 24989.8 25107.2 35569.8 35673.3 35889.8 35921.5 35983.0 251721.0 251745.0 252108.0 252636.0 253533.0 29752.3 42468.0 42590.4 42864.0 42926.8 46345.5 46354.8 46855.0 46976.8 47472.5 32796.2 32909.3 33675.3 34016.3 34162.8 33033.0 38021.0 40097.0 41601.8 42811.0 34736.7 34785.7 35078.6 35168.6 35207.3 35251.6 35815.3 36011.0 36375.8 36484.5 28415.0 28497.3 28888.1 28941.9 29831.7 04:42:55 INFO - 2015-12-10 04:42:55,367 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,367 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25920.08 Median:40785.00 stddev:79763.91 (195.6%) stddev-sans-first:79964.41 04:42:55 INFO - 2015-12-10 04:42:55,367 DEBUG : BROWSER_OUTPUT: Values: 269.5 272.5 273.5 273.6 279.5 13351.2 13657.2 15061.2 15498.3 15611.6 9931.6 10161.7 10193.6 13196.7 15788.4 4510.5 4608.2 4644.7 4651.8 4652.5 3227.7 3366.7 4629.6 5068.2 5244.7 5214.6 5228.6 5235.3 5248.4 5252.3 5207.7 5280.3 5719.0 5741.5 5793.7 5059.2 5073.9 5083.8 5087.1 5112.6 10924.3 11603.4 11631.4 11685.1 11725.1 1761.5 1771.9 1822.6 1853.0 1855.9 8563.9 8807.4 12688.4 12721.5 12723.0 1702.7 1734.9 1762.1 1787.8 1799.0 55182.0 57057.7 57963.7 58467.0 58490.7 9438.9 9528.9 9694.1 9726.5 9830.2 12188.0 12223.6 12233.6 12236.4 12289.4 6594.0 6600.4 6665.4 6670.2 6691.1 6135.6 6139.3 6171.4 6171.4 6182.7 4039.0 4090.7 4111.8 4123.2 4132.4 1602.8 1616.5 1642.1 1645.0 1695.4 849.5 876.1 918.9 967.3 989.6 13426.5 14796.4 14813.0 16035.2 16254.1 839.6 852.9 867.4 883.6 965.9 9101.9 9309.3 9367.5 9402.4 9582.0 482559.0 482757.0 483933.0 495156.0 496061.0 69260.7 69355.7 69458.3 70913.6 71944.6 1015.9 1020.2 1029.3 1036.3 1038.1 13628.5 14489.0 14635.3 14659.0 14735.1 32358.4 32386.2 32514.8 33045.7 33388.5 40775.0 40795.0 41371.4 41486.6 43596.3 8388.7 8768.6 8800.4 8805.1 8813.0 10125.4 10202.4 11661.0 15944.4 15998.4 10408.5 10956.2 12673.8 12835.2 12947.4 13098.3 13574.7 13631.1 13660.7 13704.0 13975.2 13997.9 14082.7 14211.4 14259.4 8519.7 8637.2 8681.9 8733.8 8735.0 13273.7 13336.3 13444.0 13574.3 13693.2 04:42:55 INFO - 2015-12-10 04:42:55,367 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,367 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4817.92 Median:5892.78 stddev:2474.24 (42.0%) stddev-sans-first:2468.29 04:42:55 INFO - 2015-12-10 04:42:55,368 DEBUG : BROWSER_OUTPUT: Values: 1457.6 1649.4 1676.7 1708.5 1733.8 5594.6 5916.7 6733.0 6971.1 6978.3 6696.9 6864.2 6924.2 6939.4 7020.6 2013.4 2028.8 2040.9 2052.9 2056.4 2041.3 2095.2 2097.7 2098.2 2100.1 1980.1 2002.1 2020.0 2028.0 2028.0 2002.1 2003.4 2016.6 2027.0 2030.1 1948.2 1951.2 2046.0 2050.8 2062.4 6816.7 6821.8 6836.0 6914.7 6917.3 4103.1 4147.9 4161.9 4174.0 4177.6 2707.4 2722.1 2743.3 2769.4 2776.8 795.6 804.6 806.0 822.8 833.5 9214.4 9248.2 9256.6 9260.5 9282.0 3724.7 3764.6 3766.0 3814.3 3848.6 7989.7 8013.4 8013.7 8022.0 8096.8 4125.1 4126.4 4126.9 4136.9 4138.6 3247.1 3342.8 3653.5 3752.7 3773.3 3269.0 3373.7 3382.0 3385.0 3420.7 1064.9 1083.1 1083.6 1092.8 1098.9 938.3 958.1 960.8 1006.4 1223.0 6539.5 6540.9 6550.3 6599.5 6602.4 426.7 432.0 1110.9 1116.9 1134.3 5219.3 5255.8 5265.1 5266.2 5303.4 8001.7 8129.0 8200.8 8318.3 8401.1 8253.2 8290.4 8304.2 8306.3 8308.8 6251.2 6608.1 6660.4 6678.7 6695.0 6497.0 6530.1 6551.1 6588.6 6592.2 7298.7 7404.1 7416.3 7472.5 7477.6 7601.9 7642.2 7703.1 7764.5 7782.4 5228.4 5459.5 6000.5 6053.2 6136.3 6089.6 6344.2 6397.6 6412.2 6434.9 5854.3 5905.4 5917.8 6065.2 6071.1 5842.4 6068.6 6158.4 6165.5 6174.1 6061.8 6099.1 6298.1 6319.6 6321.4 5861.7 5873.2 5877.9 5887.8 5892.3 5801.7 5807.8 5861.2 5879.6 5893.3 04:42:55 INFO - 2015-12-10 04:42:55,368 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,368 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4781.32 Median:5593.95 stddev:1489.38 (26.6%) stddev-sans-first:1454.28 04:42:55 INFO - 2015-12-10 04:42:55,368 DEBUG : BROWSER_OUTPUT: Values: 254.6 256.4 256.6 259.7 265.7 5534.6 5619.7 5619.8 5632.7 5746.8 5530.6 5547.9 5557.1 5584.1 5589.5 4138.3 4146.8 4147.4 4148.1 4152.6 4144.9 4151.3 4152.4 4155.2 4163.5 3988.8 4069.8 4093.5 4096.8 4109.7 4091.4 4098.9 4106.5 4106.6 4107.3 3486.6 3487.5 3488.6 3492.6 3492.7 5304.5 5324.9 5328.5 5335.9 5347.5 4537.5 4672.6 4680.6 4686.9 4715.7 5622.6 5780.9 5783.2 5793.0 5824.2 3765.0 3765.3 3770.1 3775.2 3778.1 6073.3 6137.7 6147.6 6150.0 6155.5 3812.8 3883.8 3914.9 3921.7 3923.6 3969.4 3969.8 3973.3 3975.0 3982.9 4675.1 4676.9 4681.4 4690.9 4692.9 5816.4 5828.3 5833.9 5848.5 5849.9 1384.3 1394.7 1410.3 1410.7 1411.2 884.7 889.6 898.2 901.8 908.2 5100.5 5106.8 5121.8 5123.0 5124.5 5995.8 6005.0 6043.0 6044.5 6061.5 5043.5 5082.9 5083.9 5085.8 5101.6 3206.5 3240.7 3280.6 3283.1 3314.1 5796.4 5804.7 5807.7 5808.2 5813.1 6335.8 6361.4 6365.1 6365.8 6368.9 5598.4 5767.5 5771.9 5775.8 5802.2 6098.8 6128.4 6129.6 6133.1 6153.4 5992.9 5999.6 5999.8 6000.5 6019.7 5600.6 5744.0 5747.1 5763.3 5776.7 3806.4 3841.8 3841.9 3851.4 3853.0 6128.6 6132.8 6135.1 6135.8 6137.2 5871.0 5886.6 5887.1 5901.2 5915.3 5736.9 5867.6 5873.2 5875.4 5880.4 5751.5 5754.5 5758.3 5760.0 5761.0 5896.8 5912.0 5913.2 5914.9 5924.4 5660.5 5742.5 5759.3 5769.4 5776.7 04:42:55 INFO - 2015-12-10 04:42:55,368 DEBUG : BROWSER_OUTPUT: 04:42:55 INFO - 2015-12-10 04:42:55,368 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12064.35 Median:44472.28 stddev:13590.05 (30.6%) stddev-sans-first:13601.26 04:42:55 INFO - 2015-12-10 04:42:55,368 DEBUG : BROWSER_OUTPUT: Values: 676.3 701.3 714.9 765.7 797.5 11800.5 11803.3 11815.4 11885.2 11903.0 11701.4 11707.2 11743.1 11777.1 11783.1 619.2 626.0 788.4 789.7 804.7 798.4 806.9 807.3 808.5 809.1 824.2 834.2 837.8 838.4 842.3 827.4 829.3 829.6 831.0 833.9 610.9 612.8 613.9 614.6 616.3 11749.4 11749.5 11859.4 11875.9 11897.9 11240.0 11986.2 12108.0 12152.6 12190.0 9194.2 9207.9 9310.0 9318.4 9326.0 3103.4 3181.2 3185.1 3185.6 3273.4 37543.0 37925.4 37958.0 38074.2 38314.8 8702.1 9128.6 9219.5 9449.1 9535.3 15026.8 15087.8 15134.5 15141.1 15143.4 6113.8 6199.8 6288.3 6291.5 6329.1 3270.4 3374.5 3397.3 3457.9 3470.3 2656.2 2667.3 2671.7 2686.6 2704.9 468.8 478.5 487.3 487.3 493.7 537.7 551.3 555.9 574.7 582.9 6974.6 7289.4 7309.8 7420.0 7441.8 580.7 583.1 593.7 597.3 604.3 2940.7 3323.4 3605.3 3847.8 3892.9 48167.8 49132.0 49451.0 49539.0 49622.3 43678.3 43782.1 44251.8 44692.8 44753.8 39531.8 40164.8 40440.8 40445.6 41363.6 7496.8 7497.7 7650.5 7658.2 7828.3 31239.7 31270.2 31605.7 31789.0 31917.7 36688.4 39494.6 39707.4 39757.6 39821.4 10022.7 10076.7 10112.6 10196.4 10221.6 10291.4 10417.3 10639.7 11134.8 11242.3 10358.9 10906.3 11010.5 11091.4 11106.7 10238.1 10645.4 10792.8 10880.8 10979.9 9984.3 9998.8 10381.8 10408.9 10506.1 8783.7 8866.4 8869.9 8903.6 9050.0 9048.5 9191.4 9199.3 9285.9 9387.8 04:42:55 INFO - 2015-12-10 04:42:55,369 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:42:55 INFO - 2015-12-10 04:42:55,369 DEBUG : BROWSER_OUTPUT: 04:42:56 INFO - 2015-12-10 04:42:56,112 INFO : Browser exited with error code: 0 04:42:56 INFO - 2015-12-10 04:42:56,136 INFO : Completed test dromaeo_css (00:18:37) 04:42:56 INFO - 2015-12-10 04:42:56,136 INFO : Starting test kraken 04:42:56 INFO - 2015-12-10 04:42:56,136 DEBUG : operating with platform_type : linux_ 04:42:56 INFO - 2015-12-10 04:42:56,136 INFO : Initialising browser for kraken test... 04:42:56 INFO - 2015-12-10 04:42:56,142 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYyMLVU/profile http://localhost:53124/getInfo.html 04:43:00 INFO - 2015-12-10 04:43:00,663 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:43:00 INFO - 2015-12-10 04:43:00,664 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:43:00 INFO - 2015-12-10 04:43:00,664 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:43:00 INFO - 2015-12-10 04:43:00,664 DEBUG : BROWSER_OUTPUT: __metrics 04:43:00 INFO - 2015-12-10 04:43:00,792 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] 04:43:01 INFO - 2015-12-10 04:43:01,672 INFO : Browser initialized. 04:43:01 INFO - 2015-12-10 04:43:01,672 INFO : Running cycle 1/1 for kraken test... 04:43:01 INFO - 2015-12-10 04:43:01,673 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYyMLVU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:43:13 INFO - 2015-12-10 04:43:13,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 143794176 04:43:13 INFO - 2015-12-10 04:43:13,699 DEBUG : BROWSER_OUTPUT: 04:43:16 INFO - 2015-12-10 04:43:16,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:16 INFO - 2015-12-10 04:43:16,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 144252928 04:43:16 INFO - 2015-12-10 04:43:16,928 DEBUG : BROWSER_OUTPUT: 04:43:19 INFO - 2015-12-10 04:43:19,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-dft) 04:43:20 INFO - 2015-12-10 04:43:20,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 142999552 04:43:20 INFO - 2015-12-10 04:43:20,280 DEBUG : BROWSER_OUTPUT: 04:43:23 INFO - 2015-12-10 04:43:23,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-fft) 04:43:23 INFO - 2015-12-10 04:43:23,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 139063296 04:43:23 INFO - 2015-12-10 04:43:23,777 DEBUG : BROWSER_OUTPUT: 04:43:25 INFO - 2015-12-10 04:43:25,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53124/tests/kraken/driver.html?testName=audio-oscillator) 04:43:26 INFO - 2015-12-10 04:43:26,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 139898880 04:43:26 INFO - 2015-12-10 04:43:26,457 DEBUG : BROWSER_OUTPUT: 04:43:28 INFO - 2015-12-10 04:43:28,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:29 INFO - 2015-12-10 04:43:29,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 140812288 04:43:29 INFO - 2015-12-10 04:43:29,296 DEBUG : BROWSER_OUTPUT: 04:43:32 INFO - 2015-12-10 04:43:32,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53124/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:32 INFO - 2015-12-10 04:43:32,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 140140544 04:43:32 INFO - 2015-12-10 04:43:32,983 DEBUG : BROWSER_OUTPUT: 04:43:36 INFO - 2015-12-10 04:43:36,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53124/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:37 INFO - 2015-12-10 04:43:37,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 138432512 04:43:37 INFO - 2015-12-10 04:43:37,041 DEBUG : BROWSER_OUTPUT: 04:43:39 INFO - 2015-12-10 04:43:39,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53124/tests/kraken/driver.html?testName=json-parse-financial) 04:43:40 INFO - 2015-12-10 04:43:40,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 138194944 04:43:40 INFO - 2015-12-10 04:43:40,548 DEBUG : BROWSER_OUTPUT: 04:43:42 INFO - 2015-12-10 04:43:42,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:42 INFO - 2015-12-10 04:43:42,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 141115392 04:43:42 INFO - 2015-12-10 04:43:42,935 DEBUG : BROWSER_OUTPUT: 04:43:44 INFO - 2015-12-10 04:43:44,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:45 INFO - 2015-12-10 04:43:45,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 141361152 04:43:45 INFO - 2015-12-10 04:43:45,445 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-10 04:43:47,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:48 INFO - 2015-12-10 04:43:48,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 141373440 04:43:48 INFO - 2015-12-10 04:43:48,261 DEBUG : BROWSER_OUTPUT: 04:43:50 INFO - 2015-12-10 04:43:50,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:51 INFO - 2015-12-10 04:43:51,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 139567104 04:43:51 INFO - 2015-12-10 04:43:51,409 DEBUG : BROWSER_OUTPUT: 04:43:54 INFO - 2015-12-10 04:43:54,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:54 INFO - 2015-12-10 04:43:54,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 139976704 04:43:54 INFO - 2015-12-10 04:43:54,665 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53124/tests/kraken/driver.html?testName=ai-astar) 04:43:56 INFO - 2015-12-10 04:43:56,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 04:43:56 INFO - 2015-12-10 04:43:56,705 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,705 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;110;116;113;113;126;113;115;114;113 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;138;154;169;127;158;155;136;169;138 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;162;165;165;166;161;165;163 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;79;72;72;138;79;91;78;73 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;141;94;95;94;134;94;95;129 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;110;110;111;110;109 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;146;147;147;149;147;147;149 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;95;96;96;99;96;96 04:43:56 INFO - 2015-12-10 04:43:56,706 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;75;73;75;74;74;73;76;87 04:43:56 INFO - 2015-12-10 04:43:56,707 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;68;68;67;69;68;68 04:43:56 INFO - 2015-12-10 04:43:56,707 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;87;96;86;85;90;85;85;94;83 04:43:56 INFO - 2015-12-10 04:43:56,707 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;128;122;125;121;128;133;130;125;123 04:43:56 INFO - 2015-12-10 04:43:56,707 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;157;151;150;152;139;155;149;150;141 04:43:56 INFO - 2015-12-10 04:43:56,707 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;70;72;72;70;90;70;70;75 04:43:56 INFO - 2015-12-10 04:43:56,707 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:43:56 INFO - 2015-12-10 04:43:56,707 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:43:56 INFO - 2015-12-10 04:43:56,708 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,811 04:43:56 INFO - 2015-12-10 04:43:56,708 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:43:56 INFO - 2015-12-10 04:43:56,708 DEBUG : BROWSER_OUTPUT: __startTimestamp1449751436704__endTimestamp 04:43:56 INFO - 2015-12-10 04:43:56,708 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:4.28 (3.7%) stddev-sans-first:4.52 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: Values: 116.0 110.0 116.0 113.0 113.0 126.0 113.0 115.0 114.0 113.0 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.50 stddev:14.36 (9.3%) stddev-sans-first:15.15 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: Values: 154.0 138.0 154.0 169.0 127.0 158.0 155.0 136.0 169.0 138.0 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.71 (1.0%) stddev-sans-first:1.74 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 162.0 165.0 165.0 166.0 161.0 165.0 163.0 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:20.14 (26.3%) stddev-sans-first:21.04 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 79.0 72.0 72.0 138.0 79.0 91.0 78.0 73.0 04:43:56 INFO - 2015-12-10 04:43:56,716 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:94.00 stddev:19.72 (21.0%) stddev-sans-first:20.39 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 141.0 94.0 95.0 94.0 134.0 94.0 95.0 129.0 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 109.0 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 146.0 147.0 147.0 149.0 147.0 147.0 149.0 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.15 (1.2%) stddev-sans-first:1.17 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 99.0 96.0 96.0 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.60 Median:75.00 stddev:4.12 (5.5%) stddev-sans-first:4.32 04:43:56 INFO - 2015-12-10 04:43:56,717 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 75.0 73.0 75.0 74.0 74.0 73.0 76.0 87.0 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 68.0 68.0 67.0 69.0 68.0 68.0 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.50 stddev:4.40 (5.1%) stddev-sans-first:4.48 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 96.0 86.0 85.0 90.0 85.0 85.0 94.0 83.0 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.50 stddev:3.74 (2.9%) stddev-sans-first:3.95 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: Values: 127.0 128.0 122.0 125.0 121.0 128.0 133.0 130.0 125.0 123.0 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,718 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:151.50 stddev:5.62 (3.7%) stddev-sans-first:5.89 04:43:56 INFO - 2015-12-10 04:43:56,719 DEBUG : BROWSER_OUTPUT: Values: 152.0 157.0 151.0 150.0 152.0 139.0 155.0 149.0 150.0 141.0 04:43:56 INFO - 2015-12-10 04:43:56,719 DEBUG : BROWSER_OUTPUT: 04:43:56 INFO - 2015-12-10 04:43:56,719 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:71.50 stddev:6.14 (8.6%) stddev-sans-first:6.46 04:43:56 INFO - 2015-12-10 04:43:56,719 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 72.0 72.0 70.0 90.0 70.0 70.0 75.0 04:43:56 INFO - 2015-12-10 04:43:56,719 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:43:56 INFO - 2015-12-10 04:43:56,719 DEBUG : BROWSER_OUTPUT: 04:43:57 INFO - 2015-12-10 04:43:57,604 INFO : Browser exited with error code: 0 04:43:57 INFO - 2015-12-10 04:43:57,652 INFO : Completed test kraken (00:01:01) 04:43:57 INFO - 2015-12-10 04:43:57,652 INFO : Starting test v8_7 04:43:57 INFO - 2015-12-10 04:43:57,653 DEBUG : operating with platform_type : linux_ 04:43:57 INFO - 2015-12-10 04:43:57,653 INFO : Initialising browser for v8_7 test... 04:43:57 INFO - 2015-12-10 04:43:57,659 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYChTRi/profile http://localhost:53124/getInfo.html 04:44:02 INFO - 2015-12-10 04:44:02,248 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:44:02 INFO - 2015-12-10 04:44:02,248 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:44:02 INFO - 2015-12-10 04:44:02,248 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:44:02 INFO - 2015-12-10 04:44:02,248 DEBUG : BROWSER_OUTPUT: __metrics 04:44:02 INFO - 2015-12-10 04:44:02,377 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] 04:44:03 INFO - 2015-12-10 04:44:03,236 INFO : Browser initialized. 04:44:03 INFO - 2015-12-10 04:44:03,236 INFO : Running cycle 1/1 for v8_7 test... 04:44:03 INFO - 2015-12-10 04:44:03,237 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYChTRi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:44:15 INFO - 2015-12-10 04:44:15,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 142921728 04:44:15 INFO - 2015-12-10 04:44:15,263 DEBUG : BROWSER_OUTPUT: 04:44:36 INFO - 2015-12-10 04:44:36,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53124/tests/v8_7/run.html (next: http://localhost:53124/tests/v8_7/run.html) 04:44:37 INFO - 2015-12-10 04:44:37,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 138465280 04:44:37 INFO - 2015-12-10 04:44:37,030 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,031 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:44:37 INFO - 2015-12-10 04:44:37,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:44:37 INFO - 2015-12-10 04:44:37,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:44:37 INFO - 2015-12-10 04:44:37,031 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:44:37 INFO - 2015-12-10 04:44:37,031 DEBUG : BROWSER_OUTPUT: |0;Richards;166.58337497917708 04:44:37 INFO - 2015-12-10 04:44:37,031 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.2881230313137 04:44:37 INFO - 2015-12-10 04:44:37,031 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 04:44:37 INFO - 2015-12-10 04:44:37,032 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 04:44:37 INFO - 2015-12-10 04:44:37,032 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1048.2180293501049 04:44:37 INFO - 2015-12-10 04:44:37,032 DEBUG : BROWSER_OUTPUT: |5;Earley;725.1631617113851 04:44:37 INFO - 2015-12-10 04:44:37,032 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 04:44:37 INFO - 2015-12-10 04:44:37,032 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 04:44:37 INFO - 2015-12-10 04:44:37,032 DEBUG : BROWSER_OUTPUT: |8;Splay;610.1281269066504 04:44:37 INFO - 2015-12-10 04:44:37,032 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: __startTimestamp1449751477024__endTimestamp 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.58 Median:166.58 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,033 DEBUG : BROWSER_OUTPUT: Values: 166.6 04:44:37 INFO - 2015-12-10 04:44:37,034 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,034 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.29 Median:185.29 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,034 DEBUG : BROWSER_OUTPUT: Values: 185.3 04:44:37 INFO - 2015-12-10 04:44:37,034 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,034 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,034 DEBUG : BROWSER_OUTPUT: Values: 277.8 04:44:37 INFO - 2015-12-10 04:44:37,034 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: Values: 5208.3 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1048.22 Median:1048.22 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: Values: 1048.2 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:725.16 Median:725.16 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,035 DEBUG : BROWSER_OUTPUT: Values: 725.2 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: Values: 12256.1 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: Values: 26000.0 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.13 Median:610.13 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: Values: 610.1 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: Values: 4835.7 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:44:37 INFO - 2015-12-10 04:44:37,036 DEBUG : BROWSER_OUTPUT: 04:44:37 INFO - 2015-12-10 04:44:37,948 INFO : Browser exited with error code: 0 04:44:37 INFO - 2015-12-10 04:44:37,962 INFO : Completed test v8_7 (00:00:40) 04:44:38 INFO - 2015-12-10 04:44:38,020 INFO : Completed test suite (00:20:18) 04:44:38 INFO - 2015-12-10 04:44:38,020 DEBUG : Working with test: dromaeo_css 04:44:38 INFO - 2015-12-10 04:44:38,020 DEBUG : Generating results file: dromaeo_css 04:44:38 INFO - 2015-12-10 04:44:38,021 DEBUG : Working with test: kraken 04:44:38 INFO - 2015-12-10 04:44:38,022 DEBUG : Generating results file: kraken 04:44:38 INFO - 2015-12-10 04:44:38,022 INFO : javascript benchmark 04:44:38 INFO - 2015-12-10 04:44:38,022 DEBUG : Working with test: v8_7 04:44:38 INFO - 2015-12-10 04:44:38,022 DEBUG : Generating results file: v8_7 04:44:38 INFO - 2015-12-10 04:44:38,022 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:44:38 INFO - 2015-12-10 04:44:38,066 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:44:38 INFO - 2015-12-10 04:44:38,066 DEBUG : process_Request line: dromaeo_css 6275.95 graph.html#tests=[[72,94,43]] 04:44:38 INFO - 2015-12-10 04:44:38,066 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:44:38 INFO - 2015-12-10 04:44:38,095 DEBUG : process_Request line: kraken 1551.20 graph.html#tests=[[232,94,43]] 04:44:38 INFO - 2015-12-10 04:44:38,095 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:44:38 INFO - 2015-12-10 04:44:38,124 DEBUG : process_Request line: v8_7 21335.50 graph.html#tests=[[230,94,43]] 04:44:38 INFO - 2015-12-10 04:44:38,125 INFO : javascript benchmark 04:44:38 INFO - 2015-12-10 04:44:38,129 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2666.6666666666665, 2705.0, 2732.4535092981396, 2735.20679003089, 2759.1722483255016, 4596.632269418446, 4731.810727570893, 4767.189577771778, 4773.546513081256, 4786.641001924857, 4685.625149988001, 4694.389729335182, 4713.764311784405, 4816.6869153504995, 4819.493953134915, 4356.86929392118, 4384.057427653054, 4430.26900561407, 4444.799984000728, 4468.4414448193975, 4285.721428107178, 4331.826726930919, 4346.239408103585, 4379.364992076147, 4404.867853964386, 4241.024564350186, 4246.0, 4343.087951530182, 4350.3909452676335, 4364.25807612705, 4380.233459144637, 4383.693141480097, 4398.0, 4404.383386325917, 4424.646028317727, 4375.408014272373, 4380.956190438087, 4389.056352884113, 4425.181341451842, 4450.0, 4411.514733379326, 4471.731696098244, 4486.618637415823, 4597.862064138081, 4629.65277604181, 5003.374578177728, 5031.597472202252, 5047.596192304607, 5060.063888180698, 5068.467810879878, 4865.44047434546, 5075.974620126913, 5078.847634570969, 5084.542391184774, 5124.948750512522, 4648.442186937556, 4708.387909571734, 4778.1399348116975, 4780.784864681098, 4829.66192366538, 5191.97404012985, 5229.6339256251695, 5232.816851410183, 5249.107651699221, 5295.841124766263, 4741.170295198326, 4851.927221091686, 5035.018171456531, 5052.8484145475695, 5059.266406371129, 4988.12707776145, 4995.575376093073, 5018.723970181675, 5077.847664570068, 5094.694318340911, 5049.495050494921, 5072.695638261716, 5073.949260507421, 5084.49155084496, 5142.5628821549835, 4857.927131093036, 5021.397432308147, 5047.192449208109, 5052.621053421009, 5081.2632168335385, 4079.1637714268504, 4108.075682971307, 4130.648894843912, 4155.397467367215, 4164.646005089541, 3674.7427680062137, 3681.263747250507, 3701.8149092545264, 3709.146896213886, 3732.8320225589914, 4287.57124287575, 4341.891452713708, 4363.890902727458, 4427.22523558376, 4452.710573812757, 5068.594512438996, 5078.7460626968505, 5112.846614601568, 5129.615278854101, 5193.0, 4420.403245561873, 4421.248387774086, 4438.334249862546, 4447.177272204653, 4463.620592249695, 4298.183345164472, 4406.669499787528, 4429.357743127229, 4498.347739577808, 4540.0, 4777.283407488904, 4778.976105119452, 4787.712737235777, 4807.278908163873, 4814.398200224972, 5056.165732654071, 5078.035173317058, 5079.466656001215, 5079.873003174803, 5095.15929871567, 4629.282461218517, 4751.144793937125, 4765.785539650793, 4776.689515181502, 4880.585150262125, 4918.6065114791445, 4958.677685950402, 4958.925616115834, 4964.950350496449, 5005.624578156726, 4864.270359446112, 5042.773075211698, 5043.773030213722, 5053.494650534917, 5091.032703786269, 4763.595094417014, 4781.665283430266, 4783.6651434399255, 4800.975995120002, 4803.759812009455, 4824.614030877451, 4859.514048595112, 4897.3878265216845, 4899.265110233351, 4903.362562866804, 4805.975970120127, 4831.396075490564, 4843.975780121218, 4856.955754512796, 4893.951060489349, 4910.754462276944, 4942.901141977212, 4960.330355401975, 4960.925586116139, 5026.271190677258, 4686.531346865286, 4772.308015337826, 4809.639277054165, 4872.415310162662, 4872.707637541759], "unit": "ms", "name": "dojo.html", "value": 4631.5094173726875}, {"lowerIsBetter": false, "replicates": [507.21128644957076, 510.96423250372465, 523.7302789063632, 526.2632314759334, 529.6636635736309, 33034.83482582587, 33675.326493470115, 33707.66292337076, 33760.324793504114, 33769.66230337696, 37216.81391593038, 37607.62392376075, 37833.24333513328, 37868.62131378692, 37890.62109378912, 7707.34487568556, 7843.529388236696, 7862.803429914241, 7863.174366691501, 7895.526268423884, 7885.0, 7943.72196973106, 7967.760967170994, 7970.202979702041, 8002.719904803333, 7949.0, 7957.244061814147, 7983.12185659577, 8009.439339246255, 8047.959760201191, 7978.880316795253, 8050.758477245692, 8053.395995300347, 8064.8387032259025, 8081.4747041442115, 7870.606469676493, 8002.8799568006525, 8014.67941282348, 8026.719064832703, 8039.839203215962, 37614.43578346327, 38115.0, 38141.0, 38203.0, 38308.61691383078, 3171.9682803171904, 3201.8559164837407, 3465.0297916583395, 3696.168362118529, 3727.1800203955086, 28327.858360708065, 28634.284142896387, 28956.710432895612, 29397.265068373246, 29481.705182948324, 3219.388316219911, 3391.423458012119, 3431.1079119428878, 3465.462853257724, 3501.1422201560526, 217412.0, 217574.0, 218793.0, 218964.0, 219043.0, 52839.73580132075, 54077.24034495688, 57730.13404798931, 58120.709396452745, 62610.68694656497, 55598.0, 56242.437575624535, 56399.71800140973, 56601.43398566044, 56840.43159568351, 12609.11736178477, 12724.55464058772, 12746.171498852545, 12785.680357991125, 12791.488340466463, 8893.4663920165, 8948.105189481, 8951.149640784246, 8960.372773905894, 8964.68623598171, 19236.8076319235, 19522.609547808963, 19598.70601940972, 19607.607847842963, 19838.60322793536, 7682.313788588956, 7868.370530357558, 7884.4086693497065, 7943.880841787378, 8051.315638170704, 848.5290663681593, 859.4628357276702, 876.088867577712, 882.9161229683169, 979.8334283171878, 25989.610155847677, 26244.60633090505, 26331.0, 26535.601965970527, 26661.600075998875, 930.134974473746, 971.6647756523988, 975.4342481360794, 1000.1598657127902, 1085.7231405991422, 12759.61721148367, 13024.283664398548, 13222.537211197754, 13250.602481925558, 13281.40233689467, 328531.0, 333471.0, 334762.0, 335833.0, 337114.0, 48334.516654833, 48514.514854851, 49027.75486122547, 49072.0, 49170.50829491731, 1204.0233453371413, 1219.1283232488813, 1222.1200735470447, 1227.110344999868, 1239.3679223596032, 24641.260762177164, 24920.252392428258, 24957.87521062383, 24989.750102498743, 25107.24678259655, 35569.82215088908, 35673.28653426865, 35889.82055089813, 35921.46117808183, 35983.0, 251721.0, 251745.0, 252108.0, 252636.0, 253533.0, 29752.256193595334, 42468.0, 42590.361144583476, 42864.0, 42926.78536607297, 46345.536544634124, 46354.76822615865, 46855.0, 46976.7651161742, 47472.52527474681, 32796.1800954978, 32909.341813163126, 33675.326493470486, 34016.319673606886, 34162.82918585391, 33033.0, 38021.0, 40097.0, 41601.79199103985, 42811.0, 34736.65263347334, 34785.65214347824, 35078.64921350754, 35168.64831351654, 35207.295854082266, 35251.64748352586, 35815.283694325444, 36011.0, 36375.81812090923, 36484.45273320955, 28415.0, 28497.28756781097, 28888.133355999355, 28941.855290724256, 29831.701682982894], "unit": "ms", "name": "ext.html", "value": 17352.947297614915}, {"lowerIsBetter": false, "replicates": [269.5242896288052, 272.5081228382771, 273.464010539343, 273.5609346998068, 279.5415518549579, 13351.198928064323, 13657.180569165857, 15061.246937653115, 15498.302576384061, 15611.609709757247, 9931.553080111395, 10161.745956351095, 10193.592256309757, 13196.670083247924, 15788.44740434082, 4510.548945105488, 4608.193566125915, 4644.744539050351, 4651.813927442915, 4652.511486293941, 3227.7417806575536, 3366.747493937952, 4629.560191781776, 5068.163752980754, 5244.659097158691, 5214.582833373321, 5228.607854410915, 5235.319408476893, 5248.370195576536, 5252.264682944391, 5207.739613019353, 5280.339957505312, 5718.971405142989, 5741.540676745892, 5793.710314484301, 5059.241113832918, 5073.923891141636, 5083.822066227664, 5087.109755792721, 5112.565431938289, 10924.344539327665, 11603.361815100166, 11631.360275184861, 11685.065194784482, 11725.061995040376, 1761.5243884151334, 1771.9114044297733, 1822.6172503774092, 1852.981470185308, 1855.870089093764, 8563.871541926876, 8807.427517211361, 12688.36558172097, 12721.491140354467, 12723.0, 1702.727563589832, 1734.913254337278, 1762.0837164674426, 1787.8480329172037, 1799.0195343537803, 55182.0, 57057.71471142659, 57963.71018144924, 58467.0, 58490.70754646242, 9438.858417123749, 9528.904710952802, 9694.079062489052, 9726.513674316257, 9830.21358291335, 12188.024958003338, 12223.572174973833, 12233.632991010283, 12236.449359778831, 12289.385530723428, 6593.967030164915, 6600.405963463215, 6665.366790154928, 6670.166229221348, 6691.063251144844, 6135.570510064253, 6139.324674285825, 6171.352008039181, 6171.382861713792, 6182.721777520022, 4038.9798051009557, 4090.734102283342, 4111.794410279534, 4123.2165888481095, 4132.442120313719, 1602.8156761972523, 1616.5473667373155, 1642.1214650162105, 1644.9506514804575, 1695.4320302698734, 849.5115308697524, 876.1326286975848, 918.93108016899, 967.2842096848423, 989.5547003848297, 13426.462941482427, 14796.408143674347, 14812.963092583415, 16035.19824008795, 16254.106024168548, 839.5802098950525, 852.8933883264592, 867.4058270085012, 883.5891310540629, 965.8602848638674, 9101.863472047793, 9309.301802364715, 9367.531623418801, 9402.388844725208, 9581.993890641383, 482559.0, 482757.0, 483933.0, 495156.0, 496061.0, 69260.6536967312, 69355.65322173356, 69458.30541694518, 70913.64543177251, 71944.64027679933, 1015.8882522922472, 1020.2144348851491, 1029.25893356783, 1036.2849633752687, 1038.08129805123, 13628.523001694894, 14488.985770995929, 14635.268236587915, 14659.04716193444, 14735.115893046452, 32358.35283294274, 32386.190345240615, 32514.83742581272, 33045.67817287282, 33388.499172512915, 40775.0, 40795.0, 41371.379429307985, 41486.58513414827, 43596.34605480857, 8388.70639527638, 8768.605412756313, 8800.427972181787, 8805.1194880514, 8813.030566637537, 10125.443100629536, 10202.38785672862, 11661.0, 15944.441944531885, 15998.360065597246, 10408.531616077144, 10956.178286628694, 12673.80989285143, 12835.229886206858, 12947.352632368533, 13098.345082746015, 13574.660633483847, 13631.113977591425, 13660.726785464434, 13704.040717150103, 13975.161490310615, 13997.860021399656, 14082.718345633235, 14211.431542738175, 14259.429622815385, 8519.701810436853, 8637.179467950535, 8681.913180868363, 8733.781655458664, 8735.039145694096, 13273.734525309634, 13336.333183340601, 13444.0, 13574.321283935962, 13693.246871422167], "unit": "ms", "name": "jquery.html", "value": 7942.578441940423}, {"lowerIsBetter": false, "replicates": [1457.6064462595093, 1649.3979697410446, 1676.7317229243324, 1708.5130737739746, 1733.7746093007906, 5594.636348637336, 5916.733746981386, 6732.990051492278, 6971.058907047547, 6978.267281935394, 6696.933030669692, 6864.176298844133, 6924.23833378328, 6939.4101501372315, 7020.613866237355, 2013.4362378533997, 2028.8072633099832, 2040.8979551022464, 2052.8563000589966, 2056.444759914822, 2041.3365656161807, 2095.21429463951, 2097.685347197925, 2098.192196004534, 2100.054975261131, 1980.1485361294638, 2002.059032254845, 2020.0, 2027.979720202794, 2028.0164120401594, 2002.0690378973775, 2003.4490515108316, 2016.5865997470482, 2026.996636664853, 2030.1067530286628, 1948.2109745553073, 1951.1805041882444, 2046.0383619698866, 2050.7846676099093, 2062.36066819285, 6816.693248803816, 6821.829454263683, 6836.0, 6914.723411063552, 6917.27368626292, 4103.117829666636, 4147.854825081138, 4161.854335098287, 4174.0, 4177.624013838769, 2707.350235943379, 2722.0881004863395, 2743.341598016482, 2769.4461107778525, 2776.7500924916653, 795.6220795122329, 804.5936801915054, 805.9556724380157, 822.8230930349944, 833.4874052457756, 9214.447133171963, 9248.16766491019, 9256.611508273745, 9260.536973151315, 9281.953590232073, 3724.72064595151, 3764.6235376462682, 3765.962340376616, 3814.256220037066, 3848.5766565677754, 7989.680412783424, 8013.398995075393, 8013.719519816778, 8022.037355517258, 8096.797580060545, 4125.133721918431, 4126.442930204444, 4126.91746165075, 4136.937945930814, 4138.6482149017065, 3247.0908145719236, 3342.8328583570724, 3653.5250417446096, 3752.6810221130963, 3773.3208022555655, 3269.0, 3373.7469689773366, 3382.0, 3384.966150338514, 3420.6921377075687, 1064.9414282214552, 1083.111848284415, 1083.5557421457165, 1092.819684752007, 1098.9120870330355, 938.3244064273712, 958.0563145301873, 960.7646126698863, 1006.4213077480478, 1222.9571964981183, 6539.47684185264, 6540.9345906541275, 6550.344965503412, 6599.538032337787, 6602.438792702674, 426.73755640281, 432.0214713673532, 1110.8778034416207, 1116.932984020945, 1134.3194083549804, 5219.347581552306, 5255.789768409298, 5265.131253343156, 5266.210068489757, 5303.36359636846, 8001.679932802739, 8129.0, 8200.753977380688, 8318.292945099613, 8401.117882622359, 8253.215944485264, 8290.378221633402, 8304.211099945616, 8306.293965012921, 8308.792280192923, 6251.156093927261, 6608.140941677551, 6660.433863121592, 6678.666066696645, 6695.029220762962, 6497.0, 6530.053142294436, 6551.050097735706, 6588.604683718992, 6592.241892182268, 7298.744543940937, 7404.074490688664, 7416.3325300721035, 7472.514286571355, 7477.626118694152, 7601.88597171054, 7642.1593624702355, 7703.114141873756, 7764.495307804975, 7782.416318776228, 5228.37259528859, 5459.454054594509, 6000.489958353589, 6053.152558641882, 6136.325004249618, 6089.573729839046, 6344.238691356882, 6397.552171348148, 6412.23053233615, 6434.903476447951, 5854.326752423355, 5905.409459054232, 5917.822465326047, 6065.150878877049, 6071.058985857199, 5842.444967728059, 6068.6358818471035, 6158.353372895961, 6165.537584681257, 6174.104754810617, 6061.848453788514, 6099.054646529795, 6298.08677741734, 6319.58922670025, 6321.367863213642, 5861.736221869941, 5873.177755114202, 5877.911831322619, 5887.764489420375, 5892.292924849045, 5801.680907550125, 5807.7967271147, 5861.208736820475, 5879.559033072451, 5893.263342082239], "unit": "ms", "name": "mootools.html", "value": 3964.5452840061985}, {"lowerIsBetter": false, "replicates": [254.6282427655623, 256.3872345095223, 256.64198443171773, 259.74934188508087, 265.6506693697788, 5534.612577119603, 5619.7471113799875, 5619.831405057845, 5632.690202038886, 5746.798862039829, 5530.617345663584, 5547.944520554804, 5557.055300598898, 5584.106542953128, 5589.469000444961, 4138.2758017347, 4146.771927543984, 4147.419361289422, 4148.066684995867, 4152.647025002879, 4144.896377590554, 4151.252774500589, 4152.397902304179, 4155.168966206771, 4163.500379954395, 3988.8205030773684, 4069.7558146511155, 4093.5292441369324, 4096.815643296044, 4109.712320137592, 4091.3862920561855, 4098.856540021085, 4106.527749308838, 4106.630403263705, 4107.28122578549, 3486.564179477565, 3487.459443786217, 3488.6162522122545, 3492.580890293156, 3492.7205823534055, 5304.549113325334, 5324.866878328073, 5328.547073498718, 5335.866603334909, 5347.54545863602, 4537.523560026183, 4672.57946784791, 4680.578747912704, 4686.859394218179, 4715.740634265114, 5622.606417550773, 5780.942190578083, 5783.161441590988, 5792.971035144839, 5824.184614153979, 3764.9834544672785, 3765.3034188675183, 3770.057485628593, 3775.1505911170043, 3778.112143646241, 6073.301570319426, 6137.662428566382, 6147.569670123094, 6150.04674275488, 6155.538334624876, 3812.8093595320124, 3883.76697398157, 3914.921701565953, 3921.745086569364, 3923.588023257574, 3969.4442778011103, 3969.8090572828037, 3973.3443981743267, 3975.045988962628, 3982.900427489278, 4675.064987002545, 4676.883077923079, 4681.438227412732, 4690.882727931829, 4692.859214223578, 5816.360200377955, 5828.271466066742, 5833.912491312633, 5848.502877255396, 5849.883002340014, 1384.3009280313377, 1394.6792237785367, 1410.330093205719, 1410.6825964158188, 1411.1744629391715, 884.7080463447047, 889.6041261638509, 898.1512470715112, 901.8466860633708, 908.2280061947424, 5100.4899510049445, 5106.846794596094, 5121.8463446096675, 5122.974385128051, 5124.538791508708, 5995.760169593167, 6004.969975150097, 6043.0, 6044.546659000593, 6061.484773794277, 5043.470435604282, 5082.949170508322, 5083.923741143886, 5085.796568137233, 5101.642884998088, 3206.5190221466964, 3240.6759324067875, 3280.5899262592175, 3283.146381940665, 3314.121757734202, 5796.362400135981, 5804.651720896675, 5807.651540907559, 5808.244928159313, 5813.128030795415, 6335.778247761398, 6361.395667411589, 6365.077063825812, 6365.840853978595, 6368.872622547616, 5598.440155984369, 5767.452092051249, 5771.94228057714, 5775.797847075332, 5802.187693722883, 6098.75604975796, 6128.448439640454, 6129.570930034854, 6133.080037994337, 6153.446189842935, 5992.910106348496, 5999.610025348338, 5999.790007349722, 6000.519958403404, 6019.6990150493175, 5600.607957443103, 5743.971280143573, 5747.1379293106365, 5763.279590051244, 5776.740046697824, 3806.3719486284454, 3841.7887016214377, 3841.8847434577006, 3851.441540976599, 3853.0367408147963, 6128.601640893327, 6132.754689812357, 6135.11040899076, 6135.815925522242, 6137.171481849893, 5871.031279838779, 5886.58793884424, 5887.116932460165, 5901.173835663097, 5915.319738230159, 5736.885262294814, 5867.647941123546, 5873.177755114373, 5875.441833025856, 5880.411958804086, 5751.539876809761, 5754.4533269339345, 5758.337791153904, 5760.020796464527, 5761.0, 5896.764129434775, 5911.970440147772, 5913.172155898092, 5914.881702366015, 5924.437178468039, 5660.490555849993, 5742.483176514133, 5759.280089988752, 5769.423057694197, 5776.7400466979925], "unit": "ms", "name": "prototype.html", "value": 4275.524307237596}, {"lowerIsBetter": false, "replicates": [676.279762053413, 701.3372363116855, 714.942804575634, 765.6669348833258, 797.4816369359919, 11800.46897889595, 11803.291802491856, 11815.350155741431, 11885.168038237327, 11903.047756179496, 11701.3564253966, 11707.239029463079, 11743.119266055037, 11777.110390421614, 11783.057355411567, 619.1610367951429, 625.9968700156493, 788.3889985261411, 789.7157023471574, 804.6982381606897, 798.3573223555036, 806.8749343851683, 807.2936180841764, 808.458332916947, 809.0938149272823, 824.2458150792019, 834.1741675741033, 837.8031162676766, 838.375410319313, 842.3471809347774, 827.4497459189631, 829.2868133405267, 829.5686243153586, 830.9916900830975, 833.9207775261341, 610.8930937085992, 612.773273888664, 613.895637741585, 614.5851550203595, 616.2512547255062, 11749.353785541793, 11749.4712737927, 11859.40702964857, 11875.940620296844, 11897.940510297392, 11240.0, 11986.160968732192, 12108.0, 12152.635420937386, 12190.0, 9194.172524472762, 9207.861882071775, 9309.953450232773, 9318.440893546409, 9326.0, 3103.3948380065895, 3181.1569933967517, 3185.0922487091298, 3185.5699480570056, 3273.427150248721, 37543.0, 37925.43111853324, 37958.0, 38074.23851522954, 38314.80842595797, 8702.086280940537, 9128.634854605874, 9219.539023048821, 9449.055094490495, 9535.332526723201, 15026.849731502545, 15087.773683394758, 15134.470293539673, 15141.091534507965, 15143.394264229308, 6113.786017489367, 6199.814005579839, 6288.339724328879, 6291.465225455796, 6329.145565348711, 3270.394976929228, 3374.4600863861665, 3397.3205358928312, 3457.94813077804, 3470.340635279289, 2656.189862092042, 2667.333166708323, 2671.666041744782, 2686.6104414859738, 2704.851233182194, 468.7937307584652, 478.51430797740323, 487.2788273355454, 487.3226215560374, 493.67910857941905, 537.725759862473, 551.3246273315157, 555.9027170245191, 574.7241324164424, 582.913774441162, 6974.58152510851, 7289.416846652255, 7309.817254568678, 7419.962900185573, 7441.776746697607, 580.7241560258843, 583.1077261773722, 593.6586462783916, 597.3220394851875, 604.2899592978321, 2940.7206315400003, 3323.3685599735973, 3605.3149901518627, 3847.8076096195077, 3892.922141557153, 48167.75916120397, 49132.0, 49451.0, 49539.0, 49622.25566616504, 43678.344824827655, 43782.124357513305, 44251.77874110673, 44692.77653611711, 44753.77623111864, 39531.80234098869, 40164.79917600393, 40440.79779601142, 40445.59554404477, 41363.586364135976, 7496.812579685551, 7497.662605182671, 7650.540967541965, 7658.157602663591, 7828.316911863976, 31239.68760312368, 31270.218244544067, 31605.683943161195, 31789.0, 31917.6808231924, 36688.449673255454, 39494.60505394909, 39707.40438893361, 39757.60242397539, 39821.40267895926, 10022.699319020441, 10076.748081298027, 10112.59549618007, 10196.4391958443, 10221.59113635476, 10291.433971131659, 10417.322874013165, 10639.734006649896, 11134.832977505182, 11242.269252498561, 10358.948205258925, 10906.34561926287, 11010.483561117375, 11091.44542772842, 11106.666799996014, 10238.12975897057, 10645.414502202453, 10792.838107428237, 10880.782384352427, 10979.945100274766, 9984.251181161297, 9998.750031249278, 10381.792364152523, 10408.947955260175, 10506.106980906708, 8783.736487905373, 8866.42368246062, 8869.866951995855, 8903.554822258991, 9050.049744776703, 9048.50233237152, 9191.402558833654, 9199.310051746012, 9285.86071208946, 9387.765305867408], "unit": "ms", "name": "yui.html", "value": 5646.645576050495}], "name": "dromaeo_css", "value": 6275.950122782622}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 116.0, 113.0, 113.0, 126.0, 113.0, 115.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.9}, {"lowerIsBetter": true, "replicates": [154.0, 138.0, 154.0, 169.0, 127.0, 158.0, 155.0, 136.0, 169.0, 138.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 165.0, 165.0, 166.0, 161.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 79.0, 72.0, 72.0, 138.0, 79.0, 91.0, 78.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 94.0, 95.0, 94.0, 134.0, 94.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 149.0, 147.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 99.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 75.0, 73.0, 75.0, 74.0, 74.0, 73.0, 76.0, 87.0], "unit": "ms", "name": "json-parse-financial", "value": 75.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 96.0, 86.0, 85.0, 90.0, 85.0, 85.0, 94.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [127.0, 128.0, 122.0, 125.0, 121.0, 128.0, 133.0, 130.0, 125.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [152.0, 157.0, 151.0, 150.0, 152.0, 139.0, 155.0, 149.0, 150.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 72.0, 72.0, 70.0, 90.0, 70.0, 70.0, 75.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 73.1}], "name": "kraken", "value": 1551.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.58337497917708], "unit": "score", "name": "Richards", "value": 211.91790600000007}, {"lowerIsBetter": false, "replicates": [185.2881230313137], "unit": "score", "name": "DeltaBlue", "value": 356.8388459999999}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1048.2180293501049], "unit": "score", "name": "RayTrace", "value": 705.9495059999997}, {"lowerIsBetter": false, "replicates": [725.1631617113851], "unit": "score", "name": "Earley", "value": 919.0524770000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [610.1281269066504], "unit": "score", "name": "Splay", "value": 133.56374900000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21335.496559382587}]} 04:44:38 INFO - RETURN: dromaeo_css: 6275.95 04:44:38 INFO - RETURN: kraken: 1551.20 04:44:38 INFO - RETURN: v8_7: 21335.50 04:44:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21335.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1551.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6275.95"}}} 04:44:38 INFO - Return code: 0 04:44:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:44:38 INFO - # TBPL SUCCESS # 04:44:38 INFO - Running post-action listener: _resource_record_post_action 04:44:38 INFO - Running post-run listener: _resource_record_post_run 04:44:39 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 10063872; Write bytes: 405319680; Read time: 2152; Write time: 330504 04:44:39 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 6991872; Read time: 0; Write time: 2368 04:44:39 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8302592; Write bytes: 398327808; Read time: 2112; Write time: 328136 04:44:39 INFO - Running post-run listener: _upload_blobber_files 04:44:39 INFO - Blob upload gear active. 04:44:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:44:39 INFO - Copying logs to upload dir... 04:44:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.084539 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-10 04:44:39.280519) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 04:44:39.283914) ========= 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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010040 build_url: 'https://queue.taskcluster.net/v1/task/l7hHCEhcSN2st5VwG5pLlA/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 04:44:39.336377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:44:39.336757) ========= 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=cd88c086d1ff67493cfd1714000001ba-1449741576.679954-1839730599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004731 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 04:44:39.386522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 04:44:39.386844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 04:44:39.387147) ========= ========= Total master_lag: 0.26 =========