builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1450207023.59 results: success (0) buildid: 20151215103151 builduid: 4278ecf146464238a03879b51284eee7 revision: 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.592964) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.593406) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.593690) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006203 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.615970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.616281) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.629483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.629805) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.679343) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.679642) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.680048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.680318) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 11:17:03-- 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% 43.4M=0s 2015-12-15 11:17:03 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.860975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.861296) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:03.911007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 11:17:03.911357) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 --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 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 --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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 11:17:04,001 truncating revision to first 12 chars 2015-12-15 11:17:04,001 Setting DEBUG logging. 2015-12-15 11:17:04,001 attempt 1/10 2015-12-15 11:17:04,001 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ac99e7e0440?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 11:17:05,470 unpacking tar archive at: fx-team-0ac99e7e0440/testing/mozharness/ program finished with exit code 0 elapsedTime=1.874381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 11:17:05.798798) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:05.799442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:05.808133) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:05.808560) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 11:17:05.809028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-15 11:17:05.809311) ========= /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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:05 INFO - MultiFileLogger online at 20151215 11:17:05 in /builds/slave/test 11:17:05 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 11:17:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:05 INFO - {'append_to_log': False, 11:17:05 INFO - 'base_work_dir': '/builds/slave/test', 11:17:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:17:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:05 INFO - 'branch': 'Fx-Team-Non-PGO', 11:17:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:05 INFO - 'config_files': ('talos/linux_config.py',), 11:17:05 INFO - 'default_actions': ('clobber', 11:17:05 INFO - 'read-buildbot-config', 11:17:05 INFO - 'download-and-extract', 11:17:05 INFO - 'populate-webroot', 11:17:05 INFO - 'create-virtualenv', 11:17:05 INFO - 'install', 11:17:05 INFO - 'run-tests'), 11:17:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:05 INFO - 'download_minidump_stackwalk': True, 11:17:05 INFO - 'download_symbols': 'ondemand', 11:17:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:05 INFO - 'installer_path': 'installer.exe', 11:17:05 INFO - 'log_level': 'info', 11:17:05 INFO - 'log_name': 'talos', 11:17:05 INFO - 'log_to_console': True, 11:17:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:05 INFO - 'opt_config_files': (), 11:17:05 INFO - 'pip_index': False, 11:17:05 INFO - 'sps_profile': False, 11:17:05 INFO - 'sps_profile_interval': 0, 11:17:05 INFO - 'suite': 'dromaeojs', 11:17:05 INFO - 'system_bits': '64', 11:17:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:05 INFO - 'title': 'talos-linux64-ix-001', 11:17:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:05 INFO - 'use_talos_json': True, 11:17:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:05 INFO - 'work_dir': 'build'} 11:17:05 INFO - ##### 11:17:05 INFO - ##### Running clobber step. 11:17:05 INFO - ##### 11:17:05 INFO - Running pre-action listener: _resource_record_pre_action 11:17:05 INFO - Running main action method: clobber 11:17:05 INFO - rmtree: /builds/slave/test/build 11:17:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:06 INFO - Running post-action listener: _resource_record_post_action 11:17:06 INFO - ##### 11:17:06 INFO - ##### Running read-buildbot-config step. 11:17:06 INFO - ##### 11:17:06 INFO - Running pre-action listener: _resource_record_pre_action 11:17:06 INFO - Running main action method: read_buildbot_config 11:17:06 INFO - Using buildbot properties: 11:17:06 INFO - { 11:17:06 INFO - "properties": { 11:17:06 INFO - "buildnumber": 2212, 11:17:06 INFO - "product": "firefox", 11:17:06 INFO - "script_repo_revision": "production", 11:17:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:17:06 INFO - "repository": "", 11:17:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:17:06 INFO - "buildid": "20151215103151", 11:17:06 INFO - "slavename": "talos-linux64-ix-001", 11:17:06 INFO - "pgo_build": "False", 11:17:06 INFO - "basedir": "/builds/slave/test", 11:17:06 INFO - "project": "", 11:17:06 INFO - "platform": "ubuntu64_hw", 11:17:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:17:06 INFO - "slavebuilddir": "test", 11:17:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:17:06 INFO - "branch": "fx-team", 11:17:06 INFO - "repo_path": "integration/fx-team", 11:17:06 INFO - "stage_platform": "linux64", 11:17:06 INFO - "builduid": "4278ecf146464238a03879b51284eee7", 11:17:06 INFO - "revision": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1" 11:17:06 INFO - }, 11:17:06 INFO - "sourcestamp": { 11:17:06 INFO - "repository": "", 11:17:06 INFO - "hasPatch": false, 11:17:06 INFO - "project": "", 11:17:06 INFO - "branch": "fx-team-linux64-talos", 11:17:06 INFO - "changes": [ 11:17:06 INFO - { 11:17:06 INFO - "category": null, 11:17:06 INFO - "files": [ 11:17:06 INFO - { 11:17:06 INFO - "url": null, 11:17:06 INFO - "name": "https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 11:17:06 INFO - } 11:17:06 INFO - ], 11:17:06 INFO - "repository": "", 11:17:06 INFO - "rev": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1", 11:17:06 INFO - "who": "s.kaspari@gmail.com", 11:17:06 INFO - "when": 1450206647, 11:17:06 INFO - "number": 7362908, 11:17:06 INFO - "comments": "Bug 1222377 - Add option to enable blocking content in restricted profiles. r=margaret\n\n(Feature only enabled in Nightly until we deployed an actual block list)", 11:17:06 INFO - "project": "", 11:17:06 INFO - "at": "Tue 15 Dec 2015 11:10:47", 11:17:06 INFO - "branch": "fx-team-linux64-talos", 11:17:06 INFO - "revlink": "", 11:17:06 INFO - "properties": [ 11:17:06 INFO - [ 11:17:06 INFO - "buildid", 11:17:06 INFO - "20151215103151", 11:17:06 INFO - "Change" 11:17:06 INFO - ], 11:17:06 INFO - [ 11:17:06 INFO - "builduid", 11:17:06 INFO - "4278ecf146464238a03879b51284eee7", 11:17:06 INFO - "Change" 11:17:06 INFO - ], 11:17:06 INFO - [ 11:17:06 INFO - "pgo_build", 11:17:06 INFO - "False", 11:17:06 INFO - "Change" 11:17:06 INFO - ] 11:17:06 INFO - ], 11:17:06 INFO - "revision": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1" 11:17:06 INFO - } 11:17:06 INFO - ], 11:17:06 INFO - "revision": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1" 11:17:06 INFO - } 11:17:06 INFO - } 11:17:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:17:06 INFO - Running post-action listener: _resource_record_post_action 11:17:06 INFO - ##### 11:17:06 INFO - ##### Running download-and-extract step. 11:17:06 INFO - ##### 11:17:06 INFO - Running pre-action listener: _resource_record_pre_action 11:17:06 INFO - Running main action method: download_and_extract 11:17:06 INFO - mkdir: /builds/slave/test/build/tests 11:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:06 INFO - https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json 11:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json 11:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:17:07 INFO - Downloaded 1302 bytes. 11:17:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:17:07 INFO - Using the following test package requirements: 11:17:07 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:07 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:07 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:07 INFO - u'jsshell-linux-x86_64.zip'], 11:17:07 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:07 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:07 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:17:07 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:17:07 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:07 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:17:07 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:17:07 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:07 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17:07 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')]} 11:17:07 INFO - https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:08 INFO - Downloaded 21863279 bytes. 11:17:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:17:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:17:09 INFO - Return code: 0 11:17:09 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:17: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')]} 11:17:09 INFO - https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:17:10 INFO - Downloaded 21863279 bytes. 11:17:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:17:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:17:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:17:11 INFO - Return code: 0 11:17: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')]} 11:17:11 INFO - https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:17:13 INFO - Downloaded 11132052 bytes. 11:17:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:17:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:17:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:17:13 INFO - Return code: 0 11:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:13 INFO - https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:17:14 INFO - Downloaded 57738640 bytes. 11:17:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:17:14 INFO - mkdir: /builds/slave/test/properties 11:17:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:14 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:14 INFO - Contents: 11:17:14 INFO - build_url:https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:17:14 INFO - Running post-action listener: _resource_record_post_action 11:17:14 INFO - Running post-action listener: set_extra_try_arguments 11:17:14 INFO - ##### 11:17:14 INFO - ##### Running populate-webroot step. 11:17:14 INFO - ##### 11:17:14 INFO - Running pre-action listener: _resource_record_pre_action 11:17:14 INFO - Running main action method: populate_webroot 11:17:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:14 INFO - '--tppagecycles', 11:17:14 INFO - '7'], 11:17:14 INFO - 'tests': ['tsvgm']}}, 11:17:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:17:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:17:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:17:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'tests': ['damp', 'tps']}, 11:17:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['damp', 'tps']}, 11:17:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:17:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:14 INFO - 'other': {'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other_l64': {'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other_nol64': {'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'svgr': {'tests': ['tsvgx', 11:17:14 INFO - 'tsvgr_opacity', 11:17:14 INFO - 'tart', 11:17:14 INFO - 'tscrollx', 11:17:14 INFO - 'cart']}, 11:17:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tsvgx', 11:17:14 INFO - 'tsvgr_opacity', 11:17:14 INFO - 'tart', 11:17:14 INFO - 'tscrollx', 11:17:14 INFO - 'cart']}, 11:17:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'tests': ['tp5o']}, 11:17:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tp5o']}, 11:17:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'talos_options': ['--xperf_path', 11:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:14 INFO - 'tests': ['tp5n']}, 11:17:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'talos_options': ['--e10s', 11:17:14 INFO - '--xperf_path', 11:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:14 INFO - 'tests': ['tp5n']}}, 11:17:14 INFO - 'talos.zip': {'path': '', 11:17:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:14 INFO - Running post-action listener: _resource_record_post_action 11:17:14 INFO - ##### 11:17:14 INFO - ##### Running create-virtualenv step. 11:17:14 INFO - ##### 11:17:14 INFO - Running pre-action listener: _resource_record_pre_action 11:17:14 INFO - Running main action method: create_virtualenv 11:17:14 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:14 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 11:17:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:14 INFO - Using real prefix '/usr' 11:17:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:15 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:17 INFO - Installing pip.................done. 11:17:17 INFO - Return code: 0 11:17:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:17 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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:17 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 11:17:17 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 11:17:17 INFO - Using env: {'DISPLAY': ':0', 11:17:17 INFO - 'HOME': '/home/cltbld', 11:17:17 INFO - 'LANG': 'en_US.UTF-8', 11:17:17 INFO - 'LANGUAGE': 'en_US:en', 11:17:17 INFO - 'LOGNAME': 'cltbld', 11:17:17 INFO - 'MAIL': '/var/mail/cltbld', 11:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:17 INFO - 'MOZ_NO_REMOTE': '1', 11:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:17 INFO - 'NO_EM_RESTART': '1', 11:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:17 INFO - 'PWD': '/builds/slave/test', 11:17:17 INFO - 'SHELL': '/bin/bash', 11:17:17 INFO - 'SHLVL': '1', 11:17:17 INFO - 'TERM': 'linux', 11:17:17 INFO - 'TMOUT': '86400', 11:17:17 INFO - 'USER': 'cltbld', 11:17:17 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:17 INFO - '_': '/tools/buildbot/bin/python'} 11:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:17 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 11:17:17 INFO - Cleaning up... 11:17:17 INFO - Return code: 0 11:17:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:17 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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:17 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 11:17:17 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 11:17:17 INFO - Using env: {'DISPLAY': ':0', 11:17:17 INFO - 'HOME': '/home/cltbld', 11:17:17 INFO - 'LANG': 'en_US.UTF-8', 11:17:17 INFO - 'LANGUAGE': 'en_US:en', 11:17:17 INFO - 'LOGNAME': 'cltbld', 11:17:17 INFO - 'MAIL': '/var/mail/cltbld', 11:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:17 INFO - 'MOZ_NO_REMOTE': '1', 11:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:17 INFO - 'NO_EM_RESTART': '1', 11:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:17 INFO - 'PWD': '/builds/slave/test', 11:17:17 INFO - 'SHELL': '/bin/bash', 11:17:17 INFO - 'SHLVL': '1', 11:17:17 INFO - 'TERM': 'linux', 11:17:17 INFO - 'TMOUT': '86400', 11:17:17 INFO - 'USER': 'cltbld', 11:17:17 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:17 INFO - '_': '/tools/buildbot/bin/python'} 11:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:17 INFO - Downloading/unpacking psutil>=0.7.1 11:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:17:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:19 INFO - Installing collected packages: psutil 11:17:19 INFO - Running setup.py install for psutil 11:17:19 INFO - building 'psutil._psutil_linux' extension 11:17:19 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 11:17:19 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 11:17:19 INFO - building 'psutil._psutil_posix' extension 11:17:19 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 11:17:19 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 11:17:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:20 INFO - Successfully installed psutil 11:17:20 INFO - Cleaning up... 11:17:20 INFO - Return code: 0 11:17:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:17:20 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')]} 11:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:20 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')]} 11:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:20 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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:20 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 11:17:20 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 11:17:20 INFO - Using env: {'DISPLAY': ':0', 11:17:20 INFO - 'HOME': '/home/cltbld', 11:17:20 INFO - 'LANG': 'en_US.UTF-8', 11:17:20 INFO - 'LANGUAGE': 'en_US:en', 11:17:20 INFO - 'LOGNAME': 'cltbld', 11:17:20 INFO - 'MAIL': '/var/mail/cltbld', 11:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:20 INFO - 'MOZ_NO_REMOTE': '1', 11:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:20 INFO - 'NO_EM_RESTART': '1', 11:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:20 INFO - 'PWD': '/builds/slave/test', 11:17:20 INFO - 'SHELL': '/bin/bash', 11:17:20 INFO - 'SHLVL': '1', 11:17:20 INFO - 'TERM': 'linux', 11:17:20 INFO - 'TMOUT': '86400', 11:17:20 INFO - 'USER': 'cltbld', 11:17:20 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:20 INFO - '_': '/tools/buildbot/bin/python'} 11:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:17:20 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 11:17:20 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 11:17:20 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 11:17:20 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 11:17:20 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 11:17:20 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 11:17:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:17:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:17:22 INFO - Installing collected packages: mozsystemmonitor 11:17:22 INFO - Running setup.py install for mozsystemmonitor 11:17:22 INFO - Successfully installed mozsystemmonitor 11:17:22 INFO - Cleaning up... 11:17:22 INFO - Return code: 0 11:17:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:22 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 11:17:22 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 11:17:22 INFO - Using env: {'DISPLAY': ':0', 11:17:22 INFO - 'HOME': '/home/cltbld', 11:17:22 INFO - 'LANG': 'en_US.UTF-8', 11:17:22 INFO - 'LANGUAGE': 'en_US:en', 11:17:22 INFO - 'LOGNAME': 'cltbld', 11:17:22 INFO - 'MAIL': '/var/mail/cltbld', 11:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:22 INFO - 'MOZ_NO_REMOTE': '1', 11:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:22 INFO - 'NO_EM_RESTART': '1', 11:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:22 INFO - 'PWD': '/builds/slave/test', 11:17:22 INFO - 'SHELL': '/bin/bash', 11:17:22 INFO - 'SHLVL': '1', 11:17:22 INFO - 'TERM': 'linux', 11:17:22 INFO - 'TMOUT': '86400', 11:17:22 INFO - 'USER': 'cltbld', 11:17:22 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:22 INFO - '_': '/tools/buildbot/bin/python'} 11:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:22 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 11:17:22 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 11:17:22 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 11:17:22 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 11:17:22 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 11:17:22 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 11:17:24 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 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 11:17:24 INFO - Downloading docopt-0.6.1.tar.gz 11:17:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:24 INFO - Running setup.py install for blobuploader 11:17:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:24 INFO - Running setup.py install for requests 11:17:25 INFO - Running setup.py install for docopt 11:17:25 INFO - Successfully installed blobuploader requests docopt 11:17:25 INFO - Cleaning up... 11:17:25 INFO - Return code: 0 11:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:25 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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:25 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 11:17:25 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 11:17:25 INFO - Using env: {'DISPLAY': ':0', 11:17:25 INFO - 'HOME': '/home/cltbld', 11:17:25 INFO - 'LANG': 'en_US.UTF-8', 11:17:25 INFO - 'LANGUAGE': 'en_US:en', 11:17:25 INFO - 'LOGNAME': 'cltbld', 11:17:25 INFO - 'MAIL': '/var/mail/cltbld', 11:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:25 INFO - 'MOZ_NO_REMOTE': '1', 11:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:25 INFO - 'NO_EM_RESTART': '1', 11:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:25 INFO - 'PWD': '/builds/slave/test', 11:17:25 INFO - 'SHELL': '/bin/bash', 11:17:25 INFO - 'SHLVL': '1', 11:17:25 INFO - 'TERM': 'linux', 11:17:25 INFO - 'TMOUT': '86400', 11:17:25 INFO - 'USER': 'cltbld', 11:17:25 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:25 INFO - '_': '/tools/buildbot/bin/python'} 11:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:25 INFO - Running setup.py (path:/tmp/pip-SRMKMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:25 INFO - Running setup.py (path:/tmp/pip-0kuPBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:25 INFO - Running setup.py (path:/tmp/pip-XC36gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:25 INFO - Running setup.py (path:/tmp/pip-neNlDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:25 INFO - Running setup.py (path:/tmp/pip-PtqK91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:26 INFO - Running setup.py (path:/tmp/pip-icOT30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:26 INFO - Running setup.py (path:/tmp/pip-asvdsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:26 INFO - Running setup.py (path:/tmp/pip-cc6tQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:26 INFO - Running setup.py (path:/tmp/pip-hsDeC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:26 INFO - Running setup.py (path:/tmp/pip-6eDrGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:26 INFO - Running setup.py (path:/tmp/pip-FDSP2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:26 INFO - Running setup.py (path:/tmp/pip-R3MHI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:26 INFO - Running setup.py (path:/tmp/pip-TPrjwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:26 INFO - Running setup.py (path:/tmp/pip-OxikYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:26 INFO - Running setup.py (path:/tmp/pip-iORFu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:26 INFO - Running setup.py (path:/tmp/pip-sTKuax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:26 INFO - Running setup.py (path:/tmp/pip-IAAjpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:26 INFO - Running setup.py install for manifestparser 11:17:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozcrash 11:17:27 INFO - Running setup.py install for mozdebug 11:17:27 INFO - Running setup.py install for mozdevice 11:17:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozfile 11:17:27 INFO - Running setup.py install for mozhttpd 11:17:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozinfo 11:17:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozInstall 11:17:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for mozleak 11:17:27 INFO - Running setup.py install for mozlog 11:17:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:27 INFO - Running setup.py install for moznetwork 11:17:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Running setup.py install for mozprocess 11:17:28 INFO - Running setup.py install for mozprofile 11:17:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Running setup.py install for mozrunner 11:17:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Running setup.py install for mozscreenshot 11:17:28 INFO - Running setup.py install for moztest 11:17:28 INFO - Running setup.py install for mozversion 11:17:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:28 INFO - Cleaning up... 11:17:28 INFO - Return code: 0 11:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:28 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 11:17:28 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 11:17:28 INFO - Using env: {'DISPLAY': ':0', 11:17:28 INFO - 'HOME': '/home/cltbld', 11:17:28 INFO - 'LANG': 'en_US.UTF-8', 11:17:28 INFO - 'LANGUAGE': 'en_US:en', 11:17:28 INFO - 'LOGNAME': 'cltbld', 11:17:28 INFO - 'MAIL': '/var/mail/cltbld', 11:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:28 INFO - 'MOZ_NO_REMOTE': '1', 11:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:28 INFO - 'NO_EM_RESTART': '1', 11:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:28 INFO - 'PWD': '/builds/slave/test', 11:17:28 INFO - 'SHELL': '/bin/bash', 11:17:28 INFO - 'SHLVL': '1', 11:17:28 INFO - 'TERM': 'linux', 11:17:28 INFO - 'TMOUT': '86400', 11:17:28 INFO - 'USER': 'cltbld', 11:17:28 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:28 INFO - '_': '/tools/buildbot/bin/python'} 11:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:28 INFO - Running setup.py (path:/tmp/pip-0JixPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:28 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)) 11:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:28 INFO - Running setup.py (path:/tmp/pip-aWt2SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:29 INFO - Running setup.py (path:/tmp/pip-TiPzjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:29 INFO - Running setup.py (path:/tmp/pip-_o5Jdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:29 INFO - Running setup.py (path:/tmp/pip-5L0RMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:29 INFO - Running setup.py (path:/tmp/pip-okYmca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:29 INFO - Running setup.py (path:/tmp/pip-p2jNdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:29 INFO - Running setup.py (path:/tmp/pip-REpMCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:29 INFO - Running setup.py (path:/tmp/pip-V52LBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:29 INFO - Running setup.py (path:/tmp/pip-2dy_la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:29 INFO - Running setup.py (path:/tmp/pip-VzaGE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:29 INFO - Running setup.py (path:/tmp/pip-J_QKge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:29 INFO - Running setup.py (path:/tmp/pip-OzNMyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:29 INFO - Running setup.py (path:/tmp/pip-4okmFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:29 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)) 11:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:29 INFO - Running setup.py (path:/tmp/pip-nijyET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:30 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)) 11:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:30 INFO - Running setup.py (path:/tmp/pip-KO_S2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:30 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)) 11:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:30 INFO - Running setup.py (path:/tmp/pip-GdmgeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:30 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)) 11:17:30 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)) 11:17:30 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)) 11:17:30 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)) 11:17:30 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)) 11:17:30 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)) 11:17:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:31 INFO - Downloading blessings-1.5.1.tar.gz 11:17:31 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 11:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:31 INFO - Installing collected packages: blessings 11:17:31 INFO - Running setup.py install for blessings 11:17:32 INFO - Successfully installed blessings 11:17:32 INFO - Cleaning up... 11:17:32 INFO - Return code: 0 11:17:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:32 INFO - Reading from file tmpfile_stdout 11:17:32 INFO - Current package versions: 11:17:32 INFO - argparse == 1.2.1 11:17:32 INFO - blessings == 1.5.1 11:17:32 INFO - blobuploader == 1.2.4 11:17:32 INFO - docopt == 0.6.1 11:17:32 INFO - manifestparser == 1.1 11:17:32 INFO - mozInstall == 1.12 11:17:32 INFO - mozcrash == 0.16 11:17:32 INFO - mozdebug == 0.1 11:17:32 INFO - mozdevice == 0.47 11:17:32 INFO - mozfile == 1.2 11:17:32 INFO - mozhttpd == 0.7 11:17:32 INFO - mozinfo == 0.9 11:17:32 INFO - mozleak == 0.1 11:17:32 INFO - mozlog == 3.1 11:17:32 INFO - moznetwork == 0.27 11:17:32 INFO - mozprocess == 0.22 11:17:32 INFO - mozprofile == 0.27 11:17:32 INFO - mozrunner == 6.11 11:17:32 INFO - mozscreenshot == 0.1 11:17:32 INFO - mozsystemmonitor == 0.0 11:17:32 INFO - moztest == 0.7 11:17:32 INFO - mozversion == 1.4 11:17:32 INFO - psutil == 3.1.1 11:17:32 INFO - requests == 1.2.3 11:17:32 INFO - wsgiref == 0.1.2 11:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:32 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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:32 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 11:17:32 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 11:17:32 INFO - Using env: {'DISPLAY': ':0', 11:17:32 INFO - 'HOME': '/home/cltbld', 11:17:32 INFO - 'LANG': 'en_US.UTF-8', 11:17:32 INFO - 'LANGUAGE': 'en_US:en', 11:17:32 INFO - 'LOGNAME': 'cltbld', 11:17:32 INFO - 'MAIL': '/var/mail/cltbld', 11:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:32 INFO - 'MOZ_NO_REMOTE': '1', 11:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:32 INFO - 'NO_EM_RESTART': '1', 11:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:32 INFO - 'PWD': '/builds/slave/test', 11:17:32 INFO - 'SHELL': '/bin/bash', 11:17:32 INFO - 'SHLVL': '1', 11:17:32 INFO - 'TERM': 'linux', 11:17:32 INFO - 'TMOUT': '86400', 11:17:32 INFO - 'USER': 'cltbld', 11:17:32 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:32 INFO - '_': '/tools/buildbot/bin/python'} 11:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 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)) 11:17:32 INFO - Cleaning up... 11:17:32 INFO - Return code: 0 11:17:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:32 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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:32 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 11:17:32 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 11:17:32 INFO - Using env: {'DISPLAY': ':0', 11:17:32 INFO - 'HOME': '/home/cltbld', 11:17:32 INFO - 'LANG': 'en_US.UTF-8', 11:17:32 INFO - 'LANGUAGE': 'en_US:en', 11:17:32 INFO - 'LOGNAME': 'cltbld', 11:17:32 INFO - 'MAIL': '/var/mail/cltbld', 11:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:32 INFO - 'MOZ_NO_REMOTE': '1', 11:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:32 INFO - 'NO_EM_RESTART': '1', 11:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:32 INFO - 'PWD': '/builds/slave/test', 11:17:32 INFO - 'SHELL': '/bin/bash', 11:17:32 INFO - 'SHLVL': '1', 11:17:32 INFO - 'TERM': 'linux', 11:17:32 INFO - 'TMOUT': '86400', 11:17:32 INFO - 'USER': 'cltbld', 11:17:32 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:32 INFO - '_': '/tools/buildbot/bin/python'} 11:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:32 INFO - Downloading/unpacking jsonschema 11:17:32 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 11:17:32 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 11:17:32 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 11:17:32 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 11:17:32 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 11:17:32 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 11:17:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:34 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 11:17:34 INFO - Downloading/unpacking functools32 (from jsonschema) 11:17:34 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 11:17:34 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 11:17:34 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 11:17:34 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 11:17:34 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 11:17:34 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 11:17:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:34 INFO - warning: no files found matching '*.txt' 11:17:34 INFO - no previously-included directories found matching 'build' 11:17:34 INFO - no previously-included directories found matching 'dist' 11:17:34 INFO - no previously-included directories found matching '.git*' 11:17:34 INFO - Installing collected packages: jsonschema, functools32 11:17:34 INFO - Running setup.py install for functools32 11:17:34 INFO - warning: no files found matching '*.txt' 11:17:34 INFO - no previously-included directories found matching 'build' 11:17:34 INFO - no previously-included directories found matching 'dist' 11:17:34 INFO - no previously-included directories found matching '.git*' 11:17:34 INFO - Successfully installed jsonschema functools32 11:17:34 INFO - Cleaning up... 11:17:34 INFO - Return code: 0 11:17:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:34 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 0x7ffb5ddc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1423240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', '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 11:17:34 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 11:17:34 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 11:17:34 INFO - Using env: {'DISPLAY': ':0', 11:17:34 INFO - 'HOME': '/home/cltbld', 11:17:34 INFO - 'LANG': 'en_US.UTF-8', 11:17:34 INFO - 'LANGUAGE': 'en_US:en', 11:17:34 INFO - 'LOGNAME': 'cltbld', 11:17:34 INFO - 'MAIL': '/var/mail/cltbld', 11:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:34 INFO - 'MOZ_NO_REMOTE': '1', 11:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:34 INFO - 'NO_EM_RESTART': '1', 11:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:34 INFO - 'PWD': '/builds/slave/test', 11:17:34 INFO - 'SHELL': '/bin/bash', 11:17:34 INFO - 'SHLVL': '1', 11:17:34 INFO - 'TERM': 'linux', 11:17:34 INFO - 'TMOUT': '86400', 11:17:34 INFO - 'USER': 'cltbld', 11:17:34 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:34 INFO - '_': '/tools/buildbot/bin/python'} 11:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:35 INFO - Downloading/unpacking flake8 11:17:35 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 11:17:35 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 11:17:35 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 11:17:35 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 11:17:35 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 11:17:35 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 11:17:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:17:36 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 11:17:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:17:36 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 11:17:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:37 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 11:17:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:17:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:37 INFO - no previously-included directories found matching 'docs/_build' 11:17:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:17:37 INFO - Running setup.py install for pep8 11:17:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:37 INFO - no previously-included directories found matching 'docs/_build' 11:17:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:17:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:17:37 INFO - Cleaning up... 11:17:37 INFO - Return code: 0 11:17:37 INFO - Running post-action listener: _resource_record_post_action 11:17:37 INFO - Running post-action listener: _start_resource_monitoring 11:17:37 INFO - Starting resource monitoring. 11:17:37 INFO - ##### 11:17:37 INFO - ##### Running install step. 11:17:37 INFO - ##### 11:17:37 INFO - Running pre-action listener: _resource_record_pre_action 11:17:37 INFO - Running main action method: install 11:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:37 INFO - Reading from file tmpfile_stdout 11:17:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:37 INFO - Reading from file tmpfile_stdout 11:17:37 INFO - Output received: 11:17:37 INFO - Usage: mozinstall [options] installer 11:17:37 INFO - Options: 11:17:37 INFO - -h, --help show this help message and exit 11:17:37 INFO - -d DEST, --destination=DEST 11:17:37 INFO - Directory to install application into. [default: 11:17:37 INFO - "/builds/slave/test"] 11:17:37 INFO - --app=APP Application being installed. [default: firefox] 11:17:37 INFO - mkdir: /builds/slave/test/build/application 11:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:17:52 INFO - Reading from file tmpfile_stdout 11:17:52 INFO - Output received: 11:17:52 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:52 INFO - Running post-action listener: _resource_record_post_action 11:17:52 INFO - ##### 11:17:52 INFO - ##### Running run-tests step. 11:17:52 INFO - ##### 11:17:52 INFO - Running pre-action listener: _resource_record_pre_action 11:17:52 INFO - Running main action method: run_tests 11:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:52 INFO - Python 2.7.3 11:17:52 INFO - Return code: 0 11:17:52 INFO - grabbing minidump binary from tooltool 11:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:52 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 0x14b20b0>, '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 0x14b2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:52 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 11:17:52 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 11:17:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:52 INFO - Return code: 0 11:17:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:17:53 INFO - Return code: 0 11:17:53 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/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test/build 11:17:53 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/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 11:17:53 INFO - Using env: {'DISPLAY': ':0', 11:17:53 INFO - 'HOME': '/home/cltbld', 11:17:53 INFO - 'LANG': 'en_US.UTF-8', 11:17:53 INFO - 'LANGUAGE': 'en_US:en', 11:17:53 INFO - 'LOGNAME': 'cltbld', 11:17:53 INFO - 'MAIL': '/var/mail/cltbld', 11:17:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:53 INFO - 'MOZ_NO_REMOTE': '1', 11:17:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:53 INFO - 'NO_EM_RESTART': '1', 11:17:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:53 INFO - 'PWD': '/builds/slave/test', 11:17:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:53 INFO - 'SHELL': '/bin/bash', 11:17:53 INFO - 'SHLVL': '1', 11:17:53 INFO - 'TERM': 'linux', 11:17:53 INFO - 'TMOUT': '86400', 11:17:53 INFO - 'USER': 'cltbld', 11:17:53 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721', 11:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:53 INFO - '_': '/tools/buildbot/bin/python'} 11:17:53 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/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 11:17:53 INFO - mozversion INFO | application_buildid: 20151215103151 11:17:53 INFO - mozversion INFO | application_changeset: 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 11:17:53 INFO - mozversion INFO | application_display_name: Nightly 11:17:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:53 INFO - mozversion INFO | application_name: Firefox 11:17:53 INFO - mozversion INFO | application_remotingname: firefox 11:17:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:17:53 INFO - mozversion INFO | application_vendor: Mozilla 11:17:53 INFO - mozversion INFO | application_version: 46.0a1 11:17:53 INFO - mozversion INFO | platform_buildid: 20151215103151 11:17:53 INFO - mozversion INFO | platform_changeset: 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 11:17:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:53 INFO - mozversion INFO | platform_version: 46.0a1 11:17:53 INFO - 2015-12-15 11:17:53,638 DEBUG : using testdate: 1450207073 11:17:53 INFO - 2015-12-15 11:17:53,638 DEBUG : actual date: 1450207073 11:17:53 INFO - 2015-12-15 11:17:53,647 INFO : starting webserver on 'localhost:42770' 11:17:53 INFO - 2015-12-15 11:17:53,648 INFO : Starting test suite talos-linux64-ix-001 11:17:53 INFO - 2015-12-15 11:17:53,648 INFO : Starting test dromaeo_css 11:17:53 INFO - 2015-12-15 11:17:53,648 DEBUG : operating with platform_type : linux_ 11:17:53 INFO - 2015-12-15 11:17:53,649 INFO : Initialising browser for dromaeo_css test... 11:17:53 INFO - 2015-12-15 11:17:53,662 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdNz0Wq/profile http://localhost:42770/getInfo.html 11:17:58 INFO - 2015-12-15 11:17:58,183 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:17:58 INFO - 2015-12-15 11:17:58,183 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:17:58 INFO - 2015-12-15 11:17:58,183 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:17:58 INFO - 2015-12-15 11:17:58,183 DEBUG : BROWSER_OUTPUT: __metrics 11:17:58 INFO - 2015-12-15 11:17:58,320 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] 11:17:58 INFO - 2015-12-15 11:17:58,388 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] 11:17:59 INFO - 2015-12-15 11:17:59,633 INFO : Browser initialized. 11:17:59 INFO - 2015-12-15 11:17:59,633 INFO : Running cycle 1/1 for dromaeo_css test... 11:17:59 INFO - 2015-12-15 11:17:59,634 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdNz0Wq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:18:11 INFO - 2015-12-15 11:18:11,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 143110144 11:18:11 INFO - 2015-12-15 11:18:11,631 DEBUG : BROWSER_OUTPUT: 11:19:03 INFO - 2015-12-15 11:19:03,119 DEBUG : BROWSER_OUTPUT: 1450207143114 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] 11:21:15 INFO - 2015-12-15 11:21:15,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42770/tests/dromaeo/cssquery-ext.html) 11:21:16 INFO - 2015-12-15 11:21:16,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 241725440 11:21:16 INFO - 2015-12-15 11:21:16,340 DEBUG : BROWSER_OUTPUT: 11:24:18 INFO - 2015-12-15 11:24:18,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-ext.html (next: http://localhost:42770/tests/dromaeo/cssquery-jquery.html) 11:24:19 INFO - 2015-12-15 11:24:19,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 227799040 11:24:19 INFO - 2015-12-15 11:24:19,388 DEBUG : BROWSER_OUTPUT: 11:27:21 INFO - 2015-12-15 11:27:21,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42770/tests/dromaeo/cssquery-mootools.html) 11:27:21 INFO - 2015-12-15 11:27:21,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 216784896 11:27:21 INFO - 2015-12-15 11:27:21,988 DEBUG : BROWSER_OUTPUT: 11:30:23 INFO - 2015-12-15 11:30:23,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42770/tests/dromaeo/cssquery-prototype.html) 11:30:24 INFO - 2015-12-15 11:30:24,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 200335360 11:30:24 INFO - 2015-12-15 11:30:24,521 DEBUG : BROWSER_OUTPUT: 11:33:27 INFO - 2015-12-15 11:33:27,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42770/tests/dromaeo/cssquery-yui.html) 11:33:27 INFO - 2015-12-15 11:33:27,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 206692352 11:33:27 INFO - 2015-12-15 11:33:27,909 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-yui.html (next: http://localhost:42770/tests/dromaeo/cssquery-dojo.html) 11:36:30 INFO - 2015-12-15 11:36:30,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 248848384 11:36:30 INFO - 2015-12-15 11:36:30,723 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,723 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:36:30 INFO - 2015-12-15 11:36:30,723 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:36:30 INFO - 2015-12-15 11:36:30,724 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:36:30 INFO - 2015-12-15 11:36:30,724 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:36:30 INFO - 2015-12-15 11:36:30,724 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2631.1580294305822;2728.017913551121;2732.4671689020624;2737.739914708102;2743.62961000265;4438.622717069053;4586.793594288257;4708.176069187892;4736.194846876031;4742.881427964298;4600.769961501928;4641.350210970467;4718.150732868083;4726.527347265281;4744.4069491313585;4243.257429949762;4276.914461710764;4286.592773686511;4325.4593175853015;4342.50061242958;4302.913941721164;4401.955980440202;4445.755483448409;4457.153140903234;4472.955270447303;4140.254754144253;4249.32010878258;4255.97872010638;4377.912441751163;4433.357163211316;4380.67144964129;4386.605205531518;4396;4402;4424.756638384888;4332.913341733148;4338.1540599583095;4346.434963454731;4393.626541743955;4403.22943484892;4399.252127138394;4500.617447516932;4513.368128462018;4664.2189619281135;4683.180443422388;4982.451930287665;5076.720780357079;5091.872703182413;5116.718580478072;5117.078925793356;5050.39395272566;5073.264376665363;5100.642954993152;5104.106781313292;5110.386753589556;4459.643228541709;4738.64460165489;4742.810287588527;4743.241081426955;4786.425628924551;5064.11378008847;5075.289459475676;5085.440601533828;5137;5184;4929.852104436873;4932.704037757674;4935.925961110514;4937.086638971802;4976.825811096594;4837.177679794443;5013.248012798036;5014.072396606566;5027.673201241908;5029.924551131736;4863;4868.367112275452;4870.025994801054;4948.480409557017;4979.775910084055;4982.227754698028;4982.9252561211615;4985;4991.550760431579;5025.296458495814;3951;4161.271777438936;4163.2298024864895;4165.291900376943;4204.201201771715;3564.7682900611376;3570.732195085379;3614.6385361464168;3655.6344365563764;3710.7588006779474;4324.956750432519;4326.610605045561;4334.544872788375;4370.300751879684;4372.759498227564;4754.381930349033;5055.7219352935945;5056.140456122468;5060.165072762953;5060.5951523878;4235.174141042467;4252.425922500484;4253.595908388698;4339.717918335361;4368.060866913629;4478.708883922534;4482.282834746425;4491.528389519053;4493.573110554492;4522.615577675869;4521.909561808811;4802.73584952831;4804.35141255926;4817.566419022305;4841.636877234221;4955.628327875352;4972.602191824573;4976.2038073908;5045.672031317952;5109.9233511498105;4752.6197904168275;4785.013879735486;4790.065937142223;4790.688605240648;4836.830710925101;4707.317438971261;4978.352814134139;4979.850604481871;4987.501249874984;5030.270610761346;4882.389701287339;4942.4316203637045;4955.355803745634;4971.9254211186135;5021.748912554431;4885.193942999507;4895.094407534618;4908.901821963612;4919.926201107058;4952.628552858478;4711.882202944954;4907.312976183266;4910.116179087656;4914.36113305268;4957.529034741694;4643.558861908114;4703.717776933395;4709.458412282632;4720.622350212044;4750.097481478508;4916.213405855046;4929.334539837219;4930.334404855442;4931.7040977541465;4961.206207006861;4593.862184134481;4786.377770889762;4833.564979151894;4834.758262086952;4840.2255639097575 11:36:30 INFO - 2015-12-15 11:36:30,725 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.1280193466691;575.6459777237001;588.5703436491361;596.7612954818073;600.1028462448637;27387.452250954968;36416;37403;37426.43860342097;37432;39975.200495990066;40464;40481;40556.59443405565;40570.39144412836;6972.477064220178;7048.964755176217;7050.224475307712;7804.8048798780055;7959.602019899011;7130.215676275606;7226.710931562731;10136.378179491283;10312.948435257813;10328.535215915264;9965.103140717334;10057.547410366551;10060.597576096947;10070.446125463097;10070.949645251763;9918.504074796232;9955.701328960144;10018.398896066223;10030.197584193247;10060.748481287954;7194.280571942816;7388.593627350494;7391.815204619874;7395.334419902235;10027.849582256273;36931.522739090404;37113.62886371129;37122.4431633523;37160.81419592885;37414.62585374166;2914.8396838173894;2949.0857834071508;2959.881604735808;3137;3433.3819912415756;27214.72785272142;28294.858525707445;28421.71578284232;28612.284692882637;29319;2623.8819253133465;2625.7111717711036;2720.455908818244;2736.53478908586;2778.333200031998;212409;214458;214784.99999999843;214913;214967;56869;56928.43071569314;57249.71375143098;57334.97982711838;57345.71327143421;59425.40574594285;59786;60281;60306.69846650738;60307;11647.41762911851;12004.939975300067;12082.939585302192;12087.093467989936;12099.213551119148;9290.907090929139;9346.15884570392;9357.672481463116;9381.0618938107;9392.765180870532;18881.69441442146;19439.80560194408;19592.669246228175;19595.412137635893;19597.31409400664;7484.625768711543;7635.427342949301;7747.147813740484;7806.960965195138;7830.138684744674;890.8930928288518;906.8186362727349;982.5725809272989;996.9202463802878;1050.5535147562255;26492.867535662197;30510.69489305123;31420.214494637818;31490.842545787124;32007.839960800513;868.6568805321863;941.4868896451451;968.8449848024283;985.881694196701;1033.0857191385678;13454.798178027337;15083.622909427351;15614.609634758996;16247.59381015484;16663.083530405944;315108;319830;320009;320095;320699;42579.57420425818;43347;48844.511554884;49643.25535116976;49860.25209621859;1151.366748288438;1223.2477026628737;1234.2409418207737;1235.6416639174538;1245.3275231375137;25530.74469255358;26031;26857.86571067132;27022;29098.27254318659;43545.34681979836;43762.56237437585;44072.33891491566;44106.33840492331;44110.794460276215;240672;241385;242248;242337;242755;29632.55551166691;30073.248168795955;43045.784771075945;44051.33922991093;44272.77863610661;39420.80289598534;45467.772661136485;46953.2957005652;47308.29037564508;47457.28814067861;33794.3241135171;34006;34399.856824689465;34655.480167796995;34980.30039399249;34066.318673625894;34155.65844341525;34349.65650343464;34642.48036279407;34693.47959780555;33535.16162095967;34128.829355853064;34331.828340858134;34372.82813586016;34389.48415773815;29586.556201656564;30278.84860575771;30455;30690.84654576713;30890;21836.781632183476;21959.451013724785;22042.669359959935;22071.11715531425;22078.779212208316 11:36:30 INFO - 2015-12-15 11:36:30,725 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.15645026956133;334.6970991252916;337.91214284286076;339.5161894300622;340.9164754635114;12676;13090.345482725874;14964.625884352883;15374.385024599016;16097.919510402431;12326.938365308184;13943.37254823533;14570.854291457083;15064.548063558083;15074.6985060299;4311.749592618137;4514.322851572258;4639.8376056838015;4649.209634362167;5086.872828179306;5041.319421878036;5081.136206844827;5088.058709138802;5090.720010399426;5092.083424983502;4571.839985600504;4630.236011058171;5055.165897626887;5059;5060.974695126519;4631.791569379369;4655.4878963314;4661.137689527448;4671.252599584084;4672.696274742165;4515.345274935116;4516.932246016312;4516.954830451719;4519.615832654228;4519.954800451987;18213.27146914122;18440.63118737631;18697.626047478974;18736.90631546847;18842.3405180818;1750.9824901751074;1774.0774797105562;1808.4665023818006;1865.9440216793519;1974.7136665183468;8896.510691911943;9154.81690366189;9315.115064068903;9735;12659.810102848465;1733.644602856424;1749.4664127441126;1750.0549703160277;1815.2013114229696;1858.4982054845116;53425;54700;54798.178027329624;57960.71019644917;57990.710046449916;9976.401415915068;10021.498925053718;10032.448215348226;10040.69877903664;10076.445795481319;10337.896621033844;10610.310329828691;11764.58823941158;12748.235105893677;12890.548830790878;6204.255489341308;6316.242050953915;6331.303556608769;6350.396712312323;6386.137871387304;5888.558358123158;5913.970430147821;5939.970300148558;5961.135635332939;6035.275766907999;4184.937225941613;4192.434021407132;4197.9370309445385;4199.2441360555395;4219.451471308772;1735.826417358254;1738.6001219719535;1747.6592064547544;1751.842334189929;1758.6043140293586;866.151171851589;908.8273228086642;932.1470854168496;935.9064093590723;976.5751897924425;15520.689586208213;15588.454404095803;15606.609834754221;15938.442154524537;15958.1223032732;821.3921697943479;853.6158728572167;865.0398058155442;904.755715956688;914.0996118822954;7264.455165862581;8697.652093916298;8944.5080520572;9052.592633331516;9201.815963680823;426072;437940;440666;440851;441801;53333.7333313331;53461.73269133629;71188.28811711817;72761.6361918187;73356.26643733494;893.4817805672694;946.4557879219338;975.3513913247752;980.3187533380287;985.5170966226641;13643.454261829416;13726.382312795748;13768.311584420539;13877.306134693426;13990.860091398956;29269.560956585243;29989.250268743457;30317;31565.368692626478;33590.664093358755;43070.138597228506;43079.7846010768;43217.35173972456;43670.126597467235;45993.620191394315;8574.09971952936;8936.106389361012;9016.143466370684;9027;9034.051424600322;10249.897501024894;11478;15823.050616963019;15910.443134490237;16022.038677679377;13029.283389413673;13030.292432138118;13427.26150061756;13536;13771.38028788727;13119.934400327937;13199.34003299812;13397.717559197668;13458.730825383633;13562.38969246406;13066.216027038028;13357.265350405822;13459.327033648475;13561.796573051215;13757.79363309571;8700;8797.428167169113;8963.327750418614;8996.775080623036;9009.369344145847;10957.561697532328;13187.142835715647;13296.135751176529;13368.465261389825;14030.438782448588 11:36:30 INFO - 2015-12-15 11:36:30,727 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1391.0594720365084;1423.7508436023693;1425.5438259756875;1456.526628845625;1518.422999260281;5798.739056742446;6940.13248343957;7105.289471052899;7127.7505287314825;7130.108736407949;7044.753433629824;7082.50422470426;7134.892976605355;7146.249643787405;7160.641967901597;1703.6881601167095;1752.5618595351161;2020.2020202020194;2050.5078781092507;2052.6100040992237;2002.3892712722613;2032.552838375555;2035.0435295411132;2037.3073155127254;2043.2950632031925;1976.21939333963;1985.354759703095;1991.233375150563;2055.2806517718827;2059.4645392198063;2001.7497812773404;2017.6569983102834;2040.4184807329839;2040.540878302385;2041.2855500574753;2062.0720675695998;2065.4629796252934;2080.3966849613594;2080.771115177329;2083.4687154775434;7068.36384725372;7112.25321341262;7135;7147.964260178665;7162.176349719797;3927.9018024549327;3987.342088555385;4001.279769641463;4006.83972641094;4017.5982401759884;2630.0663264541004;2637.02430100862;2678.665166854143;2696.892124315025;2722.986385068062;821.4578378270313;833.2500749325595;855.4653341661461;877.6313948141732;880.2869675562814;8941.865872011926;8972.955135224413;8978.685745998859;8983.191512763882;8983.595738191732;3633.927321453556;3697.0757310672334;3735.533058367704;3754.005188624962;3761.304158730589;7840.3335716464735;7861.4103942204565;7863.213678632091;7864.606769661494;7869.291763741291;3998.300297447935;4003.259397011562;4027.9194416111513;4035.7982100894837;4037.313656678372;3615.909602259912;3657.3782456982376;3658.122050707811;3660.5607327120383;3661.7986010769664;2875.3961668049524;2913.6503619565788;2916.2855100500515;3345.1302661308237;3437.5359326491102;979.8628192053118;1101.3446999035561;1101.9889801101885;1108.7505311305054;1123.3652986062848;888.6001299415288;895.6999405199201;928.5218112671979;929.3958926697566;929.8047410043831;6494.285628580852;6537.150170477903;6555.737770489222;6558.1802274715665;6563.278039415661;1004.9799004019878;1032.9276950613535;1033.565902321027;1035.5081336365167;1046.6650671785108;5260.842174734764;5306.628536002443;5314.415414304423;5316.149416093406;5327.254184414185;7901.683932642745;8054.073781515201;8059.476134051268;8362.707305244408;8378.455400398954;7987.720429785046;8068;8086.595670216466;8092.6762929482165;8096.433249672584;6636.104125943032;6688.331166883273;6692.799216023527;6696.832579185462;6723.159605049369;6613.5370524062855;6665.933340666531;6669.533132680665;6671.8999215010845;6673.466122710269;7492.628317257365;7525;7544.509606875536;7611.162772094955;7632.694692212472;7637.885431718418;7784.377249820114;7792.064952205772;7801.531908085533;7936.444448888522;6207.16203312547;6252.468540174136;6289.6540690260645;6290.779822706183;6302.905456418249;5655.886882262414;6609.405153536205;6616.735330586916;6774.356436138559;6802.251752307341;5605.859853503695;6118.235220597426;6182.907256391068;6301.6534090625455;6309.684515774101;6048.667323297261;6064.696765161812;6137.877242455036;6149.907751383644;6179.258488981351;5969.582129250911;6003.339632640319;6004.909926351021;6008.399160083956;6013.939860601338;5547.057000310037;5552.333719953632;5760.366359700513;5764.740586673526;5774.769009239583;5875.911861321998;5904.261967254093;5909.734061967308;5910.408959104056;5911.320198177093 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: |4;prototype.html;282.444995583678;285.0806150165716;288.43610741001345;288.8180446318819;294.55081001472746;4941.827036053739;5126.461721519243;5295.126304159814;5356.410794812572;5361.329833770784;5192.584593232542;5318.680879147254;5323.707196104213;5327.547158491533;5332.813351532697;4151.294279972397;4160.8335666573375;4165.56261592533;4165.6250937415625;4169.56219596941;3907.7264591478606;3971.2057588482276;4030.9596904030877;4152.774931395245;4170.040890595165;4017.959820401788;4024.5170579530495;4040.5353384360733;4052.5136983562015;4055.5944405559503;4013.578574249691;4014.6386825185728;4016.9196616067807;4018.4976877890263;4031.2743706132883;3527.770694904849;3529.5588051493564;3534.452159915217;3536.2927414516944;3539.610642829287;5023.14606516893;5032.043911656773;5032.62255330848;5034.421041580192;5036.647434679574;4532.750698711569;4647.209974304343;4655.837045703418;4657.906841863178;4666.883327916796;5556.027695153372;5567.3040869891265;5568.916466253009;5574.080276754331;5580.944190558083;3538.575370955476;3619.981900090509;3709.2210635766523;3825.7704537727827;3825.827837747308;5719.342275638313;5866.266716660418;5871.5596330274975;5890.381509941437;5890.558208134365;3907.2185562886966;3909.706771992112;3914.549826769901;3915.353966595537;3915.784631845219;3957.8021098944937;3962.583928687504;3964.682825373963;3965.246603145451;3968.0873399118364;4437.600615944581;4595.862124136282;4607.769611519478;4610.9308360374625;4618.1918164321105;5591.133374326986;5602.38373778884;5610.046292130348;5611.466910643482;5613.410591887875;1381.205806661174;1398.6153807702963;1399.7200559888063;1399.8950078744135;1400.551823416497;925.1997022575558;932.3566738950103;933.3373304953424;941.0260380506144;943.7263193673758;4899.853004409802;4900.975495122501;4903.043906438282;4916.287138364989;4921.089598424303;5822.737976791054;5823.388544202882;5824.6796426196115;5825.300963884361;5825.76696932118;4903.828366007173;4915.238138088602;4918.040982008474;4919.680220785637;4919.680220785637;3045.25391279138;3102.7362674172496;3133.874645014174;3141.1361875483967;3149.2284390324057;5540.196671482693;5552.083906155439;5553.500184983371;5558.305211848519;5558.388577256498;6026.096085587197;6027.8794424111275;6028.156058151862;6038.275406951194;6039.486643635252;5537.086380747131;5546.306711661043;5546.91679624806;5549.833504994856;5550.69471179089;5713.371529131875;5831.591788574759;5864.67744274069;5874.206982057368;5877.970610146922;5420.891582168256;5626.2967129108865;5708.315002199763;5716.256886604715;5717.3996730342715;5354.3842458117815;5490.6980116094;5524.447555244444;5530.059889818821;5543.279373681396;3888.183481468923;3911.3741801311653;3913.8630147944687;3918.4318273850704;3919.6864250859294;5830.737616807169;5844.094165404369;5848.976429124971;5859.882802343844;5860.912086318794;5418.916216756743;5591.133374326986;5606.215129881738;5607.747651355618;5645.1532270159805;5629.127485239795;5633.577481688808;5637.210790489253;5638.407967163389;5647.3787883333625;5514.172874068921;5514.2004409359615;5519.862003449946;5521.47545983147;5524;5551.639143455824;5673.858153546194;5675.659460432387;5679.6876171810945;5680.545556355564;5519.8896022080135;5534.059209934401;5541.307336582927;5542.695151766691;5550.139728342114 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: |5;yui.html;755.3013462547146;759.9316061554463;780.1340512031644;785.8428314337131;791.7347688524344;11441.713957151065;11689.12331575133;11694.707632309197;11716.589919352835;11751;12820.166689165198;12890.226586404822;12901;12920.095593308472;12934.094613377067;618.7401291457599;626.2485017978421;775.5966897213445;779.555653277632;793.1790596732383;781.9335356494705;783.2950344689768;784.4234487651571;788.5702292250709;788.9881651775228;766.7929658992069;805.3798575097171;818.0919179710517;818.6275244763648;821.7247222180577;645.1580687203198;655.1613934164277;798.6645608844241;813.9430239883211;814.1288820961573;603.3574243430733;607.8753855459664;608.1516284782704;609.1806520230283;609.4332270987979;11075.335479871233;11089.500972456259;11105.333679979227;11121.110311175087;11123.833142502868;10410.79178416435;10417.895821041768;10783.676489705322;10843.07833834125;11266.774664506745;8605.225529702357;8607.182317679873;8685.826283474358;8954.641814327419;9279.443233406017;3106.6427360853563;3183.9522407163913;3193.8722451101926;3202.0553936588763;3250.658680838525;38359.616403835884;38878.22243555113;39213.803930980444;39221.803890980365;39394.60605393938;8487.702930397407;8968.23769979546;9305.53472326381;9540.189083927806;9656.75858103539;15590.376384944702;15735;15780.68438631244;15796.210189490479;15834.60413489672;5735;5812.186293918855;5928.673922934194;6157;6239.376062393724;3400.3199360128074;3472.444408894615;3483.89548313551;3534.081138903852;3541.6281290464644;2562.93592660185;2576;2593.6887573490926;2603.075908052652;2607.087519368244;466.4402716739926;482.4644644444664;489.71351759220545;490.4604934571942;491.13069866336383;473.4555261449292;521.8356217791384;537.3471232452589;557.3033707865169;565.6295126692023;7227.530210536298;7248.855022899618;7367.521111127867;7395.445341599401;7411.2588741125455;486.7126450538306;527.5015110720409;563.5463451921242;574.1731906055267;578.4244676546863;3390.4744764561533;3437.0719905625842;3544.379733546619;3550.8579656813954;3556.608773034964;48701.26948095782;49333;49479.50520494821;49537.50462495329;49602.75198624056;43478.56521434745;43911;44174.33738493925;44329.55670443319;44477;39690.60309396869;40167.397489037685;40523.59476405257;40689.796551017054;40971.1805763883;7459.664315105942;7585.962070189614;7713.498622589514;7739.961300193463;7753.534787912743;29820.403591928472;30359.848200758854;30770.230744231572;30924.22689432782;30979.380412392078;37413.625863741014;37619.43570846385;38699.806500967316;39039.80480097581;39367.80316098401;9044.457332560067;9286.72139835806;9331.346805723535;9936.701898942754;10050.748731281776;10500;10785.406802625617;10876.129909607054;10994.780104398027;11098.944505277423;9897.802043959224;9991.400515968775;10218.948905255425;10411.11505522039;10669.46652667348;8789.736307910773;8836.690715824916;8957.731268061969;8959.596818143329;9172.266218702622;8208;9797.412155270707;9934.354266972623;10495.212859035755;10592.788144237225;8758.824823503366;8833.823323533365;8983.236424903695;9332.16010559053;9374.718758437259;8180.386471014816;8561.57192140403;8725.65097396097;9069;9097.818043638958 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: __startTimestamp1450208190719__endTimestamp 11:36:30 INFO - 2015-12-15 11:36:30,728 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4627.09 Median:4750.10 stddev:480.41 (10.1%) stddev-sans-first:455.65 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: Values: 2631.2 2728.0 2732.5 2737.7 2743.6 4438.6 4586.8 4708.2 4736.2 4742.9 4600.8 4641.4 4718.2 4726.5 4744.4 4243.3 4276.9 4286.6 4325.5 4342.5 4302.9 4402.0 4445.8 4457.2 4473.0 4140.3 4249.3 4256.0 4377.9 4433.4 4380.7 4386.6 4396.0 4402.0 4424.8 4332.9 4338.2 4346.4 4393.6 4403.2 4399.3 4500.6 4513.4 4664.2 4683.2 4982.5 5076.7 5091.9 5116.7 5117.1 5050.4 5073.3 5100.6 5104.1 5110.4 4459.6 4738.6 4742.8 4743.2 4786.4 5064.1 5075.3 5085.4 5137.0 5184.0 4929.9 4932.7 4935.9 4937.1 4976.8 4837.2 5013.2 5014.1 5027.7 5029.9 4863.0 4868.4 4870.0 4948.5 4979.8 4982.2 4982.9 4985.0 4991.6 5025.3 3951.0 4161.3 4163.2 4165.3 4204.2 3564.8 3570.7 3614.6 3655.6 3710.8 4325.0 4326.6 4334.5 4370.3 4372.8 4754.4 5055.7 5056.1 5060.2 5060.6 4235.2 4252.4 4253.6 4339.7 4368.1 4478.7 4482.3 4491.5 4493.6 4522.6 4521.9 4802.7 4804.4 4817.6 4841.6 4955.6 4972.6 4976.2 5045.7 5109.9 4752.6 4785.0 4790.1 4790.7 4836.8 4707.3 4978.4 4979.9 4987.5 5030.3 4882.4 4942.4 4955.4 4971.9 5021.7 4885.2 4895.1 4908.9 4919.9 4952.6 4711.9 4907.3 4910.1 4914.4 4957.5 4643.6 4703.7 4709.5 4720.6 4750.1 4916.2 4929.3 4930.3 4931.7 4961.2 4593.9 4786.4 4833.6 4834.8 4840.2 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42728.13 Median:18794.52 stddev:68531.18 (364.6%) stddev-sans-first:68650.20 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: Values: 534.1 575.6 588.6 596.8 600.1 27387.5 36416.0 37403.0 37426.4 37432.0 39975.2 40464.0 40481.0 40556.6 40570.4 6972.5 7049.0 7050.2 7804.8 7959.6 7130.2 7226.7 10136.4 10312.9 10328.5 9965.1 10057.5 10060.6 10070.4 10070.9 9918.5 9955.7 10018.4 10030.2 10060.7 7194.3 7388.6 7391.8 7395.3 10027.8 36931.5 37113.6 37122.4 37160.8 37414.6 2914.8 2949.1 2959.9 3137.0 3433.4 27214.7 28294.9 28421.7 28612.3 29319.0 2623.9 2625.7 2720.5 2736.5 2778.3 212409.0 214458.0 214785.0 214913.0 214967.0 56869.0 56928.4 57249.7 57335.0 57345.7 59425.4 59786.0 60281.0 60306.7 60307.0 11647.4 12004.9 12082.9 12087.1 12099.2 9290.9 9346.2 9357.7 9381.1 9392.8 18881.7 19439.8 19592.7 19595.4 19597.3 7484.6 7635.4 7747.1 7807.0 7830.1 890.9 906.8 982.6 996.9 1050.6 26492.9 30510.7 31420.2 31490.8 32007.8 868.7 941.5 968.8 985.9 1033.1 13454.8 15083.6 15614.6 16247.6 16663.1 315108.0 319830.0 320009.0 320095.0 320699.0 42579.6 43347.0 48844.5 49643.3 49860.3 1151.4 1223.2 1234.2 1235.6 1245.3 25530.7 26031.0 26857.9 27022.0 29098.3 43545.3 43762.6 44072.3 44106.3 44110.8 240672.0 241385.0 242248.0 242337.0 242755.0 29632.6 30073.2 43045.8 44051.3 44272.8 39420.8 45467.8 46953.3 47308.3 47457.3 33794.3 34006.0 34399.9 34655.5 34980.3 34066.3 34155.7 34349.7 34642.5 34693.5 33535.2 34128.8 34331.8 34372.8 34389.5 29586.6 30278.8 30455.0 30690.8 30890.0 21836.8 21959.5 22042.7 22071.1 22078.8 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,730 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24537.60 Median:234571.07 stddev:71479.21 (30.5%) stddev-sans-first:71656.61 11:36:30 INFO - 2015-12-15 11:36:30,731 DEBUG : BROWSER_OUTPUT: Values: 330.2 334.7 337.9 339.5 340.9 12676.0 13090.3 14964.6 15374.4 16097.9 12326.9 13943.4 14570.9 15064.5 15074.7 4311.7 4514.3 4639.8 4649.2 5086.9 5041.3 5081.1 5088.1 5090.7 5092.1 4571.8 4630.2 5055.2 5059.0 5061.0 4631.8 4655.5 4661.1 4671.3 4672.7 4515.3 4516.9 4517.0 4519.6 4520.0 18213.3 18440.6 18697.6 18736.9 18842.3 1751.0 1774.1 1808.5 1865.9 1974.7 8896.5 9154.8 9315.1 9735.0 12659.8 1733.6 1749.5 1750.1 1815.2 1858.5 53425.0 54700.0 54798.2 57960.7 57990.7 9976.4 10021.5 10032.4 10040.7 10076.4 10337.9 10610.3 11764.6 12748.2 12890.5 6204.3 6316.2 6331.3 6350.4 6386.1 5888.6 5914.0 5940.0 5961.1 6035.3 4184.9 4192.4 4197.9 4199.2 4219.5 1735.8 1738.6 1747.7 1751.8 1758.6 866.2 908.8 932.1 935.9 976.6 15520.7 15588.5 15606.6 15938.4 15958.1 821.4 853.6 865.0 904.8 914.1 7264.5 8697.7 8944.5 9052.6 9201.8 426072.0 437940.0 440666.0 440851.0 441801.0 53333.7 53461.7 71188.3 72761.6 73356.3 893.5 946.5 975.4 980.3 985.5 13643.5 13726.4 13768.3 13877.3 13990.9 29269.6 29989.3 30317.0 31565.4 33590.7 43070.1 43079.8 43217.4 43670.1 45993.6 8574.1 8936.1 9016.1 9027.0 9034.1 10249.9 11478.0 15823.1 15910.4 16022.0 13029.3 13030.3 13427.3 13536.0 13771.4 13119.9 13199.3 13397.7 13458.7 13562.4 13066.2 13357.3 13459.3 13561.8 13757.8 8700.0 8797.4 8963.3 8996.8 9009.4 10957.6 13187.1 13296.1 13368.5 14030.4 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4826.38 Median:6011.17 stddev:2495.42 (41.5%) stddev-sans-first:2489.06 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: Values: 1391.1 1423.8 1425.5 1456.5 1518.4 5798.7 6940.1 7105.3 7127.8 7130.1 7044.8 7082.5 7134.9 7146.2 7160.6 1703.7 1752.6 2020.2 2050.5 2052.6 2002.4 2032.6 2035.0 2037.3 2043.3 1976.2 1985.4 1991.2 2055.3 2059.5 2001.7 2017.7 2040.4 2040.5 2041.3 2062.1 2065.5 2080.4 2080.8 2083.5 7068.4 7112.3 7135.0 7148.0 7162.2 3927.9 3987.3 4001.3 4006.8 4017.6 2630.1 2637.0 2678.7 2696.9 2723.0 821.5 833.3 855.5 877.6 880.3 8941.9 8973.0 8978.7 8983.2 8983.6 3633.9 3697.1 3735.5 3754.0 3761.3 7840.3 7861.4 7863.2 7864.6 7869.3 3998.3 4003.3 4027.9 4035.8 4037.3 3615.9 3657.4 3658.1 3660.6 3661.8 2875.4 2913.7 2916.3 3345.1 3437.5 979.9 1101.3 1102.0 1108.8 1123.4 888.6 895.7 928.5 929.4 929.8 6494.3 6537.2 6555.7 6558.2 6563.3 1005.0 1032.9 1033.6 1035.5 1046.7 5260.8 5306.6 5314.4 5316.1 5327.3 7901.7 8054.1 8059.5 8362.7 8378.5 7987.7 8068.0 8086.6 8092.7 8096.4 6636.1 6688.3 6692.8 6696.8 6723.2 6613.5 6665.9 6669.5 6671.9 6673.5 7492.6 7525.0 7544.5 7611.2 7632.7 7637.9 7784.4 7792.1 7801.5 7936.4 6207.2 6252.5 6289.7 6290.8 6302.9 5655.9 6609.4 6616.7 6774.4 6802.3 5605.9 6118.2 6182.9 6301.7 6309.7 6048.7 6064.7 6137.9 6149.9 6179.3 5969.6 6003.3 6004.9 6008.4 6013.9 5547.1 5552.3 5760.4 5764.7 5774.8 5875.9 5904.3 5909.7 5910.4 5911.3 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4619.60 Median:5325.63 stddev:1387.66 (26.1%) stddev-sans-first:1352.83 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: Values: 282.4 285.1 288.4 288.8 294.6 4941.8 5126.5 5295.1 5356.4 5361.3 5192.6 5318.7 5323.7 5327.5 5332.8 4151.3 4160.8 4165.6 4165.6 4169.6 3907.7 3971.2 4031.0 4152.8 4170.0 4018.0 4024.5 4040.5 4052.5 4055.6 4013.6 4014.6 4016.9 4018.5 4031.3 3527.8 3529.6 3534.5 3536.3 3539.6 5023.1 5032.0 5032.6 5034.4 5036.6 4532.8 4647.2 4655.8 4657.9 4666.9 5556.0 5567.3 5568.9 5574.1 5580.9 3538.6 3620.0 3709.2 3825.8 3825.8 5719.3 5866.3 5871.6 5890.4 5890.6 3907.2 3909.7 3914.5 3915.4 3915.8 3957.8 3962.6 3964.7 3965.2 3968.1 4437.6 4595.9 4607.8 4610.9 4618.2 5591.1 5602.4 5610.0 5611.5 5613.4 1381.2 1398.6 1399.7 1399.9 1400.6 925.2 932.4 933.3 941.0 943.7 4899.9 4901.0 4903.0 4916.3 4921.1 5822.7 5823.4 5824.7 5825.3 5825.8 4903.8 4915.2 4918.0 4919.7 4919.7 3045.3 3102.7 3133.9 3141.1 3149.2 5540.2 5552.1 5553.5 5558.3 5558.4 6026.1 6027.9 6028.2 6038.3 6039.5 5537.1 5546.3 5546.9 5549.8 5550.7 5713.4 5831.6 5864.7 5874.2 5878.0 5420.9 5626.3 5708.3 5716.3 5717.4 5354.4 5490.7 5524.4 5530.1 5543.3 3888.2 3911.4 3913.9 3918.4 3919.7 5830.7 5844.1 5849.0 5859.9 5860.9 5418.9 5591.1 5606.2 5607.7 5645.2 5629.1 5633.6 5637.2 5638.4 5647.4 5514.2 5514.2 5519.9 5521.5 5524.0 5551.6 5673.9 5675.7 5679.7 5680.5 5519.9 5534.1 5541.3 5542.7 5550.1 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: 11:36:30 INFO - 2015-12-15 11:36:30,732 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11912.62 Median:49508.50 stddev:13607.37 (27.5%) stddev-sans-first:13619.74 11:36:30 INFO - 2015-12-15 11:36:30,734 DEBUG : BROWSER_OUTPUT: Values: 755.3 759.9 780.1 785.8 791.7 11441.7 11689.1 11694.7 11716.6 11751.0 12820.2 12890.2 12901.0 12920.1 12934.1 618.7 626.2 775.6 779.6 793.2 781.9 783.3 784.4 788.6 789.0 766.8 805.4 818.1 818.6 821.7 645.2 655.2 798.7 813.9 814.1 603.4 607.9 608.2 609.2 609.4 11075.3 11089.5 11105.3 11121.1 11123.8 10410.8 10417.9 10783.7 10843.1 11266.8 8605.2 8607.2 8685.8 8954.6 9279.4 3106.6 3184.0 3193.9 3202.1 3250.7 38359.6 38878.2 39213.8 39221.8 39394.6 8487.7 8968.2 9305.5 9540.2 9656.8 15590.4 15735.0 15780.7 15796.2 15834.6 5735.0 5812.2 5928.7 6157.0 6239.4 3400.3 3472.4 3483.9 3534.1 3541.6 2562.9 2576.0 2593.7 2603.1 2607.1 466.4 482.5 489.7 490.5 491.1 473.5 521.8 537.3 557.3 565.6 7227.5 7248.9 7367.5 7395.4 7411.3 486.7 527.5 563.5 574.2 578.4 3390.5 3437.1 3544.4 3550.9 3556.6 48701.3 49333.0 49479.5 49537.5 49602.8 43478.6 43911.0 44174.3 44329.6 44477.0 39690.6 40167.4 40523.6 40689.8 40971.2 7459.7 7586.0 7713.5 7740.0 7753.5 29820.4 30359.8 30770.2 30924.2 30979.4 37413.6 37619.4 38699.8 39039.8 39367.8 9044.5 9286.7 9331.3 9936.7 10050.7 10500.0 10785.4 10876.1 10994.8 11098.9 9897.8 9991.4 10218.9 10411.1 10669.5 8789.7 8836.7 8957.7 8959.6 9172.3 8208.0 9797.4 9934.4 10495.2 10592.8 8758.8 8833.8 8983.2 9332.2 9374.7 8180.4 8561.6 8725.7 9069.0 9097.8 11:36:30 INFO - 2015-12-15 11:36:30,734 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:36:30 INFO - 2015-12-15 11:36:30,734 DEBUG : BROWSER_OUTPUT: 11:36:31 INFO - 2015-12-15 11:36:31,448 INFO : Browser exited with error code: 0 11:36:31 INFO - 2015-12-15 11:36:31,465 INFO : Completed test dromaeo_css (00:18:37) 11:36:31 INFO - 2015-12-15 11:36:31,465 INFO : Starting test kraken 11:36:31 INFO - 2015-12-15 11:36:31,465 DEBUG : operating with platform_type : linux_ 11:36:31 INFO - 2015-12-15 11:36:31,465 INFO : Initialising browser for kraken test... 11:36:31 INFO - 2015-12-15 11:36:31,471 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xUZQ2/profile http://localhost:42770/getInfo.html 11:36:35 INFO - 2015-12-15 11:36:35,890 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:36:35 INFO - 2015-12-15 11:36:35,890 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:36:35 INFO - 2015-12-15 11:36:35,890 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:36:35 INFO - 2015-12-15 11:36:35,890 DEBUG : BROWSER_OUTPUT: __metrics 11:36:35 INFO - 2015-12-15 11:36:35,998 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] 11:36:36 INFO - 2015-12-15 11:36:36,062 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] 11:36:37 INFO - 2015-12-15 11:36:37,292 INFO : Browser initialized. 11:36:37 INFO - 2015-12-15 11:36:37,292 INFO : Running cycle 1/1 for kraken test... 11:36:37 INFO - 2015-12-15 11:36:37,292 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xUZQ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:36:49 INFO - 2015-12-15 11:36:49,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 143695872 11:36:49 INFO - 2015-12-15 11:36:49,315 DEBUG : BROWSER_OUTPUT: 11:36:51 INFO - 2015-12-15 11:36:51,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:52 INFO - 2015-12-15 11:36:52,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 180281344 11:36:52 INFO - 2015-12-15 11:36:52,538 DEBUG : BROWSER_OUTPUT: 11:36:55 INFO - 2015-12-15 11:36:55,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-dft) 11:36:55 INFO - 2015-12-15 11:36:55,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 168894464 11:36:55 INFO - 2015-12-15 11:36:55,832 DEBUG : BROWSER_OUTPUT: 11:36:58 INFO - 2015-12-15 11:36:58,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-fft) 11:36:59 INFO - 2015-12-15 11:36:59,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 153055232 11:36:59 INFO - 2015-12-15 11:36:59,434 DEBUG : BROWSER_OUTPUT: 11:37:01 INFO - 2015-12-15 11:37:01,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-oscillator) 11:37:02 INFO - 2015-12-15 11:37:02,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 155267072 11:37:02 INFO - 2015-12-15 11:37:02,047 DEBUG : BROWSER_OUTPUT: 11:37:04 INFO - 2015-12-15 11:37:04,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:04 INFO - 2015-12-15 11:37:04,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 157016064 11:37:04 INFO - 2015-12-15 11:37:04,907 DEBUG : BROWSER_OUTPUT: 11:37:07 INFO - 2015-12-15 11:37:07,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:08 INFO - 2015-12-15 11:37:08,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 158748672 11:37:08 INFO - 2015-12-15 11:37:08,440 DEBUG : BROWSER_OUTPUT: 11:37:11 INFO - 2015-12-15 11:37:11,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:12 INFO - 2015-12-15 11:37:12,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 158998528 11:37:12 INFO - 2015-12-15 11:37:12,434 DEBUG : BROWSER_OUTPUT: 11:37:15 INFO - 2015-12-15 11:37:15,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42770/tests/kraken/driver.html?testName=json-parse-financial) 11:37:15 INFO - 2015-12-15 11:37:15,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 158208000 11:37:15 INFO - 2015-12-15 11:37:15,888 DEBUG : BROWSER_OUTPUT: 11:37:17 INFO - 2015-12-15 11:37:17,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:18 INFO - 2015-12-15 11:37:18,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 165855232 11:37:18 INFO - 2015-12-15 11:37:18,234 DEBUG : BROWSER_OUTPUT: 11:37:20 INFO - 2015-12-15 11:37:20,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:20 INFO - 2015-12-15 11:37:20,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 165498880 11:37:20 INFO - 2015-12-15 11:37:20,722 DEBUG : BROWSER_OUTPUT: 11:37:22 INFO - 2015-12-15 11:37:22,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:23 INFO - 2015-12-15 11:37:23,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 178327552 11:37:23 INFO - 2015-12-15 11:37:23,428 DEBUG : BROWSER_OUTPUT: 11:37:25 INFO - 2015-12-15 11:37:25,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:26 INFO - 2015-12-15 11:37:26,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 184016896 11:37:26 INFO - 2015-12-15 11:37:26,549 DEBUG : BROWSER_OUTPUT: 11:37:29 INFO - 2015-12-15 11:37:29,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:29 INFO - 2015-12-15 11:37:29,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 179994624 11:37:29 INFO - 2015-12-15 11:37:29,727 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42770/tests/kraken/driver.html?testName=ai-astar) 11:37:31 INFO - 2015-12-15 11:37:31,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 237477888 11:37:31 INFO - 2015-12-15 11:37:31,731 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,734 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:37:31 INFO - 2015-12-15 11:37:31,735 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:37:31 INFO - 2015-12-15 11:37:31,735 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:37:31 INFO - 2015-12-15 11:37:31,735 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:37:31 INFO - 2015-12-15 11:37:31,735 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;112;114;112;102;111;111;112 11:37:31 INFO - 2015-12-15 11:37:31,735 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;135;152;170;130;153;154;137;174;130 11:37:31 INFO - 2015-12-15 11:37:31,736 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;159;162;163;161;161;163;163;162 11:37:31 INFO - 2015-12-15 11:37:31,736 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;92;91;72;72;72;113;88;72 11:37:31 INFO - 2015-12-15 11:37:31,736 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;134;95;106;96;136;95;95;132 11:37:31 INFO - 2015-12-15 11:37:31,736 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;111;111;109;109;110;109 11:37:31 INFO - 2015-12-15 11:37:31,736 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;146;147;146;147;146;146;147 11:37:31 INFO - 2015-12-15 11:37:31,736 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;94;96;96;95;95;95 11:37:31 INFO - 2015-12-15 11:37:31,737 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;71;71;70;70;70;78;68;68 11:37:31 INFO - 2015-12-15 11:37:31,737 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;67;68;68;68;68;69;69;69 11:37:31 INFO - 2015-12-15 11:37:31,737 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;91;84;82;84;83;83;83;85;84 11:37:31 INFO - 2015-12-15 11:37:31,737 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;136;125;115;123;125;125;128;120;122 11:37:31 INFO - 2015-12-15 11:37:31,737 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;146;158;144;141;134;148;148;142;143 11:37:31 INFO - 2015-12-15 11:37:31,737 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;69;71;71;69;71;69;70;70 11:37:31 INFO - 2015-12-15 11:37:31,737 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:37:31 INFO - 2015-12-15 11:37:31,738 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:37:31 INFO - 2015-12-15 11:37:31,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 11:37:31 INFO - 2015-12-15 11:37:31,738 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:37:31 INFO - 2015-12-15 11:37:31,738 DEBUG : BROWSER_OUTPUT: __startTimestamp1450208251733__endTimestamp 11:37:31 INFO - 2015-12-15 11:37:31,738 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,742 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:37:31 INFO - 2015-12-15 11:37:31,742 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:37:31 INFO - 2015-12-15 11:37:31,742 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,742 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:3.71 11:37:31 INFO - 2015-12-15 11:37:31,744 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 112.0 114.0 112.0 102.0 111.0 111.0 112.0 11:37:31 INFO - 2015-12-15 11:37:31,744 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,744 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.50 stddev:15.84 (10.3%) stddev-sans-first:16.48 11:37:31 INFO - 2015-12-15 11:37:31,744 DEBUG : BROWSER_OUTPUT: Values: 158.0 135.0 152.0 170.0 130.0 153.0 154.0 137.0 174.0 130.0 11:37:31 INFO - 2015-12-15 11:37:31,744 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,744 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 11:37:31 INFO - 2015-12-15 11:37:31,744 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 159.0 162.0 163.0 161.0 161.0 163.0 163.0 162.0 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:72.50 stddev:13.98 (19.3%) stddev-sans-first:14.47 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 92.0 91.0 72.0 72.0 72.0 113.0 88.0 72.0 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.90 Median:95.00 stddev:18.35 (19.3%) stddev-sans-first:18.85 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 134.0 95.0 106.0 96.0 136.0 95.0 95.0 132.0 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 11:37:31 INFO - 2015-12-15 11:37:31,745 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 111.0 111.0 109.0 109.0 110.0 109.0 11:37:31 INFO - 2015-12-15 11:37:31,746 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,746 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:37:31 INFO - 2015-12-15 11:37:31,746 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 11:37:31 INFO - 2015-12-15 11:37:31,746 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,746 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:37:31 INFO - 2015-12-15 11:37:31,746 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 94.0 96.0 96.0 95.0 95.0 95.0 11:37:31 INFO - 2015-12-15 11:37:31,747 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,747 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.80 Median:71.00 stddev:2.78 (3.9%) stddev-sans-first:2.95 11:37:31 INFO - 2015-12-15 11:37:31,747 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 70.0 70.0 70.0 78.0 68.0 68.0 11:37:31 INFO - 2015-12-15 11:37:31,747 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,747 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 11:37:31 INFO - 2015-12-15 11:37:31,747 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.50 (3.0%) stddev-sans-first:2.65 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: Values: 84.0 91.0 84.0 82.0 84.0 83.0 83.0 83.0 85.0 84.0 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:125.00 stddev:5.67 (4.5%) stddev-sans-first:5.74 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: Values: 119.0 136.0 125.0 115.0 123.0 125.0 125.0 128.0 120.0 122.0 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:145.00 stddev:7.04 (4.9%) stddev-sans-first:6.51 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: Values: 134.0 146.0 158.0 144.0 141.0 134.0 148.0 148.0 142.0 143.0 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 71.0 71.0 69.0 71.0 69.0 70.0 70.0 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:37:31 INFO - 2015-12-15 11:37:31,748 DEBUG : BROWSER_OUTPUT: 11:37:32 INFO - 2015-12-15 11:37:32,616 INFO : Browser exited with error code: 0 11:37:32 INFO - 2015-12-15 11:37:32,671 INFO : Completed test kraken (00:01:01) 11:37:32 INFO - 2015-12-15 11:37:32,671 INFO : Starting test v8_7 11:37:32 INFO - 2015-12-15 11:37:32,672 DEBUG : operating with platform_type : linux_ 11:37:32 INFO - 2015-12-15 11:37:32,672 INFO : Initialising browser for v8_7 test... 11:37:32 INFO - 2015-12-15 11:37:32,678 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYFUol/profile http://localhost:42770/getInfo.html 11:37:37 INFO - 2015-12-15 11:37:37,391 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:37:37 INFO - 2015-12-15 11:37:37,391 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:37:37 INFO - 2015-12-15 11:37:37,391 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:37:37 INFO - 2015-12-15 11:37:37,391 DEBUG : BROWSER_OUTPUT: __metrics 11:37:37 INFO - 2015-12-15 11:37:37,520 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] 11:37:37 INFO - 2015-12-15 11:37:37,587 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] 11:37:37 INFO - 2015-12-15 11:37:37,946 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:37:38 INFO - 2015-12-15 11:37:38,649 INFO : Browser initialized. 11:37:38 INFO - 2015-12-15 11:37:38,649 INFO : Running cycle 1/1 for v8_7 test... 11:37:38 INFO - 2015-12-15 11:37:38,649 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYFUol/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:37:50 INFO - 2015-12-15 11:37:50,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 139821056 11:37:50 INFO - 2015-12-15 11:37:50,716 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42770/tests/v8_7/run.html (next: http://localhost:42770/tests/v8_7/run.html) 11:38:12 INFO - 2015-12-15 11:38:12,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 440446976 11:38:12 INFO - 2015-12-15 11:38:12,339 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,339 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:38:12 INFO - 2015-12-15 11:38:12,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:38:12 INFO - 2015-12-15 11:38:12,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:38:12 INFO - 2015-12-15 11:38:12,339 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:38:12 INFO - 2015-12-15 11:38:12,340 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 11:38:12 INFO - 2015-12-15 11:38:12,340 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.04651162790697 11:38:12 INFO - 2015-12-15 11:38:12,340 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 11:38:12 INFO - 2015-12-15 11:38:12,340 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 11:38:12 INFO - 2015-12-15 11:38:12,340 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 11:38:12 INFO - 2015-12-15 11:38:12,340 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 11:38:12 INFO - 2015-12-15 11:38:12,340 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 11:38:12 INFO - 2015-12-15 11:38:12,341 DEBUG : BROWSER_OUTPUT: |7;RegExp;27324.324324324323 11:38:12 INFO - 2015-12-15 11:38:12,341 DEBUG : BROWSER_OUTPUT: |8;Splay;602.4096385542168 11:38:12 INFO - 2015-12-15 11:38:12,341 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:38:12 INFO - 2015-12-15 11:38:12,341 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:38:12 INFO - 2015-12-15 11:38:12,341 DEBUG : BROWSER_OUTPUT: __startTimestamp1450208292338__endTimestamp 11:38:12 INFO - 2015-12-15 11:38:12,341 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,342 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:38:12 INFO - 2015-12-15 11:38:12,342 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:38:12 INFO - 2015-12-15 11:38:12,342 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,342 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,342 DEBUG : BROWSER_OUTPUT: Values: 165.8 11:38:12 INFO - 2015-12-15 11:38:12,342 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,343 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.05 Median:186.05 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,343 DEBUG : BROWSER_OUTPUT: Values: 186.0 11:38:12 INFO - 2015-12-15 11:38:12,343 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,343 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,343 DEBUG : BROWSER_OUTPUT: Values: 278.4 11:38:12 INFO - 2015-12-15 11:38:12,344 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,344 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,344 DEBUG : BROWSER_OUTPUT: Values: 5181.3 11:38:12 INFO - 2015-12-15 11:38:12,344 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,344 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,345 DEBUG : BROWSER_OUTPUT: Values: 1966.6 11:38:12 INFO - 2015-12-15 11:38:12,345 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,345 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,345 DEBUG : BROWSER_OUTPUT: Values: 787.4 11:38:12 INFO - 2015-12-15 11:38:12,345 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,345 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,346 DEBUG : BROWSER_OUTPUT: Values: 12256.1 11:38:12 INFO - 2015-12-15 11:38:12,346 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,346 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27324.32 Median:27324.32 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,346 DEBUG : BROWSER_OUTPUT: Values: 27324.3 11:38:12 INFO - 2015-12-15 11:38:12,346 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,347 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.41 Median:602.41 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,347 DEBUG : BROWSER_OUTPUT: Values: 602.4 11:38:12 INFO - 2015-12-15 11:38:12,347 DEBUG : BROWSER_OUTPUT: 11:38:12 INFO - 2015-12-15 11:38:12,347 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:38:12 INFO - 2015-12-15 11:38:12,347 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:38:12 INFO - 2015-12-15 11:38:12,347 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:38:12 INFO - 2015-12-15 11:38:12,347 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-12-15 11:38:13,208 INFO : Browser exited with error code: 0 11:38:13 INFO - 2015-12-15 11:38:13,220 INFO : Completed test v8_7 (00:00:40) 11:38:13 INFO - 2015-12-15 11:38:13,397 INFO : Completed test suite (00:20:19) 11:38:13 INFO - 2015-12-15 11:38:13,397 DEBUG : Working with test: dromaeo_css 11:38:13 INFO - 2015-12-15 11:38:13,397 DEBUG : Generating results file: dromaeo_css 11:38:13 INFO - 2015-12-15 11:38:13,399 DEBUG : Working with test: kraken 11:38:13 INFO - 2015-12-15 11:38:13,399 DEBUG : Generating results file: kraken 11:38:13 INFO - 2015-12-15 11:38:13,399 INFO : javascript benchmark 11:38:13 INFO - 2015-12-15 11:38:13,399 DEBUG : Working with test: v8_7 11:38:13 INFO - 2015-12-15 11:38:13,399 DEBUG : Generating results file: v8_7 11:38:13 INFO - 2015-12-15 11:38:13,400 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:13 INFO - 2015-12-15 11:38:13,450 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:38:13 INFO - 2015-12-15 11:38:13,450 DEBUG : process_Request line: dromaeo_css 6231.83 graph.html#tests=[[72,132,35]] 11:38:13 INFO - 2015-12-15 11:38:13,450 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:13 INFO - 2015-12-15 11:38:13,481 DEBUG : process_Request line: kraken 1523.10 graph.html#tests=[[232,132,35]] 11:38:13 INFO - 2015-12-15 11:38:13,482 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:13 INFO - 2015-12-15 11:38:13,509 DEBUG : process_Request line: v8_7 19803.70 graph.html#tests=[[230,132,35]] 11:38:13 INFO - 2015-12-15 11:38:13,510 INFO : javascript benchmark 11:38:13 INFO - 2015-12-15 11:38:13,514 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2631.1580294305822, 2728.017913551121, 2732.4671689020624, 2737.739914708102, 2743.62961000265, 4438.622717069053, 4586.793594288257, 4708.176069187892, 4736.194846876031, 4742.881427964298, 4600.769961501928, 4641.350210970467, 4718.150732868083, 4726.527347265281, 4744.4069491313585, 4243.257429949762, 4276.914461710764, 4286.592773686511, 4325.4593175853015, 4342.50061242958, 4302.913941721164, 4401.955980440202, 4445.755483448409, 4457.153140903234, 4472.955270447303, 4140.254754144253, 4249.32010878258, 4255.97872010638, 4377.912441751163, 4433.357163211316, 4380.67144964129, 4386.605205531518, 4396.0, 4402.0, 4424.756638384888, 4332.913341733148, 4338.1540599583095, 4346.434963454731, 4393.626541743955, 4403.22943484892, 4399.252127138394, 4500.617447516932, 4513.368128462018, 4664.2189619281135, 4683.180443422388, 4982.451930287665, 5076.720780357079, 5091.872703182413, 5116.718580478072, 5117.078925793356, 5050.39395272566, 5073.264376665363, 5100.642954993152, 5104.106781313292, 5110.386753589556, 4459.643228541709, 4738.64460165489, 4742.810287588527, 4743.241081426955, 4786.425628924551, 5064.11378008847, 5075.289459475676, 5085.440601533828, 5137.0, 5184.0, 4929.852104436873, 4932.704037757674, 4935.925961110514, 4937.086638971802, 4976.825811096594, 4837.177679794443, 5013.248012798036, 5014.072396606566, 5027.673201241908, 5029.924551131736, 4863.0, 4868.367112275452, 4870.025994801054, 4948.480409557017, 4979.775910084055, 4982.227754698028, 4982.9252561211615, 4985.0, 4991.550760431579, 5025.296458495814, 3951.0, 4161.271777438936, 4163.2298024864895, 4165.291900376943, 4204.201201771715, 3564.7682900611376, 3570.732195085379, 3614.6385361464168, 3655.6344365563764, 3710.7588006779474, 4324.956750432519, 4326.610605045561, 4334.544872788375, 4370.300751879684, 4372.759498227564, 4754.381930349033, 5055.7219352935945, 5056.140456122468, 5060.165072762953, 5060.5951523878, 4235.174141042467, 4252.425922500484, 4253.595908388698, 4339.717918335361, 4368.060866913629, 4478.708883922534, 4482.282834746425, 4491.528389519053, 4493.573110554492, 4522.615577675869, 4521.909561808811, 4802.73584952831, 4804.35141255926, 4817.566419022305, 4841.636877234221, 4955.628327875352, 4972.602191824573, 4976.2038073908, 5045.672031317952, 5109.9233511498105, 4752.6197904168275, 4785.013879735486, 4790.065937142223, 4790.688605240648, 4836.830710925101, 4707.317438971261, 4978.352814134139, 4979.850604481871, 4987.501249874984, 5030.270610761346, 4882.389701287339, 4942.4316203637045, 4955.355803745634, 4971.9254211186135, 5021.748912554431, 4885.193942999507, 4895.094407534618, 4908.901821963612, 4919.926201107058, 4952.628552858478, 4711.882202944954, 4907.312976183266, 4910.116179087656, 4914.36113305268, 4957.529034741694, 4643.558861908114, 4703.717776933395, 4709.458412282632, 4720.622350212044, 4750.097481478508, 4916.213405855046, 4929.334539837219, 4930.334404855442, 4931.7040977541465, 4961.206207006861, 4593.862184134481, 4786.377770889762, 4833.564979151894, 4834.758262086952, 4840.2255639097575], "unit": "score", "name": "dojo.html", "value": 4597.656369059735}, {"lowerIsBetter": false, "replicates": [534.1280193466691, 575.6459777237001, 588.5703436491361, 596.7612954818073, 600.1028462448637, 27387.452250954968, 36416.0, 37403.0, 37426.43860342097, 37432.0, 39975.200495990066, 40464.0, 40481.0, 40556.59443405565, 40570.39144412836, 6972.477064220178, 7048.964755176217, 7050.224475307712, 7804.8048798780055, 7959.602019899011, 7130.215676275606, 7226.710931562731, 10136.378179491283, 10312.948435257813, 10328.535215915264, 9965.103140717334, 10057.547410366551, 10060.597576096947, 10070.446125463097, 10070.949645251763, 9918.504074796232, 9955.701328960144, 10018.398896066223, 10030.197584193247, 10060.748481287954, 7194.280571942816, 7388.593627350494, 7391.815204619874, 7395.334419902235, 10027.849582256273, 36931.522739090404, 37113.62886371129, 37122.4431633523, 37160.81419592885, 37414.62585374166, 2914.8396838173894, 2949.0857834071508, 2959.881604735808, 3137.0, 3433.3819912415756, 27214.72785272142, 28294.858525707445, 28421.71578284232, 28612.284692882637, 29319.0, 2623.8819253133465, 2625.7111717711036, 2720.455908818244, 2736.53478908586, 2778.333200031998, 212409.0, 214458.0, 214784.99999999843, 214913.0, 214967.0, 56869.0, 56928.43071569314, 57249.71375143098, 57334.97982711838, 57345.71327143421, 59425.40574594285, 59786.0, 60281.0, 60306.69846650738, 60307.0, 11647.41762911851, 12004.939975300067, 12082.939585302192, 12087.093467989936, 12099.213551119148, 9290.907090929139, 9346.15884570392, 9357.672481463116, 9381.0618938107, 9392.765180870532, 18881.69441442146, 19439.80560194408, 19592.669246228175, 19595.412137635893, 19597.31409400664, 7484.625768711543, 7635.427342949301, 7747.147813740484, 7806.960965195138, 7830.138684744674, 890.8930928288518, 906.8186362727349, 982.5725809272989, 996.9202463802878, 1050.5535147562255, 26492.867535662197, 30510.69489305123, 31420.214494637818, 31490.842545787124, 32007.839960800513, 868.6568805321863, 941.4868896451451, 968.8449848024283, 985.881694196701, 1033.0857191385678, 13454.798178027337, 15083.622909427351, 15614.609634758996, 16247.59381015484, 16663.083530405944, 315108.0, 319830.0, 320009.0, 320095.0, 320699.0, 42579.57420425818, 43347.0, 48844.511554884, 49643.25535116976, 49860.25209621859, 1151.366748288438, 1223.2477026628737, 1234.2409418207737, 1235.6416639174538, 1245.3275231375137, 25530.74469255358, 26031.0, 26857.86571067132, 27022.0, 29098.27254318659, 43545.34681979836, 43762.56237437585, 44072.33891491566, 44106.33840492331, 44110.794460276215, 240672.0, 241385.0, 242248.0, 242337.0, 242755.0, 29632.55551166691, 30073.248168795955, 43045.784771075945, 44051.33922991093, 44272.77863610661, 39420.80289598534, 45467.772661136485, 46953.2957005652, 47308.29037564508, 47457.28814067861, 33794.3241135171, 34006.0, 34399.856824689465, 34655.480167796995, 34980.30039399249, 34066.318673625894, 34155.65844341525, 34349.65650343464, 34642.48036279407, 34693.47959780555, 33535.16162095967, 34128.829355853064, 34331.828340858134, 34372.82813586016, 34389.48415773815, 29586.556201656564, 30278.84860575771, 30455.0, 30690.84654576713, 30890.0, 21836.781632183476, 21959.451013724785, 22042.669359959935, 22071.11715531425, 22078.779212208316], "unit": "score", "name": "ext.html", "value": 17439.537891387405}, {"lowerIsBetter": false, "replicates": [330.15645026956133, 334.6970991252916, 337.91214284286076, 339.5161894300622, 340.9164754635114, 12676.0, 13090.345482725874, 14964.625884352883, 15374.385024599016, 16097.919510402431, 12326.938365308184, 13943.37254823533, 14570.854291457083, 15064.548063558083, 15074.6985060299, 4311.749592618137, 4514.322851572258, 4639.8376056838015, 4649.209634362167, 5086.872828179306, 5041.319421878036, 5081.136206844827, 5088.058709138802, 5090.720010399426, 5092.083424983502, 4571.839985600504, 4630.236011058171, 5055.165897626887, 5059.0, 5060.974695126519, 4631.791569379369, 4655.4878963314, 4661.137689527448, 4671.252599584084, 4672.696274742165, 4515.345274935116, 4516.932246016312, 4516.954830451719, 4519.615832654228, 4519.954800451987, 18213.27146914122, 18440.63118737631, 18697.626047478974, 18736.90631546847, 18842.3405180818, 1750.9824901751074, 1774.0774797105562, 1808.4665023818006, 1865.9440216793519, 1974.7136665183468, 8896.510691911943, 9154.81690366189, 9315.115064068903, 9735.0, 12659.810102848465, 1733.644602856424, 1749.4664127441126, 1750.0549703160277, 1815.2013114229696, 1858.4982054845116, 53425.0, 54700.0, 54798.178027329624, 57960.71019644917, 57990.710046449916, 9976.401415915068, 10021.498925053718, 10032.448215348226, 10040.69877903664, 10076.445795481319, 10337.896621033844, 10610.310329828691, 11764.58823941158, 12748.235105893677, 12890.548830790878, 6204.255489341308, 6316.242050953915, 6331.303556608769, 6350.396712312323, 6386.137871387304, 5888.558358123158, 5913.970430147821, 5939.970300148558, 5961.135635332939, 6035.275766907999, 4184.937225941613, 4192.434021407132, 4197.9370309445385, 4199.2441360555395, 4219.451471308772, 1735.826417358254, 1738.6001219719535, 1747.6592064547544, 1751.842334189929, 1758.6043140293586, 866.151171851589, 908.8273228086642, 932.1470854168496, 935.9064093590723, 976.5751897924425, 15520.689586208213, 15588.454404095803, 15606.609834754221, 15938.442154524537, 15958.1223032732, 821.3921697943479, 853.6158728572167, 865.0398058155442, 904.755715956688, 914.0996118822954, 7264.455165862581, 8697.652093916298, 8944.5080520572, 9052.592633331516, 9201.815963680823, 426072.0, 437940.0, 440666.0, 440851.0, 441801.0, 53333.7333313331, 53461.73269133629, 71188.28811711817, 72761.6361918187, 73356.26643733494, 893.4817805672694, 946.4557879219338, 975.3513913247752, 980.3187533380287, 985.5170966226641, 13643.454261829416, 13726.382312795748, 13768.311584420539, 13877.306134693426, 13990.860091398956, 29269.560956585243, 29989.250268743457, 30317.0, 31565.368692626478, 33590.664093358755, 43070.138597228506, 43079.7846010768, 43217.35173972456, 43670.126597467235, 45993.620191394315, 8574.09971952936, 8936.106389361012, 9016.143466370684, 9027.0, 9034.051424600322, 10249.897501024894, 11478.0, 15823.050616963019, 15910.443134490237, 16022.038677679377, 13029.283389413673, 13030.292432138118, 13427.26150061756, 13536.0, 13771.38028788727, 13119.934400327937, 13199.34003299812, 13397.717559197668, 13458.730825383633, 13562.38969246406, 13066.216027038028, 13357.265350405822, 13459.327033648475, 13561.796573051215, 13757.79363309571, 8700.0, 8797.428167169113, 8963.327750418614, 8996.775080623036, 9009.369344145847, 10957.561697532328, 13187.142835715647, 13296.135751176529, 13368.465261389825, 14030.438782448588], "unit": "score", "name": "jquery.html", "value": 8014.8982712274465}, {"lowerIsBetter": false, "replicates": [1391.0594720365084, 1423.7508436023693, 1425.5438259756875, 1456.526628845625, 1518.422999260281, 5798.739056742446, 6940.13248343957, 7105.289471052899, 7127.7505287314825, 7130.108736407949, 7044.753433629824, 7082.50422470426, 7134.892976605355, 7146.249643787405, 7160.641967901597, 1703.6881601167095, 1752.5618595351161, 2020.2020202020194, 2050.5078781092507, 2052.6100040992237, 2002.3892712722613, 2032.552838375555, 2035.0435295411132, 2037.3073155127254, 2043.2950632031925, 1976.21939333963, 1985.354759703095, 1991.233375150563, 2055.2806517718827, 2059.4645392198063, 2001.7497812773404, 2017.6569983102834, 2040.4184807329839, 2040.540878302385, 2041.2855500574753, 2062.0720675695998, 2065.4629796252934, 2080.3966849613594, 2080.771115177329, 2083.4687154775434, 7068.36384725372, 7112.25321341262, 7135.0, 7147.964260178665, 7162.176349719797, 3927.9018024549327, 3987.342088555385, 4001.279769641463, 4006.83972641094, 4017.5982401759884, 2630.0663264541004, 2637.02430100862, 2678.665166854143, 2696.892124315025, 2722.986385068062, 821.4578378270313, 833.2500749325595, 855.4653341661461, 877.6313948141732, 880.2869675562814, 8941.865872011926, 8972.955135224413, 8978.685745998859, 8983.191512763882, 8983.595738191732, 3633.927321453556, 3697.0757310672334, 3735.533058367704, 3754.005188624962, 3761.304158730589, 7840.3335716464735, 7861.4103942204565, 7863.213678632091, 7864.606769661494, 7869.291763741291, 3998.300297447935, 4003.259397011562, 4027.9194416111513, 4035.7982100894837, 4037.313656678372, 3615.909602259912, 3657.3782456982376, 3658.122050707811, 3660.5607327120383, 3661.7986010769664, 2875.3961668049524, 2913.6503619565788, 2916.2855100500515, 3345.1302661308237, 3437.5359326491102, 979.8628192053118, 1101.3446999035561, 1101.9889801101885, 1108.7505311305054, 1123.3652986062848, 888.6001299415288, 895.6999405199201, 928.5218112671979, 929.3958926697566, 929.8047410043831, 6494.285628580852, 6537.150170477903, 6555.737770489222, 6558.1802274715665, 6563.278039415661, 1004.9799004019878, 1032.9276950613535, 1033.565902321027, 1035.5081336365167, 1046.6650671785108, 5260.842174734764, 5306.628536002443, 5314.415414304423, 5316.149416093406, 5327.254184414185, 7901.683932642745, 8054.073781515201, 8059.476134051268, 8362.707305244408, 8378.455400398954, 7987.720429785046, 8068.0, 8086.595670216466, 8092.6762929482165, 8096.433249672584, 6636.104125943032, 6688.331166883273, 6692.799216023527, 6696.832579185462, 6723.159605049369, 6613.5370524062855, 6665.933340666531, 6669.533132680665, 6671.8999215010845, 6673.466122710269, 7492.628317257365, 7525.0, 7544.509606875536, 7611.162772094955, 7632.694692212472, 7637.885431718418, 7784.377249820114, 7792.064952205772, 7801.531908085533, 7936.444448888522, 6207.16203312547, 6252.468540174136, 6289.6540690260645, 6290.779822706183, 6302.905456418249, 5655.886882262414, 6609.405153536205, 6616.735330586916, 6774.356436138559, 6802.251752307341, 5605.859853503695, 6118.235220597426, 6182.907256391068, 6301.6534090625455, 6309.684515774101, 6048.667323297261, 6064.696765161812, 6137.877242455036, 6149.907751383644, 6179.258488981351, 5969.582129250911, 6003.339632640319, 6004.909926351021, 6008.399160083956, 6013.939860601338, 5547.057000310037, 5552.333719953632, 5760.366359700513, 5764.740586673526, 5774.769009239583, 5875.911861321998, 5904.261967254093, 5909.734061967308, 5910.408959104056, 5911.320198177093], "unit": "score", "name": "mootools.html", "value": 3961.6338387907035}, {"lowerIsBetter": false, "replicates": [282.444995583678, 285.0806150165716, 288.43610741001345, 288.8180446318819, 294.55081001472746, 4941.827036053739, 5126.461721519243, 5295.126304159814, 5356.410794812572, 5361.329833770784, 5192.584593232542, 5318.680879147254, 5323.707196104213, 5327.547158491533, 5332.813351532697, 4151.294279972397, 4160.8335666573375, 4165.56261592533, 4165.6250937415625, 4169.56219596941, 3907.7264591478606, 3971.2057588482276, 4030.9596904030877, 4152.774931395245, 4170.040890595165, 4017.959820401788, 4024.5170579530495, 4040.5353384360733, 4052.5136983562015, 4055.5944405559503, 4013.578574249691, 4014.6386825185728, 4016.9196616067807, 4018.4976877890263, 4031.2743706132883, 3527.770694904849, 3529.5588051493564, 3534.452159915217, 3536.2927414516944, 3539.610642829287, 5023.14606516893, 5032.043911656773, 5032.62255330848, 5034.421041580192, 5036.647434679574, 4532.750698711569, 4647.209974304343, 4655.837045703418, 4657.906841863178, 4666.883327916796, 5556.027695153372, 5567.3040869891265, 5568.916466253009, 5574.080276754331, 5580.944190558083, 3538.575370955476, 3619.981900090509, 3709.2210635766523, 3825.7704537727827, 3825.827837747308, 5719.342275638313, 5866.266716660418, 5871.5596330274975, 5890.381509941437, 5890.558208134365, 3907.2185562886966, 3909.706771992112, 3914.549826769901, 3915.353966595537, 3915.784631845219, 3957.8021098944937, 3962.583928687504, 3964.682825373963, 3965.246603145451, 3968.0873399118364, 4437.600615944581, 4595.862124136282, 4607.769611519478, 4610.9308360374625, 4618.1918164321105, 5591.133374326986, 5602.38373778884, 5610.046292130348, 5611.466910643482, 5613.410591887875, 1381.205806661174, 1398.6153807702963, 1399.7200559888063, 1399.8950078744135, 1400.551823416497, 925.1997022575558, 932.3566738950103, 933.3373304953424, 941.0260380506144, 943.7263193673758, 4899.853004409802, 4900.975495122501, 4903.043906438282, 4916.287138364989, 4921.089598424303, 5822.737976791054, 5823.388544202882, 5824.6796426196115, 5825.300963884361, 5825.76696932118, 4903.828366007173, 4915.238138088602, 4918.040982008474, 4919.680220785637, 4919.680220785637, 3045.25391279138, 3102.7362674172496, 3133.874645014174, 3141.1361875483967, 3149.2284390324057, 5540.196671482693, 5552.083906155439, 5553.500184983371, 5558.305211848519, 5558.388577256498, 6026.096085587197, 6027.8794424111275, 6028.156058151862, 6038.275406951194, 6039.486643635252, 5537.086380747131, 5546.306711661043, 5546.91679624806, 5549.833504994856, 5550.69471179089, 5713.371529131875, 5831.591788574759, 5864.67744274069, 5874.206982057368, 5877.970610146922, 5420.891582168256, 5626.2967129108865, 5708.315002199763, 5716.256886604715, 5717.3996730342715, 5354.3842458117815, 5490.6980116094, 5524.447555244444, 5530.059889818821, 5543.279373681396, 3888.183481468923, 3911.3741801311653, 3913.8630147944687, 3918.4318273850704, 3919.6864250859294, 5830.737616807169, 5844.094165404369, 5848.976429124971, 5859.882802343844, 5860.912086318794, 5418.916216756743, 5591.133374326986, 5606.215129881738, 5607.747651355618, 5645.1532270159805, 5629.127485239795, 5633.577481688808, 5637.210790489253, 5638.407967163389, 5647.3787883333625, 5514.172874068921, 5514.2004409359615, 5519.862003449946, 5521.47545983147, 5524.0, 5551.639143455824, 5673.858153546194, 5675.659460432387, 5679.6876171810945, 5680.545556355564, 5519.8896022080135, 5534.059209934401, 5541.307336582927, 5542.695151766691, 5550.139728342114], "unit": "score", "name": "prototype.html", "value": 4166.498006557221}, {"lowerIsBetter": false, "replicates": [755.3013462547146, 759.9316061554463, 780.1340512031644, 785.8428314337131, 791.7347688524344, 11441.713957151065, 11689.12331575133, 11694.707632309197, 11716.589919352835, 11751.0, 12820.166689165198, 12890.226586404822, 12901.0, 12920.095593308472, 12934.094613377067, 618.7401291457599, 626.2485017978421, 775.5966897213445, 779.555653277632, 793.1790596732383, 781.9335356494705, 783.2950344689768, 784.4234487651571, 788.5702292250709, 788.9881651775228, 766.7929658992069, 805.3798575097171, 818.0919179710517, 818.6275244763648, 821.7247222180577, 645.1580687203198, 655.1613934164277, 798.6645608844241, 813.9430239883211, 814.1288820961573, 603.3574243430733, 607.8753855459664, 608.1516284782704, 609.1806520230283, 609.4332270987979, 11075.335479871233, 11089.500972456259, 11105.333679979227, 11121.110311175087, 11123.833142502868, 10410.79178416435, 10417.895821041768, 10783.676489705322, 10843.07833834125, 11266.774664506745, 8605.225529702357, 8607.182317679873, 8685.826283474358, 8954.641814327419, 9279.443233406017, 3106.6427360853563, 3183.9522407163913, 3193.8722451101926, 3202.0553936588763, 3250.658680838525, 38359.616403835884, 38878.22243555113, 39213.803930980444, 39221.803890980365, 39394.60605393938, 8487.702930397407, 8968.23769979546, 9305.53472326381, 9540.189083927806, 9656.75858103539, 15590.376384944702, 15735.0, 15780.68438631244, 15796.210189490479, 15834.60413489672, 5735.0, 5812.186293918855, 5928.673922934194, 6157.0, 6239.376062393724, 3400.3199360128074, 3472.444408894615, 3483.89548313551, 3534.081138903852, 3541.6281290464644, 2562.93592660185, 2576.0, 2593.6887573490926, 2603.075908052652, 2607.087519368244, 466.4402716739926, 482.4644644444664, 489.71351759220545, 490.4604934571942, 491.13069866336383, 473.4555261449292, 521.8356217791384, 537.3471232452589, 557.3033707865169, 565.6295126692023, 7227.530210536298, 7248.855022899618, 7367.521111127867, 7395.445341599401, 7411.2588741125455, 486.7126450538306, 527.5015110720409, 563.5463451921242, 574.1731906055267, 578.4244676546863, 3390.4744764561533, 3437.0719905625842, 3544.379733546619, 3550.8579656813954, 3556.608773034964, 48701.26948095782, 49333.0, 49479.50520494821, 49537.50462495329, 49602.75198624056, 43478.56521434745, 43911.0, 44174.33738493925, 44329.55670443319, 44477.0, 39690.60309396869, 40167.397489037685, 40523.59476405257, 40689.796551017054, 40971.1805763883, 7459.664315105942, 7585.962070189614, 7713.498622589514, 7739.961300193463, 7753.534787912743, 29820.403591928472, 30359.848200758854, 30770.230744231572, 30924.22689432782, 30979.380412392078, 37413.625863741014, 37619.43570846385, 38699.806500967316, 39039.80480097581, 39367.80316098401, 9044.457332560067, 9286.72139835806, 9331.346805723535, 9936.701898942754, 10050.748731281776, 10500.0, 10785.406802625617, 10876.129909607054, 10994.780104398027, 11098.944505277423, 9897.802043959224, 9991.400515968775, 10218.948905255425, 10411.11505522039, 10669.46652667348, 8789.736307910773, 8836.690715824916, 8957.731268061969, 8959.596818143329, 9172.266218702622, 8208.0, 9797.412155270707, 9934.354266972623, 10495.212859035755, 10592.788144237225, 8758.824823503366, 8833.823323533365, 8983.236424903695, 9332.16010559053, 9374.718758437259, 8180.386471014816, 8561.57192140403, 8725.65097396097, 9069.0, 9097.818043638958], "unit": "score", "name": "yui.html", "value": 5521.177271958796}], "name": "dromaeo_css", "value": 6231.8324615751535}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 114.0, 112.0, 102.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [158.0, 135.0, 152.0, 170.0, 130.0, 153.0, 154.0, 137.0, 174.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 162.0, 163.0, 161.0, 161.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 92.0, 91.0, 72.0, 72.0, 72.0, 113.0, 88.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 134.0, 95.0, 106.0, 96.0, 136.0, 95.0, 95.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 111.0, 111.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 70.0, 70.0, 70.0, 78.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 91.0, 84.0, 82.0, 84.0, 83.0, 83.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [119.0, 136.0, 125.0, 115.0, 123.0, 125.0, 125.0, 128.0, 120.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [134.0, 146.0, 158.0, 144.0, 141.0, 134.0, 148.0, 148.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 71.0, 71.0, 69.0, 71.0, 69.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1523.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [186.04651162790697], "unit": "score", "name": "DeltaBlue", "value": 355.38425000000007}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [27324.324324324323], "unit": "score", "name": "RegExp", "value": 33.33970820969339}, {"lowerIsBetter": false, "replicates": [602.4096385542168], "unit": "score", "name": "Splay", "value": 135.27506}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19803.69565149497}]} 11:38:13 INFO - RETURN: dromaeo_css: 6231.83 11:38:13 INFO - RETURN: kraken: 1523.10 11:38:13 INFO - RETURN: v8_7: 19803.70 11:38:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19803.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6231.83"}}} 11:38:13 INFO - Return code: 0 11:38:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:38:13 INFO - # TBPL SUCCESS # 11:38:13 INFO - Running post-action listener: _resource_record_post_action 11:38:13 INFO - Running post-run listener: _resource_record_post_run 11:38:14 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521465856; Read time: 16; Write time: 556236 11:38:14 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 248004608; Read time: 0; Write time: 360620 11:38:14 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273461248; Read time: 16; Write time: 195616 11:38:14 INFO - Running post-run listener: _upload_blobber_files 11:38:14 INFO - Blob upload gear active. 11:38:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:38:14 INFO - Copying logs to upload dir... 11:38:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.912969 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-15 11:38:14.741202) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 11:38:14.744453) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010062 build_url: 'https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 11:38:14.795258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:38:14.795585) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450207023.11305-1352325721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:38:14.844808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 11:38:14.845166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 11:38:14.845454) ========= ========= Total master_lag: 0.22 =========