builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1449340584.09 results: success (0) buildid: 20151205100829 builduid: f60bfabda8b24fe7ab1cf449f16b48f4 revision: 2193658ea0c7bdb7ba0dffb3114796c32e212cf3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.088377) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.088893) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.089279) ========= 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=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.132827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.133142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.209804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.210115) ========= 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=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.268976) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.269288) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.269719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.270046) ========= 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=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-05 10:36:25-- 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% 218M=0s 2015-12-05 10:36:25 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172249 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.469959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.470286) ========= 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=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015636 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:24.538759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-05 10:36:24.539165) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2193658ea0c7bdb7ba0dffb3114796c32e212cf3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2193658ea0c7bdb7ba0dffb3114796c32e212cf3 --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=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-05 10:36:25,488 truncating revision to first 12 chars 2015-12-05 10:36:25,488 Setting DEBUG logging. 2015-12-05 10:36:25,488 attempt 1/10 2015-12-05 10:36:25,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2193658ea0c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-05 10:36:26,569 unpacking tar archive at: fx-team-2193658ea0c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.370785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-05 10:36:25.930106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:25.930457) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:25.940035) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:25.940343) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 10:36:25.940809) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-05 10:36:25.941137) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:36:26 INFO - MultiFileLogger online at 20151205 10:36:26 in /builds/slave/test 10:36:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:36:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:36:26 INFO - {'append_to_log': False, 10:36:26 INFO - 'base_work_dir': '/builds/slave/test', 10:36:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:36:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:36:26 INFO - 'branch': 'Fx-Team-Non-PGO', 10:36:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:36:26 INFO - 'config_files': ('talos/linux_config.py',), 10:36:26 INFO - 'default_actions': ('clobber', 10:36:26 INFO - 'read-buildbot-config', 10:36:26 INFO - 'download-and-extract', 10:36:26 INFO - 'populate-webroot', 10:36:26 INFO - 'create-virtualenv', 10:36:26 INFO - 'install', 10:36:26 INFO - 'run-tests'), 10:36:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:36:26 INFO - 'download_minidump_stackwalk': True, 10:36:26 INFO - 'download_symbols': 'ondemand', 10:36:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:36:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:36:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:36:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:36:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:36:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:36:26 INFO - 'installer_path': 'installer.exe', 10:36:26 INFO - 'log_level': 'info', 10:36:26 INFO - 'log_name': 'talos', 10:36:26 INFO - 'log_to_console': True, 10:36:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:36:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:36:26 INFO - 'opt_config_files': (), 10:36:26 INFO - 'pip_index': False, 10:36:26 INFO - 'sps_profile': False, 10:36:26 INFO - 'sps_profile_interval': 0, 10:36:26 INFO - 'suite': 'dromaeojs', 10:36:26 INFO - 'system_bits': '64', 10:36:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:36:26 INFO - 'title': 'talos-linux64-ix-065', 10:36:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:36:26 INFO - 'use_talos_json': True, 10:36:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:36:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:36:26 INFO - 'work_dir': 'build'} 10:36:26 INFO - ##### 10:36:26 INFO - ##### Running clobber step. 10:36:26 INFO - ##### 10:36:26 INFO - Running pre-action listener: _resource_record_pre_action 10:36:26 INFO - Running main action method: clobber 10:36:26 INFO - rmtree: /builds/slave/test/build 10:36:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:36:27 INFO - Running post-action listener: _resource_record_post_action 10:36:27 INFO - ##### 10:36:27 INFO - ##### Running read-buildbot-config step. 10:36:27 INFO - ##### 10:36:27 INFO - Running pre-action listener: _resource_record_pre_action 10:36:27 INFO - Running main action method: read_buildbot_config 10:36:27 INFO - Using buildbot properties: 10:36:27 INFO - { 10:36:27 INFO - "properties": { 10:36:27 INFO - "buildnumber": 1178, 10:36:27 INFO - "product": "firefox", 10:36:27 INFO - "script_repo_revision": "production", 10:36:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:36:27 INFO - "repository": "", 10:36:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:36:27 INFO - "buildid": "20151205100829", 10:36:27 INFO - "slavename": "talos-linux64-ix-065", 10:36:27 INFO - "pgo_build": "False", 10:36:27 INFO - "basedir": "/builds/slave/test", 10:36:27 INFO - "project": "", 10:36:27 INFO - "platform": "ubuntu64_hw", 10:36:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:36:27 INFO - "slavebuilddir": "test", 10:36:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:36:27 INFO - "branch": "fx-team", 10:36:27 INFO - "repo_path": "integration/fx-team", 10:36:27 INFO - "stage_platform": "linux64", 10:36:27 INFO - "builduid": "f60bfabda8b24fe7ab1cf449f16b48f4", 10:36:27 INFO - "revision": "2193658ea0c7bdb7ba0dffb3114796c32e212cf3" 10:36:27 INFO - }, 10:36:27 INFO - "sourcestamp": { 10:36:27 INFO - "repository": "", 10:36:27 INFO - "hasPatch": false, 10:36:27 INFO - "project": "", 10:36:27 INFO - "branch": "fx-team-linux64-talos", 10:36:27 INFO - "changes": [ 10:36:27 INFO - { 10:36:27 INFO - "category": null, 10:36:27 INFO - "files": [ 10:36:27 INFO - { 10:36:27 INFO - "url": null, 10:36:27 INFO - "name": "https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:36:27 INFO - } 10:36:27 INFO - ], 10:36:27 INFO - "repository": "", 10:36:27 INFO - "rev": "2193658ea0c7bdb7ba0dffb3114796c32e212cf3", 10:36:27 INFO - "who": "jlong@mozilla.com", 10:36:27 INFO - "when": 1449340519, 10:36:27 INFO - "number": 6789073, 10:36:27 INFO - "comments": "Bug 1230556 - avoid blocking the debugger shutdown on pending requests r=me", 10:36:27 INFO - "project": "", 10:36:27 INFO - "at": "Sat 05 Dec 2015 10:35:19", 10:36:27 INFO - "branch": "fx-team-linux64-talos", 10:36:27 INFO - "revlink": "", 10:36:27 INFO - "properties": [ 10:36:27 INFO - [ 10:36:27 INFO - "buildid", 10:36:27 INFO - "20151205100829", 10:36:27 INFO - "Change" 10:36:27 INFO - ], 10:36:27 INFO - [ 10:36:27 INFO - "builduid", 10:36:27 INFO - "f60bfabda8b24fe7ab1cf449f16b48f4", 10:36:27 INFO - "Change" 10:36:27 INFO - ], 10:36:27 INFO - [ 10:36:27 INFO - "pgo_build", 10:36:27 INFO - "False", 10:36:27 INFO - "Change" 10:36:27 INFO - ] 10:36:27 INFO - ], 10:36:27 INFO - "revision": "2193658ea0c7bdb7ba0dffb3114796c32e212cf3" 10:36:27 INFO - } 10:36:27 INFO - ], 10:36:27 INFO - "revision": "2193658ea0c7bdb7ba0dffb3114796c32e212cf3" 10:36:27 INFO - } 10:36:27 INFO - } 10:36:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:36:27 INFO - Running post-action listener: _resource_record_post_action 10:36:27 INFO - ##### 10:36:27 INFO - ##### Running download-and-extract step. 10:36:27 INFO - ##### 10:36:27 INFO - Running pre-action listener: _resource_record_pre_action 10:36:27 INFO - Running main action method: download_and_extract 10:36:27 INFO - mkdir: /builds/slave/test/build/tests 10:36:27 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')]} 10:36:27 INFO - https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:36:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/test_packages.json 10:36:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/test_packages.json 10:36:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:36:35 INFO - Downloaded 1302 bytes. 10:36:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:36:35 INFO - Using the following test package requirements: 10:36:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:36:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:36:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:35 INFO - u'jsshell-linux-x86_64.zip'], 10:36:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:36:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:36:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:36:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:36:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:36:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:36:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:36:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:36:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:35 INFO - https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:36:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:36:45 INFO - Downloaded 21849117 bytes. 10:36:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:36:46 INFO - Return code: 0 10:36:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:46 INFO - https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:36:47 INFO - Downloaded 21849117 bytes. 10:36:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:36:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:36:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:36:49 INFO - Return code: 0 10:36: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')]} 10:36:49 INFO - https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:36:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:36:50 INFO - Downloaded 11132001 bytes. 10:36:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:36:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:36:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:36:50 INFO - Return code: 0 10:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:50 INFO - https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:36:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:36:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:36:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:36:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:36:51 INFO - Downloaded 57707683 bytes. 10:36:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:36:51 INFO - mkdir: /builds/slave/test/properties 10:36:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:36:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:36:51 INFO - Contents: 10:36:51 INFO - build_url:https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:36:51 INFO - Running post-action listener: _resource_record_post_action 10:36:51 INFO - Running post-action listener: set_extra_try_arguments 10:36:51 INFO - ##### 10:36:51 INFO - ##### Running populate-webroot step. 10:36:51 INFO - ##### 10:36:51 INFO - Running pre-action listener: _resource_record_pre_action 10:36:51 INFO - Running main action method: populate_webroot 10:36:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:36:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:36:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:36:51 INFO - '../fennec_ids.txt'], 10:36:51 INFO - 'tests': ['tcheck2']}, 10:36:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:36:51 INFO - '--tppagecycles', 10:36:51 INFO - '7'], 10:36:51 INFO - 'tests': ['tsvgm']}}, 10:36:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:36:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:36:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:36:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:36:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'tests': ['damp', 'tps']}, 10:36:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['damp', 'tps']}, 10:36:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:36:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:36:51 INFO - 'other': {'tests': ['a11yr', 10:36:51 INFO - 'ts_paint', 10:36:51 INFO - 'tpaint', 10:36:51 INFO - 'sessionrestore', 10:36:51 INFO - 'sessionrestore_no_auto_restore']}, 10:36:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['a11yr', 10:36:51 INFO - 'ts_paint', 10:36:51 INFO - 'tpaint', 10:36:51 INFO - 'sessionrestore', 10:36:51 INFO - 'sessionrestore_no_auto_restore']}, 10:36:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['a11yr', 10:36:51 INFO - 'ts_paint', 10:36:51 INFO - 'tpaint', 10:36:51 INFO - 'sessionrestore', 10:36:51 INFO - 'sessionrestore_no_auto_restore']}, 10:36:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['a11yr', 10:36:51 INFO - 'ts_paint', 10:36:51 INFO - 'tpaint', 10:36:51 INFO - 'sessionrestore', 10:36:51 INFO - 'sessionrestore_no_auto_restore']}, 10:36:51 INFO - 'other_l64': {'tests': ['a11yr', 10:36:51 INFO - 'ts_paint', 10:36:51 INFO - 'tpaint', 10:36:51 INFO - 'sessionrestore', 10:36:51 INFO - 'sessionrestore_no_auto_restore']}, 10:36:51 INFO - 'other_nol64': {'tests': ['a11yr', 10:36:51 INFO - 'ts_paint', 10:36:51 INFO - 'tpaint', 10:36:51 INFO - 'sessionrestore', 10:36:51 INFO - 'sessionrestore_no_auto_restore']}, 10:36:51 INFO - 'svgr': {'tests': ['tsvgx', 10:36:51 INFO - 'tsvgr_opacity', 10:36:51 INFO - 'tart', 10:36:51 INFO - 'tscrollx', 10:36:51 INFO - 'cart']}, 10:36:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['tsvgx', 10:36:51 INFO - 'tsvgr_opacity', 10:36:51 INFO - 'tart', 10:36:51 INFO - 'tscrollx', 10:36:51 INFO - 'cart']}, 10:36:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'tests': ['tp5o']}, 10:36:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'talos_options': ['--e10s'], 10:36:51 INFO - 'tests': ['tp5o']}, 10:36:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'talos_options': ['--xperf_path', 10:36:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:51 INFO - 'tests': ['tp5n']}, 10:36:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:51 INFO - 'talos_options': ['--e10s', 10:36:51 INFO - '--xperf_path', 10:36:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:51 INFO - 'tests': ['tp5n']}}, 10:36:51 INFO - 'talos.zip': {'path': '', 10:36:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:36:51 INFO - Running post-action listener: _resource_record_post_action 10:36:51 INFO - ##### 10:36:51 INFO - ##### Running create-virtualenv step. 10:36:51 INFO - ##### 10:36:51 INFO - Running pre-action listener: _resource_record_pre_action 10:36:51 INFO - Running main action method: create_virtualenv 10:36:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:36:51 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 10:36:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:36:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:36:51 INFO - Using real prefix '/usr' 10:36:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:36:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:36:54 INFO - Installing pip.................done. 10:36:54 INFO - Return code: 0 10:36:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:36:54 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')]} 10:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:54 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')]} 10:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:54 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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:36:54 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 10:36:54 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 10:36:54 INFO - Using env: {'DISPLAY': ':0', 10:36:54 INFO - 'HOME': '/home/cltbld', 10:36:54 INFO - 'LANG': 'en_US.UTF-8', 10:36:54 INFO - 'LANGUAGE': 'en_US:en', 10:36:54 INFO - 'LOGNAME': 'cltbld', 10:36:54 INFO - 'MAIL': '/var/mail/cltbld', 10:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:54 INFO - 'MOZ_NO_REMOTE': '1', 10:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:54 INFO - 'NO_EM_RESTART': '1', 10:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:54 INFO - 'PWD': '/builds/slave/test', 10:36:54 INFO - 'SHELL': '/bin/bash', 10:36:54 INFO - 'SHLVL': '1', 10:36:54 INFO - 'TERM': 'linux', 10:36:54 INFO - 'TMOUT': '86400', 10:36:54 INFO - 'USER': 'cltbld', 10:36:54 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:54 INFO - '_': '/tools/buildbot/bin/python'} 10:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:54 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 10:36:54 INFO - Cleaning up... 10:36:54 INFO - Return code: 0 10:36:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:36:54 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')]} 10:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:54 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')]} 10:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:54 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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:36:54 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 10:36:54 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 10:36:54 INFO - Using env: {'DISPLAY': ':0', 10:36:54 INFO - 'HOME': '/home/cltbld', 10:36:54 INFO - 'LANG': 'en_US.UTF-8', 10:36:54 INFO - 'LANGUAGE': 'en_US:en', 10:36:54 INFO - 'LOGNAME': 'cltbld', 10:36:54 INFO - 'MAIL': '/var/mail/cltbld', 10:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:54 INFO - 'MOZ_NO_REMOTE': '1', 10:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:54 INFO - 'NO_EM_RESTART': '1', 10:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:54 INFO - 'PWD': '/builds/slave/test', 10:36:54 INFO - 'SHELL': '/bin/bash', 10:36:54 INFO - 'SHLVL': '1', 10:36:54 INFO - 'TERM': 'linux', 10:36:54 INFO - 'TMOUT': '86400', 10:36:54 INFO - 'USER': 'cltbld', 10:36:54 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:54 INFO - '_': '/tools/buildbot/bin/python'} 10:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:54 INFO - Downloading/unpacking psutil>=0.7.1 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:36:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:56 INFO - Installing collected packages: psutil 10:36:56 INFO - Running setup.py install for psutil 10:36:56 INFO - building 'psutil._psutil_linux' extension 10:36:56 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 10:36:56 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 10:36:56 INFO - building 'psutil._psutil_posix' extension 10:36:56 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 10:36:56 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 10:36:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:57 INFO - Successfully installed psutil 10:36:57 INFO - Cleaning up... 10:36:57 INFO - Return code: 0 10:36:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:36:57 INFO - Using env: {'DISPLAY': ':0', 10:36:57 INFO - 'HOME': '/home/cltbld', 10:36:57 INFO - 'LANG': 'en_US.UTF-8', 10:36:57 INFO - 'LANGUAGE': 'en_US:en', 10:36:57 INFO - 'LOGNAME': 'cltbld', 10:36:57 INFO - 'MAIL': '/var/mail/cltbld', 10:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:57 INFO - 'MOZ_NO_REMOTE': '1', 10:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:57 INFO - 'NO_EM_RESTART': '1', 10:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:57 INFO - 'PWD': '/builds/slave/test', 10:36:57 INFO - 'SHELL': '/bin/bash', 10:36:57 INFO - 'SHLVL': '1', 10:36:57 INFO - 'TERM': 'linux', 10:36:57 INFO - 'TMOUT': '86400', 10:36:57 INFO - 'USER': 'cltbld', 10:36:57 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:57 INFO - '_': '/tools/buildbot/bin/python'} 10:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:36:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:36:59 INFO - Installing collected packages: mozsystemmonitor 10:36:59 INFO - Running setup.py install for mozsystemmonitor 10:36:59 INFO - Successfully installed mozsystemmonitor 10:36:59 INFO - Cleaning up... 10:36:59 INFO - Return code: 0 10:36:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:36:59 INFO - Using env: {'DISPLAY': ':0', 10:36:59 INFO - 'HOME': '/home/cltbld', 10:36:59 INFO - 'LANG': 'en_US.UTF-8', 10:36:59 INFO - 'LANGUAGE': 'en_US:en', 10:36:59 INFO - 'LOGNAME': 'cltbld', 10:36:59 INFO - 'MAIL': '/var/mail/cltbld', 10:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:59 INFO - 'MOZ_NO_REMOTE': '1', 10:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:59 INFO - 'NO_EM_RESTART': '1', 10:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:59 INFO - 'PWD': '/builds/slave/test', 10:36:59 INFO - 'SHELL': '/bin/bash', 10:36:59 INFO - 'SHLVL': '1', 10:36:59 INFO - 'TERM': 'linux', 10:36:59 INFO - 'TMOUT': '86400', 10:36:59 INFO - 'USER': 'cltbld', 10:36:59 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:59 INFO - '_': '/tools/buildbot/bin/python'} 10:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:37:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:37:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:37:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:01 INFO - Downloading docopt-0.6.1.tar.gz 10:37:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:37:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:37:01 INFO - Running setup.py install for blobuploader 10:37:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:37:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:37:01 INFO - Running setup.py install for requests 10:37:02 INFO - Running setup.py install for docopt 10:37:02 INFO - Successfully installed blobuploader requests docopt 10:37:02 INFO - Cleaning up... 10:37:02 INFO - Return code: 0 10:37:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:02 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')]} 10:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:02 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')]} 10:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:02 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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:37:02 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 10:37:02 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 10:37:02 INFO - Using env: {'DISPLAY': ':0', 10:37:02 INFO - 'HOME': '/home/cltbld', 10:37:02 INFO - 'LANG': 'en_US.UTF-8', 10:37:02 INFO - 'LANGUAGE': 'en_US:en', 10:37:02 INFO - 'LOGNAME': 'cltbld', 10:37:02 INFO - 'MAIL': '/var/mail/cltbld', 10:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:02 INFO - 'MOZ_NO_REMOTE': '1', 10:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:02 INFO - 'NO_EM_RESTART': '1', 10:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:02 INFO - 'PWD': '/builds/slave/test', 10:37:02 INFO - 'SHELL': '/bin/bash', 10:37:02 INFO - 'SHLVL': '1', 10:37:02 INFO - 'TERM': 'linux', 10:37:02 INFO - 'TMOUT': '86400', 10:37:02 INFO - 'USER': 'cltbld', 10:37:02 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:02 INFO - '_': '/tools/buildbot/bin/python'} 10:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:02 INFO - Running setup.py (path:/tmp/pip-viEH8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:02 INFO - Running setup.py (path:/tmp/pip-R_XxAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:02 INFO - Running setup.py (path:/tmp/pip-ifMc74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:02 INFO - Running setup.py (path:/tmp/pip-yWavcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:02 INFO - Running setup.py (path:/tmp/pip-Ff9E7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:02 INFO - Running setup.py (path:/tmp/pip-Sm1aCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:03 INFO - Running setup.py (path:/tmp/pip-yF7ssX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:03 INFO - Running setup.py (path:/tmp/pip-E0Uth4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:03 INFO - Running setup.py (path:/tmp/pip-pinzx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:03 INFO - Running setup.py (path:/tmp/pip-3Z1cxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:03 INFO - Running setup.py (path:/tmp/pip-GhZIjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:03 INFO - Running setup.py (path:/tmp/pip-Hlbjy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:03 INFO - Running setup.py (path:/tmp/pip-uaKi6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:03 INFO - Running setup.py (path:/tmp/pip-YuJ_d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:03 INFO - Running setup.py (path:/tmp/pip-5s6155-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:03 INFO - Running setup.py (path:/tmp/pip-pseXfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:03 INFO - Running setup.py (path:/tmp/pip-JtfE2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:37:03 INFO - Running setup.py install for manifestparser 10:37:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:37:03 INFO - Running setup.py install for mozcrash 10:37:04 INFO - Running setup.py install for mozdebug 10:37:04 INFO - Running setup.py install for mozdevice 10:37:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozfile 10:37:04 INFO - Running setup.py install for mozhttpd 10:37:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozinfo 10:37:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozInstall 10:37:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozleak 10:37:04 INFO - Running setup.py install for mozlog 10:37:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for moznetwork 10:37:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:37:04 INFO - Running setup.py install for mozprocess 10:37:05 INFO - Running setup.py install for mozprofile 10:37:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Running setup.py install for mozrunner 10:37:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Running setup.py install for mozscreenshot 10:37:05 INFO - Running setup.py install for moztest 10:37:05 INFO - Running setup.py install for mozversion 10:37:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:37:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:37:05 INFO - Cleaning up... 10:37:05 INFO - Return code: 0 10:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:05 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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:37:05 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 10:37:05 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 10:37:05 INFO - Using env: {'DISPLAY': ':0', 10:37:05 INFO - 'HOME': '/home/cltbld', 10:37:05 INFO - 'LANG': 'en_US.UTF-8', 10:37:05 INFO - 'LANGUAGE': 'en_US:en', 10:37:05 INFO - 'LOGNAME': 'cltbld', 10:37:05 INFO - 'MAIL': '/var/mail/cltbld', 10:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:05 INFO - 'MOZ_NO_REMOTE': '1', 10:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:05 INFO - 'NO_EM_RESTART': '1', 10:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:05 INFO - 'PWD': '/builds/slave/test', 10:37:05 INFO - 'SHELL': '/bin/bash', 10:37:05 INFO - 'SHLVL': '1', 10:37:05 INFO - 'TERM': 'linux', 10:37:05 INFO - 'TMOUT': '86400', 10:37:05 INFO - 'USER': 'cltbld', 10:37:05 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:05 INFO - '_': '/tools/buildbot/bin/python'} 10:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:37:05 INFO - Running setup.py (path:/tmp/pip-FOVX9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:37:05 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)) 10:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:37:05 INFO - Running setup.py (path:/tmp/pip-JQ20VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:37:05 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)) 10:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:37:05 INFO - Running setup.py (path:/tmp/pip-su6V0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:37:06 INFO - Running setup.py (path:/tmp/pip-kwG_cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:37:06 INFO - Running setup.py (path:/tmp/pip-MpEJny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:37:06 INFO - Running setup.py (path:/tmp/pip-nq0tTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:37:06 INFO - Running setup.py (path:/tmp/pip-7lNPd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:37:06 INFO - Running setup.py (path:/tmp/pip-jafMIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:37:06 INFO - Running setup.py (path:/tmp/pip-PYMcSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:37:06 INFO - Running setup.py (path:/tmp/pip-xmW81O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:37:06 INFO - Running setup.py (path:/tmp/pip-1B0J7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:37:06 INFO - Running setup.py (path:/tmp/pip-JeDGEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:37:06 INFO - Running setup.py (path:/tmp/pip-nr1SXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:37:06 INFO - Running setup.py (path:/tmp/pip-8Bo3Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:06 INFO - Running setup.py (path:/tmp/pip-58Se4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:37:06 INFO - Running setup.py (path:/tmp/pip-ksiOg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:37:06 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)) 10:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:37:06 INFO - Running setup.py (path:/tmp/pip-pgjd1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 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)) 10:37:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:37:07 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 10:37:07 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 10:37:07 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 10:37:07 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 10:37:07 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 10:37:07 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 10:37:08 INFO - Downloading blessings-1.5.1.tar.gz 10:37:08 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 10:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:37:08 INFO - Installing collected packages: blessings 10:37:08 INFO - Running setup.py install for blessings 10:37:08 INFO - Successfully installed blessings 10:37:08 INFO - Cleaning up... 10:37:08 INFO - Return code: 0 10:37:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:09 INFO - Reading from file tmpfile_stdout 10:37:09 INFO - Current package versions: 10:37:09 INFO - argparse == 1.2.1 10:37:09 INFO - blessings == 1.5.1 10:37:09 INFO - blobuploader == 1.2.4 10:37:09 INFO - docopt == 0.6.1 10:37:09 INFO - manifestparser == 1.1 10:37:09 INFO - mozInstall == 1.12 10:37:09 INFO - mozcrash == 0.16 10:37:09 INFO - mozdebug == 0.1 10:37:09 INFO - mozdevice == 0.47 10:37:09 INFO - mozfile == 1.2 10:37:09 INFO - mozhttpd == 0.7 10:37:09 INFO - mozinfo == 0.9 10:37:09 INFO - mozleak == 0.1 10:37:09 INFO - mozlog == 3.1 10:37:09 INFO - moznetwork == 0.27 10:37:09 INFO - mozprocess == 0.22 10:37:09 INFO - mozprofile == 0.27 10:37:09 INFO - mozrunner == 6.11 10:37:09 INFO - mozscreenshot == 0.1 10:37:09 INFO - mozsystemmonitor == 0.0 10:37:09 INFO - moztest == 0.7 10:37:09 INFO - mozversion == 1.4 10:37:09 INFO - psutil == 3.1.1 10:37:09 INFO - requests == 1.2.3 10:37:09 INFO - wsgiref == 0.1.2 10:37:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:37: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')]} 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:09 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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:37:09 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 10:37:09 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 10:37:09 INFO - Using env: {'DISPLAY': ':0', 10:37:09 INFO - 'HOME': '/home/cltbld', 10:37:09 INFO - 'LANG': 'en_US.UTF-8', 10:37:09 INFO - 'LANGUAGE': 'en_US:en', 10:37:09 INFO - 'LOGNAME': 'cltbld', 10:37:09 INFO - 'MAIL': '/var/mail/cltbld', 10:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:09 INFO - 'MOZ_NO_REMOTE': '1', 10:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:09 INFO - 'NO_EM_RESTART': '1', 10:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:09 INFO - 'PWD': '/builds/slave/test', 10:37:09 INFO - 'SHELL': '/bin/bash', 10:37:09 INFO - 'SHLVL': '1', 10:37:09 INFO - 'TERM': 'linux', 10:37:09 INFO - 'TMOUT': '86400', 10:37:09 INFO - 'USER': 'cltbld', 10:37:09 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:09 INFO - '_': '/tools/buildbot/bin/python'} 10:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:37:09 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)) 10:37:09 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)) 10:37:09 INFO - Cleaning up... 10:37:09 INFO - Return code: 0 10:37:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:37: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')]} 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:09 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 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:37:09 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 10:37:09 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 10:37:09 INFO - Using env: {'DISPLAY': ':0', 10:37:09 INFO - 'HOME': '/home/cltbld', 10:37:09 INFO - 'LANG': 'en_US.UTF-8', 10:37:09 INFO - 'LANGUAGE': 'en_US:en', 10:37:09 INFO - 'LOGNAME': 'cltbld', 10:37:09 INFO - 'MAIL': '/var/mail/cltbld', 10:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:09 INFO - 'MOZ_NO_REMOTE': '1', 10:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:09 INFO - 'NO_EM_RESTART': '1', 10:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:09 INFO - 'PWD': '/builds/slave/test', 10:37:09 INFO - 'SHELL': '/bin/bash', 10:37:09 INFO - 'SHLVL': '1', 10:37:09 INFO - 'TERM': 'linux', 10:37:09 INFO - 'TMOUT': '86400', 10:37:09 INFO - 'USER': 'cltbld', 10:37:09 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:09 INFO - '_': '/tools/buildbot/bin/python'} 10:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:09 INFO - Downloading/unpacking jsonschema 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:37:11 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 10:37:11 INFO - Downloading/unpacking functools32 (from jsonschema) 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:37:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:37:11 INFO - warning: no files found matching '*.txt' 10:37:11 INFO - no previously-included directories found matching 'build' 10:37:11 INFO - no previously-included directories found matching 'dist' 10:37:11 INFO - no previously-included directories found matching '.git*' 10:37:11 INFO - Installing collected packages: jsonschema, functools32 10:37:11 INFO - Running setup.py install for functools32 10:37:11 INFO - warning: no files found matching '*.txt' 10:37:11 INFO - no previously-included directories found matching 'build' 10:37:11 INFO - no previously-included directories found matching 'dist' 10:37:11 INFO - no previously-included directories found matching '.git*' 10:37:11 INFO - Successfully installed jsonschema functools32 10:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f611d016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', '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 10:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:37:11 INFO - Using env: {'DISPLAY': ':0', 10:37:11 INFO - 'HOME': '/home/cltbld', 10:37:11 INFO - 'LANG': 'en_US.UTF-8', 10:37:11 INFO - 'LANGUAGE': 'en_US:en', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MAIL': '/var/mail/cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SHLVL': '1', 10:37:11 INFO - 'TERM': 'linux', 10:37:11 INFO - 'TMOUT': '86400', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - '_': '/tools/buildbot/bin/python'} 10:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:11 INFO - Downloading/unpacking flake8 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:37:13 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 10:37:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:37:13 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 10:37:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:13 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 10:37:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:14 INFO - no previously-included directories found matching 'docs/_build' 10:37:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:37:14 INFO - Running setup.py install for pep8 10:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:14 INFO - no previously-included directories found matching 'docs/_build' 10:37:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:37:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:37:14 INFO - Cleaning up... 10:37:14 INFO - Return code: 0 10:37:14 INFO - Running post-action listener: _resource_record_post_action 10:37:14 INFO - Running post-action listener: _start_resource_monitoring 10:37:14 INFO - Starting resource monitoring. 10:37:14 INFO - ##### 10:37:14 INFO - ##### Running install step. 10:37:14 INFO - ##### 10:37:14 INFO - Running pre-action listener: _resource_record_pre_action 10:37:14 INFO - Running main action method: install 10:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:37:14 INFO - Reading from file tmpfile_stdout 10:37:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:37:14 INFO - Reading from file tmpfile_stdout 10:37:14 INFO - Output received: 10:37:14 INFO - Usage: mozinstall [options] installer 10:37:14 INFO - Options: 10:37:14 INFO - -h, --help show this help message and exit 10:37:14 INFO - -d DEST, --destination=DEST 10:37:14 INFO - Directory to install application into. [default: 10:37:14 INFO - "/builds/slave/test"] 10:37:14 INFO - --app=APP Application being installed. [default: firefox] 10:37:14 INFO - mkdir: /builds/slave/test/build/application 10:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:37:29 INFO - Reading from file tmpfile_stdout 10:37:29 INFO - Output received: 10:37:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:37:29 INFO - Running post-action listener: _resource_record_post_action 10:37:29 INFO - ##### 10:37:29 INFO - ##### Running run-tests step. 10:37:29 INFO - ##### 10:37:29 INFO - Running pre-action listener: _resource_record_pre_action 10:37:29 INFO - Running main action method: run_tests 10:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:37:29 INFO - Python 2.7.3 10:37:29 INFO - Return code: 0 10:37:29 INFO - grabbing minidump binary from tooltool 10:37: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')]} 10:37:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c530b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c54440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:37:29 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 10:37:29 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 10:37:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:37:29 INFO - Return code: 0 10:37:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:37:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:37:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:37:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:37:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:37:30 INFO - Return code: 0 10:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test/build 10:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 10:37:30 INFO - Using env: {'DISPLAY': ':0', 10:37:30 INFO - 'HOME': '/home/cltbld', 10:37:30 INFO - 'LANG': 'en_US.UTF-8', 10:37:30 INFO - 'LANGUAGE': 'en_US:en', 10:37:30 INFO - 'LOGNAME': 'cltbld', 10:37:30 INFO - 'MAIL': '/var/mail/cltbld', 10:37:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:37:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:30 INFO - 'MOZ_NO_REMOTE': '1', 10:37:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:30 INFO - 'NO_EM_RESTART': '1', 10:37:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:30 INFO - 'PWD': '/builds/slave/test', 10:37:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:37:30 INFO - 'SHELL': '/bin/bash', 10:37:30 INFO - 'SHLVL': '1', 10:37:30 INFO - 'TERM': 'linux', 10:37:30 INFO - 'TMOUT': '86400', 10:37:30 INFO - 'USER': 'cltbld', 10:37:30 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606', 10:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:30 INFO - '_': '/tools/buildbot/bin/python'} 10:37:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 10:37:30 INFO - mozversion INFO | application_buildid: 20151205100829 10:37:30 INFO - mozversion INFO | application_changeset: 2193658ea0c7bdb7ba0dffb3114796c32e212cf3 10:37:30 INFO - mozversion INFO | application_display_name: Nightly 10:37:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:30 INFO - mozversion INFO | application_name: Firefox 10:37:30 INFO - mozversion INFO | application_remotingname: firefox 10:37:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:37:30 INFO - mozversion INFO | application_vendor: Mozilla 10:37:30 INFO - mozversion INFO | application_version: 45.0a1 10:37:30 INFO - mozversion INFO | platform_buildid: 20151205100829 10:37:30 INFO - mozversion INFO | platform_changeset: 2193658ea0c7bdb7ba0dffb3114796c32e212cf3 10:37:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:37:30 INFO - mozversion INFO | platform_version: 45.0a1 10:37:30 INFO - 2015-12-05 10:37:30,520 DEBUG : using testdate: 1449340650 10:37:30 INFO - 2015-12-05 10:37:30,520 DEBUG : actual date: 1449340650 10:37:30 INFO - 2015-12-05 10:37:30,619 INFO : starting webserver on 'localhost:53249' 10:37:30 INFO - 2015-12-05 10:37:30,620 INFO : Starting test suite talos-linux64-ix-065 10:37:30 INFO - 2015-12-05 10:37:30,620 INFO : Starting test dromaeo_css 10:37:30 INFO - 2015-12-05 10:37:30,620 DEBUG : operating with platform_type : linux_ 10:37:30 INFO - 2015-12-05 10:37:30,621 INFO : Initialising browser for dromaeo_css test... 10:37:30 INFO - 2015-12-05 10:37:30,634 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPVsPj/profile http://localhost:53249/getInfo.html 10:37:35 INFO - 2015-12-05 10:37:35,445 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:37:35 INFO - 2015-12-05 10:37:35,445 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:37:35 INFO - 2015-12-05 10:37:35,445 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:37:35 INFO - 2015-12-05 10:37:35,445 DEBUG : BROWSER_OUTPUT: __metrics 10:37:35 INFO - 2015-12-05 10:37:35,561 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] 10:37:35 INFO - 2015-12-05 10:37:35,623 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:35 ERROR - 2015-12-05 10:37:35,639 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:37:36 INFO - 2015-12-05 10:37:36,605 INFO : Browser initialized. 10:37:36 INFO - 2015-12-05 10:37:36,605 INFO : Running cycle 1/1 for dromaeo_css test... 10:37:36 INFO - 2015-12-05 10:37:36,605 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPVsPj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:37:48 INFO - 2015-12-05 10:37:48,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 142368768 10:37:48 INFO - 2015-12-05 10:37:48,650 DEBUG : BROWSER_OUTPUT: 10:38:39 INFO - 2015-12-05 10:38:39,361 DEBUG : BROWSER_OUTPUT: 1449340719353 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] 10:40:52 INFO - 2015-12-05 10:40:52,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53249/tests/dromaeo/cssquery-ext.html) 10:40:53 INFO - 2015-12-05 10:40:53,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 239300608 10:40:53 INFO - 2015-12-05 10:40:53,947 DEBUG : BROWSER_OUTPUT: 10:43:56 INFO - 2015-12-05 10:43:56,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-ext.html (next: http://localhost:53249/tests/dromaeo/cssquery-jquery.html) 10:43:56 INFO - 2015-12-05 10:43:56,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 222920704 10:43:56 INFO - 2015-12-05 10:43:56,968 DEBUG : BROWSER_OUTPUT: 10:46:59 INFO - 2015-12-05 10:46:59,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53249/tests/dromaeo/cssquery-mootools.html) 10:46:59 INFO - 2015-12-05 10:46:59,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 207118336 10:46:59 INFO - 2015-12-05 10:46:59,703 DEBUG : BROWSER_OUTPUT: 10:50:01 INFO - 2015-12-05 10:50:01,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53249/tests/dromaeo/cssquery-prototype.html) 10:50:02 INFO - 2015-12-05 10:50:02,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 199839744 10:50:02 INFO - 2015-12-05 10:50:02,236 DEBUG : BROWSER_OUTPUT: 10:53:04 INFO - 2015-12-05 10:53:04,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53249/tests/dromaeo/cssquery-yui.html) 10:53:05 INFO - 2015-12-05 10:53:05,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 206319616 10:53:05 INFO - 2015-12-05 10:53:05,550 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/dromaeo/cssquery-yui.html (next: http://localhost:53249/tests/dromaeo/cssquery-dojo.html) 10:56:08 INFO - 2015-12-05 10:56:08,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 252104704 10:56:08 INFO - 2015-12-05 10:56:08,623 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,624 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:56:08 INFO - 2015-12-05 10:56:08,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:56:08 INFO - 2015-12-05 10:56:08,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:56:08 INFO - 2015-12-05 10:56:08,624 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:56:08 INFO - 2015-12-05 10:56:08,627 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2654.920352389428;2697.5279326117925;2703.837769733815;2713.742194491524;2740.4930087933726;4627.583517483426;4697.177993851075;4701.412323459567;4732.432108147019;4732.881677958048;4706.294055891618;4758.310045043467;4798.160321943664;4804.5916097131785;4814.759262036893;4330.675199360045;4377.1683380157665;4401.383806267133;4463.68754187207;4500.5499450054895;4203.201391735561;4407.360932664762;4443.044745379742;4491.214037543433;4539.500654927955;4273.722208056497;4346.56534346566;4353.84761533348;4364.934525982113;4389.122175564868;4301.978490107561;4400.355463250515;4406.317020861771;4406.383106365111;4437.2013037653205;4213.662906967435;4372.5627437256335;4391.297392417198;4393.209222339978;4419.64642828573;4565.863024109282;4566.13243483737;4594.862154135381;4655.25515917455;4756.881077973044;5138.460461651547;5140.563052140573;5147.459516750725;5159.638825282232;5183.326167598226;5139.691618502902;5144.794208231666;5152.124138896396;5156.690598564098;5211.661242019294;4590.104929538775;4694.319323698045;4698.718076915396;4759.286107083931;4773.331733557305;5176.275321454999;5240.292560504359;5249.632525723239;5300.734963251822;5302.734863256822;5014.6991180529285;5077;5079.6952182869145;5080.13637681595;5129.9743501282255;4870.269459581091;4928.48250933654;4981.078500477423;5163.896722065538;5174.508421699932;4980.975095124501;5064.7214403207445;5065.493450654905;5065.822696205615;5105.438401775802;5037.848864534069;5047.318611987408;5068.695878247317;5072.416672082684;5110.872228194325;4007.318755811519;4123.175364926967;4123.340265557496;4247.086876321606;4285.807138678767;3630.7821530708243;3692.2061756722433;3714.888553343404;3715.1640880802142;3719.5350581177354;4426.535213802505;4450.821967121344;4451.043025749479;4452.243118669834;4496.460424749051;4894.706317620883;5185.792568297301;5191.039657663345;5204.271402003723;5235.450277720861;4297.09760950204;4343.978280108579;4353.455818022747;4384.298512238027;4386.868393948187;4519.7740112994215;4534.433195850519;4534.909301813946;4537.568930951555;4582.427196600425;4879.585235255043;4881.999190166079;4883.560479556857;4887.486813884633;4927.1131196384995;4866.6350023747655;4981.42713587942;4993.201087825931;5035.84892453227;5123.513266239701;4890.80436782539;4908.607311415007;4909.779059942382;4912.189488734319;4915.95084049155;5075.086484432837;5079.161938280143;5083.957788653391;5087.058894104603;5124.9743751281;4862.440819305683;4971.975140124277;4978.502149784992;5059.3169922061525;5147.756913144695;4949.1586430306215;4992.700437973734;5009.849704508871;5011.774470148779;5014.924776128434;5010.49895010496;5012.77442515095;5015.573676237561;5017.64876458659;5042.243663450512;4625.375574297562;4718.882027949191;4740.69185502955;4784.95215047859;4931.753412329441;5022.573081288131;5038.193888977892;5041.445441001413;5049.57078648319;5061.670991385548;4892.951070489392;4903.828366007173;4913.287573301923;4915.410150781786;4960.77676504551 10:56:08 INFO - 2015-12-05 10:56:08,628 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.2813234993033;566.7789562070791;569.1604882797874;574.8332983434805;595.1132812109955;28424.85787571062;28911.710882891166;28998.855005724967;29008.70991290089;29022.274443138933;29722.85138574304;37367;38221;38479.23041539168;38491.61508384915;7855.960720196405;7992.720254791084;7997.40019498537;8005.199480051977;8006.799830004267;6955.200151982536;7159.105111861018;7913.604319784016;8044.115147333789;8045;6934.895976560356;7011.298870112999;7013;7016.929830701704;9800.656977005807;9741.659041933533;9852.458114803683;9867.210623150168;9871.457069861155;9872.950635246849;9602.423854568679;9725.173360264385;9740.123388895034;9760.707178784647;9761.902380976242;34048.48927266093;34443.13892152691;34477.48283775745;34505.13737156566;34537.30925381478;2563.371973866396;2609.4650596627644;2636.657234559514;2760.903368382117;2946.1161651504462;27153.728462715517;27398;27654.308642283904;27687.446251075067;27745;3252.7560432967384;3277.4428347180797;3301.4222511060707;3307.68576985186;3404.8638054478038;218364;219150;219414;221332;221748;49721.502784972414;51017.48982510201;53073.2039019415;53182.20226696603;53694.19458708123;49960.75019624879;50359.49640503548;50615.493845061814;50630.49369506331;50655;14216.64458388528;14494.85505144935;14500.347484363228;14513.201773902325;14513.709725805425;10800;10825;10858.565657373616;10858.945705271422;10866.076383507332;17533.21100550478;17886.373976910745;17988;18006.189721462564;18113.54716132081;7207.495475316782;7379.963100184465;7493.66278517468;7497.1753107158165;7501.612201742695;812.8861959325699;842.7556008757514;909.2453263791037;912.115248209236;941.6751220828803;26756.732432675424;26806.463870722866;26910;27149.728502715116;27283;938.7934654376163;942.6135284533308;1015.7003683913264;1032.4734385463319;1094.1520321750706;13691.246981415918;13699.520516781864;13853.792193117111;14056.367463464168;14118.435262589586;261357;264151;265078;265954;266170;46418.303725444144;46803.5319646806;46836.765816171384;46850.76574617105;46908.5309146911;1193.6061099837034;1196.9940150299192;1197.9814013387645;1207.3782002268838;1220.170284206748;21905;25046.62430063587;25402.87298563569;26720;29652.110436686933;41088.58911410967;41235.587644123174;41578.168436631706;41625.37561936634;41634.1673166541;221941;223679;223931;224344;315115;24598.877005614857;28739.856300718362;29040.7095929038;29239.41521169522;29411.264718382212;34166.316673666886;35260;35262.29475410426;35674.8216258917;39563.80218099006;32166.83916580402;32538.51192232071;32891;33423.1644208887;33574;32020.35959280755;32344.838275809412;32804;32846.835765821015;33048.17379565434;33196.50205246972;33239.83380083084;33427;33486.497702534;34098.07872094642;26140.8692956534;27750;29414.55878161872;30264.17004550905;30705.846470767505;22407.327780166623;23302.65046024277;23420.64869027;23517.529649406573;23576.528469430174 10:56:08 INFO - 2015-12-05 10:56:08,631 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.86869890086103;328.24503641624267;329.7856393344327;332.1878008269778;333.7163411100565;12538.310392928386;13045;15228.847711522896;15531.84468155318;15716.214189290547;15226.923865380686;15232.466863659774;15609.453669121584;15615.531534053967;15632.2965466554;4926.975365123179;4936.7037977721275;5060.54455099041;5071.391433028023;5072.39131304244;3544.6809787119155;3622.6739593436587;3625.0756057205376;4954.083494553519;5530.225768392428;5609.691466969315;5628.831135065934;5653.462921022517;5660.2075709400715;5661.179129026289;4927.334809800667;5078.542931136179;5079.339685840817;5090.490950904917;5611.691356975365;4776.80892764289;4883.658143929926;4890.5109489051165;4896.608271338285;5117.66735162217;11263.718407039807;11463.197576169672;11468.71328216793;11480.655580332603;11505.079593632488;1789.7673302470726;1790.3375750972223;1823.3982785680826;1830.0941034188163;1837.6141010387835;8492.66029358825;8842.469451832847;10009.949950250275;12071.93964030183;12139.635810925687;1560.6332511859705;1607.340990194015;1626.1869065467267;1671.707451196036;1738.4958362074983;56575.71712141454;58412;59779;59789.70105149446;59855;9841.311108222355;9933;9985.550650220757;10010.149137323264;10034.899651003543;12601.243925364508;12609.684757881127;12665.430055647517;12678.873211267954;12703.809442858364;6895.034695142684;6924.480663950224;6930.44556435494;6931.341522555349;6937.959306104024;6440.420362167428;6451;6494;6495.447886929664;6505.024246362988;4126.731762435492;4197.3074442717225;4205.17998990194;4228.682848786353;4247.490301163818;1635.8854880158274;1658.9834101658828;1678.2280151130617;1680.3110724603098;1725.12018870377;842.203418413398;893.5353616119581;964.1756298364937;976.6093562575027;988.362506183522;15890.682186356207;16101.516954491384;16131.758023629654;16247.51257462278;16533;812.3014207781304;829.4069740135832;848.1772680499905;861.2335021830576;866.9956650216835;8774.341924355698;8845;9074.682386116454;9106;9400.670976515788;514679;518886;520975;521266;530312;72074.27925720676;73886.26113738901;73925;74013;77279;1068.4604274841156;1085.766560189563;1085.7719878825378;1090.6128324444867;1107.9999999999839;14676.3395647194;14792.63018424548;14943.476978305707;15080.849191508383;15344.462943796914;32875.835620821745;34099.829500852335;34174.82912585421;34613.65386346104;34661.82669086739;43737.78131109324;43889.34165987577;43974;44414.55585444233;48444.273335899285;8318.584070796556;8719.476831390137;8775.736727898173;8793.912060879566;8827.940647122387;8905.777355566162;9538.95230523843;9811.705648830546;10258.28192026551;10334.586616535555;8213.917860821555;8711.607977640895;9463.574139163891;9585.376950498196;9692;9130.680426185052;9332.113449222314;9420.199283061016;9446.244300456085;9475.194608458083;8545.359098067545;8936.41913275635;8951.73144805657;9204.171624553823;9698.806023879624;13121.359830021247;13527.323633818467;13746.862531374558;14212.360443779848;14636.04865683727;14605.561833145022;14627.414903404171;15063.623409414853;15233.847661523243;15247.618809529851 10:56:08 INFO - 2015-12-05 10:56:08,632 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1218.421249906295;1412.2867951684398;1424.4159894443274;1638.6067343837478;1712.5975395781988;6061.605995610288;7246.094238220223;7407.333339999399;7429.034225550678;7449.068866391701;7296.197418283985;7449.739259125931;7455.366293865028;7459.776206713807;7470.55176689399;2113.8308935285218;2151.085788539864;2152.6770984352393;2153.3217036633487;2154.870707757532;2132.968005479919;2168.2627906511784;2168.945776355588;2170.1644866726265;2171.837112216582;2079.345006323011;2094.14140202517;2100.348891843526;2131.690904818808;2132.893355332235;2094.486850721575;2117.4071260047212;2119.2688522459725;2119.5337025854287;2120.6076875777953;2071.326818783886;2130.3182981445943;2130.8721476711294;2131.637621604331;2131.840111991591;7354.77935661931;7361.227071157505;7422.220666829959;7441.0326657534715;7455.179930207672;4238.660907127453;4294.4202532658;4303.07483890965;4308.18144552534;4309.547497512747;2620.1222590432226;2654.973450265492;2664.3472349274552;2669.6929853066954;2674.3581540430155;833.7082021292499;1618.482085732566;1628.267279724129;1634.7139250631092;1684.132671674089;9622;9818.803623927553;9823.115919567203;9845.556949937198;9850.60597576089;3902.297586434412;3909.354956432214;3972.205558888234;3974.3044967131214;3996.9400458993136;8723.869141962876;8730.864987551704;8741.825163496822;8745.431546949429;8755.562221889008;4325.351197320364;4368;4388.824447022147;4390.078083602415;4395.055063161436;3299.043277449513;3301.257217126127;3848.9037774055873;3970.622790834866;3977.3636218204947;3552.8808425345933;3565.554305711786;3583.2475180212446;3588.2105936694406;3600.243948770735;1106.8671759388765;1118.6923596011;1120.1151090638305;1122.8764835868049;1125.150511363915;903.3225081189108;918.2149262380568;919.1130559010587;945.952702364879;1231.3166192762924;6919;6928.099347084847;6930.099087118642;6943.6875340609795;6946.235914049451;417.0886612751149;418.6127831755614;1036.9792604147874;1121.9439028048564;1123.8145705958425;5479.342478902558;5479.643823151482;5508.944910550843;5523.033469142964;5540.445955404427;8592.828143437222;8659.220670139717;8813;8866.157715017192;8983.191512763882;8686.131386861389;8754.387192896564;8874.112588741204;8887.688930887389;8899.243564296978;6881.518293719491;6898.0687607173395;6974.895376569356;7008.26413226614;7036.331548502884;6641.734330626721;6696.732130714911;6698.430633396216;6702.430293424918;6703.162104736908;7700.961495192488;7873.330766884879;7906.327962123284;8005.199480052182;8027.317677997436;7753.379729621504;8032.317253033558;8060.7178748745855;8067.515949043076;8104.918950810652;5446.346438427414;5546.55627549787;6052.576319657758;6456.580322279036;6545.934540654723;7004.859902801813;7024.5082844200415;7091.645417729196;7093.680784364613;7105.715771369088;6472.265642557099;6655.334466553306;6676.566023208476;6689.732410703517;6752.729890804313;6336.17629708135;6595.571287866273;6616.643588064339;6625.734970601315;6650.3682150195655;6420.967895160495;6442.065900444503;6447.4197322241225;6454.903176452263;6462.386073323027;5747.166660834072;5771.884562308646;5877.177195192762;5888.528917686661;5889.234399528034;5975.193348898017;5994.490468310068;6001.489873360639;6002.819915402545;6012.669303188367 10:56:08 INFO - 2015-12-05 10:56:08,632 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.51860318854756;284.5163222521712;289.6379525593009;291.71557731212073;294.7185437906799;5127.666701664399;5299.470052994699;5369.033573956686;5429.891402171954;5470.2615146955095;5198.246254293125;5304.49607287308;5329.786808527664;5342.679439233649;5346;4094.6314831665145;4107.199096176247;4107.609777071189;4114.567970363106;4118;3877.263319969211;3950.1902110067513;4003.679705623543;4109.815058322368;4112.8971775705695;4074.327735923584;4077.9184416311655;4082.734622249559;4084.6323830855217;4084.7344922579937;4072.7759973201464;4082.0203151243786;4083.9387409188885;4086.1010577672864;4094.303968325392;3558.5551806024246;3563.625819288963;3563.928721425557;3566.233259849145;3568.0366301098816;5025.522575355335;5135.435102138762;5139.203423469368;5159.896802063938;5161.5870730341485;4682.859514214579;4698.506656801021;4699.036697477009;4700.177468942921;4701.929471057937;5589.692566908819;5595.132754423071;5601.467860553241;5604.971975140139;5606.467385598362;3648.7628304160144;3723.7765734056043;3772.1512659651357;3879.72841901067;3883.2233553289457;5910.438508341744;5911.733971971272;5938.851528711773;5941.2276404067625;5941.316748573883;3983.9203215935518;3983.9999999999422;3987.5813039631003;3994.420808982681;3998.1803730235815;4047.0489434982755;4048.0487085534874;4051.149258655715;4054.5337286211875;4054.8580799671868;4535.070310586388;4579.702319349231;4659.743714095757;4662.860114196579;4669.0428462165855;5613.933352662981;5625.493705566437;5630.296212973379;5630.521405680481;5639.859003524863;1407.240090351199;1440.7046555456106;1440.7910852926268;1441.3874103505968;1441.6467965348556;971.9028097190366;972.781124247053;980.1864452504404;995.2286977592279;997.6657819630506;4939.333190019302;4943.777530011158;4945.703257804544;4955.40535135786;4961.751912404366;5822.505087067562;5824.0390335595;5825.155352473952;5831.650100993954;5835.737391817378;4935.950640493549;4942.308076869242;4949.455559888409;4951.653384263067;4954.1082605130705;3067.92330191747;3113.7508999280003;3120.2823350629483;3151.0861850063684;3152.4640811062172;5535.972320138373;5544.362398324163;5547.694876781735;5549.084401073777;5550.972245138749;5902.822915312548;5971.940280597139;5976.103584462366;5978.163057172;5992.580519363602;5510.035743744828;5522.061249587579;5522.972385138049;5534.252875861707;5538.335399752055;5638.605297629127;5813.215215945793;5825.50483208915;5830.4461076197695;5833.591648584558;5491.231227628055;5596.552275818006;5715.31416230055;5716.771329146954;5725.398833122629;5439.456054394529;5589.105743081088;5597.608167428404;5611.5230205433;5611.775528978958;3885.9417108743955;3920.627540383659;3924.568297487331;3925.7055720821622;3927.5876033017266;5857.824265272048;5859.267591551056;5864.882702345843;5867.706614669335;5869.589128760946;5481.260029895913;5636.041872881702;5661.915071273852;5664.915026274527;5668.688222147822;5648.406917273627;5656.406077361818;5660.632058916157;5662.8018019370775;5664.518515926193;5531.363893152339;5540.806071787468;5542.667439953616;5543.501084902378;5549.250851135206;5563.304586926634;5706.9714651426475;5707.8858422832145;5710.828675139753;5720.570957178145;5498.835034948958;5530.944690553043;5534.1145416733125;5541.33503979525;5542.8337149885565 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.1953275602036;706.8692291925994;706.9363757261846;746.7647690977342;752.270297811123;11660.416979151041;11861.881381186186;11899.881001189997;13766.311684415788;14089.661482159205;13797.724045519084;13864.722705545882;13904.235267060307;13906.374213160407;13922.791158132635;635.1901325809583;638.2436812377348;798.2376830127215;802.4182467710921;812.7439856445201;806.5443024691031;807.7899746066006;810.8662070758318;810.9472884262534;811.5009269299397;837.8408102460544;842.9789255268606;843.0389356133982;843.1063073142458;844.3667249562828;659.1859054068221;661.2858113237692;800.8398320335898;808.9393295502861;809.360605121953;598.4045874355002;602.6625089949598;603.2941458493573;605.340179204669;607.717411403695;12256.754864902741;12339.938300308531;12406.007519398427;12457.626271211879;12460.688482788002;10960.56157753689;11461.885381146249;11506.30962142274;11527.423628818526;11659.941700291529;9391.62433502659;9464.053594640549;9508.952455237679;9661.565229564687;9675.806483870354;3302.240484688511;3330.7168890644325;3332;3335.332933413327;3364.5962484502015;42612.14775704499;42873;43185.78407107976;43190;43934.34098488557;9180.586873590704;9278.62885484573;9312.068793120634;9631.181349585364;9729.902700973042;16565.58586035359;16846.494605161864;16884.155792210586;16884.662306754042;16888.324467021426;6200.3179650239335;6272.153259309935;6327.070243575754;6385.776497822554;6635.104260924713;3594.2991116731987;3602.945955810665;3612.205314830733;3698.6486283802997;3750.3436898542645;2732.8496932668495;2754.5454999925187;2755.2698534888273;2755.8897644094413;2764.4471105778925;459.7586267209742;465.1116367737605;468.5455108544706;475.595743617922;477.3460359307771;458.07468912795963;465.944086709597;470.348567234376;490.91654418748897;498.2924247568462;7362.815929601803;7726.536407815549;7756.534607923542;7837.05955285358;7970.880436793453;539.1885212754779;617.0497433951664;627.6328347916428;628.9465395441439;650.1028580558799;3662.304162209172;3729.9440508392395;3730.5896351401325;3812.085099576137;3880.1463677990796;53540.46459535433;54020.18969715457;54054.72972635191;54079.18881216785;54158.72920635372;42702.57297426986;42950.35574466385;43490.56509434929;43568;43590.56409435929;36110.458343124876;37411;37542.43686344707;37635.43546846799;38197.42703859389;7548.886766698394;7835.294823465915;7926.603669816602;8068.435209535276;8208.261256486945;29963.400731985676;31210.063698089092;32423.675763242067;32427.18932026718;33121;36299;39247.41128883012;41225;41613;41939.7903010483;9928.851067233853;10051.145652619609;10180.287379883337;10434.617460666386;10488.26582139243;11200;11518.596849110241;11541.82687259675;11786.646400607995;12096.939515302367;10530.789384212427;10714.517846697074;10841.891581084088;10878.23852330361;10930.617428389969;10690.305130166515;11332.433378330885;11373.772524549628;11402.258853174517;11413.657590272305;10483.895161048596;10563.894361056291;10688.412137332522;10867.673969780919;11075.944620277169;8798.692045778367;9111.681091161778;9178.541072946193;9353.579088941151;9659.71020869375;8334.416590838584;8449.746507604781;8454.957725211334;8739.737807865775;9001.864972025294 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,833 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: __startTimestamp1449341768623__endTimestamp 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,634 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:56:08 INFO - 2015-12-05 10:56:08,635 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:56:08 INFO - 2015-12-05 10:56:08,635 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,635 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4703.03 Median:4879.59 stddev:504.04 (10.3%) stddev-sans-first:479.30 10:56:08 INFO - 2015-12-05 10:56:08,635 DEBUG : BROWSER_OUTPUT: Values: 2654.9 2697.5 2703.8 2713.7 2740.5 4627.6 4697.2 4701.4 4732.4 4732.9 4706.3 4758.3 4798.2 4804.6 4814.8 4330.7 4377.2 4401.4 4463.7 4500.5 4203.2 4407.4 4443.0 4491.2 4539.5 4273.7 4346.6 4353.8 4364.9 4389.1 4302.0 4400.4 4406.3 4406.4 4437.2 4213.7 4372.6 4391.3 4393.2 4419.6 4565.9 4566.1 4594.9 4655.3 4756.9 5138.5 5140.6 5147.5 5159.6 5183.3 5139.7 5144.8 5152.1 5156.7 5211.7 4590.1 4694.3 4698.7 4759.3 4773.3 5176.3 5240.3 5249.6 5300.7 5302.7 5014.7 5077.0 5079.7 5080.1 5130.0 4870.3 4928.5 4981.1 5163.9 5174.5 4981.0 5064.7 5065.5 5065.8 5105.4 5037.8 5047.3 5068.7 5072.4 5110.9 4007.3 4123.2 4123.3 4247.1 4285.8 3630.8 3692.2 3714.9 3715.2 3719.5 4426.5 4450.8 4451.0 4452.2 4496.5 4894.7 5185.8 5191.0 5204.3 5235.5 4297.1 4344.0 4353.5 4384.3 4386.9 4519.8 4534.4 4534.9 4537.6 4582.4 4879.6 4882.0 4883.6 4887.5 4927.1 4866.6 4981.4 4993.2 5035.8 5123.5 4890.8 4908.6 4909.8 4912.2 4916.0 5075.1 5079.2 5084.0 5087.1 5125.0 4862.4 4972.0 4978.5 5059.3 5147.8 4949.2 4992.7 5009.8 5011.8 5014.9 5010.5 5012.8 5015.6 5017.6 5042.2 4625.4 4718.9 4740.7 4785.0 4931.8 5022.6 5038.2 5041.4 5049.6 5061.7 4893.0 4903.8 4913.3 4915.4 4960.8 10:56:08 INFO - 2015-12-05 10:56:08,635 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,635 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39702.88 Median:32825.42 stddev:63458.40 (193.3%) stddev-sans-first:63568.35 10:56:08 INFO - 2015-12-05 10:56:08,635 DEBUG : BROWSER_OUTPUT: Values: 559.3 566.8 569.2 574.8 595.1 28424.9 28911.7 28998.9 29008.7 29022.3 29722.9 37367.0 38221.0 38479.2 38491.6 7856.0 7992.7 7997.4 8005.2 8006.8 6955.2 7159.1 7913.6 8044.1 8045.0 6934.9 7011.3 7013.0 7016.9 9800.7 9741.7 9852.5 9867.2 9871.5 9873.0 9602.4 9725.2 9740.1 9760.7 9761.9 34048.5 34443.1 34477.5 34505.1 34537.3 2563.4 2609.5 2636.7 2760.9 2946.1 27153.7 27398.0 27654.3 27687.4 27745.0 3252.8 3277.4 3301.4 3307.7 3404.9 218364.0 219150.0 219414.0 221332.0 221748.0 49721.5 51017.5 53073.2 53182.2 53694.2 49960.8 50359.5 50615.5 50630.5 50655.0 14216.6 14494.9 14500.3 14513.2 14513.7 10800.0 10825.0 10858.6 10858.9 10866.1 17533.2 17886.4 17988.0 18006.2 18113.5 7207.5 7380.0 7493.7 7497.2 7501.6 812.9 842.8 909.2 912.1 941.7 26756.7 26806.5 26910.0 27149.7 27283.0 938.8 942.6 1015.7 1032.5 1094.2 13691.2 13699.5 13853.8 14056.4 14118.4 261357.0 264151.0 265078.0 265954.0 266170.0 46418.3 46803.5 46836.8 46850.8 46908.5 1193.6 1197.0 1198.0 1207.4 1220.2 21905.0 25046.6 25402.9 26720.0 29652.1 41088.6 41235.6 41578.2 41625.4 41634.2 221941.0 223679.0 223931.0 224344.0 315115.0 24598.9 28739.9 29040.7 29239.4 29411.3 34166.3 35260.0 35262.3 35674.8 39563.8 32166.8 32538.5 32891.0 33423.2 33574.0 32020.4 32344.8 32804.0 32846.8 33048.2 33196.5 33239.8 33427.0 33486.5 34098.1 26140.9 27750.0 29414.6 30264.2 30705.8 22407.3 23302.7 23420.6 23517.5 23576.5 10:56:08 INFO - 2015-12-05 10:56:08,636 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,636 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27040.97 Median:26663.97 stddev:85243.90 (319.7%) stddev-sans-first:85459.43 10:56:08 INFO - 2015-12-05 10:56:08,637 DEBUG : BROWSER_OUTPUT: Values: 324.9 328.2 329.8 332.2 333.7 12538.3 13045.0 15228.8 15531.8 15716.2 15226.9 15232.5 15609.5 15615.5 15632.3 4927.0 4936.7 5060.5 5071.4 5072.4 3544.7 3622.7 3625.1 4954.1 5530.2 5609.7 5628.8 5653.5 5660.2 5661.2 4927.3 5078.5 5079.3 5090.5 5611.7 4776.8 4883.7 4890.5 4896.6 5117.7 11263.7 11463.2 11468.7 11480.7 11505.1 1789.8 1790.3 1823.4 1830.1 1837.6 8492.7 8842.5 10009.9 12071.9 12139.6 1560.6 1607.3 1626.2 1671.7 1738.5 56575.7 58412.0 59779.0 59789.7 59855.0 9841.3 9933.0 9985.6 10010.1 10034.9 12601.2 12609.7 12665.4 12678.9 12703.8 6895.0 6924.5 6930.4 6931.3 6938.0 6440.4 6451.0 6494.0 6495.4 6505.0 4126.7 4197.3 4205.2 4228.7 4247.5 1635.9 1659.0 1678.2 1680.3 1725.1 842.2 893.5 964.2 976.6 988.4 15890.7 16101.5 16131.8 16247.5 16533.0 812.3 829.4 848.2 861.2 867.0 8774.3 8845.0 9074.7 9106.0 9400.7 514679.0 518886.0 520975.0 521266.0 530312.0 72074.3 73886.3 73925.0 74013.0 77279.0 1068.5 1085.8 1085.8 1090.6 1108.0 14676.3 14792.6 14943.5 15080.8 15344.5 32875.8 34099.8 34174.8 34613.7 34661.8 43737.8 43889.3 43974.0 44414.6 48444.3 8318.6 8719.5 8775.7 8793.9 8827.9 8905.8 9539.0 9811.7 10258.3 10334.6 8213.9 8711.6 9463.6 9585.4 9692.0 9130.7 9332.1 9420.2 9446.2 9475.2 8545.4 8936.4 8951.7 9204.2 9698.8 13121.4 13527.3 13746.9 14212.4 14636.0 14605.6 14627.4 15063.6 15233.8 15247.6 10:56:08 INFO - 2015-12-05 10:56:08,637 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,637 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5103.11 Median:6007.74 stddev:2646.90 (44.1%) stddev-sans-first:2638.21 10:56:08 INFO - 2015-12-05 10:56:08,637 DEBUG : BROWSER_OUTPUT: Values: 1218.4 1412.3 1424.4 1638.6 1712.6 6061.6 7246.1 7407.3 7429.0 7449.1 7296.2 7449.7 7455.4 7459.8 7470.6 2113.8 2151.1 2152.7 2153.3 2154.9 2133.0 2168.3 2168.9 2170.2 2171.8 2079.3 2094.1 2100.3 2131.7 2132.9 2094.5 2117.4 2119.3 2119.5 2120.6 2071.3 2130.3 2130.9 2131.6 2131.8 7354.8 7361.2 7422.2 7441.0 7455.2 4238.7 4294.4 4303.1 4308.2 4309.5 2620.1 2655.0 2664.3 2669.7 2674.4 833.7 1618.5 1628.3 1634.7 1684.1 9622.0 9818.8 9823.1 9845.6 9850.6 3902.3 3909.4 3972.2 3974.3 3996.9 8723.9 8730.9 8741.8 8745.4 8755.6 4325.4 4368.0 4388.8 4390.1 4395.1 3299.0 3301.3 3848.9 3970.6 3977.4 3552.9 3565.6 3583.2 3588.2 3600.2 1106.9 1118.7 1120.1 1122.9 1125.2 903.3 918.2 919.1 946.0 1231.3 6919.0 6928.1 6930.1 6943.7 6946.2 417.1 418.6 1037.0 1121.9 1123.8 5479.3 5479.6 5508.9 5523.0 5540.4 8592.8 8659.2 8813.0 8866.2 8983.2 8686.1 8754.4 8874.1 8887.7 8899.2 6881.5 6898.1 6974.9 7008.3 7036.3 6641.7 6696.7 6698.4 6702.4 6703.2 7701.0 7873.3 7906.3 8005.2 8027.3 7753.4 8032.3 8060.7 8067.5 8104.9 5446.3 5546.6 6052.6 6456.6 6545.9 7004.9 7024.5 7091.6 7093.7 7105.7 6472.3 6655.3 6676.6 6689.7 6752.7 6336.2 6595.6 6616.6 6625.7 6650.4 6421.0 6442.1 6447.4 6454.9 6462.4 5747.2 5771.9 5877.2 5888.5 5889.2 5975.2 5994.5 6001.5 6002.8 6012.7 10:56:08 INFO - 2015-12-05 10:56:08,637 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,638 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4647.80 Median:5344.34 stddev:1383.48 (25.9%) stddev-sans-first:1347.98 10:56:08 INFO - 2015-12-05 10:56:08,638 DEBUG : BROWSER_OUTPUT: Values: 281.5 284.5 289.6 291.7 294.7 5127.7 5299.5 5369.0 5429.9 5470.3 5198.2 5304.5 5329.8 5342.7 5346.0 4094.6 4107.2 4107.6 4114.6 4118.0 3877.3 3950.2 4003.7 4109.8 4112.9 4074.3 4077.9 4082.7 4084.6 4084.7 4072.8 4082.0 4083.9 4086.1 4094.3 3558.6 3563.6 3563.9 3566.2 3568.0 5025.5 5135.4 5139.2 5159.9 5161.6 4682.9 4698.5 4699.0 4700.2 4701.9 5589.7 5595.1 5601.5 5605.0 5606.5 3648.8 3723.8 3772.2 3879.7 3883.2 5910.4 5911.7 5938.9 5941.2 5941.3 3983.9 3984.0 3987.6 3994.4 3998.2 4047.0 4048.0 4051.1 4054.5 4054.9 4535.1 4579.7 4659.7 4662.9 4669.0 5613.9 5625.5 5630.3 5630.5 5639.9 1407.2 1440.7 1440.8 1441.4 1441.6 971.9 972.8 980.2 995.2 997.7 4939.3 4943.8 4945.7 4955.4 4961.8 5822.5 5824.0 5825.2 5831.7 5835.7 4936.0 4942.3 4949.5 4951.7 4954.1 3067.9 3113.8 3120.3 3151.1 3152.5 5536.0 5544.4 5547.7 5549.1 5551.0 5902.8 5971.9 5976.1 5978.2 5992.6 5510.0 5522.1 5523.0 5534.3 5538.3 5638.6 5813.2 5825.5 5830.4 5833.6 5491.2 5596.6 5715.3 5716.8 5725.4 5439.5 5589.1 5597.6 5611.5 5611.8 3885.9 3920.6 3924.6 3925.7 3927.6 5857.8 5859.3 5864.9 5867.7 5869.6 5481.3 5636.0 5661.9 5664.9 5668.7 5648.4 5656.4 5660.6 5662.8 5664.5 5531.4 5540.8 5542.7 5543.5 5549.3 5563.3 5707.0 5707.9 5710.8 5720.6 5498.8 5530.9 5534.1 5541.3 5542.8 10:56:08 INFO - 2015-12-05 10:56:08,638 DEBUG : BROWSER_OUTPUT: 10:56:08 INFO - 2015-12-05 10:56:08,638 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12492.66 Median:43529.28 stddev:14103.89 (32.4%) stddev-sans-first:14115.54 10:56:08 INFO - 2015-12-05 10:56:08,639 DEBUG : BROWSER_OUTPUT: Values: 676.2 706.9 706.9 746.8 752.3 11660.4 11861.9 11899.9 13766.3 14089.7 13797.7 13864.7 13904.2 13906.4 13922.8 635.2 638.2 798.2 802.4 812.7 806.5 807.8 810.9 810.9 811.5 837.8 843.0 843.0 843.1 844.4 659.2 661.3 800.8 808.9 809.4 598.4 602.7 603.3 605.3 607.7 12256.8 12339.9 12406.0 12457.6 12460.7 10960.6 11461.9 11506.3 11527.4 11659.9 9391.6 9464.1 9509.0 9661.6 9675.8 3302.2 3330.7 3332.0 3335.3 3364.6 42612.1 42873.0 43185.8 43190.0 43934.3 9180.6 9278.6 9312.1 9631.2 9729.9 16565.6 16846.5 16884.2 16884.7 16888.3 6200.3 6272.2 6327.1 6385.8 6635.1 3594.3 3602.9 3612.2 3698.6 3750.3 2732.8 2754.5 2755.3 2755.9 2764.4 459.8 465.1 468.5 475.6 477.3 458.1 465.9 470.3 490.9 498.3 7362.8 7726.5 7756.5 7837.1 7970.9 539.2 617.0 627.6 628.9 650.1 3662.3 3729.9 3730.6 3812.1 3880.1 53540.5 54020.2 54054.7 54079.2 54158.7 42702.6 42950.4 43490.6 43568.0 43590.6 36110.5 37411.0 37542.4 37635.4 38197.4 7548.9 7835.3 7926.6 8068.4 8208.3 29963.4 31210.1 32423.7 32427.2 33121.0 36299.0 39247.4 41225.0 41613.0 41939.8 9928.9 10051.1 10180.3 10434.6 10488.3 11200.0 11518.6 11541.8 11786.6 12096.9 10530.8 10714.5 10841.9 10878.2 10930.6 10690.3 11332.4 11373.8 11402.3 11413.7 10483.9 10563.9 10688.4 10867.7 11075.9 8798.7 9111.7 9178.5 9353.6 9659.7 8334.4 8449.7 8455.0 8739.7 9001.9 10:56:08 INFO - 2015-12-05 10:56:08,639 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:56:08 INFO - 2015-12-05 10:56:08,639 DEBUG : BROWSER_OUTPUT: 10:56:09 INFO - 2015-12-05 10:56:09,405 INFO : Browser exited with error code: 0 10:56:09 INFO - 2015-12-05 10:56:09,420 INFO : Completed test dromaeo_css (00:18:38) 10:56:09 INFO - 2015-12-05 10:56:09,420 INFO : Starting test kraken 10:56:09 INFO - 2015-12-05 10:56:09,420 DEBUG : operating with platform_type : linux_ 10:56:09 INFO - 2015-12-05 10:56:09,421 INFO : Initialising browser for kraken test... 10:56:09 INFO - 2015-12-05 10:56:09,427 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kSyb0/profile http://localhost:53249/getInfo.html 10:56:13 INFO - 2015-12-05 10:56:13,909 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:56:13 INFO - 2015-12-05 10:56:13,909 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:56:13 INFO - 2015-12-05 10:56:13,909 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:56:13 INFO - 2015-12-05 10:56:13,909 DEBUG : BROWSER_OUTPUT: __metrics 10:56:13 INFO - 2015-12-05 10:56:13,985 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] 10:56:14 INFO - 2015-12-05 10:56:14,041 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:15 INFO - 2015-12-05 10:56:15,298 INFO : Browser initialized. 10:56:15 INFO - 2015-12-05 10:56:15,298 INFO : Running cycle 1/1 for kraken test... 10:56:15 INFO - 2015-12-05 10:56:15,298 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kSyb0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:56:27 INFO - 2015-12-05 10:56:27,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 143089664 10:56:27 INFO - 2015-12-05 10:56:27,276 DEBUG : BROWSER_OUTPUT: 10:56:29 INFO - 2015-12-05 10:56:29,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-beat-detection) 10:56:30 INFO - 2015-12-05 10:56:30,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 179597312 10:56:30 INFO - 2015-12-05 10:56:30,445 DEBUG : BROWSER_OUTPUT: 10:56:33 INFO - 2015-12-05 10:56:33,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-dft) 10:56:33 INFO - 2015-12-05 10:56:33,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 168013824 10:56:33 INFO - 2015-12-05 10:56:33,789 DEBUG : BROWSER_OUTPUT: 10:56:36 INFO - 2015-12-05 10:56:36,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-fft) 10:56:37 INFO - 2015-12-05 10:56:37,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 153808896 10:56:37 INFO - 2015-12-05 10:56:37,342 DEBUG : BROWSER_OUTPUT: 10:56:39 INFO - 2015-12-05 10:56:39,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53249/tests/kraken/driver.html?testName=audio-oscillator) 10:56:39 INFO - 2015-12-05 10:56:39,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 155590656 10:56:39 INFO - 2015-12-05 10:56:39,949 DEBUG : BROWSER_OUTPUT: 10:56:42 INFO - 2015-12-05 10:56:42,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:42 INFO - 2015-12-05 10:56:42,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 158056448 10:56:42 INFO - 2015-12-05 10:56:42,788 DEBUG : BROWSER_OUTPUT: 10:56:45 INFO - 2015-12-05 10:56:45,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53249/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:46 INFO - 2015-12-05 10:56:46,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 158576640 10:56:46 INFO - 2015-12-05 10:56:46,336 DEBUG : BROWSER_OUTPUT: 10:56:49 INFO - 2015-12-05 10:56:49,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53249/tests/kraken/driver.html?testName=imaging-desaturate) 10:56:50 INFO - 2015-12-05 10:56:50,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 159567872 10:56:50 INFO - 2015-12-05 10:56:50,326 DEBUG : BROWSER_OUTPUT: 10:56:53 INFO - 2015-12-05 10:56:53,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53249/tests/kraken/driver.html?testName=json-parse-financial) 10:56:53 INFO - 2015-12-05 10:56:53,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 157913088 10:56:53 INFO - 2015-12-05 10:56:53,737 DEBUG : BROWSER_OUTPUT: 10:56:55 INFO - 2015-12-05 10:56:55,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:56:56 INFO - 2015-12-05 10:56:56,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 167133184 10:56:56 INFO - 2015-12-05 10:56:56,080 DEBUG : BROWSER_OUTPUT: 10:56:57 INFO - 2015-12-05 10:56:57,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:56:58 INFO - 2015-12-05 10:56:58,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 165609472 10:56:58 INFO - 2015-12-05 10:56:58,573 DEBUG : BROWSER_OUTPUT: 10:57:00 INFO - 2015-12-05 10:57:00,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:57:01 INFO - 2015-12-05 10:57:01,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 177119232 10:57:01 INFO - 2015-12-05 10:57:01,287 DEBUG : BROWSER_OUTPUT: 10:57:03 INFO - 2015-12-05 10:57:03,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:57:04 INFO - 2015-12-05 10:57:04,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 182226944 10:57:04 INFO - 2015-12-05 10:57:04,436 DEBUG : BROWSER_OUTPUT: 10:57:07 INFO - 2015-12-05 10:57:07,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:57:07 INFO - 2015-12-05 10:57:07,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 180400128 10:57:07 INFO - 2015-12-05 10:57:07,633 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53249/tests/kraken/driver.html?testName=ai-astar) 10:57:09 INFO - 2015-12-05 10:57:09,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 238354432 10:57:09 INFO - 2015-12-05 10:57:09,637 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,637 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:57:09 INFO - 2015-12-05 10:57:09,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:57:09 INFO - 2015-12-05 10:57:09,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:57:09 INFO - 2015-12-05 10:57:09,639 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:57:09 INFO - 2015-12-05 10:57:09,639 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;104;111;110;111;99;110;111;114 10:57:09 INFO - 2015-12-05 10:57:09,639 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;136;151;170;136;158;156;147;169;134 10:57:09 INFO - 2015-12-05 10:57:09,639 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;159;161;163;159;161;160;162;161 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;81;88;73;78;72;104;91;71 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;94;95;95;137;94;94;132 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;109;110;111;111;110 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;147;148;148;146;146;146;147 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;96;96;95;95 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;71;72;72;71;80;69;68 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;70;68;69;69;69 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;92;84;83;84;86;83;84;86;84 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;120;131;126;125;124;119;141;129;123 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;149;148;148;137;136;137;148;147;134 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;69;67;68;69;70;68;68;68 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 10:57:09 INFO - 2015-12-05 10:57:09,640 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:57:09 INFO - 2015-12-05 10:57:09,641 DEBUG : BROWSER_OUTPUT: __startTimestamp1449341829637__endTimestamp 10:57:09 INFO - 2015-12-05 10:57:09,641 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,648 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:57:09 INFO - 2015-12-05 10:57:09,648 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:57:09 INFO - 2015-12-05 10:57:09,648 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.33 (3.9%) stddev-sans-first:4.58 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 104.0 111.0 110.0 111.0 99.0 110.0 111.0 114.0 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.10 Median:157.00 stddev:13.63 (8.7%) stddev-sans-first:13.75 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: Values: 164.0 136.0 151.0 170.0 136.0 158.0 156.0 147.0 169.0 134.0 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 159.0 161.0 163.0 159.0 161.0 160.0 162.0 161.0 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,649 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:75.50 stddev:10.83 (14.3%) stddev-sans-first:11.16 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 81.0 88.0 73.0 78.0 72.0 104.0 91.0 71.0 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:94.50 stddev:18.79 (19.9%) stddev-sans-first:19.49 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 94.0 95.0 95.0 137.0 94.0 94.0 132.0 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 109.0 110.0 111.0 111.0 110.0 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 147.0 148.0 148.0 146.0 146.0 146.0 147.0 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.50 stddev:3.20 (4.5%) stddev-sans-first:3.39 10:57:09 INFO - 2015-12-05 10:57:09,650 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 71.0 72.0 72.0 71.0 80.0 69.0 68.0 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 70.0 68.0 69.0 69.0 69.0 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:2.73 (3.2%) stddev-sans-first:2.80 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: Values: 83.0 92.0 84.0 83.0 84.0 86.0 83.0 84.0 86.0 84.0 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:127.00 stddev:6.31 (5.0%) stddev-sans-first:6.67 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: Values: 128.0 120.0 131.0 126.0 125.0 124.0 119.0 141.0 129.0 123.0 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:147.50 stddev:6.21 (4.2%) stddev-sans-first:6.40 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: Values: 138.0 149.0 148.0 148.0 137.0 136.0 137.0 148.0 147.0 134.0 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 67.0 68.0 69.0 70.0 68.0 68.0 68.0 10:57:09 INFO - 2015-12-05 10:57:09,651 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:57:09 INFO - 2015-12-05 10:57:09,652 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2015-12-05 10:57:10,568 INFO : Browser exited with error code: 0 10:57:10 INFO - 2015-12-05 10:57:10,616 INFO : Completed test kraken (00:01:01) 10:57:10 INFO - 2015-12-05 10:57:10,616 INFO : Starting test v8_7 10:57:10 INFO - 2015-12-05 10:57:10,616 DEBUG : operating with platform_type : linux_ 10:57:10 INFO - 2015-12-05 10:57:10,616 INFO : Initialising browser for v8_7 test... 10:57:10 INFO - 2015-12-05 10:57:10,622 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbwvVR/profile http://localhost:53249/getInfo.html 10:57:15 INFO - 2015-12-05 10:57:15,307 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:57:15 INFO - 2015-12-05 10:57:15,308 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:57:15 INFO - 2015-12-05 10:57:15,308 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:57:15 INFO - 2015-12-05 10:57:15,308 DEBUG : BROWSER_OUTPUT: __metrics 10:57:15 INFO - 2015-12-05 10:57:15,436 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] 10:57:15 INFO - 2015-12-05 10:57:15,513 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:16 INFO - 2015-12-05 10:57:16,393 INFO : Browser initialized. 10:57:16 INFO - 2015-12-05 10:57:16,393 INFO : Running cycle 1/1 for v8_7 test... 10:57:16 INFO - 2015-12-05 10:57:16,394 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbwvVR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:57:28 INFO - 2015-12-05 10:57:28,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 142815232 10:57:28 INFO - 2015-12-05 10:57:28,351 DEBUG : BROWSER_OUTPUT: 10:57:49 INFO - 2015-12-05 10:57:49,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53249/tests/v8_7/run.html (next: http://localhost:53249/tests/v8_7/run.html) 10:57:50 INFO - 2015-12-05 10:57:50,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 447188992 10:57:50 INFO - 2015-12-05 10:57:50,055 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,055 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:57:50 INFO - 2015-12-05 10:57:50,055 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:57:50 INFO - 2015-12-05 10:57:50,055 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:57:50 INFO - 2015-12-05 10:57:50,055 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:57:50 INFO - 2015-12-05 10:57:50,055 DEBUG : BROWSER_OUTPUT: |0;Richards;165.72754391779912 10:57:50 INFO - 2015-12-05 10:57:50,055 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.80872297172428 10:57:50 INFO - 2015-12-05 10:57:50,056 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 10:57:50 INFO - 2015-12-05 10:57:50,056 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 10:57:50 INFO - 2015-12-05 10:57:50,056 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 10:57:50 INFO - 2015-12-05 10:57:50,056 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 10:57:50 INFO - 2015-12-05 10:57:50,056 DEBUG : BROWSER_OUTPUT: |6;Boyer;11755.813953488372 10:57:50 INFO - 2015-12-05 10:57:50,056 DEBUG : BROWSER_OUTPUT: |7;RegExp;26631.57894736842 10:57:50 INFO - 2015-12-05 10:57:50,056 DEBUG : BROWSER_OUTPUT: |8;Splay;612.7450980392157 10:57:50 INFO - 2015-12-05 10:57:50,057 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:57:50 INFO - 2015-12-05 10:57:50,057 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:57:50 INFO - 2015-12-05 10:57:50,057 DEBUG : BROWSER_OUTPUT: __startTimestamp1449341870047__endTimestamp 10:57:50 INFO - 2015-12-05 10:57:50,057 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,057 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:57:50 INFO - 2015-12-05 10:57:50,057 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: Values: 165.7 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.81 Median:184.81 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: Values: 184.8 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: Values: 278.4 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: Values: 5112.2 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,058 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: Values: 1988.1 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: Values: 784.3 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11755.81 Median:11755.81 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: Values: 11755.8 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26631.58 Median:26631.58 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: Values: 26631.6 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:612.75 Median:612.75 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: Values: 612.7 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:57:50 INFO - 2015-12-05 10:57:50,059 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:57:50 INFO - 2015-12-05 10:57:50,060 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:57:50 INFO - 2015-12-05 10:57:50,060 DEBUG : BROWSER_OUTPUT: 10:57:50 INFO - 2015-12-05 10:57:50,976 INFO : Browser exited with error code: 0 10:57:50 INFO - 2015-12-05 10:57:50,994 INFO : Completed test v8_7 (00:00:40) 10:57:51 INFO - 2015-12-05 10:57:51,044 INFO : Completed test suite (00:20:20) 10:57:51 INFO - 2015-12-05 10:57:51,044 DEBUG : Working with test: dromaeo_css 10:57:51 INFO - 2015-12-05 10:57:51,044 DEBUG : Generating results file: dromaeo_css 10:57:51 INFO - 2015-12-05 10:57:51,046 DEBUG : Working with test: kraken 10:57:51 INFO - 2015-12-05 10:57:51,046 DEBUG : Generating results file: kraken 10:57:51 INFO - 2015-12-05 10:57:51,046 INFO : javascript benchmark 10:57:51 INFO - 2015-12-05 10:57:51,046 DEBUG : Working with test: v8_7 10:57:51 INFO - 2015-12-05 10:57:51,046 DEBUG : Generating results file: v8_7 10:57:51 INFO - 2015-12-05 10:57:51,047 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:51 INFO - 2015-12-05 10:57:51,101 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:57:51 INFO - 2015-12-05 10:57:51,101 DEBUG : process_Request line: dromaeo_css 6305.51 graph.html#tests=[[72,132,35]] 10:57:51 INFO - 2015-12-05 10:57:51,101 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:51 INFO - 2015-12-05 10:57:51,131 DEBUG : process_Request line: kraken 1523.00 graph.html#tests=[[232,132,35]] 10:57:51 INFO - 2015-12-05 10:57:51,131 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:51 INFO - 2015-12-05 10:57:51,164 DEBUG : process_Request line: v8_7 19931.95 graph.html#tests=[[230,132,35]] 10:57:51 INFO - 2015-12-05 10:57:51,166 INFO : javascript benchmark 10:57:51 INFO - 2015-12-05 10:57:51,169 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2654.920352389428, 2697.5279326117925, 2703.837769733815, 2713.742194491524, 2740.4930087933726, 4627.583517483426, 4697.177993851075, 4701.412323459567, 4732.432108147019, 4732.881677958048, 4706.294055891618, 4758.310045043467, 4798.160321943664, 4804.5916097131785, 4814.759262036893, 4330.675199360045, 4377.1683380157665, 4401.383806267133, 4463.68754187207, 4500.5499450054895, 4203.201391735561, 4407.360932664762, 4443.044745379742, 4491.214037543433, 4539.500654927955, 4273.722208056497, 4346.56534346566, 4353.84761533348, 4364.934525982113, 4389.122175564868, 4301.978490107561, 4400.355463250515, 4406.317020861771, 4406.383106365111, 4437.2013037653205, 4213.662906967435, 4372.5627437256335, 4391.297392417198, 4393.209222339978, 4419.64642828573, 4565.863024109282, 4566.13243483737, 4594.862154135381, 4655.25515917455, 4756.881077973044, 5138.460461651547, 5140.563052140573, 5147.459516750725, 5159.638825282232, 5183.326167598226, 5139.691618502902, 5144.794208231666, 5152.124138896396, 5156.690598564098, 5211.661242019294, 4590.104929538775, 4694.319323698045, 4698.718076915396, 4759.286107083931, 4773.331733557305, 5176.275321454999, 5240.292560504359, 5249.632525723239, 5300.734963251822, 5302.734863256822, 5014.6991180529285, 5077.0, 5079.6952182869145, 5080.13637681595, 5129.9743501282255, 4870.269459581091, 4928.48250933654, 4981.078500477423, 5163.896722065538, 5174.508421699932, 4980.975095124501, 5064.7214403207445, 5065.493450654905, 5065.822696205615, 5105.438401775802, 5037.848864534069, 5047.318611987408, 5068.695878247317, 5072.416672082684, 5110.872228194325, 4007.318755811519, 4123.175364926967, 4123.340265557496, 4247.086876321606, 4285.807138678767, 3630.7821530708243, 3692.2061756722433, 3714.888553343404, 3715.1640880802142, 3719.5350581177354, 4426.535213802505, 4450.821967121344, 4451.043025749479, 4452.243118669834, 4496.460424749051, 4894.706317620883, 5185.792568297301, 5191.039657663345, 5204.271402003723, 5235.450277720861, 4297.09760950204, 4343.978280108579, 4353.455818022747, 4384.298512238027, 4386.868393948187, 4519.7740112994215, 4534.433195850519, 4534.909301813946, 4537.568930951555, 4582.427196600425, 4879.585235255043, 4881.999190166079, 4883.560479556857, 4887.486813884633, 4927.1131196384995, 4866.6350023747655, 4981.42713587942, 4993.201087825931, 5035.84892453227, 5123.513266239701, 4890.80436782539, 4908.607311415007, 4909.779059942382, 4912.189488734319, 4915.95084049155, 5075.086484432837, 5079.161938280143, 5083.957788653391, 5087.058894104603, 5124.9743751281, 4862.440819305683, 4971.975140124277, 4978.502149784992, 5059.3169922061525, 5147.756913144695, 4949.1586430306215, 4992.700437973734, 5009.849704508871, 5011.774470148779, 5014.924776128434, 5010.49895010496, 5012.77442515095, 5015.573676237561, 5017.64876458659, 5042.243663450512, 4625.375574297562, 4718.882027949191, 4740.69185502955, 4784.95215047859, 4931.753412329441, 5022.573081288131, 5038.193888977892, 5041.445441001413, 5049.57078648319, 5061.670991385548, 4892.951070489392, 4903.828366007173, 4913.287573301923, 4915.410150781786, 4960.77676504551], "unit": "ms", "name": "dojo.html", "value": 4670.851365026447}, {"lowerIsBetter": false, "replicates": [559.2813234993033, 566.7789562070791, 569.1604882797874, 574.8332983434805, 595.1132812109955, 28424.85787571062, 28911.710882891166, 28998.855005724967, 29008.70991290089, 29022.274443138933, 29722.85138574304, 37367.0, 38221.0, 38479.23041539168, 38491.61508384915, 7855.960720196405, 7992.720254791084, 7997.40019498537, 8005.199480051977, 8006.799830004267, 6955.200151982536, 7159.105111861018, 7913.604319784016, 8044.115147333789, 8045.0, 6934.895976560356, 7011.298870112999, 7013.0, 7016.929830701704, 9800.656977005807, 9741.659041933533, 9852.458114803683, 9867.210623150168, 9871.457069861155, 9872.950635246849, 9602.423854568679, 9725.173360264385, 9740.123388895034, 9760.707178784647, 9761.902380976242, 34048.48927266093, 34443.13892152691, 34477.48283775745, 34505.13737156566, 34537.30925381478, 2563.371973866396, 2609.4650596627644, 2636.657234559514, 2760.903368382117, 2946.1161651504462, 27153.728462715517, 27398.0, 27654.308642283904, 27687.446251075067, 27745.0, 3252.7560432967384, 3277.4428347180797, 3301.4222511060707, 3307.68576985186, 3404.8638054478038, 218364.0, 219150.0, 219414.0, 221332.0, 221748.0, 49721.502784972414, 51017.48982510201, 53073.2039019415, 53182.20226696603, 53694.19458708123, 49960.75019624879, 50359.49640503548, 50615.493845061814, 50630.49369506331, 50655.0, 14216.64458388528, 14494.85505144935, 14500.347484363228, 14513.201773902325, 14513.709725805425, 10800.0, 10825.0, 10858.565657373616, 10858.945705271422, 10866.076383507332, 17533.21100550478, 17886.373976910745, 17988.0, 18006.189721462564, 18113.54716132081, 7207.495475316782, 7379.963100184465, 7493.66278517468, 7497.1753107158165, 7501.612201742695, 812.8861959325699, 842.7556008757514, 909.2453263791037, 912.115248209236, 941.6751220828803, 26756.732432675424, 26806.463870722866, 26910.0, 27149.728502715116, 27283.0, 938.7934654376163, 942.6135284533308, 1015.7003683913264, 1032.4734385463319, 1094.1520321750706, 13691.246981415918, 13699.520516781864, 13853.792193117111, 14056.367463464168, 14118.435262589586, 261357.0, 264151.0, 265078.0, 265954.0, 266170.0, 46418.303725444144, 46803.5319646806, 46836.765816171384, 46850.76574617105, 46908.5309146911, 1193.6061099837034, 1196.9940150299192, 1197.9814013387645, 1207.3782002268838, 1220.170284206748, 21905.0, 25046.62430063587, 25402.87298563569, 26720.0, 29652.110436686933, 41088.58911410967, 41235.587644123174, 41578.168436631706, 41625.37561936634, 41634.1673166541, 221941.0, 223679.0, 223931.0, 224344.0, 315115.0, 24598.877005614857, 28739.856300718362, 29040.7095929038, 29239.41521169522, 29411.264718382212, 34166.316673666886, 35260.0, 35262.29475410426, 35674.8216258917, 39563.80218099006, 32166.83916580402, 32538.51192232071, 32891.0, 33423.1644208887, 33574.0, 32020.35959280755, 32344.838275809412, 32804.0, 32846.835765821015, 33048.17379565434, 33196.50205246972, 33239.83380083084, 33427.0, 33486.497702534, 34098.07872094642, 26140.8692956534, 27750.0, 29414.55878161872, 30264.17004550905, 30705.846470767505, 22407.327780166623, 23302.65046024277, 23420.64869027, 23517.529649406573, 23576.528469430174], "unit": "ms", "name": "ext.html", "value": 16604.80675209114}, {"lowerIsBetter": false, "replicates": [324.86869890086103, 328.24503641624267, 329.7856393344327, 332.1878008269778, 333.7163411100565, 12538.310392928386, 13045.0, 15228.847711522896, 15531.84468155318, 15716.214189290547, 15226.923865380686, 15232.466863659774, 15609.453669121584, 15615.531534053967, 15632.2965466554, 4926.975365123179, 4936.7037977721275, 5060.54455099041, 5071.391433028023, 5072.39131304244, 3544.6809787119155, 3622.6739593436587, 3625.0756057205376, 4954.083494553519, 5530.225768392428, 5609.691466969315, 5628.831135065934, 5653.462921022517, 5660.2075709400715, 5661.179129026289, 4927.334809800667, 5078.542931136179, 5079.339685840817, 5090.490950904917, 5611.691356975365, 4776.80892764289, 4883.658143929926, 4890.5109489051165, 4896.608271338285, 5117.66735162217, 11263.718407039807, 11463.197576169672, 11468.71328216793, 11480.655580332603, 11505.079593632488, 1789.7673302470726, 1790.3375750972223, 1823.3982785680826, 1830.0941034188163, 1837.6141010387835, 8492.66029358825, 8842.469451832847, 10009.949950250275, 12071.93964030183, 12139.635810925687, 1560.6332511859705, 1607.340990194015, 1626.1869065467267, 1671.707451196036, 1738.4958362074983, 56575.71712141454, 58412.0, 59779.0, 59789.70105149446, 59855.0, 9841.311108222355, 9933.0, 9985.550650220757, 10010.149137323264, 10034.899651003543, 12601.243925364508, 12609.684757881127, 12665.430055647517, 12678.873211267954, 12703.809442858364, 6895.034695142684, 6924.480663950224, 6930.44556435494, 6931.341522555349, 6937.959306104024, 6440.420362167428, 6451.0, 6494.0, 6495.447886929664, 6505.024246362988, 4126.731762435492, 4197.3074442717225, 4205.17998990194, 4228.682848786353, 4247.490301163818, 1635.8854880158274, 1658.9834101658828, 1678.2280151130617, 1680.3110724603098, 1725.12018870377, 842.203418413398, 893.5353616119581, 964.1756298364937, 976.6093562575027, 988.362506183522, 15890.682186356207, 16101.516954491384, 16131.758023629654, 16247.51257462278, 16533.0, 812.3014207781304, 829.4069740135832, 848.1772680499905, 861.2335021830576, 866.9956650216835, 8774.341924355698, 8845.0, 9074.682386116454, 9106.0, 9400.670976515788, 514679.0, 518886.0, 520975.0, 521266.0, 530312.0, 72074.27925720676, 73886.26113738901, 73925.0, 74013.0, 77279.0, 1068.4604274841156, 1085.766560189563, 1085.7719878825378, 1090.6128324444867, 1107.9999999999839, 14676.3395647194, 14792.63018424548, 14943.476978305707, 15080.849191508383, 15344.462943796914, 32875.835620821745, 34099.829500852335, 34174.82912585421, 34613.65386346104, 34661.82669086739, 43737.78131109324, 43889.34165987577, 43974.0, 44414.55585444233, 48444.273335899285, 8318.584070796556, 8719.476831390137, 8775.736727898173, 8793.912060879566, 8827.940647122387, 8905.777355566162, 9538.95230523843, 9811.705648830546, 10258.28192026551, 10334.586616535555, 8213.917860821555, 8711.607977640895, 9463.574139163891, 9585.376950498196, 9692.0, 9130.680426185052, 9332.113449222314, 9420.199283061016, 9446.244300456085, 9475.194608458083, 8545.359098067545, 8936.41913275635, 8951.73144805657, 9204.171624553823, 9698.806023879624, 13121.359830021247, 13527.323633818467, 13746.862531374558, 14212.360443779848, 14636.04865683727, 14605.561833145022, 14627.414903404171, 15063.623409414853, 15233.847661523243, 15247.618809529851], "unit": "ms", "name": "jquery.html", "value": 7967.781048258627}, {"lowerIsBetter": false, "replicates": [1218.421249906295, 1412.2867951684398, 1424.4159894443274, 1638.6067343837478, 1712.5975395781988, 6061.605995610288, 7246.094238220223, 7407.333339999399, 7429.034225550678, 7449.068866391701, 7296.197418283985, 7449.739259125931, 7455.366293865028, 7459.776206713807, 7470.55176689399, 2113.8308935285218, 2151.085788539864, 2152.6770984352393, 2153.3217036633487, 2154.870707757532, 2132.968005479919, 2168.2627906511784, 2168.945776355588, 2170.1644866726265, 2171.837112216582, 2079.345006323011, 2094.14140202517, 2100.348891843526, 2131.690904818808, 2132.893355332235, 2094.486850721575, 2117.4071260047212, 2119.2688522459725, 2119.5337025854287, 2120.6076875777953, 2071.326818783886, 2130.3182981445943, 2130.8721476711294, 2131.637621604331, 2131.840111991591, 7354.77935661931, 7361.227071157505, 7422.220666829959, 7441.0326657534715, 7455.179930207672, 4238.660907127453, 4294.4202532658, 4303.07483890965, 4308.18144552534, 4309.547497512747, 2620.1222590432226, 2654.973450265492, 2664.3472349274552, 2669.6929853066954, 2674.3581540430155, 833.7082021292499, 1618.482085732566, 1628.267279724129, 1634.7139250631092, 1684.132671674089, 9622.0, 9818.803623927553, 9823.115919567203, 9845.556949937198, 9850.60597576089, 3902.297586434412, 3909.354956432214, 3972.205558888234, 3974.3044967131214, 3996.9400458993136, 8723.869141962876, 8730.864987551704, 8741.825163496822, 8745.431546949429, 8755.562221889008, 4325.351197320364, 4368.0, 4388.824447022147, 4390.078083602415, 4395.055063161436, 3299.043277449513, 3301.257217126127, 3848.9037774055873, 3970.622790834866, 3977.3636218204947, 3552.8808425345933, 3565.554305711786, 3583.2475180212446, 3588.2105936694406, 3600.243948770735, 1106.8671759388765, 1118.6923596011, 1120.1151090638305, 1122.8764835868049, 1125.150511363915, 903.3225081189108, 918.2149262380568, 919.1130559010587, 945.952702364879, 1231.3166192762924, 6919.0, 6928.099347084847, 6930.099087118642, 6943.6875340609795, 6946.235914049451, 417.0886612751149, 418.6127831755614, 1036.9792604147874, 1121.9439028048564, 1123.8145705958425, 5479.342478902558, 5479.643823151482, 5508.944910550843, 5523.033469142964, 5540.445955404427, 8592.828143437222, 8659.220670139717, 8813.0, 8866.157715017192, 8983.191512763882, 8686.131386861389, 8754.387192896564, 8874.112588741204, 8887.688930887389, 8899.243564296978, 6881.518293719491, 6898.0687607173395, 6974.895376569356, 7008.26413226614, 7036.331548502884, 6641.734330626721, 6696.732130714911, 6698.430633396216, 6702.430293424918, 6703.162104736908, 7700.961495192488, 7873.330766884879, 7906.327962123284, 8005.199480052182, 8027.317677997436, 7753.379729621504, 8032.317253033558, 8060.7178748745855, 8067.515949043076, 8104.918950810652, 5446.346438427414, 5546.55627549787, 6052.576319657758, 6456.580322279036, 6545.934540654723, 7004.859902801813, 7024.5082844200415, 7091.645417729196, 7093.680784364613, 7105.715771369088, 6472.265642557099, 6655.334466553306, 6676.566023208476, 6689.732410703517, 6752.729890804313, 6336.17629708135, 6595.571287866273, 6616.643588064339, 6625.734970601315, 6650.3682150195655, 6420.967895160495, 6442.065900444503, 6447.4197322241225, 6454.903176452263, 6462.386073323027, 5747.166660834072, 5771.884562308646, 5877.177195192762, 5888.528917686661, 5889.234399528034, 5975.193348898017, 5994.490468310068, 6001.489873360639, 6002.819915402545, 6012.669303188367], "unit": "ms", "name": "mootools.html", "value": 4201.068521390883}, {"lowerIsBetter": false, "replicates": [281.51860318854756, 284.5163222521712, 289.6379525593009, 291.71557731212073, 294.7185437906799, 5127.666701664399, 5299.470052994699, 5369.033573956686, 5429.891402171954, 5470.2615146955095, 5198.246254293125, 5304.49607287308, 5329.786808527664, 5342.679439233649, 5346.0, 4094.6314831665145, 4107.199096176247, 4107.609777071189, 4114.567970363106, 4118.0, 3877.263319969211, 3950.1902110067513, 4003.679705623543, 4109.815058322368, 4112.8971775705695, 4074.327735923584, 4077.9184416311655, 4082.734622249559, 4084.6323830855217, 4084.7344922579937, 4072.7759973201464, 4082.0203151243786, 4083.9387409188885, 4086.1010577672864, 4094.303968325392, 3558.5551806024246, 3563.625819288963, 3563.928721425557, 3566.233259849145, 3568.0366301098816, 5025.522575355335, 5135.435102138762, 5139.203423469368, 5159.896802063938, 5161.5870730341485, 4682.859514214579, 4698.506656801021, 4699.036697477009, 4700.177468942921, 4701.929471057937, 5589.692566908819, 5595.132754423071, 5601.467860553241, 5604.971975140139, 5606.467385598362, 3648.7628304160144, 3723.7765734056043, 3772.1512659651357, 3879.72841901067, 3883.2233553289457, 5910.438508341744, 5911.733971971272, 5938.851528711773, 5941.2276404067625, 5941.316748573883, 3983.9203215935518, 3983.9999999999422, 3987.5813039631003, 3994.420808982681, 3998.1803730235815, 4047.0489434982755, 4048.0487085534874, 4051.149258655715, 4054.5337286211875, 4054.8580799671868, 4535.070310586388, 4579.702319349231, 4659.743714095757, 4662.860114196579, 4669.0428462165855, 5613.933352662981, 5625.493705566437, 5630.296212973379, 5630.521405680481, 5639.859003524863, 1407.240090351199, 1440.7046555456106, 1440.7910852926268, 1441.3874103505968, 1441.6467965348556, 971.9028097190366, 972.781124247053, 980.1864452504404, 995.2286977592279, 997.6657819630506, 4939.333190019302, 4943.777530011158, 4945.703257804544, 4955.40535135786, 4961.751912404366, 5822.505087067562, 5824.0390335595, 5825.155352473952, 5831.650100993954, 5835.737391817378, 4935.950640493549, 4942.308076869242, 4949.455559888409, 4951.653384263067, 4954.1082605130705, 3067.92330191747, 3113.7508999280003, 3120.2823350629483, 3151.0861850063684, 3152.4640811062172, 5535.972320138373, 5544.362398324163, 5547.694876781735, 5549.084401073777, 5550.972245138749, 5902.822915312548, 5971.940280597139, 5976.103584462366, 5978.163057172, 5992.580519363602, 5510.035743744828, 5522.061249587579, 5522.972385138049, 5534.252875861707, 5538.335399752055, 5638.605297629127, 5813.215215945793, 5825.50483208915, 5830.4461076197695, 5833.591648584558, 5491.231227628055, 5596.552275818006, 5715.31416230055, 5716.771329146954, 5725.398833122629, 5439.456054394529, 5589.105743081088, 5597.608167428404, 5611.5230205433, 5611.775528978958, 3885.9417108743955, 3920.627540383659, 3924.568297487331, 3925.7055720821622, 3927.5876033017266, 5857.824265272048, 5859.267591551056, 5864.882702345843, 5867.706614669335, 5869.589128760946, 5481.260029895913, 5636.041872881702, 5661.915071273852, 5664.915026274527, 5668.688222147822, 5648.406917273627, 5656.406077361818, 5660.632058916157, 5662.8018019370775, 5664.518515926193, 5531.363893152339, 5540.806071787468, 5542.667439953616, 5543.501084902378, 5549.250851135206, 5563.304586926634, 5706.9714651426475, 5707.8858422832145, 5710.828675139753, 5720.570957178145, 5498.835034948958, 5530.944690553043, 5534.1145416733125, 5541.33503979525, 5542.8337149885565], "unit": "ms", "name": "prototype.html", "value": 4198.948810919572}, {"lowerIsBetter": false, "replicates": [676.1953275602036, 706.8692291925994, 706.9363757261846, 746.7647690977342, 752.270297811123, 11660.416979151041, 11861.881381186186, 11899.881001189997, 13766.311684415788, 14089.661482159205, 13797.724045519084, 13864.722705545882, 13904.235267060307, 13906.374213160407, 13922.791158132635, 635.1901325809583, 638.2436812377348, 798.2376830127215, 802.4182467710921, 812.7439856445201, 806.5443024691031, 807.7899746066006, 810.8662070758318, 810.9472884262534, 811.5009269299397, 837.8408102460544, 842.9789255268606, 843.0389356133982, 843.1063073142458, 844.3667249562828, 659.1859054068221, 661.2858113237692, 800.8398320335898, 808.9393295502861, 809.360605121953, 598.4045874355002, 602.6625089949598, 603.2941458493573, 605.340179204669, 607.717411403695, 12256.754864902741, 12339.938300308531, 12406.007519398427, 12457.626271211879, 12460.688482788002, 10960.56157753689, 11461.885381146249, 11506.30962142274, 11527.423628818526, 11659.941700291529, 9391.62433502659, 9464.053594640549, 9508.952455237679, 9661.565229564687, 9675.806483870354, 3302.240484688511, 3330.7168890644325, 3332.0, 3335.332933413327, 3364.5962484502015, 42612.14775704499, 42873.0, 43185.78407107976, 43190.0, 43934.34098488557, 9180.586873590704, 9278.62885484573, 9312.068793120634, 9631.181349585364, 9729.902700973042, 16565.58586035359, 16846.494605161864, 16884.155792210586, 16884.662306754042, 16888.324467021426, 6200.3179650239335, 6272.153259309935, 6327.070243575754, 6385.776497822554, 6635.104260924713, 3594.2991116731987, 3602.945955810665, 3612.205314830733, 3698.6486283802997, 3750.3436898542645, 2732.8496932668495, 2754.5454999925187, 2755.2698534888273, 2755.8897644094413, 2764.4471105778925, 459.7586267209742, 465.1116367737605, 468.5455108544706, 475.595743617922, 477.3460359307771, 458.07468912795963, 465.944086709597, 470.348567234376, 490.91654418748897, 498.2924247568462, 7362.815929601803, 7726.536407815549, 7756.534607923542, 7837.05955285358, 7970.880436793453, 539.1885212754779, 617.0497433951664, 627.6328347916428, 628.9465395441439, 650.1028580558799, 3662.304162209172, 3729.9440508392395, 3730.5896351401325, 3812.085099576137, 3880.1463677990796, 53540.46459535433, 54020.18969715457, 54054.72972635191, 54079.18881216785, 54158.72920635372, 42702.57297426986, 42950.35574466385, 43490.56509434929, 43568.0, 43590.56409435929, 36110.458343124876, 37411.0, 37542.43686344707, 37635.43546846799, 38197.42703859389, 7548.886766698394, 7835.294823465915, 7926.603669816602, 8068.435209535276, 8208.261256486945, 29963.400731985676, 31210.063698089092, 32423.675763242067, 32427.18932026718, 33121.0, 36299.0, 39247.41128883012, 41225.0, 41613.0, 41939.7903010483, 9928.851067233853, 10051.145652619609, 10180.287379883337, 10434.617460666386, 10488.26582139243, 11200.0, 11518.596849110241, 11541.82687259675, 11786.646400607995, 12096.939515302367, 10530.789384212427, 10714.517846697074, 10841.891581084088, 10878.23852330361, 10930.617428389969, 10690.305130166515, 11332.433378330885, 11373.772524549628, 11402.258853174517, 11413.657590272305, 10483.895161048596, 10563.894361056291, 10688.412137332522, 10867.673969780919, 11075.944620277169, 8798.692045778367, 9111.681091161778, 9178.541072946193, 9353.579088941151, 9659.71020869375, 8334.416590838584, 8449.746507604781, 8454.957725211334, 8739.737807865775, 9001.864972025294], "unit": "ms", "name": "yui.html", "value": 5765.158433846265}], "name": "dromaeo_css", "value": 6305.510138201721}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 111.0, 110.0, 111.0, 99.0, 110.0, 111.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [164.0, 136.0, 151.0, 170.0, 136.0, 158.0, 156.0, 147.0, 169.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 161.0, 163.0, 159.0, 161.0, 160.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 81.0, 88.0, 73.0, 78.0, 72.0, 104.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 94.0, 95.0, 95.0, 137.0, 94.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 71.0, 72.0, 72.0, 71.0, 80.0, 69.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 92.0, 84.0, 83.0, 84.0, 86.0, 83.0, 84.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 131.0, 126.0, 125.0, 124.0, 119.0, 141.0, 129.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 148.0, 148.0, 137.0, 136.0, 137.0, 148.0, 147.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 67.0, 68.0, 69.0, 70.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1523.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.72754391779912], "unit": "score", "name": "Richards", "value": 213.01226799999995}, {"lowerIsBetter": false, "replicates": [184.80872297172428], "unit": "score", "name": "DeltaBlue", "value": 357.76449799999983}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5112.244897959184], "unit": "score", "name": "Decrypt", "value": 52.067341317365305}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [11755.813953488372], "unit": "score", "name": "Boyer", "value": 56.69220375865485}, {"lowerIsBetter": false, "replicates": [26631.57894736842], "unit": "score", "name": "RegExp", "value": 34.20694664031621}, {"lowerIsBetter": false, "replicates": [612.7450980392157], "unit": "score", "name": "Splay", "value": 132.99331200000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19931.94938729233}]} 10:57:51 INFO - RETURN: dromaeo_css: 6305.51 10:57:51 INFO - RETURN: kraken: 1523.00 10:57:51 INFO - RETURN: v8_7: 19931.95 10:57:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19931.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6305.51"}}} 10:57:51 INFO - Return code: 0 10:57:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:57:51 ERROR - # TBPL SUCCESS # 10:57:51 INFO - Running post-action listener: _resource_record_post_action 10:57:51 INFO - Running post-run listener: _resource_record_post_run 10:57:52 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506269696; Read time: 16; Write time: 317892 10:57:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 230952960; Read time: 0; Write time: 189532 10:57:52 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275316736; Read time: 16; Write time: 128360 10:57:52 INFO - Running post-run listener: _upload_blobber_files 10:57:52 INFO - Blob upload gear active. 10:57:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:57:52 INFO - Copying logs to upload dir... 10:57:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.595780 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-05 10:57:51.544467) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 10:57:51.547951) ========= 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=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010013 build_url: 'https://queue.taskcluster.net/v1/task/vkgb0nV4TGmp1vBxutI4qA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 10:57:51.604681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:57:51.605493) ========= 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=20aa3857bbc5a756c598c738000001bb-1449332796.963869-486931606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 10:57:51.658774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 10:57:51.659095) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 10:57:51.659403) ========= ========= Total master_lag: 0.30 =========