builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1450187955.2 results: success (0) buildid: 20151215030512 builduid: f0cbc7221a204f9885cb4fd16853d8ec revision: 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.203009) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.203526) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.203842) ========= 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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006323 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.226627) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.226897) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.240462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.240738) ========= 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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.033520 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.289788) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.290079) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.290432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.290713) ========= 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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 05:59:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-12-15 05:59:15 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102834 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.405877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.406220) ========= 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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052027 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.468900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:15.469267) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 --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 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 --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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 05:59:15,579 truncating revision to first 12 chars 2015-12-15 05:59:15,579 Setting DEBUG logging. 2015-12-15 05:59:15,580 attempt 1/10 2015-12-15 05:59:15,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a22b7a21f27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 05:59:16,106 unpacking tar archive at: mozilla-central-7a22b7a21f27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:16.297947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:16.298303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:16.307336) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:16.307614) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 05:59:16.308020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-15 05:59:16.308318) ========= /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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:59:16 INFO - MultiFileLogger online at 20151215 05:59:16 in /builds/slave/test 05:59:16 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 05:59:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:59:16 INFO - {'append_to_log': False, 05:59:16 INFO - 'base_work_dir': '/builds/slave/test', 05:59:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:59:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:59:16 INFO - 'branch': 'Firefox-Non-PGO', 05:59:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:16 INFO - 'config_files': ('talos/linux_config.py',), 05:59:16 INFO - 'default_actions': ('clobber', 05:59:16 INFO - 'read-buildbot-config', 05:59:16 INFO - 'download-and-extract', 05:59:16 INFO - 'populate-webroot', 05:59:16 INFO - 'create-virtualenv', 05:59:16 INFO - 'install', 05:59:16 INFO - 'run-tests'), 05:59:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:16 INFO - 'download_minidump_stackwalk': True, 05:59:16 INFO - 'download_symbols': 'ondemand', 05:59:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:16 INFO - 'installer_path': 'installer.exe', 05:59:16 INFO - 'log_level': 'info', 05:59:16 INFO - 'log_name': 'talos', 05:59:16 INFO - 'log_to_console': True, 05:59:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:59:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:59:16 INFO - 'opt_config_files': (), 05:59:16 INFO - 'pip_index': False, 05:59:16 INFO - 'sps_profile': False, 05:59:16 INFO - 'sps_profile_interval': 0, 05:59:16 INFO - 'suite': 'dromaeojs-e10s', 05:59:16 INFO - 'system_bits': '64', 05:59:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:16 INFO - 'title': 'talos-linux64-ix-042', 05:59:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:16 INFO - 'use_talos_json': True, 05:59:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:59:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:16 INFO - 'work_dir': 'build'} 05:59:16 INFO - ##### 05:59:16 INFO - ##### Running clobber step. 05:59:16 INFO - ##### 05:59:16 INFO - Running pre-action listener: _resource_record_pre_action 05:59:16 INFO - Running main action method: clobber 05:59:16 INFO - rmtree: /builds/slave/test/build 05:59:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:59:23 INFO - Running post-action listener: _resource_record_post_action 05:59:23 INFO - ##### 05:59:23 INFO - ##### Running read-buildbot-config step. 05:59:23 INFO - ##### 05:59:23 INFO - Running pre-action listener: _resource_record_pre_action 05:59:23 INFO - Running main action method: read_buildbot_config 05:59:23 INFO - Using buildbot properties: 05:59:23 INFO - { 05:59:23 INFO - "properties": { 05:59:23 INFO - "buildnumber": 173, 05:59:23 INFO - "product": "firefox", 05:59:23 INFO - "script_repo_revision": "production", 05:59:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:59:23 INFO - "repository": "", 05:59:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:59:23 INFO - "buildid": "20151215030512", 05:59:23 INFO - "slavename": "talos-linux64-ix-042", 05:59:23 INFO - "pgo_build": "False", 05:59:23 INFO - "basedir": "/builds/slave/test", 05:59:23 INFO - "project": "", 05:59:23 INFO - "platform": "ubuntu64_hw", 05:59:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:59:23 INFO - "slavebuilddir": "test", 05:59:23 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:59:23 INFO - "branch": "mozilla-central", 05:59:23 INFO - "repo_path": "mozilla-central", 05:59:23 INFO - "stage_platform": "linux64", 05:59:23 INFO - "builduid": "f0cbc7221a204f9885cb4fd16853d8ec", 05:59:23 INFO - "revision": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636" 05:59:23 INFO - }, 05:59:23 INFO - "sourcestamp": { 05:59:23 INFO - "repository": "", 05:59:23 INFO - "hasPatch": false, 05:59:23 INFO - "project": "", 05:59:23 INFO - "branch": "mozilla-central-linux64-talos", 05:59:23 INFO - "changes": [ 05:59:23 INFO - { 05:59:23 INFO - "category": null, 05:59:23 INFO - "files": [ 05:59:23 INFO - { 05:59:23 INFO - "url": null, 05:59:23 INFO - "name": "https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 05:59:23 INFO - } 05:59:23 INFO - ], 05:59:23 INFO - "repository": "", 05:59:23 INFO - "rev": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636", 05:59:23 INFO - "who": "cbook@mozilla.com", 05:59:23 INFO - "when": 1450182624, 05:59:23 INFO - "number": 7361742, 05:59:23 INFO - "comments": "merge fx-team to mozilla-central a=merge", 05:59:23 INFO - "project": "", 05:59:23 INFO - "at": "Tue 15 Dec 2015 04:30:24", 05:59:23 INFO - "branch": "mozilla-central-linux64-talos", 05:59:23 INFO - "revlink": "", 05:59:23 INFO - "properties": [ 05:59:23 INFO - [ 05:59:23 INFO - "buildid", 05:59:23 INFO - "20151215030512", 05:59:23 INFO - "Change" 05:59:23 INFO - ], 05:59:23 INFO - [ 05:59:23 INFO - "builduid", 05:59:23 INFO - "f0cbc7221a204f9885cb4fd16853d8ec", 05:59:23 INFO - "Change" 05:59:23 INFO - ], 05:59:23 INFO - [ 05:59:23 INFO - "pgo_build", 05:59:23 INFO - "False", 05:59:23 INFO - "Change" 05:59:23 INFO - ] 05:59:23 INFO - ], 05:59:23 INFO - "revision": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636" 05:59:23 INFO - } 05:59:23 INFO - ], 05:59:23 INFO - "revision": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636" 05:59:23 INFO - } 05:59:23 INFO - } 05:59:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:59:23 INFO - Running post-action listener: _resource_record_post_action 05:59:23 INFO - ##### 05:59:23 INFO - ##### Running download-and-extract step. 05:59:23 INFO - ##### 05:59:23 INFO - Running pre-action listener: _resource_record_pre_action 05:59:23 INFO - Running main action method: download_and_extract 05:59:23 INFO - mkdir: /builds/slave/test/build/tests 05:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:23 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:59:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json 05:59:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json 05:59:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:59:23 INFO - Downloaded 1302 bytes. 05:59:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:59:23 INFO - Using the following test package requirements: 05:59:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:59:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:23 INFO - u'jsshell-linux-x86_64.zip'], 05:59:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:59:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:59:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:59:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:59:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:59:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:59:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:59:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:23 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:24 INFO - Downloaded 21869726 bytes. 05:59:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:59:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:59:26 INFO - Return code: 0 05:59:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:59: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')]} 05:59:26 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:26 INFO - Downloaded 21869726 bytes. 05:59:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:59:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:59:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:59:28 INFO - Return code: 0 05:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:28 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:59:29 INFO - Downloaded 11132038 bytes. 05:59:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:59:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:59:29 INFO - Return code: 0 05:59:29 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')]} 05:59:29 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:59:30 INFO - Downloaded 57743688 bytes. 05:59:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:30 INFO - mkdir: /builds/slave/test/properties 05:59:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:30 INFO - Contents: 05:59:30 INFO - build_url:https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:59:30 INFO - Running post-action listener: _resource_record_post_action 05:59:30 INFO - Running post-action listener: set_extra_try_arguments 05:59:30 INFO - ##### 05:59:30 INFO - ##### Running populate-webroot step. 05:59:30 INFO - ##### 05:59:30 INFO - Running pre-action listener: _resource_record_pre_action 05:59:30 INFO - Running main action method: populate_webroot 05:59:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:30 INFO - '--tppagecycles', 05:59:30 INFO - '7'], 05:59:30 INFO - 'tests': ['tsvgm']}}, 05:59:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:59:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:59:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'tests': ['damp', 'tps']}, 05:59:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['damp', 'tps']}, 05:59:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:59:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:30 INFO - 'other': {'tests': ['a11yr', 05:59:30 INFO - 'ts_paint', 05:59:30 INFO - 'tpaint', 05:59:30 INFO - 'sessionrestore', 05:59:30 INFO - 'sessionrestore_no_auto_restore']}, 05:59:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['a11yr', 05:59:30 INFO - 'ts_paint', 05:59:30 INFO - 'tpaint', 05:59:30 INFO - 'sessionrestore', 05:59:30 INFO - 'sessionrestore_no_auto_restore']}, 05:59:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['a11yr', 05:59:30 INFO - 'ts_paint', 05:59:30 INFO - 'tpaint', 05:59:30 INFO - 'sessionrestore', 05:59:30 INFO - 'sessionrestore_no_auto_restore']}, 05:59:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['a11yr', 05:59:30 INFO - 'ts_paint', 05:59:30 INFO - 'tpaint', 05:59:30 INFO - 'sessionrestore', 05:59:30 INFO - 'sessionrestore_no_auto_restore']}, 05:59:30 INFO - 'other_l64': {'tests': ['a11yr', 05:59:30 INFO - 'ts_paint', 05:59:30 INFO - 'tpaint', 05:59:30 INFO - 'sessionrestore', 05:59:30 INFO - 'sessionrestore_no_auto_restore']}, 05:59:30 INFO - 'other_nol64': {'tests': ['a11yr', 05:59:30 INFO - 'ts_paint', 05:59:30 INFO - 'tpaint', 05:59:30 INFO - 'sessionrestore', 05:59:30 INFO - 'sessionrestore_no_auto_restore']}, 05:59:30 INFO - 'svgr': {'tests': ['tsvgx', 05:59:30 INFO - 'tsvgr_opacity', 05:59:30 INFO - 'tart', 05:59:30 INFO - 'tscrollx', 05:59:30 INFO - 'cart']}, 05:59:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['tsvgx', 05:59:30 INFO - 'tsvgr_opacity', 05:59:30 INFO - 'tart', 05:59:30 INFO - 'tscrollx', 05:59:30 INFO - 'cart']}, 05:59:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'tests': ['tp5o']}, 05:59:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'talos_options': ['--e10s'], 05:59:30 INFO - 'tests': ['tp5o']}, 05:59:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'talos_options': ['--xperf_path', 05:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:30 INFO - 'tests': ['tp5n']}, 05:59:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:30 INFO - 'talos_options': ['--e10s', 05:59:30 INFO - '--xperf_path', 05:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:30 INFO - 'tests': ['tp5n']}}, 05:59:30 INFO - 'talos.zip': {'path': '', 05:59:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:30 INFO - Running post-action listener: _resource_record_post_action 05:59:30 INFO - ##### 05:59:30 INFO - ##### Running create-virtualenv step. 05:59:30 INFO - ##### 05:59:30 INFO - Running pre-action listener: _resource_record_pre_action 05:59:30 INFO - Running main action method: create_virtualenv 05:59:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:30 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 05:59:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:30 INFO - Using real prefix '/usr' 05:59:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:33 INFO - Installing pip.................done. 05:59:33 INFO - Return code: 0 05:59:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59:33 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')]} 05:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:33 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')]} 05:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:33 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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:33 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 05:59:33 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 05:59:33 INFO - Using env: {'DISPLAY': ':0', 05:59:33 INFO - 'HOME': '/home/cltbld', 05:59:33 INFO - 'LANG': 'en_US.UTF-8', 05:59:33 INFO - 'LANGUAGE': 'en_US:en', 05:59:33 INFO - 'LOGNAME': 'cltbld', 05:59:33 INFO - 'MAIL': '/var/mail/cltbld', 05:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:33 INFO - 'MOZ_NO_REMOTE': '1', 05:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:33 INFO - 'NO_EM_RESTART': '1', 05:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:33 INFO - 'PWD': '/builds/slave/test', 05:59:33 INFO - 'SHELL': '/bin/bash', 05:59:33 INFO - 'SHLVL': '1', 05:59:33 INFO - 'TERM': 'linux', 05:59:33 INFO - 'TMOUT': '86400', 05:59:33 INFO - 'USER': 'cltbld', 05:59:33 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:33 INFO - '_': '/tools/buildbot/bin/python'} 05:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:33 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 05:59:33 INFO - Cleaning up... 05:59:33 INFO - Return code: 0 05:59:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:59:33 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')]} 05:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:33 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')]} 05:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:33 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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:33 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 05:59:33 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 05:59:33 INFO - Using env: {'DISPLAY': ':0', 05:59:33 INFO - 'HOME': '/home/cltbld', 05:59:33 INFO - 'LANG': 'en_US.UTF-8', 05:59:33 INFO - 'LANGUAGE': 'en_US:en', 05:59:33 INFO - 'LOGNAME': 'cltbld', 05:59:33 INFO - 'MAIL': '/var/mail/cltbld', 05:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:33 INFO - 'MOZ_NO_REMOTE': '1', 05:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:33 INFO - 'NO_EM_RESTART': '1', 05:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:33 INFO - 'PWD': '/builds/slave/test', 05:59:33 INFO - 'SHELL': '/bin/bash', 05:59:33 INFO - 'SHLVL': '1', 05:59:33 INFO - 'TERM': 'linux', 05:59:33 INFO - 'TMOUT': '86400', 05:59:33 INFO - 'USER': 'cltbld', 05:59:33 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:33 INFO - '_': '/tools/buildbot/bin/python'} 05:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:33 INFO - Downloading/unpacking psutil>=0.7.1 05:59:33 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 05:59:33 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 05:59:33 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 05:59:33 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 05:59:33 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 05:59:33 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 05:59:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:59:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:35 INFO - Installing collected packages: psutil 05:59:35 INFO - Running setup.py install for psutil 05:59:35 INFO - building 'psutil._psutil_linux' extension 05:59:35 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 05:59:35 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 05:59:35 INFO - building 'psutil._psutil_posix' extension 05:59:35 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 05:59:35 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 05:59:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:36 INFO - Successfully installed psutil 05:59:36 INFO - Cleaning up... 05:59:36 INFO - Return code: 0 05:59:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:59:36 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')]} 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 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')]} 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:36 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 05:59:36 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 05:59:36 INFO - Using env: {'DISPLAY': ':0', 05:59:36 INFO - 'HOME': '/home/cltbld', 05:59:36 INFO - 'LANG': 'en_US.UTF-8', 05:59:36 INFO - 'LANGUAGE': 'en_US:en', 05:59:36 INFO - 'LOGNAME': 'cltbld', 05:59:36 INFO - 'MAIL': '/var/mail/cltbld', 05:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:36 INFO - 'MOZ_NO_REMOTE': '1', 05:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:36 INFO - 'NO_EM_RESTART': '1', 05:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:36 INFO - 'PWD': '/builds/slave/test', 05:59:36 INFO - 'SHELL': '/bin/bash', 05:59:36 INFO - 'SHLVL': '1', 05:59:36 INFO - 'TERM': 'linux', 05:59:36 INFO - 'TMOUT': '86400', 05:59:36 INFO - 'USER': 'cltbld', 05:59:36 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:36 INFO - '_': '/tools/buildbot/bin/python'} 05:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:59:37 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 05:59:37 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 05:59:37 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 05:59:37 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 05:59:37 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 05:59:37 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 05:59:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:59:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:59:39 INFO - Installing collected packages: mozsystemmonitor 05:59:39 INFO - Running setup.py install for mozsystemmonitor 05:59:39 INFO - Successfully installed mozsystemmonitor 05:59:39 INFO - Cleaning up... 05:59:39 INFO - Return code: 0 05:59:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:39 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')]} 05:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:39 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')]} 05:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:39 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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:39 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 05:59:39 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 05:59:39 INFO - Using env: {'DISPLAY': ':0', 05:59:39 INFO - 'HOME': '/home/cltbld', 05:59:39 INFO - 'LANG': 'en_US.UTF-8', 05:59:39 INFO - 'LANGUAGE': 'en_US:en', 05:59:39 INFO - 'LOGNAME': 'cltbld', 05:59:39 INFO - 'MAIL': '/var/mail/cltbld', 05:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:39 INFO - 'MOZ_NO_REMOTE': '1', 05:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:39 INFO - 'NO_EM_RESTART': '1', 05:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:39 INFO - 'PWD': '/builds/slave/test', 05:59:39 INFO - 'SHELL': '/bin/bash', 05:59:39 INFO - 'SHLVL': '1', 05:59:39 INFO - 'TERM': 'linux', 05:59:39 INFO - 'TMOUT': '86400', 05:59:39 INFO - 'USER': 'cltbld', 05:59:39 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:39 INFO - '_': '/tools/buildbot/bin/python'} 05:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:39 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 05:59:39 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 05:59:39 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 05:59:39 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 05:59:39 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 05:59:39 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 05:59:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:42 INFO - Downloading docopt-0.6.1.tar.gz 05:59:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:42 INFO - Running setup.py install for blobuploader 05:59:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:42 INFO - Running setup.py install for requests 05:59:42 INFO - Running setup.py install for docopt 05:59:42 INFO - Successfully installed blobuploader requests docopt 05:59:42 INFO - Cleaning up... 05:59:42 INFO - Return code: 0 05:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:42 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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:42 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 05:59:42 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 05:59:42 INFO - Using env: {'DISPLAY': ':0', 05:59:42 INFO - 'HOME': '/home/cltbld', 05:59:42 INFO - 'LANG': 'en_US.UTF-8', 05:59:42 INFO - 'LANGUAGE': 'en_US:en', 05:59:42 INFO - 'LOGNAME': 'cltbld', 05:59:42 INFO - 'MAIL': '/var/mail/cltbld', 05:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:42 INFO - 'MOZ_NO_REMOTE': '1', 05:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:42 INFO - 'NO_EM_RESTART': '1', 05:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:42 INFO - 'PWD': '/builds/slave/test', 05:59:42 INFO - 'SHELL': '/bin/bash', 05:59:42 INFO - 'SHLVL': '1', 05:59:42 INFO - 'TERM': 'linux', 05:59:42 INFO - 'TMOUT': '86400', 05:59:42 INFO - 'USER': 'cltbld', 05:59:42 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:42 INFO - '_': '/tools/buildbot/bin/python'} 05:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:42 INFO - Running setup.py (path:/tmp/pip-IDCGfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:43 INFO - Running setup.py (path:/tmp/pip-BoStAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:43 INFO - Running setup.py (path:/tmp/pip-l2KqgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:43 INFO - Running setup.py (path:/tmp/pip-fZYVeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:43 INFO - Running setup.py (path:/tmp/pip-KU0_5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:43 INFO - Running setup.py (path:/tmp/pip-BKTYAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:43 INFO - Running setup.py (path:/tmp/pip-7RTUPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:43 INFO - Running setup.py (path:/tmp/pip-N3ZFMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:43 INFO - Running setup.py (path:/tmp/pip-YJU4Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:43 INFO - Running setup.py (path:/tmp/pip-9VnFR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:43 INFO - Running setup.py (path:/tmp/pip-ytrlVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:43 INFO - Running setup.py (path:/tmp/pip-ptEBAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:43 INFO - Running setup.py (path:/tmp/pip-idafQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:43 INFO - Running setup.py (path:/tmp/pip-Ps_4SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:43 INFO - Running setup.py (path:/tmp/pip-sjoDdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:44 INFO - Running setup.py (path:/tmp/pip-ggG0xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:44 INFO - Running setup.py (path:/tmp/pip-dbTHl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:44 INFO - Running setup.py install for manifestparser 05:59:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Running setup.py install for mozcrash 05:59:44 INFO - Running setup.py install for mozdebug 05:59:44 INFO - Running setup.py install for mozdevice 05:59:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Running setup.py install for mozfile 05:59:44 INFO - Running setup.py install for mozhttpd 05:59:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Running setup.py install for mozinfo 05:59:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Running setup.py install for mozInstall 05:59:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:44 INFO - Running setup.py install for mozleak 05:59:45 INFO - Running setup.py install for mozlog 05:59:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:45 INFO - Running setup.py install for moznetwork 05:59:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:45 INFO - Running setup.py install for mozprocess 05:59:45 INFO - Running setup.py install for mozprofile 05:59:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:45 INFO - Running setup.py install for mozrunner 05:59:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:45 INFO - Running setup.py install for mozscreenshot 05:59:45 INFO - Running setup.py install for moztest 05:59:45 INFO - Running setup.py install for mozversion 05:59:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:45 INFO - Cleaning up... 05:59:45 INFO - Return code: 0 05:59:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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', '-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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:45 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 05:59:45 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 05:59:45 INFO - Using env: {'DISPLAY': ':0', 05:59:45 INFO - 'HOME': '/home/cltbld', 05:59:45 INFO - 'LANG': 'en_US.UTF-8', 05:59:45 INFO - 'LANGUAGE': 'en_US:en', 05:59:45 INFO - 'LOGNAME': 'cltbld', 05:59:45 INFO - 'MAIL': '/var/mail/cltbld', 05:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:45 INFO - 'MOZ_NO_REMOTE': '1', 05:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:45 INFO - 'NO_EM_RESTART': '1', 05:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:45 INFO - 'PWD': '/builds/slave/test', 05:59:45 INFO - 'SHELL': '/bin/bash', 05:59:45 INFO - 'SHLVL': '1', 05:59:45 INFO - 'TERM': 'linux', 05:59:45 INFO - 'TMOUT': '86400', 05:59:45 INFO - 'USER': 'cltbld', 05:59:45 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:45 INFO - '_': '/tools/buildbot/bin/python'} 05:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:46 INFO - Running setup.py (path:/tmp/pip-3gC7W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:46 INFO - Running setup.py (path:/tmp/pip-FonBgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:46 INFO - Running setup.py (path:/tmp/pip-oT5qlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:46 INFO - Running setup.py (path:/tmp/pip-F7SgoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:46 INFO - Running setup.py (path:/tmp/pip-GoYNO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:46 INFO - Running setup.py (path:/tmp/pip-gknXjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:46 INFO - Running setup.py (path:/tmp/pip-wkEfBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:46 INFO - Running setup.py (path:/tmp/pip-_I2g3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:46 INFO - Running setup.py (path:/tmp/pip-6E2Zaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:46 INFO - Running setup.py (path:/tmp/pip-CJPHcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:46 INFO - Running setup.py (path:/tmp/pip-iyH3nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:46 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)) 05:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:46 INFO - Running setup.py (path:/tmp/pip-ZTHQJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:47 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)) 05:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:47 INFO - Running setup.py (path:/tmp/pip-2aJ6Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:47 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)) 05:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:47 INFO - Running setup.py (path:/tmp/pip-ro3OrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:47 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)) 05:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:47 INFO - Running setup.py (path:/tmp/pip-Wz9uOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:47 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)) 05:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:47 INFO - Running setup.py (path:/tmp/pip-GSquTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:47 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)) 05:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:47 INFO - Running setup.py (path:/tmp/pip-jwuIo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:47 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)) 05:59:47 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)) 05:59:47 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)) 05:59:47 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)) 05:59:47 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)) 05:59:47 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)) 05:59:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59:49 INFO - Downloading blessings-1.5.1.tar.gz 05:59:49 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 05:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:49 INFO - Installing collected packages: blessings 05:59:49 INFO - Running setup.py install for blessings 05:59:49 INFO - Successfully installed blessings 05:59:49 INFO - Cleaning up... 05:59:49 INFO - Return code: 0 05:59:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:49 INFO - Reading from file tmpfile_stdout 05:59:49 INFO - Current package versions: 05:59:49 INFO - argparse == 1.2.1 05:59:49 INFO - blessings == 1.5.1 05:59:49 INFO - blobuploader == 1.2.4 05:59:49 INFO - docopt == 0.6.1 05:59:49 INFO - manifestparser == 1.1 05:59:49 INFO - mozInstall == 1.12 05:59:49 INFO - mozcrash == 0.16 05:59:49 INFO - mozdebug == 0.1 05:59:49 INFO - mozdevice == 0.47 05:59:49 INFO - mozfile == 1.2 05:59:49 INFO - mozhttpd == 0.7 05:59:49 INFO - mozinfo == 0.9 05:59:49 INFO - mozleak == 0.1 05:59:49 INFO - mozlog == 3.1 05:59:49 INFO - moznetwork == 0.27 05:59:49 INFO - mozprocess == 0.22 05:59:49 INFO - mozprofile == 0.27 05:59:49 INFO - mozrunner == 6.11 05:59:49 INFO - mozscreenshot == 0.1 05:59:49 INFO - mozsystemmonitor == 0.0 05:59:49 INFO - moztest == 0.7 05:59:49 INFO - mozversion == 1.4 05:59:49 INFO - psutil == 3.1.1 05:59:49 INFO - requests == 1.2.3 05:59:49 INFO - wsgiref == 0.1.2 05:59:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:49 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 05:59:49 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 05:59:49 INFO - Using env: {'DISPLAY': ':0', 05:59:49 INFO - 'HOME': '/home/cltbld', 05:59:49 INFO - 'LANG': 'en_US.UTF-8', 05:59:49 INFO - 'LANGUAGE': 'en_US:en', 05:59:49 INFO - 'LOGNAME': 'cltbld', 05:59:49 INFO - 'MAIL': '/var/mail/cltbld', 05:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:49 INFO - 'MOZ_NO_REMOTE': '1', 05:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:49 INFO - 'NO_EM_RESTART': '1', 05:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:49 INFO - 'PWD': '/builds/slave/test', 05:59:49 INFO - 'SHELL': '/bin/bash', 05:59:49 INFO - 'SHLVL': '1', 05:59:49 INFO - 'TERM': 'linux', 05:59:49 INFO - 'TMOUT': '86400', 05:59:49 INFO - 'USER': 'cltbld', 05:59:49 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:49 INFO - '_': '/tools/buildbot/bin/python'} 05:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 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)) 05:59:49 INFO - Cleaning up... 05:59:49 INFO - Return code: 0 05:59:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:49 INFO - Using env: {'DISPLAY': ':0', 05:59:49 INFO - 'HOME': '/home/cltbld', 05:59:49 INFO - 'LANG': 'en_US.UTF-8', 05:59:49 INFO - 'LANGUAGE': 'en_US:en', 05:59:49 INFO - 'LOGNAME': 'cltbld', 05:59:49 INFO - 'MAIL': '/var/mail/cltbld', 05:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:49 INFO - 'MOZ_NO_REMOTE': '1', 05:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:49 INFO - 'NO_EM_RESTART': '1', 05:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:49 INFO - 'PWD': '/builds/slave/test', 05:59:49 INFO - 'SHELL': '/bin/bash', 05:59:49 INFO - 'SHLVL': '1', 05:59:49 INFO - 'TERM': 'linux', 05:59:49 INFO - 'TMOUT': '86400', 05:59:49 INFO - 'USER': 'cltbld', 05:59:49 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:49 INFO - '_': '/tools/buildbot/bin/python'} 05:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:49 INFO - Downloading/unpacking jsonschema 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:51 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 05:59:51 INFO - Downloading/unpacking functools32 (from jsonschema) 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:51 INFO - warning: no files found matching '*.txt' 05:59:51 INFO - no previously-included directories found matching 'build' 05:59:51 INFO - no previously-included directories found matching 'dist' 05:59:51 INFO - no previously-included directories found matching '.git*' 05:59:51 INFO - Installing collected packages: jsonschema, functools32 05:59:51 INFO - Running setup.py install for functools32 05:59:52 INFO - warning: no files found matching '*.txt' 05:59:52 INFO - no previously-included directories found matching 'build' 05:59:52 INFO - no previously-included directories found matching 'dist' 05:59:52 INFO - no previously-included directories found matching '.git*' 05:59:52 INFO - Successfully installed jsonschema functools32 05:59:52 INFO - Cleaning up... 05:59:52 INFO - Return code: 0 05:59:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:59:52 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')]} 05:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:52 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')]} 05:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:52 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 0x7fe004507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, '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': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', '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 05:59:52 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 05:59:52 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 05:59:52 INFO - Using env: {'DISPLAY': ':0', 05:59:52 INFO - 'HOME': '/home/cltbld', 05:59:52 INFO - 'LANG': 'en_US.UTF-8', 05:59:52 INFO - 'LANGUAGE': 'en_US:en', 05:59:52 INFO - 'LOGNAME': 'cltbld', 05:59:52 INFO - 'MAIL': '/var/mail/cltbld', 05:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:52 INFO - 'MOZ_NO_REMOTE': '1', 05:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:52 INFO - 'NO_EM_RESTART': '1', 05:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:52 INFO - 'PWD': '/builds/slave/test', 05:59:52 INFO - 'SHELL': '/bin/bash', 05:59:52 INFO - 'SHLVL': '1', 05:59:52 INFO - 'TERM': 'linux', 05:59:52 INFO - 'TMOUT': '86400', 05:59:52 INFO - 'USER': 'cltbld', 05:59:52 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 05:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:52 INFO - '_': '/tools/buildbot/bin/python'} 05:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:52 INFO - Downloading/unpacking flake8 05:59:52 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 05:59:52 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 05:59:52 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 05:59:52 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 05:59:52 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 05:59:52 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 05:59:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:59:53 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 05:59:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:59:54 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 05:59:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 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 05:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:54 INFO - no previously-included directories found matching 'docs/_build' 05:59:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:59:54 INFO - Running setup.py install for pep8 05:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:54 INFO - no previously-included directories found matching 'docs/_build' 05:59:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:59:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:59:54 INFO - Cleaning up... 05:59:54 INFO - Return code: 0 05:59:54 INFO - Running post-action listener: _resource_record_post_action 05:59:54 INFO - Running post-action listener: _start_resource_monitoring 05:59:54 INFO - Starting resource monitoring. 05:59:54 INFO - ##### 05:59:54 INFO - ##### Running install step. 05:59:54 INFO - ##### 05:59:54 INFO - Running pre-action listener: _resource_record_pre_action 05:59:54 INFO - Running main action method: install 05:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:55 INFO - Reading from file tmpfile_stdout 05:59:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:55 INFO - Reading from file tmpfile_stdout 05:59:55 INFO - Output received: 05:59:55 INFO - Usage: mozinstall [options] installer 05:59:55 INFO - Options: 05:59:55 INFO - -h, --help show this help message and exit 05:59:55 INFO - -d DEST, --destination=DEST 05:59:55 INFO - Directory to install application into. [default: 05:59:55 INFO - "/builds/slave/test"] 05:59:55 INFO - --app=APP Application being installed. [default: firefox] 05:59:55 INFO - mkdir: /builds/slave/test/build/application 05:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:00:09 INFO - Reading from file tmpfile_stdout 06:00:09 INFO - Output received: 06:00:09 INFO - /builds/slave/test/build/application/firefox/firefox 06:00:09 INFO - Running post-action listener: _resource_record_post_action 06:00:09 INFO - ##### 06:00:09 INFO - ##### Running run-tests step. 06:00:09 INFO - ##### 06:00:09 INFO - Running pre-action listener: _resource_record_pre_action 06:00:09 INFO - Running main action method: run_tests 06:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:00:09 INFO - Python 2.7.3 06:00:09 INFO - Return code: 0 06:00:09 INFO - grabbing minidump binary from tooltool 06:00:09 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')]} 06:00:09 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 0x1bc20b0>, '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 0x1bc2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:00:09 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 06:00:09 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 06:00:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:09 INFO - Return code: 0 06:00:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:00:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:00:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:00:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:00:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:00:10 INFO - Return code: 0 06:00:10 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/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test/build 06:00:10 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/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 06:00:10 INFO - Using env: {'DISPLAY': ':0', 06:00:10 INFO - 'HOME': '/home/cltbld', 06:00:10 INFO - 'LANG': 'en_US.UTF-8', 06:00:10 INFO - 'LANGUAGE': 'en_US:en', 06:00:10 INFO - 'LOGNAME': 'cltbld', 06:00:10 INFO - 'MAIL': '/var/mail/cltbld', 06:00:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:00:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:10 INFO - 'MOZ_NO_REMOTE': '1', 06:00:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:10 INFO - 'NO_EM_RESTART': '1', 06:00:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:10 INFO - 'PWD': '/builds/slave/test', 06:00:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:00:10 INFO - 'SHELL': '/bin/bash', 06:00:10 INFO - 'SHLVL': '1', 06:00:10 INFO - 'TERM': 'linux', 06:00:10 INFO - 'TMOUT': '86400', 06:00:10 INFO - 'USER': 'cltbld', 06:00:10 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691', 06:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:10 INFO - '_': '/tools/buildbot/bin/python'} 06:00:10 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/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 06:00:10 INFO - mozversion INFO | application_buildid: 20151215030512 06:00:10 INFO - mozversion INFO | application_changeset: 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 06:00:10 INFO - mozversion INFO | application_display_name: Nightly 06:00:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:10 INFO - mozversion INFO | application_name: Firefox 06:00:10 INFO - mozversion INFO | application_remotingname: firefox 06:00:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:00:10 INFO - mozversion INFO | application_vendor: Mozilla 06:00:10 INFO - mozversion INFO | application_version: 46.0a1 06:00:10 INFO - mozversion INFO | platform_buildid: 20151215030512 06:00:10 INFO - mozversion INFO | platform_changeset: 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 06:00:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:00:10 INFO - mozversion INFO | platform_version: 46.0a1 06:00:10 INFO - 2015-12-15 06:00:10,894 DEBUG : using testdate: 1450188010 06:00:10 INFO - 2015-12-15 06:00:10,894 DEBUG : actual date: 1450188010 06:00:10 INFO - 2015-12-15 06:00:10,982 INFO : starting webserver on 'localhost:39888' 06:00:10 INFO - 2015-12-15 06:00:10,983 INFO : Starting test suite talos-linux64-ix-042.e 06:00:10 INFO - 2015-12-15 06:00:10,983 INFO : Starting test dromaeo_css 06:00:10 INFO - 2015-12-15 06:00:10,983 DEBUG : operating with platform_type : linux_ 06:00:10 INFO - 2015-12-15 06:00:10,983 INFO : Initialising browser for dromaeo_css test... 06:00:10 INFO - 2015-12-15 06:00:10,998 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqlW0dT/profile http://localhost:39888/getInfo.html 06:00:16 INFO - 2015-12-15 06:00:16,930 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:16 INFO - 2015-12-15 06:00:16,931 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:16 INFO - 2015-12-15 06:00:16,931 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:00:16 INFO - 2015-12-15 06:00:16,931 DEBUG : BROWSER_OUTPUT: __metrics 06:00:17 INFO - 2015-12-15 06:00:17,088 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] 06:00:18 INFO - 2015-12-15 06:00:18,008 INFO : Browser initialized. 06:00:18 INFO - 2015-12-15 06:00:18,009 INFO : Running cycle 1/1 for dromaeo_css test... 06:00:18 INFO - 2015-12-15 06:00:18,009 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqlW0dT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:00:30 INFO - 2015-12-15 06:00:30,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 143220736 06:00:30 INFO - 2015-12-15 06:00:30,004 DEBUG : BROWSER_OUTPUT: 06:01:19 INFO - 2015-12-15 06:01:19,621 DEBUG : BROWSER_OUTPUT: 1450188079616 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] 06:03:31 INFO - 2015-12-15 06:03:31,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39888/tests/dromaeo/cssquery-ext.html) 06:03:32 INFO - 2015-12-15 06:03:32,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 146046976 06:03:32 INFO - 2015-12-15 06:03:32,289 DEBUG : BROWSER_OUTPUT: 06:06:34 INFO - 2015-12-15 06:06:34,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/dromaeo/cssquery-ext.html (next: http://localhost:39888/tests/dromaeo/cssquery-jquery.html) 06:06:34 INFO - 2015-12-15 06:06:34,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 143519744 06:06:34 INFO - 2015-12-15 06:06:34,896 DEBUG : BROWSER_OUTPUT: 06:09:36 INFO - 2015-12-15 06:09:36,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39888/tests/dromaeo/cssquery-mootools.html) 06:09:37 INFO - 2015-12-15 06:09:37,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 146694144 06:09:37 INFO - 2015-12-15 06:09:37,387 DEBUG : BROWSER_OUTPUT: 06:12:39 INFO - 2015-12-15 06:12:39,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39888/tests/dromaeo/cssquery-prototype.html) 06:12:39 INFO - 2015-12-15 06:12:39,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 144445440 06:12:39 INFO - 2015-12-15 06:12:39,748 DEBUG : BROWSER_OUTPUT: 06:15:42 INFO - 2015-12-15 06:15:42,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39888/tests/dromaeo/cssquery-yui.html) 06:15:42 INFO - 2015-12-15 06:15:42,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 143839232 06:15:42 INFO - 2015-12-15 06:15:42,989 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/dromaeo/cssquery-yui.html (next: http://localhost:39888/tests/dromaeo/cssquery-dojo.html) 06:18:45 INFO - 2015-12-15 06:18:45,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 147976192 06:18:45 INFO - 2015-12-15 06:18:45,677 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,678 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:18:45 INFO - 2015-12-15 06:18:45,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:18:45 INFO - 2015-12-15 06:18:45,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:18:45 INFO - 2015-12-15 06:18:45,679 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:18:45 INFO - 2015-12-15 06:18:45,680 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2614.516314481821;2674.1175412114003;2697.4874773792976;2705.6347393101937;2720.6327145835307;4519.52544982777;4696.060787842433;4770.952290477098;4782.665213435061;4783.952160478394;4655.464621568521;4692.389989301386;4703.600193983507;4704.952950470494;4736.90526189476;4287.842282583701;4332;4355.934660980072;4357.324614684729;4359.629431498311;4194.245035893553;4350.412694286262;4370.38814565961;4398.164348773738;4413.095315460323;4288.549702281262;4320.848770293024;4389.890252743675;4392;4411.691181617256;4367.999203464934;4372.606465418127;4375.584319489675;4396.428464299621;4431.6233120184825;4225.302825033866;4300.892477688051;4344.283193273106;4368.89077773055;4395.670324725626;4491.146682130385;4506.053728716974;4555.202839503107;4562.817487300504;4642.698224615389;5005.724685142316;5052.696838189684;5055.69665820052;5060.443351231362;5067.138586440277;4886.780094895703;4964.776585053682;4971.676841005359;5075.873103172414;5115.61632877532;4675;4729.456112547066;4738.928916066262;4739.075880203396;4764.356811830427;5212.192110222922;5217.921731174036;5226.320578324793;5235.1623740201385;5237.790488380422;4793.520647935178;4899.3385892904;4902.093112774148;4904.828331008469;5050.974745126251;4963.900721985612;4987.177115775857;5001.349824522788;5006.123928312531;5075.543201111917;5023.34696489454;5070;5074.746262686925;5090.847274581768;5110.131277682803;4790.161721698689;5040.420351659606;5041.395032596112;5063.87340316495;5074.695518268915;4104.4048612950955;4145.481814773153;4196.664266858644;4202.3696445533415;4235.767032813224;3717.275131349415;3722.683571896365;3733.160038991205;3737.1404576947452;3769.359208934433;4257.914841703148;4342.956570434319;4427.380166776654;4434.268345722984;4445.3998710174355;5020.874478138003;5074.797008119634;5076.263941728429;5109.284700141983;5158.97420512895;4415.712978656377;4463.754493502824;4476.283794592915;4478.641708663365;4482.417285752831;4315.611594956469;4411.823527058946;4541.3188021797;4555.180067587866;4580.427446569179;4749.477557468745;4759.16714574948;4793.592544633745;4813.133635945564;4844.515548445127;5087.389513258433;5114.565261952627;5130.230465430066;5133.563647090039;5151.484851514969;4700.106979673988;4741.383620129361;4812.532177685839;4836.443808962014;4886.975565122151;5028.9245661315845;5032.949670503394;5034.395872495177;5038.168702164102;5045.31888195089;5087.87280317995;5097.7960881565805;5102.260172274925;5105.055564720538;5156.896862062813;4775;4847.248676455155;4870.1964175912;4953.727544984917;4954.801807927643;4854.5873600744335;4871.464138944642;4886.975565122294;4919.0407870464915;4926.876828079184;4771.117343291502;4792.544708252711;4795.95204047955;4806.519348065165;4827.927581086216;4672.813087476463;4768.928466072943;4859.392575928009;4894.2658601210105;4948.15881300187;4839.225723884161;4853.369062021915;4867.5862551682085;4915.729634870117;4941.777620007037 06:18:45 INFO - 2015-12-15 06:18:45,682 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.7636392715059;570.0394834703523;571.6970005896874;572.5419664268585;579.7072478398408;36334.45498317524;36975;37073.814630926805;37115.443268350995;37173.814130929306;38985;39510.40734388986;39598.20803583926;39616;39658.40512392309;7856.646450909694;8004.719834805783;8019.839603207933;8038.758837234863;8040.8793868092025;7737.187595302496;7785.299323060952;7796.1814009529035;7818.45270831042;7821.335186509154;7916.643751031217;7975.7607271781935;8000.439969202158;8013.11855695873;8022.438429309921;7832.921670783305;7959.96020019902;7965.084015338223;7971.760847174536;7993.96003019987;7818.14000459949;7864.646090925922;7897.60511974399;7905.486143400718;7917.960410197912;36351.27297454036;36716.63283367186;36912.63087369146;36957.260854782755;37256;3168.714815666601;3189.409959157563;3434.5363375944426;3450.723942084652;3737.364648009845;26387.34031649205;26397.73602263972;26496.73503264962;26506.469870602672;26651.866740666173;3473.5831700195886;3475.5481787367735;3484.860605575774;3535.505029295901;3555.2000799820094;216863;218582;218590;218595;219131;46730.5326946733;47477.52522474731;53991.730041350325;54221;55118;55696.44303556912;55884.72057639686;56119;56187;56228;13780.65548361299;13876.098053626481;13891.722165556632;13903.374348154357;13922.37349319283;10646.307989980627;10761.30051546647;10795.946020269848;10797.46012699362;10801.351918884891;19085.618287634446;19362.90318548398;19396;19401.514962125777;19404.12681429339;7623.733169339157;7752.341051010614;7915.525068495908;7934.960325198453;7970.322522585529;763.9083310002835;777.700585274662;823.4894365493312;831.7546323834483;867.952262625549;23823.523529529313;23853.522929541658;24001;24106.156284529956;24125.276241712778;876.5836227791875;924.9075092490697;950.6625148072472;983.6753871222479;1010.6917390195914;12289.201201921847;12341.814872776915;12450.377481125908;12533.498660053678;12578.685532861751;259159;261155.4711132237;262686;263523;265623;44969.55030449719;45321.86695332643;45641.543584564395;45735.771321143184;45799.542004580195;1196.3420118934725;1274.2736640115045;1283.3839756916545;1286.6847622332589;1289.7291568770477;23909.402264943517;24402.145924892542;24520.75479245256;24615.13847015346;24640.260792176265;38525.80737096297;38713;38810.80594597009;38904.416433754086;38909;249050;249388;249486;251204;251570;28352.716472835833;28550.286242843264;28721.856390717912;28808.855955720926;28843.56734649024;33951.66048339485;34060.31879362349;34483.482747759306;34657.306853862276;36617.81691091527;31458.685413145577;31995.36009279848;32248.677513225506;32818.17954551155;33222.667773321955;32535.349293014482;32650.673493264763;32846.34307313888;32846.67153328436;32969.34061318712;31652.208694782814;32219.838900805345;32314.192145196557;32401.51397729083;32459.675403245667;27584.862075689492;29002.274943125747;29054.418911622073;29746;29856;21940.45148871291;23248.4187895304;23817.880910595337;23835.284941451784;24183.274501764976 06:18:45 INFO - 2015-12-15 06:18:45,685 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.6603197754278;334.7589735390518;336.8602030157485;339.6976690745236;341.7744288769412;14860;15134.77082269919;16084.195790210471;16673.749893751603;17322.13389330535;10119.797604047933;10386;10400.947995260032;10646.733831654212;10659.893401065987;4696.459907110675;4844.5882100021545;4847.733374664392;4850.611951043926;4854.029194161164;4835.685680430778;5006.374203224597;5009.599232061444;5017.247412888078;5021.472745361739;3528.276703275835;4988.975055124737;5010.874728131789;5078;5316.175992721134;5256.369235691723;5263.789448422059;5274.709890955995;5276.182191760283;5313.0967735485065;4607.331936869169;4767.76161191939;4780.880477988078;5089.720065396402;5110.105731496973;11224.382658953755;11252;11305.208635395526;15644.843551564452;17626.823731762648;1757.8330058644408;1790.9283628654969;1791.3013924569427;1801.0994502748626;1872.7565416495904;5928.318243402021;5942.3760505146765;6270.46701030413;6984.952257161415;8954.820903581893;1669.1018053044725;1743.4246698589436;1758.3757765993016;1772.6809174348612;1772.8758986870923;53274.46725532734;54704.72647636776;57269.42730572683;57273.427265727645;57464.138037929464;9637;9821.852672209923;9909;9927.40435573868;10068.647597334058;11964.82052769209;11998.520059197708;12011.099167562468;12025.398730063462;12029.218100823418;6897.586144831226;7061.187963384276;7089.291070892869;7132.964335178291;7153.856922861513;6608.471322294205;6652.301508341651;6667.533272670964;6684.665766711645;6703.128593282842;4193.496780386373;4205.957940420618;4224.852130175491;4275.87172384829;4275.973766296067;1728.3605066125615;1776.2539733311783;1792.9641407172044;1793.1482545790645;1799.4961410804995;715.5277516838861;774.767569729079;819.4304958054095;936.8688383626297;945.874409452749;14688.118712877262;15438.9228053859;15662;16071.276792544364;16091.275892584861;381.46404301955795;392.4760444806159;397.7792325259451;402.30200601955585;411.80645096804454;5123.923141152885;5138.8972220556125;5244.947550524446;5272.736363181825;5286.7092309922555;479688;481981;487285;489251;494829;66244.6687766558;66714.66642666755;73415.63292183504;75775;77412.22587774051;433.66607712061534;442.09591385616494;442.2084468800875;442.2238970606629;442.5861819199059;9129.908700912905;9299.581518831805;9405.811883762422;9450.480223587769;9618.326717129734;33711.3257734839;35103.297934041686;36452.08869778277;36490.63509364872;36579.634203657624;44438.333424998;44725.329120062575;45278.32082518699;46147.76926115482;51886.48113518967;8615.91384086151;8793.120687931156;9310.95344523273;9316.394434361744;9321.72034838956;10026.448545330077;10128.746781330527;10145.49272536385;15883.602909927344;16719.49841504757;12366.505339786308;13634.522791702242;13654.658633534242;13776.380062896993;14112.012159149172;13147.868521314664;13191.40638671243;13466.057375983979;13558.86441135576;13761.17432954026;13447.260400678057;14998.400063997318;15091.471798487;15181.240937953278;15264;8919.687810926587;8990.730278091667;9082.909170908206;9219.953900230725;9228.584713688035;13648.65878353049;13751.17492950386;13873.930630346784;13932.094413863066;14066.859331406555 06:18:45 INFO - 2015-12-15 06:18:45,685 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1354.471756015154;1409.6123566019346;1494.4022391043582;1616.1757503673123;1685.1911082680313;5884.970575147129;6137.07943808429;6349.206349206349;6726.6972986215615;6734.9326506734915;6412.711427985741;6620;6625.204975402959;6646.667666616674;6656.167979002625;2024.4028011736573;2043.2235750414823;2056.845736569756;2061.7732049474544;2068.379486154155;1966.587016726489;2020.8282296004857;2023.8178563929243;2024.4938765308673;2029.6853987631941;1973.1318219983234;1990.99004504978;1991.1139542903413;1997.2610134250276;1998.6502362086649;2038.918443262275;2042.5710600773855;2063.4531849060013;2063.566651003291;2066.152877320299;1988.741463609736;2005.3683089826804;2045.4375046862083;2046.907889144992;2051.661475856482;6728.461723062143;6772.55978361405;6789.117414736102;6791.2869148739655;6821.386075253202;3970.68234541236;4059.8173082211074;4068.8982775430554;4075.735077219971;4087.4686290782306;2584.3022383956413;2626.724193959645;2628.6319915211693;2654.9336266593295;2659.162363855379;852.1180578101697;852.1861622150831;872.4634349874844;882.6866462405818;894.6510860764307;8952.239059679934;8975.474169391218;9017.639294428214;9019.323550733721;9036;3660.816959152032;3671.724620653462;3705.7776533408082;3710.406334986389;3724.478572999782;7891.210878912178;7906.841863162705;7919.960400197962;7930.1276859545405;7941.36469082472;4044.1102957349335;4054.1283624020975;4060.0661847774586;4068.6541643960004;4084.2852500812833;3564.500969864221;3588.6231945645854;3614.1326081740194;3693.741438099361;3752.1370084880086;3139.3564319314487;3164.7784655074383;3177.6345720242466;3188.0913939527586;3202.631697354834;921.3044151665449;926.6941909169958;928.726025822384;933.9439633622004;935.9485228312508;1045.2160879340495;1051.8264486359665;1052.3422860712055;1055.8996895294936;1081.6809041332667;6413.102165696806;6424.164858568356;6462.903056454157;6470.870582588416;6475.093486911836;418.3285826248888;425.10303260121117;433.07538405504476;433.26128950139935;433.3261777935341;4794.161021821237;4816.710997340171;4855.198892182821;4898.191798353303;5020;7858.332041776513;8047.155048719917;8067.39494537912;8082.676692932335;8113.188681131957;7932.28609425143;7970.681172753025;8044.718434854752;8046.235607617267;8051.63767630458;6326.2092238470195;6381.680915954184;6391.58454700443;6456.451201647913;6504;6261.0608408737235;6263.937360626335;6264.968675156595;6265.8746825062335;6277.623342599459;7093.964530177316;7256.2018177999325;7423.480356375002;7438.479306448713;7541.4343924207005;6785.93214067853;6910.136232970879;6935.202451718117;7431.4054875608745;7539.095308563007;5208.010478009166;5400.864978375572;6008.819735407945;6055.394460553909;6091.573589848668;6303.716332765129;6308.526860485574;6328.114064030948;6346.333634968262;6350.491960643045;5782.161586570008;6034.69826508664;6055.666938318434;6124.693765311806;6156.322804491413;6101;6117.571769976059;6177.413145751147;6227.906581401192;6260.154879091447;5621.550275977994;5991.430814072656;6021.7591296347655;6051.727672254671;6061.39386061408;5693.601447898607;5711.286089238845;5717.171010203414;5740.9953258180485;5768.423157684366;5520.089185284383;5793.884122317614;5842.2405087338375;5844.912326315194;5897.203877476486 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.5327961739877;301.1447489130868;303.98480075996196;304.0407514292408;306.4896946583938;5486.670799752008;5568.638038527503;5599.832005039851;5653.180288858113;5654.886902261957;5400.459954004607;5525.640833345829;5558.333000039991;5562.499375056244;5565.471280228382;4243.469566304212;4243.511996120455;4246.129543443602;4259.382389553512;4259.8296068157315;4244.851430199944;4246.426732391134;4251.87244382669;4254.7021708480415;4261.509926358462;4059.6143366380147;4174.352975288835;4215.262329092412;4215.5784421557755;4228.577142285762;4171.582841715835;4173.7495750254775;4179.728317659343;4179.874603761892;4184.748915065105;3634.83643236055;3651.598324184338;3652.9269414611827;3654.5614526256754;3655.342038433081;5355.410904800468;5371.060064488699;5372.811951581715;5372.811951581715;5377.8117765878005;4684.086603112394;4838.709677419366;4846.176150054499;4857.781399837016;4863.683860549088;5671.546276297886;5775.682337471438;5793.594448388614;5807.88384232313;5813.854653633651;3962.5443074046566;3973.3443981742976;3973.940390894139;3984.342583473723;3984.5816189300285;6038.124471951586;6056.9697151513965;6101.755929762804;6139.293981192131;6146.600470969417;3953.288408086572;4098.979505102456;4103.179364127186;4107.116969851496;4107.712460127762;4140.296149654566;4156.771377574202;4157.08544120293;4158.106007208404;4169.10364271677;4784.521547845257;4794.976025119852;4812.759362031885;4813.566778989838;4816.4220293564995;5759;5759.971200143972;5792.594518383757;5809.564282678816;5821.155932389865;1427.6716355238354;1461.298576683198;1482.5330021043337;1482.6738117614107;1482.844301348343;964.0504103458088;987.234892957949;988.7972965542046;997.2969056814928;998.9600415983425;4981.153203955337;5028.094942910311;5051.696898186047;5055.014272216956;5061.848144555669;5983.790567330209;6004.0693692477735;6004.489618382487;6010.849728756816;6017.308009578867;5028.547430731252;5035.697858128451;5041.974790126026;5063.06333328328;5063.696178229318;3115.735162511212;3249.6100467943998;3249.805011699258;3251.235959549504;3256.706896379337;5651.6043876928225;5652.3217213934595;5658.943410565924;5659.094544872801;5670.177824215466;6129.632222066691;6152.78465253714;6154.415330543591;6171.722272497748;6178.165947597106;5494.725263736797;5617.241672374259;5638.2670252866865;5650.604457688087;5663.631863928914;6005;6005.549583781147;6011.128386384037;6015.157877897185;6015.488683461955;5848.035074212878;5856.326522449973;5864.266966629171;5867.149263356704;5871.500922421642;5491.945080549143;5585.553155747449;5609.719514024364;5638.661680299195;5646.971765141148;4105.548389677074;4106.917861642691;4109.815058322323;4110.876673699794;4114.115465175002;5994.580379373577;5996.640201587918;5999.220101386792;6002.549808764447;6007;5766.5675074368755;5778.075507918713;5780.219670344618;5780.421957804186;5780.5953583248765;5640.353264230695;5686.289213848269;5743.10981797822;5776.451237132465;5779.075347944308;5646.576506762091;5652.802151924663;5659.434056594308;5668.574856885833;5682.090865461506;5630.0991841305195;5688.061469857427;5708.828735137952;5799.9130013049;5896.204012458264;5767.826965191051;5776.249087618583;5777.8555536111935;5779.855503612275;5793.739281732416 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: |5;yui.html;694.1669996004796;695.9582425054497;696.7317582730649;698.3993765361791;711.2816055783657;12024;12426.068044896647;12459.37703114844;12466.688332791684;13702;13635.181889086662;13709.520166794164;13745.450181992734;13770.24263665498;13832.654183645389;792.6036981509245;792.8493586218628;798.9840203195932;817.4686453805015;818.8362327534487;806.2582424169749;810.1452967119686;811.0308181722844;817.3134566963749;819.5082950229844;852.4842470305468;856.7130011446174;857.6783706110209;859.4928991894781;861.1689719420758;842.3093063687778;843.7763992541982;846.8137009857821;846.8433339832089;847.2586486824028;624.684534310175;625.6621424430801;627.7489004398232;636.8694417644418;637.2862394118616;10769.676909692722;10892.292001019909;10901.073408760265;10902.127829773599;10927.562897484091;10989.670309890636;10999.780004399867;11262.605808796652;11279.548818047268;11333.773324533546;9289.210417114553;9308.394954328014;9322.48726320052;9559.474228917406;9563;3206.070239630504;3230.4185246655593;3269.1990462336644;3286.063471910518;3305.8512366943305;41249.38125928114;41358.586414135774;41365.79317103425;41405.585944140774;41470.792646036876;8118.10700822909;8333.791655208668;8423.536705481258;8479.06730259671;8503.574821258911;12764.29796361209;12875.613731588068;12952.222866628032;12962.092653514352;13041.282729449782;6337.429631333202;6357.300696923335;6492.415682588589;6517.9245424504425;6636.668166591651;3838.5393752749846;3878.127421330178;3893.240818040455;3916.7258291919293;3942.72400931932;2657.4419371932113;2694.797890158246;2694.90567830125;2696.5955106734145;2700.66241719785;452.75098695717224;459.9448066232007;465.55539459815793;480.48827998181827;481.30211193768474;433.1748020021863;442.16941860696744;524.9893954138269;572.5276646766434;573.0401577357909;7128.714851405989;7903.525788452711;8017.478863873829;8042;8075.313598344206;477.4557005014286;557.6849080269716;561.1246455529388;565.197419664078;588.5404197589916;3505.2463720299747;3566.589842168132;3617.6744093031753;3687.575928768172;3704.7962362070343;48231;48268.7586562065;48304.5169548307;48565.514344856805;48616.51383486191;40653.390199147034;42186;42290.57709422928;42646.36030459546;43030.13939721251;36410.45384319237;40037;40187.39718904219;40448.79775601162;40836.38745418881;7708.961455192688;7837.373010159287;8098.5545794981845;8172.5913704315735;8299.709510167115;30886;31189.84405078051;31312.843435782674;31953.201169970005;32248;36143.277134456635;39229.41155882607;40100.1979960405;40346.79826600848;40699.186016278916;9938.354006989523;9977.60089596408;10248.590056397661;10307.278490505892;10381.740456488647;11394.293929554271;11473.139514536277;11517.884821152016;11597.76804463923;12044.21712588679;10320.43237621938;10422.843657344994;10606.09848162884;11050.889491105308;11084.224104312621;10705.197110216921;10763.784724305313;10954.397508137128;11020.724481888017;11279.661610151708;10344.172466202535;10878.836817447585;11263;11373.715657108307;11376.601818936297;9215.2627789778;9463.526823658927;9611.134997850228;9635.903640963501;9785.706428807147;8221;8621.741347759576;8942.955285223532;9475.336726429085;9577.185939195246 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: __startTimestamp1450189125677__endTimestamp 06:18:45 INFO - 2015-12-15 06:18:45,689 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,690 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:18:45 INFO - 2015-12-15 06:18:45,690 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:18:45 INFO - 2015-12-15 06:18:45,690 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,691 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4662.72 Median:4783.95 stddev:487.07 (10.2%) stddev-sans-first:461.30 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: Values: 2614.5 2674.1 2697.5 2705.6 2720.6 4519.5 4696.1 4771.0 4782.7 4784.0 4655.5 4692.4 4703.6 4705.0 4736.9 4287.8 4332.0 4355.9 4357.3 4359.6 4194.2 4350.4 4370.4 4398.2 4413.1 4288.5 4320.8 4389.9 4392.0 4411.7 4368.0 4372.6 4375.6 4396.4 4431.6 4225.3 4300.9 4344.3 4368.9 4395.7 4491.1 4506.1 4555.2 4562.8 4642.7 5005.7 5052.7 5055.7 5060.4 5067.1 4886.8 4964.8 4971.7 5075.9 5115.6 4675.0 4729.5 4738.9 4739.1 4764.4 5212.2 5217.9 5226.3 5235.2 5237.8 4793.5 4899.3 4902.1 4904.8 5051.0 4963.9 4987.2 5001.3 5006.1 5075.5 5023.3 5070.0 5074.7 5090.8 5110.1 4790.2 5040.4 5041.4 5063.9 5074.7 4104.4 4145.5 4196.7 4202.4 4235.8 3717.3 3722.7 3733.2 3737.1 3769.4 4257.9 4343.0 4427.4 4434.3 4445.4 5020.9 5074.8 5076.3 5109.3 5159.0 4415.7 4463.8 4476.3 4478.6 4482.4 4315.6 4411.8 4541.3 4555.2 4580.4 4749.5 4759.2 4793.6 4813.1 4844.5 5087.4 5114.6 5130.2 5133.6 5151.5 4700.1 4741.4 4812.5 4836.4 4887.0 5028.9 5032.9 5034.4 5038.2 5045.3 5087.9 5097.8 5102.3 5105.1 5156.9 4775.0 4847.2 4870.2 4953.7 4954.8 4854.6 4871.5 4887.0 4919.0 4926.9 4771.1 4792.5 4796.0 4806.5 4827.9 4672.8 4768.9 4859.4 4894.3 4948.2 4839.2 4853.4 4867.6 4915.7 4941.8 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39955.08 Median:18959.01 stddev:63642.51 (335.7%) stddev-sans-first:63752.31 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: Values: 562.8 570.0 571.7 572.5 579.7 36334.5 36975.0 37073.8 37115.4 37173.8 38985.0 39510.4 39598.2 39616.0 39658.4 7856.6 8004.7 8019.8 8038.8 8040.9 7737.2 7785.3 7796.2 7818.5 7821.3 7916.6 7975.8 8000.4 8013.1 8022.4 7832.9 7960.0 7965.1 7971.8 7994.0 7818.1 7864.6 7897.6 7905.5 7918.0 36351.3 36716.6 36912.6 36957.3 37256.0 3168.7 3189.4 3434.5 3450.7 3737.4 26387.3 26397.7 26496.7 26506.5 26651.9 3473.6 3475.5 3484.9 3535.5 3555.2 216863.0 218582.0 218590.0 218595.0 219131.0 46730.5 47477.5 53991.7 54221.0 55118.0 55696.4 55884.7 56119.0 56187.0 56228.0 13780.7 13876.1 13891.7 13903.4 13922.4 10646.3 10761.3 10795.9 10797.5 10801.4 19085.6 19362.9 19396.0 19401.5 19404.1 7623.7 7752.3 7915.5 7935.0 7970.3 763.9 777.7 823.5 831.8 868.0 23823.5 23853.5 24001.0 24106.2 24125.3 876.6 924.9 950.7 983.7 1010.7 12289.2 12341.8 12450.4 12533.5 12578.7 259159.0 261155.5 262686.0 263523.0 265623.0 44969.6 45321.9 45641.5 45735.8 45799.5 1196.3 1274.3 1283.4 1286.7 1289.7 23909.4 24402.1 24520.8 24615.1 24640.3 38525.8 38713.0 38810.8 38904.4 38909.0 249050.0 249388.0 249486.0 251204.0 251570.0 28352.7 28550.3 28721.9 28808.9 28843.6 33951.7 34060.3 34483.5 34657.3 36617.8 31458.7 31995.4 32248.7 32818.2 33222.7 32535.3 32650.7 32846.3 32846.7 32969.3 31652.2 32219.8 32314.2 32401.5 32459.7 27584.9 29002.3 29054.4 29746.0 29856.0 21940.5 23248.4 23817.9 23835.3 24183.3 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25882.92 Median:442.41 stddev:79633.64 (18000.2%) stddev-sans-first:79833.92 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: Values: 334.7 334.8 336.9 339.7 341.8 14860.0 15134.8 16084.2 16673.7 17322.1 10119.8 10386.0 10400.9 10646.7 10659.9 4696.5 4844.6 4847.7 4850.6 4854.0 4835.7 5006.4 5009.6 5017.2 5021.5 3528.3 4989.0 5010.9 5078.0 5316.2 5256.4 5263.8 5274.7 5276.2 5313.1 4607.3 4767.8 4780.9 5089.7 5110.1 11224.4 11252.0 11305.2 15644.8 17626.8 1757.8 1790.9 1791.3 1801.1 1872.8 5928.3 5942.4 6270.5 6985.0 8954.8 1669.1 1743.4 1758.4 1772.7 1772.9 53274.5 54704.7 57269.4 57273.4 57464.1 9637.0 9821.9 9909.0 9927.4 10068.6 11964.8 11998.5 12011.1 12025.4 12029.2 6897.6 7061.2 7089.3 7133.0 7153.9 6608.5 6652.3 6667.5 6684.7 6703.1 4193.5 4206.0 4224.9 4275.9 4276.0 1728.4 1776.3 1793.0 1793.1 1799.5 715.5 774.8 819.4 936.9 945.9 14688.1 15438.9 15662.0 16071.3 16091.3 381.5 392.5 397.8 402.3 411.8 5123.9 5138.9 5244.9 5272.7 5286.7 479688.0 481981.0 487285.0 489251.0 494829.0 66244.7 66714.7 73415.6 75775.0 77412.2 433.7 442.1 442.2 442.2 442.6 9129.9 9299.6 9405.8 9450.5 9618.3 33711.3 35103.3 36452.1 36490.6 36579.6 44438.3 44725.3 45278.3 46147.8 51886.5 8615.9 8793.1 9311.0 9316.4 9321.7 10026.4 10128.7 10145.5 15883.6 16719.5 12366.5 13634.5 13654.7 13776.4 14112.0 13147.9 13191.4 13466.1 13558.9 13761.2 13447.3 14998.4 15091.5 15181.2 15264.0 8919.7 8990.7 9082.9 9220.0 9228.6 13648.7 13751.2 13873.9 13932.1 14066.9 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,692 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4697.55 Median:6000.13 stddev:2426.44 (40.4%) stddev-sans-first:2420.24 06:18:45 INFO - 2015-12-15 06:18:45,693 DEBUG : BROWSER_OUTPUT: Values: 1354.5 1409.6 1494.4 1616.2 1685.2 5885.0 6137.1 6349.2 6726.7 6734.9 6412.7 6620.0 6625.2 6646.7 6656.2 2024.4 2043.2 2056.8 2061.8 2068.4 1966.6 2020.8 2023.8 2024.5 2029.7 1973.1 1991.0 1991.1 1997.3 1998.7 2038.9 2042.6 2063.5 2063.6 2066.2 1988.7 2005.4 2045.4 2046.9 2051.7 6728.5 6772.6 6789.1 6791.3 6821.4 3970.7 4059.8 4068.9 4075.7 4087.5 2584.3 2626.7 2628.6 2654.9 2659.2 852.1 852.2 872.5 882.7 894.7 8952.2 8975.5 9017.6 9019.3 9036.0 3660.8 3671.7 3705.8 3710.4 3724.5 7891.2 7906.8 7920.0 7930.1 7941.4 4044.1 4054.1 4060.1 4068.7 4084.3 3564.5 3588.6 3614.1 3693.7 3752.1 3139.4 3164.8 3177.6 3188.1 3202.6 921.3 926.7 928.7 933.9 935.9 1045.2 1051.8 1052.3 1055.9 1081.7 6413.1 6424.2 6462.9 6470.9 6475.1 418.3 425.1 433.1 433.3 433.3 4794.2 4816.7 4855.2 4898.2 5020.0 7858.3 8047.2 8067.4 8082.7 8113.2 7932.3 7970.7 8044.7 8046.2 8051.6 6326.2 6381.7 6391.6 6456.5 6504.0 6261.1 6263.9 6265.0 6265.9 6277.6 7094.0 7256.2 7423.5 7438.5 7541.4 6785.9 6910.1 6935.2 7431.4 7539.1 5208.0 5400.9 6008.8 6055.4 6091.6 6303.7 6308.5 6328.1 6346.3 6350.5 5782.2 6034.7 6055.7 6124.7 6156.3 6101.0 6117.6 6177.4 6227.9 6260.2 5621.6 5991.4 6021.8 6051.7 6061.4 5693.6 5711.3 5717.2 5741.0 5768.4 5520.1 5793.9 5842.2 5844.9 5897.2 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4784.47 Median:5560.42 stddev:1419.53 (25.5%) stddev-sans-first:1383.01 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: Values: 298.5 301.1 304.0 304.0 306.5 5486.7 5568.6 5599.8 5653.2 5654.9 5400.5 5525.6 5558.3 5562.5 5565.5 4243.5 4243.5 4246.1 4259.4 4259.8 4244.9 4246.4 4251.9 4254.7 4261.5 4059.6 4174.4 4215.3 4215.6 4228.6 4171.6 4173.7 4179.7 4179.9 4184.7 3634.8 3651.6 3652.9 3654.6 3655.3 5355.4 5371.1 5372.8 5372.8 5377.8 4684.1 4838.7 4846.2 4857.8 4863.7 5671.5 5775.7 5793.6 5807.9 5813.9 3962.5 3973.3 3973.9 3984.3 3984.6 6038.1 6057.0 6101.8 6139.3 6146.6 3953.3 4099.0 4103.2 4107.1 4107.7 4140.3 4156.8 4157.1 4158.1 4169.1 4784.5 4795.0 4812.8 4813.6 4816.4 5759.0 5760.0 5792.6 5809.6 5821.2 1427.7 1461.3 1482.5 1482.7 1482.8 964.1 987.2 988.8 997.3 999.0 4981.2 5028.1 5051.7 5055.0 5061.8 5983.8 6004.1 6004.5 6010.8 6017.3 5028.5 5035.7 5042.0 5063.1 5063.7 3115.7 3249.6 3249.8 3251.2 3256.7 5651.6 5652.3 5658.9 5659.1 5670.2 6129.6 6152.8 6154.4 6171.7 6178.2 5494.7 5617.2 5638.3 5650.6 5663.6 6005.0 6005.5 6011.1 6015.2 6015.5 5848.0 5856.3 5864.3 5867.1 5871.5 5491.9 5585.6 5609.7 5638.7 5647.0 4105.5 4106.9 4109.8 4110.9 4114.1 5994.6 5996.6 5999.2 6002.5 6007.0 5766.6 5778.1 5780.2 5780.4 5780.6 5640.4 5686.3 5743.1 5776.5 5779.1 5646.6 5652.8 5659.4 5668.6 5682.1 5630.1 5688.1 5708.8 5799.9 5896.2 5767.8 5776.2 5777.9 5779.9 5793.7 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12121.53 Median:42468.47 stddev:13531.43 (31.9%) stddev-sans-first:13542.18 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: Values: 694.2 696.0 696.7 698.4 711.3 12024.0 12426.1 12459.4 12466.7 13702.0 13635.2 13709.5 13745.5 13770.2 13832.7 792.6 792.8 799.0 817.5 818.8 806.3 810.1 811.0 817.3 819.5 852.5 856.7 857.7 859.5 861.2 842.3 843.8 846.8 846.8 847.3 624.7 625.7 627.7 636.9 637.3 10769.7 10892.3 10901.1 10902.1 10927.6 10989.7 10999.8 11262.6 11279.5 11333.8 9289.2 9308.4 9322.5 9559.5 9563.0 3206.1 3230.4 3269.2 3286.1 3305.9 41249.4 41358.6 41365.8 41405.6 41470.8 8118.1 8333.8 8423.5 8479.1 8503.6 12764.3 12875.6 12952.2 12962.1 13041.3 6337.4 6357.3 6492.4 6517.9 6636.7 3838.5 3878.1 3893.2 3916.7 3942.7 2657.4 2694.8 2694.9 2696.6 2700.7 452.8 459.9 465.6 480.5 481.3 433.2 442.2 525.0 572.5 573.0 7128.7 7903.5 8017.5 8042.0 8075.3 477.5 557.7 561.1 565.2 588.5 3505.2 3566.6 3617.7 3687.6 3704.8 48231.0 48268.8 48304.5 48565.5 48616.5 40653.4 42186.0 42290.6 42646.4 43030.1 36410.5 40037.0 40187.4 40448.8 40836.4 7709.0 7837.4 8098.6 8172.6 8299.7 30886.0 31189.8 31312.8 31953.2 32248.0 36143.3 39229.4 40100.2 40346.8 40699.2 9938.4 9977.6 10248.6 10307.3 10381.7 11394.3 11473.1 11517.9 11597.8 12044.2 10320.4 10422.8 10606.1 11050.9 11084.2 10705.2 10763.8 10954.4 11020.7 11279.7 10344.2 10878.8 11263.0 11373.7 11376.6 9215.3 9463.5 9611.1 9635.9 9785.7 8221.0 8621.7 8943.0 9475.3 9577.2 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:18:45 INFO - 2015-12-15 06:18:45,694 DEBUG : BROWSER_OUTPUT: 06:18:46 INFO - 2015-12-15 06:18:46,392 INFO : Browser exited with error code: 0 06:18:46 INFO - 2015-12-15 06:18:46,416 INFO : Completed test dromaeo_css (00:18:35) 06:18:46 INFO - 2015-12-15 06:18:46,416 INFO : Starting test kraken 06:18:46 INFO - 2015-12-15 06:18:46,416 DEBUG : operating with platform_type : linux_ 06:18:46 INFO - 2015-12-15 06:18:46,416 INFO : Initialising browser for kraken test... 06:18:46 INFO - 2015-12-15 06:18:46,422 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2v03u/profile http://localhost:39888/getInfo.html 06:18:50 INFO - 2015-12-15 06:18:50,906 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:18:50 INFO - 2015-12-15 06:18:50,906 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:18:50 INFO - 2015-12-15 06:18:50,906 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:18:50 INFO - 2015-12-15 06:18:50,906 DEBUG : BROWSER_OUTPUT: __metrics 06:18:51 INFO - 2015-12-15 06:18:51,056 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] 06:18:51 INFO - 2015-12-15 06:18:51,948 INFO : Browser initialized. 06:18:51 INFO - 2015-12-15 06:18:51,948 INFO : Running cycle 1/1 for kraken test... 06:18:51 INFO - 2015-12-15 06:18:51,949 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2v03u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:19:04 INFO - 2015-12-15 06:19:04,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 142544896 06:19:04 INFO - 2015-12-15 06:19:04,063 DEBUG : BROWSER_OUTPUT: 06:19:06 INFO - 2015-12-15 06:19:06,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39888/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:07 INFO - 2015-12-15 06:19:07,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 141729792 06:19:07 INFO - 2015-12-15 06:19:07,250 DEBUG : BROWSER_OUTPUT: 06:19:09 INFO - 2015-12-15 06:19:09,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39888/tests/kraken/driver.html?testName=audio-dft) 06:19:10 INFO - 2015-12-15 06:19:10,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 142557184 06:19:10 INFO - 2015-12-15 06:19:10,593 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2015-12-15 06:19:13,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39888/tests/kraken/driver.html?testName=audio-fft) 06:19:14 INFO - 2015-12-15 06:19:14,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 137068544 06:19:14 INFO - 2015-12-15 06:19:14,075 DEBUG : BROWSER_OUTPUT: 06:19:16 INFO - 2015-12-15 06:19:16,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39888/tests/kraken/driver.html?testName=audio-oscillator) 06:19:16 INFO - 2015-12-15 06:19:16,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 138526720 06:19:16 INFO - 2015-12-15 06:19:16,754 DEBUG : BROWSER_OUTPUT: 06:19:19 INFO - 2015-12-15 06:19:19,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39888/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:19 INFO - 2015-12-15 06:19:19,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 140263424 06:19:19 INFO - 2015-12-15 06:19:19,602 DEBUG : BROWSER_OUTPUT: 06:19:22 INFO - 2015-12-15 06:19:22,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39888/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:23 INFO - 2015-12-15 06:19:23,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 141021184 06:19:23 INFO - 2015-12-15 06:19:23,243 DEBUG : BROWSER_OUTPUT: 06:19:26 INFO - 2015-12-15 06:19:26,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39888/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:27 INFO - 2015-12-15 06:19:27,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 137175040 06:19:27 INFO - 2015-12-15 06:19:27,328 DEBUG : BROWSER_OUTPUT: 06:19:30 INFO - 2015-12-15 06:19:30,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39888/tests/kraken/driver.html?testName=json-parse-financial) 06:19:30 INFO - 2015-12-15 06:19:30,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 140140544 06:19:30 INFO - 2015-12-15 06:19:30,788 DEBUG : BROWSER_OUTPUT: 06:19:32 INFO - 2015-12-15 06:19:32,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39888/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:33 INFO - 2015-12-15 06:19:33,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 140574720 06:19:33 INFO - 2015-12-15 06:19:33,164 DEBUG : BROWSER_OUTPUT: 06:19:35 INFO - 2015-12-15 06:19:35,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:35 INFO - 2015-12-15 06:19:35,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 139915264 06:19:35 INFO - 2015-12-15 06:19:35,665 DEBUG : BROWSER_OUTPUT: 06:19:37 INFO - 2015-12-15 06:19:37,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:38 INFO - 2015-12-15 06:19:38,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 139870208 06:19:38 INFO - 2015-12-15 06:19:38,452 DEBUG : BROWSER_OUTPUT: 06:19:41 INFO - 2015-12-15 06:19:41,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:41 INFO - 2015-12-15 06:19:41,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 140300288 06:19:41 INFO - 2015-12-15 06:19:41,648 DEBUG : BROWSER_OUTPUT: 06:19:44 INFO - 2015-12-15 06:19:44,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:44 INFO - 2015-12-15 06:19:44,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 140025856 06:19:44 INFO - 2015-12-15 06:19:44,870 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39888/tests/kraken/driver.html?testName=ai-astar) 06:19:46 INFO - 2015-12-15 06:19:46,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 140464128 06:19:46 INFO - 2015-12-15 06:19:46,910 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,913 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;118;114;113;124;113;113;112;115 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;172;130;152;166;132;154;153;135;171;132 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;163;161;163;168;166;164;165;162 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;71;73;72;126;71;81;72 06:19:46 INFO - 2015-12-15 06:19:46,914 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;93;129;96;96;96;134;94;94;129 06:19:46 INFO - 2015-12-15 06:19:46,915 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;110;111;110;110 06:19:46 INFO - 2015-12-15 06:19:46,915 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;147;147;149;147;147;147;148 06:19:46 INFO - 2015-12-15 06:19:46,915 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;96;97;96;96;95 06:19:46 INFO - 2015-12-15 06:19:46,915 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;74;75;75;79;75;74;74;72;73 06:19:46 INFO - 2015-12-15 06:19:46,915 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;68;69;68;69;69;67;68;69 06:19:46 INFO - 2015-12-15 06:19:46,915 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;85;86;85;86;84;85;94;86;86 06:19:46 INFO - 2015-12-15 06:19:46,915 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;129;124;123;131;122;124;126;129;128 06:19:46 INFO - 2015-12-15 06:19:46,916 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;153;156;151;152;139;152;153;149;138 06:19:46 INFO - 2015-12-15 06:19:46,916 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;73;71;73;72;70;72;72;69;73 06:19:46 INFO - 2015-12-15 06:19:46,916 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:19:46 INFO - 2015-12-15 06:19:46,916 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:19:46 INFO - 2015-12-15 06:19:46,916 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,790 06:19:46 INFO - 2015-12-15 06:19:46,916 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:19:46 INFO - 2015-12-15 06:19:46,916 DEBUG : BROWSER_OUTPUT: __startTimestamp1450189186911__endTimestamp 06:19:46 INFO - 2015-12-15 06:19:46,917 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,920 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:19:46 INFO - 2015-12-15 06:19:46,921 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:19:46 INFO - 2015-12-15 06:19:46,922 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,922 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:4.03 (3.5%) stddev-sans-first:4.28 06:19:46 INFO - 2015-12-15 06:19:46,922 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 118.0 114.0 113.0 124.0 113.0 113.0 112.0 115.0 06:19:46 INFO - 2015-12-15 06:19:46,922 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,922 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:153.50 stddev:16.61 (10.8%) stddev-sans-first:15.53 06:19:46 INFO - 2015-12-15 06:19:46,923 DEBUG : BROWSER_OUTPUT: Values: 172.0 130.0 152.0 166.0 132.0 154.0 153.0 135.0 171.0 132.0 06:19:46 INFO - 2015-12-15 06:19:46,923 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,923 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.11 (1.3%) stddev-sans-first:2.15 06:19:46 INFO - 2015-12-15 06:19:46,923 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 163.0 161.0 163.0 168.0 166.0 164.0 165.0 162.0 06:19:46 INFO - 2015-12-15 06:19:46,924 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,924 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.20 Median:72.00 stddev:17.05 (23.7%) stddev-sans-first:17.93 06:19:46 INFO - 2015-12-15 06:19:46,924 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 71.0 73.0 72.0 126.0 71.0 81.0 72.0 06:19:46 INFO - 2015-12-15 06:19:46,924 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,924 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.50 stddev:17.38 (18.4%) stddev-sans-first:18.01 06:19:46 INFO - 2015-12-15 06:19:46,924 DEBUG : BROWSER_OUTPUT: Values: 95.0 93.0 129.0 96.0 96.0 96.0 134.0 94.0 94.0 129.0 06:19:46 INFO - 2015-12-15 06:19:46,924 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,925 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:19:46 INFO - 2015-12-15 06:19:46,925 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 110.0 06:19:46 INFO - 2015-12-15 06:19:46,925 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,925 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:19:46 INFO - 2015-12-15 06:19:46,925 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 147.0 147.0 149.0 147.0 147.0 147.0 148.0 06:19:46 INFO - 2015-12-15 06:19:46,925 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,926 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:19:46 INFO - 2015-12-15 06:19:46,926 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 06:19:46 INFO - 2015-12-15 06:19:46,926 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,926 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.70 Median:75.00 stddev:1.89 (2.5%) stddev-sans-first:1.94 06:19:46 INFO - 2015-12-15 06:19:46,926 DEBUG : BROWSER_OUTPUT: Values: 76.0 74.0 75.0 75.0 79.0 75.0 74.0 74.0 72.0 73.0 06:19:46 INFO - 2015-12-15 06:19:46,926 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,926 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.73 06:19:46 INFO - 2015-12-15 06:19:46,927 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 69.0 68.0 69.0 69.0 67.0 68.0 69.0 06:19:46 INFO - 2015-12-15 06:19:46,927 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,927 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:3.50 (4.1%) stddev-sans-first:2.96 06:19:46 INFO - 2015-12-15 06:19:46,927 DEBUG : BROWSER_OUTPUT: Values: 93.0 85.0 86.0 85.0 86.0 84.0 85.0 94.0 86.0 86.0 06:19:46 INFO - 2015-12-15 06:19:46,927 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,927 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:128.50 stddev:3.10 (2.4%) stddev-sans-first:3.15 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: Values: 129.0 129.0 124.0 123.0 131.0 122.0 124.0 126.0 129.0 128.0 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:152.00 stddev:6.81 (4.5%) stddev-sans-first:6.36 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: Values: 139.0 153.0 156.0 151.0 152.0 139.0 152.0 153.0 149.0 138.0 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.35 (1.9%) stddev-sans-first:1.41 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 73.0 72.0 70.0 72.0 72.0 69.0 73.0 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:19:46 INFO - 2015-12-15 06:19:46,928 DEBUG : BROWSER_OUTPUT: 06:19:47 INFO - 2015-12-15 06:19:47,872 INFO : Browser exited with error code: 0 06:19:47 INFO - 2015-12-15 06:19:47,922 INFO : Completed test kraken (00:01:01) 06:19:47 INFO - 2015-12-15 06:19:47,922 INFO : Starting test v8_7 06:19:47 INFO - 2015-12-15 06:19:47,922 DEBUG : operating with platform_type : linux_ 06:19:47 INFO - 2015-12-15 06:19:47,923 INFO : Initialising browser for v8_7 test... 06:19:47 INFO - 2015-12-15 06:19:47,929 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82ekFl/profile http://localhost:39888/getInfo.html 06:19:52 INFO - 2015-12-15 06:19:52,548 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:19:52 INFO - 2015-12-15 06:19:52,548 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:19:52 INFO - 2015-12-15 06:19:52,548 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:19:52 INFO - 2015-12-15 06:19:52,548 DEBUG : BROWSER_OUTPUT: __metrics 06:19:52 INFO - 2015-12-15 06:19:52,673 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] 06:19:53 INFO - 2015-12-15 06:19:53,572 INFO : Browser initialized. 06:19:53 INFO - 2015-12-15 06:19:53,573 INFO : Running cycle 1/1 for v8_7 test... 06:19:53 INFO - 2015-12-15 06:19:53,573 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82ekFl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:20:05 INFO - 2015-12-15 06:20:05,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 142434304 06:20:05 INFO - 2015-12-15 06:20:05,679 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39888/tests/v8_7/run.html (next: http://localhost:39888/tests/v8_7/run.html) 06:20:27 INFO - 2015-12-15 06:20:27,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 137240576 06:20:27 INFO - 2015-12-15 06:20:27,417 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: |0;Richards;164.446637066272 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.0860545524395 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 06:20:27 INFO - 2015-12-15 06:20:27,418 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1057.0824524312895 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: |5;Earley;751.8796992481203 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: |7;RegExp;26789.473684210527 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: |8;Splay;615.0550795593635 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: __startTimestamp1450189227410__endTimestamp 06:20:27 INFO - 2015-12-15 06:20:27,419 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,420 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:20:27 INFO - 2015-12-15 06:20:27,420 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:20:27 INFO - 2015-12-15 06:20:27,420 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,420 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.45 Median:164.45 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,420 DEBUG : BROWSER_OUTPUT: Values: 164.4 06:20:27 INFO - 2015-12-15 06:20:27,420 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,420 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.09 Median:192.09 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: Values: 192.1 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: Values: 277.5 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: Values: 5208.3 06:20:27 INFO - 2015-12-15 06:20:27,421 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,422 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,422 DEBUG : BROWSER_OUTPUT: Values: 1057.1 06:20:27 INFO - 2015-12-15 06:20:27,422 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,422 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:751.88 Median:751.88 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,422 DEBUG : BROWSER_OUTPUT: Values: 751.9 06:20:27 INFO - 2015-12-15 06:20:27,422 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,422 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: Values: 12280.5 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26789.47 Median:26789.47 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: Values: 26789.5 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.06 Median:615.06 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: Values: 615.1 06:20:27 INFO - 2015-12-15 06:20:27,423 DEBUG : BROWSER_OUTPUT: 06:20:27 INFO - 2015-12-15 06:20:27,424 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 06:20:27 INFO - 2015-12-15 06:20:27,424 DEBUG : BROWSER_OUTPUT: Values: 4845.4 06:20:27 INFO - 2015-12-15 06:20:27,424 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:20:27 INFO - 2015-12-15 06:20:27,424 DEBUG : BROWSER_OUTPUT: 06:20:28 INFO - 2015-12-15 06:20:28,372 INFO : Browser exited with error code: 0 06:20:28 INFO - 2015-12-15 06:20:28,386 INFO : Completed test v8_7 (00:00:40) 06:20:28 INFO - 2015-12-15 06:20:28,870 INFO : Completed test suite (00:20:17) 06:20:28 INFO - 2015-12-15 06:20:28,870 DEBUG : Working with test: dromaeo_css 06:20:28 INFO - 2015-12-15 06:20:28,870 DEBUG : Generating results file: dromaeo_css 06:20:28 INFO - 2015-12-15 06:20:28,871 DEBUG : Working with test: kraken 06:20:28 INFO - 2015-12-15 06:20:28,871 DEBUG : Generating results file: kraken 06:20:28 INFO - 2015-12-15 06:20:28,872 INFO : javascript benchmark 06:20:28 INFO - 2015-12-15 06:20:28,872 DEBUG : Working with test: v8_7 06:20:28 INFO - 2015-12-15 06:20:28,872 DEBUG : Generating results file: v8_7 06:20:28 INFO - 2015-12-15 06:20:28,872 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:29 INFO - 2015-12-15 06:20:29,046 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 06:20:29 INFO - 2015-12-15 06:20:29,046 DEBUG : process_Request line: dromaeo_css 6146.62 graph.html#tests=[[72,94,43]] 06:20:29 INFO - 2015-12-15 06:20:29,046 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:29 INFO - 2015-12-15 06:20:29,079 DEBUG : process_Request line: kraken 1542.00 graph.html#tests=[[232,94,43]] 06:20:29 INFO - 2015-12-15 06:20:29,079 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:20:29 INFO - 2015-12-15 06:20:29,193 DEBUG : process_Request line: v8_7 21106.27 graph.html#tests=[[230,94,43]] 06:20:29 INFO - 2015-12-15 06:20:29,194 INFO : javascript benchmark 06:20:29 INFO - 2015-12-15 06:20:29,198 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.516314481821, 2674.1175412114003, 2697.4874773792976, 2705.6347393101937, 2720.6327145835307, 4519.52544982777, 4696.060787842433, 4770.952290477098, 4782.665213435061, 4783.952160478394, 4655.464621568521, 4692.389989301386, 4703.600193983507, 4704.952950470494, 4736.90526189476, 4287.842282583701, 4332.0, 4355.934660980072, 4357.324614684729, 4359.629431498311, 4194.245035893553, 4350.412694286262, 4370.38814565961, 4398.164348773738, 4413.095315460323, 4288.549702281262, 4320.848770293024, 4389.890252743675, 4392.0, 4411.691181617256, 4367.999203464934, 4372.606465418127, 4375.584319489675, 4396.428464299621, 4431.6233120184825, 4225.302825033866, 4300.892477688051, 4344.283193273106, 4368.89077773055, 4395.670324725626, 4491.146682130385, 4506.053728716974, 4555.202839503107, 4562.817487300504, 4642.698224615389, 5005.724685142316, 5052.696838189684, 5055.69665820052, 5060.443351231362, 5067.138586440277, 4886.780094895703, 4964.776585053682, 4971.676841005359, 5075.873103172414, 5115.61632877532, 4675.0, 4729.456112547066, 4738.928916066262, 4739.075880203396, 4764.356811830427, 5212.192110222922, 5217.921731174036, 5226.320578324793, 5235.1623740201385, 5237.790488380422, 4793.520647935178, 4899.3385892904, 4902.093112774148, 4904.828331008469, 5050.974745126251, 4963.900721985612, 4987.177115775857, 5001.349824522788, 5006.123928312531, 5075.543201111917, 5023.34696489454, 5070.0, 5074.746262686925, 5090.847274581768, 5110.131277682803, 4790.161721698689, 5040.420351659606, 5041.395032596112, 5063.87340316495, 5074.695518268915, 4104.4048612950955, 4145.481814773153, 4196.664266858644, 4202.3696445533415, 4235.767032813224, 3717.275131349415, 3722.683571896365, 3733.160038991205, 3737.1404576947452, 3769.359208934433, 4257.914841703148, 4342.956570434319, 4427.380166776654, 4434.268345722984, 4445.3998710174355, 5020.874478138003, 5074.797008119634, 5076.263941728429, 5109.284700141983, 5158.97420512895, 4415.712978656377, 4463.754493502824, 4476.283794592915, 4478.641708663365, 4482.417285752831, 4315.611594956469, 4411.823527058946, 4541.3188021797, 4555.180067587866, 4580.427446569179, 4749.477557468745, 4759.16714574948, 4793.592544633745, 4813.133635945564, 4844.515548445127, 5087.389513258433, 5114.565261952627, 5130.230465430066, 5133.563647090039, 5151.484851514969, 4700.106979673988, 4741.383620129361, 4812.532177685839, 4836.443808962014, 4886.975565122151, 5028.9245661315845, 5032.949670503394, 5034.395872495177, 5038.168702164102, 5045.31888195089, 5087.87280317995, 5097.7960881565805, 5102.260172274925, 5105.055564720538, 5156.896862062813, 4775.0, 4847.248676455155, 4870.1964175912, 4953.727544984917, 4954.801807927643, 4854.5873600744335, 4871.464138944642, 4886.975565122294, 4919.0407870464915, 4926.876828079184, 4771.117343291502, 4792.544708252711, 4795.95204047955, 4806.519348065165, 4827.927581086216, 4672.813087476463, 4768.928466072943, 4859.392575928009, 4894.2658601210105, 4948.15881300187, 4839.225723884161, 4853.369062021915, 4867.5862551682085, 4915.729634870117, 4941.777620007037], "unit": "ms", "name": "dojo.html", "value": 4632.264168078041}, {"lowerIsBetter": false, "replicates": [562.7636392715059, 570.0394834703523, 571.6970005896874, 572.5419664268585, 579.7072478398408, 36334.45498317524, 36975.0, 37073.814630926805, 37115.443268350995, 37173.814130929306, 38985.0, 39510.40734388986, 39598.20803583926, 39616.0, 39658.40512392309, 7856.646450909694, 8004.719834805783, 8019.839603207933, 8038.758837234863, 8040.8793868092025, 7737.187595302496, 7785.299323060952, 7796.1814009529035, 7818.45270831042, 7821.335186509154, 7916.643751031217, 7975.7607271781935, 8000.439969202158, 8013.11855695873, 8022.438429309921, 7832.921670783305, 7959.96020019902, 7965.084015338223, 7971.760847174536, 7993.96003019987, 7818.14000459949, 7864.646090925922, 7897.60511974399, 7905.486143400718, 7917.960410197912, 36351.27297454036, 36716.63283367186, 36912.63087369146, 36957.260854782755, 37256.0, 3168.714815666601, 3189.409959157563, 3434.5363375944426, 3450.723942084652, 3737.364648009845, 26387.34031649205, 26397.73602263972, 26496.73503264962, 26506.469870602672, 26651.866740666173, 3473.5831700195886, 3475.5481787367735, 3484.860605575774, 3535.505029295901, 3555.2000799820094, 216863.0, 218582.0, 218590.0, 218595.0, 219131.0, 46730.5326946733, 47477.52522474731, 53991.730041350325, 54221.0, 55118.0, 55696.44303556912, 55884.72057639686, 56119.0, 56187.0, 56228.0, 13780.65548361299, 13876.098053626481, 13891.722165556632, 13903.374348154357, 13922.37349319283, 10646.307989980627, 10761.30051546647, 10795.946020269848, 10797.46012699362, 10801.351918884891, 19085.618287634446, 19362.90318548398, 19396.0, 19401.514962125777, 19404.12681429339, 7623.733169339157, 7752.341051010614, 7915.525068495908, 7934.960325198453, 7970.322522585529, 763.9083310002835, 777.700585274662, 823.4894365493312, 831.7546323834483, 867.952262625549, 23823.523529529313, 23853.522929541658, 24001.0, 24106.156284529956, 24125.276241712778, 876.5836227791875, 924.9075092490697, 950.6625148072472, 983.6753871222479, 1010.6917390195914, 12289.201201921847, 12341.814872776915, 12450.377481125908, 12533.498660053678, 12578.685532861751, 259159.0, 261155.4711132237, 262686.0, 263523.0, 265623.0, 44969.55030449719, 45321.86695332643, 45641.543584564395, 45735.771321143184, 45799.542004580195, 1196.3420118934725, 1274.2736640115045, 1283.3839756916545, 1286.6847622332589, 1289.7291568770477, 23909.402264943517, 24402.145924892542, 24520.75479245256, 24615.13847015346, 24640.260792176265, 38525.80737096297, 38713.0, 38810.80594597009, 38904.416433754086, 38909.0, 249050.0, 249388.0, 249486.0, 251204.0, 251570.0, 28352.716472835833, 28550.286242843264, 28721.856390717912, 28808.855955720926, 28843.56734649024, 33951.66048339485, 34060.31879362349, 34483.482747759306, 34657.306853862276, 36617.81691091527, 31458.685413145577, 31995.36009279848, 32248.677513225506, 32818.17954551155, 33222.667773321955, 32535.349293014482, 32650.673493264763, 32846.34307313888, 32846.67153328436, 32969.34061318712, 31652.208694782814, 32219.838900805345, 32314.192145196557, 32401.51397729083, 32459.675403245667, 27584.862075689492, 29002.274943125747, 29054.418911622073, 29746.0, 29856.0, 21940.45148871291, 23248.4187895304, 23817.880910595337, 23835.284941451784, 24183.274501764976], "unit": "ms", "name": "ext.html", "value": 16590.471224412}, {"lowerIsBetter": false, "replicates": [334.6603197754278, 334.7589735390518, 336.8602030157485, 339.6976690745236, 341.7744288769412, 14860.0, 15134.77082269919, 16084.195790210471, 16673.749893751603, 17322.13389330535, 10119.797604047933, 10386.0, 10400.947995260032, 10646.733831654212, 10659.893401065987, 4696.459907110675, 4844.5882100021545, 4847.733374664392, 4850.611951043926, 4854.029194161164, 4835.685680430778, 5006.374203224597, 5009.599232061444, 5017.247412888078, 5021.472745361739, 3528.276703275835, 4988.975055124737, 5010.874728131789, 5078.0, 5316.175992721134, 5256.369235691723, 5263.789448422059, 5274.709890955995, 5276.182191760283, 5313.0967735485065, 4607.331936869169, 4767.76161191939, 4780.880477988078, 5089.720065396402, 5110.105731496973, 11224.382658953755, 11252.0, 11305.208635395526, 15644.843551564452, 17626.823731762648, 1757.8330058644408, 1790.9283628654969, 1791.3013924569427, 1801.0994502748626, 1872.7565416495904, 5928.318243402021, 5942.3760505146765, 6270.46701030413, 6984.952257161415, 8954.820903581893, 1669.1018053044725, 1743.4246698589436, 1758.3757765993016, 1772.6809174348612, 1772.8758986870923, 53274.46725532734, 54704.72647636776, 57269.42730572683, 57273.427265727645, 57464.138037929464, 9637.0, 9821.852672209923, 9909.0, 9927.40435573868, 10068.647597334058, 11964.82052769209, 11998.520059197708, 12011.099167562468, 12025.398730063462, 12029.218100823418, 6897.586144831226, 7061.187963384276, 7089.291070892869, 7132.964335178291, 7153.856922861513, 6608.471322294205, 6652.301508341651, 6667.533272670964, 6684.665766711645, 6703.128593282842, 4193.496780386373, 4205.957940420618, 4224.852130175491, 4275.87172384829, 4275.973766296067, 1728.3605066125615, 1776.2539733311783, 1792.9641407172044, 1793.1482545790645, 1799.4961410804995, 715.5277516838861, 774.767569729079, 819.4304958054095, 936.8688383626297, 945.874409452749, 14688.118712877262, 15438.9228053859, 15662.0, 16071.276792544364, 16091.275892584861, 381.46404301955795, 392.4760444806159, 397.7792325259451, 402.30200601955585, 411.80645096804454, 5123.923141152885, 5138.8972220556125, 5244.947550524446, 5272.736363181825, 5286.7092309922555, 479688.0, 481981.0, 487285.0, 489251.0, 494829.0, 66244.6687766558, 66714.66642666755, 73415.63292183504, 75775.0, 77412.22587774051, 433.66607712061534, 442.09591385616494, 442.2084468800875, 442.2238970606629, 442.5861819199059, 9129.908700912905, 9299.581518831805, 9405.811883762422, 9450.480223587769, 9618.326717129734, 33711.3257734839, 35103.297934041686, 36452.08869778277, 36490.63509364872, 36579.634203657624, 44438.333424998, 44725.329120062575, 45278.32082518699, 46147.76926115482, 51886.48113518967, 8615.91384086151, 8793.120687931156, 9310.95344523273, 9316.394434361744, 9321.72034838956, 10026.448545330077, 10128.746781330527, 10145.49272536385, 15883.602909927344, 16719.49841504757, 12366.505339786308, 13634.522791702242, 13654.658633534242, 13776.380062896993, 14112.012159149172, 13147.868521314664, 13191.40638671243, 13466.057375983979, 13558.86441135576, 13761.17432954026, 13447.260400678057, 14998.400063997318, 15091.471798487, 15181.240937953278, 15264.0, 8919.687810926587, 8990.730278091667, 9082.909170908206, 9219.953900230725, 9228.584713688035, 13648.65878353049, 13751.17492950386, 13873.930630346784, 13932.094413863066, 14066.859331406555], "unit": "ms", "name": "jquery.html", "value": 7476.886152116983}, {"lowerIsBetter": false, "replicates": [1354.471756015154, 1409.6123566019346, 1494.4022391043582, 1616.1757503673123, 1685.1911082680313, 5884.970575147129, 6137.07943808429, 6349.206349206349, 6726.6972986215615, 6734.9326506734915, 6412.711427985741, 6620.0, 6625.204975402959, 6646.667666616674, 6656.167979002625, 2024.4028011736573, 2043.2235750414823, 2056.845736569756, 2061.7732049474544, 2068.379486154155, 1966.587016726489, 2020.8282296004857, 2023.8178563929243, 2024.4938765308673, 2029.6853987631941, 1973.1318219983234, 1990.99004504978, 1991.1139542903413, 1997.2610134250276, 1998.6502362086649, 2038.918443262275, 2042.5710600773855, 2063.4531849060013, 2063.566651003291, 2066.152877320299, 1988.741463609736, 2005.3683089826804, 2045.4375046862083, 2046.907889144992, 2051.661475856482, 6728.461723062143, 6772.55978361405, 6789.117414736102, 6791.2869148739655, 6821.386075253202, 3970.68234541236, 4059.8173082211074, 4068.8982775430554, 4075.735077219971, 4087.4686290782306, 2584.3022383956413, 2626.724193959645, 2628.6319915211693, 2654.9336266593295, 2659.162363855379, 852.1180578101697, 852.1861622150831, 872.4634349874844, 882.6866462405818, 894.6510860764307, 8952.239059679934, 8975.474169391218, 9017.639294428214, 9019.323550733721, 9036.0, 3660.816959152032, 3671.724620653462, 3705.7776533408082, 3710.406334986389, 3724.478572999782, 7891.210878912178, 7906.841863162705, 7919.960400197962, 7930.1276859545405, 7941.36469082472, 4044.1102957349335, 4054.1283624020975, 4060.0661847774586, 4068.6541643960004, 4084.2852500812833, 3564.500969864221, 3588.6231945645854, 3614.1326081740194, 3693.741438099361, 3752.1370084880086, 3139.3564319314487, 3164.7784655074383, 3177.6345720242466, 3188.0913939527586, 3202.631697354834, 921.3044151665449, 926.6941909169958, 928.726025822384, 933.9439633622004, 935.9485228312508, 1045.2160879340495, 1051.8264486359665, 1052.3422860712055, 1055.8996895294936, 1081.6809041332667, 6413.102165696806, 6424.164858568356, 6462.903056454157, 6470.870582588416, 6475.093486911836, 418.3285826248888, 425.10303260121117, 433.07538405504476, 433.26128950139935, 433.3261777935341, 4794.161021821237, 4816.710997340171, 4855.198892182821, 4898.191798353303, 5020.0, 7858.332041776513, 8047.155048719917, 8067.39494537912, 8082.676692932335, 8113.188681131957, 7932.28609425143, 7970.681172753025, 8044.718434854752, 8046.235607617267, 8051.63767630458, 6326.2092238470195, 6381.680915954184, 6391.58454700443, 6456.451201647913, 6504.0, 6261.0608408737235, 6263.937360626335, 6264.968675156595, 6265.8746825062335, 6277.623342599459, 7093.964530177316, 7256.2018177999325, 7423.480356375002, 7438.479306448713, 7541.4343924207005, 6785.93214067853, 6910.136232970879, 6935.202451718117, 7431.4054875608745, 7539.095308563007, 5208.010478009166, 5400.864978375572, 6008.819735407945, 6055.394460553909, 6091.573589848668, 6303.716332765129, 6308.526860485574, 6328.114064030948, 6346.333634968262, 6350.491960643045, 5782.161586570008, 6034.69826508664, 6055.666938318434, 6124.693765311806, 6156.322804491413, 6101.0, 6117.571769976059, 6177.413145751147, 6227.906581401192, 6260.154879091447, 5621.550275977994, 5991.430814072656, 6021.7591296347655, 6051.727672254671, 6061.39386061408, 5693.601447898607, 5711.286089238845, 5717.171010203414, 5740.9953258180485, 5768.423157684366, 5520.089185284383, 5793.884122317614, 5842.2405087338375, 5844.912326315194, 5897.203877476486], "unit": "ms", "name": "mootools.html", "value": 3809.193622624006}, {"lowerIsBetter": false, "replicates": [298.5327961739877, 301.1447489130868, 303.98480075996196, 304.0407514292408, 306.4896946583938, 5486.670799752008, 5568.638038527503, 5599.832005039851, 5653.180288858113, 5654.886902261957, 5400.459954004607, 5525.640833345829, 5558.333000039991, 5562.499375056244, 5565.471280228382, 4243.469566304212, 4243.511996120455, 4246.129543443602, 4259.382389553512, 4259.8296068157315, 4244.851430199944, 4246.426732391134, 4251.87244382669, 4254.7021708480415, 4261.509926358462, 4059.6143366380147, 4174.352975288835, 4215.262329092412, 4215.5784421557755, 4228.577142285762, 4171.582841715835, 4173.7495750254775, 4179.728317659343, 4179.874603761892, 4184.748915065105, 3634.83643236055, 3651.598324184338, 3652.9269414611827, 3654.5614526256754, 3655.342038433081, 5355.410904800468, 5371.060064488699, 5372.811951581715, 5372.811951581715, 5377.8117765878005, 4684.086603112394, 4838.709677419366, 4846.176150054499, 4857.781399837016, 4863.683860549088, 5671.546276297886, 5775.682337471438, 5793.594448388614, 5807.88384232313, 5813.854653633651, 3962.5443074046566, 3973.3443981742976, 3973.940390894139, 3984.342583473723, 3984.5816189300285, 6038.124471951586, 6056.9697151513965, 6101.755929762804, 6139.293981192131, 6146.600470969417, 3953.288408086572, 4098.979505102456, 4103.179364127186, 4107.116969851496, 4107.712460127762, 4140.296149654566, 4156.771377574202, 4157.08544120293, 4158.106007208404, 4169.10364271677, 4784.521547845257, 4794.976025119852, 4812.759362031885, 4813.566778989838, 4816.4220293564995, 5759.0, 5759.971200143972, 5792.594518383757, 5809.564282678816, 5821.155932389865, 1427.6716355238354, 1461.298576683198, 1482.5330021043337, 1482.6738117614107, 1482.844301348343, 964.0504103458088, 987.234892957949, 988.7972965542046, 997.2969056814928, 998.9600415983425, 4981.153203955337, 5028.094942910311, 5051.696898186047, 5055.014272216956, 5061.848144555669, 5983.790567330209, 6004.0693692477735, 6004.489618382487, 6010.849728756816, 6017.308009578867, 5028.547430731252, 5035.697858128451, 5041.974790126026, 5063.06333328328, 5063.696178229318, 3115.735162511212, 3249.6100467943998, 3249.805011699258, 3251.235959549504, 3256.706896379337, 5651.6043876928225, 5652.3217213934595, 5658.943410565924, 5659.094544872801, 5670.177824215466, 6129.632222066691, 6152.78465253714, 6154.415330543591, 6171.722272497748, 6178.165947597106, 5494.725263736797, 5617.241672374259, 5638.2670252866865, 5650.604457688087, 5663.631863928914, 6005.0, 6005.549583781147, 6011.128386384037, 6015.157877897185, 6015.488683461955, 5848.035074212878, 5856.326522449973, 5864.266966629171, 5867.149263356704, 5871.500922421642, 5491.945080549143, 5585.553155747449, 5609.719514024364, 5638.661680299195, 5646.971765141148, 4105.548389677074, 4106.917861642691, 4109.815058322323, 4110.876673699794, 4114.115465175002, 5994.580379373577, 5996.640201587918, 5999.220101386792, 6002.549808764447, 6007.0, 5766.5675074368755, 5778.075507918713, 5780.219670344618, 5780.421957804186, 5780.5953583248765, 5640.353264230695, 5686.289213848269, 5743.10981797822, 5776.451237132465, 5779.075347944308, 5646.576506762091, 5652.802151924663, 5659.434056594308, 5668.574856885833, 5682.090865461506, 5630.0991841305195, 5688.061469857427, 5708.828735137952, 5799.9130013049, 5896.204012458264, 5767.826965191051, 5776.249087618583, 5777.8555536111935, 5779.855503612275, 5793.739281732416], "unit": "ms", "name": "prototype.html", "value": 4323.413202530108}, {"lowerIsBetter": false, "replicates": [694.1669996004796, 695.9582425054497, 696.7317582730649, 698.3993765361791, 711.2816055783657, 12024.0, 12426.068044896647, 12459.37703114844, 12466.688332791684, 13702.0, 13635.181889086662, 13709.520166794164, 13745.450181992734, 13770.24263665498, 13832.654183645389, 792.6036981509245, 792.8493586218628, 798.9840203195932, 817.4686453805015, 818.8362327534487, 806.2582424169749, 810.1452967119686, 811.0308181722844, 817.3134566963749, 819.5082950229844, 852.4842470305468, 856.7130011446174, 857.6783706110209, 859.4928991894781, 861.1689719420758, 842.3093063687778, 843.7763992541982, 846.8137009857821, 846.8433339832089, 847.2586486824028, 624.684534310175, 625.6621424430801, 627.7489004398232, 636.8694417644418, 637.2862394118616, 10769.676909692722, 10892.292001019909, 10901.073408760265, 10902.127829773599, 10927.562897484091, 10989.670309890636, 10999.780004399867, 11262.605808796652, 11279.548818047268, 11333.773324533546, 9289.210417114553, 9308.394954328014, 9322.48726320052, 9559.474228917406, 9563.0, 3206.070239630504, 3230.4185246655593, 3269.1990462336644, 3286.063471910518, 3305.8512366943305, 41249.38125928114, 41358.586414135774, 41365.79317103425, 41405.585944140774, 41470.792646036876, 8118.10700822909, 8333.791655208668, 8423.536705481258, 8479.06730259671, 8503.574821258911, 12764.29796361209, 12875.613731588068, 12952.222866628032, 12962.092653514352, 13041.282729449782, 6337.429631333202, 6357.300696923335, 6492.415682588589, 6517.9245424504425, 6636.668166591651, 3838.5393752749846, 3878.127421330178, 3893.240818040455, 3916.7258291919293, 3942.72400931932, 2657.4419371932113, 2694.797890158246, 2694.90567830125, 2696.5955106734145, 2700.66241719785, 452.75098695717224, 459.9448066232007, 465.55539459815793, 480.48827998181827, 481.30211193768474, 433.1748020021863, 442.16941860696744, 524.9893954138269, 572.5276646766434, 573.0401577357909, 7128.714851405989, 7903.525788452711, 8017.478863873829, 8042.0, 8075.313598344206, 477.4557005014286, 557.6849080269716, 561.1246455529388, 565.197419664078, 588.5404197589916, 3505.2463720299747, 3566.589842168132, 3617.6744093031753, 3687.575928768172, 3704.7962362070343, 48231.0, 48268.7586562065, 48304.5169548307, 48565.514344856805, 48616.51383486191, 40653.390199147034, 42186.0, 42290.57709422928, 42646.36030459546, 43030.13939721251, 36410.45384319237, 40037.0, 40187.39718904219, 40448.79775601162, 40836.38745418881, 7708.961455192688, 7837.373010159287, 8098.5545794981845, 8172.5913704315735, 8299.709510167115, 30886.0, 31189.84405078051, 31312.843435782674, 31953.201169970005, 32248.0, 36143.277134456635, 39229.41155882607, 40100.1979960405, 40346.79826600848, 40699.186016278916, 9938.354006989523, 9977.60089596408, 10248.590056397661, 10307.278490505892, 10381.740456488647, 11394.293929554271, 11473.139514536277, 11517.884821152016, 11597.76804463923, 12044.21712588679, 10320.43237621938, 10422.843657344994, 10606.09848162884, 11050.889491105308, 11084.224104312621, 10705.197110216921, 10763.784724305313, 10954.397508137128, 11020.724481888017, 11279.661610151708, 10344.172466202535, 10878.836817447585, 11263.0, 11373.715657108307, 11376.601818936297, 9215.2627789778, 9463.526823658927, 9611.134997850228, 9635.903640963501, 9785.706428807147, 8221.0, 8621.741347759576, 8942.955285223532, 9475.336726429085, 9577.185939195246], "unit": "ms", "name": "yui.html", "value": 5698.237670342867}], "name": "dromaeo_css", "value": 6146.619337899483}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 118.0, 114.0, 113.0, 124.0, 113.0, 113.0, 112.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [172.0, 130.0, 152.0, 166.0, 132.0, 154.0, 153.0, 135.0, 171.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 168.0, 166.0, 164.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 71.0, 73.0, 72.0, 126.0, 71.0, 81.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.2}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 129.0, 96.0, 96.0, 96.0, 134.0, 94.0, 94.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 75.0, 79.0, 75.0, 74.0, 74.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 74.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 67.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [93.0, 85.0, 86.0, 85.0, 86.0, 84.0, 85.0, 94.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [129.0, 129.0, 124.0, 123.0, 131.0, 122.0, 124.0, 126.0, 129.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [139.0, 153.0, 156.0, 151.0, 152.0, 139.0, 152.0, 153.0, 149.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 73.0, 72.0, 70.0, 72.0, 72.0, 69.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1541.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.446637066272], "unit": "score", "name": "Richards", "value": 214.67146200000008}, {"lowerIsBetter": false, "replicates": [192.0860545524395], "unit": "score", "name": "DeltaBlue", "value": 344.2103079999998}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1057.0824524312895], "unit": "score", "name": "RayTrace", "value": 700.0295939999999}, {"lowerIsBetter": false, "replicates": [751.8796992481203], "unit": "score", "name": "Earley", "value": 886.3957899999997}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [26789.473684210527], "unit": "score", "name": "RegExp", "value": 34.0053339882122}, {"lowerIsBetter": false, "replicates": [615.0550795593635], "unit": "score", "name": "Splay", "value": 132.49382487562193}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21106.27039588117}]} 06:20:29 INFO - RETURN: dromaeo_css: 6146.62 06:20:29 INFO - RETURN: kraken: 1542.00 06:20:29 INFO - RETURN: v8_7: 21106.27 06:20:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21106.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1542.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6146.62"}}} 06:20:29 INFO - Return code: 0 06:20:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:20:29 INFO - # TBPL SUCCESS # 06:20:29 INFO - Running post-action listener: _resource_record_post_action 06:20:29 INFO - Running post-run listener: _resource_record_post_run 06:20:30 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 2838528; Write bytes: 287526912; Read time: 2228; Write time: 160892 06:20:30 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14348288; Read time: 0; Write time: 6236 06:20:30 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 2838528; Write bytes: 273178624; Read time: 2228; Write time: 154656 06:20:30 INFO - Running post-run listener: _upload_blobber_files 06:20:30 INFO - Blob upload gear active. 06:20:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:20:30 INFO - Copying logs to upload dir... 06:20:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.106247 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-15 06:20:30.426934) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 06:20:30.430726) ========= 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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009901 build_url: 'https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.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-15 06:20:30.482229) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 06:20:30.482628) ========= 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=c402a24d74c70935940d60dd000001de-1450185996.988017-1097092691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 06:20:30.532276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 06:20:30.532625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 06:20:30.532950) ========= ========= Total master_lag: 0.17 =========